builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0186 starttime: 1484782965.89 results: success (0) buildid: 20170118135732 builduid: 2737b82ab3d44d798da3f753f541ea70 revision: ef4c8016909ecef30588b8b30c1fa2d113f3c27f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-18 15:42:45.888037) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-18 15:42:45.888481) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-18 15:42:45.888770) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-18 15:42:45.967118) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 15:42:45.967499) ========= 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.NHMjPS1Mdv/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.FdWWBLb5D2/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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-01-18 15:42:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 53.3M=0s 2017-01-18 15:42:46 (53.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123973 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 15:42:46.115927) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 15:42:46.116251) ========= 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.NHMjPS1Mdv/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.FdWWBLb5D2/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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.026536 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 15:42:46.165071) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-18 15:42:46.165421) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ef4c8016909ecef30588b8b30c1fa2d113f3c27f --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 ef4c8016909ecef30588b8b30c1fa2d113f3c27f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NHMjPS1Mdv/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.FdWWBLb5D2/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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-01-18 15:42:46,257 truncating revision to first 12 chars 2017-01-18 15:42:46,257 Setting DEBUG logging. 2017-01-18 15:42:46,257 attempt 1/10 2017-01-18 15:42:46,257 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ef4c8016909e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-18 15:42:47,141 unpacking tar archive at: mozilla-central-ef4c8016909e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.156303 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-18 15:42:47.345354) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-18 15:42:47.345687) ========= script_repo_revision: ef4c8016909ecef30588b8b30c1fa2d113f3c27f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-18 15:42:47.346099) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-18 15:42:47.346364) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-18 15:42:47.366645) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-18 15:42:47.366957) ========= /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.NHMjPS1Mdv/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.FdWWBLb5D2/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 15:42:47 INFO - MultiFileLogger online at 20170118 15:42:47 in /builds/slave/test 15:42:47 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 15:42:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:42:47 INFO - {'append_to_log': False, 15:42:47 INFO - 'base_work_dir': '/builds/slave/test', 15:42:47 INFO - 'blob_upload_branch': 'Firefox', 15:42:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:42:47 INFO - 'branch': 'Firefox', 15:42:47 INFO - 'buildbot_json_path': 'buildprops.json', 15:42:47 INFO - 'config_files': ('talos/mac_config.py',), 15:42:47 INFO - 'default_actions': ('clobber', 15:42:47 INFO - 'read-buildbot-config', 15:42:47 INFO - 'download-and-extract', 15:42:47 INFO - 'populate-webroot', 15:42:47 INFO - 'create-virtualenv', 15:42:47 INFO - 'install', 15:42:47 INFO - 'run-tests'), 15:42:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:42:47 INFO - 'download_minidump_stackwalk': True, 15:42:47 INFO - 'download_symbols': 'ondemand', 15:42:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:42:47 INFO - 'tooltool.py': '/tools/tooltool.py', 15:42:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:42:47 INFO - '/tools/misc-python/virtualenv.py')}, 15:42:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:42:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:42:47 INFO - 'installer_path': 'installer.exe', 15:42:47 INFO - 'log_level': 'info', 15:42:47 INFO - 'log_name': 'talos', 15:42:47 INFO - 'log_to_console': True, 15:42:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:42:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:42:47 INFO - 'opt_config_files': (), 15:42:47 INFO - 'pip_index': False, 15:42:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:42:47 INFO - 'cmd': ('bash', 15:42:47 INFO - '-c', 15:42:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:42:47 INFO - 'enabled': True, 15:42:47 INFO - 'halt_on_failure': False, 15:42:47 INFO - 'name': 'check_screen_resolution'},), 15:42:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:42:47 INFO - 'cmd': ('bash', 15:42:47 INFO - '-c', 15:42:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:42:47 INFO - 'enabled': True, 15:42:47 INFO - 'halt_on_failure': False, 15:42:47 INFO - 'name': 'check_screen_resolution'},), 15:42:47 INFO - 'run_cmd_checks_enabled': True, 15:42:47 INFO - 'sps_profile': False, 15:42:47 INFO - 'sps_profile_interval': 0, 15:42:47 INFO - 'suite': 'dromaeojs', 15:42:47 INFO - 'system_bits': '32', 15:42:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:42:47 INFO - 'title': 't-yosemite-r7-0186', 15:42:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:42:47 INFO - 'use_talos_json': True, 15:42:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:42:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:42:47 INFO - 'work_dir': 'build'} 15:42:47 INFO - [mozharness: 2017-01-18 23:42:47.573869Z] Running clobber step. 15:42:47 INFO - Running pre-action listener: _resource_record_pre_action 15:42:47 INFO - Running main action method: clobber 15:42:47 INFO - rmtree: /builds/slave/test/build 15:42:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:42:49 INFO - Running post-action listener: _resource_record_post_action 15:42:49 INFO - [mozharness: 2017-01-18 23:42:49.765611Z] Finished clobber step (success) 15:42:49 INFO - [mozharness: 2017-01-18 23:42:49.765766Z] Running read-buildbot-config step. 15:42:49 INFO - Running pre-action listener: _resource_record_pre_action 15:42:49 INFO - Running main action method: read_buildbot_config 15:42:49 INFO - Using buildbot properties: 15:42:49 INFO - { 15:42:49 INFO - "project": "", 15:42:49 INFO - "product": "firefox", 15:42:49 INFO - "script_repo_revision": "production", 15:42:49 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 15:42:49 INFO - "repository": "", 15:42:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 15:42:49 INFO - "buildid": "20170118135732", 15:42:49 INFO - "pgo_build": "False", 15:42:49 INFO - "basedir": "/builds/slave/test", 15:42:49 INFO - "buildnumber": 116, 15:42:49 INFO - "slavename": "t-yosemite-r7-0186", 15:42:49 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 15:42:49 INFO - "platform": "yosemite_r7", 15:42:49 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:42:49 INFO - "branch": "mozilla-central", 15:42:49 INFO - "repo_path": "mozilla-central", 15:42:49 INFO - "revision": "ef4c8016909ecef30588b8b30c1fa2d113f3c27f", 15:42:49 INFO - "stage_platform": "macosx64", 15:42:49 INFO - "builduid": "2737b82ab3d44d798da3f753f541ea70", 15:42:49 INFO - "slavebuilddir": "test" 15:42:49 INFO - } 15:42:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/IyYWTlttSluTXijksNqKFg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 15:42:49 INFO - Running post-action listener: _resource_record_post_action 15:42:49 INFO - [mozharness: 2017-01-18 23:42:49.769010Z] Finished read-buildbot-config step (success) 15:42:49 INFO - [mozharness: 2017-01-18 23:42:49.769143Z] Running download-and-extract step. 15:42:49 INFO - Running pre-action listener: _resource_record_pre_action 15:42:49 INFO - Running main action method: download_and_extract 15:42:49 INFO - mkdir: /builds/slave/test/build/tests 15:42:49 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')]} 15:42:49 INFO - trying https://queue.taskcluster.net/v1/task/IyYWTlttSluTXijksNqKFg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 15:42:49 INFO - Downloading https://queue.taskcluster.net/v1/task/IyYWTlttSluTXijksNqKFg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 15:42:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IyYWTlttSluTXijksNqKFg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 15:42:50 INFO - Downloaded 1199 bytes. 15:42:50 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 15:42:50 INFO - Using the following test package requirements: 15:42:50 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 15:42:50 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:42:50 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 15:42:50 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:42:50 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 15:42:50 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:42:50 INFO - u'jsshell-mac.zip'], 15:42:50 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:42:50 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 15:42:50 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 15:42:50 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:42:50 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 15:42:50 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:42:50 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 15:42:50 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:42:50 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 15:42:50 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:42:50 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 15:42:50 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:42:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IyYWTlttSluTXijksNqKFg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 15:42:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IyYWTlttSluTXijksNqKFg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:42:50 INFO - Fetch https://queue.taskcluster.net/v1/task/IyYWTlttSluTXijksNqKFg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 15:42:51 INFO - Expected file size: 16328193 15:42:51 INFO - Obtained file size: 16328193 15:42:58 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:42:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IyYWTlttSluTXijksNqKFg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 15:42:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IyYWTlttSluTXijksNqKFg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:42:58 INFO - Fetch https://queue.taskcluster.net/v1/task/IyYWTlttSluTXijksNqKFg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 15:42:59 INFO - Expected file size: 16328193 15:42:59 INFO - Obtained file size: 16328193 15:43:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IyYWTlttSluTXijksNqKFg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 15:43:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IyYWTlttSluTXijksNqKFg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:43:05 INFO - Fetch https://queue.taskcluster.net/v1/task/IyYWTlttSluTXijksNqKFg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 15:43:06 INFO - Expected file size: 14403463 15:43:06 INFO - Obtained file size: 14403463 15:43:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:07 INFO - trying https://queue.taskcluster.net/v1/task/IyYWTlttSluTXijksNqKFg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 15:43:07 INFO - Downloading https://queue.taskcluster.net/v1/task/IyYWTlttSluTXijksNqKFg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 15:43:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IyYWTlttSluTXijksNqKFg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 15:43:09 INFO - Downloaded 69931112 bytes. 15:43:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IyYWTlttSluTXijksNqKFg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 15:43:09 INFO - mkdir: /builds/slave/test/properties 15:43:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:43:09 INFO - Writing to file /builds/slave/test/properties/build_url 15:43:09 INFO - Contents: 15:43:09 INFO - build_url:https://queue.taskcluster.net/v1/task/IyYWTlttSluTXijksNqKFg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 15:43:09 INFO - Running post-action listener: _resource_record_post_action 15:43:09 INFO - Running post-action listener: set_extra_try_arguments 15:43:09 INFO - [mozharness: 2017-01-18 23:43:09.915827Z] Finished download-and-extract step (success) 15:43:09 INFO - [mozharness: 2017-01-18 23:43:09.915972Z] Running populate-webroot step. 15:43:09 INFO - Running pre-action listener: _resource_record_pre_action 15:43:09 INFO - Running main action method: populate_webroot 15:43:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:43:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:43:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:43:09 INFO - '--tppagecycles', 15:43:09 INFO - '7'], 15:43:09 INFO - 'tests': ['tsvgm']}}, 15:43:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:43:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:43:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:43:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:43:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:43:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:43:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:43:09 INFO - 'talos_options': ['--disable-e10s'], 15:43:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:43:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:43:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:43:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:43:09 INFO - 'talos_options': ['--disable-e10s'], 15:43:09 INFO - 'tests': ['damp', 'tps']}, 15:43:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:43:09 INFO - 'tests': ['damp', 'tps']}, 15:43:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:43:09 INFO - 'tests': ['dromaeo_dom']}, 15:43:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:43:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:43:09 INFO - 'tests': ['basic_compositor_video']}, 15:43:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:43:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:43:09 INFO - 'tests': ['a11yr', 15:43:09 INFO - 'ts_paint', 15:43:09 INFO - 'tpaint', 15:43:09 INFO - 'sessionrestore', 15:43:09 INFO - 'sessionrestore_no_auto_restore', 15:43:09 INFO - 'tabpaint']}, 15:43:09 INFO - 'other-e10s': {'tests': ['a11yr', 15:43:09 INFO - 'ts_paint', 15:43:09 INFO - 'tpaint', 15:43:09 INFO - 'sessionrestore', 15:43:09 INFO - 'sessionrestore_no_auto_restore', 15:43:09 INFO - 'tabpaint']}, 15:43:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:43:09 INFO - 'ts_paint', 15:43:09 INFO - 'tpaint', 15:43:09 INFO - 'sessionrestore', 15:43:09 INFO - 'sessionrestore_no_auto_restore', 15:43:09 INFO - 'tabpaint']}, 15:43:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:43:09 INFO - 'ts_paint', 15:43:09 INFO - 'tpaint', 15:43:09 INFO - 'sessionrestore', 15:43:09 INFO - 'sessionrestore_no_auto_restore', 15:43:09 INFO - 'tabpaint']}, 15:43:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:43:09 INFO - 'tests': ['a11yr', 15:43:09 INFO - 'ts_paint', 15:43:09 INFO - 'tpaint', 15:43:09 INFO - 'sessionrestore', 15:43:09 INFO - 'sessionrestore_no_auto_restore', 15:43:09 INFO - 'tabpaint']}, 15:43:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:43:09 INFO - 'tests': ['a11yr', 15:43:09 INFO - 'ts_paint', 15:43:09 INFO - 'tpaint', 15:43:09 INFO - 'sessionrestore', 15:43:09 INFO - 'sessionrestore_no_auto_restore', 15:43:09 INFO - 'tabpaint']}, 15:43:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:43:09 INFO - 'tests': ['tsvgx', 15:43:09 INFO - 'tsvgr_opacity', 15:43:09 INFO - 'tart', 15:43:09 INFO - 'tscrollx', 15:43:09 INFO - 'cart', 15:43:09 INFO - 'tsvg_static']}, 15:43:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:43:09 INFO - 'tsvgr_opacity', 15:43:09 INFO - 'tart', 15:43:09 INFO - 'tscrollx', 15:43:09 INFO - 'cart', 15:43:09 INFO - 'tsvg_static']}, 15:43:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:43:09 INFO - 'talos_options': ['--disable-e10s'], 15:43:09 INFO - 'tests': ['tp5o']}, 15:43:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:43:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:43:09 INFO - 'talos_options': ['--disable-e10s', 15:43:09 INFO - '--xperf_path', 15:43:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:43:09 INFO - 'tests': ['tp5n']}, 15:43:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:43:09 INFO - 'talos_options': ['--xperf_path', 15:43:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:43:09 INFO - 'tests': ['tp5n']}}, 15:43:09 INFO - 'talos.zip': {'path': '', 15:43:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:43:09 INFO - Running post-action listener: _resource_record_post_action 15:43:09 INFO - [mozharness: 2017-01-18 23:43:09.934294Z] Finished populate-webroot step (success) 15:43:09 INFO - [mozharness: 2017-01-18 23:43:09.934428Z] Running create-virtualenv step. 15:43:09 INFO - Running pre-action listener: _resource_record_pre_action 15:43:09 INFO - Running main action method: create_virtualenv 15:43:09 INFO - Creating virtualenv /builds/slave/test/build/venv 15:43:09 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 15:43:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:43:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:43:10 INFO - Using real prefix '/tools/python27' 15:43:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:43:10 INFO - Installing distribute.............................................................................................................................................................................................done. 15:43:13 INFO - Installing pip.................done. 15:43:13 INFO - Return code: 0 15:43:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:43:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:43:13 INFO - Reading from file tmpfile_stdout 15:43:13 INFO - Output received: 15:43:13 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) 15:43:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:13 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 0x105148b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10514b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a84d3d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f26d30>, '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 0x104e4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f1bbe8>, '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.NHMjPS1Mdv/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.FdWWBLb5D2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 15:43:13 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 15:43:13 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 15:43:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NHMjPS1Mdv/Render', 15:43:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:13 INFO - 'HOME': '/Users/cltbld', 15:43:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:13 INFO - 'LOGNAME': 'cltbld', 15:43:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:13 INFO - 'MOZ_NO_REMOTE': '1', 15:43:13 INFO - 'NO_EM_RESTART': '1', 15:43:13 INFO - 'PAGER': '/bin/cat', 15:43:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:13 INFO - 'PWD': '/builds/slave/test', 15:43:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:13 INFO - 'SHELL': '/bin/bash', 15:43:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FdWWBLb5D2/Listeners', 15:43:13 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 15:43:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:13 INFO - 'USER': 'cltbld', 15:43:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:13 INFO - 'XPC_FLAGS': '0x0', 15:43:13 INFO - 'XPC_SERVICE_NAME': '0', 15:43:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:14 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 15:43:14 INFO - Cleaning up... 15:43:14 INFO - Return code: 0 15:43:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:43: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')]} 15:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43: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')]} 15:43:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:14 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 0x105148b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10514b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a84d3d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f26d30>, '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 0x104e4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f1bbe8>, '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.NHMjPS1Mdv/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.FdWWBLb5D2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 15:43:14 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 15:43:14 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 15:43:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NHMjPS1Mdv/Render', 15:43:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:14 INFO - 'HOME': '/Users/cltbld', 15:43:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:14 INFO - 'LOGNAME': 'cltbld', 15:43:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:14 INFO - 'MOZ_NO_REMOTE': '1', 15:43:14 INFO - 'NO_EM_RESTART': '1', 15:43:14 INFO - 'PAGER': '/bin/cat', 15:43:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:14 INFO - 'PWD': '/builds/slave/test', 15:43:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:14 INFO - 'SHELL': '/bin/bash', 15:43:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FdWWBLb5D2/Listeners', 15:43:14 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 15:43:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:14 INFO - 'USER': 'cltbld', 15:43:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:14 INFO - 'XPC_FLAGS': '0x0', 15:43:14 INFO - 'XPC_SERVICE_NAME': '0', 15:43:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:14 INFO - Downloading/unpacking psutil>=3.1.1 15:43:14 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 15:43:14 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 15:43:14 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 15:43:14 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 15:43:14 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 15:43:14 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 15:43:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:43:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:43:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:43:18 INFO - Installing collected packages: psutil 15:43:18 INFO - Running setup.py install for psutil 15:43:18 INFO - building 'psutil._psutil_osx' extension 15:43:18 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 15:43:18 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 15:43:18 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 15:43:18 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 15:43:18 INFO - building 'psutil._psutil_posix' extension 15:43:18 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 15:43:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:43:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:43:19 INFO - ^ 15:43:19 INFO - 1 warning generated. 15:43:19 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 15:43:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:43:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:43:19 INFO - Successfully installed psutil 15:43:19 INFO - Cleaning up... 15:43:19 INFO - Return code: 0 15:43:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:43:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:19 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 0x105148b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10514b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a84d3d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f26d30>, '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 0x104e4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f1bbe8>, '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.NHMjPS1Mdv/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.FdWWBLb5D2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 15:43:19 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 15:43:19 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 15:43:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NHMjPS1Mdv/Render', 15:43:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:19 INFO - 'HOME': '/Users/cltbld', 15:43:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:19 INFO - 'LOGNAME': 'cltbld', 15:43:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:19 INFO - 'MOZ_NO_REMOTE': '1', 15:43:19 INFO - 'NO_EM_RESTART': '1', 15:43:19 INFO - 'PAGER': '/bin/cat', 15:43:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:19 INFO - 'PWD': '/builds/slave/test', 15:43:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:19 INFO - 'SHELL': '/bin/bash', 15:43:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FdWWBLb5D2/Listeners', 15:43:19 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 15:43:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:19 INFO - 'USER': 'cltbld', 15:43:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:19 INFO - 'XPC_FLAGS': '0x0', 15:43:19 INFO - 'XPC_SERVICE_NAME': '0', 15:43:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:43:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:43:22 INFO - Installing collected packages: mozsystemmonitor 15:43:22 INFO - Running setup.py install for mozsystemmonitor 15:43:22 INFO - Successfully installed mozsystemmonitor 15:43:22 INFO - Cleaning up... 15:43:22 INFO - Return code: 0 15:43:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:22 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 0x105148b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10514b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a84d3d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f26d30>, '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 0x104e4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f1bbe8>, '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.NHMjPS1Mdv/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.FdWWBLb5D2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 15:43:22 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 15:43:22 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 15:43:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NHMjPS1Mdv/Render', 15:43:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:22 INFO - 'HOME': '/Users/cltbld', 15:43:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:22 INFO - 'LOGNAME': 'cltbld', 15:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:22 INFO - 'MOZ_NO_REMOTE': '1', 15:43:22 INFO - 'NO_EM_RESTART': '1', 15:43:22 INFO - 'PAGER': '/bin/cat', 15:43:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:22 INFO - 'PWD': '/builds/slave/test', 15:43:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:22 INFO - 'SHELL': '/bin/bash', 15:43:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FdWWBLb5D2/Listeners', 15:43:22 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 15:43:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:22 INFO - 'USER': 'cltbld', 15:43:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:22 INFO - 'XPC_FLAGS': '0x0', 15:43:22 INFO - 'XPC_SERVICE_NAME': '0', 15:43:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:22 INFO - Downloading/unpacking jsonschema==2.5.1 15:43:22 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 15:43:22 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 15:43:22 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 15:43:22 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 15:43:22 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 15:43:22 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 15:43:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:43:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:43:25 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 15:43:25 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 15:43:25 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 15:43:25 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 15:43:25 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 15:43:25 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 15:43:25 INFO - Downloading functools32-3.2.3-2.tar.gz 15:43:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:43:25 INFO - warning: no files found matching '*.txt' 15:43:25 INFO - no previously-included directories found matching 'build' 15:43:25 INFO - no previously-included directories found matching 'dist' 15:43:25 INFO - no previously-included directories found matching '.git*' 15:43:25 INFO - Installing collected packages: jsonschema, functools32 15:43:25 INFO - Running setup.py install for functools32 15:43:25 INFO - warning: no files found matching '*.txt' 15:43:25 INFO - no previously-included directories found matching 'build' 15:43:25 INFO - no previously-included directories found matching 'dist' 15:43:25 INFO - no previously-included directories found matching '.git*' 15:43:26 INFO - Successfully installed jsonschema functools32 15:43:26 INFO - Cleaning up... 15:43:26 INFO - Return code: 0 15:43:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:43:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105148b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10514b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a84d3d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f26d30>, '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 0x104e4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f1bbe8>, '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.NHMjPS1Mdv/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.FdWWBLb5D2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 15:43:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:43:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:43:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NHMjPS1Mdv/Render', 15:43:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:26 INFO - 'HOME': '/Users/cltbld', 15:43:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:26 INFO - 'LOGNAME': 'cltbld', 15:43:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:26 INFO - 'MOZ_NO_REMOTE': '1', 15:43:26 INFO - 'NO_EM_RESTART': '1', 15:43:26 INFO - 'PAGER': '/bin/cat', 15:43:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:26 INFO - 'PWD': '/builds/slave/test', 15:43:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:26 INFO - 'SHELL': '/bin/bash', 15:43:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FdWWBLb5D2/Listeners', 15:43:26 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 15:43:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:26 INFO - 'USER': 'cltbld', 15:43:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:26 INFO - 'XPC_FLAGS': '0x0', 15:43:26 INFO - 'XPC_SERVICE_NAME': '0', 15:43:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:43:26 INFO - Cleaning up... 15:43:26 INFO - Return code: 0 15:43:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:43:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105148b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10514b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a84d3d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f26d30>, '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 0x104e4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f1bbe8>, '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.NHMjPS1Mdv/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.FdWWBLb5D2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 15:43:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:43:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:43:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NHMjPS1Mdv/Render', 15:43:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:26 INFO - 'HOME': '/Users/cltbld', 15:43:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:26 INFO - 'LOGNAME': 'cltbld', 15:43:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:26 INFO - 'MOZ_NO_REMOTE': '1', 15:43:26 INFO - 'NO_EM_RESTART': '1', 15:43:26 INFO - 'PAGER': '/bin/cat', 15:43:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:26 INFO - 'PWD': '/builds/slave/test', 15:43:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:26 INFO - 'SHELL': '/bin/bash', 15:43:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FdWWBLb5D2/Listeners', 15:43:26 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 15:43:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:26 INFO - 'USER': 'cltbld', 15:43:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:26 INFO - 'XPC_FLAGS': '0x0', 15:43:26 INFO - 'XPC_SERVICE_NAME': '0', 15:43:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:26 INFO - Downloading/unpacking blobuploader==1.2.4 15:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:29 INFO - Downloading blobuploader-1.2.4.tar.gz 15:43:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:43:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:43:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:30 INFO - Downloading docopt-0.6.1.tar.gz 15:43:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:43:30 INFO - Installing collected packages: blobuploader, requests, docopt 15:43:30 INFO - Running setup.py install for blobuploader 15:43:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:43:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:43:30 INFO - Running setup.py install for requests 15:43:31 INFO - Running setup.py install for docopt 15:43:31 INFO - Successfully installed blobuploader requests docopt 15:43:31 INFO - Cleaning up... 15:43:31 INFO - Return code: 0 15:43:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:43:31 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')]} 15:43:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:31 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')]} 15:43:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:31 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 0x105148b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10514b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a84d3d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f26d30>, '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 0x104e4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f1bbe8>, '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.NHMjPS1Mdv/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.FdWWBLb5D2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 15:43:31 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 15:43:31 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 15:43:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NHMjPS1Mdv/Render', 15:43:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:31 INFO - 'HOME': '/Users/cltbld', 15:43:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:31 INFO - 'LOGNAME': 'cltbld', 15:43:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:31 INFO - 'MOZ_NO_REMOTE': '1', 15:43:31 INFO - 'NO_EM_RESTART': '1', 15:43:31 INFO - 'PAGER': '/bin/cat', 15:43:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:31 INFO - 'PWD': '/builds/slave/test', 15:43:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:31 INFO - 'SHELL': '/bin/bash', 15:43:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FdWWBLb5D2/Listeners', 15:43:31 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 15:43:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:31 INFO - 'USER': 'cltbld', 15:43:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:31 INFO - 'XPC_FLAGS': '0x0', 15:43:31 INFO - 'XPC_SERVICE_NAME': '0', 15:43:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:43:31 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-NvRRDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:43:31 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-hx7hAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:43:31 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-Xxvfs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:43:32 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-6ukP8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:43:32 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-iCbVXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:43:32 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-TYv9Sc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:43:32 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-NxZ6gA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:43:32 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-FHzLJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:43:32 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-nPCVns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:43:32 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-1CDNXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:43:32 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-kgf9sx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:43:32 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-E5HcX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:43:32 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-MhCvvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:43:33 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-pVhxTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:43:33 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-tkONRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:43:33 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-qyXiOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:43:33 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-vbgIpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:43:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:43:33 INFO - Running setup.py install for manifestparser 15:43:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:43:33 INFO - Running setup.py install for mozcrash 15:43:33 INFO - Running setup.py install for mozdebug 15:43:33 INFO - Running setup.py install for mozdevice 15:43:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:43:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:43:34 INFO - Running setup.py install for mozfile 15:43:34 INFO - Running setup.py install for mozhttpd 15:43:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:43:34 INFO - Running setup.py install for mozinfo 15:43:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:43:34 INFO - Running setup.py install for mozInstall 15:43:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:43:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:43:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:43:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:43:34 INFO - Running setup.py install for mozleak 15:43:34 INFO - Running setup.py install for mozlog 15:43:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:43:34 INFO - Running setup.py install for moznetwork 15:43:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:43:35 INFO - Running setup.py install for mozprocess 15:43:35 INFO - Running setup.py install for mozprofile 15:43:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:43:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:43:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:43:35 INFO - Running setup.py install for mozrunner 15:43:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:43:35 INFO - Running setup.py install for mozscreenshot 15:43:35 INFO - Running setup.py install for moztest 15:43:35 INFO - Running setup.py install for mozversion 15:43:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:43:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:43:36 INFO - Cleaning up... 15:43:36 INFO - Return code: 0 15:43:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:43:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:36 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 0x105148b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10514b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a84d3d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f26d30>, '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 0x104e4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f1bbe8>, '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.NHMjPS1Mdv/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.FdWWBLb5D2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 15:43:36 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 15:43:36 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 15:43:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NHMjPS1Mdv/Render', 15:43:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:36 INFO - 'HOME': '/Users/cltbld', 15:43:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:36 INFO - 'LOGNAME': 'cltbld', 15:43:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:36 INFO - 'MOZ_NO_REMOTE': '1', 15:43:36 INFO - 'NO_EM_RESTART': '1', 15:43:36 INFO - 'PAGER': '/bin/cat', 15:43:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:36 INFO - 'PWD': '/builds/slave/test', 15:43:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:36 INFO - 'SHELL': '/bin/bash', 15:43:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FdWWBLb5D2/Listeners', 15:43:36 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 15:43:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:36 INFO - 'USER': 'cltbld', 15:43:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:36 INFO - 'XPC_FLAGS': '0x0', 15:43:36 INFO - 'XPC_SERVICE_NAME': '0', 15:43:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:43:36 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-4oghB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:43:36 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)) 15:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:43:36 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-5_PiUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:43:36 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)) 15:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:43:36 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-Du30qI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:43:36 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)) 15:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:43:36 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-ny4Jcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:43:36 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)) 15:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:43:36 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-QI2mWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:43:36 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)) 15:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:43:36 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-GXU17d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:43:36 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)) 15:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:43:36 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-RwwRaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:43:37 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)) 15:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:43:37 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-2C19Wx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:43:37 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)) 15:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:43:37 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-YuuXog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:43:37 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)) 15:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:43:37 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-T4EBu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:43:37 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)) 15:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:43:37 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-dx54Uo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:43:37 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)) 15:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:43:37 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-maBODg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:43:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 15:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:43:37 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-qw0SFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:43:37 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)) 15:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:43:37 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-lPqUWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:43:37 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)) 15:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:43:37 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-lIfVeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:43:37 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)) 15:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:43:37 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-1tVTgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:43:38 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)) 15:43:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:43:38 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-ArGnTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:43:38 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)) 15:43:38 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)) 15:43:38 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)) 15:43:38 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)) 15:43:38 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)) 15:43:38 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)) 15:43:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:43:38 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 15:43:38 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 15:43:38 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 15:43:38 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 15:43:38 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 15:43:38 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 15:43:40 INFO - Downloading blessings-1.6.tar.gz 15:43:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:43:40 INFO - Installing collected packages: blessings 15:43:40 INFO - Running setup.py install for blessings 15:43:40 INFO - Successfully installed blessings 15:43:40 INFO - Cleaning up... 15:43:41 INFO - Return code: 0 15:43:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:43:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:43:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:43:41 INFO - Reading from file tmpfile_stdout 15:43:41 INFO - Current package versions: 15:43:41 INFO - blessings == 1.6 15:43:41 INFO - blobuploader == 1.2.4 15:43:41 INFO - docopt == 0.6.1 15:43:41 INFO - functools32 == 3.2.3-2 15:43:41 INFO - jsonschema == 2.5.1 15:43:41 INFO - manifestparser == 1.1 15:43:41 INFO - mozInstall == 1.12 15:43:41 INFO - mozcrash == 1.0 15:43:41 INFO - mozdebug == 0.1 15:43:41 INFO - mozdevice == 0.49 15:43:41 INFO - mozfile == 1.2 15:43:41 INFO - mozhttpd == 0.7 15:43:41 INFO - mozinfo == 0.9 15:43:41 INFO - mozleak == 0.1 15:43:41 INFO - mozlog == 3.4 15:43:41 INFO - moznetwork == 0.27 15:43:41 INFO - mozprocess == 0.24 15:43:41 INFO - mozprofile == 0.28 15:43:41 INFO - mozrunner == 6.13 15:43:41 INFO - mozscreenshot == 0.1 15:43:41 INFO - mozsystemmonitor == 0.3 15:43:41 INFO - moztest == 0.8 15:43:41 INFO - mozversion == 1.4 15:43:41 INFO - psutil == 3.1.1 15:43:41 INFO - requests == 1.2.3 15:43:41 INFO - wsgiref == 0.1.2 15:43:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:43:41 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')]} 15:43:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:41 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')]} 15:43:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:41 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 0x105148b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10514b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a84d3d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f26d30>, '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 0x104e4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f1bbe8>, '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.NHMjPS1Mdv/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.FdWWBLb5D2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 15:43:41 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 15:43:41 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 15:43:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NHMjPS1Mdv/Render', 15:43:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:41 INFO - 'HOME': '/Users/cltbld', 15:43:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:41 INFO - 'LOGNAME': 'cltbld', 15:43:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:41 INFO - 'MOZ_NO_REMOTE': '1', 15:43:41 INFO - 'NO_EM_RESTART': '1', 15:43:41 INFO - 'PAGER': '/bin/cat', 15:43:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:41 INFO - 'PWD': '/builds/slave/test', 15:43:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:41 INFO - 'SHELL': '/bin/bash', 15:43:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FdWWBLb5D2/Listeners', 15:43:41 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 15:43:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:41 INFO - 'USER': 'cltbld', 15:43:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:41 INFO - 'XPC_FLAGS': '0x0', 15:43:41 INFO - 'XPC_SERVICE_NAME': '0', 15:43:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:41 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)) 15:43:41 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)) 15:43:41 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)) 15:43:41 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)) 15:43:41 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)) 15:43:41 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)) 15:43:41 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)) 15:43:41 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)) 15:43:41 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)) 15:43:41 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)) 15:43:41 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)) 15:43:41 INFO - Cleaning up... 15:43:41 INFO - Return code: 0 15:43:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:43:41 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')]} 15:43:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:41 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')]} 15:43:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:41 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 0x105148b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10514b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a84d3d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f26d30>, '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 0x104e4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f1bbe8>, '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.NHMjPS1Mdv/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.FdWWBLb5D2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 15:43:41 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 15:43:41 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 15:43:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NHMjPS1Mdv/Render', 15:43:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:41 INFO - 'HOME': '/Users/cltbld', 15:43:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:41 INFO - 'LOGNAME': 'cltbld', 15:43:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:41 INFO - 'MOZ_NO_REMOTE': '1', 15:43:41 INFO - 'NO_EM_RESTART': '1', 15:43:41 INFO - 'PAGER': '/bin/cat', 15:43:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:41 INFO - 'PWD': '/builds/slave/test', 15:43:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:41 INFO - 'SHELL': '/bin/bash', 15:43:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FdWWBLb5D2/Listeners', 15:43:41 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 15:43:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:41 INFO - 'USER': 'cltbld', 15:43:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:41 INFO - 'XPC_FLAGS': '0x0', 15:43:41 INFO - 'XPC_SERVICE_NAME': '0', 15:43:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:43:41 INFO - Cleaning up... 15:43:41 INFO - Return code: 0 15:43:41 INFO - Running post-action listener: _resource_record_post_action 15:43:41 INFO - Running post-action listener: _start_resource_monitoring 15:43:41 INFO - Starting resource monitoring. 15:43:41 INFO - [mozharness: 2017-01-18 23:43:41.956233Z] Finished create-virtualenv step (success) 15:43:41 INFO - [mozharness: 2017-01-18 23:43:41.957004Z] Running install step. 15:43:41 INFO - Running pre-action listener: _resource_record_pre_action 15:43:41 INFO - Running main action method: install 15:43:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:43:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:43:42 INFO - Reading from file tmpfile_stdout 15:43:42 INFO - Detecting whether we're running mozinstall >=1.0... 15:43:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:43:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:43:42 INFO - Reading from file tmpfile_stdout 15:43:42 INFO - Output received: 15:43:42 INFO - Usage: mozinstall [options] installer 15:43:42 INFO - Options: 15:43:42 INFO - -h, --help show this help message and exit 15:43:42 INFO - -d DEST, --destination=DEST 15:43:42 INFO - Directory to install application into. [default: 15:43:42 INFO - "/builds/slave/test"] 15:43:42 INFO - --app=APP Application being installed. [default: firefox] 15:43:42 INFO - mkdir: /builds/slave/test/build/application 15:43:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:43:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 15:44:04 INFO - Reading from file tmpfile_stdout 15:44:04 INFO - Output received: 15:44:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:44:04 INFO - Running post-action listener: _resource_record_post_action 15:44:04 INFO - [mozharness: 2017-01-18 23:44:04.249367Z] Finished install step (success) 15:44:04 INFO - [mozharness: 2017-01-18 23:44:04.249488Z] Running run-tests step. 15:44:04 INFO - Running pre-action listener: _resource_record_pre_action 15:44:04 INFO - Running main action method: run_tests 15:44:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:44:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:44:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:44:04 INFO - 2017-01-18 15:44:04.261 screenresolution[1624:7349] starting screenresolution argv=screenresolution get 15:44:04 INFO - 2017-01-18 15:44:04.264 screenresolution[1624:7349] Display 0: 1600x1200x32@60 15:44:04 INFO - 2017-01-18 15:44:04.269 screenresolution[1625:7351] starting screenresolution argv=screenresolution list 15:44:04 INFO - Available Modes on Display 0 15:44:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:44:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:44:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:44:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:44:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:44:04 INFO - Intel Iris: 15:44:04 INFO - Chipset Model: Intel Iris 15:44:04 INFO - Type: GPU 15:44:04 INFO - Bus: Built-In 15:44:04 INFO - VRAM (Dynamic, Max): 1536 MB 15:44:04 INFO - Vendor: Intel (0x8086) 15:44:04 INFO - Device ID: 0x0a2e 15:44:04 INFO - Revision ID: 0x0009 15:44:04 INFO - Displays: 15:44:04 INFO - Display: 15:44:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:44:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:44:04 INFO - Display Serial Number: 1600x1200 60 15:44:04 INFO - Main Display: Yes 15:44:04 INFO - Mirror: Off 15:44:04 INFO - Online: Yes 15:44:04 INFO - Rotation: Supported 15:44:04 INFO - Return code: 0 15:44:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:44:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:44:04 INFO - Python 2.7.3 15:44:04 INFO - Return code: 0 15:44:04 INFO - grabbing minidump binary from tooltool 15:44:04 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')]} 15:44:04 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 0x104f26d30>, '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 0x104e4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f1bbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:44:04 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 15:44:04 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 15:44:04 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 15:44:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:44:04 INFO - Return code: 0 15:44:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:44:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:44:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:44:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:44:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:44:04 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IyYWTlttSluTXijksNqKFg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0186', '--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 15:44:04 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IyYWTlttSluTXijksNqKFg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0186 --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 15:44:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NHMjPS1Mdv/Render', 15:44:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:44:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:44:04 INFO - 'HOME': '/Users/cltbld', 15:44:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:44:04 INFO - 'LOGNAME': 'cltbld', 15:44:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:44:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:44:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:04 INFO - 'MOZ_NO_REMOTE': '1', 15:44:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:44:04 INFO - 'NO_EM_RESTART': '1', 15:44:04 INFO - 'PAGER': '/bin/cat', 15:44:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:44:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:04 INFO - 'PWD': '/builds/slave/test', 15:44:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:44:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:44:04 INFO - 'SHELL': '/bin/bash', 15:44:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FdWWBLb5D2/Listeners', 15:44:04 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 15:44:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:44:04 INFO - 'USER': 'cltbld', 15:44:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:44:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:44:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:04 INFO - 'XPC_FLAGS': '0x0', 15:44:04 INFO - 'XPC_SERVICE_NAME': '0', 15:44:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:44:04 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IyYWTlttSluTXijksNqKFg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0186', '--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 15:44:04 INFO - mozversion application_buildid: 20170118135732 15:44:04 INFO - mozversion application_changeset: ef4c8016909ecef30588b8b30c1fa2d113f3c27f 15:44:04 INFO - mozversion application_display_name: Nightly 15:44:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:44:04 INFO - mozversion application_name: Firefox 15:44:04 INFO - mozversion application_remotingname: firefox 15:44:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:44:04 INFO - mozversion application_vendor: Mozilla 15:44:04 INFO - mozversion application_version: 53.0a1 15:44:04 INFO - mozversion platform_buildid: 20170118135732 15:44:04 INFO - mozversion platform_changeset: ef4c8016909ecef30588b8b30c1fa2d113f3c27f 15:44:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:44:04 INFO - mozversion platform_version: 53.0a1 15:44:04 INFO - using testdate: 1484783044 15:44:04 INFO - actual date: 1484783044 15:44:04 INFO - starting webserver on 'localhost:49238' 15:44:04 INFO - SUITE-START | Running 2 tests 15:44:04 INFO - TEST-START | dromaeo_css 15:44:04 INFO - operating with platform_type : mac_ 15:44:04 INFO - Initialising browser for dromaeo_css test... 15:44:04 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/tmpJsmB1b/profile http://localhost:49238/getInfo.html) 15:44:07 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 15:44:07 INFO - PROCESS | 1635 | colorDepth:24 15:44:07 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 15:44:07 INFO - PROCESS | 1635 | __metrics 15:44:07 INFO - PROCESS | 1635 | 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" 15:44:07 INFO - PROCESS | 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:44:08 INFO - TEST-INFO | 1635: exit 0 15:44:08 INFO - Browser initialized. 15:44:08 INFO - Running cycle 1/1 for dromaeo_css test... 15:44:08 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/tmpJsmB1b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:44:20 INFO - PROCESS | 1637 | RSS: Main: 235229184 15:44:20 INFO - PROCESS | 1637 | 15:47:23 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49238/tests/dromaeo/cssquery-ext.html) 15:47:25 INFO - PROCESS | 1637 | RSS: Main: 407429120 15:47:25 INFO - PROCESS | 1637 | 15:49:09 INFO - PROCESS | 1637 | ************************* 15:49:09 INFO - PROCESS | 1637 | A coding exception was thrown and uncaught in a Task. 15:49:09 INFO - PROCESS | 1637 | 15:49:09 ERROR - PROCESS | 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:49:09 INFO - PROCESS | 1637 | Full stack: 15:49:09 INFO - PROCESS | 1637 | ************************* 15:50:28 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-ext.html (next: http://localhost:49238/tests/dromaeo/cssquery-jquery.html) 15:50:29 INFO - PROCESS | 1637 | RSS: Main: 367726592 15:50:29 INFO - PROCESS | 1637 | 15:53:31 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49238/tests/dromaeo/cssquery-mootools.html) 15:53:32 INFO - PROCESS | 1637 | RSS: Main: 341291008 15:53:32 INFO - PROCESS | 1637 | 15:56:34 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49238/tests/dromaeo/cssquery-prototype.html) 15:56:35 INFO - PROCESS | 1637 | RSS: Main: 338161664 15:56:35 INFO - PROCESS | 1637 | 15:59:38 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49238/tests/dromaeo/cssquery-yui.html) 15:59:39 INFO - PROCESS | 1637 | RSS: Main: 336728064 15:59:39 INFO - PROCESS | 1637 | 16:02:42 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-yui.html (next: http://localhost:49238/tests/dromaeo/cssquery-dojo.html) 16:02:42 INFO - PROCESS | 1637 | RSS: Main: 408621056 16:02:42 INFO - PROCESS | 1637 | 16:02:42 INFO - PROCESS | 1637 | __start_tp_report 16:02:42 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 16:02:42 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 16:02:42 INFO - PROCESS | 1637 | |i|pagename|runs| 16:02:42 INFO - PROCESS | 1637 | |0;dojo.html;3316.054924346561;3340.131565792893;3342.247994201305;3346.9665303346974;3397.7791443556166;5562.833115006556;5652.236948012017;5664.886702265962;5702.486776190142;5735.569832262576;5594.58040646951;5610.410906854772;5618.213450116987;5632.605717599769;5666.801661941833;5083.135866902617;5134.0758663440565;5156.149235376159;5169.147090730025;5205.973970130144;5217;5236.476352364771;5237.973810130944;5239.030779305822;5241.030409374259;5224.50367215114;5228.2680424740565;5233.136532472137;5233.947660523403;5237;5218.217267409881;5235.110031294689;5245.763940622681;5246.108161612535;5256.579473642099;5010.624203184776;5104.948950510522;5109.642325037249;5170.25031370453;5225.137852254374;5756.913646295309;5797.333306669745;5804.622699524517;5806.506446952014;5820.738066787005;6111.297200821918;6166.506679465677;6180.969095154495;6184.072389141665;6207.782727604512;4188.476440444944;5545.972270138664;6138.386161383871;6145.661988590626;6214.782482613087;5806.303243610793;5806.59353845231;5817.650940943557;5826.592138550303;5831.387704291031;6254.124422580842;6269.780557680459;6269.811905642838;6273.247210334789;6277.372262773777;5829.8251052468495;5863.501602363762;5884.823455296348;5981.910271345933;6074.665893375906;4887.973525559672;5692.203091567184;6213.565050446426;6254.9687251563455;6264.59280146789;6182.845428864314;6197.96901015492;6203.038529028008;6211;6220.222472190976;6089.1779609753;6201.6899155042065;6202.28673702521;6253.6873156342;6256.593321434092;4839.056384005085;4919.852404427873;4933.062718083553;4940.431850337257;4946.406431228275;4457.554244575581;4469.575390337913;4477.686561940633;4491.438570178728;4509.210888094571;5264.7627807465215;5692.8861422771315;5757.222774925332;5770.682612456271;5794.62334948227;6109.040306147876;6168.907466388007;6180.505559555225;6203.131561581382;6213.96893015532;5711.771529138871;5743.741531631086;5762.798302059407;5763.452472015152;5812.215350927655;5456.672599644034;5456.781728730885;5466.808661696901;5469.562435005269;5483.341998960071;6183.96908015457;6193.938060619336;6264.279607844974;6296.150019747275;6334.271558770801;6204.286507051746;6213.099100630293;6214.4407003369915;6228.750849965951;6231.9688401557705;6211.161493198541;6240.4071613196675;6240.469560087262;6286.15136956505;6291.528135389955;5233.7439014636975;6134.509239260938;6167.876642467215;6178.876422471615;6189.195404597373;6127.20346354971;6244.250689917239;6254.249490061222;6258.092576576462;6260.874782504416;5817.272840894888;5934.258217722785;6020.066889632114;6023.6385816851125;6125.632272693401;5908.350081490947;6109.526129009804;6109.6475967989745;6123.84690382744;6138.602983405075;5879.147523608967;5930.673812940329;5939.168516407793;5942.435468630473;5966.910496342472;5898.4101589840675;5980.37206093354;6117.96941015292;6122.2761798032625;6125.479334256638;5916.881662366643;5921.940780592139;5943.881122377615;5957.344692083954;5986 16:02:42 INFO - PROCESS | 1637 | |1;ext.html;478.91858384074715;495.91569433196355;505.30520534265384;514.7323391836245;517.9821650456852;30858.691413085864;40156.98822588303;42334.576654233446;42743.93140171497;44652.3302150468;43692.781536092356;43854.561454385446;43891;43898.78050609743;43922.78038609811;9191.356605037634;9367.578458969328;9372.765680857965;9374.343795934254;9403.905960940405;8445.662173513052;8684.218420342168;10985.363512756961;11264.4367781611;11318.490667919963;11240.718982025473;11308.03881670059;11308.321500709942;11323.603673871416;11338.48976796042;8367.707130250412;11031.558737650485;11077;11085.556577736881;11095.889041109567;8534.530600816952;8597.957010214972;8600.483970961763;8609.225169734755;10914;39303.41044884329;41407.37888931638;41412.96467588304;41422;41478.792606036775;4059.06641472463;4078.9184216315507;4089.3661482470266;4108.794560272005;4237.703360764748;30314.54528182079;30796.538051929016;30924.91762788314;31078.844605776827;31640.525392119136;3012.7891047626676;3014.3217776000442;3097.9298926296897;3230.353929214143;3257.4136655402017;476900;481492;482381.17618824064;483043.9999999965;485383.5730821359;60228.39771602228;61270;61672;61676.76646467135;61679.38320616826;64120.717585648956;64268.67865660642;64287.03569446462;64365.276166860276;64497.35502645007;13561.593152205449;15579.376824927103;16147.192640367935;16176.514704558882;16196;11232.438378081064;11488.597899073493;12516.81224781629;12589.181703189264;12614.243145411305;15030.924845375703;15150.16674082914;15151.197028549754;15168.620784480476;16724.916375418044;5975.25309336333;6506.902396464056;6786.219584747719;6810.455163587;6869.931300687029;764.7743915544928;879.7492714576315;905.8188362327561;909.9863502047475;929.7582628516634;30244.697553024627;30265.546016809767;30332.848335758623;30619.08142755721;30963.380732385227;1068.8663917010374;1072.7264547540328;1093.9343639381664;1104.7845670094255;1204.6867814368152;15458.304376303093;15748.212589370485;15830.970986885815;16162.676746465006;16163;612236;612633;616612;616662;617338;60801.783964320464;60841.39158608446;60865.39134608686;60868;60894;1397.343248673122;1399.5451478269604;1454.8981571289908;1465.5163795947526;1466.2522113721866;24494.510109798062;29876.850615746782;29998.550021749255;30097;30198.547021794253;46724;47007.52992470031;47099.52900470951;51415.74292128516;51449;522504;525401;525715;525770;527350;31056.068317950496;39365;40125;40229;40244.79877600593;46007.07985840197;46640;46984.7650761744;47113.52886471091;47343;38794.80602596969;38805.41791873068;39301;40328.79835600803;40539.39190912198;38640.01079832631;39311.04256142186;39713.40429893612;40171.79914100411;40233.79883100566;33215.667843322226;37074;37095;37867.431988520744;38046.809765950995;31146.54502718968;32002.51996220105;33031.33937321192;34125.65874341225;34717.65282347144;23980.880095599412;24034.39914002164;24058.39854003664;24495.020199192546;24663.38341541476 16:02:42 INFO - PROCESS | 1637 | |2;jquery.html;361.5769549626936;381.267965506228;381.7804762261699;391.45978549601546;411.0627768687392;14873;15683.686326273468;15888.76166857498;16740.58148546287;20664.586708265862;19784.90107549464;20580.48548786281;21104.472388190305;21352.679709804364;21365.572688546257;5797;5878.382769809173;5992.161097446361;5997.580169388145;6018.067199584049;5933.13969474426;5996.640201587897;6060.060690592965;6068.3021452533085;6083.209182806251;5758.251427314443;5950.494207992304;5998.97000514999;6007.6395416274945;6013.458788709016;5909.7636094556165;5979.431953964367;5984.581079324405;5990.311114221877;6004.819855404345;5031.421386540522;5174.793008279665;5257.342832145981;5269.789208431658;5271.551918086967;26392.736072639218;26432.86783566089;26449.206523804318;26501.46997060048;26807.463850722877;2728.304282407993;2800.397914448383;2808.887644494218;2811.156653004111;2834.1639216431204;5915.349311575723;5967.104934259853;14728.631784205481;15125.394984200619;15521.123953766464;1780.3412737287288;1840.2546968477789;1840.8987505687182;1853.8424233940132;1863.5806943437753;101026.49486752592;120752;122476;122877;143372.99999999895;11544.653660390202;11725.589604363806;11856.70358241051;11859.027225879427;12034.75930481403;15597.610059748371;15632.765508517381;15645.843541564438;15649.687006259812;15664.608384790472;6872.725090996404;8628.611712472954;8659.913400866037;8687.652493900174;8738.475691458532;8413.831723365622;8437.915620843836;8578.613962371708;8601.31189504838;8603.741887743377;3894.571597124314;4639.396878405786;4734.739589322551;4749.881252968635;4859.781309841065;1672.6236596765873;1994.1923520974028;1999.67005444103;1999.7900220476931;2000.21991423345;964.5707660091332;986.6645340584092;1008.5814387029301;1023.2888142740724;1027.4143738069379;22026.008829602706;22271.997760100836;22377.88811055967;22478.32565023052;22486.550268994528;863.6243234193146;1024.8565200871883;1057.8889216632297;1060.9469526523642;1072.5816931396762;9794.559244834;10954.38999425815;10962.561497540168;11393.487293071832;11693.941530292293;571278;707520;715530;722621;736125;160051;160203.38271247075;169078;171572;171928;941.5809964565702;970.898055704155;1066.8506409102731;1117.8993890549727;1118.245184500459;20155.697664535335;20350.898245508677;20479.4880127998;20523.07646155897;20546.075426606138;61234.38765612287;61465.69267153636;62329;62680;62947.6852615734;91420;92004.61993069976;92999.53500232726;94020;94867;8267.255946964802;8530.14698530142;8593.484390936565;8604.698835540727;8640.204049099375;9410.341276110606;12697.80953285683;13161.947044236247;13694.863051369757;13817.723645526832;11061.557537698402;11325.603603873826;11773.76452470963;11779.705507362041;11860.525578976743;11403.657890263305;11571.421428928688;11687.357195354338;11888.28670279786;12025.699357516132;11597.362145082101;11892.76214475723;11919.986801122002;11953.282803031845;12103.818442723543;7252.38354739853;7491.925080749123;7576.621168941641;7838.413323603311;8521.318294536546;9766.414015159113;10714.57141714354;11058.170637202082;11516.94241528787;11804.17370784037 16:02:42 INFO - PROCESS | 1637 | |3;mootools.html;1377.9724405511884;1456.4028748213227;1477.3868844429562;1483.8293596236435;1492.985070149299;7598.772036838896;7649.961750191255;8163.265306122448;8493.49039057657;8511.148885111486;7467.813304667386;7699.114601820792;7711.421643376755;8106.878396824052;8297.83404331913;2298.9885050574767;2343.414146463384;2344.097522453859;2347.01425401331;2347.6595893595418;2329.860208387494;2366.2782851230368;2367.3844800351862;2371.95256094878;2382.821288403368;2319.860808351496;2322.512272422793;2332.8367014309006;2333.0784340185614;2344;2296.5521723263887;2312.5259321839153;2326.6161083421216;2331.6502524621274;2333.6032874411308;2266.240809328877;2307.9884600577057;2344.10923848938;2351;2352.9647055294186;8308.875366869503;8381.539015354154;8405.159484051606;8409.915900840975;8410.36922230835;4219.662427005863;5174.715390653512;5184.7407629618365;5201.687898726051;5202.687838729688;3303.240254741423;3386.3058073095203;3424.434968230239;3431.9485207721905;3438.415469370213;1155.8728539860608;1183.4260383713893;1184.5321098166262;1225.7487215120968;1246.1214843535286;10586.947065264625;10740.785184296348;10741.51663175159;10754.247202695815;10755.247132700713;4406.5593440655675;4609.262517997105;4684;4693.9765301173275;4710.481846996828;9494.335396522178;9494.572744226527;9501.619935202652;9509.476978766234;9515.143637072697;5205.375354957429;5214.426413094557;5215;5226.555742761831;5227.895442091137;4612.976935115303;4691.483936766953;4700.741459219707;4790.640701947368;4792.353032340659;3260.4620237660993;3743.457198706172;3793.962060379361;3809.3333666608232;3869.5356557213313;1236.4806781151938;1238.5293588436336;1239.4608345369793;1250.8999280057574;1260.577706468325;787.5038725602833;796.100406540617;813.4753084260619;817.0889458254122;820.3970081989733;5533;5602.1036634139155;5680.375158732536;5698.629589076697;5748.19525266463;530.3105962249061;568.6275489554348;569.4533248081805;574.1187277528973;586.642148289543;3613.259281847215;3664.358737220976;3766.849326026983;3781.3382658034734;3798.639129282714;9491.952540237255;9898.60405583783;9918.752031199278;9919.40483570988;9924.354916930377;9667.129958303787;9692.127708506268;9735.41587504752;9764.365316254421;9889.505524723734;7615.923840761632;7661.808454788675;7727.1886451922865;7735.381169506426;7756.806079848049;4424.491183513937;5473.562115030868;5499.560035197254;5612.326520817528;5637.830865074055;8802.163794439519;8810.695989004123;9140.360174787702;9246.861297080415;9250.95374523123;8534.146585341665;9120.361574689709;9212.815743685223;9304.116108969638;9416.340856140005;6599.53803233769;6928.411085057826;7136.3220494052985;7164.785056448315;7235.34881860614;7803.687852486064;7853.1361550228285;7908.683652653829;7951.403644726553;7995.120536740837;7097.46768992338;7129.750458733919;7153.0343403639845;7210.74762383335;7224.638768061471;6991.405730512964;7007.404370628554;7079.52293195172;7088.149422069385;7147.571145731273;5463.754131064032;6376.426121649074;6381.680915954276;6404.935950640434;6470.288268290578;4927.728974906415;4978;5019.824306149268;5032.924506132485;5163.251328557413;4971.15618319165;5010.073136469765;5065.721385323695;5209.270702101633;5225.817096401608 16:02:42 INFO - PROCESS | 1637 | |4;prototype.html;347.34005389759454;357.60484664445795;358.2941605038076;366.56745040851786;367.3332900785075;4259.552746961571;4347.586979236975;5254.789808407664;5257.421683614799;5284.233786101013;4527.253003254467;5162.251473536335;5169.715665638389;5186.636935414523;5190.299309593203;3401.710854577364;3812.7902965336893;3965.9405108923247;3975.70182236332;4001.4798076250045;3412.385770561298;4028.6374226319626;4034.8500677306974;4060.6751459883285;4101.938470922939;4059.817308221137;4074.57216992216;4078.675155161559;4089.672826173914;4110.650594699454;3763.3226019316376;3930.1506407854363;4047.8785636430953;4101.712880098395;4118.146833924731;3083.753299736016;3553.751237413382;3621.420572708354;3645.505342809462;3649.376027667689;4189.790510474494;5036.445990940993;5063.645404886745;5070.884405430799;5093.363329583802;3961.3859851723028;4533.84131555394;4672.859814205579;4696.671233013691;4713;4695.506971767949;5119.744012799345;5180.430152683201;5310;5613.494785469286;3640.8725694600826;3706.8517259309597;3906.8632597858937;4101.487314085739;4107.609777071173;5454.300121439873;5476.452354764531;5506.862328441781;5744.793593345445;5876.588638795286;4014.8394064237687;4105.240530501807;4125.071858831739;4132.8140233689555;4159.750414975111;3842.9423558646645;4181.540030596632;4183.707140500136;4191.790410479463;4208.284591619432;4361.454818147731;4408.955910440919;4463.263561512379;4665.2768820832825;4779.351123862262;5512.448755124456;5579.832605021856;5591.189277554732;5601.775928962796;5633.253886165654;1156.6298784389082;1337.8461476930277;1349.0826238157952;1357.470586471277;1358.130796290375;904.2172809168975;957.8371676814958;957.9952100239593;962.9662961796444;975.6390135649855;4128.41973766396;4178.603032711888;4278.165757677285;4815.277708343777;4859.805607775649;5143.202803565453;5341.035725172566;5353.678779273256;5379.408265090837;5404.6488377905525;4454.977725111354;4519.344695019269;4851.417829860439;4889.193283108248;4914.36113305268;2399.7720216579396;2629.250663560876;2806.312453448918;2806.9017584384446;2828.717128287155;4931.975340123348;5100.393376086595;5287.113971231142;5537.197106419547;5605.467480589337;4515.245700122922;5009.649324547319;5222.817201397933;5321.946780532223;5627.822403388892;5139.023585518739;5233.685978841282;5585.329760428694;5605.999999999918;5614.775408983676;4825.806967721252;4838.371011768448;5390.353157621111;5407.405185429521;5429;4474.865754027384;4584.954150458453;4883.584895283941;5545.667259964415;5590.580706447114;5866.823995280149;5871.588988770745;5889.793857214977;5898.528117750656;5939.3466718661775;3243.7242834359345;3395.94906076414;3801.6008319126095;3819.0141126614562;3830.5020347354666;4815.7847390200905;5334.359876814807;5449.694741154443;5637.829435667216;5661.2733116399895;5449.964506743706;5504.568812108801;5509.944900550943;5513.2005859151;5537;4865.880847405046;5314.443710877558;5425.430329815313;5527.668339899619;5533.5849811265125;5105.285260063668;5329.413764485981;5390.083685773349;5429.40276569585;5479.835604931858;4565.657575681771;4574.496805351342;4579.38178345919;4920.237363208708;5519.779208831602;4524.479684836154;4975.353204083446;5407;5412.891742165056;5424.721616920981 16:02:42 INFO - PROCESS | 1637 | |5;yui.html;680.9761658341957;732.9157146928105;737.9667914943824;786.4573444323416;859.6991053131403;14397.928010359947;15392.384304627802;15414.229288535571;15424.92287538562;15427.305771240293;13606.319684015809;14189.290535473237;14374.06568573042;14462.710745785078;14473.914456415758;576.9019266724667;858.6393714639851;877.6752601537409;878.4641368765048;883.465503370458;693.1647364925253;706.3113464372221;831.085805613826;855.6534603485567;863.9222469977701;918.545320066568;920.0477505781517;921.6267411698273;922.7646950027768;924.1128516624049;916.0884919505102;917.0142097245488;917.124146440148;917.3761841947473;922.7877588154695;525.2672521832061;544.77119609764;590.8965930962107;653.4347789162388;672.1598002496879;14592;14612;14652.047616904867;14800.925995370062;14910.850891491054;13504;13521.459141634323;13650.385732642055;13712.93143534286;13732.45070197191;12385.906857264941;12471.812922806164;12514.687132821662;12712.491500339975;12876.613701588967;4446.799894004777;4459.487158976727;4627.981843994316;4631.60631346336;4634.884127896796;99028.50485747597;99591.50204248933;99665;99767;102654;10823.945880270549;10900.1279897608;10934.617288395028;11094.223404361617;11143.498542565603;18208.27166913335;20743.688844667344;21472.463188420414;21583.2445864394;21637.996970560496;6984.3364880336285;7441.55350678961;7651.120121186135;7685.538867667846;7741.690332386642;4145.1295228002455;4207.915841683211;4208.326667733148;4218.894527636772;4224.471941007374;3306.966930330714;3358.126887009395;3358.781679190845;3364.3439529291554;3400.234947136924;642.5079691874677;646.2342124582385;650.4991156809325;653.5392548253565;659.0838734159522;630.8864404407251;641.8202903187115;658.7957733102658;671.727950180168;677.4824393358841;9686.225101991824;9723.85414218773;9729.270304727173;9852.95073524642;9897.653582124734;618.6968385491077;636.8885445047098;665.364576829127;667.2526770017612;681.0363335879774;4670.369500117441;4701.623870090453;4708.9058218835435;4717.22165842639;4802.495737947465;85934.14065859387;91977;93929;97970;101204.4939775311;84484;85570.49478119797;85722;86492.56753716317;87346;62166;76257.79875219938;77223;78564.21435785684;78863;7753.4960227585025;9085.318601105077;9483.336166468282;9529;9658.227341812779;41529.58470415257;44269.778651106535;45113;45731.54268457273;47146.52853471559;49436.50563494463;56900.71549642225;58901;64924.675376622814;66665;12973.027022973127;13144.802827957397;13226.206427614374;13454.730905382034;13728.358815915191;12462.376881156088;14223.786643200154;14390.992630516183;14670.26648667541;15272.923635382196;13818.930905345409;13898.30508474552;13970.720585588027;14070.861599061063;14084.436622535393;13582;13751.312434378042;13949.511767088103;14379.281035947952;14548.344529750379;11885.702857428634;13480.797788033384;13580.117292375964;13788;13803.79294310566;10527.894721052691;11359.261647992855;11411;11592.88407115918;11878.881211188123;8318.584070796314;10880.401577913291;10930.617428389969;11126.554937802397;11164.385958772345 16:02:42 INFO - PROCESS | 1637 | __end_tp_report 16:02:42 INFO - PROCESS | 1637 | __start_cc_report 16:02:42 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,1769 16:02:42 INFO - PROCESS | 1637 | __end_cc_report 16:02:42 INFO - PROCESS | 1637 | __startTimestamp1484784162693__endTimestamp 16:02:42 INFO - PROCESS | 1637 | 16:02:42 INFO - PROCESS | 1637 | ------- Summary: start ------- 16:02:42 INFO - PROCESS | 1637 | Number of tests: 6 16:02:42 INFO - PROCESS | 1637 | 16:02:42 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5693.59 Median:5863.50 stddev:633.76 (10.8%) stddev-sans-first:607.64 16:02:42 INFO - PROCESS | 1637 | Values: 3316.1 3340.1 3342.2 3347.0 3397.8 5562.8 5652.2 5664.9 5702.5 5735.6 5594.6 5610.4 5618.2 5632.6 5666.8 5083.1 5134.1 5156.1 5169.1 5206.0 5217.0 5236.5 5238.0 5239.0 5241.0 5224.5 5228.3 5233.1 5233.9 5237.0 5218.2 5235.1 5245.8 5246.1 5256.6 5010.6 5104.9 5109.6 5170.3 5225.1 5756.9 5797.3 5804.6 5806.5 5820.7 6111.3 6166.5 6181.0 6184.1 6207.8 4188.5 5546.0 6138.4 6145.7 6214.8 5806.3 5806.6 5817.7 5826.6 5831.4 6254.1 6269.8 6269.8 6273.2 6277.4 5829.8 5863.5 5884.8 5981.9 6074.7 4888.0 5692.2 6213.6 6255.0 6264.6 6182.8 6198.0 6203.0 6211.0 6220.2 6089.2 6201.7 6202.3 6253.7 6256.6 4839.1 4919.9 4933.1 4940.4 4946.4 4457.6 4469.6 4477.7 4491.4 4509.2 5264.8 5692.9 5757.2 5770.7 5794.6 6109.0 6168.9 6180.5 6203.1 6214.0 5711.8 5743.7 5762.8 5763.5 5812.2 5456.7 5456.8 5466.8 5469.6 5483.3 6184.0 6193.9 6264.3 6296.2 6334.3 6204.3 6213.1 6214.4 6228.8 6232.0 6211.2 6240.4 6240.5 6286.2 6291.5 5233.7 6134.5 6167.9 6178.9 6189.2 6127.2 6244.3 6254.2 6258.1 6260.9 5817.3 5934.3 6020.1 6023.6 6125.6 5908.4 6109.5 6109.6 6123.8 6138.6 5879.1 5930.7 5939.2 5942.4 5966.9 5898.4 5980.4 6118.0 6122.3 6125.5 5916.9 5921.9 5943.9 5957.3 5986.0 16:02:42 INFO - PROCESS | 1637 | 16:02:42 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:68278.51 Median:40200.40 stddev:144926.35 (360.5%) stddev-sans-first:145243.50 16:02:42 INFO - PROCESS | 1637 | Values: 478.9 495.9 505.3 514.7 518.0 30858.7 40157.0 42334.6 42743.9 44652.3 43692.8 43854.6 43891.0 43898.8 43922.8 9191.4 9367.6 9372.8 9374.3 9403.9 8445.7 8684.2 10985.4 11264.4 11318.5 11240.7 11308.0 11308.3 11323.6 11338.5 8367.7 11031.6 11077.0 11085.6 11095.9 8534.5 8598.0 8600.5 8609.2 10914.0 39303.4 41407.4 41413.0 41422.0 41478.8 4059.1 4078.9 4089.4 4108.8 4237.7 30314.5 30796.5 30924.9 31078.8 31640.5 3012.8 3014.3 3097.9 3230.4 3257.4 476900.0 481492.0 482381.2 483044.0 485383.6 60228.4 61270.0 61672.0 61676.8 61679.4 64120.7 64268.7 64287.0 64365.3 64497.4 13561.6 15579.4 16147.2 16176.5 16196.0 11232.4 11488.6 12516.8 12589.2 12614.2 15030.9 15150.2 15151.2 15168.6 16724.9 5975.3 6506.9 6786.2 6810.5 6869.9 764.8 879.7 905.8 910.0 929.8 30244.7 30265.5 30332.8 30619.1 30963.4 1068.9 1072.7 1093.9 1104.8 1204.7 15458.3 15748.2 15831.0 16162.7 16163.0 612236.0 612633.0 616612.0 616662.0 617338.0 60801.8 60841.4 60865.4 60868.0 60894.0 1397.3 1399.5 1454.9 1465.5 1466.3 24494.5 29876.9 29998.6 30097.0 30198.5 46724.0 47007.5 47099.5 51415.7 51449.0 522504.0 525401.0 525715.0 525770.0 527350.0 31056.1 39365.0 40125.0 40229.0 40244.8 46007.1 46640.0 46984.8 47113.5 47343.0 38794.8 38805.4 39301.0 40328.8 40539.4 38640.0 39311.0 39713.4 40171.8 40233.8 33215.7 37074.0 37095.0 37867.4 38046.8 31146.5 32002.5 33031.3 34125.7 34717.7 23980.9 24034.4 24058.4 24495.0 24663.4 16:02:42 INFO - PROCESS | 1637 | 16:02:42 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:39629.77 Median:26412.80 stddev:116227.39 (440.0%) stddev-sans-first:116516.04 16:02:42 INFO - PROCESS | 1637 | Values: 361.6 381.3 381.8 391.5 411.1 14873.0 15683.7 15888.8 16740.6 20664.6 19784.9 20580.5 21104.5 21352.7 21365.6 5797.0 5878.4 5992.2 5997.6 6018.1 5933.1 5996.6 6060.1 6068.3 6083.2 5758.3 5950.5 5999.0 6007.6 6013.5 5909.8 5979.4 5984.6 5990.3 6004.8 5031.4 5174.8 5257.3 5269.8 5271.6 26392.7 26432.9 26449.2 26501.5 26807.5 2728.3 2800.4 2808.9 2811.2 2834.2 5915.3 5967.1 14728.6 15125.4 15521.1 1780.3 1840.3 1840.9 1853.8 1863.6 101026.5 120752.0 122476.0 122877.0 143373.0 11544.7 11725.6 11856.7 11859.0 12034.8 15597.6 15632.8 15645.8 15649.7 15664.6 6872.7 8628.6 8659.9 8687.7 8738.5 8413.8 8437.9 8578.6 8601.3 8603.7 3894.6 4639.4 4734.7 4749.9 4859.8 1672.6 1994.2 1999.7 1999.8 2000.2 964.6 986.7 1008.6 1023.3 1027.4 22026.0 22272.0 22377.9 22478.3 22486.6 863.6 1024.9 1057.9 1060.9 1072.6 9794.6 10954.4 10962.6 11393.5 11693.9 571278.0 707520.0 715530.0 722621.0 736125.0 160051.0 160203.4 169078.0 171572.0 171928.0 941.6 970.9 1066.9 1117.9 1118.2 20155.7 20350.9 20479.5 20523.1 20546.1 61234.4 61465.7 62329.0 62680.0 62947.7 91420.0 92004.6 92999.5 94020.0 94867.0 8267.3 8530.1 8593.5 8604.7 8640.2 9410.3 12697.8 13161.9 13694.9 13817.7 11061.6 11325.6 11773.8 11779.7 11860.5 11403.7 11571.4 11687.4 11888.3 12025.7 11597.4 11892.8 11920.0 11953.3 12103.8 7252.4 7491.9 7576.6 7838.4 8521.3 9766.4 10714.6 11058.2 11516.9 11804.2 16:02:42 INFO - PROCESS | 1637 | 16:02:42 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5382.58 Median:2879.10 stddev:2932.60 (101.9%) stddev-sans-first:2925.38 16:02:42 INFO - PROCESS | 1637 | Values: 1378.0 1456.4 1477.4 1483.8 1493.0 7598.8 7650.0 8163.3 8493.5 8511.1 7467.8 7699.1 7711.4 8106.9 8297.8 2299.0 2343.4 2344.1 2347.0 2347.7 2329.9 2366.3 2367.4 2372.0 2382.8 2319.9 2322.5 2332.8 2333.1 2344.0 2296.6 2312.5 2326.6 2331.7 2333.6 2266.2 2308.0 2344.1 2351.0 2353.0 8308.9 8381.5 8405.2 8409.9 8410.4 4219.7 5174.7 5184.7 5201.7 5202.7 3303.2 3386.3 3424.4 3431.9 3438.4 1155.9 1183.4 1184.5 1225.7 1246.1 10586.9 10740.8 10741.5 10754.2 10755.2 4406.6 4609.3 4684.0 4694.0 4710.5 9494.3 9494.6 9501.6 9509.5 9515.1 5205.4 5214.4 5215.0 5226.6 5227.9 4613.0 4691.5 4700.7 4790.6 4792.4 3260.5 3743.5 3794.0 3809.3 3869.5 1236.5 1238.5 1239.5 1250.9 1260.6 787.5 796.1 813.5 817.1 820.4 5533.0 5602.1 5680.4 5698.6 5748.2 530.3 568.6 569.5 574.1 586.6 3613.3 3664.4 3766.8 3781.3 3798.6 9492.0 9898.6 9918.8 9919.4 9924.4 9667.1 9692.1 9735.4 9764.4 9889.5 7615.9 7661.8 7727.2 7735.4 7756.8 4424.5 5473.6 5499.6 5612.3 5637.8 8802.2 8810.7 9140.4 9246.9 9251.0 8534.1 9120.4 9212.8 9304.1 9416.3 6599.5 6928.4 7136.3 7164.8 7235.3 7803.7 7853.1 7908.7 7951.4 7995.1 7097.5 7129.8 7153.0 7210.7 7224.6 6991.4 7007.4 7079.5 7088.1 7147.6 5463.8 6376.4 6381.7 6404.9 6470.3 4927.7 4978.0 5019.8 5032.9 5163.3 4971.2 5010.1 5065.7 5209.3 5225.8 16:02:42 INFO - PROCESS | 1637 | 16:02:42 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4407.02 Median:4844.89 stddev:1306.37 (27.0%) stddev-sans-first:1274.01 16:02:42 INFO - PROCESS | 1637 | Values: 347.3 357.6 358.3 366.6 367.3 4259.6 4347.6 5254.8 5257.4 5284.2 4527.3 5162.3 5169.7 5186.6 5190.3 3401.7 3812.8 3965.9 3975.7 4001.5 3412.4 4028.6 4034.9 4060.7 4101.9 4059.8 4074.6 4078.7 4089.7 4110.7 3763.3 3930.2 4047.9 4101.7 4118.1 3083.8 3553.8 3621.4 3645.5 3649.4 4189.8 5036.4 5063.6 5070.9 5093.4 3961.4 4533.8 4672.9 4696.7 4713.0 4695.5 5119.7 5180.4 5310.0 5613.5 3640.9 3706.9 3906.9 4101.5 4107.6 5454.3 5476.5 5506.9 5744.8 5876.6 4014.8 4105.2 4125.1 4132.8 4159.8 3842.9 4181.5 4183.7 4191.8 4208.3 4361.5 4409.0 4463.3 4665.3 4779.4 5512.4 5579.8 5591.2 5601.8 5633.3 1156.6 1337.8 1349.1 1357.5 1358.1 904.2 957.8 958.0 963.0 975.6 4128.4 4178.6 4278.2 4815.3 4859.8 5143.2 5341.0 5353.7 5379.4 5404.6 4455.0 4519.3 4851.4 4889.2 4914.4 2399.8 2629.3 2806.3 2806.9 2828.7 4932.0 5100.4 5287.1 5537.2 5605.5 4515.2 5009.6 5222.8 5321.9 5627.8 5139.0 5233.7 5585.3 5606.0 5614.8 4825.8 4838.4 5390.4 5407.4 5429.0 4474.9 4585.0 4883.6 5545.7 5590.6 5866.8 5871.6 5889.8 5898.5 5939.3 3243.7 3395.9 3801.6 3819.0 3830.5 4815.8 5334.4 5449.7 5637.8 5661.3 5450.0 5504.6 5509.9 5513.2 5537.0 4865.9 5314.4 5425.4 5527.7 5533.6 5105.3 5329.4 5390.1 5429.4 5479.8 4565.7 4574.5 4579.4 4920.2 5519.8 4524.5 4975.4 5407.0 5412.9 5424.7 16:02:42 INFO - PROCESS | 1637 | 16:02:42 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:19492.34 Median:4686.00 stddev:27392.16 (584.6%) stddev-sans-first:27432.58 16:02:42 INFO - PROCESS | 1637 | Values: 681.0 732.9 738.0 786.5 859.7 14397.9 15392.4 15414.2 15424.9 15427.3 13606.3 14189.3 14374.1 14462.7 14473.9 576.9 858.6 877.7 878.5 883.5 693.2 706.3 831.1 855.7 863.9 918.5 920.0 921.6 922.8 924.1 916.1 917.0 917.1 917.4 922.8 525.3 544.8 590.9 653.4 672.2 14592.0 14612.0 14652.0 14800.9 14910.9 13504.0 13521.5 13650.4 13712.9 13732.5 12385.9 12471.8 12514.7 12712.5 12876.6 4446.8 4459.5 4628.0 4631.6 4634.9 99028.5 99591.5 99665.0 99767.0 102654.0 10823.9 10900.1 10934.6 11094.2 11143.5 18208.3 20743.7 21472.5 21583.2 21638.0 6984.3 7441.6 7651.1 7685.5 7741.7 4145.1 4207.9 4208.3 4218.9 4224.5 3307.0 3358.1 3358.8 3364.3 3400.2 642.5 646.2 650.5 653.5 659.1 630.9 641.8 658.8 671.7 677.5 9686.2 9723.9 9729.3 9853.0 9897.7 618.7 636.9 665.4 667.3 681.0 4670.4 4701.6 4708.9 4717.2 4802.5 85934.1 91977.0 93929.0 97970.0 101204.5 84484.0 85570.5 85722.0 86492.6 87346.0 62166.0 76257.8 77223.0 78564.2 78863.0 7753.5 9085.3 9483.3 9529.0 9658.2 41529.6 44269.8 45113.0 45731.5 47146.5 49436.5 56900.7 58901.0 64924.7 66665.0 12973.0 13144.8 13226.2 13454.7 13728.4 12462.4 14223.8 14391.0 14670.3 15272.9 13818.9 13898.3 13970.7 14070.9 14084.4 13582.0 13751.3 13949.5 14379.3 14548.3 11885.7 13480.8 13580.1 13788.0 13803.8 10527.9 11359.3 11411.0 11592.9 11878.9 8318.6 10880.4 10930.6 11126.6 11164.4 16:02:42 INFO - PROCESS | 1637 | -------- Summary: end -------- 16:02:42 INFO - PROCESS | 1637 | 16:02:43 INFO - TEST-INFO | 1637: exit 0 16:02:43 INFO - TEST-OK | dromaeo_css | took 1118519ms 16:02:43 INFO - TEST-START | kraken 16:02:43 INFO - operating with platform_type : mac_ 16:02:43 INFO - Initialising browser for kraken test... 16:02:43 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/tmpSBlTsZ/profile http://localhost:49238/getInfo.html) 16:02:45 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 16:02:45 INFO - PROCESS | 1646 | colorDepth:24 16:02:45 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 16:02:45 INFO - PROCESS | 1646 | __metrics 16:02:45 INFO - PROCESS | 1646 | 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" 16:02:45 INFO - PROCESS | 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:02:46 INFO - TEST-INFO | 1646: exit 0 16:02:46 INFO - Browser initialized. 16:02:46 INFO - Running cycle 1/1 for kraken test... 16:02:46 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/tmpSBlTsZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:02:58 INFO - PROCESS | 1647 | RSS: Main: 235339776 16:02:58 INFO - PROCESS | 1647 | 16:03:01 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-beat-detection) 16:03:02 INFO - PROCESS | 1647 | RSS: Main: 287277056 16:03:02 INFO - PROCESS | 1647 | 16:03:04 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-dft) 16:03:05 INFO - PROCESS | 1647 | RSS: Main: 287100928 16:03:05 INFO - PROCESS | 1647 | 16:03:08 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-fft) 16:03:09 INFO - PROCESS | 1647 | RSS: Main: 381825024 16:03:09 INFO - PROCESS | 1647 | 16:03:11 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-oscillator) 16:03:12 INFO - PROCESS | 1647 | RSS: Main: 284499968 16:03:12 INFO - PROCESS | 1647 | 16:03:14 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:03:14 INFO - PROCESS | 1647 | RSS: Main: 286588928 16:03:14 INFO - PROCESS | 1647 | 16:03:17 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-darkroom) 16:03:18 INFO - PROCESS | 1647 | RSS: Main: 328675328 16:03:18 INFO - PROCESS | 1647 | 16:03:21 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-desaturate) 16:03:21 INFO - PROCESS | 1647 | RSS: Main: 328384512 16:03:21 INFO - PROCESS | 1647 | 16:03:24 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49238/tests/kraken/driver.html?testName=json-parse-financial) 16:03:25 INFO - PROCESS | 1647 | RSS: Main: 327278592 16:03:25 INFO - PROCESS | 1647 | 16:03:26 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49238/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:03:27 INFO - PROCESS | 1647 | RSS: Main: 303550464 16:03:27 INFO - PROCESS | 1647 | 16:03:29 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:03:29 INFO - PROCESS | 1647 | RSS: Main: 306069504 16:03:29 INFO - PROCESS | 1647 | 16:03:32 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:03:32 INFO - PROCESS | 1647 | RSS: Main: 307503104 16:03:32 INFO - PROCESS | 1647 | 16:03:35 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:03:36 INFO - PROCESS | 1647 | RSS: Main: 326299648 16:03:36 INFO - PROCESS | 1647 | 16:03:39 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:03:40 INFO - PROCESS | 1647 | RSS: Main: 319795200 16:03:40 INFO - PROCESS | 1647 | 16:03:41 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49238/tests/kraken/driver.html?testName=ai-astar) 16:03:42 INFO - PROCESS | 1647 | RSS: Main: 364048384 16:03:42 INFO - PROCESS | 1647 | 16:03:42 INFO - PROCESS | 1647 | __start_tp_report 16:03:42 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 16:03:42 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 16:03:42 INFO - PROCESS | 1647 | |i|pagename|runs| 16:03:42 INFO - PROCESS | 1647 | |0;ai-astar;113;115;114;114;121;166;153;114;114;113 16:03:42 INFO - PROCESS | 1647 | |1;audio-beat-detection;159;138;139;146;113;112;110;110;131;110 16:03:42 INFO - PROCESS | 1647 | |2;audio-dft;186;184;184;185;185;184;210;250;183;185 16:03:42 INFO - PROCESS | 1647 | |3;audio-fft;82;59;58;90;68;82;82;83;75;58 16:03:42 INFO - PROCESS | 1647 | |4;audio-oscillator;85;70;87;70;70;70;82;68;69;79 16:03:42 INFO - PROCESS | 1647 | |5;imaging-gaussian-blur;88;86;90;87;88;86;90;86;89;86 16:03:42 INFO - PROCESS | 1647 | |6;imaging-darkroom;94;95;95;95;95;94;95;95;95;130 16:03:42 INFO - PROCESS | 1647 | |7;imaging-desaturate;84;85;85;91;87;85;86;85;85;86 16:03:42 INFO - PROCESS | 1647 | |8;json-parse-financial;56;55;54;55;56;56;56;56;56;56 16:03:42 INFO - PROCESS | 1647 | |9;json-stringify-tinderbox;65;72;68;76;73;69;70;70;70;70 16:03:42 INFO - PROCESS | 1647 | |10;stanford-crypto-aes;88;86;87;86;90;89;88;88;88;90 16:03:42 INFO - PROCESS | 1647 | |11;stanford-crypto-ccm;145;127;147;131;145;156;148;143;182;162 16:03:42 INFO - PROCESS | 1647 | |12;stanford-crypto-pbkdf2;175;175;173;174;214;174;173;174;175;174 16:03:42 INFO - PROCESS | 1647 | |13;stanford-crypto-sha256-iterative;67;67;69;67;68;68;65;67;69;82 16:03:42 INFO - PROCESS | 1647 | __end_tp_report 16:03:42 INFO - PROCESS | 1647 | __start_cc_report 16:03:42 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,2007 16:03:42 INFO - PROCESS | 1647 | __end_cc_report 16:03:42 INFO - PROCESS | 1647 | __startTimestamp1484784222101__endTimestamp 16:03:42 INFO - PROCESS | 1647 | 16:03:42 INFO - PROCESS | 1647 | ------- Summary: start ------- 16:03:42 INFO - PROCESS | 1647 | Number of tests: 14 16:03:42 INFO - PROCESS | 1647 | 16:03:42 INFO - PROCESS | 1647 | [#0] ai-astar Cycles:10 Average:123.70 Median:114.50 stddev:19.25 (16.8%) stddev-sans-first:20.03 16:03:42 INFO - PROCESS | 1647 | Values: 113.0 115.0 114.0 114.0 121.0 166.0 153.0 114.0 114.0 113.0 16:03:42 INFO - PROCESS | 1647 | 16:03:42 INFO - PROCESS | 1647 | [#1] audio-beat-detection Cycles:10 Average:126.80 Median:134.50 stddev:18.12 (13.5%) stddev-sans-first:15.01 16:03:42 INFO - PROCESS | 1647 | Values: 159.0 138.0 139.0 146.0 113.0 112.0 110.0 110.0 131.0 110.0 16:03:42 INFO - PROCESS | 1647 | 16:03:42 INFO - PROCESS | 1647 | [#2] audio-dft Cycles:10 Average:193.60 Median:185.00 stddev:21.39 (11.6%) stddev-sans-first:22.51 16:03:42 INFO - PROCESS | 1647 | Values: 186.0 184.0 184.0 185.0 185.0 184.0 210.0 250.0 183.0 185.0 16:03:42 INFO - PROCESS | 1647 | 16:03:42 INFO - PROCESS | 1647 | [#3] audio-fft Cycles:10 Average:73.70 Median:82.00 stddev:12.03 (14.7%) stddev-sans-first:12.38 16:03:42 INFO - PROCESS | 1647 | Values: 82.0 59.0 58.0 90.0 68.0 82.0 82.0 83.0 75.0 58.0 16:03:42 INFO - PROCESS | 1647 | 16:03:42 INFO - PROCESS | 1647 | [#4] audio-oscillator Cycles:10 Average:75.00 Median:74.50 stddev:7.41 (9.9%) stddev-sans-first:6.92 16:03:42 INFO - PROCESS | 1647 | Values: 85.0 70.0 87.0 70.0 70.0 70.0 82.0 68.0 69.0 79.0 16:03:42 INFO - PROCESS | 1647 | 16:03:42 INFO - PROCESS | 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:87.60 Median:88.00 stddev:1.65 (1.9%) stddev-sans-first:1.74 16:03:42 INFO - PROCESS | 1647 | Values: 88.0 86.0 90.0 87.0 88.0 86.0 90.0 86.0 89.0 86.0 16:03:42 INFO - PROCESS | 1647 | 16:03:42 INFO - PROCESS | 1647 | [#6] imaging-darkroom Cycles:10 Average:98.30 Median:95.00 stddev:11.15 (11.7%) stddev-sans-first:11.71 16:03:42 INFO - PROCESS | 1647 | Values: 94.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 130.0 16:03:42 INFO - PROCESS | 1647 | 16:03:42 INFO - PROCESS | 1647 | [#7] imaging-desaturate Cycles:10 Average:85.90 Median:85.50 stddev:1.97 (2.3%) stddev-sans-first:1.96 16:03:42 INFO - PROCESS | 1647 | Values: 84.0 85.0 85.0 91.0 87.0 85.0 86.0 85.0 85.0 86.0 16:03:42 INFO - PROCESS | 1647 | 16:03:42 INFO - PROCESS | 1647 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:0.70 (1.2%) stddev-sans-first:0.73 16:03:42 INFO - PROCESS | 1647 | Values: 56.0 55.0 54.0 55.0 56.0 56.0 56.0 56.0 56.0 56.0 16:03:42 INFO - PROCESS | 1647 | 16:03:42 INFO - PROCESS | 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:70.00 stddev:2.95 (4.2%) stddev-sans-first:2.42 16:03:42 INFO - PROCESS | 1647 | Values: 65.0 72.0 68.0 76.0 73.0 69.0 70.0 70.0 70.0 70.0 16:03:42 INFO - PROCESS | 1647 | 16:03:42 INFO - PROCESS | 1647 | [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:88.00 stddev:1.41 (1.6%) stddev-sans-first:1.50 16:03:42 INFO - PROCESS | 1647 | Values: 88.0 86.0 87.0 86.0 90.0 89.0 88.0 88.0 88.0 90.0 16:03:42 INFO - PROCESS | 1647 | 16:03:42 INFO - PROCESS | 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:148.60 Median:147.50 stddev:15.59 (10.6%) stddev-sans-first:16.48 16:03:42 INFO - PROCESS | 1647 | Values: 145.0 127.0 147.0 131.0 145.0 156.0 148.0 143.0 182.0 162.0 16:03:42 INFO - PROCESS | 1647 | 16:03:42 INFO - PROCESS | 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.10 Median:174.50 stddev:12.64 (7.2%) stddev-sans-first:13.35 16:03:42 INFO - PROCESS | 1647 | Values: 175.0 175.0 173.0 174.0 214.0 174.0 173.0 174.0 175.0 174.0 16:03:42 INFO - PROCESS | 1647 | 16:03:42 INFO - PROCESS | 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:68.00 stddev:4.75 (7.0%) stddev-sans-first:4.99 16:03:42 INFO - PROCESS | 1647 | Values: 67.0 67.0 69.0 67.0 68.0 68.0 65.0 67.0 69.0 82.0 16:03:42 INFO - PROCESS | 1647 | -------- Summary: end -------- 16:03:42 INFO - PROCESS | 1647 | 16:03:42 INFO - TEST-INFO | 1647: exit 0 16:03:43 INFO - TEST-OK | kraken | took 59638ms 16:03:43 INFO - SUITE-END | took 1178s 16:03:43 INFO - Completed test suite (00:19:38) 16:03:43 INFO - javascript benchmark 16:03:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3316.054924346561, 3340.131565792893, 3342.247994201305, 3346.9665303346974, 3397.7791443556166, 5562.833115006556, 5652.236948012017, 5664.886702265962, 5702.486776190142, 5735.569832262576, 5594.58040646951, 5610.410906854772, 5618.213450116987, 5632.605717599769, 5666.801661941833, 5083.135866902617, 5134.0758663440565, 5156.149235376159, 5169.147090730025, 5205.973970130144, 5217.0, 5236.476352364771, 5237.973810130944, 5239.030779305822, 5241.030409374259, 5224.50367215114, 5228.2680424740565, 5233.136532472137, 5233.947660523403, 5237.0, 5218.217267409881, 5235.110031294689, 5245.763940622681, 5246.108161612535, 5256.579473642099, 5010.624203184776, 5104.948950510522, 5109.642325037249, 5170.25031370453, 5225.137852254374, 5756.913646295309, 5797.333306669745, 5804.622699524517, 5806.506446952014, 5820.738066787005, 6111.297200821918, 6166.506679465677, 6180.969095154495, 6184.072389141665, 6207.782727604512, 4188.476440444944, 5545.972270138664, 6138.386161383871, 6145.661988590626, 6214.782482613087, 5806.303243610793, 5806.59353845231, 5817.650940943557, 5826.592138550303, 5831.387704291031, 6254.124422580842, 6269.780557680459, 6269.811905642838, 6273.247210334789, 6277.372262773777, 5829.8251052468495, 5863.501602363762, 5884.823455296348, 5981.910271345933, 6074.665893375906, 4887.973525559672, 5692.203091567184, 6213.565050446426, 6254.9687251563455, 6264.59280146789, 6182.845428864314, 6197.96901015492, 6203.038529028008, 6211.0, 6220.222472190976, 6089.1779609753, 6201.6899155042065, 6202.28673702521, 6253.6873156342, 6256.593321434092, 4839.056384005085, 4919.852404427873, 4933.062718083553, 4940.431850337257, 4946.406431228275, 4457.554244575581, 4469.575390337913, 4477.686561940633, 4491.438570178728, 4509.210888094571, 5264.7627807465215, 5692.8861422771315, 5757.222774925332, 5770.682612456271, 5794.62334948227, 6109.040306147876, 6168.907466388007, 6180.505559555225, 6203.131561581382, 6213.96893015532, 5711.771529138871, 5743.741531631086, 5762.798302059407, 5763.452472015152, 5812.215350927655, 5456.672599644034, 5456.781728730885, 5466.808661696901, 5469.562435005269, 5483.341998960071, 6183.96908015457, 6193.938060619336, 6264.279607844974, 6296.150019747275, 6334.271558770801, 6204.286507051746, 6213.099100630293, 6214.4407003369915, 6228.750849965951, 6231.9688401557705, 6211.161493198541, 6240.4071613196675, 6240.469560087262, 6286.15136956505, 6291.528135389955, 5233.7439014636975, 6134.509239260938, 6167.876642467215, 6178.876422471615, 6189.195404597373, 6127.20346354971, 6244.250689917239, 6254.249490061222, 6258.092576576462, 6260.874782504416, 5817.272840894888, 5934.258217722785, 6020.066889632114, 6023.6385816851125, 6125.632272693401, 5908.350081490947, 6109.526129009804, 6109.6475967989745, 6123.84690382744, 6138.602983405075, 5879.147523608967, 5930.673812940329, 5939.168516407793, 5942.435468630473, 5966.910496342472, 5898.4101589840675, 5980.37206093354, 6117.96941015292, 6122.2761798032625, 6125.479334256638, 5916.881662366643, 5921.940780592139, 5943.881122377615, 5957.344692083954, 5986.0], "value": 5655.165962146635, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [478.91858384074715, 495.91569433196355, 505.30520534265384, 514.7323391836245, 517.9821650456852, 30858.691413085864, 40156.98822588303, 42334.576654233446, 42743.93140171497, 44652.3302150468, 43692.781536092356, 43854.561454385446, 43891.0, 43898.78050609743, 43922.78038609811, 9191.356605037634, 9367.578458969328, 9372.765680857965, 9374.343795934254, 9403.905960940405, 8445.662173513052, 8684.218420342168, 10985.363512756961, 11264.4367781611, 11318.490667919963, 11240.718982025473, 11308.03881670059, 11308.321500709942, 11323.603673871416, 11338.48976796042, 8367.707130250412, 11031.558737650485, 11077.0, 11085.556577736881, 11095.889041109567, 8534.530600816952, 8597.957010214972, 8600.483970961763, 8609.225169734755, 10914.0, 39303.41044884329, 41407.37888931638, 41412.96467588304, 41422.0, 41478.792606036775, 4059.06641472463, 4078.9184216315507, 4089.3661482470266, 4108.794560272005, 4237.703360764748, 30314.54528182079, 30796.538051929016, 30924.91762788314, 31078.844605776827, 31640.525392119136, 3012.7891047626676, 3014.3217776000442, 3097.9298926296897, 3230.353929214143, 3257.4136655402017, 476900.0, 481492.0, 482381.17618824064, 483043.9999999965, 485383.5730821359, 60228.39771602228, 61270.0, 61672.0, 61676.76646467135, 61679.38320616826, 64120.717585648956, 64268.67865660642, 64287.03569446462, 64365.276166860276, 64497.35502645007, 13561.593152205449, 15579.376824927103, 16147.192640367935, 16176.514704558882, 16196.0, 11232.438378081064, 11488.597899073493, 12516.81224781629, 12589.181703189264, 12614.243145411305, 15030.924845375703, 15150.16674082914, 15151.197028549754, 15168.620784480476, 16724.916375418044, 5975.25309336333, 6506.902396464056, 6786.219584747719, 6810.455163587, 6869.931300687029, 764.7743915544928, 879.7492714576315, 905.8188362327561, 909.9863502047475, 929.7582628516634, 30244.697553024627, 30265.546016809767, 30332.848335758623, 30619.08142755721, 30963.380732385227, 1068.8663917010374, 1072.7264547540328, 1093.9343639381664, 1104.7845670094255, 1204.6867814368152, 15458.304376303093, 15748.212589370485, 15830.970986885815, 16162.676746465006, 16163.0, 612236.0, 612633.0, 616612.0, 616662.0, 617338.0, 60801.783964320464, 60841.39158608446, 60865.39134608686, 60868.0, 60894.0, 1397.343248673122, 1399.5451478269604, 1454.8981571289908, 1465.5163795947526, 1466.2522113721866, 24494.510109798062, 29876.850615746782, 29998.550021749255, 30097.0, 30198.547021794253, 46724.0, 47007.52992470031, 47099.52900470951, 51415.74292128516, 51449.0, 522504.0, 525401.0, 525715.0, 525770.0, 527350.0, 31056.068317950496, 39365.0, 40125.0, 40229.0, 40244.79877600593, 46007.07985840197, 46640.0, 46984.7650761744, 47113.52886471091, 47343.0, 38794.80602596969, 38805.41791873068, 39301.0, 40328.79835600803, 40539.39190912198, 38640.01079832631, 39311.04256142186, 39713.40429893612, 40171.79914100411, 40233.79883100566, 33215.667843322226, 37074.0, 37095.0, 37867.431988520744, 38046.809765950995, 31146.54502718968, 32002.51996220105, 33031.33937321192, 34125.65874341225, 34717.65282347144, 23980.880095599412, 24034.39914002164, 24058.39854003664, 24495.020199192546, 24663.38341541476], "value": 20104.57721282311, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.5769549626936, 381.267965506228, 381.7804762261699, 391.45978549601546, 411.0627768687392, 14873.0, 15683.686326273468, 15888.76166857498, 16740.58148546287, 20664.586708265862, 19784.90107549464, 20580.48548786281, 21104.472388190305, 21352.679709804364, 21365.572688546257, 5797.0, 5878.382769809173, 5992.161097446361, 5997.580169388145, 6018.067199584049, 5933.13969474426, 5996.640201587897, 6060.060690592965, 6068.3021452533085, 6083.209182806251, 5758.251427314443, 5950.494207992304, 5998.97000514999, 6007.6395416274945, 6013.458788709016, 5909.7636094556165, 5979.431953964367, 5984.581079324405, 5990.311114221877, 6004.819855404345, 5031.421386540522, 5174.793008279665, 5257.342832145981, 5269.789208431658, 5271.551918086967, 26392.736072639218, 26432.86783566089, 26449.206523804318, 26501.46997060048, 26807.463850722877, 2728.304282407993, 2800.397914448383, 2808.887644494218, 2811.156653004111, 2834.1639216431204, 5915.349311575723, 5967.104934259853, 14728.631784205481, 15125.394984200619, 15521.123953766464, 1780.3412737287288, 1840.2546968477789, 1840.8987505687182, 1853.8424233940132, 1863.5806943437753, 101026.49486752592, 120752.0, 122476.0, 122877.0, 143372.99999999895, 11544.653660390202, 11725.589604363806, 11856.70358241051, 11859.027225879427, 12034.75930481403, 15597.610059748371, 15632.765508517381, 15645.843541564438, 15649.687006259812, 15664.608384790472, 6872.725090996404, 8628.611712472954, 8659.913400866037, 8687.652493900174, 8738.475691458532, 8413.831723365622, 8437.915620843836, 8578.613962371708, 8601.31189504838, 8603.741887743377, 3894.571597124314, 4639.396878405786, 4734.739589322551, 4749.881252968635, 4859.781309841065, 1672.6236596765873, 1994.1923520974028, 1999.67005444103, 1999.7900220476931, 2000.21991423345, 964.5707660091332, 986.6645340584092, 1008.5814387029301, 1023.2888142740724, 1027.4143738069379, 22026.008829602706, 22271.997760100836, 22377.88811055967, 22478.32565023052, 22486.550268994528, 863.6243234193146, 1024.8565200871883, 1057.8889216632297, 1060.9469526523642, 1072.5816931396762, 9794.559244834, 10954.38999425815, 10962.561497540168, 11393.487293071832, 11693.941530292293, 571278.0, 707520.0, 715530.0, 722621.0, 736125.0, 160051.0, 160203.38271247075, 169078.0, 171572.0, 171928.0, 941.5809964565702, 970.898055704155, 1066.8506409102731, 1117.8993890549727, 1118.245184500459, 20155.697664535335, 20350.898245508677, 20479.4880127998, 20523.07646155897, 20546.075426606138, 61234.38765612287, 61465.69267153636, 62329.0, 62680.0, 62947.6852615734, 91420.0, 92004.61993069976, 92999.53500232726, 94020.0, 94867.0, 8267.255946964802, 8530.14698530142, 8593.484390936565, 8604.698835540727, 8640.204049099375, 9410.341276110606, 12697.80953285683, 13161.947044236247, 13694.863051369757, 13817.723645526832, 11061.557537698402, 11325.603603873826, 11773.76452470963, 11779.705507362041, 11860.525578976743, 11403.657890263305, 11571.421428928688, 11687.357195354338, 11888.28670279786, 12025.699357516132, 11597.362145082101, 11892.76214475723, 11919.986801122002, 11953.282803031845, 12103.818442723543, 7252.38354739853, 7491.925080749123, 7576.621168941641, 7838.413323603311, 8521.318294536546, 9766.414015159113, 10714.57141714354, 11058.170637202082, 11516.94241528787, 11804.17370784037], "value": 10005.482047392252, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1377.9724405511884, 1456.4028748213227, 1477.3868844429562, 1483.8293596236435, 1492.985070149299, 7598.772036838896, 7649.961750191255, 8163.265306122448, 8493.49039057657, 8511.148885111486, 7467.813304667386, 7699.114601820792, 7711.421643376755, 8106.878396824052, 8297.83404331913, 2298.9885050574767, 2343.414146463384, 2344.097522453859, 2347.01425401331, 2347.6595893595418, 2329.860208387494, 2366.2782851230368, 2367.3844800351862, 2371.95256094878, 2382.821288403368, 2319.860808351496, 2322.512272422793, 2332.8367014309006, 2333.0784340185614, 2344.0, 2296.5521723263887, 2312.5259321839153, 2326.6161083421216, 2331.6502524621274, 2333.6032874411308, 2266.240809328877, 2307.9884600577057, 2344.10923848938, 2351.0, 2352.9647055294186, 8308.875366869503, 8381.539015354154, 8405.159484051606, 8409.915900840975, 8410.36922230835, 4219.662427005863, 5174.715390653512, 5184.7407629618365, 5201.687898726051, 5202.687838729688, 3303.240254741423, 3386.3058073095203, 3424.434968230239, 3431.9485207721905, 3438.415469370213, 1155.8728539860608, 1183.4260383713893, 1184.5321098166262, 1225.7487215120968, 1246.1214843535286, 10586.947065264625, 10740.785184296348, 10741.51663175159, 10754.247202695815, 10755.247132700713, 4406.5593440655675, 4609.262517997105, 4684.0, 4693.9765301173275, 4710.481846996828, 9494.335396522178, 9494.572744226527, 9501.619935202652, 9509.476978766234, 9515.143637072697, 5205.375354957429, 5214.426413094557, 5215.0, 5226.555742761831, 5227.895442091137, 4612.976935115303, 4691.483936766953, 4700.741459219707, 4790.640701947368, 4792.353032340659, 3260.4620237660993, 3743.457198706172, 3793.962060379361, 3809.3333666608232, 3869.5356557213313, 1236.4806781151938, 1238.5293588436336, 1239.4608345369793, 1250.8999280057574, 1260.577706468325, 787.5038725602833, 796.100406540617, 813.4753084260619, 817.0889458254122, 820.3970081989733, 5533.0, 5602.1036634139155, 5680.375158732536, 5698.629589076697, 5748.19525266463, 530.3105962249061, 568.6275489554348, 569.4533248081805, 574.1187277528973, 586.642148289543, 3613.259281847215, 3664.358737220976, 3766.849326026983, 3781.3382658034734, 3798.639129282714, 9491.952540237255, 9898.60405583783, 9918.752031199278, 9919.40483570988, 9924.354916930377, 9667.129958303787, 9692.127708506268, 9735.41587504752, 9764.365316254421, 9889.505524723734, 7615.923840761632, 7661.808454788675, 7727.1886451922865, 7735.381169506426, 7756.806079848049, 4424.491183513937, 5473.562115030868, 5499.560035197254, 5612.326520817528, 5637.830865074055, 8802.163794439519, 8810.695989004123, 9140.360174787702, 9246.861297080415, 9250.95374523123, 8534.146585341665, 9120.361574689709, 9212.815743685223, 9304.116108969638, 9416.340856140005, 6599.53803233769, 6928.411085057826, 7136.3220494052985, 7164.785056448315, 7235.34881860614, 7803.687852486064, 7853.1361550228285, 7908.683652653829, 7951.403644726553, 7995.120536740837, 7097.46768992338, 7129.750458733919, 7153.0343403639845, 7210.74762383335, 7224.638768061471, 6991.405730512964, 7007.404370628554, 7079.52293195172, 7088.149422069385, 7147.571145731273, 5463.754131064032, 6376.426121649074, 6381.680915954276, 6404.935950640434, 6470.288268290578, 4927.728974906415, 4978.0, 5019.824306149268, 5032.924506132485, 5163.251328557413, 4971.15618319165, 5010.073136469765, 5065.721385323695, 5209.270702101633, 5225.817096401608], "value": 4329.586160391708, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.34005389759454, 357.60484664445795, 358.2941605038076, 366.56745040851786, 367.3332900785075, 4259.552746961571, 4347.586979236975, 5254.789808407664, 5257.421683614799, 5284.233786101013, 4527.253003254467, 5162.251473536335, 5169.715665638389, 5186.636935414523, 5190.299309593203, 3401.710854577364, 3812.7902965336893, 3965.9405108923247, 3975.70182236332, 4001.4798076250045, 3412.385770561298, 4028.6374226319626, 4034.8500677306974, 4060.6751459883285, 4101.938470922939, 4059.817308221137, 4074.57216992216, 4078.675155161559, 4089.672826173914, 4110.650594699454, 3763.3226019316376, 3930.1506407854363, 4047.8785636430953, 4101.712880098395, 4118.146833924731, 3083.753299736016, 3553.751237413382, 3621.420572708354, 3645.505342809462, 3649.376027667689, 4189.790510474494, 5036.445990940993, 5063.645404886745, 5070.884405430799, 5093.363329583802, 3961.3859851723028, 4533.84131555394, 4672.859814205579, 4696.671233013691, 4713.0, 4695.506971767949, 5119.744012799345, 5180.430152683201, 5310.0, 5613.494785469286, 3640.8725694600826, 3706.8517259309597, 3906.8632597858937, 4101.487314085739, 4107.609777071173, 5454.300121439873, 5476.452354764531, 5506.862328441781, 5744.793593345445, 5876.588638795286, 4014.8394064237687, 4105.240530501807, 4125.071858831739, 4132.8140233689555, 4159.750414975111, 3842.9423558646645, 4181.540030596632, 4183.707140500136, 4191.790410479463, 4208.284591619432, 4361.454818147731, 4408.955910440919, 4463.263561512379, 4665.2768820832825, 4779.351123862262, 5512.448755124456, 5579.832605021856, 5591.189277554732, 5601.775928962796, 5633.253886165654, 1156.6298784389082, 1337.8461476930277, 1349.0826238157952, 1357.470586471277, 1358.130796290375, 904.2172809168975, 957.8371676814958, 957.9952100239593, 962.9662961796444, 975.6390135649855, 4128.41973766396, 4178.603032711888, 4278.165757677285, 4815.277708343777, 4859.805607775649, 5143.202803565453, 5341.035725172566, 5353.678779273256, 5379.408265090837, 5404.6488377905525, 4454.977725111354, 4519.344695019269, 4851.417829860439, 4889.193283108248, 4914.36113305268, 2399.7720216579396, 2629.250663560876, 2806.312453448918, 2806.9017584384446, 2828.717128287155, 4931.975340123348, 5100.393376086595, 5287.113971231142, 5537.197106419547, 5605.467480589337, 4515.245700122922, 5009.649324547319, 5222.817201397933, 5321.946780532223, 5627.822403388892, 5139.023585518739, 5233.685978841282, 5585.329760428694, 5605.999999999918, 5614.775408983676, 4825.806967721252, 4838.371011768448, 5390.353157621111, 5407.405185429521, 5429.0, 4474.865754027384, 4584.954150458453, 4883.584895283941, 5545.667259964415, 5590.580706447114, 5866.823995280149, 5871.588988770745, 5889.793857214977, 5898.528117750656, 5939.3466718661775, 3243.7242834359345, 3395.94906076414, 3801.6008319126095, 3819.0141126614562, 3830.5020347354666, 4815.7847390200905, 5334.359876814807, 5449.694741154443, 5637.829435667216, 5661.2733116399895, 5449.964506743706, 5504.568812108801, 5509.944900550943, 5513.2005859151, 5537.0, 4865.880847405046, 5314.443710877558, 5425.430329815313, 5527.668339899619, 5533.5849811265125, 5105.285260063668, 5329.413764485981, 5390.083685773349, 5429.40276569585, 5479.835604931858, 4565.657575681771, 4574.496805351342, 4579.38178345919, 4920.237363208708, 5519.779208831602, 4524.479684836154, 4975.353204083446, 5407.0, 5412.891742165056, 5424.721616920981], "value": 4013.1270820243685, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [680.9761658341957, 732.9157146928105, 737.9667914943824, 786.4573444323416, 859.6991053131403, 14397.928010359947, 15392.384304627802, 15414.229288535571, 15424.92287538562, 15427.305771240293, 13606.319684015809, 14189.290535473237, 14374.06568573042, 14462.710745785078, 14473.914456415758, 576.9019266724667, 858.6393714639851, 877.6752601537409, 878.4641368765048, 883.465503370458, 693.1647364925253, 706.3113464372221, 831.085805613826, 855.6534603485567, 863.9222469977701, 918.545320066568, 920.0477505781517, 921.6267411698273, 922.7646950027768, 924.1128516624049, 916.0884919505102, 917.0142097245488, 917.124146440148, 917.3761841947473, 922.7877588154695, 525.2672521832061, 544.77119609764, 590.8965930962107, 653.4347789162388, 672.1598002496879, 14592.0, 14612.0, 14652.047616904867, 14800.925995370062, 14910.850891491054, 13504.0, 13521.459141634323, 13650.385732642055, 13712.93143534286, 13732.45070197191, 12385.906857264941, 12471.812922806164, 12514.687132821662, 12712.491500339975, 12876.613701588967, 4446.799894004777, 4459.487158976727, 4627.981843994316, 4631.60631346336, 4634.884127896796, 99028.50485747597, 99591.50204248933, 99665.0, 99767.0, 102654.0, 10823.945880270549, 10900.1279897608, 10934.617288395028, 11094.223404361617, 11143.498542565603, 18208.27166913335, 20743.688844667344, 21472.463188420414, 21583.2445864394, 21637.996970560496, 6984.3364880336285, 7441.55350678961, 7651.120121186135, 7685.538867667846, 7741.690332386642, 4145.1295228002455, 4207.915841683211, 4208.326667733148, 4218.894527636772, 4224.471941007374, 3306.966930330714, 3358.126887009395, 3358.781679190845, 3364.3439529291554, 3400.234947136924, 642.5079691874677, 646.2342124582385, 650.4991156809325, 653.5392548253565, 659.0838734159522, 630.8864404407251, 641.8202903187115, 658.7957733102658, 671.727950180168, 677.4824393358841, 9686.225101991824, 9723.85414218773, 9729.270304727173, 9852.95073524642, 9897.653582124734, 618.6968385491077, 636.8885445047098, 665.364576829127, 667.2526770017612, 681.0363335879774, 4670.369500117441, 4701.623870090453, 4708.9058218835435, 4717.22165842639, 4802.495737947465, 85934.14065859387, 91977.0, 93929.0, 97970.0, 101204.4939775311, 84484.0, 85570.49478119797, 85722.0, 86492.56753716317, 87346.0, 62166.0, 76257.79875219938, 77223.0, 78564.21435785684, 78863.0, 7753.4960227585025, 9085.318601105077, 9483.336166468282, 9529.0, 9658.227341812779, 41529.58470415257, 44269.778651106535, 45113.0, 45731.54268457273, 47146.52853471559, 49436.50563494463, 56900.71549642225, 58901.0, 64924.675376622814, 66665.0, 12973.027022973127, 13144.802827957397, 13226.206427614374, 13454.730905382034, 13728.358815915191, 12462.376881156088, 14223.786643200154, 14390.992630516183, 14670.26648667541, 15272.923635382196, 13818.930905345409, 13898.30508474552, 13970.720585588027, 14070.861599061063, 14084.436622535393, 13582.0, 13751.312434378042, 13949.511767088103, 14379.281035947952, 14548.344529750379, 11885.702857428634, 13480.797788033384, 13580.117292375964, 13788.0, 13803.79294310566, 10527.894721052691, 11359.261647992855, 11411.0, 11592.88407115918, 11878.881211188123, 8318.584070796314, 10880.401577913291, 10930.617428389969, 11126.554937802397, 11164.385958772345], "value": 7365.303071328966, "unit": "score"}], "name": "dromaeo_css", "value": 7253.117442488713, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 114.0, 121.0, 166.0, 153.0, 114.0, 114.0, 113.0], "value": 123.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 138.0, 139.0, 146.0, 113.0, 112.0, 110.0, 110.0, 131.0, 110.0], "value": 126.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 184.0, 185.0, 185.0, 184.0, 210.0, 250.0, 183.0, 185.0], "value": 193.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 58.0, 90.0, 68.0, 82.0, 82.0, 83.0, 75.0, 58.0], "value": 73.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 87.0, 70.0, 70.0, 70.0, 82.0, 68.0, 69.0, 79.0], "value": 75.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 90.0, 87.0, 88.0, 86.0, 90.0, 86.0, 89.0, 86.0], "value": 87.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 130.0], "value": 98.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 91.0, 87.0, 85.0, 86.0, 85.0, 85.0, 86.0], "value": 85.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 55.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 68.0, 76.0, 73.0, 69.0, 70.0, 70.0, 70.0, 70.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 87.0, 86.0, 90.0, 89.0, 88.0, 88.0, 88.0, 90.0], "value": 88.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 127.0, 147.0, 131.0, 145.0, 156.0, 148.0, 143.0, 182.0, 162.0], "value": 148.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 175.0, 173.0, 174.0, 214.0, 174.0, 173.0, 174.0, 175.0, 174.0], "value": 178.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 69.0, 67.0, 68.0, 68.0, 65.0, 67.0, 69.0, 82.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1474.1, "alertThreshold": 2.0}]} 16:03:43 INFO - Return code: 0 16:03:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:03:43 ERROR - # TBPL SUCCESS # 16:03:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:03:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:03:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:03:43 INFO - 2017-01-18 16:03:43.405 screenresolution[1651:9625] starting screenresolution argv=screenresolution get 16:03:43 INFO - 2017-01-18 16:03:43.408 screenresolution[1651:9625] Display 0: 1600x1200x32@60 16:03:43 INFO - 2017-01-18 16:03:43.414 screenresolution[1652:9628] starting screenresolution argv=screenresolution list 16:03:43 INFO - Available Modes on Display 0 16:03:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:03:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:03:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:03:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:03:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:03:43 INFO - Intel Iris: 16:03:43 INFO - Chipset Model: Intel Iris 16:03:43 INFO - Type: GPU 16:03:43 INFO - Bus: Built-In 16:03:43 INFO - VRAM (Dynamic, Max): 1536 MB 16:03:43 INFO - Vendor: Intel (0x8086) 16:03:43 INFO - Device ID: 0x0a2e 16:03:43 INFO - Revision ID: 0x0009 16:03:43 INFO - Displays: 16:03:43 INFO - Display: 16:03:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:03:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:03:43 INFO - Display Serial Number: 1600x1200 60 16:03:43 INFO - Main Display: Yes 16:03:43 INFO - Mirror: Off 16:03:43 INFO - Online: Yes 16:03:43 INFO - Rotation: Supported 16:03:43 INFO - Return code: 0 16:03:43 INFO - Running post-action listener: _resource_record_post_action 16:03:43 INFO - [mozharness: 2017-01-19 00:03:43.651404Z] Finished run-tests step (success) 16:03:43 INFO - Running post-run listener: _resource_record_post_run 16:03:43 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 38491136; Write bytes: 551881216; Read time: 380; Write time: 1629 16:03:43 INFO - TinderboxPrint: CPU usage
53.6% 16:03:43 INFO - TinderboxPrint: I/O read bytes / time
38,491,136 / 380 16:03:43 INFO - TinderboxPrint: I/O write bytes / time
551,881,216 / 1,629 16:03:43 INFO - TinderboxPrint: CPU idle
2,227.6 (46.4%) 16:03:43 INFO - TinderboxPrint: CPU system
956.6 (19.9%) 16:03:43 INFO - TinderboxPrint: CPU user
1,621.4 (33.7%) 16:03:43 INFO - TinderboxPrint: Swap in / out
289,095,680 / 0 16:03:43 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 247114240; Write bytes: 239370240; Read time: 17799; Write time: 443 16:03:43 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 35267584; Write bytes: 298617344; Read time: 345; Write time: 1148 16:03:44 INFO - Running post-run listener: _upload_blobber_files 16:03:44 INFO - Blob upload gear active. 16:03:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:03:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:03:44 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'] 16:03:44 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 16:03:44 INFO - (blobuploader) - INFO - Open directory for files ... 16:03:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:03:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:03:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:03:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:03:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:03:45 INFO - (blobuploader) - INFO - Done attempting. 16:03:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:03:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:03:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:03:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:03:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:03:46 INFO - (blobuploader) - INFO - Done attempting. 16:03:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:03:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:03:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:03:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:03:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:03:47 INFO - (blobuploader) - INFO - Done attempting. 16:03:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:03:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:03:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:03:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:03:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:03:49 INFO - (blobuploader) - INFO - Done attempting. 16:03:49 INFO - (blobuploader) - INFO - Iteration through files over. 16:03:49 INFO - Return code: 0 16:03:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:03:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:03:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df1095ac1ddbf0b9f2565a52bb3463d73eff1c4573ea4b8366609dfb5ca6e534f9edcf99e219a08354db5798e51c952bfab2ebad42d8a20335ee9dcfd67bcf45", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06f7f61328e66aba8b8fa47e3d15d26d877188d97f83d7c1bd65b2e914351500d28c6cf635e40f0a1b7a8e7a4564e240772715ad4a7557add06cadb66e19b01e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18747c456e7aa13b09bbbbe5ee7add1b99ea42f91ac7c5b82bc18d71eb21477712121bd04ffe738701bfd31531118cd97e23b8875934da89051c31e0737717fd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/839bfa46f3db2582423d44976dd51b21d87f4fcb5bd3c0aa391b1be3583407d0f7cddae2e234b5570fcd5cc4313f8f16557815d3dd59ee25f5cae3d174f74556"} 16:03:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:03:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:03:49 INFO - Contents: 16:03:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df1095ac1ddbf0b9f2565a52bb3463d73eff1c4573ea4b8366609dfb5ca6e534f9edcf99e219a08354db5798e51c952bfab2ebad42d8a20335ee9dcfd67bcf45", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06f7f61328e66aba8b8fa47e3d15d26d877188d97f83d7c1bd65b2e914351500d28c6cf635e40f0a1b7a8e7a4564e240772715ad4a7557add06cadb66e19b01e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18747c456e7aa13b09bbbbe5ee7add1b99ea42f91ac7c5b82bc18d71eb21477712121bd04ffe738701bfd31531118cd97e23b8875934da89051c31e0737717fd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/839bfa46f3db2582423d44976dd51b21d87f4fcb5bd3c0aa391b1be3583407d0f7cddae2e234b5570fcd5cc4313f8f16557815d3dd59ee25f5cae3d174f74556"} 16:03:49 INFO - Running post-run listener: copy_logs_to_upload_dir 16:03:49 INFO - Copying logs to upload dir... 16:03:49 INFO - mkdir: /builds/slave/test/build/upload/logs 16:03:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.587066 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-18 16:03:49.992874) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-18 16:03:49.996242) ========= 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.NHMjPS1Mdv/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.FdWWBLb5D2/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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/df1095ac1ddbf0b9f2565a52bb3463d73eff1c4573ea4b8366609dfb5ca6e534f9edcf99e219a08354db5798e51c952bfab2ebad42d8a20335ee9dcfd67bcf45", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06f7f61328e66aba8b8fa47e3d15d26d877188d97f83d7c1bd65b2e914351500d28c6cf635e40f0a1b7a8e7a4564e240772715ad4a7557add06cadb66e19b01e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18747c456e7aa13b09bbbbe5ee7add1b99ea42f91ac7c5b82bc18d71eb21477712121bd04ffe738701bfd31531118cd97e23b8875934da89051c31e0737717fd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/839bfa46f3db2582423d44976dd51b21d87f4fcb5bd3c0aa391b1be3583407d0f7cddae2e234b5570fcd5cc4313f8f16557815d3dd59ee25f5cae3d174f74556"} build_url:https://queue.taskcluster.net/v1/task/IyYWTlttSluTXijksNqKFg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011144 build_url: 'https://queue.taskcluster.net/v1/task/IyYWTlttSluTXijksNqKFg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df1095ac1ddbf0b9f2565a52bb3463d73eff1c4573ea4b8366609dfb5ca6e534f9edcf99e219a08354db5798e51c952bfab2ebad42d8a20335ee9dcfd67bcf45", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06f7f61328e66aba8b8fa47e3d15d26d877188d97f83d7c1bd65b2e914351500d28c6cf635e40f0a1b7a8e7a4564e240772715ad4a7557add06cadb66e19b01e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18747c456e7aa13b09bbbbe5ee7add1b99ea42f91ac7c5b82bc18d71eb21477712121bd04ffe738701bfd31531118cd97e23b8875934da89051c31e0737717fd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/839bfa46f3db2582423d44976dd51b21d87f4fcb5bd3c0aa391b1be3583407d0f7cddae2e234b5570fcd5cc4313f8f16557815d3dd59ee25f5cae3d174f74556"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-18 16:03:50.031588) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 16:03:50.032016) ========= 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.NHMjPS1Mdv/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.FdWWBLb5D2/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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.005075 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 16:03:50.081049) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-18 16:03:50.081437) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-18 16:03:50.081854) ========= ========= Total master_lag: 0.18 =========