builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0363 starttime: 1493638696.42 results: success (0) buildid: 20170501030204 builduid: ba6e4e2072514cbe9a82b58e9a0be0f9 revision: 076a7a66096f9e8d102548397254be32eb26bc3d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-01 04:38:16.417544) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-01 04:38:16.418187) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-01 04:38:16.418708) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-01 04:38:16.574125) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 04:38:16.574652) ========= 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.yCLwXbMYMB/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.mXD4E7eWEY/Listeners TMPDIR=/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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-05-01 04:38:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 153M=0s 2017-05-01 04:38:17 (153 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.465728 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 04:38:17.068867) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 04:38:17.069201) ========= 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.yCLwXbMYMB/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.mXD4E7eWEY/Listeners TMPDIR=/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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.026470 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 04:38:17.118827) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-01 04:38:17.119180) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 076a7a66096f9e8d102548397254be32eb26bc3d --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 076a7a66096f9e8d102548397254be32eb26bc3d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yCLwXbMYMB/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.mXD4E7eWEY/Listeners TMPDIR=/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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-05-01 04:38:17,225 truncating revision to first 12 chars 2017-05-01 04:38:17,225 Setting DEBUG logging. 2017-05-01 04:38:17,225 attempt 1/10 2017-05-01 04:38:17,225 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/076a7a66096f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-01 04:38:18,197 unpacking tar archive at: mozilla-central-076a7a66096f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.251383 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-01 04:38:18.398371) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-01 04:38:18.398659) ========= script_repo_revision: 076a7a66096f9e8d102548397254be32eb26bc3d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-01 04:38:18.399041) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-01 04:38:18.399328) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-01 04:38:18.420561) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-05-01 04:38:18.420823) ========= /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.yCLwXbMYMB/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.mXD4E7eWEY/Listeners TMPDIR=/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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 04:38:18 INFO - MultiFileLogger online at 20170501 04:38:18 in /builds/slave/test 04:38:18 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 04:38:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:38:18 INFO - {'append_to_log': False, 04:38:18 INFO - 'base_work_dir': '/builds/slave/test', 04:38:18 INFO - 'blob_upload_branch': 'Firefox', 04:38:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:38:18 INFO - 'branch': 'Firefox', 04:38:18 INFO - 'buildbot_json_path': 'buildprops.json', 04:38:18 INFO - 'config_files': ('talos/mac_config.py',), 04:38:18 INFO - 'default_actions': ('clobber', 04:38:18 INFO - 'read-buildbot-config', 04:38:18 INFO - 'download-and-extract', 04:38:18 INFO - 'populate-webroot', 04:38:18 INFO - 'create-virtualenv', 04:38:18 INFO - 'install', 04:38:18 INFO - 'run-tests'), 04:38:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:38:18 INFO - 'download_minidump_stackwalk': True, 04:38:18 INFO - 'download_symbols': 'ondemand', 04:38:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:38:18 INFO - 'tooltool.py': '/tools/tooltool.py', 04:38:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:38:18 INFO - '/tools/misc-python/virtualenv.py')}, 04:38:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:38:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:38:18 INFO - 'gecko_profile': False, 04:38:18 INFO - 'gecko_profile_interval': 0, 04:38:18 INFO - 'installer_path': 'installer.exe', 04:38:18 INFO - 'log_level': 'info', 04:38:18 INFO - 'log_name': 'talos', 04:38:18 INFO - 'log_to_console': True, 04:38:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:38:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:38:18 INFO - 'opt_config_files': (), 04:38:18 INFO - 'pip_index': False, 04:38:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:38:18 INFO - 'cmd': ('bash', 04:38:18 INFO - '-c', 04:38:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:38:18 INFO - 'enabled': True, 04:38:18 INFO - 'halt_on_failure': False, 04:38:18 INFO - 'name': 'check_screen_resolution'},), 04:38:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:38:18 INFO - 'cmd': ('bash', 04:38:18 INFO - '-c', 04:38:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:38:18 INFO - 'enabled': True, 04:38:18 INFO - 'halt_on_failure': False, 04:38:18 INFO - 'name': 'check_screen_resolution'},), 04:38:18 INFO - 'run_cmd_checks_enabled': True, 04:38:18 INFO - 'suite': 'dromaeojs', 04:38:18 INFO - 'system_bits': '32', 04:38:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:38:18 INFO - 'title': 't-yosemite-r7-0363', 04:38:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:38:18 INFO - 'use_talos_json': True, 04:38:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:38:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:38:18 INFO - 'work_dir': 'build'} 04:38:18 INFO - [mozharness: 2017-05-01 11:38:18.636150Z] Running clobber step. 04:38:18 INFO - Running pre-action listener: _resource_record_pre_action 04:38:18 INFO - Running main action method: clobber 04:38:18 INFO - rmtree: /builds/slave/test/build 04:38:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:38:21 INFO - Running post-action listener: _resource_record_post_action 04:38:21 INFO - [mozharness: 2017-05-01 11:38:21.164915Z] Finished clobber step (success) 04:38:21 INFO - [mozharness: 2017-05-01 11:38:21.165065Z] Running read-buildbot-config step. 04:38:21 INFO - Running pre-action listener: _resource_record_pre_action 04:38:21 INFO - Running main action method: read_buildbot_config 04:38:21 INFO - Using buildbot properties: 04:38:21 INFO - { 04:38:21 INFO - "project": "", 04:38:21 INFO - "product": "firefox", 04:38:21 INFO - "script_repo_revision": "production", 04:38:21 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:38:21 INFO - "repository": "", 04:38:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:38:21 INFO - "buildid": "20170501030204", 04:38:21 INFO - "stage_platform": "macosx64", 04:38:21 INFO - "basedir": "/builds/slave/test", 04:38:21 INFO - "nightly_build": "True", 04:38:21 INFO - "buildnumber": 20, 04:38:21 INFO - "slavename": "t-yosemite-r7-0363", 04:38:21 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 04:38:21 INFO - "platform": "yosemite_r7", 04:38:21 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:38:21 INFO - "branch": "mozilla-central", 04:38:21 INFO - "repo_path": "mozilla-central", 04:38:21 INFO - "revision": "076a7a66096f9e8d102548397254be32eb26bc3d", 04:38:21 INFO - "pgo_build": "False", 04:38:21 INFO - "builduid": "ba6e4e2072514cbe9a82b58e9a0be0f9", 04:38:21 INFO - "slavebuilddir": "test" 04:38:21 INFO - } 04:38:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:38:21 INFO - Running post-action listener: _resource_record_post_action 04:38:21 INFO - [mozharness: 2017-05-01 11:38:21.168326Z] Finished read-buildbot-config step (success) 04:38:21 INFO - [mozharness: 2017-05-01 11:38:21.168461Z] Running download-and-extract step. 04:38:21 INFO - Running pre-action listener: _resource_record_pre_action 04:38:21 INFO - Running main action method: download_and_extract 04:38:21 INFO - mkdir: /builds/slave/test/build/tests 04:38: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')]} 04:38:21 INFO - trying https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:38:21 INFO - Downloading https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/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 04:38:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/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 04:38:22 INFO - Downloaded 1325 bytes. 04:38:22 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:38:22 INFO - Using the following test package requirements: 04:38:22 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:38:22 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:38:22 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:38:22 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:38:22 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:38:22 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:38:22 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:38:22 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:38:22 INFO - u'jsshell-mac.zip'], 04:38:22 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:38:22 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:38:22 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:38:22 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:38:22 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:38:22 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:38:22 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:38:22 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:38:22 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:38:22 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:38:22 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:38:22 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:38:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:38:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:38:22 INFO - Fetch https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:38:24 INFO - Content-Length response header: 52699090 04:38:24 INFO - Bytes received: 52699090 04:38:40 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 04:38:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:38:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:38:40 INFO - Fetch https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:38:42 INFO - Content-Length response header: 52699090 04:38:42 INFO - Bytes received: 52699090 04:38:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:38:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:38:58 INFO - Fetch https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:38:58 INFO - Content-Length response header: 14408811 04:38:58 INFO - Bytes received: 14408811 04:38:59 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')]} 04:38:59 INFO - trying https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:38:59 INFO - Downloading https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:38:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/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 04:39:01 INFO - Downloaded 71324432 bytes. 04:39:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:39:01 INFO - mkdir: /builds/slave/test/properties 04:39:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:39:01 INFO - Writing to file /builds/slave/test/properties/build_url 04:39:01 INFO - Contents: 04:39:01 INFO - build_url:https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:39:01 INFO - Running post-action listener: _resource_record_post_action 04:39:01 INFO - Running post-action listener: set_extra_try_arguments 04:39:01 INFO - [mozharness: 2017-05-01 11:39:01.852797Z] Finished download-and-extract step (success) 04:39:01 INFO - [mozharness: 2017-05-01 11:39:01.852920Z] Running populate-webroot step. 04:39:01 INFO - Running pre-action listener: _resource_record_pre_action 04:39:01 INFO - Running main action method: populate_webroot 04:39:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:39:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:39:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:39:01 INFO - '--tppagecycles', 04:39:01 INFO - '7'], 04:39:01 INFO - 'tests': ['tsvgm']}}, 04:39:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:39:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:39:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:39:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:39:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:39:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:39:01 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:39:01 INFO - 'talos_options': ['--disable-e10s'], 04:39:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:39:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:39:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:39:01 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:39:01 INFO - 'talos_options': ['--disable-e10s'], 04:39:01 INFO - 'tests': ['damp', 'tps']}, 04:39:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:39:01 INFO - 'tests': ['damp', 'tps']}, 04:39:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:39:01 INFO - 'tests': ['dromaeo_dom']}, 04:39:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:39:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:39:01 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:39:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:39:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:39:01 INFO - 'tests': ['a11yr', 04:39:01 INFO - 'ts_paint', 04:39:01 INFO - 'tpaint', 04:39:01 INFO - 'sessionrestore', 04:39:01 INFO - 'sessionrestore_no_auto_restore', 04:39:01 INFO - 'tabpaint']}, 04:39:01 INFO - 'other-e10s': {'tests': ['a11yr', 04:39:01 INFO - 'ts_paint', 04:39:01 INFO - 'tpaint', 04:39:01 INFO - 'sessionrestore', 04:39:01 INFO - 'sessionrestore_no_auto_restore', 04:39:01 INFO - 'tabpaint']}, 04:39:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:39:01 INFO - 'ts_paint', 04:39:01 INFO - 'tpaint', 04:39:01 INFO - 'sessionrestore', 04:39:01 INFO - 'sessionrestore_no_auto_restore', 04:39:01 INFO - 'tabpaint']}, 04:39:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:39:01 INFO - 'ts_paint', 04:39:01 INFO - 'tpaint', 04:39:01 INFO - 'sessionrestore', 04:39:01 INFO - 'sessionrestore_no_auto_restore', 04:39:01 INFO - 'tabpaint']}, 04:39:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:39:01 INFO - 'tests': ['a11yr', 04:39:01 INFO - 'ts_paint', 04:39:01 INFO - 'tpaint', 04:39:01 INFO - 'sessionrestore', 04:39:01 INFO - 'sessionrestore_no_auto_restore', 04:39:01 INFO - 'tabpaint']}, 04:39:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:39:01 INFO - 'tests': ['a11yr', 04:39:01 INFO - 'ts_paint', 04:39:01 INFO - 'tpaint', 04:39:01 INFO - 'sessionrestore', 04:39:01 INFO - 'sessionrestore_no_auto_restore', 04:39:01 INFO - 'tabpaint']}, 04:39:01 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:39:01 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:39:01 INFO - 'bloom_basic_ref']}, 04:39:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:39:01 INFO - 'tests': ['tsvgx', 04:39:01 INFO - 'tsvgr_opacity', 04:39:01 INFO - 'tart', 04:39:01 INFO - 'tscrollx', 04:39:01 INFO - 'cart', 04:39:01 INFO - 'tsvg_static']}, 04:39:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:39:01 INFO - 'tsvgr_opacity', 04:39:01 INFO - 'tart', 04:39:01 INFO - 'tscrollx', 04:39:01 INFO - 'cart', 04:39:01 INFO - 'tsvg_static']}, 04:39:01 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:39:01 INFO - 'talos_options': ['--disable-e10s'], 04:39:01 INFO - 'tests': ['tp5o']}, 04:39:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:39:01 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:39:01 INFO - 'talos_options': ['--disable-e10s', 04:39:01 INFO - '--xperf_path', 04:39:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:39:01 INFO - 'tests': ['tp5n']}, 04:39:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:39:01 INFO - 'talos_options': ['--xperf_path', 04:39:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:39:01 INFO - 'tests': ['tp5n']}}, 04:39:01 INFO - 'talos.zip': {'path': '', 04:39:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:39:01 INFO - Running post-action listener: _resource_record_post_action 04:39:01 INFO - [mozharness: 2017-05-01 11:39:01.872177Z] Finished populate-webroot step (success) 04:39:01 INFO - [mozharness: 2017-05-01 11:39:01.872313Z] Running create-virtualenv step. 04:39:01 INFO - Running pre-action listener: _resource_record_pre_action 04:39:01 INFO - Running main action method: create_virtualenv 04:39:01 INFO - Creating virtualenv /builds/slave/test/build/venv 04:39:01 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 04:39:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:39:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:39:01 INFO - Using real prefix '/tools/python27' 04:39:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:39:02 INFO - Installing distribute.............................................................................................................................................................................................done. 04:39:05 INFO - Installing pip.................done. 04:39:05 INFO - Return code: 0 04:39:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:39:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:39:05 INFO - Reading from file tmpfile_stdout 04:39:05 INFO - Output received: 04:39:05 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) 04:39:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1055adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe90ad62960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10538bd30>, '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 0x1052b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105380be8>, '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.yCLwXbMYMB/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.mXD4E7eWEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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 04:39:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:39:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:39:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yCLwXbMYMB/Render', 04:39:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:05 INFO - 'HOME': '/Users/cltbld', 04:39:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:05 INFO - 'LOGNAME': 'cltbld', 04:39:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:05 INFO - 'MOZ_NO_REMOTE': '1', 04:39:05 INFO - 'NO_EM_RESTART': '1', 04:39:05 INFO - 'PAGER': '/bin/cat', 04:39:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:05 INFO - 'PWD': '/builds/slave/test', 04:39:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:05 INFO - 'SHELL': '/bin/bash', 04:39:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mXD4E7eWEY/Listeners', 04:39:05 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 04:39:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:05 INFO - 'USER': 'cltbld', 04:39:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:05 INFO - 'XPC_FLAGS': '0x0', 04:39:05 INFO - 'XPC_SERVICE_NAME': '0', 04:39:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:06 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 04:39:06 INFO - Cleaning up... 04:39:06 INFO - Return code: 0 04:39:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:06 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 0x1055adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe90ad62960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10538bd30>, '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 0x1052b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105380be8>, '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.yCLwXbMYMB/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.mXD4E7eWEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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 04:39:06 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 04:39:06 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 04:39:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yCLwXbMYMB/Render', 04:39:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:06 INFO - 'HOME': '/Users/cltbld', 04:39:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:06 INFO - 'LOGNAME': 'cltbld', 04:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:06 INFO - 'MOZ_NO_REMOTE': '1', 04:39:06 INFO - 'NO_EM_RESTART': '1', 04:39:06 INFO - 'PAGER': '/bin/cat', 04:39:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:06 INFO - 'PWD': '/builds/slave/test', 04:39:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:06 INFO - 'SHELL': '/bin/bash', 04:39:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mXD4E7eWEY/Listeners', 04:39:06 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 04:39:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:06 INFO - 'USER': 'cltbld', 04:39:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:06 INFO - 'XPC_FLAGS': '0x0', 04:39:06 INFO - 'XPC_SERVICE_NAME': '0', 04:39:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:06 INFO - Downloading/unpacking psutil>=3.1.1 04:39:06 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 04:39:06 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 04:39:06 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 04:39:06 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 04:39:06 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 04:39:06 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 04:39:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:39:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:39:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:39:10 INFO - Installing collected packages: psutil 04:39:10 INFO - Running setup.py install for psutil 04:39:10 INFO - building 'psutil._psutil_osx' extension 04:39:10 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 04:39:11 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 04:39:11 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 04:39:11 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 04:39:11 INFO - building 'psutil._psutil_posix' extension 04:39:11 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 04:39:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:39:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:39:11 INFO - ^ 04:39:11 INFO - 1 warning generated. 04:39:11 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 04:39:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:39:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:39:11 INFO - Successfully installed psutil 04:39:11 INFO - Cleaning up... 04:39:11 INFO - Return code: 0 04:39:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:39: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')]} 04:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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')]} 04:39:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1055adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe90ad62960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10538bd30>, '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 0x1052b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105380be8>, '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.yCLwXbMYMB/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.mXD4E7eWEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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 04:39: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:39: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 mozsystemmonitor==0.3 04:39:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yCLwXbMYMB/Render', 04:39:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:11 INFO - 'HOME': '/Users/cltbld', 04:39:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:11 INFO - 'LOGNAME': 'cltbld', 04:39:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:11 INFO - 'MOZ_NO_REMOTE': '1', 04:39:11 INFO - 'NO_EM_RESTART': '1', 04:39:11 INFO - 'PAGER': '/bin/cat', 04:39:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:11 INFO - 'PWD': '/builds/slave/test', 04:39:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:11 INFO - 'SHELL': '/bin/bash', 04:39:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mXD4E7eWEY/Listeners', 04:39:11 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 04:39:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:11 INFO - 'USER': 'cltbld', 04:39:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:11 INFO - 'XPC_FLAGS': '0x0', 04:39:11 INFO - 'XPC_SERVICE_NAME': '0', 04:39:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:39:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:39:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:39:14 INFO - Installing collected packages: mozsystemmonitor 04:39:14 INFO - Running setup.py install for mozsystemmonitor 04:39:14 INFO - Successfully installed mozsystemmonitor 04:39:14 INFO - Cleaning up... 04:39:14 INFO - Return code: 0 04:39:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:39:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1055adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe90ad62960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10538bd30>, '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 0x1052b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105380be8>, '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.yCLwXbMYMB/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.mXD4E7eWEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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 04:39:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:39:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:39:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yCLwXbMYMB/Render', 04:39:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:14 INFO - 'HOME': '/Users/cltbld', 04:39:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:14 INFO - 'LOGNAME': 'cltbld', 04:39:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:14 INFO - 'MOZ_NO_REMOTE': '1', 04:39:14 INFO - 'NO_EM_RESTART': '1', 04:39:14 INFO - 'PAGER': '/bin/cat', 04:39:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:14 INFO - 'PWD': '/builds/slave/test', 04:39:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:14 INFO - 'SHELL': '/bin/bash', 04:39:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mXD4E7eWEY/Listeners', 04:39:14 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 04:39:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:14 INFO - 'USER': 'cltbld', 04:39:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:14 INFO - 'XPC_FLAGS': '0x0', 04:39:14 INFO - 'XPC_SERVICE_NAME': '0', 04:39:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:15 INFO - Downloading/unpacking jsonschema==2.5.1 04:39: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 04:39: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 04:39: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 04:39: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 04:39: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 04:39: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 04:39:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:39:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:39:17 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 04:39:17 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 04:39:17 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 04:39:17 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 04:39:17 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 04:39:17 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 04:39:18 INFO - Downloading functools32-3.2.3-2.tar.gz 04:39:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:39:18 INFO - warning: no files found matching '*.txt' 04:39:18 INFO - no previously-included directories found matching 'build' 04:39:18 INFO - no previously-included directories found matching 'dist' 04:39:18 INFO - no previously-included directories found matching '.git*' 04:39:18 INFO - Installing collected packages: jsonschema, functools32 04:39:18 INFO - Running setup.py install for functools32 04:39:18 INFO - warning: no files found matching '*.txt' 04:39:18 INFO - no previously-included directories found matching 'build' 04:39:18 INFO - no previously-included directories found matching 'dist' 04:39:18 INFO - no previously-included directories found matching '.git*' 04:39:18 INFO - Successfully installed jsonschema functools32 04:39:18 INFO - Cleaning up... 04:39:18 INFO - Return code: 0 04:39:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:39: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')]} 04:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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')]} 04:39:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1055adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe90ad62960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10538bd30>, '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 0x1052b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105380be8>, '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.yCLwXbMYMB/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.mXD4E7eWEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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 04:39:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:39:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:39:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yCLwXbMYMB/Render', 04:39:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:18 INFO - 'HOME': '/Users/cltbld', 04:39:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:18 INFO - 'LOGNAME': 'cltbld', 04:39:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:18 INFO - 'MOZ_NO_REMOTE': '1', 04:39:18 INFO - 'NO_EM_RESTART': '1', 04:39:18 INFO - 'PAGER': '/bin/cat', 04:39:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:18 INFO - 'PWD': '/builds/slave/test', 04:39:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:18 INFO - 'SHELL': '/bin/bash', 04:39:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mXD4E7eWEY/Listeners', 04:39:18 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 04:39:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:18 INFO - 'USER': 'cltbld', 04:39:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:18 INFO - 'XPC_FLAGS': '0x0', 04:39:18 INFO - 'XPC_SERVICE_NAME': '0', 04:39:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:39:18 INFO - Cleaning up... 04:39:18 INFO - Return code: 0 04:39:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:39: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')]} 04:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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')]} 04:39:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1055adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe90ad62960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10538bd30>, '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 0x1052b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105380be8>, '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.yCLwXbMYMB/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.mXD4E7eWEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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 04:39:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:39:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:39:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yCLwXbMYMB/Render', 04:39:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:18 INFO - 'HOME': '/Users/cltbld', 04:39:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:18 INFO - 'LOGNAME': 'cltbld', 04:39:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:18 INFO - 'MOZ_NO_REMOTE': '1', 04:39:18 INFO - 'NO_EM_RESTART': '1', 04:39:18 INFO - 'PAGER': '/bin/cat', 04:39:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:18 INFO - 'PWD': '/builds/slave/test', 04:39:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:18 INFO - 'SHELL': '/bin/bash', 04:39:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mXD4E7eWEY/Listeners', 04:39:18 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 04:39:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:18 INFO - 'USER': 'cltbld', 04:39:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:18 INFO - 'XPC_FLAGS': '0x0', 04:39:18 INFO - 'XPC_SERVICE_NAME': '0', 04:39:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:18 INFO - Downloading/unpacking blobuploader==1.2.4 04:39:18 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 04:39:18 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 04:39:18 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 04:39:18 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 04:39:18 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 04:39:18 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 04:39:21 INFO - Downloading blobuploader-1.2.4.tar.gz 04:39:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:39:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:39:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:22 INFO - Downloading docopt-0.6.1.tar.gz 04:39:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:39:22 INFO - Installing collected packages: blobuploader, requests, docopt 04:39:22 INFO - Running setup.py install for blobuploader 04:39:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:39:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:39:23 INFO - Running setup.py install for requests 04:39:23 INFO - Running setup.py install for docopt 04:39:23 INFO - Successfully installed blobuploader requests docopt 04:39:23 INFO - Cleaning up... 04:39:23 INFO - Return code: 0 04:39:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:23 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 0x1055adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe90ad62960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10538bd30>, '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 0x1052b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105380be8>, '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.yCLwXbMYMB/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.mXD4E7eWEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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 04:39:23 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 04:39:23 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 04:39:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yCLwXbMYMB/Render', 04:39:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:23 INFO - 'HOME': '/Users/cltbld', 04:39:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:23 INFO - 'LOGNAME': 'cltbld', 04:39:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:23 INFO - 'MOZ_NO_REMOTE': '1', 04:39:23 INFO - 'NO_EM_RESTART': '1', 04:39:23 INFO - 'PAGER': '/bin/cat', 04:39:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:23 INFO - 'PWD': '/builds/slave/test', 04:39:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:23 INFO - 'SHELL': '/bin/bash', 04:39:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mXD4E7eWEY/Listeners', 04:39:23 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 04:39:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:23 INFO - 'USER': 'cltbld', 04:39:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:23 INFO - 'XPC_FLAGS': '0x0', 04:39:23 INFO - 'XPC_SERVICE_NAME': '0', 04:39:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:39:24 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-XmJAJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:39:24 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-TYmYno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:39:24 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-NpcPR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:39:24 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-tXZVRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:39:24 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-0KTB4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:39:24 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-U1d5GW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:39:24 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-kNQyRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:39:24 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-y2lzms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:39:24 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-pzGCC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:39:24 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-d0eMAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:39:25 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-Vdhz1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:39:25 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-Wep6HT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:39:25 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-0dRgWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:39:25 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-iOdXzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:25 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-wF4dA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:39:25 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-Chy7OO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:39:25 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-C2lSTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:39:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:39:25 INFO - Running setup.py install for manifestparser 04:39:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:39:25 INFO - Running setup.py install for mozcrash 04:39:26 INFO - Running setup.py install for mozdebug 04:39:26 INFO - Running setup.py install for mozdevice 04:39:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:39:26 INFO - Running setup.py install for mozfile 04:39:26 INFO - Running setup.py install for mozhttpd 04:39:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:39:26 INFO - Running setup.py install for mozinfo 04:39:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:39:26 INFO - Running setup.py install for mozInstall 04:39:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:39:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:39:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:39:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:39:26 INFO - Running setup.py install for mozleak 04:39:27 INFO - Running setup.py install for mozlog 04:39:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:39:27 INFO - Running setup.py install for moznetwork 04:39:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:39:27 INFO - Running setup.py install for mozprocess 04:39:27 INFO - Running setup.py install for mozprofile 04:39:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:39:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:39:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:39:27 INFO - Running setup.py install for mozrunner 04:39:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:39:27 INFO - Running setup.py install for mozscreenshot 04:39:28 INFO - Running setup.py install for moztest 04:39:28 INFO - Running setup.py install for mozversion 04:39:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:39:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:39:28 INFO - Cleaning up... 04:39:28 INFO - Return code: 0 04:39:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:28 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')]} 04:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:28 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')]} 04:39:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:28 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 0x1055adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe90ad62960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10538bd30>, '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 0x1052b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105380be8>, '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.yCLwXbMYMB/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.mXD4E7eWEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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 04:39:28 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 04:39:28 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 04:39:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yCLwXbMYMB/Render', 04:39:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:28 INFO - 'HOME': '/Users/cltbld', 04:39:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:28 INFO - 'LOGNAME': 'cltbld', 04:39:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:28 INFO - 'MOZ_NO_REMOTE': '1', 04:39:28 INFO - 'NO_EM_RESTART': '1', 04:39:28 INFO - 'PAGER': '/bin/cat', 04:39:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:28 INFO - 'PWD': '/builds/slave/test', 04:39:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:28 INFO - 'SHELL': '/bin/bash', 04:39:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mXD4E7eWEY/Listeners', 04:39:28 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 04:39:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:28 INFO - 'USER': 'cltbld', 04:39:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:28 INFO - 'XPC_FLAGS': '0x0', 04:39:28 INFO - 'XPC_SERVICE_NAME': '0', 04:39:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:39:28 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-rQOYDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:39:28 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)) 04:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:39:28 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-nxohSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:39:28 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)) 04:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:39:28 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-l_ujbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:39:28 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)) 04:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:39:28 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-2oOXq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:39:29 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)) 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:39:29 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-Hd01fd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:39:29 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)) 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:39:29 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-ZY0ei5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:39:29 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)) 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:39:29 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-_1O3BO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:39:29 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)) 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:39:29 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-V7oahA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:39:29 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)) 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:39:29 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-iiumwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:39:29 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)) 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:39:29 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-QFDChK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:39:29 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)) 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:39:29 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-4C8FYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:39:29 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)) 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:39:29 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-sbdepU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:39:29 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)) 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:39:29 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-BsAjn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:39:30 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)) 04:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:39:30 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-BtEg4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:39:30 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)) 04:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:30 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-PTKLAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:30 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)) 04:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:39:30 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-Rs1kx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:39:30 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)) 04:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:39:30 INFO - Running setup.py (path:/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/pip-iP5ElL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:39:30 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)) 04:39:30 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)) 04:39:30 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)) 04:39:30 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)) 04:39:30 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)) 04:39:30 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)) 04:39:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:39:30 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 04:39:30 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 04:39:30 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 04:39:30 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 04:39:30 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 04:39:30 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 04:39:33 INFO - Downloading blessings-1.6.tar.gz 04:39:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:39:33 INFO - Installing collected packages: blessings 04:39:33 INFO - Running setup.py install for blessings 04:39:33 INFO - Successfully installed blessings 04:39:33 INFO - Cleaning up... 04:39:33 INFO - Return code: 0 04:39:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:39:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:39:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:39:33 INFO - Reading from file tmpfile_stdout 04:39:33 INFO - Current package versions: 04:39:33 INFO - blessings == 1.6 04:39:33 INFO - blobuploader == 1.2.4 04:39:33 INFO - docopt == 0.6.1 04:39:33 INFO - functools32 == 3.2.3-2 04:39:33 INFO - jsonschema == 2.5.1 04:39:33 INFO - manifestparser == 1.1 04:39:33 INFO - mozInstall == 1.12 04:39:33 INFO - mozcrash == 1.0 04:39:33 INFO - mozdebug == 0.1 04:39:33 INFO - mozdevice == 0.50 04:39:33 INFO - mozfile == 1.2 04:39:33 INFO - mozhttpd == 0.7 04:39:33 INFO - mozinfo == 0.9 04:39:33 INFO - mozleak == 0.1 04:39:33 INFO - mozlog == 3.4 04:39:33 INFO - moznetwork == 0.27 04:39:33 INFO - mozprocess == 0.25 04:39:33 INFO - mozprofile == 0.28 04:39:33 INFO - mozrunner == 6.13 04:39:33 INFO - mozscreenshot == 0.1 04:39:33 INFO - mozsystemmonitor == 0.3 04:39:33 INFO - moztest == 0.8 04:39:33 INFO - mozversion == 1.4 04:39:33 INFO - psutil == 3.1.1 04:39:33 INFO - requests == 1.2.3 04:39:33 INFO - wsgiref == 0.1.2 04:39:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:39:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:33 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 0x1055adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe90ad62960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10538bd30>, '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 0x1052b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105380be8>, '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.yCLwXbMYMB/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.mXD4E7eWEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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 04:39:33 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 04:39:33 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 04:39:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yCLwXbMYMB/Render', 04:39:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:33 INFO - 'HOME': '/Users/cltbld', 04:39:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:33 INFO - 'LOGNAME': 'cltbld', 04:39:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:33 INFO - 'MOZ_NO_REMOTE': '1', 04:39:33 INFO - 'NO_EM_RESTART': '1', 04:39:33 INFO - 'PAGER': '/bin/cat', 04:39:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:33 INFO - 'PWD': '/builds/slave/test', 04:39:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:33 INFO - 'SHELL': '/bin/bash', 04:39:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mXD4E7eWEY/Listeners', 04:39:33 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 04:39:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:33 INFO - 'USER': 'cltbld', 04:39:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:33 INFO - 'XPC_FLAGS': '0x0', 04:39:33 INFO - 'XPC_SERVICE_NAME': '0', 04:39:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:33 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)) 04:39:33 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)) 04:39:33 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)) 04:39:33 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)) 04:39:33 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)) 04:39:33 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)) 04:39:33 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)) 04:39:33 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)) 04:39:33 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)) 04:39:33 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)) 04:39:33 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)) 04:39:33 INFO - Cleaning up... 04:39:34 INFO - Return code: 0 04:39:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:39:34 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')]} 04:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:34 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')]} 04:39:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:34 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 0x1055adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe90ad62960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10538bd30>, '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 0x1052b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105380be8>, '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.yCLwXbMYMB/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.mXD4E7eWEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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 04:39:34 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 04:39:34 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 04:39:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yCLwXbMYMB/Render', 04:39:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:34 INFO - 'HOME': '/Users/cltbld', 04:39:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:34 INFO - 'LOGNAME': 'cltbld', 04:39:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:34 INFO - 'MOZ_NO_REMOTE': '1', 04:39:34 INFO - 'NO_EM_RESTART': '1', 04:39:34 INFO - 'PAGER': '/bin/cat', 04:39:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:34 INFO - 'PWD': '/builds/slave/test', 04:39:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:34 INFO - 'SHELL': '/bin/bash', 04:39:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mXD4E7eWEY/Listeners', 04:39:34 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 04:39:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:34 INFO - 'USER': 'cltbld', 04:39:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:34 INFO - 'XPC_FLAGS': '0x0', 04:39:34 INFO - 'XPC_SERVICE_NAME': '0', 04:39:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:39:34 INFO - Cleaning up... 04:39:34 INFO - Return code: 0 04:39:34 INFO - Running post-action listener: _resource_record_post_action 04:39:34 INFO - Running post-action listener: _start_resource_monitoring 04:39:34 INFO - Starting resource monitoring. 04:39:34 INFO - [mozharness: 2017-05-01 11:39:34.305478Z] Finished create-virtualenv step (success) 04:39:34 INFO - [mozharness: 2017-05-01 11:39:34.306430Z] Running install step. 04:39:34 INFO - Running pre-action listener: _resource_record_pre_action 04:39:34 INFO - Running main action method: install 04:39:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:39:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:39:34 INFO - Reading from file tmpfile_stdout 04:39:34 INFO - Detecting whether we're running mozinstall >=1.0... 04:39:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:39:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:39:34 INFO - Reading from file tmpfile_stdout 04:39:34 INFO - Output received: 04:39:34 INFO - Usage: mozinstall [options] installer 04:39:34 INFO - Options: 04:39:34 INFO - -h, --help show this help message and exit 04:39:34 INFO - -d DEST, --destination=DEST 04:39:34 INFO - Directory to install application into. [default: 04:39:34 INFO - "/builds/slave/test"] 04:39:34 INFO - --app=APP Application being installed. [default: firefox] 04:39:34 INFO - mkdir: /builds/slave/test/build/application 04:39:34 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'] 04:39:34 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 04:39:54 INFO - Reading from file tmpfile_stdout 04:39:54 INFO - Output received: 04:39:54 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:39:54 INFO - Running post-action listener: _resource_record_post_action 04:39:54 INFO - [mozharness: 2017-05-01 11:39:54.612775Z] Finished install step (success) 04:39:54 INFO - [mozharness: 2017-05-01 11:39:54.612911Z] Running run-tests step. 04:39:54 INFO - Running pre-action listener: _resource_record_pre_action 04:39:54 INFO - Running main action method: run_tests 04:39:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:39:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:39:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:39:54 INFO - 2017-05-01 04:39:54.625 screenresolution[1646:8801] starting screenresolution argv=screenresolution get 04:39:54 INFO - 2017-05-01 04:39:54.628 screenresolution[1646:8801] Display 0: 1600x1200x32@60 04:39:54 INFO - 2017-05-01 04:39:54.633 screenresolution[1647:8803] starting screenresolution argv=screenresolution list 04:39:54 INFO - Available Modes on Display 0 04:39:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:39:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:39:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:39:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:39:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:39:54 INFO - Intel Iris: 04:39:54 INFO - Chipset Model: Intel Iris 04:39:54 INFO - Type: GPU 04:39:54 INFO - Bus: Built-In 04:39:54 INFO - VRAM (Dynamic, Max): 1536 MB 04:39:54 INFO - Vendor: Intel (0x8086) 04:39:54 INFO - Device ID: 0x0a2e 04:39:54 INFO - Revision ID: 0x0009 04:39:54 INFO - Displays: 04:39:54 INFO - Display: 04:39:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:39:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:39:54 INFO - Display Serial Number: 1600x1200 60 04:39:54 INFO - Main Display: Yes 04:39:54 INFO - Mirror: Off 04:39:54 INFO - Online: Yes 04:39:54 INFO - Rotation: Supported 04:39:54 INFO - Return code: 0 04:39:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:39:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:39:54 INFO - Python 2.7.3 04:39:54 INFO - Return code: 0 04:39:54 INFO - grabbing minidump binary from tooltool 04:39:54 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')]} 04:39:54 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 0x10538bd30>, '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 0x1052b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105380be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:39:54 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 04:39:54 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 04:39:54 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 04:39:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:39:54 INFO - Return code: 0 04:39:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:39:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:39:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:39:54 INFO - ENV: RUST_BACKTRACE is now 1 04:39:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:39:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:39:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0363', '--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 04:39:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0363 --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 04:39:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yCLwXbMYMB/Render', 04:39:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:54 INFO - 'HOME': '/Users/cltbld', 04:39:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:54 INFO - 'LOGNAME': 'cltbld', 04:39:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:39:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:54 INFO - 'MOZ_NO_REMOTE': '1', 04:39:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:39:54 INFO - 'NO_EM_RESTART': '1', 04:39:54 INFO - 'PAGER': '/bin/cat', 04:39:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:54 INFO - 'PWD': '/builds/slave/test', 04:39:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:39:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:54 INFO - 'RUST_BACKTRACE': '1', 04:39:54 INFO - 'SHELL': '/bin/bash', 04:39:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mXD4E7eWEY/Listeners', 04:39:54 INFO - 'TMPDIR': '/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/', 04:39:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:54 INFO - 'USER': 'cltbld', 04:39:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:54 INFO - 'XPC_FLAGS': '0x0', 04:39:54 INFO - 'XPC_SERVICE_NAME': '0', 04:39:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0363', '--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 04:39:55 INFO - mozversion application_buildid: 20170501030204 04:39:55 INFO - mozversion application_changeset: 076a7a66096f9e8d102548397254be32eb26bc3d 04:39:55 INFO - mozversion application_display_name: Nightly 04:39:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:39:55 INFO - mozversion application_name: Firefox 04:39:55 INFO - mozversion application_remotingname: firefox 04:39:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:39:55 INFO - mozversion application_vendor: Mozilla 04:39:55 INFO - mozversion application_version: 55.0a1 04:39:55 INFO - mozversion platform_buildid: 20170501030204 04:39:55 INFO - mozversion platform_changeset: 076a7a66096f9e8d102548397254be32eb26bc3d 04:39:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:39:55 INFO - mozversion platform_version: 55.0a1 04:39:55 INFO - using testdate: 1493638795 04:39:55 INFO - actual date: 1493638795 04:39:55 INFO - starting webserver on 'localhost:49235' 04:39:55 INFO - SUITE-START | Running 2 tests 04:39:55 INFO - TEST-START | dromaeo_css 04:39:55 INFO - operating with platform_type : mac_ 04:39:55 INFO - Initialising browser for dromaeo_css test... 04:39:55 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/tmpBxYs0Q/profile http://localhost:49235/getInfo.html) 04:39:57 INFO - PID 1657 | __metrics Screen width/height:1600/1200 04:39:57 INFO - PID 1657 | colorDepth:24 04:39:57 INFO - PID 1657 | Browser inner width/height: 1024/689 04:39:57 INFO - PID 1657 | __metrics 04:39:57 INFO - PID 1657 | 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" 04:39:57 INFO - PID 1657 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:39:58 INFO - TEST-INFO | 1657: exit 0 04:39:58 INFO - Browser initialized. 04:39:58 INFO - Running cycle 1/1 for dromaeo_css test... 04:39:58 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/tmpBxYs0Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:40:10 INFO - PID 1660 | RSS: Main: 240971776 04:40:10 INFO - PID 1660 | 04:43:15 INFO - PID 1660 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 04:43:17 INFO - PID 1660 | RSS: Main: 407363584 04:43:17 INFO - PID 1660 | 04:45:00 INFO - PID 1660 | ************************* 04:45:00 INFO - PID 1660 | A coding exception was thrown and uncaught in a Task. 04:45:00 INFO - PID 1660 | 04:45:00 ERROR - PID 1660 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:45:00 INFO - PID 1660 | Full stack: 04:45:00 INFO - PID 1660 | ************************* 04:45:00 INFO - PID 1660 | ************************* 04:45:00 INFO - PID 1660 | A coding exception was thrown and uncaught in a Task. 04:45:00 INFO - PID 1660 | 04:45:00 ERROR - PID 1660 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:45:00 INFO - PID 1660 | Full stack: 04:45:00 INFO - PID 1660 | ************************* 04:45:00 INFO - PID 1660 | ************************* 04:45:00 INFO - PID 1660 | A coding exception was thrown and uncaught in a Task. 04:45:00 INFO - PID 1660 | 04:45:00 ERROR - PID 1660 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:45:00 INFO - PID 1660 | Full stack: 04:45:00 INFO - PID 1660 | ************************* 04:45:00 INFO - PID 1660 | ************************* 04:45:00 INFO - PID 1660 | A coding exception was thrown and uncaught in a Task. 04:45:00 INFO - PID 1660 | 04:45:00 ERROR - PID 1660 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:45:00 INFO - PID 1660 | Full stack: 04:45:00 INFO - PID 1660 | ************************* 04:46:19 INFO - PID 1660 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 04:46:20 INFO - PID 1660 | RSS: Main: 366145536 04:46:20 INFO - PID 1660 | 04:49:22 INFO - PID 1660 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 04:49:23 INFO - PID 1660 | RSS: Main: 357486592 04:49:23 INFO - PID 1660 | 04:52:25 INFO - PID 1660 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 04:52:26 INFO - PID 1660 | RSS: Main: 322617344 04:52:26 INFO - PID 1660 | 04:55:29 INFO - PID 1660 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 04:55:30 INFO - PID 1660 | RSS: Main: 337879040 04:55:30 INFO - PID 1660 | 04:58:32 INFO - PID 1660 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 04:58:33 INFO - PID 1660 | RSS: Main: 376094720 04:58:33 INFO - PID 1660 | 04:58:33 INFO - PID 1660 | __start_tp_report 04:58:33 INFO - PID 1660 | _x_x_mozilla_page_load 04:58:33 INFO - PID 1660 | _x_x_mozilla_page_load_details 04:58:33 INFO - PID 1660 | |i|pagename|runs| 04:58:33 INFO - PID 1660 | |0;dojo.html;3466.4280393735035;3481.355949149407;3483.51230827684;3497.2131270464165;3522.696602257165;5963.493103086243;6091.025435930252;6150.600210986288;6178.505719542437;6201.782937597185;6102.277183976812;6121.296050954142;6159.5380346474085;6195.163652906856;6207.068939659053;5100.795968161287;5148.819791307305;5229.895402091975;5260.8158714445;5316.096263635172;5366.087765079927;5366.91949620756;5371.167469042285;5386.272853164812;5422.2951016367815;5196.870078248036;5266.447023062561;5286.894262114774;5297.708626025567;5308.362996440414;5311.044012077825;5334.759935802898;5352.57179425645;5357.8392648220615;5372.946270537323;5273.182656688219;5304.389995150568;5322.627416080876;5329.2006199070065;5340.439253878365;5512.834614961557;5930.169776231331;6135.5091592672925;6161.19904412428;6161.6303021818385;6404.519661025442;6408.647524386157;6417.101605775195;6431.356864313578;6449.613023218575;6407.743690252384;6495.512836537231;6496.252930912911;6503.7073331700185;6516.446102081329;6201.56589038772;6207.441330280297;6255.093011513351;6263.6868156592445;6275.497960163176;6647.401733843881;6653.933460665428;6655.0682904393425;6657.966710166515;6661.16735408074;6341.936580634227;6379.425851673372;6418.518611104186;6420.582662126947;6425.5502114851515;6441.967790161113;6459.063435801782;6479.902801457982;6498.025296205513;6500.317466666026;6405.327440618668;6412.903806442907;6413.422791948747;6416.935830641727;6438;6360.173177486897;6412.2625898022325;6430.3891130342545;6435.22777266731;6471.935280647227;5127.333446651986;5142.97428512855;5151.793928242828;5162.586993040548;5177.741112944338;3861.6331448512346;4600.4479462464715;4621.907561848744;4655.278431843002;4685.882852928704;5899.351071382144;6136;6157.907631385533;6158.737458820931;6181.938180618226;6371.458426033839;6393.680315984182;6443.130177426081;6520.282768895418;6537.934620653733;6107.006761825774;6117.583823141483;6176.104464852661;6193.411625895533;6213.161223234896;5667.744951477193;5668.773249070074;5676.318841739017;5681.545476361881;5716.771329146787;6459.386358296142;6514.9348506514325;6633.270340262471;6665.66671666405;6696.866062678621;6493.772717954849;6505.577137486048;6520.836979075561;6526.738930442729;6560.671966401565;6632.668366581555;6741.561798483083;6753.15585551806;6753.864922701617;6754.425873800782;6357.968210159104;6439.066335381437;6439.098526206241;6449.935500644933;6450.258220304725;5832.445917637818;6016.157737916607;6426.164598602339;6446.452051575481;6497.805065848032;6262.812115636538;6339.492840572835;6357.268914074941;6393;6420.775272865428;6295.559310848196;6336.461400780985;6353.332900045613;6399.968000159969;6425.935740642721;6397.168368112116;6397.712102955471;6408.166938297992;6411.487081033413;6412.97392417211;6245.469135123565;6308.306086330408;6312.4634406076;6318.210223722035;6418.967905160444;6289.811305660837;6330.936690633035;6341.556091073765;6352.047192920914;6363.268224154096 04:58:33 INFO - PID 1660 | |1;ext.html;752.319151168193;788.8501184774892;805.4281460163284;1120.837478565608;1132.660201939418;26333.47333053338;36018.81990590047;36171.276574468495;36196.45705314419;36250;38238.617613823924;38440.03899902504;38477.61522384775;38478;38553.614463855425;6034.487068599175;8327.375446841495;8494.193051660082;8505.106963768809;8516.829663406728;6088.726007329658;8283.62723677433;8443.15568443157;8444.408891377607;8453.281471074966;8508.74473765788;8533.701320453785;8555.828883422328;8567.31461483083;8587.914120858773;6024.126501657279;8441.366897482683;8501.787455313666;8504.44721093127;8520.573971301472;6031.758729650809;8199.22107399796;8330.416870819045;8343.45767525109;8360.707375241898;35984.74053408118;36409.45385819215;36412;36444.63555364439;36486.63513364885;3476.026712520498;3498.440249560058;3505.0185947934365;3509.4209455439823;3514.6836784689244;29637.407251854842;29654.70345296541;29692.70307296921;29693.812247510075;29734.85132574345;2664.880750084969;3002.8348440835744;3086.8302243376606;3098.395812816502;3099.767517436201;233068;282355;285924.57037714886;287111.5644421785;287395;46838.76580617075;46876.296855547196;46931.29603055957;46951.76524117426;47025.76487117542;49304.75347623239;49373.50626493761;49374.012519749405;49527;49559;13817.585472435843;13887.236202008784;13914.51299204523;13927.373268202955;13942.093763905314;9741.9025809741;9786.706398808046;11306.830397544043;11330.09359251258;11347.716307092223;10204.744881378025;10341.689749307532;11247.381394023407;11749.177557571058;11918.344491053076;5321.813736519203;5338.9466105339225;5366.704831234241;5370.684182375265;5417.079096553595;897.3808072430003;995.2784231432298;1025.8717660292464;1056.6354607660344;1060.41677077607;23381.064757409855;28693.28266793305;29360.559591606143;29691.663875125672;29969.700302997127;943.5753910740194;1053.2469284461647;1075.542894269932;1113.0705860606483;1114.2590177532013;10520.947395262974;11531.520723044585;12087;12096.879031209752;12126.333051682243;242885;243053;243636.7818160898;243750;243804.78097609399;48179.75910120427;48252.5174748255;48292.7585362071;48348.75825620849;48432;1324.1326930860303;1443.5492330208074;1457.2640816387657;1490.3889405343973;1492.9626759330886;22229.110835566396;22697;22851.54296914019;22922.19772307961;22951.426214344774;35311.58753649825;35353.82323088368;35423.29153416866;35437.29125417529;35495.822520888265;175026;224853;225822.8708856511;226632;226754;27372.04197853145;31424.05727828169;31475.527867081553;31536.684633153374;31557.684423155475;34649.48025779565;39049.02377440587;41366.79316603518;41441.34234630581;41485.96285092897;27599.448011039265;28151.71848281491;29192.854035729684;29488.705112949454;30060.947866824557;28434.289142771595;28769.42461150807;29308.560371594016;29461;29683.554746678386;34717.13207169841;34782.47826282658;34803;34830.9550713479;34899.302013960085;27425.725742742317;27624.309392265353;29825;30441;31346.843265783526;23742.881285593463;23918.760812391654;23986.28041158768;24277.63583546213;24379.51240975206 04:58:33 INFO - PID 1660 | |2;jquery.html;425.6871199668245;428.2779176433139;430.7480124127386;434.2032370599949;446.69624655234446;18955.71566426501;20739.481512962182;21249;21450.678239826397;21489.785102148973;21159.471013224676;22129.66805497919;22453;22722;22820.771792282074;6106.267247930244;6275.2469703635625;6282.937170628281;6295.024271237942;6310.716017779211;5894.440028197336;6126;6187.938120618781;6188.969055154718;6191.628502289855;5887.646741195542;6121.143039974385;6126.468382904274;6147.077938309267;6154.138420621117;6081.148639190517;6204.7828326008375;6207.441330280274;6225.87548249037;6238.344973777734;5267.894642107175;5410.161424979135;5481.095619222823;5490;5512.283403157604;26688.332791680168;26702;26913.730862691318;27042.86478567614;27623.171304860887;2148.1085349579907;2248.4940888300166;2251.7410497792634;2252.200468833557;2252.2117258959397;17431.912840435845;17521.386751463764;17736.379226727004;18084.728729069073;18334.358297459657;2127.053461209762;2143.753468351144;2187.475005998549;2189;2190.5509370579152;128954;147908;158554;159951;162962.1851890745;10235.692929211986;10469.31949423285;11269.943650281695;12183.512659493521;12216.816747748613;14740.262986850828;15825.920870395805;16232.026078435332;16234.51296461108;16244.75632865508;7999.3200577950365;8050.4364694472;8759.474431534129;8797.12028797115;8893.955530222307;8246.800767420298;8267.462614930131;8285.461445006054;8433.283170930417;8540.188682075193;7596.24037596247;7753.689852405841;7794.883076753853;7799.688012479437;7803.531788092732;1771.4685594321652;1991.2632326039459;2097.4336929029078;2113.6512475441687;2231.129859354853;783.4633276205817;867.085225087526;906;959.4770849886828;965.8358079126565;16693.582660433585;20882.060307286207;21013.94930253512;21482.37375731624;25133.62299565508;969.4425705219527;977.9608815647294;981.1807141037172;1003.3428104591504;1010.4190090697878;11032.944835275772;11276.548938042386;11284.830727539094;11297.26567773092;11306.265092768943;521515;547134;552367;558050;564832;89910;132982;139287;140663;141697;991.8512223166583;1024.4775164666073;1030.108955753268;1045.6340280901775;1047.1413440978324;21038;22131.66802497996;22404;22548.101924076702;22623.20818771335;45692;54420;55146.72426637841;55341.723291383285;56220.43779562152;72065.27934720585;73101.26898731157;74206.62896685483;74828.87756683545;75953;8695.347848911231;8829.16122968317;9001.279897608045;9014.86477702848;9317.487538185194;14173.078749881224;14212.928935355258;14370.856291436952;14519.782203266748;14526.564203073925;11500.884991149982;11672.649820505398;11753.941230293794;12127.45426455794;12199.085068620067;11110.277906924439;11183.657961044726;11197.888021119685;11608.535658573563;11938.820917686415;11885.46515406826;11924.0460763137;12096.697582560506;12213.877861221274;12243.877561224273;8457.40798144124;8790.692325768567;9004.729858104267;9114.316426267924;9150.588223529823;10039.598416063276;11973.682894881382;12068;12212.450439730055;12253.75492490163 04:58:33 INFO - PID 1660 | |3;mootools.html;1159;1228.1832581333413;1402.9929850350748;1421.0620990146506;1433.1329545624899;8569.700060497884;9922.950385248072;11237.83143252852;11410.7147321317;11596.420178991058;11252.09983201344;11320;11336.319820810737;11336.48985795639;11346.20576559641;2444.7433019532914;2497.3756560859783;2497.7636070145304;2498.2755001049673;2501.4246723253664;1949.220311875247;2040.5714799892041;2084.593504266669;2167.8157356624706;2172.706684597583;2113.8625989310644;2328.7438381778074;2490.2280293109193;2495.6007038873786;2502.4744803591175;2430.052279610953;2456.6929133858266;2457.0908763757348;2461.2001099642507;2468.6173643085262;2430.8541487510806;2432.4891772727747;2435.9634605480933;2437.536867995075;2444.10790061628;11089.944550277198;11330.150238732129;11350.262232954832;11356.48895799691;11359.943200283946;6348.206474190726;6594.86810263792;6607.867842643121;6613.702383392759;6640.667966601699;3895.104126050996;4097.733647312945;4242.0879510905;4282.100758840647;4286.39990401344;1172.150191111446;1191.7139886427283;1250.8749125087509;1296.3129541343103;1296.6823128333524;16194.838051619568;16202.75695864563;16218.75671864923;16238.269277882524;16287.755683664755;5677.318721753416;5846.210761547221;5943.613665111754;5992.610480318853;6056.515478761688;13309.201447913156;13349;13368.799468007988;13375.264360460074;13414.530491432753;6582.736690532325;6664.100346453264;6668.133142691419;6677.699503522256;6695.832604184837;6018.518518518508;6158.291796443376;6211.875762484816;6213.596116252429;6223.875522489525;4114.403411505315;4426.623736982328;4543.954560454419;4561.908761824745;4601.217792975202;1316.585275638171;1319.6671361924525;1334.252818421687;1380.861913808611;1439.9640008999859;657.8026592022375;704.5490885833071;723.8335182907961;778.5056489129444;794.7417089445953;5911.586188966731;5997.6401415914315;6165.260168779775;6274.623522588659;7060.71757129709;769.4267770511005;882.3250213586612;899.1278459893892;925.0887875442684;945.3854994253653;4054.682228275822;4120.134771697977;4144.772037537904;4248.63886569645;4259.765712885821;14293.85706142946;14884.776728349083;14927.029743066665;14944.476943306932;15016.549503514912;14142.717145657029;14738.926305368404;14766.778498322534;14817.40730370773;14841.628959276104;8311.6675332986;8522.78693032679;8526.57367131641;8535.701250456204;8559.614817333235;6382.106505089198;6754.425873800586;6795.932040679728;6932.168139823253;6940.826479338057;12812.807807882702;13396.26320552379;13475.304939012432;13592.048556600943;13602.523911663044;12975.221486710827;13235.007374446763;13783.035187536776;13794.931025345211;13813.171209727449;8788.98926623421;8881.511516866634;8887.866681999905;8987.325950553604;9000.414973026733;10268.537915793659;10381.792364152523;10433.843492347773;10450.738731531772;10453.26827122094;7114.359707626339;8812.559372031501;8945.910540894769;8964.32767542424;9016;8544.871826922725;8606.053334133116;8637.740867773977;8657.177568131017;8724;7680.692772289046;7846.686132554634;7952.721654742057;7959.681612735426;7974.202579741979;5855.03391940325;5856.180134781049;5941.494972927349;6066.423689749643;6087.726052327567;5469.75386107634;5982.0727787193055;6055.576109672281;6084.6349219047;6170.074488826712 04:58:33 INFO - PID 1660 | |4;prototype.html;390.94722212501307;393.29207426632075;397.9661728753056;404.88865561970454;406.5588836112818;4504.436945381827;5287.889543195929;5706.059939620528;5789.884202315961;5812.651240925547;4619.914320134766;4905.533974272438;5186.636935414523;5741.320823528821;5760.423957604237;3927.057506198506;3936.921261574767;4400.559944005589;4456.643468522527;4456.6657500687415;4451.888702782424;4462.910741785162;4464.933026004613;4474.619657329131;4481.46222453306;3712.162479572602;3918.490596222487;4416.757078360689;4421.850318917089;4444.244478438657;3848.960780589239;4405.647548196137;4415.072834704716;4442.64458843295;4449.288113901776;3934.291827471083;3942.8457234212515;3949.6445319921345;3963.801809909522;3971.5035620547433;5185.325907631984;5250.238715386247;5597.076482380402;5616.83751755577;5638.464345887134;4385.890352741175;4399.64802815774;5321.733913304358;5349.625526213166;5361.195820626937;6182.505399568024;6183.2889217740085;6197.907031394533;6199.380061993809;6228.626282423023;3973.284808734427;4455.195645763471;4516.23224051912;4557.58981691646;4562.954370456286;5223.503767142115;6193.566450348478;6399.9040014399825;6428.878470104854;6446.355364463563;4517.728936263835;4586.1057093866375;4591.17358875399;4606.332081848181;4609.585137337655;3920.745151565196;4455.888602784957;4676.041411510632;4696.459907110658;4712.434507859079;4616.630669546428;4989.451160372356;5193.402758682724;5273.288106105627;5311.123664595299;6166.568340216142;6200.472959798468;6201.658908759971;6205.317415084337;6251.156093927352;1234.2779474007627;1342.7784415571516;1450.3835869755312;1575.8818088643397;1629.3482606957075;919.5218486387041;923.5797712041006;940.3464592108555;943.1087622196958;952.2857856607544;4470.955290447054;4854.902901941941;5731.312242530839;5753.942460575425;5788.18965344852;6321.905171422432;6324.9051264231075;6330.177076980055;6343.841403964938;6350.33321501245;5660.981072632816;5731.942680573225;5757.222774925332;5778.711064446761;5806.5645076618575;2759.4481103779326;3309.1396236978558;3313.2379552703014;3323.335332933423;3339.6326404096017;5455.890882182413;6294.590851594632;6413;6563.9343606563325;6579.736810527621;5129.9743501282255;6182.752689892444;6454.548181627241;6463;6519.5436319457185;5679.716014199356;6503.772367967098;6518.282988871126;6539.836504087436;6541.33196035008;6028.15605815195;6381.298057213796;6409.903851442139;6426.935730642634;6446.9032964506505;5672.234248376416;5925.096702615773;6288.213973253343;6336.461400780985;6342.651154186564;5415.889742602836;5891.646501209942;5942.61373010753;6286.4342209201395;6375.904361434675;4317.438732964694;4678.60231880294;4701.247800351927;4709;4710.552497512731;6209.59637623553;6379.075034120119;6401.807945761635;6408;6424.357564243725;6124.54065945047;6127;6134.386561344008;6146.723397447215;6176.845578860564;5375;5819.388964158702;6120.2873787182725;6125.724342404514;6173.32093469727;5127.974360128175;5300.840974770763;5798.478136967525;6094.634321940698;6098.26820781509;5269.604779641466;6084.326810127251;6218.409251121137;6227.844303892439;6238.313785483684;5695.401982791747;5995.520358371407;6066.757329706938;6074.439605226433;6080.331163571915 04:58:33 INFO - PID 1660 | |5;yui.html;698.113395987096;836.506461187899;836.7949852286191;847.593155285463;864.995675021625;12430.378481075944;17189;17642.38251661192;17931.73102403465;18550.72173917392;16983.57541061474;17288.82711172888;17309.653806923852;17486.82513174868;17534.386296479624;791.8337149198661;902.4269588811119;991.3803872579638;1001.6093723447825;1002.3334482569119;671.5869740109822;1004.3823048824956;1008.3093081239338;1010.171659239424;1015.5836107196051;731.2139450091147;932.6689025395955;1040.5057597641135;1056.8414737789317;1057.0750593230923;1043.7234132954698;1044.2742294105599;1044.4621020174616;1045.7542477517738;1047.7904419116207;777.8522080804629;778.9756470241671;782.3271986092013;783.220695408067;785.7917651822214;16144.515664530083;16522.42171524003;16633.002019878724;16700.916495417445;16943.830561694347;16323.673526529521;16388.836111638968;16523.83476165235;16858.409955651492;16876.240569174417;13630.522931697442;13742.862571374259;13850.030497865153;13949.232792196424;13954.511592094228;3379.69881595585;3402.897913062612;3408.471686888536;3409.1817963688786;3409.6760807723226;96377.9999999993;113508;113837;113891;114180.42909785481;11032.172587055842;13407.329633518286;13747.793783093262;13771.931140344233;13772.862271377158;16879.578010549834;19482.902585487267;19789.406317810488;25362.365940851625;25467;7720.884186737204;7742.645037118482;7786.1824508426935;7929.960350198212;7934.484258523177;3897.2400381925254;3955.6044395560216;3963.722539422213;3966.0679740261016;3968.166684996183;4232.851850185229;4326.6754993375625;4354.869353919387;4395.055063161436;4400.559944005638;917.7430319510547;939.9237872635794;940.9341346105707;943.4197968249478;945.1352012908112;573.4695406748741;582.3099626942087;586.6978506069378;598.3567664760313;621.8289970258215;10041.347312424668;10799.78400431987;10824.567017319376;11116.96889516669;11575.373246117673;562.9662220266797;574.5719439017959;580.8199458167896;594;607.9908801367983;4718.716876987323;5092.185250359925;5103.974480127576;5155.097857874857;5162;93510.53244733733;99169;103441;105344;106028.46985765175;90220.5488972551;90459.54770226107;91389;92970.53514732383;93348;78068.60965695248;81642;82678.75981860278;82784.17215827765;84874.5756271227;9467.621295148117;10097.242706796873;10730;10891.455427228766;11907.52369905194;38261.23477530378;38458;38679.22641547097;39605.00987475336;39868.60131398765;69759;69970.65014674894;71777.6411117962;71817;73345.26654733598;13045.934770326088;13399.866001339862;13434.596962091153;13441.865581344062;13562.525311614047;17354.652906942043;17636.941783493032;17873;18043;18052.638947221243;14570.781438278222;15909.045457272137;16250.155476504297;16471.25879335409;16606.584835379213;16260.024398536125;16494.17529123515;16632.50102496927;16726;16760.74858877142;14310.356033978704;15236.781057515595;15620.375184992474;16157;16288.67422651564;10543.683689489328;11523.769524609628;11551.76896462083;12303.261804291771;12311.384430778604;12166.48667928245;12683.492660293854;12701.42843572023;12749;12817.295048772034 04:58:33 INFO - PID 1660 | __end_tp_report 04:58:33 INFO - PID 1660 | __start_cc_report 04:58:33 INFO - PID 1660 | _x_x_mozilla_cycle_collect,1729 04:58:33 INFO - PID 1660 | __end_cc_report 04:58:33 INFO - PID 1660 | __startTimestamp1493639913152__endTimestamp 04:58:33 INFO - PID 1660 | 04:58:33 INFO - PID 1660 | ------- Summary: start ------- 04:58:33 INFO - PID 1660 | Number of tests: 6 04:58:33 INFO - PID 1660 | 04:58:33 INFO - PID 1660 | [#0] dojo.html Cycles:165 Average:6003.56 Median:6312.46 stddev:700.41 (11.1%) stddev-sans-first:673.69 04:58:33 INFO - PID 1660 | Values: 3466.4 3481.4 3483.5 3497.2 3522.7 5963.5 6091.0 6150.6 6178.5 6201.8 6102.3 6121.3 6159.5 6195.2 6207.1 5100.8 5148.8 5229.9 5260.8 5316.1 5366.1 5366.9 5371.2 5386.3 5422.3 5196.9 5266.4 5286.9 5297.7 5308.4 5311.0 5334.8 5352.6 5357.8 5372.9 5273.2 5304.4 5322.6 5329.2 5340.4 5512.8 5930.2 6135.5 6161.2 6161.6 6404.5 6408.6 6417.1 6431.4 6449.6 6407.7 6495.5 6496.3 6503.7 6516.4 6201.6 6207.4 6255.1 6263.7 6275.5 6647.4 6653.9 6655.1 6658.0 6661.2 6341.9 6379.4 6418.5 6420.6 6425.6 6442.0 6459.1 6479.9 6498.0 6500.3 6405.3 6412.9 6413.4 6416.9 6438.0 6360.2 6412.3 6430.4 6435.2 6471.9 5127.3 5143.0 5151.8 5162.6 5177.7 3861.6 4600.4 4621.9 4655.3 4685.9 5899.4 6136.0 6157.9 6158.7 6181.9 6371.5 6393.7 6443.1 6520.3 6537.9 6107.0 6117.6 6176.1 6193.4 6213.2 5667.7 5668.8 5676.3 5681.5 5716.8 6459.4 6514.9 6633.3 6665.7 6696.9 6493.8 6505.6 6520.8 6526.7 6560.7 6632.7 6741.6 6753.2 6753.9 6754.4 6358.0 6439.1 6439.1 6449.9 6450.3 5832.4 6016.2 6426.2 6446.5 6497.8 6262.8 6339.5 6357.3 6393.0 6420.8 6295.6 6336.5 6353.3 6400.0 6425.9 6397.2 6397.7 6408.2 6411.5 6413.0 6245.5 6308.3 6312.5 6318.2 6419.0 6289.8 6330.9 6341.6 6352.0 6363.3 04:58:33 INFO - PID 1660 | 04:58:33 INFO - PID 1660 | [#1] ext.html Cycles:180 Average:39570.95 Median:31506.11 stddev:64355.14 (204.3%) stddev-sans-first:64469.67 04:58:33 INFO - PID 1660 | Values: 752.3 788.9 805.4 1120.8 1132.7 26333.5 36018.8 36171.3 36196.5 36250.0 38238.6 38440.0 38477.6 38478.0 38553.6 6034.5 8327.4 8494.2 8505.1 8516.8 6088.7 8283.6 8443.2 8444.4 8453.3 8508.7 8533.7 8555.8 8567.3 8587.9 6024.1 8441.4 8501.8 8504.4 8520.6 6031.8 8199.2 8330.4 8343.5 8360.7 35984.7 36409.5 36412.0 36444.6 36486.6 3476.0 3498.4 3505.0 3509.4 3514.7 29637.4 29654.7 29692.7 29693.8 29734.9 2664.9 3002.8 3086.8 3098.4 3099.8 233068.0 282355.0 285924.6 287111.6 287395.0 46838.8 46876.3 46931.3 46951.8 47025.8 49304.8 49373.5 49374.0 49527.0 49559.0 13817.6 13887.2 13914.5 13927.4 13942.1 9741.9 9786.7 11306.8 11330.1 11347.7 10204.7 10341.7 11247.4 11749.2 11918.3 5321.8 5338.9 5366.7 5370.7 5417.1 897.4 995.3 1025.9 1056.6 1060.4 23381.1 28693.3 29360.6 29691.7 29969.7 943.6 1053.2 1075.5 1113.1 1114.3 10520.9 11531.5 12087.0 12096.9 12126.3 242885.0 243053.0 243636.8 243750.0 243804.8 48179.8 48252.5 48292.8 48348.8 48432.0 1324.1 1443.5 1457.3 1490.4 1493.0 22229.1 22697.0 22851.5 22922.2 22951.4 35311.6 35353.8 35423.3 35437.3 35495.8 175026.0 224853.0 225822.9 226632.0 226754.0 27372.0 31424.1 31475.5 31536.7 31557.7 34649.5 39049.0 41366.8 41441.3 41486.0 27599.4 28151.7 29192.9 29488.7 30060.9 28434.3 28769.4 29308.6 29461.0 29683.6 34717.1 34782.5 34803.0 34831.0 34899.3 27425.7 27624.3 29825.0 30441.0 31346.8 23742.9 23918.8 23986.3 24277.6 24379.5 04:58:33 INFO - PID 1660 | 04:58:33 INFO - PID 1660 | [#2] jquery.html Cycles:180 Average:35275.20 Median:22585.66 stddev:93030.16 (411.9%) stddev-sans-first:93254.33 04:58:33 INFO - PID 1660 | Values: 425.7 428.3 430.7 434.2 446.7 18955.7 20739.5 21249.0 21450.7 21489.8 21159.5 22129.7 22453.0 22722.0 22820.8 6106.3 6275.2 6282.9 6295.0 6310.7 5894.4 6126.0 6187.9 6189.0 6191.6 5887.6 6121.1 6126.5 6147.1 6154.1 6081.1 6204.8 6207.4 6225.9 6238.3 5267.9 5410.2 5481.1 5490.0 5512.3 26688.3 26702.0 26913.7 27042.9 27623.2 2148.1 2248.5 2251.7 2252.2 2252.2 17431.9 17521.4 17736.4 18084.7 18334.4 2127.1 2143.8 2187.5 2189.0 2190.6 128954.0 147908.0 158554.0 159951.0 162962.2 10235.7 10469.3 11269.9 12183.5 12216.8 14740.3 15825.9 16232.0 16234.5 16244.8 7999.3 8050.4 8759.5 8797.1 8894.0 8246.8 8267.5 8285.5 8433.3 8540.2 7596.2 7753.7 7794.9 7799.7 7803.5 1771.5 1991.3 2097.4 2113.7 2231.1 783.5 867.1 906.0 959.5 965.8 16693.6 20882.1 21013.9 21482.4 25133.6 969.4 978.0 981.2 1003.3 1010.4 11032.9 11276.5 11284.8 11297.3 11306.3 521515.0 547134.0 552367.0 558050.0 564832.0 89910.0 132982.0 139287.0 140663.0 141697.0 991.9 1024.5 1030.1 1045.6 1047.1 21038.0 22131.7 22404.0 22548.1 22623.2 45692.0 54420.0 55146.7 55341.7 56220.4 72065.3 73101.3 74206.6 74828.9 75953.0 8695.3 8829.2 9001.3 9014.9 9317.5 14173.1 14212.9 14370.9 14519.8 14526.6 11500.9 11672.6 11753.9 12127.5 12199.1 11110.3 11183.7 11197.9 11608.5 11938.8 11885.5 11924.0 12096.7 12213.9 12243.9 8457.4 8790.7 9004.7 9114.3 9150.6 10039.6 11973.7 12068.0 12212.5 12253.8 04:58:33 INFO - PID 1660 | 04:58:33 INFO - PID 1660 | [#3] mootools.html Cycles:180 Average:7011.78 Median:4106.07 stddev:4462.72 (108.7%) stddev-sans-first:4453.56 04:58:33 INFO - PID 1660 | Values: 1159.0 1228.2 1403.0 1421.1 1433.1 8569.7 9923.0 11237.8 11410.7 11596.4 11252.1 11320.0 11336.3 11336.5 11346.2 2444.7 2497.4 2497.8 2498.3 2501.4 1949.2 2040.6 2084.6 2167.8 2172.7 2113.9 2328.7 2490.2 2495.6 2502.5 2430.1 2456.7 2457.1 2461.2 2468.6 2430.9 2432.5 2436.0 2437.5 2444.1 11089.9 11330.2 11350.3 11356.5 11359.9 6348.2 6594.9 6607.9 6613.7 6640.7 3895.1 4097.7 4242.1 4282.1 4286.4 1172.2 1191.7 1250.9 1296.3 1296.7 16194.8 16202.8 16218.8 16238.3 16287.8 5677.3 5846.2 5943.6 5992.6 6056.5 13309.2 13349.0 13368.8 13375.3 13414.5 6582.7 6664.1 6668.1 6677.7 6695.8 6018.5 6158.3 6211.9 6213.6 6223.9 4114.4 4426.6 4544.0 4561.9 4601.2 1316.6 1319.7 1334.3 1380.9 1440.0 657.8 704.5 723.8 778.5 794.7 5911.6 5997.6 6165.3 6274.6 7060.7 769.4 882.3 899.1 925.1 945.4 4054.7 4120.1 4144.8 4248.6 4259.8 14293.9 14884.8 14927.0 14944.5 15016.5 14142.7 14738.9 14766.8 14817.4 14841.6 8311.7 8522.8 8526.6 8535.7 8559.6 6382.1 6754.4 6795.9 6932.2 6940.8 12812.8 13396.3 13475.3 13592.0 13602.5 12975.2 13235.0 13783.0 13794.9 13813.2 8789.0 8881.5 8887.9 8987.3 9000.4 10268.5 10381.8 10433.8 10450.7 10453.3 7114.4 8812.6 8945.9 8964.3 9016.0 8544.9 8606.1 8637.7 8657.2 8724.0 7680.7 7846.7 7952.7 7959.7 7974.2 5855.0 5856.2 5941.5 6066.4 6087.7 5469.8 5982.1 6055.6 6084.6 6170.1 04:58:33 INFO - PID 1660 | 04:58:33 INFO - PID 1660 | [#4] prototype.html Cycles:180 Average:5018.35 Median:5666.61 stddev:1520.51 (26.8%) stddev-sans-first:1484.58 04:58:33 INFO - PID 1660 | Values: 390.9 393.3 398.0 404.9 406.6 4504.4 5287.9 5706.1 5789.9 5812.7 4619.9 4905.5 5186.6 5741.3 5760.4 3927.1 3936.9 4400.6 4456.6 4456.7 4451.9 4462.9 4464.9 4474.6 4481.5 3712.2 3918.5 4416.8 4421.9 4444.2 3849.0 4405.6 4415.1 4442.6 4449.3 3934.3 3942.8 3949.6 3963.8 3971.5 5185.3 5250.2 5597.1 5616.8 5638.5 4385.9 4399.6 5321.7 5349.6 5361.2 6182.5 6183.3 6197.9 6199.4 6228.6 3973.3 4455.2 4516.2 4557.6 4563.0 5223.5 6193.6 6399.9 6428.9 6446.4 4517.7 4586.1 4591.2 4606.3 4609.6 3920.7 4455.9 4676.0 4696.5 4712.4 4616.6 4989.5 5193.4 5273.3 5311.1 6166.6 6200.5 6201.7 6205.3 6251.2 1234.3 1342.8 1450.4 1575.9 1629.3 919.5 923.6 940.3 943.1 952.3 4471.0 4854.9 5731.3 5753.9 5788.2 6321.9 6324.9 6330.2 6343.8 6350.3 5661.0 5731.9 5757.2 5778.7 5806.6 2759.4 3309.1 3313.2 3323.3 3339.6 5455.9 6294.6 6413.0 6563.9 6579.7 5130.0 6182.8 6454.5 6463.0 6519.5 5679.7 6503.8 6518.3 6539.8 6541.3 6028.2 6381.3 6409.9 6426.9 6446.9 5672.2 5925.1 6288.2 6336.5 6342.7 5415.9 5891.6 5942.6 6286.4 6375.9 4317.4 4678.6 4701.2 4709.0 4710.6 6209.6 6379.1 6401.8 6408.0 6424.4 6124.5 6127.0 6134.4 6146.7 6176.8 5375.0 5819.4 6120.3 6125.7 6173.3 5128.0 5300.8 5798.5 6094.6 6098.3 5269.6 6084.3 6218.4 6227.8 6238.3 5695.4 5995.5 6066.8 6074.4 6080.3 04:58:33 INFO - PID 1660 | 04:58:33 INFO - PID 1660 | [#5] yui.html Cycles:180 Average:21350.75 Median:17757.69 stddev:29800.19 (167.8%) stddev-sans-first:29843.44 04:58:33 INFO - PID 1660 | Values: 698.1 836.5 836.8 847.6 865.0 12430.4 17189.0 17642.4 17931.7 18550.7 16983.6 17288.8 17309.7 17486.8 17534.4 791.8 902.4 991.4 1001.6 1002.3 671.6 1004.4 1008.3 1010.2 1015.6 731.2 932.7 1040.5 1056.8 1057.1 1043.7 1044.3 1044.5 1045.8 1047.8 777.9 779.0 782.3 783.2 785.8 16144.5 16522.4 16633.0 16700.9 16943.8 16323.7 16388.8 16523.8 16858.4 16876.2 13630.5 13742.9 13850.0 13949.2 13954.5 3379.7 3402.9 3408.5 3409.2 3409.7 96378.0 113508.0 113837.0 113891.0 114180.4 11032.2 13407.3 13747.8 13771.9 13772.9 16879.6 19482.9 19789.4 25362.4 25467.0 7720.9 7742.6 7786.2 7930.0 7934.5 3897.2 3955.6 3963.7 3966.1 3968.2 4232.9 4326.7 4354.9 4395.1 4400.6 917.7 939.9 940.9 943.4 945.1 573.5 582.3 586.7 598.4 621.8 10041.3 10799.8 10824.6 11117.0 11575.4 563.0 574.6 580.8 594.0 608.0 4718.7 5092.2 5104.0 5155.1 5162.0 93510.5 99169.0 103441.0 105344.0 106028.5 90220.5 90459.5 91389.0 92970.5 93348.0 78068.6 81642.0 82678.8 82784.2 84874.6 9467.6 10097.2 10730.0 10891.5 11907.5 38261.2 38458.0 38679.2 39605.0 39868.6 69759.0 69970.7 71777.6 71817.0 73345.3 13045.9 13399.9 13434.6 13441.9 13562.5 17354.7 17636.9 17873.0 18043.0 18052.6 14570.8 15909.0 16250.2 16471.3 16606.6 16260.0 16494.2 16632.5 16726.0 16760.7 14310.4 15236.8 15620.4 16157.0 16288.7 10543.7 11523.8 11551.8 12303.3 12311.4 12166.5 12683.5 12701.4 12749.0 12817.3 04:58:33 INFO - PID 1660 | -------- Summary: end -------- 04:58:33 INFO - PID 1660 | 04:58:33 INFO - TEST-INFO | 1660: exit 0 04:58:33 INFO - TEST-OK | dromaeo_css | took 1118630ms 04:58:33 INFO - TEST-START | kraken 04:58:33 INFO - operating with platform_type : mac_ 04:58:33 INFO - Initialising browser for kraken test... 04:58:33 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/tmpdzGmak/profile http://localhost:49235/getInfo.html) 04:58:36 INFO - PID 1669 | __metrics Screen width/height:1600/1200 04:58:36 INFO - PID 1669 | colorDepth:24 04:58:36 INFO - PID 1669 | Browser inner width/height: 1024/689 04:58:36 INFO - PID 1669 | __metrics 04:58:36 INFO - PID 1669 | 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" 04:58:36 INFO - PID 1669 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:58:37 INFO - TEST-INFO | 1669: exit 0 04:58:37 INFO - Browser initialized. 04:58:37 INFO - Running cycle 1/1 for kraken test... 04:58:37 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/T/tmpdzGmak/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:58:49 INFO - PID 1670 | RSS: Main: 241180672 04:58:49 INFO - PID 1670 | 04:58:52 INFO - PID 1670 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 04:58:53 INFO - PID 1670 | RSS: Main: 310562816 04:58:53 INFO - PID 1670 | 04:58:56 INFO - PID 1670 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 04:58:56 INFO - PID 1670 | RSS: Main: 293740544 04:58:56 INFO - PID 1670 | 04:58:59 INFO - PID 1670 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 04:59:00 INFO - PID 1670 | RSS: Main: 385527808 04:59:00 INFO - PID 1670 | 04:59:02 INFO - PID 1670 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 04:59:03 INFO - PID 1670 | RSS: Main: 289681408 04:59:03 INFO - PID 1670 | 04:59:05 INFO - PID 1670 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:59:05 INFO - PID 1670 | RSS: Main: 291913728 04:59:05 INFO - PID 1670 | 04:59:08 INFO - PID 1670 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 04:59:09 INFO - PID 1670 | RSS: Main: 355766272 04:59:09 INFO - PID 1670 | 04:59:12 INFO - PID 1670 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 04:59:12 INFO - PID 1670 | RSS: Main: 371859456 04:59:12 INFO - PID 1670 | 04:59:15 INFO - PID 1670 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 04:59:16 INFO - PID 1670 | RSS: Main: 377749504 04:59:16 INFO - PID 1670 | 04:59:17 INFO - PID 1670 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:59:18 INFO - PID 1670 | RSS: Main: 329478144 04:59:18 INFO - PID 1670 | 04:59:20 INFO - PID 1670 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:59:20 INFO - PID 1670 | RSS: Main: 331644928 04:59:20 INFO - PID 1670 | 04:59:22 INFO - PID 1670 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:59:23 INFO - PID 1670 | RSS: Main: 334729216 04:59:23 INFO - PID 1670 | 04:59:26 INFO - PID 1670 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:59:27 INFO - PID 1670 | RSS: Main: 349671424 04:59:27 INFO - PID 1670 | 04:59:30 INFO - PID 1670 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:59:30 INFO - PID 1670 | RSS: Main: 342487040 04:59:30 INFO - PID 1670 | 04:59:32 INFO - PID 1670 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 04:59:33 INFO - PID 1670 | RSS: Main: 385589248 04:59:33 INFO - PID 1670 | 04:59:33 INFO - PID 1670 | __start_tp_report 04:59:33 INFO - PID 1670 | _x_x_mozilla_page_load 04:59:33 INFO - PID 1670 | _x_x_mozilla_page_load_details 04:59:33 INFO - PID 1670 | |i|pagename|runs| 04:59:33 INFO - PID 1670 | |0;ai-astar;111;112;112;147;165;111;111;110;109;110 04:59:33 INFO - PID 1670 | |1;audio-beat-detection;140;109;109;144;107;107;106;105;135;108 04:59:33 INFO - PID 1670 | |2;audio-dft;184;184;183;185;184;185;182;184;186;182 04:59:33 INFO - PID 1670 | |3;audio-fft;80;57;59;87;59;58;56;59;81;58 04:59:33 INFO - PID 1670 | |4;audio-oscillator;93;69;85;69;69;69;90;69;68;105 04:59:33 INFO - PID 1670 | |5;imaging-gaussian-blur;89;88;93;88;88;89;89;89;89;89 04:59:33 INFO - PID 1670 | |6;imaging-darkroom;96;96;96;96;96;96;96;95;96;96 04:59:33 INFO - PID 1670 | |7;imaging-desaturate;85;84;85;84;83;83;85;84;83;85 04:59:33 INFO - PID 1670 | |8;json-parse-financial;47;48;47;47;47;48;49;48;48;47 04:59:33 INFO - PID 1670 | |9;json-stringify-tinderbox;55;55;61;59;67;60;60;59;58;57 04:59:33 INFO - PID 1670 | |10;stanford-crypto-aes;82;83;82;82;83;82;80;81;81;82 04:59:33 INFO - PID 1670 | |11;stanford-crypto-ccm;138;148;147;128;147;142;151;141;216;151 04:59:33 INFO - PID 1670 | |12;stanford-crypto-pbkdf2;186;183;213;185;182;186;185;180;183;181 04:59:33 INFO - PID 1670 | |13;stanford-crypto-sha256-iterative;68;68;81;98;91;94;64;65;96;90 04:59:33 INFO - PID 1670 | __end_tp_report 04:59:33 INFO - PID 1670 | __start_cc_report 04:59:33 INFO - PID 1670 | _x_x_mozilla_cycle_collect,2192 04:59:33 INFO - PID 1670 | __end_cc_report 04:59:33 INFO - PID 1670 | __startTimestamp1493639973039__endTimestamp 04:59:33 INFO - PID 1670 | 04:59:33 INFO - PID 1670 | ------- Summary: start ------- 04:59:33 INFO - PID 1670 | Number of tests: 14 04:59:33 INFO - PID 1670 | 04:59:33 INFO - PID 1670 | [#0] ai-astar Cycles:10 Average:119.80 Median:111.50 stddev:19.57 (17.5%) stddev-sans-first:20.49 04:59:33 INFO - PID 1670 | Values: 111.0 112.0 112.0 147.0 165.0 111.0 111.0 110.0 109.0 110.0 04:59:33 INFO - PID 1670 | 04:59:33 INFO - PID 1670 | [#1] audio-beat-detection Cycles:10 Average:117.00 Median:109.00 stddev:15.83 (14.5%) stddev-sans-first:14.44 04:59:33 INFO - PID 1670 | Values: 140.0 109.0 109.0 144.0 107.0 107.0 106.0 105.0 135.0 108.0 04:59:33 INFO - PID 1670 | 04:59:33 INFO - PID 1670 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.00 stddev:1.29 (0.7%) stddev-sans-first:1.36 04:59:33 INFO - PID 1670 | Values: 184.0 184.0 183.0 185.0 184.0 185.0 182.0 184.0 186.0 182.0 04:59:33 INFO - PID 1670 | 04:59:33 INFO - PID 1670 | [#3] audio-fft Cycles:10 Average:65.40 Median:59.00 stddev:12.08 (20.5%) stddev-sans-first:11.61 04:59:33 INFO - PID 1670 | Values: 80.0 57.0 59.0 87.0 59.0 58.0 56.0 59.0 81.0 58.0 04:59:33 INFO - PID 1670 | 04:59:33 INFO - PID 1670 | [#4] audio-oscillator Cycles:10 Average:78.60 Median:69.00 stddev:13.53 (19.6%) stddev-sans-first:13.31 04:59:33 INFO - PID 1670 | Values: 93.0 69.0 85.0 69.0 69.0 69.0 90.0 69.0 68.0 105.0 04:59:33 INFO - PID 1670 | 04:59:33 INFO - PID 1670 | [#5] imaging-gaussian-blur Cycles:10 Average:89.10 Median:89.00 stddev:1.45 (1.6%) stddev-sans-first:1.54 04:59:33 INFO - PID 1670 | Values: 89.0 88.0 93.0 88.0 88.0 89.0 89.0 89.0 89.0 89.0 04:59:33 INFO - PID 1670 | 04:59:33 INFO - PID 1670 | [#6] imaging-darkroom Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:59:33 INFO - PID 1670 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 04:59:33 INFO - PID 1670 | 04:59:33 INFO - PID 1670 | [#7] imaging-desaturate Cycles:10 Average:84.10 Median:84.50 stddev:0.88 (1.0%) stddev-sans-first:0.87 04:59:33 INFO - PID 1670 | Values: 85.0 84.0 85.0 84.0 83.0 83.0 85.0 84.0 83.0 85.0 04:59:33 INFO - PID 1670 | 04:59:33 INFO - PID 1670 | [#8] json-parse-financial Cycles:10 Average:47.60 Median:48.00 stddev:0.70 (1.5%) stddev-sans-first:0.71 04:59:33 INFO - PID 1670 | Values: 47.0 48.0 47.0 47.0 47.0 48.0 49.0 48.0 48.0 47.0 04:59:33 INFO - PID 1670 | 04:59:33 INFO - PID 1670 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.50 stddev:3.45 (5.8%) stddev-sans-first:3.32 04:59:33 INFO - PID 1670 | Values: 55.0 55.0 61.0 59.0 67.0 60.0 60.0 59.0 58.0 57.0 04:59:33 INFO - PID 1670 | 04:59:33 INFO - PID 1670 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.00 stddev:0.92 (1.1%) stddev-sans-first:0.97 04:59:33 INFO - PID 1670 | Values: 82.0 83.0 82.0 82.0 83.0 82.0 80.0 81.0 81.0 82.0 04:59:33 INFO - PID 1670 | 04:59:33 INFO - PID 1670 | [#11] stanford-crypto-ccm Cycles:10 Average:150.90 Median:147.50 stddev:23.91 (16.2%) stddev-sans-first:24.90 04:59:33 INFO - PID 1670 | Values: 138.0 148.0 147.0 128.0 147.0 142.0 151.0 141.0 216.0 151.0 04:59:33 INFO - PID 1670 | 04:59:33 INFO - PID 1670 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.40 Median:185.00 stddev:9.57 (5.2%) stddev-sans-first:10.15 04:59:33 INFO - PID 1670 | Values: 186.0 183.0 213.0 185.0 182.0 186.0 185.0 180.0 183.0 181.0 04:59:33 INFO - PID 1670 | 04:59:33 INFO - PID 1670 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.50 Median:90.50 stddev:13.92 (15.4%) stddev-sans-first:13.88 04:59:33 INFO - PID 1670 | Values: 68.0 68.0 81.0 98.0 91.0 94.0 64.0 65.0 96.0 90.0 04:59:33 INFO - PID 1670 | -------- Summary: end -------- 04:59:33 INFO - PID 1670 | 04:59:34 INFO - TEST-INFO | 1670: exit 0 04:59:34 INFO - TEST-OK | kraken | took 60299ms 04:59:34 INFO - SUITE-END | took 1178s 04:59:34 INFO - Completed test suite (00:19:38) 04:59:34 INFO - javascript benchmark 04:59:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7632.535149708779, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3466.4280393735035, 3481.355949149407, 3483.51230827684, 3497.2131270464165, 3522.696602257165, 5963.493103086243, 6091.025435930252, 6150.600210986288, 6178.505719542437, 6201.782937597185, 6102.277183976812, 6121.296050954142, 6159.5380346474085, 6195.163652906856, 6207.068939659053, 5100.795968161287, 5148.819791307305, 5229.895402091975, 5260.8158714445, 5316.096263635172, 5366.087765079927, 5366.91949620756, 5371.167469042285, 5386.272853164812, 5422.2951016367815, 5196.870078248036, 5266.447023062561, 5286.894262114774, 5297.708626025567, 5308.362996440414, 5311.044012077825, 5334.759935802898, 5352.57179425645, 5357.8392648220615, 5372.946270537323, 5273.182656688219, 5304.389995150568, 5322.627416080876, 5329.2006199070065, 5340.439253878365, 5512.834614961557, 5930.169776231331, 6135.5091592672925, 6161.19904412428, 6161.6303021818385, 6404.519661025442, 6408.647524386157, 6417.101605775195, 6431.356864313578, 6449.613023218575, 6407.743690252384, 6495.512836537231, 6496.252930912911, 6503.7073331700185, 6516.446102081329, 6201.56589038772, 6207.441330280297, 6255.093011513351, 6263.6868156592445, 6275.497960163176, 6647.401733843881, 6653.933460665428, 6655.0682904393425, 6657.966710166515, 6661.16735408074, 6341.936580634227, 6379.425851673372, 6418.518611104186, 6420.582662126947, 6425.5502114851515, 6441.967790161113, 6459.063435801782, 6479.902801457982, 6498.025296205513, 6500.317466666026, 6405.327440618668, 6412.903806442907, 6413.422791948747, 6416.935830641727, 6438.0, 6360.173177486897, 6412.2625898022325, 6430.3891130342545, 6435.22777266731, 6471.935280647227, 5127.333446651986, 5142.97428512855, 5151.793928242828, 5162.586993040548, 5177.741112944338, 3861.6331448512346, 4600.4479462464715, 4621.907561848744, 4655.278431843002, 4685.882852928704, 5899.351071382144, 6136.0, 6157.907631385533, 6158.737458820931, 6181.938180618226, 6371.458426033839, 6393.680315984182, 6443.130177426081, 6520.282768895418, 6537.934620653733, 6107.006761825774, 6117.583823141483, 6176.104464852661, 6193.411625895533, 6213.161223234896, 5667.744951477193, 5668.773249070074, 5676.318841739017, 5681.545476361881, 5716.771329146787, 6459.386358296142, 6514.9348506514325, 6633.270340262471, 6665.66671666405, 6696.866062678621, 6493.772717954849, 6505.577137486048, 6520.836979075561, 6526.738930442729, 6560.671966401565, 6632.668366581555, 6741.561798483083, 6753.15585551806, 6753.864922701617, 6754.425873800782, 6357.968210159104, 6439.066335381437, 6439.098526206241, 6449.935500644933, 6450.258220304725, 5832.445917637818, 6016.157737916607, 6426.164598602339, 6446.452051575481, 6497.805065848032, 6262.812115636538, 6339.492840572835, 6357.268914074941, 6393.0, 6420.775272865428, 6295.559310848196, 6336.461400780985, 6353.332900045613, 6399.968000159969, 6425.935740642721, 6397.168368112116, 6397.712102955471, 6408.166938297992, 6411.487081033413, 6412.97392417211, 6245.469135123565, 6308.306086330408, 6312.4634406076, 6318.210223722035, 6418.967905160444, 6289.811305660837, 6330.936690633035, 6341.556091073765, 6352.047192920914, 6363.268224154096], "value": 5955.876832334245, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.319151168193, 788.8501184774892, 805.4281460163284, 1120.837478565608, 1132.660201939418, 26333.47333053338, 36018.81990590047, 36171.276574468495, 36196.45705314419, 36250.0, 38238.617613823924, 38440.03899902504, 38477.61522384775, 38478.0, 38553.614463855425, 6034.487068599175, 8327.375446841495, 8494.193051660082, 8505.106963768809, 8516.829663406728, 6088.726007329658, 8283.62723677433, 8443.15568443157, 8444.408891377607, 8453.281471074966, 8508.74473765788, 8533.701320453785, 8555.828883422328, 8567.31461483083, 8587.914120858773, 6024.126501657279, 8441.366897482683, 8501.787455313666, 8504.44721093127, 8520.573971301472, 6031.758729650809, 8199.22107399796, 8330.416870819045, 8343.45767525109, 8360.707375241898, 35984.74053408118, 36409.45385819215, 36412.0, 36444.63555364439, 36486.63513364885, 3476.026712520498, 3498.440249560058, 3505.0185947934365, 3509.4209455439823, 3514.6836784689244, 29637.407251854842, 29654.70345296541, 29692.70307296921, 29693.812247510075, 29734.85132574345, 2664.880750084969, 3002.8348440835744, 3086.8302243376606, 3098.395812816502, 3099.767517436201, 233068.0, 282355.0, 285924.57037714886, 287111.5644421785, 287395.0, 46838.76580617075, 46876.296855547196, 46931.29603055957, 46951.76524117426, 47025.76487117542, 49304.75347623239, 49373.50626493761, 49374.012519749405, 49527.0, 49559.0, 13817.585472435843, 13887.236202008784, 13914.51299204523, 13927.373268202955, 13942.093763905314, 9741.9025809741, 9786.706398808046, 11306.830397544043, 11330.09359251258, 11347.716307092223, 10204.744881378025, 10341.689749307532, 11247.381394023407, 11749.177557571058, 11918.344491053076, 5321.813736519203, 5338.9466105339225, 5366.704831234241, 5370.684182375265, 5417.079096553595, 897.3808072430003, 995.2784231432298, 1025.8717660292464, 1056.6354607660344, 1060.41677077607, 23381.064757409855, 28693.28266793305, 29360.559591606143, 29691.663875125672, 29969.700302997127, 943.5753910740194, 1053.2469284461647, 1075.542894269932, 1113.0705860606483, 1114.2590177532013, 10520.947395262974, 11531.520723044585, 12087.0, 12096.879031209752, 12126.333051682243, 242885.0, 243053.0, 243636.7818160898, 243750.0, 243804.78097609399, 48179.75910120427, 48252.5174748255, 48292.7585362071, 48348.75825620849, 48432.0, 1324.1326930860303, 1443.5492330208074, 1457.2640816387657, 1490.3889405343973, 1492.9626759330886, 22229.110835566396, 22697.0, 22851.54296914019, 22922.19772307961, 22951.426214344774, 35311.58753649825, 35353.82323088368, 35423.29153416866, 35437.29125417529, 35495.822520888265, 175026.0, 224853.0, 225822.8708856511, 226632.0, 226754.0, 27372.04197853145, 31424.05727828169, 31475.527867081553, 31536.684633153374, 31557.684423155475, 34649.48025779565, 39049.02377440587, 41366.79316603518, 41441.34234630581, 41485.96285092897, 27599.448011039265, 28151.71848281491, 29192.854035729684, 29488.705112949454, 30060.947866824557, 28434.289142771595, 28769.42461150807, 29308.560371594016, 29461.0, 29683.554746678386, 34717.13207169841, 34782.47826282658, 34803.0, 34830.9550713479, 34899.302013960085, 27425.725742742317, 27624.309392265353, 29825.0, 30441.0, 31346.843265783526, 23742.881285593463, 23918.760812391654, 23986.28041158768, 24277.63583546213, 24379.51240975206], "value": 16506.607944884272, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.6871199668245, 428.2779176433139, 430.7480124127386, 434.2032370599949, 446.69624655234446, 18955.71566426501, 20739.481512962182, 21249.0, 21450.678239826397, 21489.785102148973, 21159.471013224676, 22129.66805497919, 22453.0, 22722.0, 22820.771792282074, 6106.267247930244, 6275.2469703635625, 6282.937170628281, 6295.024271237942, 6310.716017779211, 5894.440028197336, 6126.0, 6187.938120618781, 6188.969055154718, 6191.628502289855, 5887.646741195542, 6121.143039974385, 6126.468382904274, 6147.077938309267, 6154.138420621117, 6081.148639190517, 6204.7828326008375, 6207.441330280274, 6225.87548249037, 6238.344973777734, 5267.894642107175, 5410.161424979135, 5481.095619222823, 5490.0, 5512.283403157604, 26688.332791680168, 26702.0, 26913.730862691318, 27042.86478567614, 27623.171304860887, 2148.1085349579907, 2248.4940888300166, 2251.7410497792634, 2252.200468833557, 2252.2117258959397, 17431.912840435845, 17521.386751463764, 17736.379226727004, 18084.728729069073, 18334.358297459657, 2127.053461209762, 2143.753468351144, 2187.475005998549, 2189.0, 2190.5509370579152, 128954.0, 147908.0, 158554.0, 159951.0, 162962.1851890745, 10235.692929211986, 10469.31949423285, 11269.943650281695, 12183.512659493521, 12216.816747748613, 14740.262986850828, 15825.920870395805, 16232.026078435332, 16234.51296461108, 16244.75632865508, 7999.3200577950365, 8050.4364694472, 8759.474431534129, 8797.12028797115, 8893.955530222307, 8246.800767420298, 8267.462614930131, 8285.461445006054, 8433.283170930417, 8540.188682075193, 7596.24037596247, 7753.689852405841, 7794.883076753853, 7799.688012479437, 7803.531788092732, 1771.4685594321652, 1991.2632326039459, 2097.4336929029078, 2113.6512475441687, 2231.129859354853, 783.4633276205817, 867.085225087526, 906.0, 959.4770849886828, 965.8358079126565, 16693.582660433585, 20882.060307286207, 21013.94930253512, 21482.37375731624, 25133.62299565508, 969.4425705219527, 977.9608815647294, 981.1807141037172, 1003.3428104591504, 1010.4190090697878, 11032.944835275772, 11276.548938042386, 11284.830727539094, 11297.26567773092, 11306.265092768943, 521515.0, 547134.0, 552367.0, 558050.0, 564832.0, 89910.0, 132982.0, 139287.0, 140663.0, 141697.0, 991.8512223166583, 1024.4775164666073, 1030.108955753268, 1045.6340280901775, 1047.1413440978324, 21038.0, 22131.66802497996, 22404.0, 22548.101924076702, 22623.20818771335, 45692.0, 54420.0, 55146.72426637841, 55341.723291383285, 56220.43779562152, 72065.27934720585, 73101.26898731157, 74206.62896685483, 74828.87756683545, 75953.0, 8695.347848911231, 8829.16122968317, 9001.279897608045, 9014.86477702848, 9317.487538185194, 14173.078749881224, 14212.928935355258, 14370.856291436952, 14519.782203266748, 14526.564203073925, 11500.884991149982, 11672.649820505398, 11753.941230293794, 12127.45426455794, 12199.085068620067, 11110.277906924439, 11183.657961044726, 11197.888021119685, 11608.535658573563, 11938.820917686415, 11885.46515406826, 11924.0460763137, 12096.697582560506, 12213.877861221274, 12243.877561224273, 8457.40798144124, 8790.692325768567, 9004.729858104267, 9114.316426267924, 9150.588223529823, 10039.598416063276, 11973.682894881382, 12068.0, 12212.450439730055, 12253.75492490163], "value": 10334.326820112985, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1159.0, 1228.1832581333413, 1402.9929850350748, 1421.0620990146506, 1433.1329545624899, 8569.700060497884, 9922.950385248072, 11237.83143252852, 11410.7147321317, 11596.420178991058, 11252.09983201344, 11320.0, 11336.319820810737, 11336.48985795639, 11346.20576559641, 2444.7433019532914, 2497.3756560859783, 2497.7636070145304, 2498.2755001049673, 2501.4246723253664, 1949.220311875247, 2040.5714799892041, 2084.593504266669, 2167.8157356624706, 2172.706684597583, 2113.8625989310644, 2328.7438381778074, 2490.2280293109193, 2495.6007038873786, 2502.4744803591175, 2430.052279610953, 2456.6929133858266, 2457.0908763757348, 2461.2001099642507, 2468.6173643085262, 2430.8541487510806, 2432.4891772727747, 2435.9634605480933, 2437.536867995075, 2444.10790061628, 11089.944550277198, 11330.150238732129, 11350.262232954832, 11356.48895799691, 11359.943200283946, 6348.206474190726, 6594.86810263792, 6607.867842643121, 6613.702383392759, 6640.667966601699, 3895.104126050996, 4097.733647312945, 4242.0879510905, 4282.100758840647, 4286.39990401344, 1172.150191111446, 1191.7139886427283, 1250.8749125087509, 1296.3129541343103, 1296.6823128333524, 16194.838051619568, 16202.75695864563, 16218.75671864923, 16238.269277882524, 16287.755683664755, 5677.318721753416, 5846.210761547221, 5943.613665111754, 5992.610480318853, 6056.515478761688, 13309.201447913156, 13349.0, 13368.799468007988, 13375.264360460074, 13414.530491432753, 6582.736690532325, 6664.100346453264, 6668.133142691419, 6677.699503522256, 6695.832604184837, 6018.518518518508, 6158.291796443376, 6211.875762484816, 6213.596116252429, 6223.875522489525, 4114.403411505315, 4426.623736982328, 4543.954560454419, 4561.908761824745, 4601.217792975202, 1316.585275638171, 1319.6671361924525, 1334.252818421687, 1380.861913808611, 1439.9640008999859, 657.8026592022375, 704.5490885833071, 723.8335182907961, 778.5056489129444, 794.7417089445953, 5911.586188966731, 5997.6401415914315, 6165.260168779775, 6274.623522588659, 7060.71757129709, 769.4267770511005, 882.3250213586612, 899.1278459893892, 925.0887875442684, 945.3854994253653, 4054.682228275822, 4120.134771697977, 4144.772037537904, 4248.63886569645, 4259.765712885821, 14293.85706142946, 14884.776728349083, 14927.029743066665, 14944.476943306932, 15016.549503514912, 14142.717145657029, 14738.926305368404, 14766.778498322534, 14817.40730370773, 14841.628959276104, 8311.6675332986, 8522.78693032679, 8526.57367131641, 8535.701250456204, 8559.614817333235, 6382.106505089198, 6754.425873800586, 6795.932040679728, 6932.168139823253, 6940.826479338057, 12812.807807882702, 13396.26320552379, 13475.304939012432, 13592.048556600943, 13602.523911663044, 12975.221486710827, 13235.007374446763, 13783.035187536776, 13794.931025345211, 13813.171209727449, 8788.98926623421, 8881.511516866634, 8887.866681999905, 8987.325950553604, 9000.414973026733, 10268.537915793659, 10381.792364152523, 10433.843492347773, 10450.738731531772, 10453.26827122094, 7114.359707626339, 8812.559372031501, 8945.910540894769, 8964.32767542424, 9016.0, 8544.871826922725, 8606.053334133116, 8637.740867773977, 8657.177568131017, 8724.0, 7680.692772289046, 7846.686132554634, 7952.721654742057, 7959.681612735426, 7974.202579741979, 5855.03391940325, 5856.180134781049, 5941.494972927349, 6066.423689749643, 6087.726052327567, 5469.75386107634, 5982.0727787193055, 6055.576109672281, 6084.6349219047, 6170.074488826712], "value": 5281.8988013841645, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.94722212501307, 393.29207426632075, 397.9661728753056, 404.88865561970454, 406.5588836112818, 4504.436945381827, 5287.889543195929, 5706.059939620528, 5789.884202315961, 5812.651240925547, 4619.914320134766, 4905.533974272438, 5186.636935414523, 5741.320823528821, 5760.423957604237, 3927.057506198506, 3936.921261574767, 4400.559944005589, 4456.643468522527, 4456.6657500687415, 4451.888702782424, 4462.910741785162, 4464.933026004613, 4474.619657329131, 4481.46222453306, 3712.162479572602, 3918.490596222487, 4416.757078360689, 4421.850318917089, 4444.244478438657, 3848.960780589239, 4405.647548196137, 4415.072834704716, 4442.64458843295, 4449.288113901776, 3934.291827471083, 3942.8457234212515, 3949.6445319921345, 3963.801809909522, 3971.5035620547433, 5185.325907631984, 5250.238715386247, 5597.076482380402, 5616.83751755577, 5638.464345887134, 4385.890352741175, 4399.64802815774, 5321.733913304358, 5349.625526213166, 5361.195820626937, 6182.505399568024, 6183.2889217740085, 6197.907031394533, 6199.380061993809, 6228.626282423023, 3973.284808734427, 4455.195645763471, 4516.23224051912, 4557.58981691646, 4562.954370456286, 5223.503767142115, 6193.566450348478, 6399.9040014399825, 6428.878470104854, 6446.355364463563, 4517.728936263835, 4586.1057093866375, 4591.17358875399, 4606.332081848181, 4609.585137337655, 3920.745151565196, 4455.888602784957, 4676.041411510632, 4696.459907110658, 4712.434507859079, 4616.630669546428, 4989.451160372356, 5193.402758682724, 5273.288106105627, 5311.123664595299, 6166.568340216142, 6200.472959798468, 6201.658908759971, 6205.317415084337, 6251.156093927352, 1234.2779474007627, 1342.7784415571516, 1450.3835869755312, 1575.8818088643397, 1629.3482606957075, 919.5218486387041, 923.5797712041006, 940.3464592108555, 943.1087622196958, 952.2857856607544, 4470.955290447054, 4854.902901941941, 5731.312242530839, 5753.942460575425, 5788.18965344852, 6321.905171422432, 6324.9051264231075, 6330.177076980055, 6343.841403964938, 6350.33321501245, 5660.981072632816, 5731.942680573225, 5757.222774925332, 5778.711064446761, 5806.5645076618575, 2759.4481103779326, 3309.1396236978558, 3313.2379552703014, 3323.335332933423, 3339.6326404096017, 5455.890882182413, 6294.590851594632, 6413.0, 6563.9343606563325, 6579.736810527621, 5129.9743501282255, 6182.752689892444, 6454.548181627241, 6463.0, 6519.5436319457185, 5679.716014199356, 6503.772367967098, 6518.282988871126, 6539.836504087436, 6541.33196035008, 6028.15605815195, 6381.298057213796, 6409.903851442139, 6426.935730642634, 6446.9032964506505, 5672.234248376416, 5925.096702615773, 6288.213973253343, 6336.461400780985, 6342.651154186564, 5415.889742602836, 5891.646501209942, 5942.61373010753, 6286.4342209201395, 6375.904361434675, 4317.438732964694, 4678.60231880294, 4701.247800351927, 4709.0, 4710.552497512731, 6209.59637623553, 6379.075034120119, 6401.807945761635, 6408.0, 6424.357564243725, 6124.54065945047, 6127.0, 6134.386561344008, 6146.723397447215, 6176.845578860564, 5375.0, 5819.388964158702, 6120.2873787182725, 6125.724342404514, 6173.32093469727, 5127.974360128175, 5300.840974770763, 5798.478136967525, 6094.634321940698, 6098.26820781509, 5269.604779641466, 6084.326810127251, 6218.409251121137, 6227.844303892439, 6238.313785483684, 5695.401982791747, 5995.520358371407, 6066.757329706938, 6074.439605226433, 6080.331163571915], "value": 4545.729532199783, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.113395987096, 836.506461187899, 836.7949852286191, 847.593155285463, 864.995675021625, 12430.378481075944, 17189.0, 17642.38251661192, 17931.73102403465, 18550.72173917392, 16983.57541061474, 17288.82711172888, 17309.653806923852, 17486.82513174868, 17534.386296479624, 791.8337149198661, 902.4269588811119, 991.3803872579638, 1001.6093723447825, 1002.3334482569119, 671.5869740109822, 1004.3823048824956, 1008.3093081239338, 1010.171659239424, 1015.5836107196051, 731.2139450091147, 932.6689025395955, 1040.5057597641135, 1056.8414737789317, 1057.0750593230923, 1043.7234132954698, 1044.2742294105599, 1044.4621020174616, 1045.7542477517738, 1047.7904419116207, 777.8522080804629, 778.9756470241671, 782.3271986092013, 783.220695408067, 785.7917651822214, 16144.515664530083, 16522.42171524003, 16633.002019878724, 16700.916495417445, 16943.830561694347, 16323.673526529521, 16388.836111638968, 16523.83476165235, 16858.409955651492, 16876.240569174417, 13630.522931697442, 13742.862571374259, 13850.030497865153, 13949.232792196424, 13954.511592094228, 3379.69881595585, 3402.897913062612, 3408.471686888536, 3409.1817963688786, 3409.6760807723226, 96377.9999999993, 113508.0, 113837.0, 113891.0, 114180.42909785481, 11032.172587055842, 13407.329633518286, 13747.793783093262, 13771.931140344233, 13772.862271377158, 16879.578010549834, 19482.902585487267, 19789.406317810488, 25362.365940851625, 25467.0, 7720.884186737204, 7742.645037118482, 7786.1824508426935, 7929.960350198212, 7934.484258523177, 3897.2400381925254, 3955.6044395560216, 3963.722539422213, 3966.0679740261016, 3968.166684996183, 4232.851850185229, 4326.6754993375625, 4354.869353919387, 4395.055063161436, 4400.559944005638, 917.7430319510547, 939.9237872635794, 940.9341346105707, 943.4197968249478, 945.1352012908112, 573.4695406748741, 582.3099626942087, 586.6978506069378, 598.3567664760313, 621.8289970258215, 10041.347312424668, 10799.78400431987, 10824.567017319376, 11116.96889516669, 11575.373246117673, 562.9662220266797, 574.5719439017959, 580.8199458167896, 594.0, 607.9908801367983, 4718.716876987323, 5092.185250359925, 5103.974480127576, 5155.097857874857, 5162.0, 93510.53244733733, 99169.0, 103441.0, 105344.0, 106028.46985765175, 90220.5488972551, 90459.54770226107, 91389.0, 92970.53514732383, 93348.0, 78068.60965695248, 81642.0, 82678.75981860278, 82784.17215827765, 84874.5756271227, 9467.621295148117, 10097.242706796873, 10730.0, 10891.455427228766, 11907.52369905194, 38261.23477530378, 38458.0, 38679.22641547097, 39605.00987475336, 39868.60131398765, 69759.0, 69970.65014674894, 71777.6411117962, 71817.0, 73345.26654733598, 13045.934770326088, 13399.866001339862, 13434.596962091153, 13441.865581344062, 13562.525311614047, 17354.652906942043, 17636.941783493032, 17873.0, 18043.0, 18052.638947221243, 14570.781438278222, 15909.045457272137, 16250.155476504297, 16471.25879335409, 16606.584835379213, 16260.024398536125, 16494.17529123515, 16632.50102496927, 16726.0, 16760.74858877142, 14310.356033978704, 15236.781057515595, 15620.375184992474, 16157.0, 16288.67422651564, 10543.683689489328, 11523.769524609628, 11551.76896462083, 12303.261804291771, 12311.384430778604, 12166.48667928245, 12683.492660293854, 12701.42843572023, 12749.0, 12817.295048772034], "value": 8104.0531232949, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1441.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 112.0, 147.0, 165.0, 111.0, 111.0, 110.0, 109.0, 110.0], "value": 119.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 109.0, 109.0, 144.0, 107.0, 107.0, 106.0, 105.0, 135.0, 108.0], "value": 117.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 183.0, 185.0, 184.0, 185.0, 182.0, 184.0, 186.0, 182.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 59.0, 87.0, 59.0, 58.0, 56.0, 59.0, 81.0, 58.0], "value": 65.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 69.0, 85.0, 69.0, 69.0, 69.0, 90.0, 69.0, 68.0, 105.0], "value": 78.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 93.0, 88.0, 88.0, 89.0, 89.0, 89.0, 89.0, 89.0], "value": 89.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 84.0, 83.0, 83.0, 85.0, 84.0, 83.0, 85.0], "value": 84.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 48.0, 47.0, 47.0, 47.0, 48.0, 49.0, 48.0, 48.0, 47.0], "value": 47.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 61.0, 59.0, 67.0, 60.0, 60.0, 59.0, 58.0, 57.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 82.0, 82.0, 83.0, 82.0, 80.0, 81.0, 81.0, 82.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 148.0, 147.0, 128.0, 147.0, 142.0, 151.0, 141.0, 216.0, 151.0], "value": 150.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 183.0, 213.0, 185.0, 182.0, 186.0, 185.0, 180.0, 183.0, 181.0], "value": 186.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 81.0, 98.0, 91.0, 94.0, 64.0, 65.0, 96.0, 90.0], "value": 81.5, "unit": "score"}]}]} 04:59:34 INFO - Return code: 0 04:59:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:59:34 ERROR - # TBPL SUCCESS # 04:59:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:59:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:59:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:59:34 INFO - 2017-05-01 04:59:34.347 screenresolution[1675:11231] starting screenresolution argv=screenresolution get 04:59:34 INFO - 2017-05-01 04:59:34.351 screenresolution[1675:11231] Display 0: 1600x1200x32@60 04:59:34 INFO - 2017-05-01 04:59:34.357 screenresolution[1676:11234] starting screenresolution argv=screenresolution list 04:59:34 INFO - Available Modes on Display 0 04:59:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:59:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:59:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:59:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:59:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:59:34 INFO - Intel Iris: 04:59:34 INFO - Chipset Model: Intel Iris 04:59:34 INFO - Type: GPU 04:59:34 INFO - Bus: Built-In 04:59:34 INFO - VRAM (Dynamic, Max): 1536 MB 04:59:34 INFO - Vendor: Intel (0x8086) 04:59:34 INFO - Device ID: 0x0a2e 04:59:34 INFO - Revision ID: 0x0009 04:59:34 INFO - Displays: 04:59:34 INFO - Display: 04:59:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:59:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:59:34 INFO - Display Serial Number: 1600x1200 60 04:59:34 INFO - Main Display: Yes 04:59:34 INFO - Mirror: Off 04:59:34 INFO - Online: Yes 04:59:34 INFO - Rotation: Supported 04:59:34 INFO - Return code: 0 04:59:34 INFO - Running post-action listener: _resource_record_post_action 04:59:34 INFO - [mozharness: 2017-05-01 11:59:34.605718Z] Finished run-tests step (success) 04:59:34 INFO - Running post-run listener: _resource_record_post_run 04:59:34 INFO - Total resource usage - Wall time: 1199s; CPU: 53.0%; Read bytes: 33070592; Write bytes: 508238848; Read time: 208; Write time: 1570 04:59:34 INFO - TinderboxPrint: CPU usage
53.4% 04:59:34 INFO - TinderboxPrint: I/O read bytes / time
33,070,592 / 208 04:59:34 INFO - TinderboxPrint: I/O write bytes / time
508,238,848 / 1,570 04:59:34 INFO - TinderboxPrint: CPU idle
2,233.7 (46.6%) 04:59:34 INFO - TinderboxPrint: CPU system
954.9 (19.9%) 04:59:34 INFO - TinderboxPrint: CPU user
1,609.1 (33.5%) 04:59:34 INFO - TinderboxPrint: Swap in / out
238,149,632 / 0 04:59:34 INFO - install - Wall time: 20s; CPU: 55.0%; Read bytes: 206017024; Write bytes: 204793856; Read time: 16030; Write time: 437 04:59:34 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 30932480; Write bytes: 296375296; Read time: 186; Write time: 1105 04:59:35 INFO - Running post-run listener: _upload_blobber_files 04:59:35 INFO - Blob upload gear active. 04:59:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:59:35 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 04:59:35 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'] 04:59:35 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 04:59:35 INFO - (blobuploader) - INFO - Open directory for files ... 04:59:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:59:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:59:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:36 INFO - (blobuploader) - INFO - Done attempting. 04:59:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:59:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:59:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:37 INFO - (blobuploader) - INFO - Done attempting. 04:59:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:59:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:59:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:38 INFO - (blobuploader) - INFO - Done attempting. 04:59:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:59:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:59:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:40 INFO - (blobuploader) - INFO - Done attempting. 04:59:40 INFO - (blobuploader) - INFO - Iteration through files over. 04:59:40 INFO - Return code: 0 04:59:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:59:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:59:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3500944a2fd3a1c0998549625b43fa795866a9b85f38dc9c429f3b8bedd2a1ca72ea5ff19fb5acc8054506fe10b9b979f94a19343b0af46fde5820216610fd42", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe674481571e9a677a677822ed8ea126abe134be7d83afc158cdae9815f5bd56c01ee20184e0822d29c8f54e552530dcd0b6ee1e3a4a0c9b97ebe5bebd33553b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a125555092595a767a84d461d65f3570b96e4ccd9f6fb2cf82018b56b6540de371aabc16b09c4890d629c7d0a9f16b1320ea74f8fd008a802471ca7078f1a755", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3144d241b1dc53308c150af7f8f82c6c40b57205a9d0313b30beb693c21d9212282a55c56f817ea2ee429507163fdaf5749de6eb6708b60516e25b89fa4b717e"} 04:59:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:59:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:59:40 INFO - Contents: 04:59:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3500944a2fd3a1c0998549625b43fa795866a9b85f38dc9c429f3b8bedd2a1ca72ea5ff19fb5acc8054506fe10b9b979f94a19343b0af46fde5820216610fd42", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe674481571e9a677a677822ed8ea126abe134be7d83afc158cdae9815f5bd56c01ee20184e0822d29c8f54e552530dcd0b6ee1e3a4a0c9b97ebe5bebd33553b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a125555092595a767a84d461d65f3570b96e4ccd9f6fb2cf82018b56b6540de371aabc16b09c4890d629c7d0a9f16b1320ea74f8fd008a802471ca7078f1a755", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3144d241b1dc53308c150af7f8f82c6c40b57205a9d0313b30beb693c21d9212282a55c56f817ea2ee429507163fdaf5749de6eb6708b60516e25b89fa4b717e"} 04:59:40 INFO - Running post-run listener: copy_logs_to_upload_dir 04:59:40 INFO - Copying logs to upload dir... 04:59:40 INFO - mkdir: /builds/slave/test/build/upload/logs 04:59:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.277239 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-05-01 04:59:40.745204) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-01 04:59:40.748550) ========= 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.yCLwXbMYMB/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.mXD4E7eWEY/Listeners TMPDIR=/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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/3500944a2fd3a1c0998549625b43fa795866a9b85f38dc9c429f3b8bedd2a1ca72ea5ff19fb5acc8054506fe10b9b979f94a19343b0af46fde5820216610fd42", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe674481571e9a677a677822ed8ea126abe134be7d83afc158cdae9815f5bd56c01ee20184e0822d29c8f54e552530dcd0b6ee1e3a4a0c9b97ebe5bebd33553b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a125555092595a767a84d461d65f3570b96e4ccd9f6fb2cf82018b56b6540de371aabc16b09c4890d629c7d0a9f16b1320ea74f8fd008a802471ca7078f1a755", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3144d241b1dc53308c150af7f8f82c6c40b57205a9d0313b30beb693c21d9212282a55c56f817ea2ee429507163fdaf5749de6eb6708b60516e25b89fa4b717e"} build_url:https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011155 build_url: 'https://queue.taskcluster.net/v1/task/SaXEXgWvT22CBBqFI7QrYA/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/3500944a2fd3a1c0998549625b43fa795866a9b85f38dc9c429f3b8bedd2a1ca72ea5ff19fb5acc8054506fe10b9b979f94a19343b0af46fde5820216610fd42", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe674481571e9a677a677822ed8ea126abe134be7d83afc158cdae9815f5bd56c01ee20184e0822d29c8f54e552530dcd0b6ee1e3a4a0c9b97ebe5bebd33553b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a125555092595a767a84d461d65f3570b96e4ccd9f6fb2cf82018b56b6540de371aabc16b09c4890d629c7d0a9f16b1320ea74f8fd008a802471ca7078f1a755", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3144d241b1dc53308c150af7f8f82c6c40b57205a9d0313b30beb693c21d9212282a55c56f817ea2ee429507163fdaf5749de6eb6708b60516e25b89fa4b717e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-01 04:59:40.784095) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 04:59:40.784422) ========= 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.yCLwXbMYMB/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.mXD4E7eWEY/Listeners TMPDIR=/var/folders/hb/llxgk70n58q_fcntkch5rymc00000w/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.005216 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 04:59:40.832913) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-01 04:59:40.833245) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-01 04:59:40.833568) ========= ========= Total master_lag: 0.19 =========