builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0163 starttime: 1492675632.74 results: success (0) buildid: 20170420002927 builduid: 3e6c7fc84f1d47a69e0d7f6fc4babd94 revision: f6be27f5457ffd75b3763db09a139e24bc2155dc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-20 01:07:12.735517) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-20 01:07:12.736001) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-20 01:07:12.736280) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-20 01:07:12.762992) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 01:07:12.763392) ========= 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.MQzx2FiK5Q/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.UntVS59VLp/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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-04-20 01:07:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 68.3M=0s 2017-04-20 01:07:12 (68.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131771 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 01:07:12.919486) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 01:07:12.919856) ========= 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.MQzx2FiK5Q/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.UntVS59VLp/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.028361 ========= master_lag: 0.11 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 01:07:13.061269) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-20 01:07:13.061623) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f6be27f5457ffd75b3763db09a139e24bc2155dc --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 f6be27f5457ffd75b3763db09a139e24bc2155dc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MQzx2FiK5Q/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.UntVS59VLp/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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-04-20 01:07:13,175 truncating revision to first 12 chars 2017-04-20 01:07:13,175 Setting DEBUG logging. 2017-04-20 01:07:13,175 attempt 1/10 2017-04-20 01:07:13,175 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f6be27f5457f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-20 01:07:14,987 unpacking tar archive at: mozilla-central-f6be27f5457f/testing/mozharness/ program finished with exit code 0 elapsedTime=2.088280 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-20 01:07:15.174106) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-20 01:07:15.174512) ========= script_repo_revision: f6be27f5457ffd75b3763db09a139e24bc2155dc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-20 01:07:15.175381) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-20 01:07:15.175710) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-20 01:07:15.195631) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-20 01:07:15.196064) ========= /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.MQzx2FiK5Q/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.UntVS59VLp/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 01:07:15 INFO - MultiFileLogger online at 20170420 01:07:15 in /builds/slave/test 01:07:15 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 01:07:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:07:15 INFO - {'append_to_log': False, 01:07:15 INFO - 'base_work_dir': '/builds/slave/test', 01:07:15 INFO - 'blob_upload_branch': 'Firefox', 01:07:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:07:15 INFO - 'branch': 'Firefox', 01:07:15 INFO - 'buildbot_json_path': 'buildprops.json', 01:07:15 INFO - 'config_files': ('talos/mac_config.py',), 01:07:15 INFO - 'default_actions': ('clobber', 01:07:15 INFO - 'read-buildbot-config', 01:07:15 INFO - 'download-and-extract', 01:07:15 INFO - 'populate-webroot', 01:07:15 INFO - 'create-virtualenv', 01:07:15 INFO - 'install', 01:07:15 INFO - 'run-tests'), 01:07:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:07:15 INFO - 'download_minidump_stackwalk': True, 01:07:15 INFO - 'download_symbols': 'ondemand', 01:07:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:07:15 INFO - 'tooltool.py': '/tools/tooltool.py', 01:07:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:07:15 INFO - '/tools/misc-python/virtualenv.py')}, 01:07:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:07:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:07:15 INFO - 'gecko_profile': False, 01:07:15 INFO - 'gecko_profile_interval': 0, 01:07:15 INFO - 'installer_path': 'installer.exe', 01:07:15 INFO - 'log_level': 'info', 01:07:15 INFO - 'log_name': 'talos', 01:07:15 INFO - 'log_to_console': True, 01:07:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:07:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:07:15 INFO - 'opt_config_files': (), 01:07:15 INFO - 'pip_index': False, 01:07:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:07:15 INFO - 'cmd': ('bash', 01:07:15 INFO - '-c', 01:07:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:07:15 INFO - 'enabled': True, 01:07:15 INFO - 'halt_on_failure': False, 01:07:15 INFO - 'name': 'check_screen_resolution'},), 01:07:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:07:15 INFO - 'cmd': ('bash', 01:07:15 INFO - '-c', 01:07:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:07:15 INFO - 'enabled': True, 01:07:15 INFO - 'halt_on_failure': False, 01:07:15 INFO - 'name': 'check_screen_resolution'},), 01:07:15 INFO - 'run_cmd_checks_enabled': True, 01:07:15 INFO - 'suite': 'dromaeojs', 01:07:15 INFO - 'system_bits': '32', 01:07:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:07:15 INFO - 'title': 't-yosemite-r7-0163', 01:07:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:07:15 INFO - 'use_talos_json': True, 01:07:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:07:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:07:15 INFO - 'work_dir': 'build'} 01:07:15 INFO - [mozharness: 2017-04-20 08:07:15.419266Z] Running clobber step. 01:07:15 INFO - Running pre-action listener: _resource_record_pre_action 01:07:15 INFO - Running main action method: clobber 01:07:15 INFO - rmtree: /builds/slave/test/build 01:07:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:07:18 INFO - Running post-action listener: _resource_record_post_action 01:07:18 INFO - [mozharness: 2017-04-20 08:07:18.021207Z] Finished clobber step (success) 01:07:18 INFO - [mozharness: 2017-04-20 08:07:18.021333Z] Running read-buildbot-config step. 01:07:18 INFO - Running pre-action listener: _resource_record_pre_action 01:07:18 INFO - Running main action method: read_buildbot_config 01:07:18 INFO - Using buildbot properties: 01:07:18 INFO - { 01:07:18 INFO - "project": "", 01:07:18 INFO - "product": "firefox", 01:07:18 INFO - "script_repo_revision": "production", 01:07:18 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 01:07:18 INFO - "repository": "", 01:07:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 01:07:18 INFO - "buildid": "20170420002927", 01:07:18 INFO - "pgo_build": "False", 01:07:18 INFO - "basedir": "/builds/slave/test", 01:07:18 INFO - "buildnumber": 15, 01:07:18 INFO - "slavename": "t-yosemite-r7-0163", 01:07:18 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 01:07:18 INFO - "platform": "yosemite_r7", 01:07:18 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 01:07:18 INFO - "branch": "mozilla-central", 01:07:18 INFO - "repo_path": "mozilla-central", 01:07:18 INFO - "revision": "f6be27f5457ffd75b3763db09a139e24bc2155dc", 01:07:18 INFO - "stage_platform": "macosx64", 01:07:18 INFO - "builduid": "3e6c7fc84f1d47a69e0d7f6fc4babd94", 01:07:18 INFO - "slavebuilddir": "test" 01:07:18 INFO - } 01:07:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/SwJPNy_TRdKF1CSMbOzHyg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 01:07:18 INFO - Running post-action listener: _resource_record_post_action 01:07:18 INFO - [mozharness: 2017-04-20 08:07:18.024653Z] Finished read-buildbot-config step (success) 01:07:18 INFO - [mozharness: 2017-04-20 08:07:18.024785Z] Running download-and-extract step. 01:07:18 INFO - Running pre-action listener: _resource_record_pre_action 01:07:18 INFO - Running main action method: download_and_extract 01:07:18 INFO - mkdir: /builds/slave/test/build/tests 01:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:07:18 INFO - trying https://queue.taskcluster.net/v1/task/SwJPNy_TRdKF1CSMbOzHyg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 01:07:18 INFO - Downloading https://queue.taskcluster.net/v1/task/SwJPNy_TRdKF1CSMbOzHyg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 01:07:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SwJPNy_TRdKF1CSMbOzHyg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 01:07:19 INFO - Downloaded 1325 bytes. 01:07:19 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 01:07:19 INFO - Using the following test package requirements: 01:07:19 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 01:07:19 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 01:07:19 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 01:07:19 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 01:07:19 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 01:07:19 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 01:07:19 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 01:07:19 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 01:07:19 INFO - u'jsshell-mac.zip'], 01:07:19 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 01:07:19 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 01:07:19 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 01:07:19 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 01:07:19 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 01:07:19 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 01:07:19 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 01:07:19 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 01:07:19 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 01:07:19 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 01:07:19 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 01:07:19 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:07:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SwJPNy_TRdKF1CSMbOzHyg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 01:07:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SwJPNy_TRdKF1CSMbOzHyg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:07:19 INFO - Fetch https://queue.taskcluster.net/v1/task/SwJPNy_TRdKF1CSMbOzHyg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 01:07:20 INFO - Expected file size: 52518658 01:07:20 INFO - Obtained file size: 52518658 01:07:37 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 01:07:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SwJPNy_TRdKF1CSMbOzHyg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 01:07:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SwJPNy_TRdKF1CSMbOzHyg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:07:37 INFO - Fetch https://queue.taskcluster.net/v1/task/SwJPNy_TRdKF1CSMbOzHyg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 01:07:39 INFO - Expected file size: 52518658 01:07:39 INFO - Obtained file size: 52518658 01:07:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SwJPNy_TRdKF1CSMbOzHyg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 01:07:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SwJPNy_TRdKF1CSMbOzHyg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 01:07:54 INFO - Fetch https://queue.taskcluster.net/v1/task/SwJPNy_TRdKF1CSMbOzHyg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 01:07:55 INFO - Expected file size: 14408811 01:07:55 INFO - Obtained file size: 14408811 01:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:07:55 INFO - trying https://queue.taskcluster.net/v1/task/SwJPNy_TRdKF1CSMbOzHyg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 01:07:55 INFO - Downloading https://queue.taskcluster.net/v1/task/SwJPNy_TRdKF1CSMbOzHyg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 01:07:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SwJPNy_TRdKF1CSMbOzHyg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 01:07:58 INFO - Downloaded 70961948 bytes. 01:07:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SwJPNy_TRdKF1CSMbOzHyg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 01:07:58 INFO - mkdir: /builds/slave/test/properties 01:07:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:07:58 INFO - Writing to file /builds/slave/test/properties/build_url 01:07:58 INFO - Contents: 01:07:58 INFO - build_url:https://queue.taskcluster.net/v1/task/SwJPNy_TRdKF1CSMbOzHyg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 01:07:58 INFO - Running post-action listener: _resource_record_post_action 01:07:58 INFO - Running post-action listener: set_extra_try_arguments 01:07:58 INFO - [mozharness: 2017-04-20 08:07:58.692560Z] Finished download-and-extract step (success) 01:07:58 INFO - [mozharness: 2017-04-20 08:07:58.692699Z] Running populate-webroot step. 01:07:58 INFO - Running pre-action listener: _resource_record_pre_action 01:07:58 INFO - Running main action method: populate_webroot 01:07:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:07:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:07:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:07:58 INFO - '--tppagecycles', 01:07:58 INFO - '7'], 01:07:58 INFO - 'tests': ['tsvgm']}}, 01:07:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:07:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:07:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:07:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:07:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:07:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:07:58 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:07:58 INFO - 'talos_options': ['--disable-e10s'], 01:07:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:07:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:07:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:07:58 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:07:58 INFO - 'talos_options': ['--disable-e10s'], 01:07:58 INFO - 'tests': ['damp', 'tps']}, 01:07:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:07:58 INFO - 'tests': ['damp', 'tps']}, 01:07:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:07:58 INFO - 'tests': ['dromaeo_dom']}, 01:07:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:07:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:07:58 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 01:07:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 01:07:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:07:58 INFO - 'tests': ['a11yr', 01:07:58 INFO - 'ts_paint', 01:07:58 INFO - 'tpaint', 01:07:58 INFO - 'sessionrestore', 01:07:58 INFO - 'sessionrestore_no_auto_restore', 01:07:58 INFO - 'tabpaint']}, 01:07:58 INFO - 'other-e10s': {'tests': ['a11yr', 01:07:58 INFO - 'ts_paint', 01:07:58 INFO - 'tpaint', 01:07:58 INFO - 'sessionrestore', 01:07:58 INFO - 'sessionrestore_no_auto_restore', 01:07:58 INFO - 'tabpaint']}, 01:07:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:07:58 INFO - 'ts_paint', 01:07:58 INFO - 'tpaint', 01:07:58 INFO - 'sessionrestore', 01:07:58 INFO - 'sessionrestore_no_auto_restore', 01:07:58 INFO - 'tabpaint']}, 01:07:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:07:58 INFO - 'ts_paint', 01:07:58 INFO - 'tpaint', 01:07:58 INFO - 'sessionrestore', 01:07:58 INFO - 'sessionrestore_no_auto_restore', 01:07:58 INFO - 'tabpaint']}, 01:07:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:07:58 INFO - 'tests': ['a11yr', 01:07:58 INFO - 'ts_paint', 01:07:58 INFO - 'tpaint', 01:07:58 INFO - 'sessionrestore', 01:07:58 INFO - 'sessionrestore_no_auto_restore', 01:07:58 INFO - 'tabpaint']}, 01:07:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:07:58 INFO - 'tests': ['a11yr', 01:07:58 INFO - 'ts_paint', 01:07:58 INFO - 'tpaint', 01:07:58 INFO - 'sessionrestore', 01:07:58 INFO - 'sessionrestore_no_auto_restore', 01:07:58 INFO - 'tabpaint']}, 01:07:58 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 01:07:58 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 01:07:58 INFO - 'bloom_basic_ref']}, 01:07:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:07:58 INFO - 'tests': ['tsvgx', 01:07:58 INFO - 'tsvgr_opacity', 01:07:58 INFO - 'tart', 01:07:58 INFO - 'tscrollx', 01:07:58 INFO - 'cart', 01:07:58 INFO - 'tsvg_static']}, 01:07:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:07:58 INFO - 'tsvgr_opacity', 01:07:58 INFO - 'tart', 01:07:58 INFO - 'tscrollx', 01:07:58 INFO - 'cart', 01:07:58 INFO - 'tsvg_static']}, 01:07:58 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:07:58 INFO - 'talos_options': ['--disable-e10s'], 01:07:58 INFO - 'tests': ['tp5o']}, 01:07:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:07:58 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:07:58 INFO - 'talos_options': ['--disable-e10s', 01:07:58 INFO - '--xperf_path', 01:07:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:07:58 INFO - 'tests': ['tp5n']}, 01:07:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:07:58 INFO - 'talos_options': ['--xperf_path', 01:07:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:07:58 INFO - 'tests': ['tp5n']}}, 01:07:58 INFO - 'talos.zip': {'path': '', 01:07:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:07:58 INFO - Running post-action listener: _resource_record_post_action 01:07:58 INFO - [mozharness: 2017-04-20 08:07:58.711915Z] Finished populate-webroot step (success) 01:07:58 INFO - [mozharness: 2017-04-20 08:07:58.712047Z] Running create-virtualenv step. 01:07:58 INFO - Running pre-action listener: _resource_record_pre_action 01:07:58 INFO - Running main action method: create_virtualenv 01:07:58 INFO - Creating virtualenv /builds/slave/test/build/venv 01:07:58 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 01:07:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:07:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:07:58 INFO - Using real prefix '/tools/python27' 01:07:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:07:59 INFO - Installing distribute.............................................................................................................................................................................................done. 01:08:02 INFO - Installing pip.................done. 01:08:02 INFO - Return code: 0 01:08:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:08:02 INFO - Reading from file tmpfile_stdout 01:08:02 INFO - Output received: 01:08:02 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) 01:08:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:08:02 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')]} 01:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:02 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')]} 01:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:02 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 0x10b07cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b07f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b858e490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae5ad30>, '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 0x10ad80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae4fbe8>, '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.MQzx2FiK5Q/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.UntVS59VLp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 01:08:02 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 01:08:02 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 01:08:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MQzx2FiK5Q/Render', 01:08:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:08:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:08:02 INFO - 'HOME': '/Users/cltbld', 01:08:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:08:02 INFO - 'LOGNAME': 'cltbld', 01:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:02 INFO - 'MOZ_NO_REMOTE': '1', 01:08:02 INFO - 'NO_EM_RESTART': '1', 01:08:02 INFO - 'PAGER': '/bin/cat', 01:08:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:02 INFO - 'PWD': '/builds/slave/test', 01:08:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:08:02 INFO - 'SHELL': '/bin/bash', 01:08:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UntVS59VLp/Listeners', 01:08:02 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 01:08:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:08:02 INFO - 'USER': 'cltbld', 01:08:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:08:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:02 INFO - 'XPC_FLAGS': '0x0', 01:08:02 INFO - 'XPC_SERVICE_NAME': '0', 01:08:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:02 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 01:08:02 INFO - Cleaning up... 01:08:02 INFO - Return code: 0 01:08:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:08:02 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')]} 01:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:02 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')]} 01:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:02 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 0x10b07cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b07f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b858e490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae5ad30>, '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 0x10ad80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae4fbe8>, '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.MQzx2FiK5Q/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.UntVS59VLp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 01:08:02 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 01:08:02 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 01:08:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MQzx2FiK5Q/Render', 01:08:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:08:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:08:02 INFO - 'HOME': '/Users/cltbld', 01:08:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:08:02 INFO - 'LOGNAME': 'cltbld', 01:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:02 INFO - 'MOZ_NO_REMOTE': '1', 01:08:02 INFO - 'NO_EM_RESTART': '1', 01:08:02 INFO - 'PAGER': '/bin/cat', 01:08:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:02 INFO - 'PWD': '/builds/slave/test', 01:08:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:08:02 INFO - 'SHELL': '/bin/bash', 01:08:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UntVS59VLp/Listeners', 01:08:02 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 01:08:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:08:02 INFO - 'USER': 'cltbld', 01:08:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:08:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:02 INFO - 'XPC_FLAGS': '0x0', 01:08:02 INFO - 'XPC_SERVICE_NAME': '0', 01:08:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:03 INFO - Downloading/unpacking psutil>=3.1.1 01:08:03 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 01:08:03 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 01:08:03 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 01:08:03 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 01:08:03 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 01:08:03 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 01:08:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:08:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:08:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:08:06 INFO - Installing collected packages: psutil 01:08:06 INFO - Running setup.py install for psutil 01:08:06 INFO - building 'psutil._psutil_osx' extension 01:08:06 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 01:08:07 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 01:08:07 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 01:08:07 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 01:08:07 INFO - building 'psutil._psutil_posix' extension 01:08:07 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 01:08:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:08:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:08:07 INFO - ^ 01:08:07 INFO - 1 warning generated. 01:08:07 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 01:08:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:08:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:08:07 INFO - Successfully installed psutil 01:08:07 INFO - Cleaning up... 01:08:07 INFO - Return code: 0 01:08:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:08: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')]} 01:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08: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')]} 01:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:07 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 0x10b07cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b07f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b858e490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae5ad30>, '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 0x10ad80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae4fbe8>, '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.MQzx2FiK5Q/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.UntVS59VLp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 01:08:07 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 01:08:07 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 01:08:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MQzx2FiK5Q/Render', 01:08:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:08:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:08:07 INFO - 'HOME': '/Users/cltbld', 01:08:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:08:07 INFO - 'LOGNAME': 'cltbld', 01:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:07 INFO - 'MOZ_NO_REMOTE': '1', 01:08:07 INFO - 'NO_EM_RESTART': '1', 01:08:07 INFO - 'PAGER': '/bin/cat', 01:08:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:07 INFO - 'PWD': '/builds/slave/test', 01:08:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:08:07 INFO - 'SHELL': '/bin/bash', 01:08:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UntVS59VLp/Listeners', 01:08:07 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 01:08:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:08:07 INFO - 'USER': 'cltbld', 01:08:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:08:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:07 INFO - 'XPC_FLAGS': '0x0', 01:08:07 INFO - 'XPC_SERVICE_NAME': '0', 01:08:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:08:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:08:08 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 01:08:08 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 01:08:08 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 01:08:08 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 01:08:08 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 01:08:08 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 01:08:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:08:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:08:10 INFO - Installing collected packages: mozsystemmonitor 01:08:10 INFO - Running setup.py install for mozsystemmonitor 01:08:11 INFO - Successfully installed mozsystemmonitor 01:08:11 INFO - Cleaning up... 01:08:11 INFO - Return code: 0 01:08:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:08:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b07cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b07f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b858e490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae5ad30>, '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 0x10ad80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae4fbe8>, '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.MQzx2FiK5Q/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.UntVS59VLp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 01:08:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:08:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MQzx2FiK5Q/Render', 01:08:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:08:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:08:11 INFO - 'HOME': '/Users/cltbld', 01:08:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:08:11 INFO - 'LOGNAME': 'cltbld', 01:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:11 INFO - 'MOZ_NO_REMOTE': '1', 01:08:11 INFO - 'NO_EM_RESTART': '1', 01:08:11 INFO - 'PAGER': '/bin/cat', 01:08:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:11 INFO - 'PWD': '/builds/slave/test', 01:08:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:08:11 INFO - 'SHELL': '/bin/bash', 01:08:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UntVS59VLp/Listeners', 01:08:11 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 01:08:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:08:11 INFO - 'USER': 'cltbld', 01:08:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:08:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:11 INFO - 'XPC_FLAGS': '0x0', 01:08:11 INFO - 'XPC_SERVICE_NAME': '0', 01:08:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:08:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:12 INFO - Downloading/unpacking jsonschema==2.5.1 01:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:08:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:08:15 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 01:08:15 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 01:08:15 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 01:08:15 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 01:08:15 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 01:08:15 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 01:08:15 INFO - Downloading functools32-3.2.3-2.tar.gz 01:08:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:08:15 INFO - warning: no files found matching '*.txt' 01:08:15 INFO - no previously-included directories found matching 'build' 01:08:15 INFO - no previously-included directories found matching 'dist' 01:08:15 INFO - no previously-included directories found matching '.git*' 01:08:15 INFO - Installing collected packages: jsonschema, functools32 01:08:15 INFO - Running setup.py install for functools32 01:08:15 INFO - warning: no files found matching '*.txt' 01:08:15 INFO - no previously-included directories found matching 'build' 01:08:15 INFO - no previously-included directories found matching 'dist' 01:08:15 INFO - no previously-included directories found matching '.git*' 01:08:15 INFO - Successfully installed jsonschema functools32 01:08:15 INFO - Cleaning up... 01:08:15 INFO - Return code: 0 01:08:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:08:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:15 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 0x10b07cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b07f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b858e490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae5ad30>, '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 0x10ad80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae4fbe8>, '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.MQzx2FiK5Q/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.UntVS59VLp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 01:08:15 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 01:08:15 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 01:08:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MQzx2FiK5Q/Render', 01:08:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:08:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:08:15 INFO - 'HOME': '/Users/cltbld', 01:08:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:08:15 INFO - 'LOGNAME': 'cltbld', 01:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:15 INFO - 'MOZ_NO_REMOTE': '1', 01:08:15 INFO - 'NO_EM_RESTART': '1', 01:08:15 INFO - 'PAGER': '/bin/cat', 01:08:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:15 INFO - 'PWD': '/builds/slave/test', 01:08:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:08:15 INFO - 'SHELL': '/bin/bash', 01:08:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UntVS59VLp/Listeners', 01:08:15 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 01:08:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:08:15 INFO - 'USER': 'cltbld', 01:08:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:08:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:15 INFO - 'XPC_FLAGS': '0x0', 01:08:15 INFO - 'XPC_SERVICE_NAME': '0', 01:08:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:08:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:08:16 INFO - Cleaning up... 01:08:16 INFO - Return code: 0 01:08:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:08:16 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')]} 01:08:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:16 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')]} 01:08:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:16 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 0x10b07cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b07f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b858e490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae5ad30>, '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 0x10ad80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae4fbe8>, '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.MQzx2FiK5Q/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.UntVS59VLp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 01:08:16 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 01:08:16 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 01:08:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MQzx2FiK5Q/Render', 01:08:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:08:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:08:16 INFO - 'HOME': '/Users/cltbld', 01:08:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:08:16 INFO - 'LOGNAME': 'cltbld', 01:08:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:16 INFO - 'MOZ_NO_REMOTE': '1', 01:08:16 INFO - 'NO_EM_RESTART': '1', 01:08:16 INFO - 'PAGER': '/bin/cat', 01:08:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:08:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:16 INFO - 'PWD': '/builds/slave/test', 01:08:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:08:16 INFO - 'SHELL': '/bin/bash', 01:08:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UntVS59VLp/Listeners', 01:08:16 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 01:08:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:08:16 INFO - 'USER': 'cltbld', 01:08:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:08:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:08:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:16 INFO - 'XPC_FLAGS': '0x0', 01:08:16 INFO - 'XPC_SERVICE_NAME': '0', 01:08:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:08:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:16 INFO - Downloading/unpacking blobuploader==1.2.4 01:08:16 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 01:08:16 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 01:08:16 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 01:08:16 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 01:08:16 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 01:08:16 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 01:08:18 INFO - Downloading blobuploader-1.2.4.tar.gz 01:08:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:08:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:08: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 01:08: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 01:08: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 01:08: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 01:08: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 01:08: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 01:08:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:08:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:08: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 01:08: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 01:08: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 01:08: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 01:08: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 01:08: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 01:08:20 INFO - Downloading docopt-0.6.1.tar.gz 01:08:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:08:20 INFO - Installing collected packages: blobuploader, requests, docopt 01:08:20 INFO - Running setup.py install for blobuploader 01:08:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:08:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:08:20 INFO - Running setup.py install for requests 01:08:20 INFO - Running setup.py install for docopt 01:08:21 INFO - Successfully installed blobuploader requests docopt 01:08:21 INFO - Cleaning up... 01:08:21 INFO - Return code: 0 01:08:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:08:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:08:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:21 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 0x10b07cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b07f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b858e490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae5ad30>, '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 0x10ad80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae4fbe8>, '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.MQzx2FiK5Q/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.UntVS59VLp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 01:08:21 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 01:08:21 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 01:08:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MQzx2FiK5Q/Render', 01:08:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:08:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:08:21 INFO - 'HOME': '/Users/cltbld', 01:08:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:08:21 INFO - 'LOGNAME': 'cltbld', 01:08:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:21 INFO - 'MOZ_NO_REMOTE': '1', 01:08:21 INFO - 'NO_EM_RESTART': '1', 01:08:21 INFO - 'PAGER': '/bin/cat', 01:08:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:08:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:21 INFO - 'PWD': '/builds/slave/test', 01:08:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:08:21 INFO - 'SHELL': '/bin/bash', 01:08:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UntVS59VLp/Listeners', 01:08:21 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 01:08:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:08:21 INFO - 'USER': 'cltbld', 01:08:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:08:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:08:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:21 INFO - 'XPC_FLAGS': '0x0', 01:08:21 INFO - 'XPC_SERVICE_NAME': '0', 01:08:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:08:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:08:21 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-5pdyPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:08:21 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-VNe1w2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:08:21 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-xXQWHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:08:21 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-sLKZLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:08:21 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-O26GsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:08:21 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-3BhxvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:08:21 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-7sLvpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:08:22 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-B1Xks8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:08:22 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-u80Lfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:08:22 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-oGiIIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:08:22 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Ev5gFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:08:22 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-W4Oc5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:08:22 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-C0xgff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:08:22 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-mQZFB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:08:22 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-S_z9Mq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:08:22 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-B3yrra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:08:23 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-5xOYlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:08:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:08:23 INFO - Running setup.py install for manifestparser 01:08:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:08:23 INFO - Running setup.py install for mozcrash 01:08:23 INFO - Running setup.py install for mozdebug 01:08:23 INFO - Running setup.py install for mozdevice 01:08:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:08:23 INFO - Running setup.py install for mozfile 01:08:23 INFO - Running setup.py install for mozhttpd 01:08:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:08:23 INFO - Running setup.py install for mozinfo 01:08:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:08:24 INFO - Running setup.py install for mozInstall 01:08:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:08:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:08:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:08:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:08:24 INFO - Running setup.py install for mozleak 01:08:24 INFO - Running setup.py install for mozlog 01:08:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:08:24 INFO - Running setup.py install for moznetwork 01:08:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:08:24 INFO - Running setup.py install for mozprocess 01:08:24 INFO - Running setup.py install for mozprofile 01:08:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:08:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:08:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:08:25 INFO - Running setup.py install for mozrunner 01:08:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:08:25 INFO - Running setup.py install for mozscreenshot 01:08:25 INFO - Running setup.py install for moztest 01:08:25 INFO - Running setup.py install for mozversion 01:08:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:08:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:08:25 INFO - Cleaning up... 01:08:25 INFO - Return code: 0 01:08:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:08:25 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')]} 01:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:25 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')]} 01:08:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:25 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 0x10b07cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b07f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b858e490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae5ad30>, '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 0x10ad80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae4fbe8>, '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.MQzx2FiK5Q/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.UntVS59VLp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 01:08:25 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 01:08:25 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 01:08:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MQzx2FiK5Q/Render', 01:08:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:08:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:08:25 INFO - 'HOME': '/Users/cltbld', 01:08:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:08:25 INFO - 'LOGNAME': 'cltbld', 01:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:25 INFO - 'MOZ_NO_REMOTE': '1', 01:08:25 INFO - 'NO_EM_RESTART': '1', 01:08:25 INFO - 'PAGER': '/bin/cat', 01:08:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:25 INFO - 'PWD': '/builds/slave/test', 01:08:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:08:25 INFO - 'SHELL': '/bin/bash', 01:08:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UntVS59VLp/Listeners', 01:08:25 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 01:08:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:08:25 INFO - 'USER': 'cltbld', 01:08:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:08:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:25 INFO - 'XPC_FLAGS': '0x0', 01:08:25 INFO - 'XPC_SERVICE_NAME': '0', 01:08:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:08:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:08:25 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-JqjujW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:08:26 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)) 01:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:08:26 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-tD9pCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:08:26 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)) 01:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:08:26 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-MGiZIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:08:26 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)) 01:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:08:26 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-NhVl3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 01:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:08:26 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-FTBOR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:08:26 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)) 01:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:08:26 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-5m2KAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:08:26 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)) 01:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:08:26 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-wr__K2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:08:26 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)) 01:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:08:26 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-slAgMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:08:26 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)) 01:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:08:26 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-DTkbny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:08:26 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)) 01:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:08:26 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Ixpr0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:08:26 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)) 01:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:08:26 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-hRA86A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:08:27 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)) 01:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:08:27 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-dw713Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:08:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:08:27 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-00e9Qt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:08:27 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)) 01:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:08:27 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-gnq6rs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:08:27 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)) 01:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:08:27 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-D1AjEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:08:27 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)) 01:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:08:27 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-eYYHzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:08:27 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)) 01:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:08:27 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Ww2YiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:08:27 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)) 01:08:27 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)) 01:08:27 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)) 01:08:27 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)) 01:08:27 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:08:27 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:08:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:08:27 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 01:08:27 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 01:08:27 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 01:08:27 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 01:08:27 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 01:08:27 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 01:08:30 INFO - Downloading blessings-1.6.tar.gz 01:08:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:08:30 INFO - Installing collected packages: blessings 01:08:30 INFO - Running setup.py install for blessings 01:08:30 INFO - Successfully installed blessings 01:08:30 INFO - Cleaning up... 01:08:30 INFO - Return code: 0 01:08:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:08:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:08:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:08:30 INFO - Reading from file tmpfile_stdout 01:08:30 INFO - Current package versions: 01:08:30 INFO - blessings == 1.6 01:08:30 INFO - blobuploader == 1.2.4 01:08:30 INFO - docopt == 0.6.1 01:08:30 INFO - functools32 == 3.2.3-2 01:08:30 INFO - jsonschema == 2.5.1 01:08:30 INFO - manifestparser == 1.1 01:08:30 INFO - mozInstall == 1.12 01:08:30 INFO - mozcrash == 1.0 01:08:30 INFO - mozdebug == 0.1 01:08:30 INFO - mozdevice == 0.50 01:08:30 INFO - mozfile == 1.2 01:08:30 INFO - mozhttpd == 0.7 01:08:30 INFO - mozinfo == 0.9 01:08:30 INFO - mozleak == 0.1 01:08:30 INFO - mozlog == 3.4 01:08:30 INFO - moznetwork == 0.27 01:08:30 INFO - mozprocess == 0.25 01:08:30 INFO - mozprofile == 0.28 01:08:30 INFO - mozrunner == 6.13 01:08:30 INFO - mozscreenshot == 0.1 01:08:30 INFO - mozsystemmonitor == 0.3 01:08:30 INFO - moztest == 0.8 01:08:30 INFO - mozversion == 1.4 01:08:30 INFO - psutil == 3.1.1 01:08:30 INFO - requests == 1.2.3 01:08:30 INFO - wsgiref == 0.1.2 01:08:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:08:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:30 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 0x10b07cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b07f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b858e490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae5ad30>, '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 0x10ad80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae4fbe8>, '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.MQzx2FiK5Q/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.UntVS59VLp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 01:08:30 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 01:08:30 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 01:08:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MQzx2FiK5Q/Render', 01:08:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:08:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:08:30 INFO - 'HOME': '/Users/cltbld', 01:08:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:08:30 INFO - 'LOGNAME': 'cltbld', 01:08:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:30 INFO - 'MOZ_NO_REMOTE': '1', 01:08:30 INFO - 'NO_EM_RESTART': '1', 01:08:30 INFO - 'PAGER': '/bin/cat', 01:08:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:08:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:30 INFO - 'PWD': '/builds/slave/test', 01:08:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:08:30 INFO - 'SHELL': '/bin/bash', 01:08:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UntVS59VLp/Listeners', 01:08:30 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 01:08:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:08:30 INFO - 'USER': 'cltbld', 01:08:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:08:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:08:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:30 INFO - 'XPC_FLAGS': '0x0', 01:08:30 INFO - 'XPC_SERVICE_NAME': '0', 01:08:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:08:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:31 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)) 01:08:31 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)) 01:08:31 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)) 01:08:31 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)) 01:08:31 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)) 01:08:31 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)) 01:08:31 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)) 01:08:31 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)) 01:08:31 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)) 01:08:31 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)) 01:08:31 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)) 01:08:31 INFO - Cleaning up... 01:08:31 INFO - Return code: 0 01:08:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:08: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')]} 01:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08: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')]} 01:08:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:31 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 0x10b07cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b07f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b858e490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae5ad30>, '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 0x10ad80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae4fbe8>, '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.MQzx2FiK5Q/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.UntVS59VLp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 01:08:31 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 01:08:31 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 01:08:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MQzx2FiK5Q/Render', 01:08:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:08:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:08:31 INFO - 'HOME': '/Users/cltbld', 01:08:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:08:31 INFO - 'LOGNAME': 'cltbld', 01:08:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:31 INFO - 'MOZ_NO_REMOTE': '1', 01:08:31 INFO - 'NO_EM_RESTART': '1', 01:08:31 INFO - 'PAGER': '/bin/cat', 01:08:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:08:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:31 INFO - 'PWD': '/builds/slave/test', 01:08:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:08:31 INFO - 'SHELL': '/bin/bash', 01:08:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UntVS59VLp/Listeners', 01:08:31 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 01:08:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:08:31 INFO - 'USER': 'cltbld', 01:08:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:08:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:08:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:31 INFO - 'XPC_FLAGS': '0x0', 01:08:31 INFO - 'XPC_SERVICE_NAME': '0', 01:08:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:08:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:08:31 INFO - Cleaning up... 01:08:31 INFO - Return code: 0 01:08:31 INFO - Running post-action listener: _resource_record_post_action 01:08:31 INFO - Running post-action listener: _start_resource_monitoring 01:08:31 INFO - Starting resource monitoring. 01:08:31 INFO - [mozharness: 2017-04-20 08:08:31.511015Z] Finished create-virtualenv step (success) 01:08:31 INFO - [mozharness: 2017-04-20 08:08:31.511963Z] Running install step. 01:08:31 INFO - Running pre-action listener: _resource_record_pre_action 01:08:31 INFO - Running main action method: install 01:08:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:08:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:08:31 INFO - Reading from file tmpfile_stdout 01:08:31 INFO - Detecting whether we're running mozinstall >=1.0... 01:08:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:08:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:08:31 INFO - Reading from file tmpfile_stdout 01:08:31 INFO - Output received: 01:08:31 INFO - Usage: mozinstall [options] installer 01:08:31 INFO - Options: 01:08:31 INFO - -h, --help show this help message and exit 01:08:31 INFO - -d DEST, --destination=DEST 01:08:31 INFO - Directory to install application into. [default: 01:08:31 INFO - "/builds/slave/test"] 01:08:31 INFO - --app=APP Application being installed. [default: firefox] 01:08:31 INFO - mkdir: /builds/slave/test/build/application 01:08:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:08:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 01:08:51 INFO - Reading from file tmpfile_stdout 01:08:51 INFO - Output received: 01:08:51 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:08:51 INFO - Running post-action listener: _resource_record_post_action 01:08:51 INFO - [mozharness: 2017-04-20 08:08:51.258039Z] Finished install step (success) 01:08:51 INFO - [mozharness: 2017-04-20 08:08:51.258203Z] Running run-tests step. 01:08:51 INFO - Running pre-action listener: _resource_record_pre_action 01:08:51 INFO - Running main action method: run_tests 01:08:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:08:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:08:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:08:51 INFO - 2017-04-20 01:08:51.272 screenresolution[1623:7337] starting screenresolution argv=screenresolution get 01:08:51 INFO - 2017-04-20 01:08:51.275 screenresolution[1623:7337] Display 0: 1600x1200x32@60 01:08:51 INFO - 2017-04-20 01:08:51.281 screenresolution[1624:7339] starting screenresolution argv=screenresolution list 01:08:51 INFO - Available Modes on Display 0 01:08:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:08:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:08:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:08:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:08:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:08:51 INFO - Intel Iris: 01:08:51 INFO - Chipset Model: Intel Iris 01:08:51 INFO - Type: GPU 01:08:51 INFO - Bus: Built-In 01:08:51 INFO - VRAM (Dynamic, Max): 1536 MB 01:08:51 INFO - Vendor: Intel (0x8086) 01:08:51 INFO - Device ID: 0x0a2e 01:08:51 INFO - Revision ID: 0x0009 01:08:51 INFO - Displays: 01:08:51 INFO - Display: 01:08:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:08:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:08:51 INFO - Display Serial Number: 1600x1200 60 01:08:51 INFO - Main Display: Yes 01:08:51 INFO - Mirror: Off 01:08:51 INFO - Online: Yes 01:08:51 INFO - Rotation: Supported 01:08:51 INFO - Return code: 0 01:08:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:08:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:08:51 INFO - Python 2.7.3 01:08:51 INFO - Return code: 0 01:08:51 INFO - grabbing minidump binary from tooltool 01:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:08:51 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 0x10ae5ad30>, '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 0x10ad80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae4fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:08:51 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 01:08:51 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 01:08:51 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 01:08:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:08:51 INFO - Return code: 0 01:08:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:08:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:08:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:08:51 INFO - ENV: RUST_BACKTRACE is now 1 01:08:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:08:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:08:51 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/SwJPNy_TRdKF1CSMbOzHyg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--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 01:08:51 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/SwJPNy_TRdKF1CSMbOzHyg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0163 --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 01:08:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MQzx2FiK5Q/Render', 01:08:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:08:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:08:51 INFO - 'HOME': '/Users/cltbld', 01:08:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:08:51 INFO - 'LOGNAME': 'cltbld', 01:08:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:08:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:51 INFO - 'MOZ_NO_REMOTE': '1', 01:08:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:08:51 INFO - 'NO_EM_RESTART': '1', 01:08:51 INFO - 'PAGER': '/bin/cat', 01:08:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:51 INFO - 'PWD': '/builds/slave/test', 01:08:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:08:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:08:51 INFO - 'RUST_BACKTRACE': '1', 01:08:51 INFO - 'SHELL': '/bin/bash', 01:08:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UntVS59VLp/Listeners', 01:08:51 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 01:08:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:08:51 INFO - 'USER': 'cltbld', 01:08:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:08:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:51 INFO - 'XPC_FLAGS': '0x0', 01:08:51 INFO - 'XPC_SERVICE_NAME': '0', 01:08:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:08:51 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/SwJPNy_TRdKF1CSMbOzHyg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--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 01:08:51 INFO - mozversion application_buildid: 20170420002927 01:08:51 INFO - mozversion application_changeset: f6be27f5457ffd75b3763db09a139e24bc2155dc 01:08:51 INFO - mozversion application_display_name: Nightly 01:08:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:08:51 INFO - mozversion application_name: Firefox 01:08:51 INFO - mozversion application_remotingname: firefox 01:08:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:08:51 INFO - mozversion application_vendor: Mozilla 01:08:51 INFO - mozversion application_version: 55.0a1 01:08:51 INFO - mozversion platform_buildid: 20170420002927 01:08:51 INFO - mozversion platform_changeset: f6be27f5457ffd75b3763db09a139e24bc2155dc 01:08:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:08:51 INFO - mozversion platform_version: 55.0a1 01:08:51 INFO - using testdate: 1492675731 01:08:51 INFO - actual date: 1492675731 01:08:51 INFO - starting webserver on 'localhost:49237' 01:08:51 INFO - SUITE-START | Running 2 tests 01:08:51 INFO - TEST-START | dromaeo_css 01:08:51 INFO - operating with platform_type : mac_ 01:08:51 INFO - Initialising browser for dromaeo_css test... 01:08:51 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmp5gi2L7/profile http://localhost:49237/getInfo.html) 01:08:54 INFO - PID 1634 | __metrics Screen width/height:1600/1200 01:08:54 INFO - PID 1634 | colorDepth:24 01:08:54 INFO - PID 1634 | Browser inner width/height: 1024/689 01:08:54 INFO - PID 1634 | __metrics 01:08:54 INFO - PID 1634 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:08:54 INFO - PID 1634 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:08:55 INFO - TEST-INFO | 1634: exit 0 01:08:55 INFO - Browser initialized. 01:08:55 INFO - Running cycle 1/1 for dromaeo_css test... 01:08:55 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmp5gi2L7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:09:08 INFO - PID 1636 | RSS: Main: 241098752 01:09:08 INFO - PID 1636 | 01:12:12 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49237/tests/dromaeo/cssquery-ext.html) 01:12:14 INFO - PID 1636 | RSS: Main: 390762496 01:12:14 INFO - PID 1636 | 01:13:57 INFO - PID 1636 | ************************* 01:13:57 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 01:13:57 INFO - PID 1636 | 01:13:57 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:13:57 INFO - PID 1636 | Full stack: 01:13:57 INFO - PID 1636 | ************************* 01:13:57 INFO - PID 1636 | ************************* 01:13:57 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 01:13:57 INFO - PID 1636 | 01:13:57 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:13:57 INFO - PID 1636 | Full stack: 01:13:57 INFO - PID 1636 | ************************* 01:13:57 INFO - PID 1636 | ************************* 01:13:57 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 01:13:57 INFO - PID 1636 | 01:13:57 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:13:57 INFO - PID 1636 | Full stack: 01:13:57 INFO - PID 1636 | ************************* 01:13:57 INFO - PID 1636 | ************************* 01:13:57 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 01:13:57 INFO - PID 1636 | 01:13:57 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:13:57 INFO - PID 1636 | Full stack: 01:13:57 INFO - PID 1636 | ************************* 01:15:17 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-ext.html (next: http://localhost:49237/tests/dromaeo/cssquery-jquery.html) 01:15:17 INFO - PID 1636 | RSS: Main: 369119232 01:15:17 INFO - PID 1636 | 01:18:20 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49237/tests/dromaeo/cssquery-mootools.html) 01:18:20 INFO - PID 1636 | RSS: Main: 346791936 01:18:20 INFO - PID 1636 | 01:21:23 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49237/tests/dromaeo/cssquery-prototype.html) 01:21:23 INFO - PID 1636 | RSS: Main: 335826944 01:21:23 INFO - PID 1636 | 01:24:27 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49237/tests/dromaeo/cssquery-yui.html) 01:24:28 INFO - PID 1636 | RSS: Main: 342474752 01:24:28 INFO - PID 1636 | 01:27:30 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-yui.html (next: http://localhost:49237/tests/dromaeo/cssquery-dojo.html) 01:27:30 INFO - PID 1636 | RSS: Main: 375107584 01:27:30 INFO - PID 1636 | 01:27:30 INFO - PID 1636 | __start_tp_report 01:27:30 INFO - PID 1636 | _x_x_mozilla_page_load 01:27:30 INFO - PID 1636 | _x_x_mozilla_page_load_details 01:27:30 INFO - PID 1636 | |i|pagename|runs| 01:27:30 INFO - PID 1636 | |0;dojo.html;3243.399971005364;3510.578730552334;3512.789232646043;3522.7886326820394;3581.122624956886;5200.219967004951;5838.386969368219;6070.150178974942;6072.301685306191;6088.908666370008;5043.293938848564;6049.274087109553;6102.908456373158;6111.774065234684;6139.798803208758;5166.5608423283875;5248.21276808478;5276.577873770089;5283.128283833163;5307.442718514559;5377.139657654776;5393.2449457076045;5394.7842086316505;5402.297701298826;5437.429069947658;5173.198154286091;5252.923150754086;5258.579313654898;5296.3379577553;5347.25138480613;5284.180951952453;5305.602079844027;5315.415304316522;5351.331083614548;5387.542058924957;5242.737863106868;5260.921086183672;5264.210368444726;5284.630075894689;5286.629935904488;5892.528597712216;6061.545384096166;6078.6048906820915;6098.756049758004;6123.112148738453;4865.783554111472;5715.942840571583;6253.218347706536;6271.34150914152;6413.775517856852;6528.11870397495;6536.379043990813;6548.27968923418;6563.982582699689;6565.146530950994;6061.424164704346;6207.317195108534;6218.067289906459;6222.62664240147;6238.877002139613;5380.973095134499;6450.903236451457;6483.222013358427;6685.76599819004;6692.431143352772;6297;6353.078803573456;6355.173827402408;6356.332585078592;6374.458171055512;6418.903716444257;6476.838079047967;6478.190226221723;6485.837854053592;6529.967350163219;6199.380061993855;6332.081848131995;6429.903551446732;6451.129097571861;6455.193100862392;6191.349908259568;6228.439440450381;6344.111824344595;6408.967955160194;6412.358764123644;5186.377634683787;5192.324997750268;5192.5586325162785;5213.635045546851;5225.242339860699;4633.351330813689;4643.164230438486;4643.976780116078;4657.510961349078;4657.74382408964;5892.587518873724;5964.761409543569;5985.191999080069;6057.3639767824625;6097.451229389376;6495.3179916109075;6535.901961470582;6547.443467305332;6555.737770489127;6559.245686746085;6078.544109191828;6085.452309292096;6107.938920610737;6110.877782444415;6119.510439164945;5465.508104270635;5621.18492818539;5630.60585758993;5717.542596592262;5736.913946290809;6471.320511346335;6599.505037122139;6697.3637504437;6709.396154346132;6717.496187785838;6263.843403914939;6328.525360597881;6458.354164583692;6506.089147519446;6517.478601711947;6435.678216089271;6488.935110648833;6491.707873145814;6497.415232629086;6503.284638689645;6258.12386265914;6260.843478913063;6261.499080073674;6273.278572963985;6274.811755647338;6387.393197646216;6459.677016149268;6567.802965911031;6577.408033277028;6604.603723776589;6294.276158241861;6298.212723409574;6306.653134077486;6311.684415779101;6313.273973493107;6201.255849298113;6277.748890044347;6299.874002520016;6337.65142917144;6353.428191462791;5241.659292145999;6159.969200153971;6245.219347581552;6248.500119990299;6270.811875643738;6311.116443697794;6329.49364050884;6330.778422755181;6350.650714210763;6367.586106903036;6120.355709576858;6217.564770466024;6259.029850373199;6266.436020758154;6291.245050593958 01:27:30 INFO - PID 1636 | |1;ext.html;761.402299195132;795.5823192823768;809.7327881799005;1132.1848269246145;1146.9025132863705;27192.048278310263;27713.861430692818;27720.722792772067;27772.44455110899;27821.721782782166;27730.306742331453;38362.42456363157;38443.61556384435;38520.61479385205;38556.80721596388;8382.03606585243;8546.487210767344;8558.058613552505;8560.957195214016;8599.355048371366;5990.8502287442725;8429;8571.742847714548;8572.914270857274;8574.957125214365;6143.293521245047;8387.161283871594;8553.95723021384;8558.657653693845;8572.699955501559;8518.574071296442;8573.01410337813;8588.398812083156;8595.914040859605;8596.613152408157;5989.880202395928;8291.502509849368;8380.580970951429;8399.698046802756;8409.915900841035;26698.733012669818;36472.452913206325;36581.451278230845;36601.81699091488;36904.63095369039;3575.6960658344074;3609.963900360989;3614.2410093880317;3615.8553657853654;3616.2948225096115;30769.38461230763;30797;30917;30997.535036974463;31003;3125.46867032605;3169.0492852144266;3190.952135717966;3199.2161920329436;3199.680031996805;240375;282071;288445;288918.9999999979;289095;47905.281420778716;48011.75994120077;48029.519704803206;48122.518774811804;48137.75931120322;45629.087418252115;47693;51178.232326515135;51233.743831280604;51398.74300628473;13592.932035339958;13716.931415342859;13738.725225495635;13749.725005500035;13768.449262029406;11128.666140015812;11138.053265472525;11138.721531961604;11154.10767138627;11156.497957591928;8843.744845064468;10606.15150787935;12113.273203607812;12384.195027323196;12458.937705311415;4711.916403029405;4899.04468628614;5638.548916086703;5861.384554621789;5868.706564671749;981.8330883749779;1016.872890888639;1019.6380284998867;1045.5608644369383;1050.364529459681;18798;19786.307479238447;23685.407864803172;24788.38029049288;25186.74813251844;964.5996911281879;1082.0910435234441;1093.6773651772746;1132.3828513460185;1149.3391300002531;10938.890611093788;11530.365829879269;11704.648860534198;12473.251604903553;12637.368131593383;281857;306275;306494;306551.4672426624;306798;53968.73015634975;54009.45990540123;54106;54130.45869541254;54244;1408.5985494134327;1452.389996201619;1499.9475018374305;1506.6233441639808;1526.198745658516;22442.88778556162;22538.08426283784;22908.083676652746;24140.39649008789;24177.637335440333;37989.81005094957;38033.80983095067;38066;38190;38333.233335333694;279687.2031279661;280481;280678;281082;281532;33494.66505335013;33966;34051;34127.488087678204;34236.31527369488;36953;37538.498460061295;44515.777421113984;44807.551924480336;44881.775591121834;22901.885490573106;25390.492190156463;28804;29121.126366209046;29827.403451931274;23751;30493.847530762203;30610.84694576513;30998;31016.844915775277;35816.4627530582;36001.45997810087;36499.452508212926;36760.81619591885;36809;25839.354016149748;30090.849545753008;30962.53556196614;31029.379412411174;31494.370112598077;21979.120835166414;22577.661335079658;23316.65025024592;23814.52370952606;24140 01:27:30 INFO - PID 1636 | |2;jquery.html;411.6871177904792;422.78015431975376;427.58524231495437;438.08003193294076;451.79443353274263;19195.904020479877;20924.267650632213;21572.13711451544;21742;21758.347249582497;21794.89102554489;22150.556988860215;22450.76520791356;22609.54780904381;22992.850357482144;6113.205283313174;6348;6355.968220158893;6358.491320694357;6366.745330186787;6031.155638210654;6170.382961703838;6254.562180647356;6273.027680709497;6304.180456540644;5295.417504074568;6148.200733904586;6223.284322302948;6226.626402415847;6234.189555357797;6031.4270144336215;6224.564280500322;6261.123442718023;6281.842953926142;6291.779787707431;5374.462553744634;5537.473939975695;5568.638038527482;5580.274564306655;5619.1009438490055;26774.929002839865;26796.062137825276;27500.449991000267;27764.30589235285;27989;1921.6060707554918;2299.6895419118373;2301.9079236830507;2304.193532263711;2305.446692793734;17349.566260843454;17591.648167036714;18044.368447104287;18071;18274.36039738616;2145.817605503534;2166.490874644457;2198.670199470076;2202.493426511895;2205.658122990923;155561;157253;158255;159908;162149;11771.646850594496;12463.875361246453;12488.876001159939;12489.812652810215;12504.937475312565;16720;16767;16776.916115419346;16780.916095419445;16789.664206716043;7361.895715642697;8710.390272680852;8894.911050889537;8957.28341732673;9046.773830654287;8391.8321633567;8411.200935911078;8412.495250284881;8592;8606.13938606147;6635.900461493082;7710.843373493909;7716.2669546393;7801.414893882868;7834.255745704149;1831.4505648305721;1990.9800901991084;2159.902804373807;2167.533980194266;2167.837412194092;833.6998680475024;927.3091546797679;928.4150984879618;940.9905900940903;950.8448081882219;19354.903225483784;20459.693104603444;21240.362789116352;21356.35930922075;21371.35885923425;920.3143657974852;936.4615346175976;986.4722373530127;990.6186118344489;993.2171751705706;9376;9755.609775609038;10591.523381447852;10980.792112867579;11237.438128093563;520837;521247.3937630288;526298;533530;544987;90397;100636;108847;109000;117708;990.0792263195298;1054.9841752373568;1159.0553698735503;1159.2233203753506;1159.8898104680043;22027.779722203213;22189.556208876056;22232.221872234393;22283.554328913007;22286.665700014837;38477;42243.36634950417;57140.714296428254;58168.418315817995;59780.70109649424;70777.6461117691;75772.62113689617;76723.61638191773;77453;77784.22215777996;8733.301335892986;8946.821063578562;9018.639254429749;9143.222826059593;9242.676506322246;9850;14273.57179284623;14363.99452038389;14708.485203018272;14755.778663320274;11882.82175767347;12058;12210.084243681937;12286.631401057983;12297.077719170918;11366.261193022427;11449.942750286194;11574.768504629692;11792;11854.051675866083;9866.457344845816;11763.176577639482;11931.105167112328;12244.877551224374;12289.70958049392;8743;8744.69393571222;8974.86537701948;8996.820063598821;9146.542672866462;11918.642440726791;11979.880201197877;12086.51653933868;12211.694707632025;12225.877741222474 01:27:30 INFO - PID 1636 | |3;mootools.html;1353.1678018018918;1420.2401715082426;1441.9855801441981;1443.0259574787017;1463.8755705765009;11292.887071129286;11876.703082422922;11890.989265912396;11906.702332441682;11936.283822970629;9760.511974401286;11527.884721152786;11600.767984640323;11755.941220293907;11965.222260553059;2507.1601013660447;2549.5665736824785;2550.4516528946274;2560.705518865326;2563.14134764854;2481.7766401023996;2490.476999830038;2540.504601602688;2542.4660821227562;2545.5163518931436;2456.3245107595376;2559.5264875997905;2559.9616005759926;2562.2441379792913;2562.897484100643;2113.2392338758036;2462.950740985188;2511.8618475983812;2528.5954247320433;2570.6786651668635;2448.8530688158767;2474.7772700457044;2475.2697954103583;2482.044412901028;2496.5131799299143;11843.111766617452;11967.341796201206;11980.760384792255;11991;12021.51913923442;6560.114384558071;6808.931910680879;6814.454843612499;6825.965870170618;6837.692303846339;3922.8038598069984;4220.978895105535;4235.195312890541;4324.82700691972;4327.956720432787;1230.341767154577;1255.7614053329837;1290.6128161551496;1301.8242537257445;1304.0741073837587;15174.468893588672;15575;15581.143037132953;16616;16654.83345166557;5039.949600503948;5183.844484665466;5189.117849965515;5190.8183213587345;5198.246254293182;12125.69685757863;12394.62816115518;12401.13192076564;12425.565105221274;12429.813552796715;6379.202599675041;6444.484441244689;6452.322506136882;6461.935380646133;6529.347065293433;6097.512199024068;6252.249730032334;6268.091126786681;6273.498120150468;6277.587542802833;4410.823567057282;4421.027373977719;4435.756033418128;4485.0581377911;4517.2094883395275;1289.8516670583003;1292.140726416941;1299.1750238598559;1306.3664122900386;1314.6844757258189;688.8002479280952;766.4443278622954;795.9602019899098;796.5977181523409;810.6878851642042;6705.994100884809;6774.898376524356;6855.657217139223;6895.5173137879865;6976.686049127801;814.3159745813545;886.2688282167109;900.617237673986;937.7843096087938;940.1022023967095;3680.742348035612;4098.323776576832;4129.855455059059;4148.02521407469;4286.39990401344;14934.626634334012;15344.846551534565;15365.692686146214;15389.076655400711;15452.922735386475;14756.778648320284;15136.621584460476;15247.390104395921;15249.237538123049;15307.693846123015;8681.479111253346;8831.823363532694;8837.20465158126;8882.777930551658;8895.110488951183;5812.593118481665;6230.127782110418;6535.509836762167;6752.729890804313;6812;12898.80651790205;13188.340582971005;13828.170309781446;13853.722925541231;13914.7476727091;11736.471858766205;12388.194767340094;12608.810867837174;12639.494420223456;13949.721005580035;10620.415877126523;10725.249232553646;10774.569017239537;10865.18511111654;10869.456527173768;9763.707088787347;10578.100861426865;10771.6229931952;10772.24594278393;10780.514876830404;8995;9038.774030649023;9091.681791137278;9379.343445958717;9458.763530911783;8737.169968852948;8903.955480222558;9023.187913087853;9072.364934454525;9111.681091161778;8095.617529880478;8141.755747327589;8198.1391953844;8263.917360826556;8292.17078292166;5699.544036476989;5840.503557197686;5985.371535988833;5996.850078748066;6210.596311239755;5954.46409823118;6037.75848966054;6086.452219300284;6086.452219300284;6129.908051379144 01:27:30 INFO - PID 1636 | |4;prototype.html;398.0744768413439;402.3321286664136;407.1673427840067;410.9547949725528;413.32008845449235;4931.827386041489;5608.971955140229;5893.116032595113;5922.88154236915;5944.78131982943;4931.950680493194;5119.515340551236;5530.474604912537;5659.886802263953;5848;4449.176902273073;4465.330200469939;4465.508794032654;4466.8436604718845;4470.932936005963;4454.33185022246;4484.932726009112;4500.392447019643;4502.6172775314135;4505.797239124231;3658.5609726832686;4319.6457930428;4416.447944006999;4446.266366049598;4456.376107344974;4422.646188304944;4439.622632076277;4443.977885086416;4446.1107778444275;4453;3942.743721658083;3973.403989401584;3984.3625019996953;3988.920221595552;3991.1419044905483;5418.810341638024;5564.4991950724625;5613.971930140364;5704.117641178401;5723.397448714367;5320.813771517978;5338.706371149585;5347.679139251657;5358.705271210082;5363.490468405495;6244.625322480666;6254.843628909268;6255.530835187379;6266.310705822356;6266.843328916768;4310.98691807425;4467.664925130628;4529.9547004530195;4534.279432340602;4540.772961351952;6310.5898116622275;6480.3195664455025;6514.478841692653;6538.640374779386;6544.345565443466;3938.542739186519;4202.348635961431;4463.8214471421425;4471.955280447219;4475.888102797456;4693.882652933636;4703.200455922433;4705.976470117627;4724.433068031858;4739.502352253033;4161.958380416218;5168.01807656544;5177.8446646599905;5363.410024897258;5385.434529374437;5502.422245664227;5713.314402271754;5809.099589563624;6305.211848518935;6330;1535.8848086393566;1607.4615003973565;1613.9757903631455;1626.8291829357747;1626.991865040667;1079.2391364088298;1122.3041714137287;1130.8473356096986;1131.4399372310595;1150.4535345710888;4706.529347065334;5919.348871624118;5936.792212272636;5946.256717910262;5975.223220981332;5107.846764597068;6194.318624951252;6445.709943052574;6463.806085817433;6475.801976634338;5097.847064588068;5540.584456165804;5851;5881.529477641779;5885.323187833454;2901.2746813296676;3331.3337332533592;3352.8155951422905;3363.83180840957;3378.3243351329834;5115.5396014358885;6614.669266536654;6629.966850165815;6652.467802575879;6655.73377064912;6615.37153970372;6624.403803657598;6630.9336906630315;6638.369354911276;6678.699458524378;5314.5216930476445;6290.496760259169;6595.4393876521035;6608.2400523939405;6657.567258128206;6391.169148010729;6416.647084410216;6417.7753778617525;6449.935500644933;6451.4516266116025;6129.632222066691;6233.252009758858;6369.694212686296;6370.267419246846;6374.872502549831;5829.737661805144;6621.437177839744;6649.140869426194;6677.332266773284;6695.799126026227;3894.552126505488;3945.033466800652;4126.525449573338;4312.353147027971;4329.830945644721;5385.299911011543;6175.3515880831865;6412.551121421456;6486.254080780771;6552.508561857975;5516.393196748435;6231.501479881508;6236.440889777556;6259.34276900937;6266.310705822447;5188.714620695898;5982.222311099703;6246.718897649707;6255.966810786604;6287.559870808999;5870.972579798604;6088.969555152196;6162.476189523941;6179.351168127282;6194.4115309045565;5496.835094947158;5660.745266463102;6146.692665366624;6259.624422534663;6278;5515.944840551543;5833.212516310414;6133;6141.201643786458;6168.321484636776 01:27:30 INFO - PID 1636 | |5;yui.html;709.9858002839946;795.8010497375656;864.3128712673424;866.501761487145;874.0822136756407;12740.044496662753;14880.851191488082;17339.65320693587;17745.46763597094;17746.3788767393;16717.498475045737;17173.74239386407;17455.21451534681;17730.46808595741;18012.81987180128;960.9231261499064;1003.372891942536;1006.1598565198068;1008.5713571732022;1008.8133695266363;678.6844117485368;706.2055187913597;1027.2706378471294;1027.768752030791;1030.922680798943;755.765712629084;760.3347071312602;762.8359902620936;1019.7246743379283;1066.264277648424;1014.7666036811501;1023.6724248240529;1026.1585499890093;1026.296986564206;1060.4697651174413;760.2055851634999;762.0893032825776;762.527233115472;764.9502782319131;789.1556035042507;16168.353265869351;16451.42420015306;16635.251413686292;16700.49898503047;17030.574235644082;13975.930120349332;16731.749023764653;16904.323827046905;17122.657546849117;17175.570610734707;13876.861231387758;14081.366338514792;14153.363098660586;14223.004389692622;14345.211013394259;3531.4526248431534;3548.8580456781697;3551.0057183988524;3553;3555.306715190539;107654.3851842223;107682;107698.99999999921;107804;109348;11100.777984440267;11468.254563453349;13070.346482675828;13153.342332883318;13279.269640169883;18571.44285671432;19486.025698715006;19917;25307;25358.366040848756;7716.42126840478;7805.414593905366;7918.881216781753;7929.484583502054;7929.563873986871;3906.570277269498;3947.684185265172;3981.7212795104642;3983.661388781928;3999.34010888206;4341.110072435206;4433.069055498381;4438.533953934855;4440.755758433317;4444;892.2638822971074;947.4694171263976;948.369334392635;948.8671585977969;949.715085474355;645.4642646603309;665.5756680703299;668.3216535216661;672.8755180291662;702.2521015118882;10001.949795271392;10974.176936729777;11082.445877706245;11885.940570297093;11899.345535995604;647.7344288841647;656.592912394309;659.953803233769;687.5599616245507;689.1764341611826;4782.37829082224;5252.527272545489;5313.814016509404;5458.153986132156;5558.221848941152;97242.02757972472;101738;102370.48814756027;102635.46046809155;105196;84090;85702.57148714217;85853;86467.56766216128;87765;77912;78641.60679196568;79427.01432464119;80685.78971315434;81464.59267703624;11721.531138754695;12128.211666241667;12166.330851803235;12186.512539498675;12238.449269782703;39181;39462.42150313955;39700.60299396969;39895;39904;40442;47123.29315060345;49266.507334926195;49593.50406495889;49894;15718.449854255046;15775.605609859846;15798.526044218692;16024.359025638843;16244.51266462008;17577;17645.823541764417;17861.821381786016;17907.820921791135;18348.899066056078;16234.51296461108;16781.832181678026;16796.076215808247;16902.23939922731;16943.237554310334;16300.918495407446;16457;16838.410655626994;16951.406700765416;17004.31982720727;15911.363545458053;16119.919400402923;16296.755548666542;16385.262663179947;16501.257443414834;11554.94222528882;11599.942000289944;11702.180847340946;11917.642470725892;12112.697182570506;10858.891411085788;11379.805120462232;12331.75336493283;12595.24428534291;12727.80908286358 01:27:30 INFO - PID 1636 | __end_tp_report 01:27:30 INFO - PID 1636 | __start_cc_report 01:27:30 INFO - PID 1636 | _x_x_mozilla_cycle_collect,1591 01:27:30 INFO - PID 1636 | __end_cc_report 01:27:30 INFO - PID 1636 | __startTimestamp1492676850680__endTimestamp 01:27:30 INFO - PID 1636 | 01:27:30 INFO - PID 1636 | ------- Summary: start ------- 01:27:30 INFO - PID 1636 | Number of tests: 6 01:27:30 INFO - PID 1636 | 01:27:30 INFO - PID 1636 | [#0] dojo.html Cycles:165 Average:5937.27 Median:6218.07 stddev:682.92 (11.0%) stddev-sans-first:651.49 01:27:30 INFO - PID 1636 | Values: 3243.4 3510.6 3512.8 3522.8 3581.1 5200.2 5838.4 6070.2 6072.3 6088.9 5043.3 6049.3 6102.9 6111.8 6139.8 5166.6 5248.2 5276.6 5283.1 5307.4 5377.1 5393.2 5394.8 5402.3 5437.4 5173.2 5252.9 5258.6 5296.3 5347.3 5284.2 5305.6 5315.4 5351.3 5387.5 5242.7 5260.9 5264.2 5284.6 5286.6 5892.5 6061.5 6078.6 6098.8 6123.1 4865.8 5715.9 6253.2 6271.3 6413.8 6528.1 6536.4 6548.3 6564.0 6565.1 6061.4 6207.3 6218.1 6222.6 6238.9 5381.0 6450.9 6483.2 6685.8 6692.4 6297.0 6353.1 6355.2 6356.3 6374.5 6418.9 6476.8 6478.2 6485.8 6530.0 6199.4 6332.1 6429.9 6451.1 6455.2 6191.3 6228.4 6344.1 6409.0 6412.4 5186.4 5192.3 5192.6 5213.6 5225.2 4633.4 4643.2 4644.0 4657.5 4657.7 5892.6 5964.8 5985.2 6057.4 6097.5 6495.3 6535.9 6547.4 6555.7 6559.2 6078.5 6085.5 6107.9 6110.9 6119.5 5465.5 5621.2 5630.6 5717.5 5736.9 6471.3 6599.5 6697.4 6709.4 6717.5 6263.8 6328.5 6458.4 6506.1 6517.5 6435.7 6488.9 6491.7 6497.4 6503.3 6258.1 6260.8 6261.5 6273.3 6274.8 6387.4 6459.7 6567.8 6577.4 6604.6 6294.3 6298.2 6306.7 6311.7 6313.3 6201.3 6277.7 6299.9 6337.7 6353.4 5241.7 6160.0 6245.2 6248.5 6270.8 6311.1 6329.5 6330.8 6350.7 6367.6 6120.4 6217.6 6259.0 6266.4 6291.2 01:27:30 INFO - PID 1636 | 01:27:30 INFO - PID 1636 | [#1] ext.html Cycles:180 Average:43123.29 Median:17309.92 stddev:75329.04 (435.2%) stddev-sans-first:75473.21 01:27:30 INFO - PID 1636 | Values: 761.4 795.6 809.7 1132.2 1146.9 27192.0 27713.9 27720.7 27772.4 27821.7 27730.3 38362.4 38443.6 38520.6 38556.8 8382.0 8546.5 8558.1 8561.0 8599.4 5990.9 8429.0 8571.7 8572.9 8575.0 6143.3 8387.2 8554.0 8558.7 8572.7 8518.6 8573.0 8588.4 8595.9 8596.6 5989.9 8291.5 8380.6 8399.7 8409.9 26698.7 36472.5 36581.5 36601.8 36904.6 3575.7 3610.0 3614.2 3615.9 3616.3 30769.4 30797.0 30917.0 30997.5 31003.0 3125.5 3169.0 3191.0 3199.2 3199.7 240375.0 282071.0 288445.0 288919.0 289095.0 47905.3 48011.8 48029.5 48122.5 48137.8 45629.1 47693.0 51178.2 51233.7 51398.7 13592.9 13716.9 13738.7 13749.7 13768.4 11128.7 11138.1 11138.7 11154.1 11156.5 8843.7 10606.2 12113.3 12384.2 12458.9 4711.9 4899.0 5638.5 5861.4 5868.7 981.8 1016.9 1019.6 1045.6 1050.4 18798.0 19786.3 23685.4 24788.4 25186.7 964.6 1082.1 1093.7 1132.4 1149.3 10938.9 11530.4 11704.6 12473.3 12637.4 281857.0 306275.0 306494.0 306551.5 306798.0 53968.7 54009.5 54106.0 54130.5 54244.0 1408.6 1452.4 1499.9 1506.6 1526.2 22442.9 22538.1 22908.1 24140.4 24177.6 37989.8 38033.8 38066.0 38190.0 38333.2 279687.2 280481.0 280678.0 281082.0 281532.0 33494.7 33966.0 34051.0 34127.5 34236.3 36953.0 37538.5 44515.8 44807.6 44881.8 22901.9 25390.5 28804.0 29121.1 29827.4 23751.0 30493.8 30610.8 30998.0 31016.8 35816.5 36001.5 36499.5 36760.8 36809.0 25839.4 30090.8 30962.5 31029.4 31494.4 21979.1 22577.7 23316.7 23814.5 24140.0 01:27:30 INFO - PID 1636 | 01:27:30 INFO - PID 1636 | [#2] jquery.html Cycles:180 Average:34308.46 Median:27148.26 stddev:89618.56 (330.1%) stddev-sans-first:89833.83 01:27:30 INFO - PID 1636 | Values: 411.7 422.8 427.6 438.1 451.8 19195.9 20924.3 21572.1 21742.0 21758.3 21794.9 22150.6 22450.8 22609.5 22992.9 6113.2 6348.0 6356.0 6358.5 6366.7 6031.2 6170.4 6254.6 6273.0 6304.2 5295.4 6148.2 6223.3 6226.6 6234.2 6031.4 6224.6 6261.1 6281.8 6291.8 5374.5 5537.5 5568.6 5580.3 5619.1 26774.9 26796.1 27500.4 27764.3 27989.0 1921.6 2299.7 2301.9 2304.2 2305.4 17349.6 17591.6 18044.4 18071.0 18274.4 2145.8 2166.5 2198.7 2202.5 2205.7 155561.0 157253.0 158255.0 159908.0 162149.0 11771.6 12463.9 12488.9 12489.8 12504.9 16720.0 16767.0 16776.9 16780.9 16789.7 7361.9 8710.4 8894.9 8957.3 9046.8 8391.8 8411.2 8412.5 8592.0 8606.1 6635.9 7710.8 7716.3 7801.4 7834.3 1831.5 1991.0 2159.9 2167.5 2167.8 833.7 927.3 928.4 941.0 950.8 19354.9 20459.7 21240.4 21356.4 21371.4 920.3 936.5 986.5 990.6 993.2 9376.0 9755.6 10591.5 10980.8 11237.4 520837.0 521247.4 526298.0 533530.0 544987.0 90397.0 100636.0 108847.0 109000.0 117708.0 990.1 1055.0 1159.1 1159.2 1159.9 22027.8 22189.6 22232.2 22283.6 22286.7 38477.0 42243.4 57140.7 58168.4 59780.7 70777.6 75772.6 76723.6 77453.0 77784.2 8733.3 8946.8 9018.6 9143.2 9242.7 9850.0 14273.6 14364.0 14708.5 14755.8 11882.8 12058.0 12210.1 12286.6 12297.1 11366.3 11449.9 11574.8 11792.0 11854.1 9866.5 11763.2 11931.1 12244.9 12289.7 8743.0 8744.7 8974.9 8996.8 9146.5 11918.6 11979.9 12086.5 12211.7 12225.9 01:27:30 INFO - PID 1636 | 01:27:30 INFO - PID 1636 | [#3] mootools.html Cycles:180 Average:7146.62 Median:2563.02 stddev:4512.80 (176.1%) stddev-sans-first:4504.46 01:27:30 INFO - PID 1636 | Values: 1353.2 1420.2 1442.0 1443.0 1463.9 11292.9 11876.7 11891.0 11906.7 11936.3 9760.5 11527.9 11600.8 11755.9 11965.2 2507.2 2549.6 2550.5 2560.7 2563.1 2481.8 2490.5 2540.5 2542.5 2545.5 2456.3 2559.5 2560.0 2562.2 2562.9 2113.2 2463.0 2511.9 2528.6 2570.7 2448.9 2474.8 2475.3 2482.0 2496.5 11843.1 11967.3 11980.8 11991.0 12021.5 6560.1 6808.9 6814.5 6826.0 6837.7 3922.8 4221.0 4235.2 4324.8 4328.0 1230.3 1255.8 1290.6 1301.8 1304.1 15174.5 15575.0 15581.1 16616.0 16654.8 5039.9 5183.8 5189.1 5190.8 5198.2 12125.7 12394.6 12401.1 12425.6 12429.8 6379.2 6444.5 6452.3 6461.9 6529.3 6097.5 6252.2 6268.1 6273.5 6277.6 4410.8 4421.0 4435.8 4485.1 4517.2 1289.9 1292.1 1299.2 1306.4 1314.7 688.8 766.4 796.0 796.6 810.7 6706.0 6774.9 6855.7 6895.5 6976.7 814.3 886.3 900.6 937.8 940.1 3680.7 4098.3 4129.9 4148.0 4286.4 14934.6 15344.8 15365.7 15389.1 15452.9 14756.8 15136.6 15247.4 15249.2 15307.7 8681.5 8831.8 8837.2 8882.8 8895.1 5812.6 6230.1 6535.5 6752.7 6812.0 12898.8 13188.3 13828.2 13853.7 13914.7 11736.5 12388.2 12608.8 12639.5 13949.7 10620.4 10725.2 10774.6 10865.2 10869.5 9763.7 10578.1 10771.6 10772.2 10780.5 8995.0 9038.8 9091.7 9379.3 9458.8 8737.2 8904.0 9023.2 9072.4 9111.7 8095.6 8141.8 8198.1 8263.9 8292.2 5699.5 5840.5 5985.4 5996.9 6210.6 5954.5 6037.8 6086.5 6086.5 6129.9 01:27:30 INFO - PID 1636 | 01:27:30 INFO - PID 1636 | [#4] prototype.html Cycles:180 Average:5102.36 Median:5535.53 stddev:1530.84 (27.7%) stddev-sans-first:1493.86 01:27:30 INFO - PID 1636 | Values: 398.1 402.3 407.2 411.0 413.3 4931.8 5609.0 5893.1 5922.9 5944.8 4932.0 5119.5 5530.5 5659.9 5848.0 4449.2 4465.3 4465.5 4466.8 4470.9 4454.3 4484.9 4500.4 4502.6 4505.8 3658.6 4319.6 4416.4 4446.3 4456.4 4422.6 4439.6 4444.0 4446.1 4453.0 3942.7 3973.4 3984.4 3988.9 3991.1 5418.8 5564.5 5614.0 5704.1 5723.4 5320.8 5338.7 5347.7 5358.7 5363.5 6244.6 6254.8 6255.5 6266.3 6266.8 4311.0 4467.7 4530.0 4534.3 4540.8 6310.6 6480.3 6514.5 6538.6 6544.3 3938.5 4202.3 4463.8 4472.0 4475.9 4693.9 4703.2 4706.0 4724.4 4739.5 4162.0 5168.0 5177.8 5363.4 5385.4 5502.4 5713.3 5809.1 6305.2 6330.0 1535.9 1607.5 1614.0 1626.8 1627.0 1079.2 1122.3 1130.8 1131.4 1150.5 4706.5 5919.3 5936.8 5946.3 5975.2 5107.8 6194.3 6445.7 6463.8 6475.8 5097.8 5540.6 5851.0 5881.5 5885.3 2901.3 3331.3 3352.8 3363.8 3378.3 5115.5 6614.7 6630.0 6652.5 6655.7 6615.4 6624.4 6630.9 6638.4 6678.7 5314.5 6290.5 6595.4 6608.2 6657.6 6391.2 6416.6 6417.8 6449.9 6451.5 6129.6 6233.3 6369.7 6370.3 6374.9 5829.7 6621.4 6649.1 6677.3 6695.8 3894.6 3945.0 4126.5 4312.4 4329.8 5385.3 6175.4 6412.6 6486.3 6552.5 5516.4 6231.5 6236.4 6259.3 6266.3 5188.7 5982.2 6246.7 6256.0 6287.6 5871.0 6089.0 6162.5 6179.4 6194.4 5496.8 5660.7 6146.7 6259.6 6278.0 5515.9 5833.2 6133.0 6141.2 6168.3 01:27:30 INFO - PID 1636 | 01:27:30 INFO - PID 1636 | [#5] yui.html Cycles:180 Average:20564.95 Median:17688.15 stddev:28174.84 (159.3%) stddev-sans-first:28214.43 01:27:30 INFO - PID 1636 | Values: 710.0 795.8 864.3 866.5 874.1 12740.0 14880.9 17339.7 17745.5 17746.4 16717.5 17173.7 17455.2 17730.5 18012.8 960.9 1003.4 1006.2 1008.6 1008.8 678.7 706.2 1027.3 1027.8 1030.9 755.8 760.3 762.8 1019.7 1066.3 1014.8 1023.7 1026.2 1026.3 1060.5 760.2 762.1 762.5 765.0 789.2 16168.4 16451.4 16635.3 16700.5 17030.6 13975.9 16731.7 16904.3 17122.7 17175.6 13876.9 14081.4 14153.4 14223.0 14345.2 3531.5 3548.9 3551.0 3553.0 3555.3 107654.4 107682.0 107699.0 107804.0 109348.0 11100.8 11468.3 13070.3 13153.3 13279.3 18571.4 19486.0 19917.0 25307.0 25358.4 7716.4 7805.4 7918.9 7929.5 7929.6 3906.6 3947.7 3981.7 3983.7 3999.3 4341.1 4433.1 4438.5 4440.8 4444.0 892.3 947.5 948.4 948.9 949.7 645.5 665.6 668.3 672.9 702.3 10001.9 10974.2 11082.4 11885.9 11899.3 647.7 656.6 660.0 687.6 689.2 4782.4 5252.5 5313.8 5458.2 5558.2 97242.0 101738.0 102370.5 102635.5 105196.0 84090.0 85702.6 85853.0 86467.6 87765.0 77912.0 78641.6 79427.0 80685.8 81464.6 11721.5 12128.2 12166.3 12186.5 12238.4 39181.0 39462.4 39700.6 39895.0 39904.0 40442.0 47123.3 49266.5 49593.5 49894.0 15718.4 15775.6 15798.5 16024.4 16244.5 17577.0 17645.8 17861.8 17907.8 18348.9 16234.5 16781.8 16796.1 16902.2 16943.2 16300.9 16457.0 16838.4 16951.4 17004.3 15911.4 16119.9 16296.8 16385.3 16501.3 11554.9 11599.9 11702.2 11917.6 12112.7 10858.9 11379.8 12331.8 12595.2 12727.8 01:27:30 INFO - PID 1636 | -------- Summary: end -------- 01:27:30 INFO - PID 1636 | 01:27:31 INFO - TEST-INFO | 1636: exit 0 01:27:31 INFO - TEST-OK | dromaeo_css | took 1119536ms 01:27:31 INFO - TEST-START | kraken 01:27:31 INFO - operating with platform_type : mac_ 01:27:31 INFO - Initialising browser for kraken test... 01:27:31 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmp5709Ox/profile http://localhost:49237/getInfo.html) 01:27:33 INFO - PID 1646 | __metrics Screen width/height:1600/1200 01:27:33 INFO - PID 1646 | colorDepth:24 01:27:33 INFO - PID 1646 | Browser inner width/height: 1024/689 01:27:33 INFO - PID 1646 | __metrics 01:27:33 INFO - PID 1646 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:27:33 INFO - PID 1646 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:27:34 INFO - TEST-INFO | 1646: exit 0 01:27:34 INFO - Browser initialized. 01:27:34 INFO - Running cycle 1/1 for kraken test... 01:27:34 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmp5709Ox/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:27:47 INFO - PID 1647 | RSS: Main: 241479680 01:27:47 INFO - PID 1647 | 01:27:49 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection) 01:27:50 INFO - PID 1647 | RSS: Main: 311500800 01:27:50 INFO - PID 1647 | 01:27:53 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-dft) 01:27:53 INFO - PID 1647 | RSS: Main: 293703680 01:27:53 INFO - PID 1647 | 01:27:57 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-fft) 01:27:57 INFO - PID 1647 | RSS: Main: 383430656 01:27:57 INFO - PID 1647 | 01:27:59 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator) 01:28:00 INFO - PID 1647 | RSS: Main: 287354880 01:28:00 INFO - PID 1647 | 01:28:02 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:28:03 INFO - PID 1647 | RSS: Main: 290877440 01:28:03 INFO - PID 1647 | 01:28:05 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom) 01:28:06 INFO - PID 1647 | RSS: Main: 355250176 01:28:06 INFO - PID 1647 | 01:28:09 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate) 01:28:10 INFO - PID 1647 | RSS: Main: 374812672 01:28:10 INFO - PID 1647 | 01:28:12 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial) 01:28:13 INFO - PID 1647 | RSS: Main: 384905216 01:28:13 INFO - PID 1647 | 01:28:14 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:28:15 INFO - PID 1647 | RSS: Main: 332193792 01:28:15 INFO - PID 1647 | 01:28:17 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:28:18 INFO - PID 1647 | RSS: Main: 331427840 01:28:18 INFO - PID 1647 | 01:28:20 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:28:20 INFO - PID 1647 | RSS: Main: 332972032 01:28:20 INFO - PID 1647 | 01:28:23 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:28:24 INFO - PID 1647 | RSS: Main: 342310912 01:28:24 INFO - PID 1647 | 01:28:27 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:28:28 INFO - PID 1647 | RSS: Main: 339828736 01:28:28 INFO - PID 1647 | 01:28:30 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49237/tests/kraken/driver.html?testName=ai-astar) 01:28:30 INFO - PID 1647 | RSS: Main: 382660608 01:28:30 INFO - PID 1647 | 01:28:30 INFO - PID 1647 | __start_tp_report 01:28:30 INFO - PID 1647 | _x_x_mozilla_page_load 01:28:30 INFO - PID 1647 | _x_x_mozilla_page_load_details 01:28:30 INFO - PID 1647 | |i|pagename|runs| 01:28:30 INFO - PID 1647 | |0;ai-astar;110;110;111;111;110;111;111;111;110;110 01:28:30 INFO - PID 1647 | |1;audio-beat-detection;140;111;109;146;108;110;94;141;159;145 01:28:30 INFO - PID 1647 | |2;audio-dft;190;186;184;185;184;185;183;184;180;183 01:28:30 INFO - PID 1647 | |3;audio-fft;78;62;77;119;88;57;56;59;81;57 01:28:30 INFO - PID 1647 | |4;audio-oscillator;90;69;85;68;68;68;90;68;69;90 01:28:30 INFO - PID 1647 | |5;imaging-gaussian-blur;87;86;86;87;86;86;86;85;87;87 01:28:30 INFO - PID 1647 | |6;imaging-darkroom;93;94;94;94;94;93;93;94;93;94 01:28:30 INFO - PID 1647 | |7;imaging-desaturate;85;83;84;84;85;86;85;84;84;84 01:28:30 INFO - PID 1647 | |8;json-parse-financial;47;46;48;46;47;46;47;47;47;49 01:28:30 INFO - PID 1647 | |9;json-stringify-tinderbox;55;57;57;69;62;60;56;57;58;57 01:28:30 INFO - PID 1647 | |10;stanford-crypto-aes;80;83;70;94;108;106;104;105;83;84 01:28:30 INFO - PID 1647 | |11;stanford-crypto-ccm;146;149;146;134;137;141;135;135;221;151 01:28:30 INFO - PID 1647 | |12;stanford-crypto-pbkdf2;184;179;188;186;186;178;221;185;180;184 01:28:30 INFO - PID 1647 | |13;stanford-crypto-sha256-iterative;68;68;67;71;87;96;97;96;55;73 01:28:30 INFO - PID 1647 | __end_tp_report 01:28:30 INFO - PID 1647 | __start_cc_report 01:28:30 INFO - PID 1647 | _x_x_mozilla_cycle_collect,2194 01:28:30 INFO - PID 1647 | __end_cc_report 01:28:30 INFO - PID 1647 | __startTimestamp1492676910450__endTimestamp 01:28:30 INFO - PID 1647 | 01:28:30 INFO - PID 1647 | ------- Summary: start ------- 01:28:30 INFO - PID 1647 | Number of tests: 14 01:28:30 INFO - PID 1647 | 01:28:30 INFO - PID 1647 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 01:28:30 INFO - PID 1647 | Values: 110.0 110.0 111.0 111.0 110.0 111.0 111.0 111.0 110.0 110.0 01:28:30 INFO - PID 1647 | 01:28:30 INFO - PID 1647 | [#1] audio-beat-detection Cycles:10 Average:126.30 Median:143.00 stddev:22.08 (15.4%) stddev-sans-first:22.86 01:28:30 INFO - PID 1647 | Values: 140.0 111.0 109.0 146.0 108.0 110.0 94.0 141.0 159.0 145.0 01:28:30 INFO - PID 1647 | 01:28:30 INFO - PID 1647 | [#2] audio-dft Cycles:10 Average:184.40 Median:184.50 stddev:2.55 (1.4%) stddev-sans-first:1.72 01:28:30 INFO - PID 1647 | Values: 190.0 186.0 184.0 185.0 184.0 185.0 183.0 184.0 180.0 183.0 01:28:30 INFO - PID 1647 | 01:28:30 INFO - PID 1647 | [#3] audio-fft Cycles:10 Average:73.40 Median:69.50 stddev:19.90 (28.6%) stddev-sans-first:21.03 01:28:30 INFO - PID 1647 | Values: 78.0 62.0 77.0 119.0 88.0 57.0 56.0 59.0 81.0 57.0 01:28:30 INFO - PID 1647 | 01:28:30 INFO - PID 1647 | [#4] audio-oscillator Cycles:10 Average:76.50 Median:77.00 stddev:10.65 (13.8%) stddev-sans-first:10.11 01:28:30 INFO - PID 1647 | Values: 90.0 69.0 85.0 68.0 68.0 68.0 90.0 68.0 69.0 90.0 01:28:30 INFO - PID 1647 | 01:28:30 INFO - PID 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:86.50 stddev:0.67 (0.8%) stddev-sans-first:0.67 01:28:30 INFO - PID 1647 | Values: 87.0 86.0 86.0 87.0 86.0 86.0 86.0 85.0 87.0 87.0 01:28:30 INFO - PID 1647 | 01:28:30 INFO - PID 1647 | [#6] imaging-darkroom Cycles:10 Average:93.60 Median:94.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 01:28:30 INFO - PID 1647 | Values: 93.0 94.0 94.0 94.0 94.0 93.0 93.0 94.0 93.0 94.0 01:28:30 INFO - PID 1647 | 01:28:30 INFO - PID 1647 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.84 (1.0%) stddev-sans-first:0.87 01:28:30 INFO - PID 1647 | Values: 85.0 83.0 84.0 84.0 85.0 86.0 85.0 84.0 84.0 84.0 01:28:30 INFO - PID 1647 | 01:28:30 INFO - PID 1647 | [#8] json-parse-financial Cycles:10 Average:47.00 Median:47.00 stddev:0.94 (2.0%) stddev-sans-first:1.00 01:28:30 INFO - PID 1647 | Values: 47.0 46.0 48.0 46.0 47.0 46.0 47.0 47.0 47.0 49.0 01:28:30 INFO - PID 1647 | 01:28:30 INFO - PID 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:57.50 stddev:4.10 (7.1%) stddev-sans-first:4.12 01:28:30 INFO - PID 1647 | Values: 55.0 57.0 57.0 69.0 62.0 60.0 56.0 57.0 58.0 57.0 01:28:30 INFO - PID 1647 | 01:28:30 INFO - PID 1647 | [#10] stanford-crypto-aes Cycles:10 Average:91.70 Median:81.50 stddev:13.43 (16.5%) stddev-sans-first:13.56 01:28:30 INFO - PID 1647 | Values: 80.0 83.0 70.0 94.0 108.0 106.0 104.0 105.0 83.0 84.0 01:28:30 INFO - PID 1647 | 01:28:30 INFO - PID 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:149.50 Median:146.00 stddev:25.88 (17.7%) stddev-sans-first:27.42 01:28:30 INFO - PID 1647 | Values: 146.0 149.0 146.0 134.0 137.0 141.0 135.0 135.0 221.0 151.0 01:28:30 INFO - PID 1647 | 01:28:30 INFO - PID 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.10 Median:185.50 stddev:12.36 (6.7%) stddev-sans-first:13.06 01:28:30 INFO - PID 1647 | Values: 184.0 179.0 188.0 186.0 186.0 178.0 221.0 185.0 180.0 184.0 01:28:30 INFO - PID 1647 | 01:28:30 INFO - PID 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.80 Median:80.00 stddev:14.96 (18.7%) stddev-sans-first:15.44 01:28:30 INFO - PID 1647 | Values: 68.0 68.0 67.0 71.0 87.0 96.0 97.0 96.0 55.0 73.0 01:28:30 INFO - PID 1647 | -------- Summary: end -------- 01:28:30 INFO - PID 1647 | 01:28:31 INFO - TEST-INFO | 1647: exit 0 01:28:31 INFO - TEST-OK | kraken | took 60268ms 01:28:31 INFO - SUITE-END | took 1179s 01:28:32 INFO - Completed test suite (00:19:40) 01:28:32 INFO - javascript benchmark 01:28:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7700.154543788463, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3243.399971005364, 3510.578730552334, 3512.789232646043, 3522.7886326820394, 3581.122624956886, 5200.219967004951, 5838.386969368219, 6070.150178974942, 6072.301685306191, 6088.908666370008, 5043.293938848564, 6049.274087109553, 6102.908456373158, 6111.774065234684, 6139.798803208758, 5166.5608423283875, 5248.21276808478, 5276.577873770089, 5283.128283833163, 5307.442718514559, 5377.139657654776, 5393.2449457076045, 5394.7842086316505, 5402.297701298826, 5437.429069947658, 5173.198154286091, 5252.923150754086, 5258.579313654898, 5296.3379577553, 5347.25138480613, 5284.180951952453, 5305.602079844027, 5315.415304316522, 5351.331083614548, 5387.542058924957, 5242.737863106868, 5260.921086183672, 5264.210368444726, 5284.630075894689, 5286.629935904488, 5892.528597712216, 6061.545384096166, 6078.6048906820915, 6098.756049758004, 6123.112148738453, 4865.783554111472, 5715.942840571583, 6253.218347706536, 6271.34150914152, 6413.775517856852, 6528.11870397495, 6536.379043990813, 6548.27968923418, 6563.982582699689, 6565.146530950994, 6061.424164704346, 6207.317195108534, 6218.067289906459, 6222.62664240147, 6238.877002139613, 5380.973095134499, 6450.903236451457, 6483.222013358427, 6685.76599819004, 6692.431143352772, 6297.0, 6353.078803573456, 6355.173827402408, 6356.332585078592, 6374.458171055512, 6418.903716444257, 6476.838079047967, 6478.190226221723, 6485.837854053592, 6529.967350163219, 6199.380061993855, 6332.081848131995, 6429.903551446732, 6451.129097571861, 6455.193100862392, 6191.349908259568, 6228.439440450381, 6344.111824344595, 6408.967955160194, 6412.358764123644, 5186.377634683787, 5192.324997750268, 5192.5586325162785, 5213.635045546851, 5225.242339860699, 4633.351330813689, 4643.164230438486, 4643.976780116078, 4657.510961349078, 4657.74382408964, 5892.587518873724, 5964.761409543569, 5985.191999080069, 6057.3639767824625, 6097.451229389376, 6495.3179916109075, 6535.901961470582, 6547.443467305332, 6555.737770489127, 6559.245686746085, 6078.544109191828, 6085.452309292096, 6107.938920610737, 6110.877782444415, 6119.510439164945, 5465.508104270635, 5621.18492818539, 5630.60585758993, 5717.542596592262, 5736.913946290809, 6471.320511346335, 6599.505037122139, 6697.3637504437, 6709.396154346132, 6717.496187785838, 6263.843403914939, 6328.525360597881, 6458.354164583692, 6506.089147519446, 6517.478601711947, 6435.678216089271, 6488.935110648833, 6491.707873145814, 6497.415232629086, 6503.284638689645, 6258.12386265914, 6260.843478913063, 6261.499080073674, 6273.278572963985, 6274.811755647338, 6387.393197646216, 6459.677016149268, 6567.802965911031, 6577.408033277028, 6604.603723776589, 6294.276158241861, 6298.212723409574, 6306.653134077486, 6311.684415779101, 6313.273973493107, 6201.255849298113, 6277.748890044347, 6299.874002520016, 6337.65142917144, 6353.428191462791, 5241.659292145999, 6159.969200153971, 6245.219347581552, 6248.500119990299, 6270.811875643738, 6311.116443697794, 6329.49364050884, 6330.778422755181, 6350.650714210763, 6367.586106903036, 6120.355709576858, 6217.564770466024, 6259.029850373199, 6266.436020758154, 6291.245050593958], "value": 5894.207635378389, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [761.402299195132, 795.5823192823768, 809.7327881799005, 1132.1848269246145, 1146.9025132863705, 27192.048278310263, 27713.861430692818, 27720.722792772067, 27772.44455110899, 27821.721782782166, 27730.306742331453, 38362.42456363157, 38443.61556384435, 38520.61479385205, 38556.80721596388, 8382.03606585243, 8546.487210767344, 8558.058613552505, 8560.957195214016, 8599.355048371366, 5990.8502287442725, 8429.0, 8571.742847714548, 8572.914270857274, 8574.957125214365, 6143.293521245047, 8387.161283871594, 8553.95723021384, 8558.657653693845, 8572.699955501559, 8518.574071296442, 8573.01410337813, 8588.398812083156, 8595.914040859605, 8596.613152408157, 5989.880202395928, 8291.502509849368, 8380.580970951429, 8399.698046802756, 8409.915900841035, 26698.733012669818, 36472.452913206325, 36581.451278230845, 36601.81699091488, 36904.63095369039, 3575.6960658344074, 3609.963900360989, 3614.2410093880317, 3615.8553657853654, 3616.2948225096115, 30769.38461230763, 30797.0, 30917.0, 30997.535036974463, 31003.0, 3125.46867032605, 3169.0492852144266, 3190.952135717966, 3199.2161920329436, 3199.680031996805, 240375.0, 282071.0, 288445.0, 288918.9999999979, 289095.0, 47905.281420778716, 48011.75994120077, 48029.519704803206, 48122.518774811804, 48137.75931120322, 45629.087418252115, 47693.0, 51178.232326515135, 51233.743831280604, 51398.74300628473, 13592.932035339958, 13716.931415342859, 13738.725225495635, 13749.725005500035, 13768.449262029406, 11128.666140015812, 11138.053265472525, 11138.721531961604, 11154.10767138627, 11156.497957591928, 8843.744845064468, 10606.15150787935, 12113.273203607812, 12384.195027323196, 12458.937705311415, 4711.916403029405, 4899.04468628614, 5638.548916086703, 5861.384554621789, 5868.706564671749, 981.8330883749779, 1016.872890888639, 1019.6380284998867, 1045.5608644369383, 1050.364529459681, 18798.0, 19786.307479238447, 23685.407864803172, 24788.38029049288, 25186.74813251844, 964.5996911281879, 1082.0910435234441, 1093.6773651772746, 1132.3828513460185, 1149.3391300002531, 10938.890611093788, 11530.365829879269, 11704.648860534198, 12473.251604903553, 12637.368131593383, 281857.0, 306275.0, 306494.0, 306551.4672426624, 306798.0, 53968.73015634975, 54009.45990540123, 54106.0, 54130.45869541254, 54244.0, 1408.5985494134327, 1452.389996201619, 1499.9475018374305, 1506.6233441639808, 1526.198745658516, 22442.88778556162, 22538.08426283784, 22908.083676652746, 24140.39649008789, 24177.637335440333, 37989.81005094957, 38033.80983095067, 38066.0, 38190.0, 38333.233335333694, 279687.2031279661, 280481.0, 280678.0, 281082.0, 281532.0, 33494.66505335013, 33966.0, 34051.0, 34127.488087678204, 34236.31527369488, 36953.0, 37538.498460061295, 44515.777421113984, 44807.551924480336, 44881.775591121834, 22901.885490573106, 25390.492190156463, 28804.0, 29121.126366209046, 29827.403451931274, 23751.0, 30493.847530762203, 30610.84694576513, 30998.0, 31016.844915775277, 35816.4627530582, 36001.45997810087, 36499.452508212926, 36760.81619591885, 36809.0, 25839.354016149748, 30090.849545753008, 30962.53556196614, 31029.379412411174, 31494.370112598077, 21979.120835166414, 22577.661335079658, 23316.65025024592, 23814.52370952606, 24140.0], "value": 16813.119415012738, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.6871177904792, 422.78015431975376, 427.58524231495437, 438.08003193294076, 451.79443353274263, 19195.904020479877, 20924.267650632213, 21572.13711451544, 21742.0, 21758.347249582497, 21794.89102554489, 22150.556988860215, 22450.76520791356, 22609.54780904381, 22992.850357482144, 6113.205283313174, 6348.0, 6355.968220158893, 6358.491320694357, 6366.745330186787, 6031.155638210654, 6170.382961703838, 6254.562180647356, 6273.027680709497, 6304.180456540644, 5295.417504074568, 6148.200733904586, 6223.284322302948, 6226.626402415847, 6234.189555357797, 6031.4270144336215, 6224.564280500322, 6261.123442718023, 6281.842953926142, 6291.779787707431, 5374.462553744634, 5537.473939975695, 5568.638038527482, 5580.274564306655, 5619.1009438490055, 26774.929002839865, 26796.062137825276, 27500.449991000267, 27764.30589235285, 27989.0, 1921.6060707554918, 2299.6895419118373, 2301.9079236830507, 2304.193532263711, 2305.446692793734, 17349.566260843454, 17591.648167036714, 18044.368447104287, 18071.0, 18274.36039738616, 2145.817605503534, 2166.490874644457, 2198.670199470076, 2202.493426511895, 2205.658122990923, 155561.0, 157253.0, 158255.0, 159908.0, 162149.0, 11771.646850594496, 12463.875361246453, 12488.876001159939, 12489.812652810215, 12504.937475312565, 16720.0, 16767.0, 16776.916115419346, 16780.916095419445, 16789.664206716043, 7361.895715642697, 8710.390272680852, 8894.911050889537, 8957.28341732673, 9046.773830654287, 8391.8321633567, 8411.200935911078, 8412.495250284881, 8592.0, 8606.13938606147, 6635.900461493082, 7710.843373493909, 7716.2669546393, 7801.414893882868, 7834.255745704149, 1831.4505648305721, 1990.9800901991084, 2159.902804373807, 2167.533980194266, 2167.837412194092, 833.6998680475024, 927.3091546797679, 928.4150984879618, 940.9905900940903, 950.8448081882219, 19354.903225483784, 20459.693104603444, 21240.362789116352, 21356.35930922075, 21371.35885923425, 920.3143657974852, 936.4615346175976, 986.4722373530127, 990.6186118344489, 993.2171751705706, 9376.0, 9755.609775609038, 10591.523381447852, 10980.792112867579, 11237.438128093563, 520837.0, 521247.3937630288, 526298.0, 533530.0, 544987.0, 90397.0, 100636.0, 108847.0, 109000.0, 117708.0, 990.0792263195298, 1054.9841752373568, 1159.0553698735503, 1159.2233203753506, 1159.8898104680043, 22027.779722203213, 22189.556208876056, 22232.221872234393, 22283.554328913007, 22286.665700014837, 38477.0, 42243.36634950417, 57140.714296428254, 58168.418315817995, 59780.70109649424, 70777.6461117691, 75772.62113689617, 76723.61638191773, 77453.0, 77784.22215777996, 8733.301335892986, 8946.821063578562, 9018.639254429749, 9143.222826059593, 9242.676506322246, 9850.0, 14273.57179284623, 14363.99452038389, 14708.485203018272, 14755.778663320274, 11882.82175767347, 12058.0, 12210.084243681937, 12286.631401057983, 12297.077719170918, 11366.261193022427, 11449.942750286194, 11574.768504629692, 11792.0, 11854.051675866083, 9866.457344845816, 11763.176577639482, 11931.105167112328, 12244.877551224374, 12289.70958049392, 8743.0, 8744.69393571222, 8974.86537701948, 8996.820063598821, 9146.542672866462, 11918.642440726791, 11979.880201197877, 12086.51653933868, 12211.694707632025, 12225.877741222474], "value": 10328.931872316283, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1353.1678018018918, 1420.2401715082426, 1441.9855801441981, 1443.0259574787017, 1463.8755705765009, 11292.887071129286, 11876.703082422922, 11890.989265912396, 11906.702332441682, 11936.283822970629, 9760.511974401286, 11527.884721152786, 11600.767984640323, 11755.941220293907, 11965.222260553059, 2507.1601013660447, 2549.5665736824785, 2550.4516528946274, 2560.705518865326, 2563.14134764854, 2481.7766401023996, 2490.476999830038, 2540.504601602688, 2542.4660821227562, 2545.5163518931436, 2456.3245107595376, 2559.5264875997905, 2559.9616005759926, 2562.2441379792913, 2562.897484100643, 2113.2392338758036, 2462.950740985188, 2511.8618475983812, 2528.5954247320433, 2570.6786651668635, 2448.8530688158767, 2474.7772700457044, 2475.2697954103583, 2482.044412901028, 2496.5131799299143, 11843.111766617452, 11967.341796201206, 11980.760384792255, 11991.0, 12021.51913923442, 6560.114384558071, 6808.931910680879, 6814.454843612499, 6825.965870170618, 6837.692303846339, 3922.8038598069984, 4220.978895105535, 4235.195312890541, 4324.82700691972, 4327.956720432787, 1230.341767154577, 1255.7614053329837, 1290.6128161551496, 1301.8242537257445, 1304.0741073837587, 15174.468893588672, 15575.0, 15581.143037132953, 16616.0, 16654.83345166557, 5039.949600503948, 5183.844484665466, 5189.117849965515, 5190.8183213587345, 5198.246254293182, 12125.69685757863, 12394.62816115518, 12401.13192076564, 12425.565105221274, 12429.813552796715, 6379.202599675041, 6444.484441244689, 6452.322506136882, 6461.935380646133, 6529.347065293433, 6097.512199024068, 6252.249730032334, 6268.091126786681, 6273.498120150468, 6277.587542802833, 4410.823567057282, 4421.027373977719, 4435.756033418128, 4485.0581377911, 4517.2094883395275, 1289.8516670583003, 1292.140726416941, 1299.1750238598559, 1306.3664122900386, 1314.6844757258189, 688.8002479280952, 766.4443278622954, 795.9602019899098, 796.5977181523409, 810.6878851642042, 6705.994100884809, 6774.898376524356, 6855.657217139223, 6895.5173137879865, 6976.686049127801, 814.3159745813545, 886.2688282167109, 900.617237673986, 937.7843096087938, 940.1022023967095, 3680.742348035612, 4098.323776576832, 4129.855455059059, 4148.02521407469, 4286.39990401344, 14934.626634334012, 15344.846551534565, 15365.692686146214, 15389.076655400711, 15452.922735386475, 14756.778648320284, 15136.621584460476, 15247.390104395921, 15249.237538123049, 15307.693846123015, 8681.479111253346, 8831.823363532694, 8837.20465158126, 8882.777930551658, 8895.110488951183, 5812.593118481665, 6230.127782110418, 6535.509836762167, 6752.729890804313, 6812.0, 12898.80651790205, 13188.340582971005, 13828.170309781446, 13853.722925541231, 13914.7476727091, 11736.471858766205, 12388.194767340094, 12608.810867837174, 12639.494420223456, 13949.721005580035, 10620.415877126523, 10725.249232553646, 10774.569017239537, 10865.18511111654, 10869.456527173768, 9763.707088787347, 10578.100861426865, 10771.6229931952, 10772.24594278393, 10780.514876830404, 8995.0, 9038.774030649023, 9091.681791137278, 9379.343445958717, 9458.763530911783, 8737.169968852948, 8903.955480222558, 9023.187913087853, 9072.364934454525, 9111.681091161778, 8095.617529880478, 8141.755747327589, 8198.1391953844, 8263.917360826556, 8292.17078292166, 5699.544036476989, 5840.503557197686, 5985.371535988833, 5996.850078748066, 6210.596311239755, 5954.46409823118, 6037.75848966054, 6086.452219300284, 6086.452219300284, 6129.908051379144], "value": 5399.079506383964, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.0744768413439, 402.3321286664136, 407.1673427840067, 410.9547949725528, 413.32008845449235, 4931.827386041489, 5608.971955140229, 5893.116032595113, 5922.88154236915, 5944.78131982943, 4931.950680493194, 5119.515340551236, 5530.474604912537, 5659.886802263953, 5848.0, 4449.176902273073, 4465.330200469939, 4465.508794032654, 4466.8436604718845, 4470.932936005963, 4454.33185022246, 4484.932726009112, 4500.392447019643, 4502.6172775314135, 4505.797239124231, 3658.5609726832686, 4319.6457930428, 4416.447944006999, 4446.266366049598, 4456.376107344974, 4422.646188304944, 4439.622632076277, 4443.977885086416, 4446.1107778444275, 4453.0, 3942.743721658083, 3973.403989401584, 3984.3625019996953, 3988.920221595552, 3991.1419044905483, 5418.810341638024, 5564.4991950724625, 5613.971930140364, 5704.117641178401, 5723.397448714367, 5320.813771517978, 5338.706371149585, 5347.679139251657, 5358.705271210082, 5363.490468405495, 6244.625322480666, 6254.843628909268, 6255.530835187379, 6266.310705822356, 6266.843328916768, 4310.98691807425, 4467.664925130628, 4529.9547004530195, 4534.279432340602, 4540.772961351952, 6310.5898116622275, 6480.3195664455025, 6514.478841692653, 6538.640374779386, 6544.345565443466, 3938.542739186519, 4202.348635961431, 4463.8214471421425, 4471.955280447219, 4475.888102797456, 4693.882652933636, 4703.200455922433, 4705.976470117627, 4724.433068031858, 4739.502352253033, 4161.958380416218, 5168.01807656544, 5177.8446646599905, 5363.410024897258, 5385.434529374437, 5502.422245664227, 5713.314402271754, 5809.099589563624, 6305.211848518935, 6330.0, 1535.8848086393566, 1607.4615003973565, 1613.9757903631455, 1626.8291829357747, 1626.991865040667, 1079.2391364088298, 1122.3041714137287, 1130.8473356096986, 1131.4399372310595, 1150.4535345710888, 4706.529347065334, 5919.348871624118, 5936.792212272636, 5946.256717910262, 5975.223220981332, 5107.846764597068, 6194.318624951252, 6445.709943052574, 6463.806085817433, 6475.801976634338, 5097.847064588068, 5540.584456165804, 5851.0, 5881.529477641779, 5885.323187833454, 2901.2746813296676, 3331.3337332533592, 3352.8155951422905, 3363.83180840957, 3378.3243351329834, 5115.5396014358885, 6614.669266536654, 6629.966850165815, 6652.467802575879, 6655.73377064912, 6615.37153970372, 6624.403803657598, 6630.9336906630315, 6638.369354911276, 6678.699458524378, 5314.5216930476445, 6290.496760259169, 6595.4393876521035, 6608.2400523939405, 6657.567258128206, 6391.169148010729, 6416.647084410216, 6417.7753778617525, 6449.935500644933, 6451.4516266116025, 6129.632222066691, 6233.252009758858, 6369.694212686296, 6370.267419246846, 6374.872502549831, 5829.737661805144, 6621.437177839744, 6649.140869426194, 6677.332266773284, 6695.799126026227, 3894.552126505488, 3945.033466800652, 4126.525449573338, 4312.353147027971, 4329.830945644721, 5385.299911011543, 6175.3515880831865, 6412.551121421456, 6486.254080780771, 6552.508561857975, 5516.393196748435, 6231.501479881508, 6236.440889777556, 6259.34276900937, 6266.310705822447, 5188.714620695898, 5982.222311099703, 6246.718897649707, 6255.966810786604, 6287.559870808999, 5870.972579798604, 6088.969555152196, 6162.476189523941, 6179.351168127282, 6194.4115309045565, 5496.835094947158, 5660.745266463102, 6146.692665366624, 6259.624422534663, 6278.0, 5515.944840551543, 5833.212516310414, 6133.0, 6141.201643786458, 6168.321484636776], "value": 4644.099416762006, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.9858002839946, 795.8010497375656, 864.3128712673424, 866.501761487145, 874.0822136756407, 12740.044496662753, 14880.851191488082, 17339.65320693587, 17745.46763597094, 17746.3788767393, 16717.498475045737, 17173.74239386407, 17455.21451534681, 17730.46808595741, 18012.81987180128, 960.9231261499064, 1003.372891942536, 1006.1598565198068, 1008.5713571732022, 1008.8133695266363, 678.6844117485368, 706.2055187913597, 1027.2706378471294, 1027.768752030791, 1030.922680798943, 755.765712629084, 760.3347071312602, 762.8359902620936, 1019.7246743379283, 1066.264277648424, 1014.7666036811501, 1023.6724248240529, 1026.1585499890093, 1026.296986564206, 1060.4697651174413, 760.2055851634999, 762.0893032825776, 762.527233115472, 764.9502782319131, 789.1556035042507, 16168.353265869351, 16451.42420015306, 16635.251413686292, 16700.49898503047, 17030.574235644082, 13975.930120349332, 16731.749023764653, 16904.323827046905, 17122.657546849117, 17175.570610734707, 13876.861231387758, 14081.366338514792, 14153.363098660586, 14223.004389692622, 14345.211013394259, 3531.4526248431534, 3548.8580456781697, 3551.0057183988524, 3553.0, 3555.306715190539, 107654.3851842223, 107682.0, 107698.99999999921, 107804.0, 109348.0, 11100.777984440267, 11468.254563453349, 13070.346482675828, 13153.342332883318, 13279.269640169883, 18571.44285671432, 19486.025698715006, 19917.0, 25307.0, 25358.366040848756, 7716.42126840478, 7805.414593905366, 7918.881216781753, 7929.484583502054, 7929.563873986871, 3906.570277269498, 3947.684185265172, 3981.7212795104642, 3983.661388781928, 3999.34010888206, 4341.110072435206, 4433.069055498381, 4438.533953934855, 4440.755758433317, 4444.0, 892.2638822971074, 947.4694171263976, 948.369334392635, 948.8671585977969, 949.715085474355, 645.4642646603309, 665.5756680703299, 668.3216535216661, 672.8755180291662, 702.2521015118882, 10001.949795271392, 10974.176936729777, 11082.445877706245, 11885.940570297093, 11899.345535995604, 647.7344288841647, 656.592912394309, 659.953803233769, 687.5599616245507, 689.1764341611826, 4782.37829082224, 5252.527272545489, 5313.814016509404, 5458.153986132156, 5558.221848941152, 97242.02757972472, 101738.0, 102370.48814756027, 102635.46046809155, 105196.0, 84090.0, 85702.57148714217, 85853.0, 86467.56766216128, 87765.0, 77912.0, 78641.60679196568, 79427.01432464119, 80685.78971315434, 81464.59267703624, 11721.531138754695, 12128.211666241667, 12166.330851803235, 12186.512539498675, 12238.449269782703, 39181.0, 39462.42150313955, 39700.60299396969, 39895.0, 39904.0, 40442.0, 47123.29315060345, 49266.507334926195, 49593.50406495889, 49894.0, 15718.449854255046, 15775.605609859846, 15798.526044218692, 16024.359025638843, 16244.51266462008, 17577.0, 17645.823541764417, 17861.821381786016, 17907.820921791135, 18348.899066056078, 16234.51296461108, 16781.832181678026, 16796.076215808247, 16902.23939922731, 16943.237554310334, 16300.918495407446, 16457.0, 16838.410655626994, 16951.406700765416, 17004.31982720727, 15911.363545458053, 16119.919400402923, 16296.755548666542, 16385.262663179947, 16501.257443414834, 11554.94222528882, 11599.942000289944, 11702.180847340946, 11917.642470725892, 12112.697182570506, 10858.891411085788, 11379.805120462232, 12331.75336493283, 12595.24428534291, 12727.80908286358], "value": 8121.115744656037, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1447.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 111.0, 111.0, 110.0, 111.0, 111.0, 111.0, 110.0, 110.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 111.0, 109.0, 146.0, 108.0, 110.0, 94.0, 141.0, 159.0, 145.0], "value": 126.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 186.0, 184.0, 185.0, 184.0, 185.0, 183.0, 184.0, 180.0, 183.0], "value": 184.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 62.0, 77.0, 119.0, 88.0, 57.0, 56.0, 59.0, 81.0, 57.0], "value": 73.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 69.0, 85.0, 68.0, 68.0, 68.0, 90.0, 68.0, 69.0, 90.0], "value": 76.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 86.0, 87.0, 86.0, 86.0, 86.0, 85.0, 87.0, 87.0], "value": 86.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 94.0, 93.0, 93.0, 94.0, 93.0, 94.0], "value": 93.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 84.0, 84.0, 85.0, 86.0, 85.0, 84.0, 84.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 46.0, 48.0, 46.0, 47.0, 46.0, 47.0, 47.0, 47.0, 49.0], "value": 47.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 57.0, 69.0, 62.0, 60.0, 56.0, 57.0, 58.0, 57.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 70.0, 94.0, 108.0, 106.0, 104.0, 105.0, 83.0, 84.0], "value": 91.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 149.0, 146.0, 134.0, 137.0, 141.0, 135.0, 135.0, 221.0, 151.0], "value": 149.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 179.0, 188.0, 186.0, 186.0, 178.0, 221.0, 185.0, 180.0, 184.0], "value": 187.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 71.0, 87.0, 96.0, 97.0, 96.0, 55.0, 73.0], "value": 77.8, "unit": "score"}]}]} 01:28:32 INFO - Return code: 0 01:28:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:28:32 ERROR - # TBPL SUCCESS # 01:28:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:28:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:28:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:28:32 INFO - 2017-04-20 01:28:32.279 screenresolution[1651:9756] starting screenresolution argv=screenresolution get 01:28:32 INFO - 2017-04-20 01:28:32.282 screenresolution[1651:9756] Display 0: 1600x1200x32@60 01:28:32 INFO - 2017-04-20 01:28:32.288 screenresolution[1652:9759] starting screenresolution argv=screenresolution list 01:28:32 INFO - Available Modes on Display 0 01:28:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:28:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:28:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:28:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:28:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:28:32 INFO - Intel Iris: 01:28:32 INFO - Chipset Model: Intel Iris 01:28:32 INFO - Type: GPU 01:28:32 INFO - Bus: Built-In 01:28:32 INFO - VRAM (Dynamic, Max): 1536 MB 01:28:32 INFO - Vendor: Intel (0x8086) 01:28:32 INFO - Device ID: 0x0a2e 01:28:32 INFO - Revision ID: 0x0009 01:28:32 INFO - Displays: 01:28:32 INFO - Display: 01:28:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:28:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:28:32 INFO - Display Serial Number: 1600x1200 60 01:28:32 INFO - Main Display: Yes 01:28:32 INFO - Mirror: Off 01:28:32 INFO - Online: Yes 01:28:32 INFO - Rotation: Supported 01:28:32 INFO - Return code: 0 01:28:32 INFO - Running post-action listener: _resource_record_post_action 01:28:32 INFO - [mozharness: 2017-04-20 08:28:32.521506Z] Finished run-tests step (success) 01:28:32 INFO - Running post-run listener: _resource_record_post_run 01:28:32 INFO - Total resource usage - Wall time: 1200s; CPU: 53.0%; Read bytes: 38949888; Write bytes: 514732544; Read time: 380; Write time: 1664 01:28:32 INFO - TinderboxPrint: CPU usage
53.5% 01:28:32 INFO - TinderboxPrint: I/O read bytes / time
38,949,888 / 380 01:28:32 INFO - TinderboxPrint: I/O write bytes / time
514,732,544 / 1,664 01:28:32 INFO - TinderboxPrint: CPU idle
2,235.0 (46.5%) 01:28:32 INFO - TinderboxPrint: CPU system
958.2 (20.0%) 01:28:32 INFO - TinderboxPrint: CPU user
1,608.4 (33.5%) 01:28:32 INFO - TinderboxPrint: Swap in / out
246,513,664 / 0 01:28:32 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 198726144; Write bytes: 193283584; Read time: 14915; Write time: 353 01:28:32 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 37979136; Write bytes: 304618496; Read time: 365; Write time: 1243 01:28:33 INFO - Running post-run listener: _upload_blobber_files 01:28:33 INFO - Blob upload gear active. 01:28:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:28:33 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 01:28:33 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'] 01:28:33 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 01:28:33 INFO - (blobuploader) - INFO - Open directory for files ... 01:28:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:28:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:28:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:28:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:28:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:28:34 INFO - (blobuploader) - INFO - Done attempting. 01:28:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:28:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:28:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:28:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:28:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:28:35 INFO - (blobuploader) - INFO - Done attempting. 01:28:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:28:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:28:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:28:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:28:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:28:36 INFO - (blobuploader) - INFO - Done attempting. 01:28:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:28:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:28:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:28:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:28:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:28:38 INFO - (blobuploader) - INFO - Done attempting. 01:28:38 INFO - (blobuploader) - INFO - Iteration through files over. 01:28:38 INFO - Return code: 0 01:28:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:28:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:28:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b94d96d1bc874df5c09d6e0fbc122f82762c3a61abaf7dc99518a6b76a8d07ab16d01cc628cd08c0f6afd48c81bf4104773cf5e3186638dd6b9f1bfcecbc6c06", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7272cc1caddf07c3da9dfc75761158874a3a161de1094d7462193359347bae4356c1bdfc23641e187a08f4d242472fc42458e07a9be20c09c6bdba29800e613d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a26af991eb403c9a5977441d8cf0a683b1276f8dda84a47f6877a1f6378cafeca810657bcee23b59e8710d81c7fe3e6bfdd72929bed95aa6071544378f2327a2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f49c195aa8f55f1abfe45a3dec23d068ea86ce881c55b80eb35f42a1fd7f8f3af3f59dc243b1a778bfba7152c9bfc2dfe8388e26098d9895247edf46ea76445"} 01:28:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:28:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:28:38 INFO - Contents: 01:28:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b94d96d1bc874df5c09d6e0fbc122f82762c3a61abaf7dc99518a6b76a8d07ab16d01cc628cd08c0f6afd48c81bf4104773cf5e3186638dd6b9f1bfcecbc6c06", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7272cc1caddf07c3da9dfc75761158874a3a161de1094d7462193359347bae4356c1bdfc23641e187a08f4d242472fc42458e07a9be20c09c6bdba29800e613d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a26af991eb403c9a5977441d8cf0a683b1276f8dda84a47f6877a1f6378cafeca810657bcee23b59e8710d81c7fe3e6bfdd72929bed95aa6071544378f2327a2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f49c195aa8f55f1abfe45a3dec23d068ea86ce881c55b80eb35f42a1fd7f8f3af3f59dc243b1a778bfba7152c9bfc2dfe8388e26098d9895247edf46ea76445"} 01:28:38 INFO - Running post-run listener: copy_logs_to_upload_dir 01:28:38 INFO - Copying logs to upload dir... 01:28:38 INFO - mkdir: /builds/slave/test/build/upload/logs 01:28:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.328686 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-20 01:28:38.580966) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-20 01:28:38.584126) ========= 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.MQzx2FiK5Q/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.UntVS59VLp/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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/b94d96d1bc874df5c09d6e0fbc122f82762c3a61abaf7dc99518a6b76a8d07ab16d01cc628cd08c0f6afd48c81bf4104773cf5e3186638dd6b9f1bfcecbc6c06", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7272cc1caddf07c3da9dfc75761158874a3a161de1094d7462193359347bae4356c1bdfc23641e187a08f4d242472fc42458e07a9be20c09c6bdba29800e613d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a26af991eb403c9a5977441d8cf0a683b1276f8dda84a47f6877a1f6378cafeca810657bcee23b59e8710d81c7fe3e6bfdd72929bed95aa6071544378f2327a2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f49c195aa8f55f1abfe45a3dec23d068ea86ce881c55b80eb35f42a1fd7f8f3af3f59dc243b1a778bfba7152c9bfc2dfe8388e26098d9895247edf46ea76445"} build_url:https://queue.taskcluster.net/v1/task/SwJPNy_TRdKF1CSMbOzHyg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011136 build_url: 'https://queue.taskcluster.net/v1/task/SwJPNy_TRdKF1CSMbOzHyg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b94d96d1bc874df5c09d6e0fbc122f82762c3a61abaf7dc99518a6b76a8d07ab16d01cc628cd08c0f6afd48c81bf4104773cf5e3186638dd6b9f1bfcecbc6c06", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7272cc1caddf07c3da9dfc75761158874a3a161de1094d7462193359347bae4356c1bdfc23641e187a08f4d242472fc42458e07a9be20c09c6bdba29800e613d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a26af991eb403c9a5977441d8cf0a683b1276f8dda84a47f6877a1f6378cafeca810657bcee23b59e8710d81c7fe3e6bfdd72929bed95aa6071544378f2327a2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f49c195aa8f55f1abfe45a3dec23d068ea86ce881c55b80eb35f42a1fd7f8f3af3f59dc243b1a778bfba7152c9bfc2dfe8388e26098d9895247edf46ea76445"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-20 01:28:38.621087) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 01:28:38.621460) ========= 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.MQzx2FiK5Q/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.UntVS59VLp/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.005078 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 01:28:38.670483) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-20 01:28:38.673824) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-20 01:28:38.674151) ========= ========= Total master_lag: 0.29 =========