builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0203 starttime: 1492508858.32 results: success (0) buildid: 20170418012046 builduid: 31ff4e31b21a4870a40f6367df29ca4f revision: 92f94fc0993bcba7ac34cae4c0e82b06012bcd91 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-18 02:47:38.320252) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-18 02:47:38.320717) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-18 02:47:38.320995) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-18 02:47:38.347132) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 02:47:38.347444) ========= 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.ZmCJz7xugu/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.Am0xwANu7j/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-18 02:47:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.60M=0.001s 2017-04-18 02:47:38 (9.60 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129033 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 02:47:38.501650) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 02:47:38.502040) ========= 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.ZmCJz7xugu/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.Am0xwANu7j/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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.022463 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 02:47:38.551765) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-18 02:47:38.552185) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 92f94fc0993bcba7ac34cae4c0e82b06012bcd91 --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 92f94fc0993bcba7ac34cae4c0e82b06012bcd91 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZmCJz7xugu/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.Am0xwANu7j/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-18 02:47:38,640 truncating revision to first 12 chars 2017-04-18 02:47:38,640 Setting DEBUG logging. 2017-04-18 02:47:38,641 attempt 1/10 2017-04-18 02:47:38,641 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/92f94fc0993b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-18 02:47:40,419 unpacking tar archive at: mozilla-central-92f94fc0993b/testing/mozharness/ program finished with exit code 0 elapsedTime=2.043914 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-18 02:47:40.620445) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-18 02:47:40.620809) ========= script_repo_revision: 92f94fc0993bcba7ac34cae4c0e82b06012bcd91 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-18 02:47:40.621216) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-18 02:47:40.621481) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-18 02:47:40.641372) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-04-18 02:47:40.641775) ========= /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.ZmCJz7xugu/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.Am0xwANu7j/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 02:47:40 INFO - MultiFileLogger online at 20170418 02:47:40 in /builds/slave/test 02:47:40 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 02:47:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:47:40 INFO - {'append_to_log': False, 02:47:40 INFO - 'base_work_dir': '/builds/slave/test', 02:47:40 INFO - 'blob_upload_branch': 'Firefox', 02:47:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:47:40 INFO - 'branch': 'Firefox', 02:47:40 INFO - 'buildbot_json_path': 'buildprops.json', 02:47:40 INFO - 'config_files': ('talos/mac_config.py',), 02:47:40 INFO - 'default_actions': ('clobber', 02:47:40 INFO - 'read-buildbot-config', 02:47:40 INFO - 'download-and-extract', 02:47:40 INFO - 'populate-webroot', 02:47:40 INFO - 'create-virtualenv', 02:47:40 INFO - 'install', 02:47:40 INFO - 'run-tests'), 02:47:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:47:40 INFO - 'download_minidump_stackwalk': True, 02:47:40 INFO - 'download_symbols': 'ondemand', 02:47:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:47:40 INFO - 'tooltool.py': '/tools/tooltool.py', 02:47:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:47:40 INFO - '/tools/misc-python/virtualenv.py')}, 02:47:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:47:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:47:40 INFO - 'gecko_profile': False, 02:47:40 INFO - 'gecko_profile_interval': 0, 02:47:40 INFO - 'installer_path': 'installer.exe', 02:47:40 INFO - 'log_level': 'info', 02:47:40 INFO - 'log_name': 'talos', 02:47:40 INFO - 'log_to_console': True, 02:47:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:47:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:47:40 INFO - 'opt_config_files': (), 02:47:40 INFO - 'pip_index': False, 02:47:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:47:40 INFO - 'cmd': ('bash', 02:47:40 INFO - '-c', 02:47:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:47:40 INFO - 'enabled': True, 02:47:40 INFO - 'halt_on_failure': False, 02:47:40 INFO - 'name': 'check_screen_resolution'},), 02:47:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:47:40 INFO - 'cmd': ('bash', 02:47:40 INFO - '-c', 02:47:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:47:40 INFO - 'enabled': True, 02:47:40 INFO - 'halt_on_failure': False, 02:47:40 INFO - 'name': 'check_screen_resolution'},), 02:47:40 INFO - 'run_cmd_checks_enabled': True, 02:47:40 INFO - 'suite': 'dromaeojs', 02:47:40 INFO - 'system_bits': '32', 02:47:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:47:40 INFO - 'title': 't-yosemite-r7-0203', 02:47:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:47:40 INFO - 'use_talos_json': True, 02:47:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:47:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:47:40 INFO - 'work_dir': 'build'} 02:47:40 INFO - [mozharness: 2017-04-18 09:47:40.849312Z] Running clobber step. 02:47:40 INFO - Running pre-action listener: _resource_record_pre_action 02:47:40 INFO - Running main action method: clobber 02:47:40 INFO - rmtree: /builds/slave/test/build 02:47:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:47:41 INFO - Running post-action listener: _resource_record_post_action 02:47:41 INFO - [mozharness: 2017-04-18 09:47:41.559458Z] Finished clobber step (success) 02:47:41 INFO - [mozharness: 2017-04-18 09:47:41.559667Z] Running read-buildbot-config step. 02:47:41 INFO - Running pre-action listener: _resource_record_pre_action 02:47:41 INFO - Running main action method: read_buildbot_config 02:47:41 INFO - Using buildbot properties: 02:47:41 INFO - { 02:47:41 INFO - "project": "", 02:47:41 INFO - "product": "firefox", 02:47:41 INFO - "script_repo_revision": "production", 02:47:41 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 02:47:41 INFO - "repository": "", 02:47:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 02:47:41 INFO - "buildid": "20170418012046", 02:47:41 INFO - "pgo_build": "False", 02:47:41 INFO - "basedir": "/builds/slave/test", 02:47:41 INFO - "buildnumber": 99, 02:47:41 INFO - "slavename": "t-yosemite-r7-0203", 02:47:41 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 02:47:41 INFO - "platform": "yosemite_r7", 02:47:41 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 02:47:41 INFO - "branch": "mozilla-central", 02:47:41 INFO - "repo_path": "mozilla-central", 02:47:41 INFO - "revision": "92f94fc0993bcba7ac34cae4c0e82b06012bcd91", 02:47:41 INFO - "stage_platform": "macosx64", 02:47:41 INFO - "builduid": "31ff4e31b21a4870a40f6367df29ca4f", 02:47:41 INFO - "slavebuilddir": "test" 02:47:41 INFO - } 02:47:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/URdcIZuiTimOBMVGo9sgVg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 02:47:41 INFO - Running post-action listener: _resource_record_post_action 02:47:41 INFO - [mozharness: 2017-04-18 09:47:41.564465Z] Finished read-buildbot-config step (success) 02:47:41 INFO - [mozharness: 2017-04-18 09:47:41.564605Z] Running download-and-extract step. 02:47:41 INFO - Running pre-action listener: _resource_record_pre_action 02:47:41 INFO - Running main action method: download_and_extract 02:47:41 INFO - mkdir: /builds/slave/test/build/tests 02:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:47:41 INFO - trying https://queue.taskcluster.net/v1/task/URdcIZuiTimOBMVGo9sgVg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 02:47:41 INFO - Downloading https://queue.taskcluster.net/v1/task/URdcIZuiTimOBMVGo9sgVg/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 02:47:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/URdcIZuiTimOBMVGo9sgVg/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 02:47:42 INFO - Downloaded 1325 bytes. 02:47:42 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 02:47:42 INFO - Using the following test package requirements: 02:47:42 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:47:42 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 02:47:42 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 02:47:42 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:47:42 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 02:47:42 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:47:42 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 02:47:42 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:47:42 INFO - u'jsshell-mac.zip'], 02:47:42 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:47:42 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 02:47:42 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 02:47:42 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:47:42 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 02:47:42 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:47:42 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 02:47:42 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:47:42 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 02:47:42 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:47:42 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 02:47:42 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:47:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/URdcIZuiTimOBMVGo9sgVg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 02:47:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/URdcIZuiTimOBMVGo9sgVg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:47:42 INFO - Fetch https://queue.taskcluster.net/v1/task/URdcIZuiTimOBMVGo9sgVg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 02:47:44 INFO - Expected file size: 52625965 02:47:44 INFO - Obtained file size: 52625965 02:48:01 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 02:48:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/URdcIZuiTimOBMVGo9sgVg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 02:48:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/URdcIZuiTimOBMVGo9sgVg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:48:01 INFO - Fetch https://queue.taskcluster.net/v1/task/URdcIZuiTimOBMVGo9sgVg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 02:48:02 INFO - Expected file size: 52625965 02:48:02 INFO - Obtained file size: 52625965 02:48:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/URdcIZuiTimOBMVGo9sgVg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 02:48:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/URdcIZuiTimOBMVGo9sgVg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 02:48:18 INFO - Fetch https://queue.taskcluster.net/v1/task/URdcIZuiTimOBMVGo9sgVg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 02:48:19 INFO - Expected file size: 14408802 02:48:19 INFO - Obtained file size: 14408802 02:48:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:19 INFO - trying https://queue.taskcluster.net/v1/task/URdcIZuiTimOBMVGo9sgVg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 02:48:19 INFO - Downloading https://queue.taskcluster.net/v1/task/URdcIZuiTimOBMVGo9sgVg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 02:48:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/URdcIZuiTimOBMVGo9sgVg/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 02:48:21 INFO - Downloaded 71363923 bytes. 02:48:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/URdcIZuiTimOBMVGo9sgVg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 02:48:21 INFO - mkdir: /builds/slave/test/properties 02:48:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:48:21 INFO - Writing to file /builds/slave/test/properties/build_url 02:48:21 INFO - Contents: 02:48:21 INFO - build_url:https://queue.taskcluster.net/v1/task/URdcIZuiTimOBMVGo9sgVg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 02:48:22 INFO - Running post-action listener: _resource_record_post_action 02:48:22 INFO - Running post-action listener: set_extra_try_arguments 02:48:22 INFO - [mozharness: 2017-04-18 09:48:22.354273Z] Finished download-and-extract step (success) 02:48:22 INFO - [mozharness: 2017-04-18 09:48:22.354416Z] Running populate-webroot step. 02:48:22 INFO - Running pre-action listener: _resource_record_pre_action 02:48:22 INFO - Running main action method: populate_webroot 02:48:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:48:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:48:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:48:22 INFO - '--tppagecycles', 02:48:22 INFO - '7'], 02:48:22 INFO - 'tests': ['tsvgm']}}, 02:48:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:48:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:48:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:48:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:48:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:48:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:48:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:48:22 INFO - 'talos_options': ['--disable-e10s'], 02:48:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:48:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:48:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:48:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:48:22 INFO - 'talos_options': ['--disable-e10s'], 02:48:22 INFO - 'tests': ['damp', 'tps']}, 02:48:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:48:22 INFO - 'tests': ['damp', 'tps']}, 02:48:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:48:22 INFO - 'tests': ['dromaeo_dom']}, 02:48:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:48:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:48:22 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:48:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:48:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:48:22 INFO - 'tests': ['a11yr', 02:48:22 INFO - 'ts_paint', 02:48:22 INFO - 'tpaint', 02:48:22 INFO - 'sessionrestore', 02:48:22 INFO - 'sessionrestore_no_auto_restore', 02:48:22 INFO - 'tabpaint']}, 02:48:22 INFO - 'other-e10s': {'tests': ['a11yr', 02:48:22 INFO - 'ts_paint', 02:48:22 INFO - 'tpaint', 02:48:22 INFO - 'sessionrestore', 02:48:22 INFO - 'sessionrestore_no_auto_restore', 02:48:22 INFO - 'tabpaint']}, 02:48:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:48:22 INFO - 'ts_paint', 02:48:22 INFO - 'tpaint', 02:48:22 INFO - 'sessionrestore', 02:48:22 INFO - 'sessionrestore_no_auto_restore', 02:48:22 INFO - 'tabpaint']}, 02:48:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:48:22 INFO - 'ts_paint', 02:48:22 INFO - 'tpaint', 02:48:22 INFO - 'sessionrestore', 02:48:22 INFO - 'sessionrestore_no_auto_restore', 02:48:22 INFO - 'tabpaint']}, 02:48:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:48:22 INFO - 'tests': ['a11yr', 02:48:22 INFO - 'ts_paint', 02:48:22 INFO - 'tpaint', 02:48:22 INFO - 'sessionrestore', 02:48:22 INFO - 'sessionrestore_no_auto_restore', 02:48:22 INFO - 'tabpaint']}, 02:48:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:48:22 INFO - 'tests': ['a11yr', 02:48:22 INFO - 'ts_paint', 02:48:22 INFO - 'tpaint', 02:48:22 INFO - 'sessionrestore', 02:48:22 INFO - 'sessionrestore_no_auto_restore', 02:48:22 INFO - 'tabpaint']}, 02:48:22 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 02:48:22 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 02:48:22 INFO - 'bloom_basic_ref']}, 02:48:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:48:22 INFO - 'tests': ['tsvgx', 02:48:22 INFO - 'tsvgr_opacity', 02:48:22 INFO - 'tart', 02:48:22 INFO - 'tscrollx', 02:48:22 INFO - 'cart', 02:48:22 INFO - 'tsvg_static']}, 02:48:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:48:22 INFO - 'tsvgr_opacity', 02:48:22 INFO - 'tart', 02:48:22 INFO - 'tscrollx', 02:48:22 INFO - 'cart', 02:48:22 INFO - 'tsvg_static']}, 02:48:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:48:22 INFO - 'talos_options': ['--disable-e10s'], 02:48:22 INFO - 'tests': ['tp5o']}, 02:48:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:48:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:48:22 INFO - 'talos_options': ['--disable-e10s', 02:48:22 INFO - '--xperf_path', 02:48:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:48:22 INFO - 'tests': ['tp5n']}, 02:48:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:48:22 INFO - 'talos_options': ['--xperf_path', 02:48:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:48:22 INFO - 'tests': ['tp5n']}}, 02:48:22 INFO - 'talos.zip': {'path': '', 02:48:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:48:22 INFO - Running post-action listener: _resource_record_post_action 02:48:22 INFO - [mozharness: 2017-04-18 09:48:22.373681Z] Finished populate-webroot step (success) 02:48:22 INFO - [mozharness: 2017-04-18 09:48:22.373823Z] Running create-virtualenv step. 02:48:22 INFO - Running pre-action listener: _resource_record_pre_action 02:48:22 INFO - Running main action method: create_virtualenv 02:48:22 INFO - Creating virtualenv /builds/slave/test/build/venv 02:48:22 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 02:48:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:48:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:48:22 INFO - Using real prefix '/tools/python27' 02:48:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:48:23 INFO - Installing distribute.............................................................................................................................................................................................done. 02:48:26 INFO - Installing pip.................done. 02:48:26 INFO - Return code: 0 02:48:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:48:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:48:26 INFO - Reading from file tmpfile_stdout 02:48:26 INFO - Output received: 02:48:26 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) 02:48:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c1f8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1fb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b1d79840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfd6d30>, '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 0x10befcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfcbbe8>, '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.ZmCJz7xugu/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.Am0xwANu7j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 02:48:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:48:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:48:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZmCJz7xugu/Render', 02:48:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:26 INFO - 'HOME': '/Users/cltbld', 02:48:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:26 INFO - 'LOGNAME': 'cltbld', 02:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:26 INFO - 'MOZ_NO_REMOTE': '1', 02:48:26 INFO - 'NO_EM_RESTART': '1', 02:48:26 INFO - 'PAGER': '/bin/cat', 02:48:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:26 INFO - 'PWD': '/builds/slave/test', 02:48:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:26 INFO - 'SHELL': '/bin/bash', 02:48:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Am0xwANu7j/Listeners', 02:48:26 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 02:48:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:26 INFO - 'USER': 'cltbld', 02:48:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:26 INFO - 'XPC_FLAGS': '0x0', 02:48:26 INFO - 'XPC_SERVICE_NAME': '0', 02:48:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:26 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 02:48:26 INFO - Cleaning up... 02:48:26 INFO - Return code: 0 02:48:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c1f8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1fb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b1d79840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfd6d30>, '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 0x10befcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfcbbe8>, '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.ZmCJz7xugu/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.Am0xwANu7j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 02:48:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:48:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:48:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZmCJz7xugu/Render', 02:48:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:26 INFO - 'HOME': '/Users/cltbld', 02:48:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:26 INFO - 'LOGNAME': 'cltbld', 02:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:26 INFO - 'MOZ_NO_REMOTE': '1', 02:48:26 INFO - 'NO_EM_RESTART': '1', 02:48:26 INFO - 'PAGER': '/bin/cat', 02:48:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:26 INFO - 'PWD': '/builds/slave/test', 02:48:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:26 INFO - 'SHELL': '/bin/bash', 02:48:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Am0xwANu7j/Listeners', 02:48:26 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 02:48:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:26 INFO - 'USER': 'cltbld', 02:48:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:26 INFO - 'XPC_FLAGS': '0x0', 02:48:26 INFO - 'XPC_SERVICE_NAME': '0', 02:48:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:26 INFO - Downloading/unpacking psutil>=3.1.1 02:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:48:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:48:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:48:30 INFO - Installing collected packages: psutil 02:48:30 INFO - Running setup.py install for psutil 02:48:30 INFO - building 'psutil._psutil_osx' extension 02:48:30 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 02:48:31 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 02:48:31 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 02:48:31 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 02:48:31 INFO - building 'psutil._psutil_posix' extension 02:48:31 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 02:48:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:48:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:48:31 INFO - ^ 02:48:31 INFO - 1 warning generated. 02:48:31 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 02:48:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:48:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:48:31 INFO - Successfully installed psutil 02:48:31 INFO - Cleaning up... 02:48:31 INFO - Return code: 0 02:48:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:48:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c1f8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1fb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b1d79840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfd6d30>, '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 0x10befcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfcbbe8>, '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.ZmCJz7xugu/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.Am0xwANu7j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 02:48:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:48:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:48:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZmCJz7xugu/Render', 02:48:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:31 INFO - 'HOME': '/Users/cltbld', 02:48:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:31 INFO - 'LOGNAME': 'cltbld', 02:48:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:31 INFO - 'MOZ_NO_REMOTE': '1', 02:48:31 INFO - 'NO_EM_RESTART': '1', 02:48:31 INFO - 'PAGER': '/bin/cat', 02:48:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:31 INFO - 'PWD': '/builds/slave/test', 02:48:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:31 INFO - 'SHELL': '/bin/bash', 02:48:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Am0xwANu7j/Listeners', 02:48:31 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 02:48:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:31 INFO - 'USER': 'cltbld', 02:48:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:31 INFO - 'XPC_FLAGS': '0x0', 02:48:31 INFO - 'XPC_SERVICE_NAME': '0', 02:48:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:48:31 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 02:48:31 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 02:48:31 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 02:48:31 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 02:48:31 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 02:48:31 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 02:48:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:48:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:48:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:48:34 INFO - Installing collected packages: mozsystemmonitor 02:48:34 INFO - Running setup.py install for mozsystemmonitor 02:48:34 INFO - Successfully installed mozsystemmonitor 02:48:34 INFO - Cleaning up... 02:48:34 INFO - Return code: 0 02:48:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:48: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')]} 02:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:35 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')]} 02:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:35 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 0x10c1f8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1fb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b1d79840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfd6d30>, '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 0x10befcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfcbbe8>, '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.ZmCJz7xugu/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.Am0xwANu7j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 02:48:35 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 02:48:35 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 02:48:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZmCJz7xugu/Render', 02:48:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:36 INFO - 'HOME': '/Users/cltbld', 02:48:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:36 INFO - 'LOGNAME': 'cltbld', 02:48:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:36 INFO - 'MOZ_NO_REMOTE': '1', 02:48:36 INFO - 'NO_EM_RESTART': '1', 02:48:36 INFO - 'PAGER': '/bin/cat', 02:48:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:36 INFO - 'PWD': '/builds/slave/test', 02:48:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:36 INFO - 'SHELL': '/bin/bash', 02:48:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Am0xwANu7j/Listeners', 02:48:36 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 02:48:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:36 INFO - 'USER': 'cltbld', 02:48:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:36 INFO - 'XPC_FLAGS': '0x0', 02:48:36 INFO - 'XPC_SERVICE_NAME': '0', 02:48:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:36 INFO - Downloading/unpacking jsonschema==2.5.1 02:48:36 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 02:48:36 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 02:48:36 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 02:48:36 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 02:48:36 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 02:48:36 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 02:48:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:48:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:48:39 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 02:48:39 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 02:48:39 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 02:48:39 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 02:48:39 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 02:48:39 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 02:48:39 INFO - Downloading functools32-3.2.3-2.tar.gz 02:48:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:48:39 INFO - warning: no files found matching '*.txt' 02:48:39 INFO - no previously-included directories found matching 'build' 02:48:39 INFO - no previously-included directories found matching 'dist' 02:48:39 INFO - no previously-included directories found matching '.git*' 02:48:39 INFO - Installing collected packages: jsonschema, functools32 02:48:39 INFO - Running setup.py install for functools32 02:48:39 INFO - warning: no files found matching '*.txt' 02:48:39 INFO - no previously-included directories found matching 'build' 02:48:39 INFO - no previously-included directories found matching 'dist' 02:48:39 INFO - no previously-included directories found matching '.git*' 02:48:39 INFO - Successfully installed jsonschema functools32 02:48:39 INFO - Cleaning up... 02:48:39 INFO - Return code: 0 02:48:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:48:39 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')]} 02:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:39 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')]} 02:48:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:39 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 0x10c1f8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1fb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b1d79840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfd6d30>, '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 0x10befcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfcbbe8>, '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.ZmCJz7xugu/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.Am0xwANu7j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 02:48:39 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 02:48:39 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 02:48:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZmCJz7xugu/Render', 02:48:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:39 INFO - 'HOME': '/Users/cltbld', 02:48:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:39 INFO - 'LOGNAME': 'cltbld', 02:48:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:39 INFO - 'MOZ_NO_REMOTE': '1', 02:48:39 INFO - 'NO_EM_RESTART': '1', 02:48:39 INFO - 'PAGER': '/bin/cat', 02:48:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:39 INFO - 'PWD': '/builds/slave/test', 02:48:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:39 INFO - 'SHELL': '/bin/bash', 02:48:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Am0xwANu7j/Listeners', 02:48:39 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 02:48:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:39 INFO - 'USER': 'cltbld', 02:48:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:39 INFO - 'XPC_FLAGS': '0x0', 02:48:39 INFO - 'XPC_SERVICE_NAME': '0', 02:48:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:48:40 INFO - Cleaning up... 02:48:40 INFO - Return code: 0 02:48:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:48:40 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')]} 02:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:40 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')]} 02:48:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:40 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 0x10c1f8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1fb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b1d79840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfd6d30>, '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 0x10befcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfcbbe8>, '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.ZmCJz7xugu/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.Am0xwANu7j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 02:48:40 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 02:48:40 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 02:48:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZmCJz7xugu/Render', 02:48:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:40 INFO - 'HOME': '/Users/cltbld', 02:48:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:40 INFO - 'LOGNAME': 'cltbld', 02:48:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:40 INFO - 'MOZ_NO_REMOTE': '1', 02:48:40 INFO - 'NO_EM_RESTART': '1', 02:48:40 INFO - 'PAGER': '/bin/cat', 02:48:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:40 INFO - 'PWD': '/builds/slave/test', 02:48:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:40 INFO - 'SHELL': '/bin/bash', 02:48:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Am0xwANu7j/Listeners', 02:48:40 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 02:48:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:40 INFO - 'USER': 'cltbld', 02:48:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:40 INFO - 'XPC_FLAGS': '0x0', 02:48:40 INFO - 'XPC_SERVICE_NAME': '0', 02:48:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:40 INFO - Downloading/unpacking blobuploader==1.2.4 02:48:40 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 02:48:40 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 02:48:40 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 02:48:40 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 02:48:40 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 02:48:40 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 02:48:43 INFO - Downloading blobuploader-1.2.4.tar.gz 02:48:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:48:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:48:43 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 02:48:43 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 02:48:43 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 02:48:43 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 02:48:43 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 02:48:43 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 02:48:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:48:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:48:43 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 02:48:43 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 02:48:43 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 02:48:43 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 02:48:43 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 02:48:43 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 02:48:44 INFO - Downloading docopt-0.6.1.tar.gz 02:48:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:48:44 INFO - Installing collected packages: blobuploader, requests, docopt 02:48:44 INFO - Running setup.py install for blobuploader 02:48:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:48:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:48:44 INFO - Running setup.py install for requests 02:48:45 INFO - Running setup.py install for docopt 02:48:45 INFO - Successfully installed blobuploader requests docopt 02:48:45 INFO - Cleaning up... 02:48:45 INFO - Return code: 0 02:48:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:45 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 0x10c1f8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1fb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b1d79840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfd6d30>, '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 0x10befcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfcbbe8>, '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.ZmCJz7xugu/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.Am0xwANu7j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 02:48:45 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 02:48:45 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 02:48:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZmCJz7xugu/Render', 02:48:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:45 INFO - 'HOME': '/Users/cltbld', 02:48:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:45 INFO - 'LOGNAME': 'cltbld', 02:48:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:45 INFO - 'MOZ_NO_REMOTE': '1', 02:48:45 INFO - 'NO_EM_RESTART': '1', 02:48:45 INFO - 'PAGER': '/bin/cat', 02:48:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:45 INFO - 'PWD': '/builds/slave/test', 02:48:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:45 INFO - 'SHELL': '/bin/bash', 02:48:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Am0xwANu7j/Listeners', 02:48:45 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 02:48:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:45 INFO - 'USER': 'cltbld', 02:48:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:45 INFO - 'XPC_FLAGS': '0x0', 02:48:45 INFO - 'XPC_SERVICE_NAME': '0', 02:48:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:48:45 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-nVQHet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:48:45 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-uVjmbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:48:45 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-MEZYUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:48:45 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-IlMVZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:48:45 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-6NCnn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:48:46 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-UVPn8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:48:46 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-Fth_Bm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:48:46 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-y3blxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:48:46 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-0DIWtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:48:46 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-ZGgr_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:48:46 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-VTES2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:48:46 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-tiqAX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:48:46 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-h587J3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:48:46 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-BhQWVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:47 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-rXRJys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:48:47 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-MIzXdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:48:47 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-jkuDIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:48:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:48:47 INFO - Running setup.py install for manifestparser 02:48:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:48:47 INFO - Running setup.py install for mozcrash 02:48:47 INFO - Running setup.py install for mozdebug 02:48:47 INFO - Running setup.py install for mozdevice 02:48:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:48:47 INFO - Running setup.py install for mozfile 02:48:48 INFO - Running setup.py install for mozhttpd 02:48:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:48:48 INFO - Running setup.py install for mozinfo 02:48:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:48:48 INFO - Running setup.py install for mozInstall 02:48:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:48:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:48:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:48:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:48:48 INFO - Running setup.py install for mozleak 02:48:48 INFO - Running setup.py install for mozlog 02:48:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:48:48 INFO - Running setup.py install for moznetwork 02:48:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:48:48 INFO - Running setup.py install for mozprocess 02:48:49 INFO - Running setup.py install for mozprofile 02:48:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:48:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:48:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:48:49 INFO - Running setup.py install for mozrunner 02:48:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:48:49 INFO - Running setup.py install for mozscreenshot 02:48:49 INFO - Running setup.py install for moztest 02:48:49 INFO - Running setup.py install for mozversion 02:48:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:48:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:48:49 INFO - Cleaning up... 02:48:49 INFO - Return code: 0 02:48:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:49 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 0x10c1f8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1fb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b1d79840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfd6d30>, '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 0x10befcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfcbbe8>, '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.ZmCJz7xugu/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.Am0xwANu7j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 02:48:49 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 02:48:49 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 02:48:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZmCJz7xugu/Render', 02:48:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:49 INFO - 'HOME': '/Users/cltbld', 02:48:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:49 INFO - 'LOGNAME': 'cltbld', 02:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:49 INFO - 'MOZ_NO_REMOTE': '1', 02:48:49 INFO - 'NO_EM_RESTART': '1', 02:48:49 INFO - 'PAGER': '/bin/cat', 02:48:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:49 INFO - 'PWD': '/builds/slave/test', 02:48:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:49 INFO - 'SHELL': '/bin/bash', 02:48:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Am0xwANu7j/Listeners', 02:48:49 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 02:48:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:49 INFO - 'USER': 'cltbld', 02:48:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:49 INFO - 'XPC_FLAGS': '0x0', 02:48:49 INFO - 'XPC_SERVICE_NAME': '0', 02:48:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:48:50 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-5x3hOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:48:50 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)) 02:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:48:50 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-VvNY2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:48:50 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)) 02:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:48:50 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-079Kvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:48:50 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)) 02:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:48:50 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-Xy1Soq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:48:50 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)) 02:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:48:50 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-d6AQ0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:48:50 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)) 02:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:48:50 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-RvElKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:48:50 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)) 02:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:48:50 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-ACmPqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:48:50 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)) 02:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:48:50 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-cZsK6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:48:51 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)) 02:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:48:51 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-u4deMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:48:51 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)) 02:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:48:51 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-PTyeAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:48:51 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)) 02:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:48:51 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-ydWC9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:48:51 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)) 02:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:48:51 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-JkAL1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:48:51 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)) 02:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:48:51 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-uvLLRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:48:51 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)) 02:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:48:51 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-oJ_d6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:48:51 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)) 02:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:51 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-B5cXys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:51 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)) 02:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:48:51 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-sZIASw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:48:51 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)) 02:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:48:51 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-vfJVxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:48:51 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)) 02:48:51 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)) 02:48:51 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)) 02:48:51 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)) 02:48:51 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)) 02:48:51 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)) 02:48:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:54 INFO - Downloading blessings-1.6.tar.gz 02:48:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:48:54 INFO - Installing collected packages: blessings 02:48:54 INFO - Running setup.py install for blessings 02:48:54 INFO - Successfully installed blessings 02:48:54 INFO - Cleaning up... 02:48:54 INFO - Return code: 0 02:48:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:48:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:48:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:48:55 INFO - Reading from file tmpfile_stdout 02:48:55 INFO - Current package versions: 02:48:55 INFO - blessings == 1.6 02:48:55 INFO - blobuploader == 1.2.4 02:48:55 INFO - docopt == 0.6.1 02:48:55 INFO - functools32 == 3.2.3-2 02:48:55 INFO - jsonschema == 2.5.1 02:48:55 INFO - manifestparser == 1.1 02:48:55 INFO - mozInstall == 1.12 02:48:55 INFO - mozcrash == 1.0 02:48:55 INFO - mozdebug == 0.1 02:48:55 INFO - mozdevice == 0.50 02:48:55 INFO - mozfile == 1.2 02:48:55 INFO - mozhttpd == 0.7 02:48:55 INFO - mozinfo == 0.9 02:48:55 INFO - mozleak == 0.1 02:48:55 INFO - mozlog == 3.4 02:48:55 INFO - moznetwork == 0.27 02:48:55 INFO - mozprocess == 0.25 02:48:55 INFO - mozprofile == 0.28 02:48:55 INFO - mozrunner == 6.13 02:48:55 INFO - mozscreenshot == 0.1 02:48:55 INFO - mozsystemmonitor == 0.3 02:48:55 INFO - moztest == 0.8 02:48:55 INFO - mozversion == 1.4 02:48:55 INFO - psutil == 3.1.1 02:48:55 INFO - requests == 1.2.3 02:48:55 INFO - wsgiref == 0.1.2 02:48:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:55 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 0x10c1f8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1fb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b1d79840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfd6d30>, '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 0x10befcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfcbbe8>, '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.ZmCJz7xugu/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.Am0xwANu7j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 02:48:55 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 02:48:55 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 02:48:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZmCJz7xugu/Render', 02:48:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:55 INFO - 'HOME': '/Users/cltbld', 02:48:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:55 INFO - 'LOGNAME': 'cltbld', 02:48:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:55 INFO - 'MOZ_NO_REMOTE': '1', 02:48:55 INFO - 'NO_EM_RESTART': '1', 02:48:55 INFO - 'PAGER': '/bin/cat', 02:48:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:55 INFO - 'PWD': '/builds/slave/test', 02:48:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:55 INFO - 'SHELL': '/bin/bash', 02:48:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Am0xwANu7j/Listeners', 02:48:55 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 02:48:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:55 INFO - 'USER': 'cltbld', 02:48:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:55 INFO - 'XPC_FLAGS': '0x0', 02:48:55 INFO - 'XPC_SERVICE_NAME': '0', 02:48:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:55 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)) 02:48:55 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)) 02:48:55 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)) 02:48:55 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)) 02:48:55 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)) 02:48:55 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)) 02:48:55 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)) 02:48:55 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)) 02:48:55 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)) 02:48:55 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)) 02:48:55 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)) 02:48:55 INFO - Cleaning up... 02:48:55 INFO - Return code: 0 02:48:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:48:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c1f8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1fb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b1d79840>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfd6d30>, '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 0x10befcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfcbbe8>, '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.ZmCJz7xugu/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.Am0xwANu7j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 02:48:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:48:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:48:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZmCJz7xugu/Render', 02:48:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:55 INFO - 'HOME': '/Users/cltbld', 02:48:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:55 INFO - 'LOGNAME': 'cltbld', 02:48:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:55 INFO - 'MOZ_NO_REMOTE': '1', 02:48:55 INFO - 'NO_EM_RESTART': '1', 02:48:55 INFO - 'PAGER': '/bin/cat', 02:48:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:55 INFO - 'PWD': '/builds/slave/test', 02:48:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:55 INFO - 'SHELL': '/bin/bash', 02:48:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Am0xwANu7j/Listeners', 02:48:55 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 02:48:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:55 INFO - 'USER': 'cltbld', 02:48:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:55 INFO - 'XPC_FLAGS': '0x0', 02:48:55 INFO - 'XPC_SERVICE_NAME': '0', 02:48:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:48:55 INFO - Cleaning up... 02:48:55 INFO - Return code: 0 02:48:55 INFO - Running post-action listener: _resource_record_post_action 02:48:55 INFO - Running post-action listener: _start_resource_monitoring 02:48:55 INFO - Starting resource monitoring. 02:48:55 INFO - [mozharness: 2017-04-18 09:48:55.780601Z] Finished create-virtualenv step (success) 02:48:55 INFO - [mozharness: 2017-04-18 09:48:55.781640Z] Running install step. 02:48:55 INFO - Running pre-action listener: _resource_record_pre_action 02:48:55 INFO - Running main action method: install 02:48:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:48:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:48:56 INFO - Reading from file tmpfile_stdout 02:48:56 INFO - Detecting whether we're running mozinstall >=1.0... 02:48:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:48:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:48:56 INFO - Reading from file tmpfile_stdout 02:48:56 INFO - Output received: 02:48:56 INFO - Usage: mozinstall [options] installer 02:48:56 INFO - Options: 02:48:56 INFO - -h, --help show this help message and exit 02:48:56 INFO - -d DEST, --destination=DEST 02:48:56 INFO - Directory to install application into. [default: 02:48:56 INFO - "/builds/slave/test"] 02:48:56 INFO - --app=APP Application being installed. [default: firefox] 02:48:56 INFO - mkdir: /builds/slave/test/build/application 02:48:56 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'] 02:48:56 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 02:49:16 INFO - Reading from file tmpfile_stdout 02:49:16 INFO - Output received: 02:49:16 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:49:16 INFO - Running post-action listener: _resource_record_post_action 02:49:16 INFO - [mozharness: 2017-04-18 09:49:16.019514Z] Finished install step (success) 02:49:16 INFO - [mozharness: 2017-04-18 09:49:16.019664Z] Running run-tests step. 02:49:16 INFO - Running pre-action listener: _resource_record_pre_action 02:49:16 INFO - Running main action method: run_tests 02:49:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:49:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:49:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:49:16 INFO - 2017-04-18 02:49:16.034 screenresolution[7604:147132] starting screenresolution argv=screenresolution get 02:49:16 INFO - 2017-04-18 02:49:16.037 screenresolution[7604:147132] Display 0: 1600x1200x32@60 02:49:16 INFO - 2017-04-18 02:49:16.043 screenresolution[7605:147135] starting screenresolution argv=screenresolution list 02:49:16 INFO - Available Modes on Display 0 02:49:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:49:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:49:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:49:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:49:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:49:16 INFO - Intel Iris: 02:49:16 INFO - Chipset Model: Intel Iris 02:49:16 INFO - Type: GPU 02:49:16 INFO - Bus: Built-In 02:49:16 INFO - VRAM (Dynamic, Max): 1536 MB 02:49:16 INFO - Vendor: Intel (0x8086) 02:49:16 INFO - Device ID: 0x0a2e 02:49:16 INFO - Revision ID: 0x0009 02:49:16 INFO - Displays: 02:49:16 INFO - Display: 02:49:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:49:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:49:16 INFO - Display Serial Number: 1600x1200 60 02:49:16 INFO - Main Display: Yes 02:49:16 INFO - Mirror: Off 02:49:16 INFO - Online: Yes 02:49:16 INFO - Rotation: Supported 02:49:16 INFO - Return code: 0 02:49:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:49:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:49:16 INFO - Python 2.7.3 02:49:16 INFO - Return code: 0 02:49:16 INFO - grabbing minidump binary from tooltool 02:49:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:49:16 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 0x10bfd6d30>, '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 0x10befcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfcbbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:49:16 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 02:49:16 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 02:49:16 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 02:49:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:49:16 INFO - Return code: 0 02:49:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:49:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:49:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:49:16 INFO - ENV: RUST_BACKTRACE is now 1 02:49:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:49:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:49:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/URdcIZuiTimOBMVGo9sgVg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0203', '--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 02:49:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/URdcIZuiTimOBMVGo9sgVg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0203 --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 02:49:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZmCJz7xugu/Render', 02:49:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:49:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:49:16 INFO - 'HOME': '/Users/cltbld', 02:49:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:49:16 INFO - 'LOGNAME': 'cltbld', 02:49:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:49:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:49:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:16 INFO - 'MOZ_NO_REMOTE': '1', 02:49:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:49:16 INFO - 'NO_EM_RESTART': '1', 02:49:16 INFO - 'PAGER': '/bin/cat', 02:49:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:49:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:16 INFO - 'PWD': '/builds/slave/test', 02:49:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:49:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:49:16 INFO - 'RUST_BACKTRACE': '1', 02:49:16 INFO - 'SHELL': '/bin/bash', 02:49:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Am0xwANu7j/Listeners', 02:49:16 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 02:49:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:49:16 INFO - 'USER': 'cltbld', 02:49:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:49:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:49:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:16 INFO - 'XPC_FLAGS': '0x0', 02:49:16 INFO - 'XPC_SERVICE_NAME': '0', 02:49:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:49:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/URdcIZuiTimOBMVGo9sgVg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0203', '--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 02:49:16 INFO - mozversion application_buildid: 20170418012046 02:49:16 INFO - mozversion application_changeset: 92f94fc0993bcba7ac34cae4c0e82b06012bcd91 02:49:16 INFO - mozversion application_display_name: Nightly 02:49:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:49:16 INFO - mozversion application_name: Firefox 02:49:16 INFO - mozversion application_remotingname: firefox 02:49:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:49:16 INFO - mozversion application_vendor: Mozilla 02:49:16 INFO - mozversion application_version: 55.0a1 02:49:16 INFO - mozversion platform_buildid: 20170418012046 02:49:16 INFO - mozversion platform_changeset: 92f94fc0993bcba7ac34cae4c0e82b06012bcd91 02:49:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:49:16 INFO - mozversion platform_version: 55.0a1 02:49:16 INFO - using testdate: 1492508956 02:49:16 INFO - actual date: 1492508956 02:49:16 INFO - starting webserver on 'localhost:65105' 02:49:16 INFO - SUITE-START | Running 2 tests 02:49:16 INFO - TEST-START | dromaeo_css 02:49:16 INFO - operating with platform_type : mac_ 02:49:16 INFO - Initialising browser for dromaeo_css test... 02:49:16 INFO - TEST-INFO | started process 7615 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/tmpea8WBY/profile http://localhost:65105/getInfo.html) 02:49:19 INFO - PID 7615 | __metrics Screen width/height:1600/1200 02:49:19 INFO - PID 7615 | colorDepth:24 02:49:19 INFO - PID 7615 | Browser inner width/height: 1024/689 02:49:19 INFO - PID 7615 | __metrics 02:49:19 INFO - PID 7615 | 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" 02:49:19 INFO - PID 7615 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:49:20 INFO - TEST-INFO | 7615: exit 0 02:49:20 INFO - Browser initialized. 02:49:20 INFO - Running cycle 1/1 for dromaeo_css test... 02:49:20 INFO - TEST-INFO | started process 7617 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/tmpea8WBY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:49:32 INFO - PID 7617 | RSS: Main: 241209344 02:49:32 INFO - PID 7617 | 02:52:38 INFO - PID 7617 | Cycle 1(1): loaded http://localhost:65105/tests/dromaeo/cssquery-dojo.html (next: http://localhost:65105/tests/dromaeo/cssquery-ext.html) 02:52:40 INFO - PID 7617 | RSS: Main: 395149312 02:52:40 INFO - PID 7617 | 02:54:21 INFO - PID 7617 | ************************* 02:54:21 INFO - PID 7617 | A coding exception was thrown and uncaught in a Task. 02:54:21 INFO - PID 7617 | 02:54:21 ERROR - PID 7617 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:54:21 INFO - PID 7617 | Full stack: 02:54:21 INFO - PID 7617 | ************************* 02:54:21 INFO - PID 7617 | ************************* 02:54:21 INFO - PID 7617 | A coding exception was thrown and uncaught in a Task. 02:54:21 INFO - PID 7617 | 02:54:21 ERROR - PID 7617 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:54:21 INFO - PID 7617 | Full stack: 02:54:21 INFO - PID 7617 | ************************* 02:54:21 INFO - PID 7617 | ************************* 02:54:21 INFO - PID 7617 | A coding exception was thrown and uncaught in a Task. 02:54:21 INFO - PID 7617 | 02:54:21 ERROR - PID 7617 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:54:21 INFO - PID 7617 | Full stack: 02:54:21 INFO - PID 7617 | ************************* 02:54:21 INFO - PID 7617 | ************************* 02:54:21 INFO - PID 7617 | A coding exception was thrown and uncaught in a Task. 02:54:21 INFO - PID 7617 | 02:54:21 ERROR - PID 7617 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:54:21 INFO - PID 7617 | Full stack: 02:54:21 INFO - PID 7617 | ************************* 02:55:42 INFO - PID 7617 | Cycle 1(1): loaded http://localhost:65105/tests/dromaeo/cssquery-ext.html (next: http://localhost:65105/tests/dromaeo/cssquery-jquery.html) 02:55:43 INFO - PID 7617 | RSS: Main: 367886336 02:55:43 INFO - PID 7617 | 02:58:45 INFO - PID 7617 | Cycle 1(1): loaded http://localhost:65105/tests/dromaeo/cssquery-jquery.html (next: http://localhost:65105/tests/dromaeo/cssquery-mootools.html) 02:58:46 INFO - PID 7617 | RSS: Main: 363462656 02:58:46 INFO - PID 7617 | 03:01:48 INFO - PID 7617 | Cycle 1(1): loaded http://localhost:65105/tests/dromaeo/cssquery-mootools.html (next: http://localhost:65105/tests/dromaeo/cssquery-prototype.html) 03:01:49 INFO - PID 7617 | RSS: Main: 332554240 03:01:49 INFO - PID 7617 | 03:04:52 INFO - PID 7617 | Cycle 1(1): loaded http://localhost:65105/tests/dromaeo/cssquery-prototype.html (next: http://localhost:65105/tests/dromaeo/cssquery-yui.html) 03:04:53 INFO - PID 7617 | RSS: Main: 336404480 03:04:53 INFO - PID 7617 | 03:07:55 INFO - PID 7617 | Cycle 1(1): loaded http://localhost:65105/tests/dromaeo/cssquery-yui.html (next: http://localhost:65105/tests/dromaeo/cssquery-dojo.html) 03:07:56 INFO - PID 7617 | RSS: Main: 375742464 03:07:56 INFO - PID 7617 | 03:07:56 INFO - PID 7617 | __start_tp_report 03:07:56 INFO - PID 7617 | _x_x_mozilla_page_load 03:07:56 INFO - PID 7617 | _x_x_mozilla_page_load_details 03:07:56 INFO - PID 7617 | |i|pagename|runs| 03:07:56 INFO - PID 7617 | |0;dojo.html;2698.6896506901703;3451.344244593527;3481.234128491731;3487.2676737885045;3518.841652125654;5955.34491205967;6103.877922441554;6112.473085128069;6194.47346975507;6222.937770622298;6045.123457098718;6103.084537319404;6111.388861113886;6114.785982490614;6128.57100003;5247.86880327992;5261.4475480074425;5270.393904700951;5281.841544753664;5371.462853714617;5347.6256662033475;5351.946480535204;5368.758405871745;5370.5435038021815;5372.516473517383;5343.171808369709;5346.465353464661;5347.518723314901;5348.090824559834;5352.090144675395;5314.096603577401;5330.173823057432;5341.385740639837;5346.946530534684;5355.812546560871;5193.896122077537;5310.946890531084;5311.150215965427;5335.759890804923;5345.4387289334445;6178.443940045418;6215.1609532712955;6233.407826256498;6244.219472565929;6261;6437.935620643781;6467.029945508164;6468.902966455507;6493;6517.902231466484;6313.958196897506;6410.61536307823;6429.742810287629;6431.2604050533855;6436.388543088399;6180.969095154541;6248.218972628421;6267.122602835607;6281.277653069864;6309.242890853127;6751.25736169021;6767.255601883789;6768.424683901825;6773.983902414579;6775.3902148805855;6258.843528911722;6438.806835794933;6441.291457939623;6449.677516124175;6457;6390.552661313756;6407.103005579223;6505.707243174069;6510.707018184193;6564;6428.389303016206;6473.06140609609;6481.740730370732;6489.870202595922;6494.025896115526;6475.514336424787;6476.740930362733;6493.772717954849;6507.577007494498;6519.706613202417;5115.411727651293;5230.555402790729;5255.500727430888;5272.367315922113;5291.523762861361;3939.665128464055;4700.412448443944;4704.858854234379;4707;4741.715497070187;6201.6899155042065;6206.317305096436;6208.379162083756;6213.409726076015;6223.533235007392;6271.811845644638;6401.07184458251;6565.343465653396;6609.1077704510235;6616.4376028037195;6036.6679832609625;6062.484688801501;6084.5132389408745;6084.726187321581;6086.573939824259;5612.326520817528;5670.177824215466;5684.062129748628;5689.743961521742;5690.9430905690415;6501.122348482894;6502.934970650422;6508.284088750328;6511.120998665119;6526.053722210253;6309.3690630936535;6358.237011558643;6359.55483116196;6380.170577825039;6381.93618063832;5516.834494965157;6509.479241660751;6510.641914694548;6543;6735.360140786617;6424.935750642434;6428.4857211423905;6434.453071488976;6439.066335381437;6443.6455994920725;5488.4785945335125;6468.450181734605;6568.934310656832;6581.07864898905;6593.175853018372;6216.471599913877;6278.717457714322;6310.305866354605;6314;6315.96842015787;6250.593711408744;6294.6852657366035;6319.684015799284;6358.268799088164;6378.808635740936;6140.289530736458;6209.503239740719;6214.689265536796;6279.340669229665;6293.213348331458;6388.169537960035;6399.488040956805;6399.840003999937;6401.327860574573;6404.071409645669;6132.20254427538;6300.149479820166;6303.054541818764;6314.905276420949;6333.778317759041 03:07:56 INFO - PID 7617 | |1;ext.html;749.1272667342546;783.7296132834172;806.7136166660833;1135.4947048563392;1154.393943179831;28078.438431231363;38016;38519.42220866686;38584;38787.41818872719;40628.18743625133;41103.79448102763;41123.38314925271;41148.38277425841;41283.76148715536;6130.356312587181;8510.914890851089;8662.696805611804;8697.565121743919;8729.956350218241;6202.193714817067;8405.117462666392;8589.871151932726;8601;8626.741197764046;8564.186402291803;8614.612342444605;8652.697155599555;8669.913300867005;8699.304055675531;8570.228679418851;8637.827243455096;8641.092685268019;8650.437721548142;8652.394332396734;8562.443441176365;8602.01076876161;8610.52642104684;8625.051244363114;8631.180037896389;38706.419403708685;38716.61283387158;38727.612723872684;38754;38846.22307553861;3501.8074005929666;3538.575370955476;3541.6281290464644;3545.06055895188;3550.0947258449187;31155.376892462024;31194.724553921966;31216.37567248665;31250.687493125006;31381.8430907844;3067.8466076696077;3138.0272115644225;3161.4309424303615;3170.7621928355234;3176.6664500227607;265351;270075;271258;271589;271913;50504.494955050715;50598;50714.74642626837;50732.23901641478;50818.74590627023;52855.471445285824;52859;52874.206886896725;52953.73523132437;53027.6743081426;12203.450844711831;14719.779203311959;14764.852351476562;14778.926105369404;14790.926045369919;10087.445190514445;11987.041036717043;12000.519979200908;12030.87969120315;12051.75896482083;11506.884931150582;11607.76784464323;12770.425330860133;12872.292023938586;13112.213267203999;5218.921716174261;5245.606579506552;5260.92108618371;5262.789488420421;5262.868428289246;1007.5667462990838;1035.668586052456;1037.8910214427376;1075.424647813416;1086.9565217391216;23545.41136471602;24699.382515436897;24760.87619561927;24764.25707228786;24800.37999050002;1120.708615759892;1126.5212284778936;1159.5709587452698;1162.4710756605893;1169.368540987874;10287.537060832281;12088.576899808464;12606.180598261084;12624.295720077856;12754.872451275554;304226;305358;305866;305989;306156;55949.72025139848;56009.43990560124;56145.1578226327;56219.999999999185;56238.18809059531;1458.9635259118395;1493.111598598832;1532.341093329879;1546.3505327762366;1552.2937063636018;24055.879720601286;24292.51414971726;24337.51324973526;24351.634725479485;24384.51230975406;40453.39319910145;40478.9880252996;40507;40549.594504054585;40564.985875353355;284935;285503;285553.5722321375;285850;287166;31412.52881206738;35833.46249806307;35926.461103082955;36648;36750.26499469942;37387.878363649135;39474.80262598669;39639.80180099081;39711.41875778065;46883.53116468792;28775.568366474938;29539.852300739218;31674.68325316717;32319.35361292808;32474.83762581172;24828.255152345457;30418.54372184463;30427;31418.842905785325;31666.366672666878;29862.402751945276;37426.8128659355;38175.04562385962;38222.80888595539;38318.80840595779;24412.63381049321;31681;32369.190770230933;33148.50277245795;33505;22832.556256840395;23561.29316120519;24103.035878565363;24105.397365066012;24459.75540244575 03:07:56 INFO - PID 7617 | |2;jquery.html;426.3209379060634;429.57381493441744;435.47742708749496;435.9934600980986;456.03776032571267;20202.59594808103;21802;22303.888480557576;22507.54984900305;22540.54918901623;21553.13787448504;22580.88709556454;22951;23432.179873704423;23656.645150322714;5986.401359864;6045.183900173464;6299.181106456154;6305.180326557541;6307.968460157693;6031.668258245794;6258.217722784652;6258.561900666955;6269.404406581368;6284.937150628481;5832.708364581775;6074.331823499411;6142.938570614304;6241.344658810827;6258;6109.755609775603;6155.846103847395;6157.3842615738295;6161.568690191689;6167.568270221086;5355.0896347621;5464.98897703926;5517.641353312062;5598.832035038915;5618.15727640853;25046.87476562624;26564.937402503878;28360;28634;28722.712772872423;2190.255313193522;2285.451491641994;2290.038183962723;2293.6674182243482;2294.73610534789;17699;17810;18067.819321806746;18172.818271817247;18343.899366037946;2116.767155612881;2134.6584546472645;2178.0307763045453;2183.530540933707;2183.836212284085;146731.7287789855;154260;157550;158508.20745896312;164277.17861410737;11370.772584548262;12079.879201207876;12107.213031152947;12117.27296362221;12147.392630368622;16423.507294781175;16461.506154815375;16485.010899346078;16485.17574121289;16510;8690.956545217234;8898.510581918057;8938.86591701125;8984.146506081912;9039.322050846213;7464.365528929993;8443;8448.662053517914;8634.79112924191;8646.417398778658;7452.329290363893;7585.924140758632;7650.540967541965;7672.271134242238;7673.846523069507;2077.9376618701463;2084.749830020377;2085.1450905128822;2085.8018488243897;2226.387743370586;921.2307723051193;942.8632848237104;950.1828427552299;991.4051569058652;1006.4615430744517;19688.31090911811;20416.285430009877;20438.489037774176;20527;20540.281090162072;914.6341463414687;917.2799352508249;974.288769198489;987.7702260685493;1020.8366661334151;9117.908820911838;9761.121499065119;10675.626353077605;10703.518341674644;10784;537602;555197;559984;565411;570328;119714;120330;120589.39705301593;121740;124308.75691242972;1064.3338437214727;1075.102289588187;1092.202692034819;1162.0715796193545;1167.6263595649311;14691.55925322242;17961.910190448965;18032.36886708959;18084;18196.81803181951;55995;57559;57780.133297999724;58229.4177058224;58245;77679;77975.61012194902;79231.2646983943;80141.79787303078;80636;8465;8669.956650216709;8808.973935994629;8830.248915049582;8946.284297256074;12161.635150945485;12672.87327126717;13898.374573144434;13912.304384780518;14372.640683982983;11685.240459370114;11805;11854.11094167958;12024.458899349374;12140.939295303468;11039.83440248413;11093.16801239894;11236.381998990135;11429.142814289127;11459.31244125355;10566.735831604272;10780.191485638452;11755.412229388667;11982.041436685218;12171.391430428266;8272.214139656722;8456.788580285542;8693.956530217309;8826.514541700011;8837.381383303107;11547.076233901436;11580.884191158317;11772.52909883595;11888.227265227733;11893.226940248856 03:07:56 INFO - PID 7617 | |3;mootools.html;1173.5012619636652;1355.3155656393524;1425.109306683323;1447.0811034992782;1455.5342290467051;9776.560054797534;10160.237982151331;11510.597129100473;11610.941945290262;11895.702607434818;11643.883561164386;11731.002864756485;11733.70665733357;11755.529778808837;11784.116191285644;2443.413580740623;2491.4145175883655;2497.8001759859167;2498.7376325485743;2498.800095992316;1776.8450507170314;2125.7767934366902;2162.340486151723;2189.5730332585154;2380.5238952209543;2056.3008577083788;2471.7404672509397;2472.332470233045;2472.4066224106264;2484.9875750621222;2429.7205821330595;2444.1934161726585;2464.5687004774095;2467.728549859514;2478.120267305099;2056.640087984597;2392.5781249999905;2406.5908795504806;2418.5525677749674;2422.39440139965;11581.652550423501;11705.590304339306;11707;11734.70663233426;11750.882491175063;5633.380328163898;6389.8402539936405;6641.236257830363;6647.335266473314;6668.9666551667415;3931.4495970564144;4105.137921036586;4215.283401821697;4228.513720922103;4245;1202.2546021466746;1231.9199252048588;1277.1443133100752;1282.2114399644151;1288.3493835612956;16538.751918721227;16561.585960351087;16573.337066517324;16591.585210369718;16602.66794664112;5553.50018498329;5707.315122185364;5864.882702346014;5877.206577112035;6011.248593925759;13886.791698124536;13891.374888130058;13896;13897.16617002983;13902.304884755722;6549.2468366137555;6717.395434410926;6731.798046058626;6736.2590115087305;6740.494462915301;5867.295924489089;6084.60450070744;6140.846478838065;6151.6001459904965;6152.8769424611255;4126.154138401621;4271.914561708749;4281.464816897887;4284.400183974246;4588.632909367243;1301.7763302495814;1320.808482769993;1323.126736354021;1324.6224825924564;1374.6838227207797;781.3397678961269;817.8282560662327;819.4427789103466;821.256762629821;831.9251267385964;5583.972080139654;6337.493000559944;6478.838029049311;6889.173299204128;6952.513324067368;827.2389401750404;908.4640062363237;910.4400793511943;917.0416914324413;928.1414691410419;4353.933286344865;4608.239640459354;4625.5836974671765;4627.514111018362;4808.422989241313;13096;15298.464553740565;15319.540413787605;15324.387024518894;15326.23368831554;14702.01522794409;14941.10353378779;15239.16184609835;15272.770908436383;15285.465008724641;8526.488410695254;8549.273311768446;8662.826743465095;8803.471791692518;8812.559372031374;6930.930690693029;7040.542364746275;7161.606111663908;7178.60517671533;7185.820354491179;13440.723131302511;13446.731065378834;13607.639236076313;13733.381997810322;13764.862351376758;13720.313984300945;13765.174089554659;13833.58499244984;13982.370793314121;14109.29453527299;9507.191888689538;9536.23710103204;9550.235981121632;9769.706908792748;9864.260180486348;10772.24594278393;10835.187360947803;10851.837222441827;10858.402787846744;10873.184511161537;8996.460212387277;9245.121713437213;9342.159205671522;9345.906540934775;9429.62281508732;8990.460572365679;9053.139951704577;9075.410098343587;9154.725358239264;9178.954105229432;8110.351171906352;8131.593420328842;8229.341652667652;8246.340292776444;8259.793505162419;5355.892882142258;5489.094299440548;5845.298564172326;5906.557008224315;6350.079238510298;6066.848328791639;6186.226721659793;6190.442860142429;6244.063390491463;6263.123162757127 03:07:56 INFO - PID 7617 | |4;prototype.html;379.6033145363097;381.919796842663;391.9372900335947;393.1233349630323;396.1680471010878;5362.766563690344;5688.5015715335085;5698.430156984305;5720.170575266589;5749.310082790061;5347.46525347466;5404.513593776559;5539.861503462415;5550.780547282567;5583.441655834425;3718.8326525306425;4031.153457773871;4081.0613558881473;4335.132973405323;4354.956450435503;3938.9803050984847;3949.2693851637396;4317.43873296471;4319.395284660134;4342.891427714317;3193.0101668482844;4177.832886684529;4296.935545966813;4302.612764851163;4313.374560688699;3487.773294735834;4199.7480151190875;4262.318029115327;4307.547707490731;4319.02821865081;3797.544294684628;3804.353259945816;3804.8668296609762;3805.0487378155462;3810.5236845394325;5472.7263636818;5501.752421141018;5504.256925315071;5517.282753242052;5526.651173251352;4555.155162159331;4692.343071969893;4903.215485522299;4957.3059771632;4965.925511117336;5102.897942041175;5913.940860591382;5985.072313791369;5996.790112346091;6009;4112.100968816977;4123.195976784528;4128.6284234418745;4132.235536425771;4132.297509423405;5012.172991456406;5206.817761378372;5928.413309947463;6294.653794041372;6299.181106456132;4123.3196522574035;4192.874213773592;4195.119025004722;4196.475440569929;4203.936940945889;3552.236269202134;4265.55211702773;4270.466191726035;4279.828806847753;4282.850100246476;4113.753174809521;4902.852914412573;4956.529129732669;4959.975200123977;4971.5028497150715;6061.878762424815;6068.271807383054;6070.666113363807;6072.180255665517;6091.238595175603;1281.39774306076;1389.235920243882;1433.6917562723856;1450.8828202284394;1455.5851582298994;878.499255424402;966.1256562810527;970.9174720148725;975.8097171051577;985.482621623639;5715.228444160069;5726.312842458931;5730.049024752256;5731.942680573141;5747.712614369349;5376.623636345418;5564.693941833238;6042.610199654104;6336.398042185985;6341.968290158519;4823.614110871122;5079.974600126976;5525.198846167284;5552.555795536347;5726.3700992890745;3039.407315573442;3276.672332766704;3332.666733326648;3335.6997870191312;3340.8329583520726;6054.636721796706;6317.810465686037;6480.921562257984;6510.18622672166;6553.672316384162;5731.799387021434;6074.635521868702;6453.967730161319;6486.189226346707;6542.836429089216;5371.731413429313;6497.480201583862;6543.411093001652;6546.607203567801;6574.408303252731;5492.633356481687;5614.326280846324;6320.6839658016;6323;6392.552521323649;5062.063518249136;5433.782648694008;5962.940370596239;6203.038529028008;6236.5053978409;5882.294124705063;6135.84660383494;6321.304656487875;6422.454091402283;6447.258565265054;4139.027328577721;4163.812628431668;4175.937360939528;4180.327868852483;4186.748795072305;4940.777665005012;5664.49019588239;6138.631682099089;6219.440250377307;6243.4422871303295;4995.675281106716;6081.483073938588;6097.237845269341;6098.634081955097;6102.9694851525455;5076.517730815566;5361.651492653121;5821.883562328814;5857.736401862012;6012.819615411545;5623.381428042994;5919.852003699942;5948.4943779779205;5979.730912108878;6028.8794224116145;5394.919076213939;6042.123892035543;6118.357572455006;6121.540884433774;6132.202813634199;5695.45893140151;5949.8215053548465;5954.434328738763;5960.466801609212;5978.312494063064 03:07:56 INFO - PID 7617 | |5;yui.html;698.7728988078876;833.3041910005145;849.4903058165102;853.6372041882203;856.9357298202632;13390.933045334772;17863.642727145467;18548.25806967723;18668.346607868727;18702.251909923605;16810.411635592758;17057.914710426463;17170.656586868285;17199.484015479524;17206.225719842605;961.4711908450341;981.0385821894548;999.5452069308484;1000.9840012387433;1001.9098281154695;670.0451856105055;693.1266604078871;960.9183219426358;1012.4937531234383;1022.6267412394496;1061.3419679798535;1066.3335415365398;1067.8398240263946;1070.6038765656717;1072.4905669806858;1048.7692707604315;1059.5285098131335;1061.7239517725409;1063.1601035182198;1064.249703958715;781.1797612506845;785.5993443343935;785.7407055671615;785.8899754034439;788.4126325887194;15496.070235785888;16368.345266189339;16601.91699041509;16818.243179056848;16908.323667053304;13313.334333283394;13970.93014534931;16049.679006419923;16367.181640918026;16523.6695266094;15337.23313834315;15543.844561554353;15657.530274091796;15761.369545218178;15802.762958555631;5245.947540524584;5273.973630131824;5281.973590132025;5285.101532739405;5288.656237344599;123383.76616233813;124062.01100840328;124100.37949810283;126272.73727262701;127429;11371.31772093677;11778.94110529459;12812.167209131376;12934.611961641165;12968.546100886424;20025.59820812529;24861;25109.246722598353;25142;25788.484230315287;7756.340711039512;7860.489068210548;7954.244346787046;7961.084475285301;7962.840743185104;3964.7621142731527;3995.4606128172904;4050.8177132029127;4054.1283624020975;4054.412110243998;4199.811008504625;4295.699301048897;4313.072689371737;4317.41714868495;4320.935185972213;805.1666525146445;912.1790388650268;933.0902370189146;934.6915517879083;935.5883411299006;644.2333622988629;668.4117976180929;670.0652589637526;672.9461643068543;683.3644710419358;10743.892561074446;11627.941860290644;11641.449357945738;11857.762844743056;11912.702182445508;651.4202359899693;657.9210494740566;660.3825423229296;671.1375881991618;690.8756423843656;4963.553280204799;5323.574114070865;5430.56555475561;5540.36285827135;5669.489745922887;100925.49537252414;102151.48924255332;102528;103475;105777;69634.65182674055;88844;89485;92756.53621731984;92846;79111.60444197743;80740.54075674049;81139;81835.18164818395;81947;9433.622655093719;11076.169287303323;11115.499802509068;11290.266132701348;11394.658160255205;38324.6167538321;38721.2255754889;38924.41613375858;39053;39893;39878.80060599678;47266.76366618145;51634.74182629063;51966.22050669167;52698;13803.378847952066;14238.216898070705;14345.211013394364;14439.278036098363;14478.420863165355;15467.690646186787;17680.469585912444;18054.5486362842;18519.44441666752;18756.812431875507;16099.75850362269;16283.511494655178;16355.264013119677;16947;16974.40589579359;16425.342986280415;16699.666006679556;16810.411635592696;17028.574285642957;17497.737533937256;14932.253387330808;15031.699366012399;15184.316705748488;15420.614484637974;15424.845751542342;9195.310351723781;9686.903130968882;11015;11611.535538578362;12102.515899363927;12452.439640216031;12473.87526124727;12492.813182747625;12541.74916501683;12553.686157846127 03:07:56 INFO - PID 7617 | __end_tp_report 03:07:56 INFO - PID 7617 | __start_cc_report 03:07:56 INFO - PID 7617 | _x_x_mozilla_cycle_collect,1652 03:07:56 INFO - PID 7617 | __end_cc_report 03:07:56 INFO - PID 7617 | __startTimestamp1492510076255__endTimestamp 03:07:56 INFO - PID 7617 | 03:07:56 INFO - PID 7617 | ------- Summary: start ------- 03:07:56 INFO - PID 7617 | Number of tests: 6 03:07:56 INFO - PID 7617 | 03:07:56 INFO - PID 7617 | [#0] dojo.html Cycles:165 Average:5997.44 Median:6271.81 stddev:706.93 (11.3%) stddev-sans-first:660.04 03:07:56 INFO - PID 7617 | Values: 2698.7 3451.3 3481.2 3487.3 3518.8 5955.3 6103.9 6112.5 6194.5 6222.9 6045.1 6103.1 6111.4 6114.8 6128.6 5247.9 5261.4 5270.4 5281.8 5371.5 5347.6 5351.9 5368.8 5370.5 5372.5 5343.2 5346.5 5347.5 5348.1 5352.1 5314.1 5330.2 5341.4 5346.9 5355.8 5193.9 5310.9 5311.2 5335.8 5345.4 6178.4 6215.2 6233.4 6244.2 6261.0 6437.9 6467.0 6468.9 6493.0 6517.9 6314.0 6410.6 6429.7 6431.3 6436.4 6181.0 6248.2 6267.1 6281.3 6309.2 6751.3 6767.3 6768.4 6774.0 6775.4 6258.8 6438.8 6441.3 6449.7 6457.0 6390.6 6407.1 6505.7 6510.7 6564.0 6428.4 6473.1 6481.7 6489.9 6494.0 6475.5 6476.7 6493.8 6507.6 6519.7 5115.4 5230.6 5255.5 5272.4 5291.5 3939.7 4700.4 4704.9 4707.0 4741.7 6201.7 6206.3 6208.4 6213.4 6223.5 6271.8 6401.1 6565.3 6609.1 6616.4 6036.7 6062.5 6084.5 6084.7 6086.6 5612.3 5670.2 5684.1 5689.7 5690.9 6501.1 6502.9 6508.3 6511.1 6526.1 6309.4 6358.2 6359.6 6380.2 6381.9 5516.8 6509.5 6510.6 6543.0 6735.4 6424.9 6428.5 6434.5 6439.1 6443.6 5488.5 6468.5 6568.9 6581.1 6593.2 6216.5 6278.7 6310.3 6314.0 6316.0 6250.6 6294.7 6319.7 6358.3 6378.8 6140.3 6209.5 6214.7 6279.3 6293.2 6388.2 6399.5 6399.8 6401.3 6404.1 6132.2 6300.1 6303.1 6314.9 6333.8 03:07:56 INFO - PID 7617 | 03:07:56 INFO - PID 7617 | [#1] ext.html Cycles:180 Average:44297.10 Median:32344.27 stddev:75275.65 (232.7%) stddev-sans-first:75415.80 03:07:56 INFO - PID 7617 | Values: 749.1 783.7 806.7 1135.5 1154.4 28078.4 38016.0 38519.4 38584.0 38787.4 40628.2 41103.8 41123.4 41148.4 41283.8 6130.4 8510.9 8662.7 8697.6 8730.0 6202.2 8405.1 8589.9 8601.0 8626.7 8564.2 8614.6 8652.7 8669.9 8699.3 8570.2 8637.8 8641.1 8650.4 8652.4 8562.4 8602.0 8610.5 8625.1 8631.2 38706.4 38716.6 38727.6 38754.0 38846.2 3501.8 3538.6 3541.6 3545.1 3550.1 31155.4 31194.7 31216.4 31250.7 31381.8 3067.8 3138.0 3161.4 3170.8 3176.7 265351.0 270075.0 271258.0 271589.0 271913.0 50504.5 50598.0 50714.7 50732.2 50818.7 52855.5 52859.0 52874.2 52953.7 53027.7 12203.5 14719.8 14764.9 14778.9 14790.9 10087.4 11987.0 12000.5 12030.9 12051.8 11506.9 11607.8 12770.4 12872.3 13112.2 5218.9 5245.6 5260.9 5262.8 5262.9 1007.6 1035.7 1037.9 1075.4 1087.0 23545.4 24699.4 24760.9 24764.3 24800.4 1120.7 1126.5 1159.6 1162.5 1169.4 10287.5 12088.6 12606.2 12624.3 12754.9 304226.0 305358.0 305866.0 305989.0 306156.0 55949.7 56009.4 56145.2 56220.0 56238.2 1459.0 1493.1 1532.3 1546.4 1552.3 24055.9 24292.5 24337.5 24351.6 24384.5 40453.4 40479.0 40507.0 40549.6 40565.0 284935.0 285503.0 285553.6 285850.0 287166.0 31412.5 35833.5 35926.5 36648.0 36750.3 37387.9 39474.8 39639.8 39711.4 46883.5 28775.6 29539.9 31674.7 32319.4 32474.8 24828.3 30418.5 30427.0 31418.8 31666.4 29862.4 37426.8 38175.0 38222.8 38318.8 24412.6 31681.0 32369.2 33148.5 33505.0 22832.6 23561.3 24103.0 24105.4 24459.8 03:07:56 INFO - PID 7617 | 03:07:56 INFO - PID 7617 | [#2] jquery.html Cycles:180 Average:35575.02 Median:2294.20 stddev:94388.57 (4114.2%) stddev-sans-first:94616.46 03:07:56 INFO - PID 7617 | Values: 426.3 429.6 435.5 436.0 456.0 20202.6 21802.0 22303.9 22507.5 22540.5 21553.1 22580.9 22951.0 23432.2 23656.6 5986.4 6045.2 6299.2 6305.2 6308.0 6031.7 6258.2 6258.6 6269.4 6284.9 5832.7 6074.3 6142.9 6241.3 6258.0 6109.8 6155.8 6157.4 6161.6 6167.6 5355.1 5465.0 5517.6 5598.8 5618.2 25046.9 26564.9 28360.0 28634.0 28722.7 2190.3 2285.5 2290.0 2293.7 2294.7 17699.0 17810.0 18067.8 18172.8 18343.9 2116.8 2134.7 2178.0 2183.5 2183.8 146731.7 154260.0 157550.0 158508.2 164277.2 11370.8 12079.9 12107.2 12117.3 12147.4 16423.5 16461.5 16485.0 16485.2 16510.0 8691.0 8898.5 8938.9 8984.1 9039.3 7464.4 8443.0 8448.7 8634.8 8646.4 7452.3 7585.9 7650.5 7672.3 7673.8 2077.9 2084.7 2085.1 2085.8 2226.4 921.2 942.9 950.2 991.4 1006.5 19688.3 20416.3 20438.5 20527.0 20540.3 914.6 917.3 974.3 987.8 1020.8 9117.9 9761.1 10675.6 10703.5 10784.0 537602.0 555197.0 559984.0 565411.0 570328.0 119714.0 120330.0 120589.4 121740.0 124308.8 1064.3 1075.1 1092.2 1162.1 1167.6 14691.6 17961.9 18032.4 18084.0 18196.8 55995.0 57559.0 57780.1 58229.4 58245.0 77679.0 77975.6 79231.3 80141.8 80636.0 8465.0 8670.0 8809.0 8830.2 8946.3 12161.6 12672.9 13898.4 13912.3 14372.6 11685.2 11805.0 11854.1 12024.5 12140.9 11039.8 11093.2 11236.4 11429.1 11459.3 10566.7 10780.2 11755.4 11982.0 12171.4 8272.2 8456.8 8694.0 8826.5 8837.4 11547.1 11580.9 11772.5 11888.2 11893.2 03:07:56 INFO - PID 7617 | 03:07:56 INFO - PID 7617 | [#3] mootools.html Cycles:180 Average:7196.40 Median:4115.65 stddev:4609.62 (112.0%) stddev-sans-first:4600.33 03:07:56 INFO - PID 7617 | Values: 1173.5 1355.3 1425.1 1447.1 1455.5 9776.6 10160.2 11510.6 11610.9 11895.7 11643.9 11731.0 11733.7 11755.5 11784.1 2443.4 2491.4 2497.8 2498.7 2498.8 1776.8 2125.8 2162.3 2189.6 2380.5 2056.3 2471.7 2472.3 2472.4 2485.0 2429.7 2444.2 2464.6 2467.7 2478.1 2056.6 2392.6 2406.6 2418.6 2422.4 11581.7 11705.6 11707.0 11734.7 11750.9 5633.4 6389.8 6641.2 6647.3 6669.0 3931.4 4105.1 4215.3 4228.5 4245.0 1202.3 1231.9 1277.1 1282.2 1288.3 16538.8 16561.6 16573.3 16591.6 16602.7 5553.5 5707.3 5864.9 5877.2 6011.2 13886.8 13891.4 13896.0 13897.2 13902.3 6549.2 6717.4 6731.8 6736.3 6740.5 5867.3 6084.6 6140.8 6151.6 6152.9 4126.2 4271.9 4281.5 4284.4 4588.6 1301.8 1320.8 1323.1 1324.6 1374.7 781.3 817.8 819.4 821.3 831.9 5584.0 6337.5 6478.8 6889.2 6952.5 827.2 908.5 910.4 917.0 928.1 4353.9 4608.2 4625.6 4627.5 4808.4 13096.0 15298.5 15319.5 15324.4 15326.2 14702.0 14941.1 15239.2 15272.8 15285.5 8526.5 8549.3 8662.8 8803.5 8812.6 6930.9 7040.5 7161.6 7178.6 7185.8 13440.7 13446.7 13607.6 13733.4 13764.9 13720.3 13765.2 13833.6 13982.4 14109.3 9507.2 9536.2 9550.2 9769.7 9864.3 10772.2 10835.2 10851.8 10858.4 10873.2 8996.5 9245.1 9342.2 9345.9 9429.6 8990.5 9053.1 9075.4 9154.7 9179.0 8110.4 8131.6 8229.3 8246.3 8259.8 5355.9 5489.1 5845.3 5906.6 6350.1 6066.8 6186.2 6190.4 6244.1 6263.1 03:07:56 INFO - PID 7617 | 03:07:56 INFO - PID 7617 | [#4] prototype.html Cycles:180 Average:4884.43 Median:5510.77 stddev:1504.48 (27.3%) stddev-sans-first:1470.22 03:07:56 INFO - PID 7617 | Values: 379.6 381.9 391.9 393.1 396.2 5362.8 5688.5 5698.4 5720.2 5749.3 5347.5 5404.5 5539.9 5550.8 5583.4 3718.8 4031.2 4081.1 4335.1 4355.0 3939.0 3949.3 4317.4 4319.4 4342.9 3193.0 4177.8 4296.9 4302.6 4313.4 3487.8 4199.7 4262.3 4307.5 4319.0 3797.5 3804.4 3804.9 3805.0 3810.5 5472.7 5501.8 5504.3 5517.3 5526.7 4555.2 4692.3 4903.2 4957.3 4965.9 5102.9 5913.9 5985.1 5996.8 6009.0 4112.1 4123.2 4128.6 4132.2 4132.3 5012.2 5206.8 5928.4 6294.7 6299.2 4123.3 4192.9 4195.1 4196.5 4203.9 3552.2 4265.6 4270.5 4279.8 4282.9 4113.8 4902.9 4956.5 4960.0 4971.5 6061.9 6068.3 6070.7 6072.2 6091.2 1281.4 1389.2 1433.7 1450.9 1455.6 878.5 966.1 970.9 975.8 985.5 5715.2 5726.3 5730.0 5731.9 5747.7 5376.6 5564.7 6042.6 6336.4 6342.0 4823.6 5080.0 5525.2 5552.6 5726.4 3039.4 3276.7 3332.7 3335.7 3340.8 6054.6 6317.8 6480.9 6510.2 6553.7 5731.8 6074.6 6454.0 6486.2 6542.8 5371.7 6497.5 6543.4 6546.6 6574.4 5492.6 5614.3 6320.7 6323.0 6392.6 5062.1 5433.8 5962.9 6203.0 6236.5 5882.3 6135.8 6321.3 6422.5 6447.3 4139.0 4163.8 4175.9 4180.3 4186.7 4940.8 5664.5 6138.6 6219.4 6243.4 4995.7 6081.5 6097.2 6098.6 6103.0 5076.5 5361.7 5821.9 5857.7 6012.8 5623.4 5919.9 5948.5 5979.7 6028.9 5394.9 6042.1 6118.4 6121.5 6132.2 5695.5 5949.8 5954.4 5960.5 5978.3 03:07:56 INFO - PID 7617 | 03:07:56 INFO - PID 7617 | [#5] yui.html Cycles:180 Average:21185.39 Median:18287.00 stddev:30007.65 (164.1%) stddev-sans-first:30052.40 03:07:56 INFO - PID 7617 | Values: 698.8 833.3 849.5 853.6 856.9 13390.9 17863.6 18548.3 18668.3 18702.3 16810.4 17057.9 17170.7 17199.5 17206.2 961.5 981.0 999.5 1001.0 1001.9 670.0 693.1 960.9 1012.5 1022.6 1061.3 1066.3 1067.8 1070.6 1072.5 1048.8 1059.5 1061.7 1063.2 1064.2 781.2 785.6 785.7 785.9 788.4 15496.1 16368.3 16601.9 16818.2 16908.3 13313.3 13970.9 16049.7 16367.2 16523.7 15337.2 15543.8 15657.5 15761.4 15802.8 5245.9 5274.0 5282.0 5285.1 5288.7 123383.8 124062.0 124100.4 126272.7 127429.0 11371.3 11778.9 12812.2 12934.6 12968.5 20025.6 24861.0 25109.2 25142.0 25788.5 7756.3 7860.5 7954.2 7961.1 7962.8 3964.8 3995.5 4050.8 4054.1 4054.4 4199.8 4295.7 4313.1 4317.4 4320.9 805.2 912.2 933.1 934.7 935.6 644.2 668.4 670.1 672.9 683.4 10743.9 11627.9 11641.4 11857.8 11912.7 651.4 657.9 660.4 671.1 690.9 4963.6 5323.6 5430.6 5540.4 5669.5 100925.5 102151.5 102528.0 103475.0 105777.0 69634.7 88844.0 89485.0 92756.5 92846.0 79111.6 80740.5 81139.0 81835.2 81947.0 9433.6 11076.2 11115.5 11290.3 11394.7 38324.6 38721.2 38924.4 39053.0 39893.0 39878.8 47266.8 51634.7 51966.2 52698.0 13803.4 14238.2 14345.2 14439.3 14478.4 15467.7 17680.5 18054.5 18519.4 18756.8 16099.8 16283.5 16355.3 16947.0 16974.4 16425.3 16699.7 16810.4 17028.6 17497.7 14932.3 15031.7 15184.3 15420.6 15424.8 9195.3 9686.9 11015.0 11611.5 12102.5 12452.4 12473.9 12492.8 12541.7 12553.7 03:07:56 INFO - PID 7617 | -------- Summary: end -------- 03:07:56 INFO - PID 7617 | 03:07:56 INFO - TEST-INFO | 7617: exit 0 03:07:56 INFO - TEST-OK | dromaeo_css | took 1120357ms 03:07:56 INFO - TEST-START | kraken 03:07:56 INFO - operating with platform_type : mac_ 03:07:56 INFO - Initialising browser for kraken test... 03:07:57 INFO - TEST-INFO | started process 7620 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/tmpBqvW7j/profile http://localhost:65105/getInfo.html) 03:07:59 INFO - PID 7620 | __metrics Screen width/height:1600/1200 03:07:59 INFO - PID 7620 | colorDepth:24 03:07:59 INFO - PID 7620 | Browser inner width/height: 1024/689 03:07:59 INFO - PID 7620 | __metrics 03:07:59 INFO - PID 7620 | 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" 03:07:59 INFO - PID 7620 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:08:00 INFO - TEST-INFO | 7620: exit 0 03:08:00 INFO - Browser initialized. 03:08:00 INFO - Running cycle 1/1 for kraken test... 03:08:00 INFO - TEST-INFO | started process 7621 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/tmpBqvW7j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:08:13 INFO - PID 7621 | RSS: Main: 241328128 03:08:13 INFO - PID 7621 | 03:08:16 INFO - PID 7621 | Cycle 1(1): loaded http://localhost:65105/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:65105/tests/kraken/driver.html?testName=audio-beat-detection) 03:08:17 INFO - PID 7621 | RSS: Main: 311664640 03:08:17 INFO - PID 7621 | 03:08:19 INFO - PID 7621 | Cycle 1(1): loaded http://localhost:65105/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:65105/tests/kraken/driver.html?testName=audio-dft) 03:08:20 INFO - PID 7621 | RSS: Main: 293281792 03:08:20 INFO - PID 7621 | 03:08:23 INFO - PID 7621 | Cycle 1(1): loaded http://localhost:65105/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:65105/tests/kraken/driver.html?testName=audio-fft) 03:08:24 INFO - PID 7621 | RSS: Main: 383614976 03:08:24 INFO - PID 7621 | 03:08:26 INFO - PID 7621 | Cycle 1(1): loaded http://localhost:65105/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:65105/tests/kraken/driver.html?testName=audio-oscillator) 03:08:27 INFO - PID 7621 | RSS: Main: 287244288 03:08:27 INFO - PID 7621 | 03:08:29 INFO - PID 7621 | Cycle 1(1): loaded http://localhost:65105/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:65105/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:08:29 INFO - PID 7621 | RSS: Main: 289488896 03:08:29 INFO - PID 7621 | 03:08:32 INFO - PID 7621 | Cycle 1(1): loaded http://localhost:65105/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:65105/tests/kraken/driver.html?testName=imaging-darkroom) 03:08:33 INFO - PID 7621 | RSS: Main: 352657408 03:08:33 INFO - PID 7621 | 03:08:36 INFO - PID 7621 | Cycle 1(1): loaded http://localhost:65105/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:65105/tests/kraken/driver.html?testName=imaging-desaturate) 03:08:36 INFO - PID 7621 | RSS: Main: 376389632 03:08:36 INFO - PID 7621 | 03:08:39 INFO - PID 7621 | Cycle 1(1): loaded http://localhost:65105/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:65105/tests/kraken/driver.html?testName=json-parse-financial) 03:08:40 INFO - PID 7621 | RSS: Main: 372580352 03:08:40 INFO - PID 7621 | 03:08:41 INFO - PID 7621 | Cycle 1(1): loaded http://localhost:65105/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:65105/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:08:42 INFO - PID 7621 | RSS: Main: 312623104 03:08:42 INFO - PID 7621 | 03:08:44 INFO - PID 7621 | Cycle 1(1): loaded http://localhost:65105/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:65105/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:08:45 INFO - PID 7621 | RSS: Main: 332804096 03:08:45 INFO - PID 7621 | 03:08:47 INFO - PID 7621 | Cycle 1(1): loaded http://localhost:65105/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:65105/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:08:48 INFO - PID 7621 | RSS: Main: 315502592 03:08:48 INFO - PID 7621 | 03:08:50 INFO - PID 7621 | Cycle 1(1): loaded http://localhost:65105/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:65105/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:08:51 INFO - PID 7621 | RSS: Main: 348504064 03:08:51 INFO - PID 7621 | 03:08:54 INFO - PID 7621 | Cycle 1(1): loaded http://localhost:65105/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:65105/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:08:55 INFO - PID 7621 | RSS: Main: 340619264 03:08:55 INFO - PID 7621 | 03:08:57 INFO - PID 7621 | Cycle 1(1): loaded http://localhost:65105/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:65105/tests/kraken/driver.html?testName=ai-astar) 03:08:57 INFO - PID 7621 | RSS: Main: 383672320 03:08:57 INFO - PID 7621 | 03:08:57 INFO - PID 7621 | __start_tp_report 03:08:57 INFO - PID 7621 | _x_x_mozilla_page_load 03:08:57 INFO - PID 7621 | _x_x_mozilla_page_load_details 03:08:57 INFO - PID 7621 | |i|pagename|runs| 03:08:57 INFO - PID 7621 | |0;ai-astar;111;112;109;111;112;115;162;166;112;111 03:08:57 INFO - PID 7621 | |1;audio-beat-detection;146;114;138;188;112;110;111;112;130;110 03:08:57 INFO - PID 7621 | |2;audio-dft;188;186;185;189;187;184;188;183;187;187 03:08:57 INFO - PID 7621 | |3;audio-fft;80;60;59;91;60;59;58;79;92;87 03:08:57 INFO - PID 7621 | |4;audio-oscillator;95;69;87;69;69;70;105;101;102;91 03:08:57 INFO - PID 7621 | |5;imaging-gaussian-blur;88;87;89;88;87;87;88;88;88;87 03:08:57 INFO - PID 7621 | |6;imaging-darkroom;95;95;96;95;95;94;96;95;94;93 03:08:57 INFO - PID 7621 | |7;imaging-desaturate;105;131;83;87;86;84;84;105;87;83 03:08:57 INFO - PID 7621 | |8;json-parse-financial;49;50;49;50;50;49;50;49;49;49 03:08:57 INFO - PID 7621 | |9;json-stringify-tinderbox;56;65;70;66;60;57;57;58;60;59 03:08:57 INFO - PID 7621 | |10;stanford-crypto-aes;79;81;81;79;71;77;107;103;105;103 03:08:57 INFO - PID 7621 | |11;stanford-crypto-ccm;138;141;135;137;136;138;139;141;164;157 03:08:57 INFO - PID 7621 | |12;stanford-crypto-pbkdf2;183;188;185;184;185;177;185;191;183;185 03:08:57 INFO - PID 7621 | |13;stanford-crypto-sha256-iterative;69;65;66;68;67;68;67;68;68;73 03:08:57 INFO - PID 7621 | __end_tp_report 03:08:57 INFO - PID 7621 | __start_cc_report 03:08:57 INFO - PID 7621 | _x_x_mozilla_cycle_collect,2267 03:08:57 INFO - PID 7621 | __end_cc_report 03:08:57 INFO - PID 7621 | __startTimestamp1492510137268__endTimestamp 03:08:57 INFO - PID 7621 | 03:08:57 INFO - PID 7621 | ------- Summary: start ------- 03:08:57 INFO - PID 7621 | Number of tests: 14 03:08:57 INFO - PID 7621 | 03:08:57 INFO - PID 7621 | [#0] ai-astar Cycles:10 Average:122.10 Median:112.00 stddev:22.15 (19.8%) stddev-sans-first:23.13 03:08:57 INFO - PID 7621 | Values: 111.0 112.0 109.0 111.0 112.0 115.0 162.0 166.0 112.0 111.0 03:08:57 INFO - PID 7621 | 03:08:57 INFO - PID 7621 | [#1] audio-beat-detection Cycles:10 Average:127.10 Median:122.00 stddev:25.09 (20.6%) stddev-sans-first:25.66 03:08:57 INFO - PID 7621 | Values: 146.0 114.0 138.0 188.0 112.0 110.0 111.0 112.0 130.0 110.0 03:08:57 INFO - PID 7621 | 03:08:57 INFO - PID 7621 | [#2] audio-dft Cycles:10 Average:186.40 Median:187.00 stddev:1.90 (1.0%) stddev-sans-first:1.92 03:08:57 INFO - PID 7621 | Values: 188.0 186.0 185.0 189.0 187.0 184.0 188.0 183.0 187.0 187.0 03:08:57 INFO - PID 7621 | 03:08:57 INFO - PID 7621 | [#3] audio-fft Cycles:10 Average:72.50 Median:79.50 stddev:14.60 (18.4%) stddev-sans-first:15.23 03:08:57 INFO - PID 7621 | Values: 80.0 60.0 59.0 91.0 60.0 59.0 58.0 79.0 92.0 87.0 03:08:57 INFO - PID 7621 | 03:08:57 INFO - PID 7621 | [#4] audio-oscillator Cycles:10 Average:85.80 Median:69.50 stddev:15.17 (21.8%) stddev-sans-first:15.72 03:08:57 INFO - PID 7621 | Values: 95.0 69.0 87.0 69.0 69.0 70.0 105.0 101.0 102.0 91.0 03:08:57 INFO - PID 7621 | 03:08:57 INFO - PID 7621 | [#5] imaging-gaussian-blur Cycles:10 Average:87.70 Median:88.00 stddev:0.67 (0.8%) stddev-sans-first:0.71 03:08:57 INFO - PID 7621 | Values: 88.0 87.0 89.0 88.0 87.0 87.0 88.0 88.0 88.0 87.0 03:08:57 INFO - PID 7621 | 03:08:57 INFO - PID 7621 | [#6] imaging-darkroom Cycles:10 Average:94.80 Median:95.00 stddev:0.92 (1.0%) stddev-sans-first:0.97 03:08:57 INFO - PID 7621 | Values: 95.0 95.0 96.0 95.0 95.0 94.0 96.0 95.0 94.0 93.0 03:08:57 INFO - PID 7621 | 03:08:57 INFO - PID 7621 | [#7] imaging-desaturate Cycles:10 Average:93.50 Median:84.00 stddev:15.68 (18.7%) stddev-sans-first:16.07 03:08:57 INFO - PID 7621 | Values: 105.0 131.0 83.0 87.0 86.0 84.0 84.0 105.0 87.0 83.0 03:08:57 INFO - PID 7621 | 03:08:57 INFO - PID 7621 | [#8] json-parse-financial Cycles:10 Average:49.40 Median:49.50 stddev:0.52 (1.0%) stddev-sans-first:0.53 03:08:57 INFO - PID 7621 | Values: 49.0 50.0 49.0 50.0 50.0 49.0 50.0 49.0 49.0 49.0 03:08:57 INFO - PID 7621 | 03:08:57 INFO - PID 7621 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:60.00 stddev:4.64 (7.7%) stddev-sans-first:4.58 03:08:57 INFO - PID 7621 | Values: 56.0 65.0 70.0 66.0 60.0 57.0 57.0 58.0 60.0 59.0 03:08:57 INFO - PID 7621 | 03:08:57 INFO - PID 7621 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:78.00 stddev:14.01 (18.0%) stddev-sans-first:14.42 03:08:57 INFO - PID 7621 | Values: 79.0 81.0 81.0 79.0 71.0 77.0 107.0 103.0 105.0 103.0 03:08:57 INFO - PID 7621 | 03:08:57 INFO - PID 7621 | [#11] stanford-crypto-ccm Cycles:10 Average:142.60 Median:140.00 stddev:9.77 (7.0%) stddev-sans-first:10.22 03:08:57 INFO - PID 7621 | Values: 138.0 141.0 135.0 137.0 136.0 138.0 139.0 141.0 164.0 157.0 03:08:57 INFO - PID 7621 | 03:08:57 INFO - PID 7621 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.60 Median:185.00 stddev:3.60 (1.9%) stddev-sans-first:3.77 03:08:57 INFO - PID 7621 | Values: 183.0 188.0 185.0 184.0 185.0 177.0 185.0 191.0 183.0 185.0 03:08:57 INFO - PID 7621 | 03:08:57 INFO - PID 7621 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:2.13 (3.1%) stddev-sans-first:2.22 03:08:57 INFO - PID 7621 | Values: 69.0 65.0 66.0 68.0 67.0 68.0 67.0 68.0 68.0 73.0 03:08:57 INFO - PID 7621 | -------- Summary: end -------- 03:08:57 INFO - PID 7621 | 03:08:58 INFO - TEST-INFO | 7621: exit 0 03:08:58 INFO - TEST-OK | kraken | took 61513ms 03:08:58 INFO - SUITE-END | took 1181s 03:08:58 INFO - Completed test suite (00:19:42) 03:08:58 INFO - javascript benchmark 03:08:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7724.211575641455, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2698.6896506901703, 3451.344244593527, 3481.234128491731, 3487.2676737885045, 3518.841652125654, 5955.34491205967, 6103.877922441554, 6112.473085128069, 6194.47346975507, 6222.937770622298, 6045.123457098718, 6103.084537319404, 6111.388861113886, 6114.785982490614, 6128.57100003, 5247.86880327992, 5261.4475480074425, 5270.393904700951, 5281.841544753664, 5371.462853714617, 5347.6256662033475, 5351.946480535204, 5368.758405871745, 5370.5435038021815, 5372.516473517383, 5343.171808369709, 5346.465353464661, 5347.518723314901, 5348.090824559834, 5352.090144675395, 5314.096603577401, 5330.173823057432, 5341.385740639837, 5346.946530534684, 5355.812546560871, 5193.896122077537, 5310.946890531084, 5311.150215965427, 5335.759890804923, 5345.4387289334445, 6178.443940045418, 6215.1609532712955, 6233.407826256498, 6244.219472565929, 6261.0, 6437.935620643781, 6467.029945508164, 6468.902966455507, 6493.0, 6517.902231466484, 6313.958196897506, 6410.61536307823, 6429.742810287629, 6431.2604050533855, 6436.388543088399, 6180.969095154541, 6248.218972628421, 6267.122602835607, 6281.277653069864, 6309.242890853127, 6751.25736169021, 6767.255601883789, 6768.424683901825, 6773.983902414579, 6775.3902148805855, 6258.843528911722, 6438.806835794933, 6441.291457939623, 6449.677516124175, 6457.0, 6390.552661313756, 6407.103005579223, 6505.707243174069, 6510.707018184193, 6564.0, 6428.389303016206, 6473.06140609609, 6481.740730370732, 6489.870202595922, 6494.025896115526, 6475.514336424787, 6476.740930362733, 6493.772717954849, 6507.577007494498, 6519.706613202417, 5115.411727651293, 5230.555402790729, 5255.500727430888, 5272.367315922113, 5291.523762861361, 3939.665128464055, 4700.412448443944, 4704.858854234379, 4707.0, 4741.715497070187, 6201.6899155042065, 6206.317305096436, 6208.379162083756, 6213.409726076015, 6223.533235007392, 6271.811845644638, 6401.07184458251, 6565.343465653396, 6609.1077704510235, 6616.4376028037195, 6036.6679832609625, 6062.484688801501, 6084.5132389408745, 6084.726187321581, 6086.573939824259, 5612.326520817528, 5670.177824215466, 5684.062129748628, 5689.743961521742, 5690.9430905690415, 6501.122348482894, 6502.934970650422, 6508.284088750328, 6511.120998665119, 6526.053722210253, 6309.3690630936535, 6358.237011558643, 6359.55483116196, 6380.170577825039, 6381.93618063832, 5516.834494965157, 6509.479241660751, 6510.641914694548, 6543.0, 6735.360140786617, 6424.935750642434, 6428.4857211423905, 6434.453071488976, 6439.066335381437, 6443.6455994920725, 5488.4785945335125, 6468.450181734605, 6568.934310656832, 6581.07864898905, 6593.175853018372, 6216.471599913877, 6278.717457714322, 6310.305866354605, 6314.0, 6315.96842015787, 6250.593711408744, 6294.6852657366035, 6319.684015799284, 6358.268799088164, 6378.808635740936, 6140.289530736458, 6209.503239740719, 6214.689265536796, 6279.340669229665, 6293.213348331458, 6388.169537960035, 6399.488040956805, 6399.840003999937, 6401.327860574573, 6404.071409645669, 6132.20254427538, 6300.149479820166, 6303.054541818764, 6314.905276420949, 6333.778317759041], "value": 5948.503113771409, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.1272667342546, 783.7296132834172, 806.7136166660833, 1135.4947048563392, 1154.393943179831, 28078.438431231363, 38016.0, 38519.42220866686, 38584.0, 38787.41818872719, 40628.18743625133, 41103.79448102763, 41123.38314925271, 41148.38277425841, 41283.76148715536, 6130.356312587181, 8510.914890851089, 8662.696805611804, 8697.565121743919, 8729.956350218241, 6202.193714817067, 8405.117462666392, 8589.871151932726, 8601.0, 8626.741197764046, 8564.186402291803, 8614.612342444605, 8652.697155599555, 8669.913300867005, 8699.304055675531, 8570.228679418851, 8637.827243455096, 8641.092685268019, 8650.437721548142, 8652.394332396734, 8562.443441176365, 8602.01076876161, 8610.52642104684, 8625.051244363114, 8631.180037896389, 38706.419403708685, 38716.61283387158, 38727.612723872684, 38754.0, 38846.22307553861, 3501.8074005929666, 3538.575370955476, 3541.6281290464644, 3545.06055895188, 3550.0947258449187, 31155.376892462024, 31194.724553921966, 31216.37567248665, 31250.687493125006, 31381.8430907844, 3067.8466076696077, 3138.0272115644225, 3161.4309424303615, 3170.7621928355234, 3176.6664500227607, 265351.0, 270075.0, 271258.0, 271589.0, 271913.0, 50504.494955050715, 50598.0, 50714.74642626837, 50732.23901641478, 50818.74590627023, 52855.471445285824, 52859.0, 52874.206886896725, 52953.73523132437, 53027.6743081426, 12203.450844711831, 14719.779203311959, 14764.852351476562, 14778.926105369404, 14790.926045369919, 10087.445190514445, 11987.041036717043, 12000.519979200908, 12030.87969120315, 12051.75896482083, 11506.884931150582, 11607.76784464323, 12770.425330860133, 12872.292023938586, 13112.213267203999, 5218.921716174261, 5245.606579506552, 5260.92108618371, 5262.789488420421, 5262.868428289246, 1007.5667462990838, 1035.668586052456, 1037.8910214427376, 1075.424647813416, 1086.9565217391216, 23545.41136471602, 24699.382515436897, 24760.87619561927, 24764.25707228786, 24800.37999050002, 1120.708615759892, 1126.5212284778936, 1159.5709587452698, 1162.4710756605893, 1169.368540987874, 10287.537060832281, 12088.576899808464, 12606.180598261084, 12624.295720077856, 12754.872451275554, 304226.0, 305358.0, 305866.0, 305989.0, 306156.0, 55949.72025139848, 56009.43990560124, 56145.1578226327, 56219.999999999185, 56238.18809059531, 1458.9635259118395, 1493.111598598832, 1532.341093329879, 1546.3505327762366, 1552.2937063636018, 24055.879720601286, 24292.51414971726, 24337.51324973526, 24351.634725479485, 24384.51230975406, 40453.39319910145, 40478.9880252996, 40507.0, 40549.594504054585, 40564.985875353355, 284935.0, 285503.0, 285553.5722321375, 285850.0, 287166.0, 31412.52881206738, 35833.46249806307, 35926.461103082955, 36648.0, 36750.26499469942, 37387.878363649135, 39474.80262598669, 39639.80180099081, 39711.41875778065, 46883.53116468792, 28775.568366474938, 29539.852300739218, 31674.68325316717, 32319.35361292808, 32474.83762581172, 24828.255152345457, 30418.54372184463, 30427.0, 31418.842905785325, 31666.366672666878, 29862.402751945276, 37426.8128659355, 38175.04562385962, 38222.80888595539, 38318.80840595779, 24412.63381049321, 31681.0, 32369.190770230933, 33148.50277245795, 33505.0, 22832.556256840395, 23561.29316120519, 24103.035878565363, 24105.397365066012, 24459.75540244575], "value": 17506.919959118088, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.3209379060634, 429.57381493441744, 435.47742708749496, 435.9934600980986, 456.03776032571267, 20202.59594808103, 21802.0, 22303.888480557576, 22507.54984900305, 22540.54918901623, 21553.13787448504, 22580.88709556454, 22951.0, 23432.179873704423, 23656.645150322714, 5986.401359864, 6045.183900173464, 6299.181106456154, 6305.180326557541, 6307.968460157693, 6031.668258245794, 6258.217722784652, 6258.561900666955, 6269.404406581368, 6284.937150628481, 5832.708364581775, 6074.331823499411, 6142.938570614304, 6241.344658810827, 6258.0, 6109.755609775603, 6155.846103847395, 6157.3842615738295, 6161.568690191689, 6167.568270221086, 5355.0896347621, 5464.98897703926, 5517.641353312062, 5598.832035038915, 5618.15727640853, 25046.87476562624, 26564.937402503878, 28360.0, 28634.0, 28722.712772872423, 2190.255313193522, 2285.451491641994, 2290.038183962723, 2293.6674182243482, 2294.73610534789, 17699.0, 17810.0, 18067.819321806746, 18172.818271817247, 18343.899366037946, 2116.767155612881, 2134.6584546472645, 2178.0307763045453, 2183.530540933707, 2183.836212284085, 146731.7287789855, 154260.0, 157550.0, 158508.20745896312, 164277.17861410737, 11370.772584548262, 12079.879201207876, 12107.213031152947, 12117.27296362221, 12147.392630368622, 16423.507294781175, 16461.506154815375, 16485.010899346078, 16485.17574121289, 16510.0, 8690.956545217234, 8898.510581918057, 8938.86591701125, 8984.146506081912, 9039.322050846213, 7464.365528929993, 8443.0, 8448.662053517914, 8634.79112924191, 8646.417398778658, 7452.329290363893, 7585.924140758632, 7650.540967541965, 7672.271134242238, 7673.846523069507, 2077.9376618701463, 2084.749830020377, 2085.1450905128822, 2085.8018488243897, 2226.387743370586, 921.2307723051193, 942.8632848237104, 950.1828427552299, 991.4051569058652, 1006.4615430744517, 19688.31090911811, 20416.285430009877, 20438.489037774176, 20527.0, 20540.281090162072, 914.6341463414687, 917.2799352508249, 974.288769198489, 987.7702260685493, 1020.8366661334151, 9117.908820911838, 9761.121499065119, 10675.626353077605, 10703.518341674644, 10784.0, 537602.0, 555197.0, 559984.0, 565411.0, 570328.0, 119714.0, 120330.0, 120589.39705301593, 121740.0, 124308.75691242972, 1064.3338437214727, 1075.102289588187, 1092.202692034819, 1162.0715796193545, 1167.6263595649311, 14691.55925322242, 17961.910190448965, 18032.36886708959, 18084.0, 18196.81803181951, 55995.0, 57559.0, 57780.133297999724, 58229.4177058224, 58245.0, 77679.0, 77975.61012194902, 79231.2646983943, 80141.79787303078, 80636.0, 8465.0, 8669.956650216709, 8808.973935994629, 8830.248915049582, 8946.284297256074, 12161.635150945485, 12672.87327126717, 13898.374573144434, 13912.304384780518, 14372.640683982983, 11685.240459370114, 11805.0, 11854.11094167958, 12024.458899349374, 12140.939295303468, 11039.83440248413, 11093.16801239894, 11236.381998990135, 11429.142814289127, 11459.31244125355, 10566.735831604272, 10780.191485638452, 11755.412229388667, 11982.041436685218, 12171.391430428266, 8272.214139656722, 8456.788580285542, 8693.956530217309, 8826.514541700011, 8837.381383303107, 11547.076233901436, 11580.884191158317, 11772.52909883595, 11888.227265227733, 11893.226940248856], "value": 10332.524431812537, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1173.5012619636652, 1355.3155656393524, 1425.109306683323, 1447.0811034992782, 1455.5342290467051, 9776.560054797534, 10160.237982151331, 11510.597129100473, 11610.941945290262, 11895.702607434818, 11643.883561164386, 11731.002864756485, 11733.70665733357, 11755.529778808837, 11784.116191285644, 2443.413580740623, 2491.4145175883655, 2497.8001759859167, 2498.7376325485743, 2498.800095992316, 1776.8450507170314, 2125.7767934366902, 2162.340486151723, 2189.5730332585154, 2380.5238952209543, 2056.3008577083788, 2471.7404672509397, 2472.332470233045, 2472.4066224106264, 2484.9875750621222, 2429.7205821330595, 2444.1934161726585, 2464.5687004774095, 2467.728549859514, 2478.120267305099, 2056.640087984597, 2392.5781249999905, 2406.5908795504806, 2418.5525677749674, 2422.39440139965, 11581.652550423501, 11705.590304339306, 11707.0, 11734.70663233426, 11750.882491175063, 5633.380328163898, 6389.8402539936405, 6641.236257830363, 6647.335266473314, 6668.9666551667415, 3931.4495970564144, 4105.137921036586, 4215.283401821697, 4228.513720922103, 4245.0, 1202.2546021466746, 1231.9199252048588, 1277.1443133100752, 1282.2114399644151, 1288.3493835612956, 16538.751918721227, 16561.585960351087, 16573.337066517324, 16591.585210369718, 16602.66794664112, 5553.50018498329, 5707.315122185364, 5864.882702346014, 5877.206577112035, 6011.248593925759, 13886.791698124536, 13891.374888130058, 13896.0, 13897.16617002983, 13902.304884755722, 6549.2468366137555, 6717.395434410926, 6731.798046058626, 6736.2590115087305, 6740.494462915301, 5867.295924489089, 6084.60450070744, 6140.846478838065, 6151.6001459904965, 6152.8769424611255, 4126.154138401621, 4271.914561708749, 4281.464816897887, 4284.400183974246, 4588.632909367243, 1301.7763302495814, 1320.808482769993, 1323.126736354021, 1324.6224825924564, 1374.6838227207797, 781.3397678961269, 817.8282560662327, 819.4427789103466, 821.256762629821, 831.9251267385964, 5583.972080139654, 6337.493000559944, 6478.838029049311, 6889.173299204128, 6952.513324067368, 827.2389401750404, 908.4640062363237, 910.4400793511943, 917.0416914324413, 928.1414691410419, 4353.933286344865, 4608.239640459354, 4625.5836974671765, 4627.514111018362, 4808.422989241313, 13096.0, 15298.464553740565, 15319.540413787605, 15324.387024518894, 15326.23368831554, 14702.01522794409, 14941.10353378779, 15239.16184609835, 15272.770908436383, 15285.465008724641, 8526.488410695254, 8549.273311768446, 8662.826743465095, 8803.471791692518, 8812.559372031374, 6930.930690693029, 7040.542364746275, 7161.606111663908, 7178.60517671533, 7185.820354491179, 13440.723131302511, 13446.731065378834, 13607.639236076313, 13733.381997810322, 13764.862351376758, 13720.313984300945, 13765.174089554659, 13833.58499244984, 13982.370793314121, 14109.29453527299, 9507.191888689538, 9536.23710103204, 9550.235981121632, 9769.706908792748, 9864.260180486348, 10772.24594278393, 10835.187360947803, 10851.837222441827, 10858.402787846744, 10873.184511161537, 8996.460212387277, 9245.121713437213, 9342.159205671522, 9345.906540934775, 9429.62281508732, 8990.460572365679, 9053.139951704577, 9075.410098343587, 9154.725358239264, 9178.954105229432, 8110.351171906352, 8131.593420328842, 8229.341652667652, 8246.340292776444, 8259.793505162419, 5355.892882142258, 5489.094299440548, 5845.298564172326, 5906.557008224315, 6350.079238510298, 6066.848328791639, 6186.226721659793, 6190.442860142429, 6244.063390491463, 6263.123162757127], "value": 5398.084496326435, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.6033145363097, 381.919796842663, 391.9372900335947, 393.1233349630323, 396.1680471010878, 5362.766563690344, 5688.5015715335085, 5698.430156984305, 5720.170575266589, 5749.310082790061, 5347.46525347466, 5404.513593776559, 5539.861503462415, 5550.780547282567, 5583.441655834425, 3718.8326525306425, 4031.153457773871, 4081.0613558881473, 4335.132973405323, 4354.956450435503, 3938.9803050984847, 3949.2693851637396, 4317.43873296471, 4319.395284660134, 4342.891427714317, 3193.0101668482844, 4177.832886684529, 4296.935545966813, 4302.612764851163, 4313.374560688699, 3487.773294735834, 4199.7480151190875, 4262.318029115327, 4307.547707490731, 4319.02821865081, 3797.544294684628, 3804.353259945816, 3804.8668296609762, 3805.0487378155462, 3810.5236845394325, 5472.7263636818, 5501.752421141018, 5504.256925315071, 5517.282753242052, 5526.651173251352, 4555.155162159331, 4692.343071969893, 4903.215485522299, 4957.3059771632, 4965.925511117336, 5102.897942041175, 5913.940860591382, 5985.072313791369, 5996.790112346091, 6009.0, 4112.100968816977, 4123.195976784528, 4128.6284234418745, 4132.235536425771, 4132.297509423405, 5012.172991456406, 5206.817761378372, 5928.413309947463, 6294.653794041372, 6299.181106456132, 4123.3196522574035, 4192.874213773592, 4195.119025004722, 4196.475440569929, 4203.936940945889, 3552.236269202134, 4265.55211702773, 4270.466191726035, 4279.828806847753, 4282.850100246476, 4113.753174809521, 4902.852914412573, 4956.529129732669, 4959.975200123977, 4971.5028497150715, 6061.878762424815, 6068.271807383054, 6070.666113363807, 6072.180255665517, 6091.238595175603, 1281.39774306076, 1389.235920243882, 1433.6917562723856, 1450.8828202284394, 1455.5851582298994, 878.499255424402, 966.1256562810527, 970.9174720148725, 975.8097171051577, 985.482621623639, 5715.228444160069, 5726.312842458931, 5730.049024752256, 5731.942680573141, 5747.712614369349, 5376.623636345418, 5564.693941833238, 6042.610199654104, 6336.398042185985, 6341.968290158519, 4823.614110871122, 5079.974600126976, 5525.198846167284, 5552.555795536347, 5726.3700992890745, 3039.407315573442, 3276.672332766704, 3332.666733326648, 3335.6997870191312, 3340.8329583520726, 6054.636721796706, 6317.810465686037, 6480.921562257984, 6510.18622672166, 6553.672316384162, 5731.799387021434, 6074.635521868702, 6453.967730161319, 6486.189226346707, 6542.836429089216, 5371.731413429313, 6497.480201583862, 6543.411093001652, 6546.607203567801, 6574.408303252731, 5492.633356481687, 5614.326280846324, 6320.6839658016, 6323.0, 6392.552521323649, 5062.063518249136, 5433.782648694008, 5962.940370596239, 6203.038529028008, 6236.5053978409, 5882.294124705063, 6135.84660383494, 6321.304656487875, 6422.454091402283, 6447.258565265054, 4139.027328577721, 4163.812628431668, 4175.937360939528, 4180.327868852483, 4186.748795072305, 4940.777665005012, 5664.49019588239, 6138.631682099089, 6219.440250377307, 6243.4422871303295, 4995.675281106716, 6081.483073938588, 6097.237845269341, 6098.634081955097, 6102.9694851525455, 5076.517730815566, 5361.651492653121, 5821.883562328814, 5857.736401862012, 6012.819615411545, 5623.381428042994, 5919.852003699942, 5948.4943779779205, 5979.730912108878, 6028.8794224116145, 5394.919076213939, 6042.123892035543, 6118.357572455006, 6121.540884433774, 6132.202813634199, 5695.45893140151, 5949.8215053548465, 5954.434328738763, 5960.466801609212, 5978.312494063064], "value": 4421.998547664312, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.7728988078876, 833.3041910005145, 849.4903058165102, 853.6372041882203, 856.9357298202632, 13390.933045334772, 17863.642727145467, 18548.25806967723, 18668.346607868727, 18702.251909923605, 16810.411635592758, 17057.914710426463, 17170.656586868285, 17199.484015479524, 17206.225719842605, 961.4711908450341, 981.0385821894548, 999.5452069308484, 1000.9840012387433, 1001.9098281154695, 670.0451856105055, 693.1266604078871, 960.9183219426358, 1012.4937531234383, 1022.6267412394496, 1061.3419679798535, 1066.3335415365398, 1067.8398240263946, 1070.6038765656717, 1072.4905669806858, 1048.7692707604315, 1059.5285098131335, 1061.7239517725409, 1063.1601035182198, 1064.249703958715, 781.1797612506845, 785.5993443343935, 785.7407055671615, 785.8899754034439, 788.4126325887194, 15496.070235785888, 16368.345266189339, 16601.91699041509, 16818.243179056848, 16908.323667053304, 13313.334333283394, 13970.93014534931, 16049.679006419923, 16367.181640918026, 16523.6695266094, 15337.23313834315, 15543.844561554353, 15657.530274091796, 15761.369545218178, 15802.762958555631, 5245.947540524584, 5273.973630131824, 5281.973590132025, 5285.101532739405, 5288.656237344599, 123383.76616233813, 124062.01100840328, 124100.37949810283, 126272.73727262701, 127429.0, 11371.31772093677, 11778.94110529459, 12812.167209131376, 12934.611961641165, 12968.546100886424, 20025.59820812529, 24861.0, 25109.246722598353, 25142.0, 25788.484230315287, 7756.340711039512, 7860.489068210548, 7954.244346787046, 7961.084475285301, 7962.840743185104, 3964.7621142731527, 3995.4606128172904, 4050.8177132029127, 4054.1283624020975, 4054.412110243998, 4199.811008504625, 4295.699301048897, 4313.072689371737, 4317.41714868495, 4320.935185972213, 805.1666525146445, 912.1790388650268, 933.0902370189146, 934.6915517879083, 935.5883411299006, 644.2333622988629, 668.4117976180929, 670.0652589637526, 672.9461643068543, 683.3644710419358, 10743.892561074446, 11627.941860290644, 11641.449357945738, 11857.762844743056, 11912.702182445508, 651.4202359899693, 657.9210494740566, 660.3825423229296, 671.1375881991618, 690.8756423843656, 4963.553280204799, 5323.574114070865, 5430.56555475561, 5540.36285827135, 5669.489745922887, 100925.49537252414, 102151.48924255332, 102528.0, 103475.0, 105777.0, 69634.65182674055, 88844.0, 89485.0, 92756.53621731984, 92846.0, 79111.60444197743, 80740.54075674049, 81139.0, 81835.18164818395, 81947.0, 9433.622655093719, 11076.169287303323, 11115.499802509068, 11290.266132701348, 11394.658160255205, 38324.6167538321, 38721.2255754889, 38924.41613375858, 39053.0, 39893.0, 39878.80060599678, 47266.76366618145, 51634.74182629063, 51966.22050669167, 52698.0, 13803.378847952066, 14238.216898070705, 14345.211013394364, 14439.278036098363, 14478.420863165355, 15467.690646186787, 17680.469585912444, 18054.5486362842, 18519.44441666752, 18756.812431875507, 16099.75850362269, 16283.511494655178, 16355.264013119677, 16947.0, 16974.40589579359, 16425.342986280415, 16699.666006679556, 16810.411635592696, 17028.574285642957, 17497.737533937256, 14932.253387330808, 15031.699366012399, 15184.316705748488, 15420.614484637974, 15424.845751542342, 9195.310351723781, 9686.903130968882, 11015.0, 11611.535538578362, 12102.515899363927, 12452.439640216031, 12473.87526124727, 12492.813182747625, 12541.74916501683, 12553.686157846127], "value": 8268.164950261715, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1463.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 109.0, 111.0, 112.0, 115.0, 162.0, 166.0, 112.0, 111.0], "value": 122.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 114.0, 138.0, 188.0, 112.0, 110.0, 111.0, 112.0, 130.0, 110.0], "value": 127.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 186.0, 185.0, 189.0, 187.0, 184.0, 188.0, 183.0, 187.0, 187.0], "value": 186.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 59.0, 91.0, 60.0, 59.0, 58.0, 79.0, 92.0, 87.0], "value": 72.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 69.0, 87.0, 69.0, 69.0, 70.0, 105.0, 101.0, 102.0, 91.0], "value": 85.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 89.0, 88.0, 87.0, 87.0, 88.0, 88.0, 88.0, 87.0], "value": 87.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 94.0, 96.0, 95.0, 94.0, 93.0], "value": 94.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 131.0, 83.0, 87.0, 86.0, 84.0, 84.0, 105.0, 87.0, 83.0], "value": 93.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 50.0, 49.0, 50.0, 50.0, 49.0, 50.0, 49.0, 49.0, 49.0], "value": 49.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 65.0, 70.0, 66.0, 60.0, 57.0, 57.0, 58.0, 60.0, 59.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 81.0, 79.0, 71.0, 77.0, 107.0, 103.0, 105.0, 103.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 141.0, 135.0, 137.0, 136.0, 138.0, 139.0, 141.0, 164.0, 157.0], "value": 142.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 188.0, 185.0, 184.0, 185.0, 177.0, 185.0, 191.0, 183.0, 185.0], "value": 184.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 66.0, 68.0, 67.0, 68.0, 67.0, 68.0, 68.0, 73.0], "value": 67.9, "unit": "score"}]}]} 03:08:59 INFO - Return code: 0 03:08:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:08:59 ERROR - # TBPL SUCCESS # 03:08:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:08:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:08:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:08:59 INFO - 2017-04-18 03:08:59.093 screenresolution[7626:149231] starting screenresolution argv=screenresolution get 03:08:59 INFO - 2017-04-18 03:08:59.096 screenresolution[7626:149231] Display 0: 1600x1200x32@60 03:08:59 INFO - 2017-04-18 03:08:59.102 screenresolution[7627:149234] starting screenresolution argv=screenresolution list 03:08:59 INFO - Available Modes on Display 0 03:08:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:08:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:08:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:08:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:08:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:08:59 INFO - Intel Iris: 03:08:59 INFO - Chipset Model: Intel Iris 03:08:59 INFO - Type: GPU 03:08:59 INFO - Bus: Built-In 03:08:59 INFO - VRAM (Dynamic, Max): 1536 MB 03:08:59 INFO - Vendor: Intel (0x8086) 03:08:59 INFO - Device ID: 0x0a2e 03:08:59 INFO - Revision ID: 0x0009 03:08:59 INFO - Displays: 03:08:59 INFO - Display: 03:08:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:08:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:08:59 INFO - Display Serial Number: 1600x1200 60 03:08:59 INFO - Main Display: Yes 03:08:59 INFO - Mirror: Off 03:08:59 INFO - Online: Yes 03:08:59 INFO - Rotation: Supported 03:08:59 INFO - Return code: 0 03:08:59 INFO - Running post-action listener: _resource_record_post_action 03:08:59 INFO - [mozharness: 2017-04-18 10:08:59.342155Z] Finished run-tests step (success) 03:08:59 INFO - Running post-run listener: _resource_record_post_run 03:08:59 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 143360; Write bytes: 517818368; Read time: 4; Write time: 1592 03:08:59 INFO - TinderboxPrint: CPU usage
53.4% 03:08:59 INFO - TinderboxPrint: I/O read bytes / time
143,360 / 4 03:08:59 INFO - TinderboxPrint: I/O write bytes / time
517,818,368 / 1,592 03:08:59 INFO - TinderboxPrint: CPU idle
2,241.6 (46.6%) 03:08:59 INFO - TinderboxPrint: CPU system
964.7 (20.0%) 03:08:59 INFO - TinderboxPrint: CPU user
1,607.4 (33.4%) 03:08:59 INFO - TinderboxPrint: Swap in / out
207,814,656 / 0 03:08:59 INFO - install - Wall time: 20s; CPU: 55.0%; Read bytes: 207839744; Write bytes: 206936064; Read time: 16042; Write time: 416 03:08:59 INFO - run-tests - Wall time: 1183s; CPU: 53.0%; Read bytes: 143360; Write bytes: 303693824; Read time: 4; Write time: 1144 03:08:59 INFO - Running post-run listener: _upload_blobber_files 03:08:59 INFO - Blob upload gear active. 03:08:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:08:59 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 03:08:59 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'] 03:08:59 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 03:09:00 INFO - (blobuploader) - INFO - Open directory for files ... 03:09:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:09:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:09:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:09:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:09:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:09:00 INFO - (blobuploader) - INFO - Done attempting. 03:09:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:09:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:09:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:09:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:09:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:09:01 INFO - (blobuploader) - INFO - Done attempting. 03:09:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:09:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:09:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:09:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:09:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:09:02 INFO - (blobuploader) - INFO - Done attempting. 03:09:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:09:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:09:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:09:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:09:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:09:05 INFO - (blobuploader) - INFO - Done attempting. 03:09:05 INFO - (blobuploader) - INFO - Iteration through files over. 03:09:05 INFO - Return code: 0 03:09:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:09:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:09:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cde36651965b341186317c3c6bf01eb95dca1af6be608f34b28568e190e507fe05ecacc35054cb5700fb19b839da0cef92ec5d1d0f6c265152f9bb79fa622b3d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54d8716ce0d6e991cdf4b873c3abcbc082c783ed12f7149ae4d6c5a61f28808b1ad4275657d4348486faecb5287214010a4d65a67c0ac2a2c06c649db71b3332", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bca805c3c6573f6c5cb8e876dcbcd1d565bfd5851dd75fff8effb7f81d1d843aea9a663c936fd5903b48c9bc93e6a20c23159790e6b3c765d6ef26cf85ac68bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c990ce9914db7cfd400cc0763c4a4a80325830dadecd410d2c63eb83effb793d78f55a13a1ea6085ceb92c4b14a085ea96e2a0e54a33257385e29c033aee84f5"} 03:09:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:09:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:09:05 INFO - Contents: 03:09:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cde36651965b341186317c3c6bf01eb95dca1af6be608f34b28568e190e507fe05ecacc35054cb5700fb19b839da0cef92ec5d1d0f6c265152f9bb79fa622b3d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54d8716ce0d6e991cdf4b873c3abcbc082c783ed12f7149ae4d6c5a61f28808b1ad4275657d4348486faecb5287214010a4d65a67c0ac2a2c06c649db71b3332", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bca805c3c6573f6c5cb8e876dcbcd1d565bfd5851dd75fff8effb7f81d1d843aea9a663c936fd5903b48c9bc93e6a20c23159790e6b3c765d6ef26cf85ac68bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c990ce9914db7cfd400cc0763c4a4a80325830dadecd410d2c63eb83effb793d78f55a13a1ea6085ceb92c4b14a085ea96e2a0e54a33257385e29c033aee84f5"} 03:09:05 INFO - Running post-run listener: copy_logs_to_upload_dir 03:09:05 INFO - Copying logs to upload dir... 03:09:05 INFO - mkdir: /builds/slave/test/build/upload/logs 03:09:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.970445 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-04-18 03:09:05.656263) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-18 03:09:05.660299) ========= 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.ZmCJz7xugu/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.Am0xwANu7j/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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/cde36651965b341186317c3c6bf01eb95dca1af6be608f34b28568e190e507fe05ecacc35054cb5700fb19b839da0cef92ec5d1d0f6c265152f9bb79fa622b3d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54d8716ce0d6e991cdf4b873c3abcbc082c783ed12f7149ae4d6c5a61f28808b1ad4275657d4348486faecb5287214010a4d65a67c0ac2a2c06c649db71b3332", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bca805c3c6573f6c5cb8e876dcbcd1d565bfd5851dd75fff8effb7f81d1d843aea9a663c936fd5903b48c9bc93e6a20c23159790e6b3c765d6ef26cf85ac68bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c990ce9914db7cfd400cc0763c4a4a80325830dadecd410d2c63eb83effb793d78f55a13a1ea6085ceb92c4b14a085ea96e2a0e54a33257385e29c033aee84f5"} build_url:https://queue.taskcluster.net/v1/task/URdcIZuiTimOBMVGo9sgVg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011654 build_url: 'https://queue.taskcluster.net/v1/task/URdcIZuiTimOBMVGo9sgVg/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/cde36651965b341186317c3c6bf01eb95dca1af6be608f34b28568e190e507fe05ecacc35054cb5700fb19b839da0cef92ec5d1d0f6c265152f9bb79fa622b3d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54d8716ce0d6e991cdf4b873c3abcbc082c783ed12f7149ae4d6c5a61f28808b1ad4275657d4348486faecb5287214010a4d65a67c0ac2a2c06c649db71b3332", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bca805c3c6573f6c5cb8e876dcbcd1d565bfd5851dd75fff8effb7f81d1d843aea9a663c936fd5903b48c9bc93e6a20c23159790e6b3c765d6ef26cf85ac68bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c990ce9914db7cfd400cc0763c4a4a80325830dadecd410d2c63eb83effb793d78f55a13a1ea6085ceb92c4b14a085ea96e2a0e54a33257385e29c033aee84f5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-18 03:09:05.695922) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 03:09:05.696253) ========= 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.ZmCJz7xugu/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.Am0xwANu7j/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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.005235 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 03:09:05.748161) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-18 03:09:05.748745) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-18 03:09:05.749384) ========= ========= Total master_lag: 0.19 =========