builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0180 starttime: 1492860405.99 results: success (0) buildid: 20170422030205 builduid: d556da6f77a14e54ac35b497def50801 revision: 7d85b081bfabe91dbf18a421f1eee2a32f335823 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-22 04:26:45.991768) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-22 04:26:45.992242) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-22 04:26:45.992530) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-22 04:26:46.162930) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-22 04:26:46.163325) ========= 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.KRIDkGrirE/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.6mlxGQEyYw/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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-22 04:26:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.1M=0.001s 2017-04-22 04:26:46 (18.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.281361 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-22 04:26:46.470147) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-22 04:26:46.470496) ========= 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.KRIDkGrirE/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.6mlxGQEyYw/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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.029968 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-22 04:26:46.522560) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-22 04:26:46.522903) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7d85b081bfabe91dbf18a421f1eee2a32f335823 --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 7d85b081bfabe91dbf18a421f1eee2a32f335823 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KRIDkGrirE/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.6mlxGQEyYw/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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-22 04:26:46,592 truncating revision to first 12 chars 2017-04-22 04:26:46,592 Setting DEBUG logging. 2017-04-22 04:26:46,593 attempt 1/10 2017-04-22 04:26:46,593 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7d85b081bfab?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-22 04:26:48,379 unpacking tar archive at: mozilla-central-7d85b081bfab/testing/mozharness/ program finished with exit code 0 elapsedTime=2.151123 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-22 04:26:48.698499) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-22 04:26:48.698826) ========= script_repo_revision: 7d85b081bfabe91dbf18a421f1eee2a32f335823 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-22 04:26:48.699212) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-22 04:26:48.699494) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-22 04:26:48.720243) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2017-04-22 04:26:48.720537) ========= /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.KRIDkGrirE/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.6mlxGQEyYw/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:26:48 INFO - MultiFileLogger online at 20170422 04:26:48 in /builds/slave/test 04:26:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:26:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:26:48 INFO - {'append_to_log': False, 04:26:48 INFO - 'base_work_dir': '/builds/slave/test', 04:26:48 INFO - 'blob_upload_branch': 'Firefox', 04:26:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:26:48 INFO - 'branch': 'Firefox', 04:26:48 INFO - 'buildbot_json_path': 'buildprops.json', 04:26:48 INFO - 'config_files': ('talos/mac_config.py',), 04:26:48 INFO - 'default_actions': ('clobber', 04:26:48 INFO - 'read-buildbot-config', 04:26:48 INFO - 'download-and-extract', 04:26:48 INFO - 'populate-webroot', 04:26:48 INFO - 'create-virtualenv', 04:26:48 INFO - 'install', 04:26:48 INFO - 'run-tests'), 04:26:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:26:48 INFO - 'download_minidump_stackwalk': True, 04:26:48 INFO - 'download_symbols': 'ondemand', 04:26:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:26:48 INFO - 'tooltool.py': '/tools/tooltool.py', 04:26:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:26:48 INFO - '/tools/misc-python/virtualenv.py')}, 04:26:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:26:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:26:48 INFO - 'gecko_profile': False, 04:26:48 INFO - 'gecko_profile_interval': 0, 04:26:48 INFO - 'installer_path': 'installer.exe', 04:26:48 INFO - 'log_level': 'info', 04:26:48 INFO - 'log_name': 'talos', 04:26:48 INFO - 'log_to_console': True, 04:26:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:26:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:26:48 INFO - 'opt_config_files': (), 04:26:48 INFO - 'pip_index': False, 04:26:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:26:48 INFO - 'cmd': ('bash', 04:26:48 INFO - '-c', 04:26:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:26:48 INFO - 'enabled': True, 04:26:48 INFO - 'halt_on_failure': False, 04:26:48 INFO - 'name': 'check_screen_resolution'},), 04:26:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:26:48 INFO - 'cmd': ('bash', 04:26:48 INFO - '-c', 04:26:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:26:48 INFO - 'enabled': True, 04:26:48 INFO - 'halt_on_failure': False, 04:26:48 INFO - 'name': 'check_screen_resolution'},), 04:26:48 INFO - 'run_cmd_checks_enabled': True, 04:26:48 INFO - 'suite': 'dromaeojs', 04:26:48 INFO - 'system_bits': '32', 04:26:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:26:48 INFO - 'title': 't-yosemite-r7-0180', 04:26:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:26:48 INFO - 'use_talos_json': True, 04:26:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:26:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:26:48 INFO - 'work_dir': 'build'} 04:26:48 INFO - [mozharness: 2017-04-22 11:26:48.906452Z] Running clobber step. 04:26:48 INFO - Running pre-action listener: _resource_record_pre_action 04:26:48 INFO - Running main action method: clobber 04:26:48 INFO - rmtree: /builds/slave/test/build 04:26:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:26:51 INFO - Running post-action listener: _resource_record_post_action 04:26:51 INFO - [mozharness: 2017-04-22 11:26:51.487332Z] Finished clobber step (success) 04:26:51 INFO - [mozharness: 2017-04-22 11:26:51.487494Z] Running read-buildbot-config step. 04:26:51 INFO - Running pre-action listener: _resource_record_pre_action 04:26:51 INFO - Running main action method: read_buildbot_config 04:26:51 INFO - Using buildbot properties: 04:26:51 INFO - { 04:26:51 INFO - "project": "", 04:26:51 INFO - "product": "firefox", 04:26:51 INFO - "script_repo_revision": "production", 04:26:51 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:26:51 INFO - "repository": "", 04:26:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:26:51 INFO - "buildid": "20170422030205", 04:26:51 INFO - "stage_platform": "macosx64", 04:26:51 INFO - "basedir": "/builds/slave/test", 04:26:51 INFO - "nightly_build": "True", 04:26:51 INFO - "buildnumber": 28, 04:26:51 INFO - "slavename": "t-yosemite-r7-0180", 04:26:51 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 04:26:51 INFO - "platform": "yosemite_r7", 04:26:51 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:26:51 INFO - "branch": "mozilla-central", 04:26:51 INFO - "repo_path": "mozilla-central", 04:26:51 INFO - "revision": "7d85b081bfabe91dbf18a421f1eee2a32f335823", 04:26:51 INFO - "pgo_build": "False", 04:26:51 INFO - "builduid": "d556da6f77a14e54ac35b497def50801", 04:26:51 INFO - "slavebuilddir": "test" 04:26:51 INFO - } 04:26:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/LS5Yufv8T_KdVlaWrJUi5A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:26:51 INFO - Running post-action listener: _resource_record_post_action 04:26:51 INFO - [mozharness: 2017-04-22 11:26:51.491040Z] Finished read-buildbot-config step (success) 04:26:51 INFO - [mozharness: 2017-04-22 11:26:51.491193Z] Running download-and-extract step. 04:26:51 INFO - Running pre-action listener: _resource_record_pre_action 04:26:51 INFO - Running main action method: download_and_extract 04:26:51 INFO - mkdir: /builds/slave/test/build/tests 04:26:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:51 INFO - trying https://queue.taskcluster.net/v1/task/LS5Yufv8T_KdVlaWrJUi5A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:26:51 INFO - Downloading https://queue.taskcluster.net/v1/task/LS5Yufv8T_KdVlaWrJUi5A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:26:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LS5Yufv8T_KdVlaWrJUi5A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:26:53 INFO - Downloaded 1325 bytes. 04:26:53 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:26:53 INFO - Using the following test package requirements: 04:26:53 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:26:53 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:26:53 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:26:53 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:26:53 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:26:53 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:26:53 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:26:53 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:26:53 INFO - u'jsshell-mac.zip'], 04:26:53 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:26:53 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:26:53 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:26:53 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:26:53 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:26:53 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:26:53 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:26:53 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:26:53 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:26:53 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:26:53 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:26:53 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:26:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LS5Yufv8T_KdVlaWrJUi5A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:26:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LS5Yufv8T_KdVlaWrJUi5A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:26:53 INFO - Fetch https://queue.taskcluster.net/v1/task/LS5Yufv8T_KdVlaWrJUi5A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:27:01 INFO - Content-Length response header: 52523100 04:27:01 INFO - Bytes received: 52523100 04:27:17 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:27:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LS5Yufv8T_KdVlaWrJUi5A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:27:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LS5Yufv8T_KdVlaWrJUi5A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:27:17 INFO - Fetch https://queue.taskcluster.net/v1/task/LS5Yufv8T_KdVlaWrJUi5A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:27:19 INFO - Content-Length response header: 52523100 04:27:19 INFO - Bytes received: 52523100 04:27:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LS5Yufv8T_KdVlaWrJUi5A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:27:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LS5Yufv8T_KdVlaWrJUi5A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:27:35 INFO - Fetch https://queue.taskcluster.net/v1/task/LS5Yufv8T_KdVlaWrJUi5A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:27:36 INFO - Content-Length response header: 14408811 04:27:36 INFO - Bytes received: 14408811 04:27:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:36 INFO - trying https://queue.taskcluster.net/v1/task/LS5Yufv8T_KdVlaWrJUi5A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:27:36 INFO - Downloading https://queue.taskcluster.net/v1/task/LS5Yufv8T_KdVlaWrJUi5A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:27:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LS5Yufv8T_KdVlaWrJUi5A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:27:38 INFO - Downloaded 71119761 bytes. 04:27:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LS5Yufv8T_KdVlaWrJUi5A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:27:38 INFO - mkdir: /builds/slave/test/properties 04:27:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:27:38 INFO - Writing to file /builds/slave/test/properties/build_url 04:27:38 INFO - Contents: 04:27:38 INFO - build_url:https://queue.taskcluster.net/v1/task/LS5Yufv8T_KdVlaWrJUi5A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:27:39 INFO - Running post-action listener: _resource_record_post_action 04:27:39 INFO - Running post-action listener: set_extra_try_arguments 04:27:39 INFO - [mozharness: 2017-04-22 11:27:39.380957Z] Finished download-and-extract step (success) 04:27:39 INFO - [mozharness: 2017-04-22 11:27:39.381091Z] Running populate-webroot step. 04:27:39 INFO - Running pre-action listener: _resource_record_pre_action 04:27:39 INFO - Running main action method: populate_webroot 04:27:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:27:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:27:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:27:39 INFO - '--tppagecycles', 04:27:39 INFO - '7'], 04:27:39 INFO - 'tests': ['tsvgm']}}, 04:27:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:27:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:27:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:27:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:27:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:27:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:27:39 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:27:39 INFO - 'talos_options': ['--disable-e10s'], 04:27:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:27:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:27:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:27:39 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:27:39 INFO - 'talos_options': ['--disable-e10s'], 04:27:39 INFO - 'tests': ['damp', 'tps']}, 04:27:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:27:39 INFO - 'tests': ['damp', 'tps']}, 04:27:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:27:39 INFO - 'tests': ['dromaeo_dom']}, 04:27:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:27:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:27:39 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:27:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:27:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:27:39 INFO - 'tests': ['a11yr', 04:27:39 INFO - 'ts_paint', 04:27:39 INFO - 'tpaint', 04:27:39 INFO - 'sessionrestore', 04:27:39 INFO - 'sessionrestore_no_auto_restore', 04:27:39 INFO - 'tabpaint']}, 04:27:39 INFO - 'other-e10s': {'tests': ['a11yr', 04:27:39 INFO - 'ts_paint', 04:27:39 INFO - 'tpaint', 04:27:39 INFO - 'sessionrestore', 04:27:39 INFO - 'sessionrestore_no_auto_restore', 04:27:39 INFO - 'tabpaint']}, 04:27:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:27:39 INFO - 'ts_paint', 04:27:39 INFO - 'tpaint', 04:27:39 INFO - 'sessionrestore', 04:27:39 INFO - 'sessionrestore_no_auto_restore', 04:27:39 INFO - 'tabpaint']}, 04:27:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:27:39 INFO - 'ts_paint', 04:27:39 INFO - 'tpaint', 04:27:39 INFO - 'sessionrestore', 04:27:39 INFO - 'sessionrestore_no_auto_restore', 04:27:39 INFO - 'tabpaint']}, 04:27:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:27:39 INFO - 'tests': ['a11yr', 04:27:39 INFO - 'ts_paint', 04:27:39 INFO - 'tpaint', 04:27:39 INFO - 'sessionrestore', 04:27:39 INFO - 'sessionrestore_no_auto_restore', 04:27:39 INFO - 'tabpaint']}, 04:27:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:27:39 INFO - 'tests': ['a11yr', 04:27:39 INFO - 'ts_paint', 04:27:39 INFO - 'tpaint', 04:27:39 INFO - 'sessionrestore', 04:27:39 INFO - 'sessionrestore_no_auto_restore', 04:27:39 INFO - 'tabpaint']}, 04:27:39 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:27:39 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:27:39 INFO - 'bloom_basic_ref']}, 04:27:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:27:39 INFO - 'tests': ['tsvgx', 04:27:39 INFO - 'tsvgr_opacity', 04:27:39 INFO - 'tart', 04:27:39 INFO - 'tscrollx', 04:27:39 INFO - 'cart', 04:27:39 INFO - 'tsvg_static']}, 04:27:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:27:39 INFO - 'tsvgr_opacity', 04:27:39 INFO - 'tart', 04:27:39 INFO - 'tscrollx', 04:27:39 INFO - 'cart', 04:27:39 INFO - 'tsvg_static']}, 04:27:39 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:27:39 INFO - 'talos_options': ['--disable-e10s'], 04:27:39 INFO - 'tests': ['tp5o']}, 04:27:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:27:39 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:27:39 INFO - 'talos_options': ['--disable-e10s', 04:27:39 INFO - '--xperf_path', 04:27:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:27:39 INFO - 'tests': ['tp5n']}, 04:27:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:27:39 INFO - 'talos_options': ['--xperf_path', 04:27:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:27:39 INFO - 'tests': ['tp5n']}}, 04:27:39 INFO - 'talos.zip': {'path': '', 04:27:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:27:39 INFO - Running post-action listener: _resource_record_post_action 04:27:39 INFO - [mozharness: 2017-04-22 11:27:39.399877Z] Finished populate-webroot step (success) 04:27:39 INFO - [mozharness: 2017-04-22 11:27:39.399973Z] Running create-virtualenv step. 04:27:39 INFO - Running pre-action listener: _resource_record_pre_action 04:27:39 INFO - Running main action method: create_virtualenv 04:27:39 INFO - Creating virtualenv /builds/slave/test/build/venv 04:27:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:27:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:27:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:27:39 INFO - Using real prefix '/tools/python27' 04:27:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:27:40 INFO - Installing distribute.............................................................................................................................................................................................done. 04:27:43 INFO - Installing pip.................done. 04:27:43 INFO - Return code: 0 04:27:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:27:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:27:43 INFO - Reading from file tmpfile_stdout 04:27:43 INFO - Output received: 04:27:43 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:27:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:27:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:43 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 0x102f4cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f4f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdd1cd0bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d2ad30>, '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 0x102c50db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d1fbe8>, '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.KRIDkGrirE/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.6mlxGQEyYw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:27:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:27:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:27:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRIDkGrirE/Render', 04:27:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:43 INFO - 'HOME': '/Users/cltbld', 04:27:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:43 INFO - 'LOGNAME': 'cltbld', 04:27:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:43 INFO - 'MOZ_NO_REMOTE': '1', 04:27:43 INFO - 'NO_EM_RESTART': '1', 04:27:43 INFO - 'PAGER': '/bin/cat', 04:27:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:43 INFO - 'PWD': '/builds/slave/test', 04:27:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:43 INFO - 'SHELL': '/bin/bash', 04:27:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6mlxGQEyYw/Listeners', 04:27:43 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 04:27:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:43 INFO - 'USER': 'cltbld', 04:27:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:43 INFO - 'XPC_FLAGS': '0x0', 04:27:43 INFO - 'XPC_SERVICE_NAME': '0', 04:27:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:27:43 INFO - Cleaning up... 04:27:43 INFO - Return code: 0 04:27:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:27:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:43 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 0x102f4cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f4f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdd1cd0bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d2ad30>, '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 0x102c50db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d1fbe8>, '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.KRIDkGrirE/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.6mlxGQEyYw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:27:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:27:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:27:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRIDkGrirE/Render', 04:27:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:43 INFO - 'HOME': '/Users/cltbld', 04:27:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:43 INFO - 'LOGNAME': 'cltbld', 04:27:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:43 INFO - 'MOZ_NO_REMOTE': '1', 04:27:43 INFO - 'NO_EM_RESTART': '1', 04:27:43 INFO - 'PAGER': '/bin/cat', 04:27:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:43 INFO - 'PWD': '/builds/slave/test', 04:27:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:43 INFO - 'SHELL': '/bin/bash', 04:27:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6mlxGQEyYw/Listeners', 04:27:43 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 04:27:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:43 INFO - 'USER': 'cltbld', 04:27:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:43 INFO - 'XPC_FLAGS': '0x0', 04:27:43 INFO - 'XPC_SERVICE_NAME': '0', 04:27:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:43 INFO - Downloading/unpacking psutil>=3.1.1 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:27:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:27:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:27:47 INFO - Installing collected packages: psutil 04:27:47 INFO - Running setup.py install for psutil 04:27:48 INFO - building 'psutil._psutil_osx' extension 04:27:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:27:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:27:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:27:48 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:27:48 INFO - building 'psutil._psutil_posix' extension 04:27:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:27:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:27:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:27:48 INFO - ^ 04:27:48 INFO - 1 warning generated. 04:27:48 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:27:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:27:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:27:49 INFO - Successfully installed psutil 04:27:49 INFO - Cleaning up... 04:27:49 INFO - Return code: 0 04:27:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:27: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')]} 04:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27: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')]} 04:27:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:49 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 0x102f4cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f4f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdd1cd0bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d2ad30>, '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 0x102c50db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d1fbe8>, '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.KRIDkGrirE/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.6mlxGQEyYw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:27:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:27:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:27:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRIDkGrirE/Render', 04:27:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:49 INFO - 'HOME': '/Users/cltbld', 04:27:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:49 INFO - 'LOGNAME': 'cltbld', 04:27:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:49 INFO - 'MOZ_NO_REMOTE': '1', 04:27:49 INFO - 'NO_EM_RESTART': '1', 04:27:49 INFO - 'PAGER': '/bin/cat', 04:27:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:49 INFO - 'PWD': '/builds/slave/test', 04:27:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:49 INFO - 'SHELL': '/bin/bash', 04:27:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6mlxGQEyYw/Listeners', 04:27:49 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 04:27:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:49 INFO - 'USER': 'cltbld', 04:27:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:49 INFO - 'XPC_FLAGS': '0x0', 04:27:49 INFO - 'XPC_SERVICE_NAME': '0', 04:27:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:27:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:27:52 INFO - Installing collected packages: mozsystemmonitor 04:27:52 INFO - Running setup.py install for mozsystemmonitor 04:27:52 INFO - Successfully installed mozsystemmonitor 04:27:52 INFO - Cleaning up... 04:27:52 INFO - Return code: 0 04:27:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:27:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:52 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 0x102f4cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f4f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdd1cd0bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d2ad30>, '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 0x102c50db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d1fbe8>, '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.KRIDkGrirE/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.6mlxGQEyYw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:27:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:27:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:27:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRIDkGrirE/Render', 04:27:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:52 INFO - 'HOME': '/Users/cltbld', 04:27:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:52 INFO - 'LOGNAME': 'cltbld', 04:27:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:52 INFO - 'MOZ_NO_REMOTE': '1', 04:27:52 INFO - 'NO_EM_RESTART': '1', 04:27:52 INFO - 'PAGER': '/bin/cat', 04:27:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:52 INFO - 'PWD': '/builds/slave/test', 04:27:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:52 INFO - 'SHELL': '/bin/bash', 04:27:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6mlxGQEyYw/Listeners', 04:27:52 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 04:27:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:52 INFO - 'USER': 'cltbld', 04:27:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:52 INFO - 'XPC_FLAGS': '0x0', 04:27:52 INFO - 'XPC_SERVICE_NAME': '0', 04:27:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:52 INFO - Downloading/unpacking jsonschema==2.5.1 04:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:27:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:55 INFO - Downloading functools32-3.2.3-2.tar.gz 04:27:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:27:55 INFO - warning: no files found matching '*.txt' 04:27:55 INFO - no previously-included directories found matching 'build' 04:27:55 INFO - no previously-included directories found matching 'dist' 04:27:55 INFO - no previously-included directories found matching '.git*' 04:27:55 INFO - Installing collected packages: jsonschema, functools32 04:27:55 INFO - Running setup.py install for functools32 04:27:55 INFO - warning: no files found matching '*.txt' 04:27:55 INFO - no previously-included directories found matching 'build' 04:27:55 INFO - no previously-included directories found matching 'dist' 04:27:55 INFO - no previously-included directories found matching '.git*' 04:27:56 INFO - Successfully installed jsonschema functools32 04:27:56 INFO - Cleaning up... 04:27:56 INFO - Return code: 0 04:27:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102f4cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f4f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdd1cd0bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d2ad30>, '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 0x102c50db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d1fbe8>, '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.KRIDkGrirE/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.6mlxGQEyYw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:27:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:27:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRIDkGrirE/Render', 04:27:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:56 INFO - 'HOME': '/Users/cltbld', 04:27:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:56 INFO - 'LOGNAME': 'cltbld', 04:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:56 INFO - 'MOZ_NO_REMOTE': '1', 04:27:56 INFO - 'NO_EM_RESTART': '1', 04:27:56 INFO - 'PAGER': '/bin/cat', 04:27:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:56 INFO - 'PWD': '/builds/slave/test', 04:27:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:56 INFO - 'SHELL': '/bin/bash', 04:27:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6mlxGQEyYw/Listeners', 04:27:56 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 04:27:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:56 INFO - 'USER': 'cltbld', 04:27:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:56 INFO - 'XPC_FLAGS': '0x0', 04:27:56 INFO - 'XPC_SERVICE_NAME': '0', 04:27:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:27:56 INFO - Cleaning up... 04:27:56 INFO - Return code: 0 04:27:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102f4cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f4f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdd1cd0bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d2ad30>, '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 0x102c50db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d1fbe8>, '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.KRIDkGrirE/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.6mlxGQEyYw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:27:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:27:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRIDkGrirE/Render', 04:27:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:56 INFO - 'HOME': '/Users/cltbld', 04:27:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:56 INFO - 'LOGNAME': 'cltbld', 04:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:56 INFO - 'MOZ_NO_REMOTE': '1', 04:27:56 INFO - 'NO_EM_RESTART': '1', 04:27:56 INFO - 'PAGER': '/bin/cat', 04:27:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:56 INFO - 'PWD': '/builds/slave/test', 04:27:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:56 INFO - 'SHELL': '/bin/bash', 04:27:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6mlxGQEyYw/Listeners', 04:27:56 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 04:27:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:56 INFO - 'USER': 'cltbld', 04:27:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:56 INFO - 'XPC_FLAGS': '0x0', 04:27:56 INFO - 'XPC_SERVICE_NAME': '0', 04:27:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:56 INFO - Downloading/unpacking blobuploader==1.2.4 04:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:59 INFO - Downloading blobuploader-1.2.4.tar.gz 04:27:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:27:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:27:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:00 INFO - Downloading docopt-0.6.1.tar.gz 04:28:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:28:00 INFO - Installing collected packages: blobuploader, requests, docopt 04:28:00 INFO - Running setup.py install for blobuploader 04:28:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:28:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:28:00 INFO - Running setup.py install for requests 04:28:01 INFO - Running setup.py install for docopt 04:28:01 INFO - Successfully installed blobuploader requests docopt 04:28:01 INFO - Cleaning up... 04:28:01 INFO - Return code: 0 04:28:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:01 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 0x102f4cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f4f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdd1cd0bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d2ad30>, '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 0x102c50db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d1fbe8>, '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.KRIDkGrirE/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.6mlxGQEyYw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:28:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:28:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:28:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRIDkGrirE/Render', 04:28:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:01 INFO - 'HOME': '/Users/cltbld', 04:28:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:01 INFO - 'LOGNAME': 'cltbld', 04:28:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:01 INFO - 'MOZ_NO_REMOTE': '1', 04:28:01 INFO - 'NO_EM_RESTART': '1', 04:28:01 INFO - 'PAGER': '/bin/cat', 04:28:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:01 INFO - 'PWD': '/builds/slave/test', 04:28:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:01 INFO - 'SHELL': '/bin/bash', 04:28:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6mlxGQEyYw/Listeners', 04:28:01 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 04:28:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:01 INFO - 'USER': 'cltbld', 04:28:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:01 INFO - 'XPC_FLAGS': '0x0', 04:28:01 INFO - 'XPC_SERVICE_NAME': '0', 04:28:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:28:01 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-PXbqNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:28:01 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-4GISfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:28:01 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-bNrAwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:28:01 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-oiKpgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:28:02 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-1V0fBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:28:02 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-gDbZYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:28:02 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Nyff06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:28:02 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-BXjUwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:28:02 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-pkEe2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:28:02 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-WpdZLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:28:02 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-aeZw59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:28:02 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-UZ0eC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:28:02 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-n7xk4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:28:03 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-sSnjpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:28:03 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-mE8BGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:28:03 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-o0vrzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:28:03 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-dKJv8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:28:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:28:03 INFO - Running setup.py install for manifestparser 04:28:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:28:03 INFO - Running setup.py install for mozcrash 04:28:03 INFO - Running setup.py install for mozdebug 04:28:03 INFO - Running setup.py install for mozdevice 04:28:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:28:04 INFO - Running setup.py install for mozfile 04:28:04 INFO - Running setup.py install for mozhttpd 04:28:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:28:04 INFO - Running setup.py install for mozinfo 04:28:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:28:04 INFO - Running setup.py install for mozInstall 04:28:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:28:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:28:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:28:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:28:04 INFO - Running setup.py install for mozleak 04:28:04 INFO - Running setup.py install for mozlog 04:28:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:28:04 INFO - Running setup.py install for moznetwork 04:28:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:28:05 INFO - Running setup.py install for mozprocess 04:28:05 INFO - Running setup.py install for mozprofile 04:28:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:28:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:28:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:28:05 INFO - Running setup.py install for mozrunner 04:28:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:28:05 INFO - Running setup.py install for mozscreenshot 04:28:05 INFO - Running setup.py install for moztest 04:28:05 INFO - Running setup.py install for mozversion 04:28:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:28:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:28:05 INFO - Cleaning up... 04:28:06 INFO - Return code: 0 04:28:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:06 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 0x102f4cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f4f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdd1cd0bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d2ad30>, '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 0x102c50db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d1fbe8>, '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.KRIDkGrirE/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.6mlxGQEyYw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:28:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:28:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:28:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRIDkGrirE/Render', 04:28:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:06 INFO - 'HOME': '/Users/cltbld', 04:28:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:06 INFO - 'LOGNAME': 'cltbld', 04:28:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:06 INFO - 'MOZ_NO_REMOTE': '1', 04:28:06 INFO - 'NO_EM_RESTART': '1', 04:28:06 INFO - 'PAGER': '/bin/cat', 04:28:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:06 INFO - 'PWD': '/builds/slave/test', 04:28:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:06 INFO - 'SHELL': '/bin/bash', 04:28:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6mlxGQEyYw/Listeners', 04:28:06 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 04:28:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:06 INFO - 'USER': 'cltbld', 04:28:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:06 INFO - 'XPC_FLAGS': '0x0', 04:28:06 INFO - 'XPC_SERVICE_NAME': '0', 04:28:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:28:06 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-MFCxFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:28:06 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-q6Vh70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:28:06 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-9b6VJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:28:06 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Ixd2IN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:28:06 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-qXaj2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:28:06 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-sTch8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:28:06 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-2disLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:28:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:28:07 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-gqDmsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:28:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:28:07 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-mvEcDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:28:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:28:07 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-mM2uPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:28:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:28:07 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-XW86aG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:28:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:28:07 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-egmKk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:28:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:28:07 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-z1ytGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:28:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:28:07 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-pc8own-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:28:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:28:07 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Tbac3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:28:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:28:07 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-2GMrI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:28:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:28:07 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-SGNhFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:28:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:10 INFO - Downloading blessings-1.6.tar.gz 04:28:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:28:10 INFO - Installing collected packages: blessings 04:28:10 INFO - Running setup.py install for blessings 04:28:10 INFO - Successfully installed blessings 04:28:10 INFO - Cleaning up... 04:28:11 INFO - Return code: 0 04:28:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:28:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:28:11 INFO - Reading from file tmpfile_stdout 04:28:11 INFO - Current package versions: 04:28:11 INFO - blessings == 1.6 04:28:11 INFO - blobuploader == 1.2.4 04:28:11 INFO - docopt == 0.6.1 04:28:11 INFO - functools32 == 3.2.3-2 04:28:11 INFO - jsonschema == 2.5.1 04:28:11 INFO - manifestparser == 1.1 04:28:11 INFO - mozInstall == 1.12 04:28:11 INFO - mozcrash == 1.0 04:28:11 INFO - mozdebug == 0.1 04:28:11 INFO - mozdevice == 0.50 04:28:11 INFO - mozfile == 1.2 04:28:11 INFO - mozhttpd == 0.7 04:28:11 INFO - mozinfo == 0.9 04:28:11 INFO - mozleak == 0.1 04:28:11 INFO - mozlog == 3.4 04:28:11 INFO - moznetwork == 0.27 04:28:11 INFO - mozprocess == 0.25 04:28:11 INFO - mozprofile == 0.28 04:28:11 INFO - mozrunner == 6.13 04:28:11 INFO - mozscreenshot == 0.1 04:28:11 INFO - mozsystemmonitor == 0.3 04:28:11 INFO - moztest == 0.8 04:28:11 INFO - mozversion == 1.4 04:28:11 INFO - psutil == 3.1.1 04:28:11 INFO - requests == 1.2.3 04:28:11 INFO - wsgiref == 0.1.2 04:28:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:28:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:11 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 0x102f4cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f4f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdd1cd0bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d2ad30>, '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 0x102c50db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d1fbe8>, '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.KRIDkGrirE/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.6mlxGQEyYw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:28:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:28:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRIDkGrirE/Render', 04:28:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:11 INFO - 'HOME': '/Users/cltbld', 04:28:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:11 INFO - 'LOGNAME': 'cltbld', 04:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:11 INFO - 'MOZ_NO_REMOTE': '1', 04:28:11 INFO - 'NO_EM_RESTART': '1', 04:28:11 INFO - 'PAGER': '/bin/cat', 04:28:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:11 INFO - 'PWD': '/builds/slave/test', 04:28:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:11 INFO - 'SHELL': '/bin/bash', 04:28:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6mlxGQEyYw/Listeners', 04:28:11 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 04:28:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:11 INFO - 'USER': 'cltbld', 04:28:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:11 INFO - 'XPC_FLAGS': '0x0', 04:28:11 INFO - 'XPC_SERVICE_NAME': '0', 04:28:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:28:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:28:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:28:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:28:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:28:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:28:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:28:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:28:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:28:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:28:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:28:11 INFO - Cleaning up... 04:28:11 INFO - Return code: 0 04:28:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:28:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102f4cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f4f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdd1cd0bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d2ad30>, '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 0x102c50db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d1fbe8>, '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.KRIDkGrirE/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.6mlxGQEyYw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:28:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:28:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRIDkGrirE/Render', 04:28:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:11 INFO - 'HOME': '/Users/cltbld', 04:28:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:11 INFO - 'LOGNAME': 'cltbld', 04:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:11 INFO - 'MOZ_NO_REMOTE': '1', 04:28:11 INFO - 'NO_EM_RESTART': '1', 04:28:11 INFO - 'PAGER': '/bin/cat', 04:28:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:11 INFO - 'PWD': '/builds/slave/test', 04:28:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:11 INFO - 'SHELL': '/bin/bash', 04:28:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6mlxGQEyYw/Listeners', 04:28:11 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 04:28:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:11 INFO - 'USER': 'cltbld', 04:28:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:11 INFO - 'XPC_FLAGS': '0x0', 04:28:11 INFO - 'XPC_SERVICE_NAME': '0', 04:28:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:28:11 INFO - Cleaning up... 04:28:11 INFO - Return code: 0 04:28:11 INFO - Running post-action listener: _resource_record_post_action 04:28:11 INFO - Running post-action listener: _start_resource_monitoring 04:28:11 INFO - Starting resource monitoring. 04:28:11 INFO - [mozharness: 2017-04-22 11:28:11.919553Z] Finished create-virtualenv step (success) 04:28:11 INFO - [mozharness: 2017-04-22 11:28:11.920508Z] Running install step. 04:28:11 INFO - Running pre-action listener: _resource_record_pre_action 04:28:11 INFO - Running main action method: install 04:28:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:28:12 INFO - Reading from file tmpfile_stdout 04:28:12 INFO - Detecting whether we're running mozinstall >=1.0... 04:28:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:28:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:28:12 INFO - Reading from file tmpfile_stdout 04:28:12 INFO - Output received: 04:28:12 INFO - Usage: mozinstall [options] installer 04:28:12 INFO - Options: 04:28:12 INFO - -h, --help show this help message and exit 04:28:12 INFO - -d DEST, --destination=DEST 04:28:12 INFO - Directory to install application into. [default: 04:28:12 INFO - "/builds/slave/test"] 04:28:12 INFO - --app=APP Application being installed. [default: firefox] 04:28:12 INFO - mkdir: /builds/slave/test/build/application 04:28:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:28:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:28:32 INFO - Reading from file tmpfile_stdout 04:28:32 INFO - Output received: 04:28:32 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:28:32 INFO - Running post-action listener: _resource_record_post_action 04:28:32 INFO - [mozharness: 2017-04-22 11:28:32.264099Z] Finished install step (success) 04:28:32 INFO - [mozharness: 2017-04-22 11:28:32.264238Z] Running run-tests step. 04:28:32 INFO - Running pre-action listener: _resource_record_pre_action 04:28:32 INFO - Running main action method: run_tests 04:28:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:28:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:28:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:28:32 INFO - 2017-04-22 04:28:32.278 screenresolution[1642:8616] starting screenresolution argv=screenresolution get 04:28:32 INFO - 2017-04-22 04:28:32.281 screenresolution[1642:8616] Display 0: 1600x1200x32@60 04:28:32 INFO - 2017-04-22 04:28:32.287 screenresolution[1643:8618] starting screenresolution argv=screenresolution list 04:28:32 INFO - Available Modes on Display 0 04:28:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:28:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:28:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:28:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:28:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:28:32 INFO - Intel Iris: 04:28:32 INFO - Chipset Model: Intel Iris 04:28:32 INFO - Type: GPU 04:28:32 INFO - Bus: Built-In 04:28:32 INFO - VRAM (Dynamic, Max): 1536 MB 04:28:32 INFO - Vendor: Intel (0x8086) 04:28:32 INFO - Device ID: 0x0a2e 04:28:32 INFO - Revision ID: 0x0009 04:28:32 INFO - Displays: 04:28:32 INFO - Display: 04:28:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:28:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:28:32 INFO - Display Serial Number: 1600x1200 60 04:28:32 INFO - Main Display: Yes 04:28:32 INFO - Mirror: Off 04:28:32 INFO - Online: Yes 04:28:32 INFO - Rotation: Supported 04:28:32 INFO - Return code: 0 04:28:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:28:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:28:32 INFO - Python 2.7.3 04:28:32 INFO - Return code: 0 04:28:32 INFO - grabbing minidump binary from tooltool 04:28:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:32 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 0x102d2ad30>, '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 0x102c50db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d1fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:28:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:28:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:28:32 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:28:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:28:32 INFO - Return code: 0 04:28:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:28:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:28:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:28:32 INFO - ENV: RUST_BACKTRACE is now 1 04:28:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:28:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:28:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LS5Yufv8T_KdVlaWrJUi5A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0180', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:28:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LS5Yufv8T_KdVlaWrJUi5A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0180 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:28:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KRIDkGrirE/Render', 04:28:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:32 INFO - 'HOME': '/Users/cltbld', 04:28:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:32 INFO - 'LOGNAME': 'cltbld', 04:28:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:28:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:28:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:32 INFO - 'MOZ_NO_REMOTE': '1', 04:28:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:28:32 INFO - 'NO_EM_RESTART': '1', 04:28:32 INFO - 'PAGER': '/bin/cat', 04:28:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:32 INFO - 'PWD': '/builds/slave/test', 04:28:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:28:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:32 INFO - 'RUST_BACKTRACE': '1', 04:28:32 INFO - 'SHELL': '/bin/bash', 04:28:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6mlxGQEyYw/Listeners', 04:28:32 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 04:28:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:32 INFO - 'USER': 'cltbld', 04:28:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:32 INFO - 'XPC_FLAGS': '0x0', 04:28:32 INFO - 'XPC_SERVICE_NAME': '0', 04:28:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LS5Yufv8T_KdVlaWrJUi5A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0180', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:28:32 INFO - mozversion application_buildid: 20170422030205 04:28:32 INFO - mozversion application_changeset: 7d85b081bfabe91dbf18a421f1eee2a32f335823 04:28:32 INFO - mozversion application_display_name: Nightly 04:28:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:28:32 INFO - mozversion application_name: Firefox 04:28:32 INFO - mozversion application_remotingname: firefox 04:28:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:28:32 INFO - mozversion application_vendor: Mozilla 04:28:32 INFO - mozversion application_version: 55.0a1 04:28:32 INFO - mozversion platform_buildid: 20170422030205 04:28:32 INFO - mozversion platform_changeset: 7d85b081bfabe91dbf18a421f1eee2a32f335823 04:28:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:28:32 INFO - mozversion platform_version: 55.0a1 04:28:32 INFO - using testdate: 1492860512 04:28:32 INFO - actual date: 1492860512 04:28:32 INFO - starting webserver on 'localhost:49241' 04:28:32 INFO - SUITE-START | Running 2 tests 04:28:32 INFO - TEST-START | dromaeo_css 04:28:32 INFO - operating with platform_type : mac_ 04:28:32 INFO - Initialising browser for dromaeo_css test... 04:28:32 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmp7i6sjx/profile http://localhost:49241/getInfo.html) 04:28:35 INFO - PID 1653 | __metrics Screen width/height:1600/1200 04:28:35 INFO - PID 1653 | colorDepth:24 04:28:35 INFO - PID 1653 | Browser inner width/height: 1024/689 04:28:35 INFO - PID 1653 | __metrics 04:28:35 INFO - PID 1653 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:28:35 INFO - PID 1653 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:28:36 INFO - TEST-INFO | 1653: exit 0 04:28:36 INFO - Browser initialized. 04:28:36 INFO - Running cycle 1/1 for dromaeo_css test... 04:28:36 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmp7i6sjx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:28:49 INFO - PID 1656 | RSS: Main: 243249152 04:28:49 INFO - PID 1656 | 04:31:54 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 04:31:56 INFO - PID 1656 | RSS: Main: 429449216 04:31:56 INFO - PID 1656 | 04:33:38 INFO - PID 1656 | ************************* 04:33:38 INFO - PID 1656 | A coding exception was thrown and uncaught in a Task. 04:33:38 INFO - PID 1656 | 04:33:38 ERROR - PID 1656 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:33:38 INFO - PID 1656 | Full stack: 04:33:38 INFO - PID 1656 | ************************* 04:33:38 INFO - PID 1656 | ************************* 04:33:38 INFO - PID 1656 | A coding exception was thrown and uncaught in a Task. 04:33:38 INFO - PID 1656 | 04:33:38 ERROR - PID 1656 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:33:38 INFO - PID 1656 | Full stack: 04:33:38 INFO - PID 1656 | ************************* 04:33:38 INFO - PID 1656 | ************************* 04:33:38 INFO - PID 1656 | A coding exception was thrown and uncaught in a Task. 04:33:38 INFO - PID 1656 | 04:33:38 ERROR - PID 1656 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:33:38 INFO - PID 1656 | Full stack: 04:33:38 INFO - PID 1656 | ************************* 04:33:38 INFO - PID 1656 | ************************* 04:33:38 INFO - PID 1656 | A coding exception was thrown and uncaught in a Task. 04:33:38 INFO - PID 1656 | 04:33:38 ERROR - PID 1656 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:33:38 INFO - PID 1656 | Full stack: 04:33:38 INFO - PID 1656 | ************************* 04:34:58 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 04:34:59 INFO - PID 1656 | RSS: Main: 367501312 04:34:59 INFO - PID 1656 | 04:38:01 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 04:38:02 INFO - PID 1656 | RSS: Main: 357613568 04:38:02 INFO - PID 1656 | 04:41:04 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 04:41:05 INFO - PID 1656 | RSS: Main: 337092608 04:41:05 INFO - PID 1656 | 04:44:08 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 04:44:09 INFO - PID 1656 | RSS: Main: 340258816 04:44:09 INFO - PID 1656 | 04:47:11 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 04:47:11 INFO - PID 1656 | RSS: Main: 378712064 04:47:11 INFO - PID 1656 | 04:47:11 INFO - PID 1656 | __start_tp_report 04:47:11 INFO - PID 1656 | _x_x_mozilla_page_load 04:47:11 INFO - PID 1656 | _x_x_mozilla_page_load_details 04:47:11 INFO - PID 1656 | |i|pagename|runs| 04:47:11 INFO - PID 1656 | |0;dojo.html;3497.178163131662;3506.4039113350727;3526.8412921418535;3546.9290614187717;3563.0201694534;5774.913376299359;6068.211132552762;6109.7690694183475;6154.9076763848525;6183.598066125699;6014.609050411709;6129.083728908212;6137.263528376601;6151.04658777889;6157.476614487763;5183.015227106856;5288.286081379003;5304.946950530484;5332.786688532474;5428.104362780136;5200.427952925175;5340.06548853951;5403.540699040586;5404.243405923174;5416.350037995446;5275.86810329741;5280.841574752763;5310.973445132789;5333.226682131108;5395.271638328814;5330.946690533084;5355.598330125256;5363.678179309254;5373.1402975524115;5394.946050539484;5311.28297679816;5333.146696528575;5342.385625653061;5355.839324820262;5399.055165346088;4831.613470922353;5990.700464976734;6010.699465026775;6016.4885984691355;6154.476869466101;6326.240851097852;6391.233052033739;6391.265004524493;6408.903866442007;6427.42153206209;6406.199225096863;6421.486281097501;6425.100485931926;6429.2284925808735;6535.21577410709;6221.191245138103;6291.685415729241;6293.433590976742;6311.33730958252;6311.715972781236;6730.764423245163;6743;6744.460443164633;6749;6763.830904227434;6278;6346.30190679025;6359.20509936258;6386.361363863576;6390.169277993924;6576.80269591913;6604.471642268607;6604.735810567619;6605.339466053356;6627.304133066055;6469.482441404771;6477.287498375175;6480.708368123352;6490.902636460457;6493.448056915215;5453.809116680897;6299.842503937438;6324.462420694293;6515;6527.8694426111215;5148.536631703089;5193.169092945186;5226.425093239741;5249.580033597379;5274.841754747364;4657.022025374709;4670.972386075058;4688.64835137366;4698.436187657503;4756.6908150970075;5107.361579802525;6156;6208.689565521706;6220.284667263232;6231.034189700604;6390.137331460193;6416.037594360883;6443.48452123829;6582.914322448118;6638.734450622018;6086.6348019119;6099.664518451527;6099.725512351954;6100.908486372708;6115.4190351916495;5652.180433837153;5656.981743286248;5658.377578466366;5659.377468478464;5659.434056594308;6515.543911926215;6563;6581.703823328057;6582.078509008838;6588.439982601532;6276.278228003838;6389;6397.200349956255;6421.743130274736;6422.293547709842;6558.213014438298;6566.8358291043105;6719.966400168163;6785.796426107225;6795.456363491007;6497;6519.4132528072705;6521.608703477807;6522.739090436329;6529.5102867284195;6620.66896655175;6628.933710663025;6634.33656634352;6638.137042184485;6653.401193892573;6296.181496405438;6353.0152826312;6367.299597044229;6370.076338930921;6439.7424103035355;5205.45342739007;6230.875382492415;6396.200474940632;6397.328280530477;6425.1968503937005;5251.606129540376;6325.525585581192;6341.112244285896;6349.07938348946;6365.204349456318;6137.560853825989;6370.108184854032;6398;6422.614643121427;6432.774852880127;6259.436650701458;6263.937360626335;6272.843178920563;6311.621302721851;6323.114763933145 04:47:11 INFO - PID 1656 | |1;ext.html;731.2175971710269;785.4266385538557;801.3949468151545;1099.5217080569948;1119.412308538018;27762.58356124657;36964.630353696455;37154.88535343937;37247;37297.50809967598;31846.681533184663;39331.41002884959;39760.01799865007;39785.8064258072;39835.80082099593;6002.909956350658;8422.957885210566;8556.18716221958;8568.186022327869;8579.099194584573;6054.848628784272;8417.915820841805;8569.228769410753;8578.87131693022;8580.227779499844;8606.149677819267;8638.308935285162;8657.653693852239;8671.176238257356;8695.913040869573;8572.057073721886;8623.568821558896;8638;8644.913550864474;8648.913510864937;8383.371247156427;8450.704225352145;8451.788705282355;8455.915440845574;8457.703980360659;37628.62371376278;37707;37716.62283377186;37726.43410348847;37772.05569860776;3620.565532136134;3647.5075864758182;3672.063623775947;3674.4488326750934;3675.871344502956;30861.919832805743;30941.381172376427;30968.380632387227;30997;31030.22424439407;3110.2068972412117;3127.5465057566526;3168.762342824274;3171.1120886151916;3178.141901686555;291524;298303.0169698297;298667.99999999785;299744;300063;49204;49263.75368123208;49293.01413971701;49414.50585494171;49559.75220123876;51909.740451297504;51918.22122668163;51957.48042519602;52071.43785686435;52082.739586301825;13918.582442526538;13996.72006559863;14001.71996560063;14004.509842155476;14014.0190186688;9727.124558789743;11324.71688207785;11336.659900203007;11337.773244535063;11358.26171298863;10901.236913416144;10933.945330273298;10987.450627468595;10987.505562249718;10992.28550144238;4479.656103169036;4967.975160124249;5010.574101201439;5147.249935022111;5154.226865970135;1019.4596863662271;1023.7850051489271;1032.8554002439664;1068.770214403907;1071.3518321415431;20948.26681066186;22978.310650680505;24197.395065123514;24225.273241802774;24281.39296517566;1101.9173561982884;1130.886911308879;1141.6446257527507;1142.274655593704;1154.3247200387866;11381.886181138249;11994.34031128279;12314.50741970329;12356.752864942831;12414.068944829174;322588;322595;322940;323107;323226;52875.73562132165;52920.73539632277;53047;53080;53171;1412.865777751112;1445.3784872504923;1494.7608382658723;1496.7530357490891;1517.4764706176352;22082;23845.642315364938;23902.760972390748;23981.520369592858;24025;38007.04982375463;38047.809760951015;38130.809345953094;38198.80900595479;38215.61784382232;291959;292428;292549;292716;293760.53119735117;33206.501902471966;33783;33965.49051764176;33973;34037.65962340444;29371.118866433186;35718.64281357257;36398.8180059098;43200.783996079816;43663.34504982364;29073.709262907945;30158.095257142322;30310.05361530281;30321.725870559356;30402.54396184103;26165.476690466465;29941.850290748407;30135;30291.848540757153;30565.930192443157;36244.637553624125;36269;36329.45505817468;36344;36356.454653179695;27190.72809271961;29189;30958;31088.844555777076;31843;23282.185123520594;23835.761642384048;23907.04371825177;24173.879130604233;24287.63568546438 04:47:11 INFO - PID 1656 | |2;jquery.html;390.93549564321887;423.64413892330435;426.6437524666902;427.78610694652673;429.8839313385386;19180.61638767224;20395;21201.575968480658;21374.786252137474;21404.464888377777;21653.45866353342;21807.23674671387;21815.23646672363;21868.562628747415;22052.338429847092;5872.882542349161;6202.4417802397775;6208.379162083778;6214.6638472728355;6215.844603884894;6002.339742628307;6110.633361998272;6117.816465506042;6127.693615319238;6197.349278325779;6135.478484328837;6150.138980542728;6163.137160797492;6166.352532984017;6176.876462470748;5870.207521984542;6098.603590766586;6166.568340216187;6171.321154672983;6181.59819611726;5281.841544753664;5454.318210223722;5471.23402723619;5475.753591088411;5477.397486276506;26789.86605066962;27336;27364.726352736616;27372.45255094887;27616.585751213748;2195.703580016693;2317.73346065203;2321.6749655048307;2322.431004403915;2322.9419264518524;17207.05361205133;17368.47894563165;17749.7337539937;17966.5508362292;18162.636747265115;2147.935561933129;2286.7827556382117;2292.1633603734685;2297.2533926473798;2307.976920230793;149995;153644;154228.45771542253;157245;160108;21753.67369489459;22224;22810.42973925632;23027.424314391938;23290.53418931612;40273.395899061536;40391.596084039375;40553;40579.59420405758;40666;8648.827023459495;8662.2637075848;8992.46045237288;8997.820043599091;10625.256232063835;8262.876056859152;8285.337173026264;8303.792405189919;8479.406441549156;8515.063343032261;6404.7117879695525;6490.2536208335705;7768.922310776933;7872.252136047066;7902.960485197652;1794.7577077094686;1808.511701840522;1855.8864681191446;1899.9170472830353;2000.9299674511321;951.9619215231452;953.3639486818951;957.4733896356976;983.9016098390103;987.8419452887504;17898.91050544765;17977.280908763765;20513.38459846207;21055.68416473754;21144.89427552883;934.9953250233706;1002.4386343647581;1013.5185786751234;1019.1591936652292;1025.4616326428536;9455.243580513543;10544.156467482582;10710.678679639623;10817.930105515166;10858.099832529277;581689;585704;592209;593905;595775.0211249003;109984.85098468573;129122;131425;133323.33338333247;134899;1172.2556176827604;1182.5742732616252;1233.0751936047964;1234.8826861448329;1237.04747344546;21912.342629721134;22287;22317;22352.441188970406;22358.441038974157;41697;54568;55629;55987;57172;76806.8478972827;76964;77730;78242;78288.60855695685;8475.237228649452;8699.695510657097;8725.083866193958;8737.43206691563;8808.031116577044;11652;13034;13441.596752097452;13606.387712552762;13772.31138443094;9993.750156246151;11677.941610292233;11798.646040618794;12023.27860328383;12088.395580220778;9088;10984.725381865517;11003.724906877393;11314.03830674402;11353.659390218307;11067.889321106686;11302.717432063935;11680.88319116832;12045.217060891015;12198.390080496118;8573.828523429622;8608.440451370641;8752.124787521452;8835.702717293421;8840.469571825712;11321.959811782983;11379.374134422686;11634.592789252336;11729.178957472895;11760.470778814803 04:47:11 INFO - PID 1656 | |3;mootools.html;1172.841666375039;1348.7369962857244;1380.523719316836;1402.1587047771338;1418.1420240754344;9782.902170978288;10217.48912554373;10229.181665466773;10251.589936402544;10255.743606409844;9926.45404502752;11320.377379244139;11498.712532186699;11593.710157246072;11602.477888495017;2479.5784716598178;2508.7114981777145;2508.912188073418;2513.0952856971476;2514.8994040238367;1896.3647178195322;2379.202967006055;2415.949062157958;2521.773040426361;2523.179966510882;1880.8589355798301;2093.1522733292963;2438.573249681299;2517.6601158843596;2521.760432758885;2482.7889629381525;2485.689288838895;2485.7762801347785;2486.1422809130822;2490.489449662815;2447.7919376852988;2459.1761759810483;2488.639147323628;2489.21589699246;2508.2099138771227;11710.53157873684;11814.704632384173;11836.46735896878;11856.99215566678;11895.048396128375;5650.3219613646215;6490.156279683658;6753.45972322213;6756.324367563254;6762;4020.853307766064;4133.565975572552;4245.681573881971;4255.340422234559;4263.381809637585;1259.9622011339675;1264.854541727704;1295.8574556798744;1308.496228951851;1317.8286822712987;16754.74867876983;16761.994280343097;16783.91608041952;16787.832121678748;16814.32742690291;5786.42135786418;5936.1986131871645;5947.286325640951;6063.878722425615;6104.145419641254;13913.930430347986;13919.234442105579;13927.65180870466;13939.860601394059;13951.302434878215;6819.079424277659;6819.659017049128;6822.9317706823285;6825.566631007445;6839.965800171067;6076.574639775262;6105.389461053948;6128.662923539159;6203.441690247809;6257.405546473078;4356.477222733292;4513.75174365413;4556.567126123013;4601.8707279049895;4611.677182597253;1371.6296599917966;1401.628568429367;1401.9719605608034;1412.6256542016374;1433.6989232261133;768.7962689887185;774.6630215856121;799.3972085967598;805.1787177079347;808.2321794295443;6194;6494.318096599884;6982.93017069833;7111.64441777909;7159.391451726661;504.485424866634;527.8363707250764;589.5755056359415;589.8260013296087;599.2748773983442;3831.5593706723525;3831.6743076838225;3851.826667799956;3952.3083460394314;3965.385365268388;12326.50693972249;13844.792328115087;14736.336864841109;15028.699426011637;15081.698366032619;14816.25918704082;14971.92514037423;15228.695426091415;15259.313330900137;15292.311845966959;8503.957480212559;8653.783655408664;8711.695090671796;8743.91256087431;8744.300455963508;7065.858682826418;7213.819654508469;7354.85999670052;7359.227281135618;7398.075240594926;12910.22538647684;13138.671533211746;13161.341932903126;13360.198388096745;13388.598342049754;13518.526851560147;13553.322333883463;13654.522091726742;13718.108322958975;13725.636250775915;9380.343375963617;9656.565454554422;9659.034096590285;9662.3719458235;9685.322027458293;10482.52828622729;10547.208959327927;10610.681679549625;10701.732456688334;10711.785764284827;9191.200339601075;9227;9260.351775375928;9282.21101206378;9286;8769.210771030637;8897.433604578368;8921.776955576162;8971.32715046361;9081.68214112503;8139.674413023413;8237.341012718849;8369.079401265977;8374.246317831425;8394.664213431395;5706.971465142814;6109.84725381869;6152.692365381624;6165.198524191826;6217.191765070512;5736.368999409978;6205.844853878689;6276.309605943251;6314.989601663712;6383.39357761012 04:47:11 INFO - PID 1656 | |4;prototype.html;349.9562554680665;395.5214190829097;399.0144343471626;403.4513062235361;406.31738679019236;4593.7243765374105;5596.832095037145;5625.7904550521625;5674.404187560303;5701.315842098944;5101.591872650189;5563.582731295149;5605.159226116085;5624.3531993820725;5640.858978525539;3584.910377240564;3822.4266360045935;4365.5852693994175;4388.912221755555;4459.687821852472;3719.64663356982;3729.5151630288024;3803.1062700265416;4373.671974601902;4409.801558929856;3959.990202498359;4185.414042034103;4340.133742490728;4359.891002724926;4366.3844377580335;3810.2760475509563;4204.32730763078;4360.470926862412;4378.408914796525;4401.383806267125;3450.5341778859784;3496.6328535503662;3863.1887303666263;3888.9805550972064;3904.3016287914847;4349.26062569364;5549.916751248735;5556.499915007628;5558.277423934903;5679.659220446786;4560.817567297304;4913.361263035818;5134.024535338273;5276.234945932857;5324.92012619811;5434.91847622286;5648.53138184071;6027.794441111751;6130.927087759625;6163.537734669918;4319.124199769504;4378.759168245745;4460.174867649463;4478.440194975628;4483.341163769426;5888.852778680567;6114.327423983358;6227.782027629011;6254.843628909268;6428.325025872309;4206.284931561642;4347.456652888242;4563.873746483603;4567.373760087963;4570.977145114253;3790.7346485745734;4634.97682511592;4641.86074417768;4663.48701642819;4666.673332866734;4733.479317275097;4873.171560834667;4933.55597996182;5294.338207724035;5313.8937221255355;6068.271807383142;6101.664408457577;6141;6156.168917196211;6169.105479705508;1419.7018626088636;1437;1443.5164219986211;1446.8625480579328;1452.1722618107576;920.6409500294891;955.8136163448061;962.7978124593914;975.5463709375175;986.240594742059;5648.689322087324;5662.801801936995;5682.954136510853;5692.231548740867;5715.685637289989;5549.6115271931385;5821.330546987066;6202.449387653087;6234.906476402857;6311.873762524724;5440.891182176334;5680.97159514208;5710.885782284414;5717.42825717425;5772;2726.6046423268517;3243.6594157613113;3285.2608163163577;3286.5891763529557;3295.9011229663147;6255.875397053105;6318.336574659686;6324.588901721373;6426.453751431087;6437.452816510556;5584.246126772915;6394.520410969103;6416.871662566816;6423.261324947691;6425.453836423862;5411.750601916135;6400.039994000844;6426.814882939823;6430.839229019219;6484.092227088211;5253.290805741176;5395.379531353945;5996.770662014189;6068.241469816273;6198.969005155126;4851.781669824937;4894.192458244493;6094.421030002142;6138.5396095292135;6162.599431036968;5247.137266270419;6257.5932564383165;6330.189056317324;6451.161349024596;6498.025296205418;3463.636318186554;3949.328614135661;4115.670746340225;4142;4157.314043182841;5386.676799392049;5957.434043765836;6047.069404886859;6236.407541283571;6343.90484142729;5496.5053145217125;6062.302835174011;6076.361981992004;6089.147519347383;6094.299155597163;5265.341832270966;5339.492748189071;5712.285964254468;5954.809038192292;6067.362926892789;4898.877528061685;5463.934532766072;5591.384947655673;5607.971960140173;6046.818595442144;4732.787024583971;6033.728482218223;6143.047827586731;6161.582835947846;6164.198654174928;4402.515723270373;5762.683052432157;5936.8812623748145;5994.72200563783;6001.609895356788 04:47:11 INFO - PID 1656 | |5;yui.html;672.1228796420669;844.8352571248607;846.6697987784765;853.522027664508;866.6749968761715;12879.291638959854;17984.28062877485;18543.629127417476;18560.814391856078;18791.718124228148;14018.859811401882;16631.251593678284;16750.916245418757;16776.245068971893;16842.157892105377;600.9483404042925;631.671530803984;887.9289656827439;946.6213514594149;951.7335146159087;962.5908988679818;963.2631037256505;964.5273815830228;964.8938616752151;974.8245315843145;985.857050727644;989.579428742785;989.9802003959917;997.0826839307854;1027.1012863744224;987.8419452887575;988.8467287570438;989.7970915962211;990.6285143071384;1033.2095946600857;727.2255048373465;727.5016613619634;730.1639622632057;739.2090463204373;768.8270139218687;16447.177641117898;16658.0838053907;16782;16844.410445634345;17051.573710657332;16852.494425167264;16871.91564042172;16973.15134243283;17178.57053573658;17273.79083464158;13625.727485450236;13896.235707036109;13896.305184740824;14106;14111.71776564463;3470.514128022079;3491.8428670709877;3493.7903725776537;3498.8775392861126;3500.7899526028264;124115;125248;125780;125853.37073314576;128448;10529.789404211873;10868.61959831402;12884;12950.546730864375;12973.740525189443;18610.534736631693;24325;24426.633600496007;24721.87639061829;25111.995520179353;7514.39884809214;7667.846643067108;7697.615119244016;7697.769066928001;7697.961510192413;3734.029152420336;3770.5286839145106;3806.7715937043868;3861.691064714816;3866;4305.9569404306185;4357.847475338348;4403.251447253974;4406.27296496081;4407.294832826797;912.5665308978315;920.0293690156815;933.8459154239611;935.3732998890623;936.4194199596294;635.2853040329629;650.8405440667067;662.102850637389;672.7880717573948;689.8516818883965;9960.954099819559;10275.948620256851;10812.621558245424;11132.944335278271;13262.137961032502;571.7912961768924;664.465105589995;670.0920253057135;676.8662490328679;696.7665831946254;4294.763787991628;4903.926441103386;5483.725813709299;5682.715864206773;5782.392848750905;101071;102004;102223;102253.48873255735;104099.479502602;85710;87147;87254;88246.55876720576;88339;76318;77031.61484192543;77405.83891241637;77481;79125.33994560958;11988.39256926008;12466.189697669623;12660.810087848506;12673.112882098165;12692.17500862441;39782.60217397789;39834;40784.388234175916;41420.378694319006;41444.79277603592;49999.25001125059;50317.49682503128;50433.243501348246;50576.988460231325;51293.97412051813;15549;15691.450799221973;15858.52424427269;15967.68064638724;16029.35882564731;17409.216585253947;17564.473065808048;17723.82276177222;17845.553861153057;17972.910135449238;16005.439809606607;16198.595035124215;16363.509094727176;16406.343746250015;16583.25375358136;13302;15792.447264345692;15842.049477031414;15883.682326353177;16107.194640268173;15779.447719330228;15882.285297161425;15977.680446390774;16001.839981600035;16027.519174424786;9805.460699661588;10226.875043745331;11095.445227738743;11413.828792568283;12032.037437004843;12638.494460221487;12859.698747613415;13079.803802943154;13732.313384330942;13759.17444953306 04:47:11 INFO - PID 1656 | __end_tp_report 04:47:11 INFO - PID 1656 | __start_cc_report 04:47:11 INFO - PID 1656 | _x_x_mozilla_cycle_collect,1870 04:47:11 INFO - PID 1656 | __end_cc_report 04:47:11 INFO - PID 1656 | __startTimestamp1492861631857__endTimestamp 04:47:11 INFO - PID 1656 | 04:47:11 INFO - PID 1656 | ------- Summary: start ------- 04:47:11 INFO - PID 1656 | Number of tests: 6 04:47:11 INFO - PID 1656 | 04:47:11 INFO - PID 1656 | [#0] dojo.html Cycles:165 Average:5997.58 Median:6293.43 stddev:695.64 (11.1%) stddev-sans-first:669.55 04:47:11 INFO - PID 1656 | Values: 3497.2 3506.4 3526.8 3546.9 3563.0 5774.9 6068.2 6109.8 6154.9 6183.6 6014.6 6129.1 6137.3 6151.0 6157.5 5183.0 5288.3 5304.9 5332.8 5428.1 5200.4 5340.1 5403.5 5404.2 5416.4 5275.9 5280.8 5311.0 5333.2 5395.3 5330.9 5355.6 5363.7 5373.1 5394.9 5311.3 5333.1 5342.4 5355.8 5399.1 4831.6 5990.7 6010.7 6016.5 6154.5 6326.2 6391.2 6391.3 6408.9 6427.4 6406.2 6421.5 6425.1 6429.2 6535.2 6221.2 6291.7 6293.4 6311.3 6311.7 6730.8 6743.0 6744.5 6749.0 6763.8 6278.0 6346.3 6359.2 6386.4 6390.2 6576.8 6604.5 6604.7 6605.3 6627.3 6469.5 6477.3 6480.7 6490.9 6493.4 5453.8 6299.8 6324.5 6515.0 6527.9 5148.5 5193.2 5226.4 5249.6 5274.8 4657.0 4671.0 4688.6 4698.4 4756.7 5107.4 6156.0 6208.7 6220.3 6231.0 6390.1 6416.0 6443.5 6582.9 6638.7 6086.6 6099.7 6099.7 6100.9 6115.4 5652.2 5657.0 5658.4 5659.4 5659.4 6515.5 6563.0 6581.7 6582.1 6588.4 6276.3 6389.0 6397.2 6421.7 6422.3 6558.2 6566.8 6720.0 6785.8 6795.5 6497.0 6519.4 6521.6 6522.7 6529.5 6620.7 6628.9 6634.3 6638.1 6653.4 6296.2 6353.0 6367.3 6370.1 6439.7 5205.5 6230.9 6396.2 6397.3 6425.2 5251.6 6325.5 6341.1 6349.1 6365.2 6137.6 6370.1 6398.0 6422.6 6432.8 6259.4 6263.9 6272.8 6311.6 6323.1 04:47:11 INFO - PID 1656 | 04:47:11 INFO - PID 1656 | [#1] ext.html Cycles:180 Average:45056.31 Median:322767.50 stddev:80014.40 (24.8%) stddev-sans-first:80169.65 04:47:11 INFO - PID 1656 | Values: 731.2 785.4 801.4 1099.5 1119.4 27762.6 36964.6 37154.9 37247.0 37297.5 31846.7 39331.4 39760.0 39785.8 39835.8 6002.9 8423.0 8556.2 8568.2 8579.1 6054.8 8417.9 8569.2 8578.9 8580.2 8606.1 8638.3 8657.7 8671.2 8695.9 8572.1 8623.6 8638.0 8644.9 8648.9 8383.4 8450.7 8451.8 8455.9 8457.7 37628.6 37707.0 37716.6 37726.4 37772.1 3620.6 3647.5 3672.1 3674.4 3675.9 30861.9 30941.4 30968.4 30997.0 31030.2 3110.2 3127.5 3168.8 3171.1 3178.1 291524.0 298303.0 298668.0 299744.0 300063.0 49204.0 49263.8 49293.0 49414.5 49559.8 51909.7 51918.2 51957.5 52071.4 52082.7 13918.6 13996.7 14001.7 14004.5 14014.0 9727.1 11324.7 11336.7 11337.8 11358.3 10901.2 10933.9 10987.5 10987.5 10992.3 4479.7 4968.0 5010.6 5147.2 5154.2 1019.5 1023.8 1032.9 1068.8 1071.4 20948.3 22978.3 24197.4 24225.3 24281.4 1101.9 1130.9 1141.6 1142.3 1154.3 11381.9 11994.3 12314.5 12356.8 12414.1 322588.0 322595.0 322940.0 323107.0 323226.0 52875.7 52920.7 53047.0 53080.0 53171.0 1412.9 1445.4 1494.8 1496.8 1517.5 22082.0 23845.6 23902.8 23981.5 24025.0 38007.0 38047.8 38130.8 38198.8 38215.6 291959.0 292428.0 292549.0 292716.0 293760.5 33206.5 33783.0 33965.5 33973.0 34037.7 29371.1 35718.6 36398.8 43200.8 43663.3 29073.7 30158.1 30310.1 30321.7 30402.5 26165.5 29941.9 30135.0 30291.8 30565.9 36244.6 36269.0 36329.5 36344.0 36356.5 27190.7 29189.0 30958.0 31088.8 31843.0 23282.2 23835.8 23907.0 24173.9 24287.6 04:47:11 INFO - PID 1656 | 04:47:11 INFO - PID 1656 | [#2] jquery.html Cycles:180 Average:37421.64 Median:12806.74 stddev:99330.98 (775.6%) stddev-sans-first:99570.72 04:47:11 INFO - PID 1656 | Values: 390.9 423.6 426.6 427.8 429.9 19180.6 20395.0 21201.6 21374.8 21404.5 21653.5 21807.2 21815.2 21868.6 22052.3 5872.9 6202.4 6208.4 6214.7 6215.8 6002.3 6110.6 6117.8 6127.7 6197.3 6135.5 6150.1 6163.1 6166.4 6176.9 5870.2 6098.6 6166.6 6171.3 6181.6 5281.8 5454.3 5471.2 5475.8 5477.4 26789.9 27336.0 27364.7 27372.5 27616.6 2195.7 2317.7 2321.7 2322.4 2322.9 17207.1 17368.5 17749.7 17966.6 18162.6 2147.9 2286.8 2292.2 2297.3 2308.0 149995.0 153644.0 154228.5 157245.0 160108.0 21753.7 22224.0 22810.4 23027.4 23290.5 40273.4 40391.6 40553.0 40579.6 40666.0 8648.8 8662.3 8992.5 8997.8 10625.3 8262.9 8285.3 8303.8 8479.4 8515.1 6404.7 6490.3 7768.9 7872.3 7903.0 1794.8 1808.5 1855.9 1899.9 2000.9 952.0 953.4 957.5 983.9 987.8 17898.9 17977.3 20513.4 21055.7 21144.9 935.0 1002.4 1013.5 1019.2 1025.5 9455.2 10544.2 10710.7 10817.9 10858.1 581689.0 585704.0 592209.0 593905.0 595775.0 109984.9 129122.0 131425.0 133323.3 134899.0 1172.3 1182.6 1233.1 1234.9 1237.0 21912.3 22287.0 22317.0 22352.4 22358.4 41697.0 54568.0 55629.0 55987.0 57172.0 76806.8 76964.0 77730.0 78242.0 78288.6 8475.2 8699.7 8725.1 8737.4 8808.0 11652.0 13034.0 13441.6 13606.4 13772.3 9993.8 11677.9 11798.6 12023.3 12088.4 9088.0 10984.7 11003.7 11314.0 11353.7 11067.9 11302.7 11680.9 12045.2 12198.4 8573.8 8608.4 8752.1 8835.7 8840.5 11322.0 11379.4 11634.6 11729.2 11760.5 04:47:11 INFO - PID 1656 | 04:47:11 INFO - PID 1656 | [#3] mootools.html Cycles:180 Average:7145.34 Median:3902.07 stddev:4538.13 (116.3%) stddev-sans-first:4528.67 04:47:11 INFO - PID 1656 | Values: 1172.8 1348.7 1380.5 1402.2 1418.1 9782.9 10217.5 10229.2 10251.6 10255.7 9926.5 11320.4 11498.7 11593.7 11602.5 2479.6 2508.7 2508.9 2513.1 2514.9 1896.4 2379.2 2415.9 2521.8 2523.2 1880.9 2093.2 2438.6 2517.7 2521.8 2482.8 2485.7 2485.8 2486.1 2490.5 2447.8 2459.2 2488.6 2489.2 2508.2 11710.5 11814.7 11836.5 11857.0 11895.0 5650.3 6490.2 6753.5 6756.3 6762.0 4020.9 4133.6 4245.7 4255.3 4263.4 1260.0 1264.9 1295.9 1308.5 1317.8 16754.7 16762.0 16783.9 16787.8 16814.3 5786.4 5936.2 5947.3 6063.9 6104.1 13913.9 13919.2 13927.7 13939.9 13951.3 6819.1 6819.7 6822.9 6825.6 6840.0 6076.6 6105.4 6128.7 6203.4 6257.4 4356.5 4513.8 4556.6 4601.9 4611.7 1371.6 1401.6 1402.0 1412.6 1433.7 768.8 774.7 799.4 805.2 808.2 6194.0 6494.3 6982.9 7111.6 7159.4 504.5 527.8 589.6 589.8 599.3 3831.6 3831.7 3851.8 3952.3 3965.4 12326.5 13844.8 14736.3 15028.7 15081.7 14816.3 14971.9 15228.7 15259.3 15292.3 8504.0 8653.8 8711.7 8743.9 8744.3 7065.9 7213.8 7354.9 7359.2 7398.1 12910.2 13138.7 13161.3 13360.2 13388.6 13518.5 13553.3 13654.5 13718.1 13725.6 9380.3 9656.6 9659.0 9662.4 9685.3 10482.5 10547.2 10610.7 10701.7 10711.8 9191.2 9227.0 9260.4 9282.2 9286.0 8769.2 8897.4 8921.8 8971.3 9081.7 8139.7 8237.3 8369.1 8374.2 8394.7 5707.0 6109.8 6152.7 6165.2 6217.2 5736.4 6205.8 6276.3 6315.0 6383.4 04:47:11 INFO - PID 1656 | 04:47:11 INFO - PID 1656 | [#4] prototype.html Cycles:180 Average:4903.74 Median:5553.21 stddev:1497.51 (27.0%) stddev-sans-first:1462.18 04:47:11 INFO - PID 1656 | Values: 350.0 395.5 399.0 403.5 406.3 4593.7 5596.8 5625.8 5674.4 5701.3 5101.6 5563.6 5605.2 5624.4 5640.9 3584.9 3822.4 4365.6 4388.9 4459.7 3719.6 3729.5 3803.1 4373.7 4409.8 3960.0 4185.4 4340.1 4359.9 4366.4 3810.3 4204.3 4360.5 4378.4 4401.4 3450.5 3496.6 3863.2 3889.0 3904.3 4349.3 5549.9 5556.5 5558.3 5679.7 4560.8 4913.4 5134.0 5276.2 5324.9 5434.9 5648.5 6027.8 6130.9 6163.5 4319.1 4378.8 4460.2 4478.4 4483.3 5888.9 6114.3 6227.8 6254.8 6428.3 4206.3 4347.5 4563.9 4567.4 4571.0 3790.7 4635.0 4641.9 4663.5 4666.7 4733.5 4873.2 4933.6 5294.3 5313.9 6068.3 6101.7 6141.0 6156.2 6169.1 1419.7 1437.0 1443.5 1446.9 1452.2 920.6 955.8 962.8 975.5 986.2 5648.7 5662.8 5683.0 5692.2 5715.7 5549.6 5821.3 6202.4 6234.9 6311.9 5440.9 5681.0 5710.9 5717.4 5772.0 2726.6 3243.7 3285.3 3286.6 3295.9 6255.9 6318.3 6324.6 6426.5 6437.5 5584.2 6394.5 6416.9 6423.3 6425.5 5411.8 6400.0 6426.8 6430.8 6484.1 5253.3 5395.4 5996.8 6068.2 6199.0 4851.8 4894.2 6094.4 6138.5 6162.6 5247.1 6257.6 6330.2 6451.2 6498.0 3463.6 3949.3 4115.7 4142.0 4157.3 5386.7 5957.4 6047.1 6236.4 6343.9 5496.5 6062.3 6076.4 6089.1 6094.3 5265.3 5339.5 5712.3 5954.8 6067.4 4898.9 5463.9 5591.4 5608.0 6046.8 4732.8 6033.7 6143.0 6161.6 6164.2 4402.5 5762.7 5936.9 5994.7 6001.6 04:47:11 INFO - PID 1656 | 04:47:11 INFO - PID 1656 | [#5] yui.html Cycles:180 Average:21165.33 Median:3481.18 stddev:29946.46 (860.2%) stddev-sans-first:29990.93 04:47:11 INFO - PID 1656 | Values: 672.1 844.8 846.7 853.5 866.7 12879.3 17984.3 18543.6 18560.8 18791.7 14018.9 16631.3 16750.9 16776.2 16842.2 600.9 631.7 887.9 946.6 951.7 962.6 963.3 964.5 964.9 974.8 985.9 989.6 990.0 997.1 1027.1 987.8 988.8 989.8 990.6 1033.2 727.2 727.5 730.2 739.2 768.8 16447.2 16658.1 16782.0 16844.4 17051.6 16852.5 16871.9 16973.2 17178.6 17273.8 13625.7 13896.2 13896.3 14106.0 14111.7 3470.5 3491.8 3493.8 3498.9 3500.8 124115.0 125248.0 125780.0 125853.4 128448.0 10529.8 10868.6 12884.0 12950.5 12973.7 18610.5 24325.0 24426.6 24721.9 25112.0 7514.4 7667.8 7697.6 7697.8 7698.0 3734.0 3770.5 3806.8 3861.7 3866.0 4306.0 4357.8 4403.3 4406.3 4407.3 912.6 920.0 933.8 935.4 936.4 635.3 650.8 662.1 672.8 689.9 9961.0 10275.9 10812.6 11132.9 13262.1 571.8 664.5 670.1 676.9 696.8 4294.8 4903.9 5483.7 5682.7 5782.4 101071.0 102004.0 102223.0 102253.5 104099.5 85710.0 87147.0 87254.0 88246.6 88339.0 76318.0 77031.6 77405.8 77481.0 79125.3 11988.4 12466.2 12660.8 12673.1 12692.2 39782.6 39834.0 40784.4 41420.4 41444.8 49999.3 50317.5 50433.2 50577.0 51294.0 15549.0 15691.5 15858.5 15967.7 16029.4 17409.2 17564.5 17723.8 17845.6 17972.9 16005.4 16198.6 16363.5 16406.3 16583.3 13302.0 15792.4 15842.0 15883.7 16107.2 15779.4 15882.3 15977.7 16001.8 16027.5 9805.5 10226.9 11095.4 11413.8 12032.0 12638.5 12859.7 13079.8 13732.3 13759.2 04:47:11 INFO - PID 1656 | -------- Summary: end -------- 04:47:11 INFO - PID 1656 | 04:47:12 INFO - TEST-INFO | 1656: exit 0 04:47:12 INFO - TEST-OK | dromaeo_css | took 1119697ms 04:47:12 INFO - TEST-START | kraken 04:47:12 INFO - operating with platform_type : mac_ 04:47:12 INFO - Initialising browser for kraken test... 04:47:12 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpQwAlIO/profile http://localhost:49241/getInfo.html) 04:47:15 INFO - PID 1665 | __metrics Screen width/height:1600/1200 04:47:15 INFO - PID 1665 | colorDepth:24 04:47:15 INFO - PID 1665 | Browser inner width/height: 1024/689 04:47:15 INFO - PID 1665 | __metrics 04:47:15 INFO - PID 1665 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:47:15 INFO - PID 1665 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:47:16 INFO - TEST-INFO | 1665: exit 0 04:47:16 INFO - Browser initialized. 04:47:16 INFO - Running cycle 1/1 for kraken test... 04:47:16 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpQwAlIO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:47:28 INFO - PID 1667 | RSS: Main: 241827840 04:47:28 INFO - PID 1667 | 04:47:31 INFO - PID 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 04:47:32 INFO - PID 1667 | RSS: Main: 311635968 04:47:32 INFO - PID 1667 | 04:47:34 INFO - PID 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 04:47:35 INFO - PID 1667 | RSS: Main: 294797312 04:47:35 INFO - PID 1667 | 04:47:38 INFO - PID 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 04:47:39 INFO - PID 1667 | RSS: Main: 386183168 04:47:39 INFO - PID 1667 | 04:47:41 INFO - PID 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 04:47:41 INFO - PID 1667 | RSS: Main: 290930688 04:47:41 INFO - PID 1667 | 04:47:43 INFO - PID 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:47:44 INFO - PID 1667 | RSS: Main: 293007360 04:47:44 INFO - PID 1667 | 04:47:46 INFO - PID 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 04:47:47 INFO - PID 1667 | RSS: Main: 357056512 04:47:47 INFO - PID 1667 | 04:47:50 INFO - PID 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 04:47:51 INFO - PID 1667 | RSS: Main: 378966016 04:47:51 INFO - PID 1667 | 04:47:54 INFO - PID 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 04:47:54 INFO - PID 1667 | RSS: Main: 394190848 04:47:54 INFO - PID 1667 | 04:47:56 INFO - PID 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:47:56 INFO - PID 1667 | RSS: Main: 332058624 04:47:56 INFO - PID 1667 | 04:47:58 INFO - PID 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:47:59 INFO - PID 1667 | RSS: Main: 334905344 04:47:59 INFO - PID 1667 | 04:48:01 INFO - PID 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:48:02 INFO - PID 1667 | RSS: Main: 337068032 04:48:02 INFO - PID 1667 | 04:48:04 INFO - PID 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:48:05 INFO - PID 1667 | RSS: Main: 352473088 04:48:05 INFO - PID 1667 | 04:48:08 INFO - PID 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:48:09 INFO - PID 1667 | RSS: Main: 344625152 04:48:09 INFO - PID 1667 | 04:48:11 INFO - PID 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 04:48:11 INFO - PID 1667 | RSS: Main: 387137536 04:48:11 INFO - PID 1667 | 04:48:11 INFO - PID 1667 | __start_tp_report 04:48:11 INFO - PID 1667 | _x_x_mozilla_page_load 04:48:11 INFO - PID 1667 | _x_x_mozilla_page_load_details 04:48:11 INFO - PID 1667 | |i|pagename|runs| 04:48:11 INFO - PID 1667 | |0;ai-astar;112;111;114;160;163;112;110;111;110;111 04:48:11 INFO - PID 1667 | |1;audio-beat-detection;139;110;107;149;111;105;108;107;137;109 04:48:11 INFO - PID 1667 | |2;audio-dft;186;183;186;185;185;185;182;179;182;186 04:48:11 INFO - PID 1667 | |3;audio-fft;81;58;61;87;61;58;59;59;82;59 04:48:11 INFO - PID 1667 | |4;audio-oscillator;91;70;85;69;68;69;86;68;68;90 04:48:11 INFO - PID 1667 | |5;imaging-gaussian-blur;88;89;88;88;88;88;89;88;88;88 04:48:11 INFO - PID 1667 | |6;imaging-darkroom;97;96;96;96;96;96;96;96;103;152 04:48:11 INFO - PID 1667 | |7;imaging-desaturate;84;88;87;86;79;85;84;86;85;86 04:48:11 INFO - PID 1667 | |8;json-parse-financial;47;47;49;48;49;49;48;48;48;49 04:48:11 INFO - PID 1667 | |9;json-stringify-tinderbox;54;59;60;66;63;60;55;56;56;59 04:48:11 INFO - PID 1667 | |10;stanford-crypto-aes;83;83;83;83;83;84;80;81;86;98 04:48:11 INFO - PID 1667 | |11;stanford-crypto-ccm;146;147;156;138;135;135;143;141;170;132 04:48:11 INFO - PID 1667 | |12;stanford-crypto-pbkdf2;187;189;189;188;186;186;186;187;183;189 04:48:11 INFO - PID 1667 | |13;stanford-crypto-sha256-iterative;67;69;66;67;68;68;67;68;68;70 04:48:11 INFO - PID 1667 | __end_tp_report 04:48:11 INFO - PID 1667 | __start_cc_report 04:48:11 INFO - PID 1667 | _x_x_mozilla_cycle_collect,2182 04:48:11 INFO - PID 1667 | __end_cc_report 04:48:11 INFO - PID 1667 | __startTimestamp1492861691455__endTimestamp 04:48:11 INFO - PID 1667 | 04:48:11 INFO - PID 1667 | ------- Summary: start ------- 04:48:11 INFO - PID 1667 | Number of tests: 14 04:48:11 INFO - PID 1667 | 04:48:11 INFO - PID 1667 | [#0] ai-astar Cycles:10 Average:121.40 Median:112.00 stddev:21.18 (18.9%) stddev-sans-first:22.19 04:48:11 INFO - PID 1667 | Values: 112.0 111.0 114.0 160.0 163.0 112.0 110.0 111.0 110.0 111.0 04:48:11 INFO - PID 1667 | 04:48:11 INFO - PID 1667 | [#1] audio-beat-detection Cycles:10 Average:118.20 Median:110.50 stddev:16.56 (15.0%) stddev-sans-first:15.76 04:48:11 INFO - PID 1667 | Values: 139.0 110.0 107.0 149.0 111.0 105.0 108.0 107.0 137.0 109.0 04:48:11 INFO - PID 1667 | 04:48:11 INFO - PID 1667 | [#2] audio-dft Cycles:10 Average:183.90 Median:185.00 stddev:2.33 (1.3%) stddev-sans-first:2.35 04:48:11 INFO - PID 1667 | Values: 186.0 183.0 186.0 185.0 185.0 185.0 182.0 179.0 182.0 186.0 04:48:11 INFO - PID 1667 | 04:48:11 INFO - PID 1667 | [#3] audio-fft Cycles:10 Average:66.50 Median:61.00 stddev:11.76 (19.3%) stddev-sans-first:11.24 04:48:11 INFO - PID 1667 | Values: 81.0 58.0 61.0 87.0 61.0 58.0 59.0 59.0 82.0 59.0 04:48:11 INFO - PID 1667 | 04:48:11 INFO - PID 1667 | [#4] audio-oscillator Cycles:10 Average:76.40 Median:77.50 stddev:10.15 (13.1%) stddev-sans-first:9.28 04:48:11 INFO - PID 1667 | Values: 91.0 70.0 85.0 69.0 68.0 69.0 86.0 68.0 68.0 90.0 04:48:11 INFO - PID 1667 | 04:48:11 INFO - PID 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:88.20 Median:88.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 04:48:11 INFO - PID 1667 | Values: 88.0 89.0 88.0 88.0 88.0 88.0 89.0 88.0 88.0 88.0 04:48:11 INFO - PID 1667 | 04:48:11 INFO - PID 1667 | [#6] imaging-darkroom Cycles:10 Average:102.40 Median:96.00 stddev:17.56 (18.3%) stddev-sans-first:18.52 04:48:11 INFO - PID 1667 | Values: 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 103.0 152.0 04:48:11 INFO - PID 1667 | 04:48:11 INFO - PID 1667 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:86.00 stddev:2.45 (2.8%) stddev-sans-first:2.57 04:48:11 INFO - PID 1667 | Values: 84.0 88.0 87.0 86.0 79.0 85.0 84.0 86.0 85.0 86.0 04:48:11 INFO - PID 1667 | 04:48:11 INFO - PID 1667 | [#8] json-parse-financial Cycles:10 Average:48.20 Median:48.50 stddev:0.79 (1.6%) stddev-sans-first:0.71 04:48:11 INFO - PID 1667 | Values: 47.0 47.0 49.0 48.0 49.0 49.0 48.0 48.0 48.0 49.0 04:48:11 INFO - PID 1667 | 04:48:11 INFO - PID 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.50 stddev:3.74 (6.3%) stddev-sans-first:3.54 04:48:11 INFO - PID 1667 | Values: 54.0 59.0 60.0 66.0 63.0 60.0 55.0 56.0 56.0 59.0 04:48:11 INFO - PID 1667 | 04:48:11 INFO - PID 1667 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:83.00 stddev:5.04 (6.1%) stddev-sans-first:5.32 04:48:11 INFO - PID 1667 | Values: 83.0 83.0 83.0 83.0 83.0 84.0 80.0 81.0 86.0 98.0 04:48:11 INFO - PID 1667 | 04:48:11 INFO - PID 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:144.30 Median:144.50 stddev:11.47 (7.9%) stddev-sans-first:12.15 04:48:11 INFO - PID 1667 | Values: 146.0 147.0 156.0 138.0 135.0 135.0 143.0 141.0 170.0 132.0 04:48:11 INFO - PID 1667 | 04:48:11 INFO - PID 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.00 Median:187.50 stddev:1.89 (1.0%) stddev-sans-first:2.00 04:48:11 INFO - PID 1667 | Values: 187.0 189.0 189.0 188.0 186.0 186.0 186.0 187.0 183.0 189.0 04:48:11 INFO - PID 1667 | 04:48:11 INFO - PID 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.14 (1.7%) stddev-sans-first:1.17 04:48:11 INFO - PID 1667 | Values: 67.0 69.0 66.0 67.0 68.0 68.0 67.0 68.0 68.0 70.0 04:48:11 INFO - PID 1667 | -------- Summary: end -------- 04:48:11 INFO - PID 1667 | 04:48:12 INFO - TEST-INFO | 1667: exit 0 04:48:12 INFO - TEST-OK | kraken | took 60054ms 04:48:12 INFO - SUITE-END | took 1179s 04:48:13 INFO - Completed test suite (00:19:40) 04:48:13 INFO - javascript benchmark 04:48:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7722.5374949042825, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3497.178163131662, 3506.4039113350727, 3526.8412921418535, 3546.9290614187717, 3563.0201694534, 5774.913376299359, 6068.211132552762, 6109.7690694183475, 6154.9076763848525, 6183.598066125699, 6014.609050411709, 6129.083728908212, 6137.263528376601, 6151.04658777889, 6157.476614487763, 5183.015227106856, 5288.286081379003, 5304.946950530484, 5332.786688532474, 5428.104362780136, 5200.427952925175, 5340.06548853951, 5403.540699040586, 5404.243405923174, 5416.350037995446, 5275.86810329741, 5280.841574752763, 5310.973445132789, 5333.226682131108, 5395.271638328814, 5330.946690533084, 5355.598330125256, 5363.678179309254, 5373.1402975524115, 5394.946050539484, 5311.28297679816, 5333.146696528575, 5342.385625653061, 5355.839324820262, 5399.055165346088, 4831.613470922353, 5990.700464976734, 6010.699465026775, 6016.4885984691355, 6154.476869466101, 6326.240851097852, 6391.233052033739, 6391.265004524493, 6408.903866442007, 6427.42153206209, 6406.199225096863, 6421.486281097501, 6425.100485931926, 6429.2284925808735, 6535.21577410709, 6221.191245138103, 6291.685415729241, 6293.433590976742, 6311.33730958252, 6311.715972781236, 6730.764423245163, 6743.0, 6744.460443164633, 6749.0, 6763.830904227434, 6278.0, 6346.30190679025, 6359.20509936258, 6386.361363863576, 6390.169277993924, 6576.80269591913, 6604.471642268607, 6604.735810567619, 6605.339466053356, 6627.304133066055, 6469.482441404771, 6477.287498375175, 6480.708368123352, 6490.902636460457, 6493.448056915215, 5453.809116680897, 6299.842503937438, 6324.462420694293, 6515.0, 6527.8694426111215, 5148.536631703089, 5193.169092945186, 5226.425093239741, 5249.580033597379, 5274.841754747364, 4657.022025374709, 4670.972386075058, 4688.64835137366, 4698.436187657503, 4756.6908150970075, 5107.361579802525, 6156.0, 6208.689565521706, 6220.284667263232, 6231.034189700604, 6390.137331460193, 6416.037594360883, 6443.48452123829, 6582.914322448118, 6638.734450622018, 6086.6348019119, 6099.664518451527, 6099.725512351954, 6100.908486372708, 6115.4190351916495, 5652.180433837153, 5656.981743286248, 5658.377578466366, 5659.377468478464, 5659.434056594308, 6515.543911926215, 6563.0, 6581.703823328057, 6582.078509008838, 6588.439982601532, 6276.278228003838, 6389.0, 6397.200349956255, 6421.743130274736, 6422.293547709842, 6558.213014438298, 6566.8358291043105, 6719.966400168163, 6785.796426107225, 6795.456363491007, 6497.0, 6519.4132528072705, 6521.608703477807, 6522.739090436329, 6529.5102867284195, 6620.66896655175, 6628.933710663025, 6634.33656634352, 6638.137042184485, 6653.401193892573, 6296.181496405438, 6353.0152826312, 6367.299597044229, 6370.076338930921, 6439.7424103035355, 5205.45342739007, 6230.875382492415, 6396.200474940632, 6397.328280530477, 6425.1968503937005, 5251.606129540376, 6325.525585581192, 6341.112244285896, 6349.07938348946, 6365.204349456318, 6137.560853825989, 6370.108184854032, 6398.0, 6422.614643121427, 6432.774852880127, 6259.436650701458, 6263.937360626335, 6272.843178920563, 6311.621302721851, 6323.114763933145], "value": 5953.437910099225, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.2175971710269, 785.4266385538557, 801.3949468151545, 1099.5217080569948, 1119.412308538018, 27762.58356124657, 36964.630353696455, 37154.88535343937, 37247.0, 37297.50809967598, 31846.681533184663, 39331.41002884959, 39760.01799865007, 39785.8064258072, 39835.80082099593, 6002.909956350658, 8422.957885210566, 8556.18716221958, 8568.186022327869, 8579.099194584573, 6054.848628784272, 8417.915820841805, 8569.228769410753, 8578.87131693022, 8580.227779499844, 8606.149677819267, 8638.308935285162, 8657.653693852239, 8671.176238257356, 8695.913040869573, 8572.057073721886, 8623.568821558896, 8638.0, 8644.913550864474, 8648.913510864937, 8383.371247156427, 8450.704225352145, 8451.788705282355, 8455.915440845574, 8457.703980360659, 37628.62371376278, 37707.0, 37716.62283377186, 37726.43410348847, 37772.05569860776, 3620.565532136134, 3647.5075864758182, 3672.063623775947, 3674.4488326750934, 3675.871344502956, 30861.919832805743, 30941.381172376427, 30968.380632387227, 30997.0, 31030.22424439407, 3110.2068972412117, 3127.5465057566526, 3168.762342824274, 3171.1120886151916, 3178.141901686555, 291524.0, 298303.0169698297, 298667.99999999785, 299744.0, 300063.0, 49204.0, 49263.75368123208, 49293.01413971701, 49414.50585494171, 49559.75220123876, 51909.740451297504, 51918.22122668163, 51957.48042519602, 52071.43785686435, 52082.739586301825, 13918.582442526538, 13996.72006559863, 14001.71996560063, 14004.509842155476, 14014.0190186688, 9727.124558789743, 11324.71688207785, 11336.659900203007, 11337.773244535063, 11358.26171298863, 10901.236913416144, 10933.945330273298, 10987.450627468595, 10987.505562249718, 10992.28550144238, 4479.656103169036, 4967.975160124249, 5010.574101201439, 5147.249935022111, 5154.226865970135, 1019.4596863662271, 1023.7850051489271, 1032.8554002439664, 1068.770214403907, 1071.3518321415431, 20948.26681066186, 22978.310650680505, 24197.395065123514, 24225.273241802774, 24281.39296517566, 1101.9173561982884, 1130.886911308879, 1141.6446257527507, 1142.274655593704, 1154.3247200387866, 11381.886181138249, 11994.34031128279, 12314.50741970329, 12356.752864942831, 12414.068944829174, 322588.0, 322595.0, 322940.0, 323107.0, 323226.0, 52875.73562132165, 52920.73539632277, 53047.0, 53080.0, 53171.0, 1412.865777751112, 1445.3784872504923, 1494.7608382658723, 1496.7530357490891, 1517.4764706176352, 22082.0, 23845.642315364938, 23902.760972390748, 23981.520369592858, 24025.0, 38007.04982375463, 38047.809760951015, 38130.809345953094, 38198.80900595479, 38215.61784382232, 291959.0, 292428.0, 292549.0, 292716.0, 293760.53119735117, 33206.501902471966, 33783.0, 33965.49051764176, 33973.0, 34037.65962340444, 29371.118866433186, 35718.64281357257, 36398.8180059098, 43200.783996079816, 43663.34504982364, 29073.709262907945, 30158.095257142322, 30310.05361530281, 30321.725870559356, 30402.54396184103, 26165.476690466465, 29941.850290748407, 30135.0, 30291.848540757153, 30565.930192443157, 36244.637553624125, 36269.0, 36329.45505817468, 36344.0, 36356.454653179695, 27190.72809271961, 29189.0, 30958.0, 31088.844555777076, 31843.0, 23282.185123520594, 23835.761642384048, 23907.04371825177, 24173.879130604233, 24287.63568546438], "value": 17161.703204519028, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.93549564321887, 423.64413892330435, 426.6437524666902, 427.78610694652673, 429.8839313385386, 19180.61638767224, 20395.0, 21201.575968480658, 21374.786252137474, 21404.464888377777, 21653.45866353342, 21807.23674671387, 21815.23646672363, 21868.562628747415, 22052.338429847092, 5872.882542349161, 6202.4417802397775, 6208.379162083778, 6214.6638472728355, 6215.844603884894, 6002.339742628307, 6110.633361998272, 6117.816465506042, 6127.693615319238, 6197.349278325779, 6135.478484328837, 6150.138980542728, 6163.137160797492, 6166.352532984017, 6176.876462470748, 5870.207521984542, 6098.603590766586, 6166.568340216187, 6171.321154672983, 6181.59819611726, 5281.841544753664, 5454.318210223722, 5471.23402723619, 5475.753591088411, 5477.397486276506, 26789.86605066962, 27336.0, 27364.726352736616, 27372.45255094887, 27616.585751213748, 2195.703580016693, 2317.73346065203, 2321.6749655048307, 2322.431004403915, 2322.9419264518524, 17207.05361205133, 17368.47894563165, 17749.7337539937, 17966.5508362292, 18162.636747265115, 2147.935561933129, 2286.7827556382117, 2292.1633603734685, 2297.2533926473798, 2307.976920230793, 149995.0, 153644.0, 154228.45771542253, 157245.0, 160108.0, 21753.67369489459, 22224.0, 22810.42973925632, 23027.424314391938, 23290.53418931612, 40273.395899061536, 40391.596084039375, 40553.0, 40579.59420405758, 40666.0, 8648.827023459495, 8662.2637075848, 8992.46045237288, 8997.820043599091, 10625.256232063835, 8262.876056859152, 8285.337173026264, 8303.792405189919, 8479.406441549156, 8515.063343032261, 6404.7117879695525, 6490.2536208335705, 7768.922310776933, 7872.252136047066, 7902.960485197652, 1794.7577077094686, 1808.511701840522, 1855.8864681191446, 1899.9170472830353, 2000.9299674511321, 951.9619215231452, 953.3639486818951, 957.4733896356976, 983.9016098390103, 987.8419452887504, 17898.91050544765, 17977.280908763765, 20513.38459846207, 21055.68416473754, 21144.89427552883, 934.9953250233706, 1002.4386343647581, 1013.5185786751234, 1019.1591936652292, 1025.4616326428536, 9455.243580513543, 10544.156467482582, 10710.678679639623, 10817.930105515166, 10858.099832529277, 581689.0, 585704.0, 592209.0, 593905.0, 595775.0211249003, 109984.85098468573, 129122.0, 131425.0, 133323.33338333247, 134899.0, 1172.2556176827604, 1182.5742732616252, 1233.0751936047964, 1234.8826861448329, 1237.04747344546, 21912.342629721134, 22287.0, 22317.0, 22352.441188970406, 22358.441038974157, 41697.0, 54568.0, 55629.0, 55987.0, 57172.0, 76806.8478972827, 76964.0, 77730.0, 78242.0, 78288.60855695685, 8475.237228649452, 8699.695510657097, 8725.083866193958, 8737.43206691563, 8808.031116577044, 11652.0, 13034.0, 13441.596752097452, 13606.387712552762, 13772.31138443094, 9993.750156246151, 11677.941610292233, 11798.646040618794, 12023.27860328383, 12088.395580220778, 9088.0, 10984.725381865517, 11003.724906877393, 11314.03830674402, 11353.659390218307, 11067.889321106686, 11302.717432063935, 11680.88319116832, 12045.217060891015, 12198.390080496118, 8573.828523429622, 8608.440451370641, 8752.124787521452, 8835.702717293421, 8840.469571825712, 11321.959811782983, 11379.374134422686, 11634.592789252336, 11729.178957472895, 11760.470778814803], "value": 10783.84172857547, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1172.841666375039, 1348.7369962857244, 1380.523719316836, 1402.1587047771338, 1418.1420240754344, 9782.902170978288, 10217.48912554373, 10229.181665466773, 10251.589936402544, 10255.743606409844, 9926.45404502752, 11320.377379244139, 11498.712532186699, 11593.710157246072, 11602.477888495017, 2479.5784716598178, 2508.7114981777145, 2508.912188073418, 2513.0952856971476, 2514.8994040238367, 1896.3647178195322, 2379.202967006055, 2415.949062157958, 2521.773040426361, 2523.179966510882, 1880.8589355798301, 2093.1522733292963, 2438.573249681299, 2517.6601158843596, 2521.760432758885, 2482.7889629381525, 2485.689288838895, 2485.7762801347785, 2486.1422809130822, 2490.489449662815, 2447.7919376852988, 2459.1761759810483, 2488.639147323628, 2489.21589699246, 2508.2099138771227, 11710.53157873684, 11814.704632384173, 11836.46735896878, 11856.99215566678, 11895.048396128375, 5650.3219613646215, 6490.156279683658, 6753.45972322213, 6756.324367563254, 6762.0, 4020.853307766064, 4133.565975572552, 4245.681573881971, 4255.340422234559, 4263.381809637585, 1259.9622011339675, 1264.854541727704, 1295.8574556798744, 1308.496228951851, 1317.8286822712987, 16754.74867876983, 16761.994280343097, 16783.91608041952, 16787.832121678748, 16814.32742690291, 5786.42135786418, 5936.1986131871645, 5947.286325640951, 6063.878722425615, 6104.145419641254, 13913.930430347986, 13919.234442105579, 13927.65180870466, 13939.860601394059, 13951.302434878215, 6819.079424277659, 6819.659017049128, 6822.9317706823285, 6825.566631007445, 6839.965800171067, 6076.574639775262, 6105.389461053948, 6128.662923539159, 6203.441690247809, 6257.405546473078, 4356.477222733292, 4513.75174365413, 4556.567126123013, 4601.8707279049895, 4611.677182597253, 1371.6296599917966, 1401.628568429367, 1401.9719605608034, 1412.6256542016374, 1433.6989232261133, 768.7962689887185, 774.6630215856121, 799.3972085967598, 805.1787177079347, 808.2321794295443, 6194.0, 6494.318096599884, 6982.93017069833, 7111.64441777909, 7159.391451726661, 504.485424866634, 527.8363707250764, 589.5755056359415, 589.8260013296087, 599.2748773983442, 3831.5593706723525, 3831.6743076838225, 3851.826667799956, 3952.3083460394314, 3965.385365268388, 12326.50693972249, 13844.792328115087, 14736.336864841109, 15028.699426011637, 15081.698366032619, 14816.25918704082, 14971.92514037423, 15228.695426091415, 15259.313330900137, 15292.311845966959, 8503.957480212559, 8653.783655408664, 8711.695090671796, 8743.91256087431, 8744.300455963508, 7065.858682826418, 7213.819654508469, 7354.85999670052, 7359.227281135618, 7398.075240594926, 12910.22538647684, 13138.671533211746, 13161.341932903126, 13360.198388096745, 13388.598342049754, 13518.526851560147, 13553.322333883463, 13654.522091726742, 13718.108322958975, 13725.636250775915, 9380.343375963617, 9656.565454554422, 9659.034096590285, 9662.3719458235, 9685.322027458293, 10482.52828622729, 10547.208959327927, 10610.681679549625, 10701.732456688334, 10711.785764284827, 9191.200339601075, 9227.0, 9260.351775375928, 9282.21101206378, 9286.0, 8769.210771030637, 8897.433604578368, 8921.776955576162, 8971.32715046361, 9081.68214112503, 8139.674413023413, 8237.341012718849, 8369.079401265977, 8374.246317831425, 8394.664213431395, 5706.971465142814, 6109.84725381869, 6152.692365381624, 6165.198524191826, 6217.191765070512, 5736.368999409978, 6205.844853878689, 6276.309605943251, 6314.989601663712, 6383.39357761012], "value": 5331.780852842289, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.9562554680665, 395.5214190829097, 399.0144343471626, 403.4513062235361, 406.31738679019236, 4593.7243765374105, 5596.832095037145, 5625.7904550521625, 5674.404187560303, 5701.315842098944, 5101.591872650189, 5563.582731295149, 5605.159226116085, 5624.3531993820725, 5640.858978525539, 3584.910377240564, 3822.4266360045935, 4365.5852693994175, 4388.912221755555, 4459.687821852472, 3719.64663356982, 3729.5151630288024, 3803.1062700265416, 4373.671974601902, 4409.801558929856, 3959.990202498359, 4185.414042034103, 4340.133742490728, 4359.891002724926, 4366.3844377580335, 3810.2760475509563, 4204.32730763078, 4360.470926862412, 4378.408914796525, 4401.383806267125, 3450.5341778859784, 3496.6328535503662, 3863.1887303666263, 3888.9805550972064, 3904.3016287914847, 4349.26062569364, 5549.916751248735, 5556.499915007628, 5558.277423934903, 5679.659220446786, 4560.817567297304, 4913.361263035818, 5134.024535338273, 5276.234945932857, 5324.92012619811, 5434.91847622286, 5648.53138184071, 6027.794441111751, 6130.927087759625, 6163.537734669918, 4319.124199769504, 4378.759168245745, 4460.174867649463, 4478.440194975628, 4483.341163769426, 5888.852778680567, 6114.327423983358, 6227.782027629011, 6254.843628909268, 6428.325025872309, 4206.284931561642, 4347.456652888242, 4563.873746483603, 4567.373760087963, 4570.977145114253, 3790.7346485745734, 4634.97682511592, 4641.86074417768, 4663.48701642819, 4666.673332866734, 4733.479317275097, 4873.171560834667, 4933.55597996182, 5294.338207724035, 5313.8937221255355, 6068.271807383142, 6101.664408457577, 6141.0, 6156.168917196211, 6169.105479705508, 1419.7018626088636, 1437.0, 1443.5164219986211, 1446.8625480579328, 1452.1722618107576, 920.6409500294891, 955.8136163448061, 962.7978124593914, 975.5463709375175, 986.240594742059, 5648.689322087324, 5662.801801936995, 5682.954136510853, 5692.231548740867, 5715.685637289989, 5549.6115271931385, 5821.330546987066, 6202.449387653087, 6234.906476402857, 6311.873762524724, 5440.891182176334, 5680.97159514208, 5710.885782284414, 5717.42825717425, 5772.0, 2726.6046423268517, 3243.6594157613113, 3285.2608163163577, 3286.5891763529557, 3295.9011229663147, 6255.875397053105, 6318.336574659686, 6324.588901721373, 6426.453751431087, 6437.452816510556, 5584.246126772915, 6394.520410969103, 6416.871662566816, 6423.261324947691, 6425.453836423862, 5411.750601916135, 6400.039994000844, 6426.814882939823, 6430.839229019219, 6484.092227088211, 5253.290805741176, 5395.379531353945, 5996.770662014189, 6068.241469816273, 6198.969005155126, 4851.781669824937, 4894.192458244493, 6094.421030002142, 6138.5396095292135, 6162.599431036968, 5247.137266270419, 6257.5932564383165, 6330.189056317324, 6451.161349024596, 6498.025296205418, 3463.636318186554, 3949.328614135661, 4115.670746340225, 4142.0, 4157.314043182841, 5386.676799392049, 5957.434043765836, 6047.069404886859, 6236.407541283571, 6343.90484142729, 5496.5053145217125, 6062.302835174011, 6076.361981992004, 6089.147519347383, 6094.299155597163, 5265.341832270966, 5339.492748189071, 5712.285964254468, 5954.809038192292, 6067.362926892789, 4898.877528061685, 5463.934532766072, 5591.384947655673, 5607.971960140173, 6046.818595442144, 4732.787024583971, 6033.728482218223, 6143.047827586731, 6161.582835947846, 6164.198654174928, 4402.515723270373, 5762.683052432157, 5936.8812623748145, 5994.72200563783, 6001.609895356788], "value": 4445.495710755897, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.1228796420669, 844.8352571248607, 846.6697987784765, 853.522027664508, 866.6749968761715, 12879.291638959854, 17984.28062877485, 18543.629127417476, 18560.814391856078, 18791.718124228148, 14018.859811401882, 16631.251593678284, 16750.916245418757, 16776.245068971893, 16842.157892105377, 600.9483404042925, 631.671530803984, 887.9289656827439, 946.6213514594149, 951.7335146159087, 962.5908988679818, 963.2631037256505, 964.5273815830228, 964.8938616752151, 974.8245315843145, 985.857050727644, 989.579428742785, 989.9802003959917, 997.0826839307854, 1027.1012863744224, 987.8419452887575, 988.8467287570438, 989.7970915962211, 990.6285143071384, 1033.2095946600857, 727.2255048373465, 727.5016613619634, 730.1639622632057, 739.2090463204373, 768.8270139218687, 16447.177641117898, 16658.0838053907, 16782.0, 16844.410445634345, 17051.573710657332, 16852.494425167264, 16871.91564042172, 16973.15134243283, 17178.57053573658, 17273.79083464158, 13625.727485450236, 13896.235707036109, 13896.305184740824, 14106.0, 14111.71776564463, 3470.514128022079, 3491.8428670709877, 3493.7903725776537, 3498.8775392861126, 3500.7899526028264, 124115.0, 125248.0, 125780.0, 125853.37073314576, 128448.0, 10529.789404211873, 10868.61959831402, 12884.0, 12950.546730864375, 12973.740525189443, 18610.534736631693, 24325.0, 24426.633600496007, 24721.87639061829, 25111.995520179353, 7514.39884809214, 7667.846643067108, 7697.615119244016, 7697.769066928001, 7697.961510192413, 3734.029152420336, 3770.5286839145106, 3806.7715937043868, 3861.691064714816, 3866.0, 4305.9569404306185, 4357.847475338348, 4403.251447253974, 4406.27296496081, 4407.294832826797, 912.5665308978315, 920.0293690156815, 933.8459154239611, 935.3732998890623, 936.4194199596294, 635.2853040329629, 650.8405440667067, 662.102850637389, 672.7880717573948, 689.8516818883965, 9960.954099819559, 10275.948620256851, 10812.621558245424, 11132.944335278271, 13262.137961032502, 571.7912961768924, 664.465105589995, 670.0920253057135, 676.8662490328679, 696.7665831946254, 4294.763787991628, 4903.926441103386, 5483.725813709299, 5682.715864206773, 5782.392848750905, 101071.0, 102004.0, 102223.0, 102253.48873255735, 104099.479502602, 85710.0, 87147.0, 87254.0, 88246.55876720576, 88339.0, 76318.0, 77031.61484192543, 77405.83891241637, 77481.0, 79125.33994560958, 11988.39256926008, 12466.189697669623, 12660.810087848506, 12673.112882098165, 12692.17500862441, 39782.60217397789, 39834.0, 40784.388234175916, 41420.378694319006, 41444.79277603592, 49999.25001125059, 50317.49682503128, 50433.243501348246, 50576.988460231325, 51293.97412051813, 15549.0, 15691.450799221973, 15858.52424427269, 15967.68064638724, 16029.35882564731, 17409.216585253947, 17564.473065808048, 17723.82276177222, 17845.553861153057, 17972.910135449238, 16005.439809606607, 16198.595035124215, 16363.509094727176, 16406.343746250015, 16583.25375358136, 13302.0, 15792.447264345692, 15842.049477031414, 15883.682326353177, 16107.194640268173, 15779.447719330228, 15882.285297161425, 15977.680446390774, 16001.839981600035, 16027.519174424786, 9805.460699661588, 10226.875043745331, 11095.445227738743, 11413.828792568283, 12032.037437004843, 12638.494460221487, 12859.698747613415, 13079.803802943154, 13732.313384330942, 13759.17444953306], "value": 8121.424839211423, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1432.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 114.0, 160.0, 163.0, 112.0, 110.0, 111.0, 110.0, 111.0], "value": 121.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 110.0, 107.0, 149.0, 111.0, 105.0, 108.0, 107.0, 137.0, 109.0], "value": 118.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 183.0, 186.0, 185.0, 185.0, 185.0, 182.0, 179.0, 182.0, 186.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 61.0, 87.0, 61.0, 58.0, 59.0, 59.0, 82.0, 59.0], "value": 66.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 70.0, 85.0, 69.0, 68.0, 69.0, 86.0, 68.0, 68.0, 90.0], "value": 76.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 88.0, 88.0, 88.0, 88.0, 89.0, 88.0, 88.0, 88.0], "value": 88.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 103.0, 152.0], "value": 102.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 88.0, 87.0, 86.0, 79.0, 85.0, 84.0, 86.0, 85.0, 86.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 47.0, 49.0, 48.0, 49.0, 49.0, 48.0, 48.0, 48.0, 49.0], "value": 48.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 59.0, 60.0, 66.0, 63.0, 60.0, 55.0, 56.0, 56.0, 59.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 83.0, 83.0, 84.0, 80.0, 81.0, 86.0, 98.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 156.0, 138.0, 135.0, 135.0, 143.0, 141.0, 170.0, 132.0], "value": 144.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 189.0, 189.0, 188.0, 186.0, 186.0, 186.0, 187.0, 183.0, 189.0], "value": 187.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 66.0, 67.0, 68.0, 68.0, 67.0, 68.0, 68.0, 70.0], "value": 67.8, "unit": "score"}]}]} 04:48:13 INFO - Return code: 0 04:48:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:48:13 ERROR - # TBPL SUCCESS # 04:48:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:48:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:48:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:48:13 INFO - 2017-04-22 04:48:13.295 screenresolution[1671:10980] starting screenresolution argv=screenresolution get 04:48:13 INFO - 2017-04-22 04:48:13.298 screenresolution[1671:10980] Display 0: 1600x1200x32@60 04:48:13 INFO - 2017-04-22 04:48:13.304 screenresolution[1672:10983] starting screenresolution argv=screenresolution list 04:48:13 INFO - Available Modes on Display 0 04:48:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:48:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:48:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:48:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:48:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:48:13 INFO - Intel Iris: 04:48:13 INFO - Chipset Model: Intel Iris 04:48:13 INFO - Type: GPU 04:48:13 INFO - Bus: Built-In 04:48:13 INFO - VRAM (Dynamic, Max): 1536 MB 04:48:13 INFO - Vendor: Intel (0x8086) 04:48:13 INFO - Device ID: 0x0a2e 04:48:13 INFO - Revision ID: 0x0009 04:48:13 INFO - Displays: 04:48:13 INFO - Display: 04:48:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:48:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:48:13 INFO - Display Serial Number: 1600x1200 60 04:48:13 INFO - Main Display: Yes 04:48:13 INFO - Mirror: Off 04:48:13 INFO - Online: Yes 04:48:13 INFO - Rotation: Supported 04:48:13 INFO - Return code: 0 04:48:13 INFO - Running post-action listener: _resource_record_post_action 04:48:13 INFO - [mozharness: 2017-04-22 11:48:13.533940Z] Finished run-tests step (success) 04:48:13 INFO - Running post-run listener: _resource_record_post_run 04:48:13 INFO - Total resource usage - Wall time: 1201s; CPU: 53.0%; Read bytes: 33848320; Write bytes: 516752384; Read time: 314; Write time: 1843 04:48:13 INFO - TinderboxPrint: CPU usage
53.3% 04:48:13 INFO - TinderboxPrint: I/O read bytes / time
33,848,320 / 314 04:48:13 INFO - TinderboxPrint: I/O write bytes / time
516,752,384 / 1,843 04:48:13 INFO - TinderboxPrint: CPU idle
2,242.9 (46.7%) 04:48:13 INFO - TinderboxPrint: CPU system
959.2 (20.0%) 04:48:13 INFO - TinderboxPrint: CPU user
1,603.6 (33.4%) 04:48:13 INFO - TinderboxPrint: Swap in / out
238,514,176 / 0 04:48:13 INFO - install - Wall time: 20s; CPU: 55.0%; Read bytes: 205519360; Write bytes: 203071488; Read time: 15874; Write time: 379 04:48:13 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 31771648; Write bytes: 306627584; Read time: 292; Write time: 1435 04:48:14 INFO - Running post-run listener: _upload_blobber_files 04:48:14 INFO - Blob upload gear active. 04:48:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:48:14 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:48:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:48:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:48:14 INFO - (blobuploader) - INFO - Open directory for files ... 04:48:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:48:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:48:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:48:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:48:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:48:15 INFO - (blobuploader) - INFO - Done attempting. 04:48:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:48:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:48:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:48:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:48:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:48:16 INFO - (blobuploader) - INFO - Done attempting. 04:48:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:48:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:48:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:48:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:48:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:48:17 INFO - (blobuploader) - INFO - Done attempting. 04:48:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:48:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:48:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:48:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:48:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:48:19 INFO - (blobuploader) - INFO - Done attempting. 04:48:19 INFO - (blobuploader) - INFO - Iteration through files over. 04:48:19 INFO - Return code: 0 04:48:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:48:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:48:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c4ec480716ef21e0d12eff83c87309da1fb364be3c463b7eeabbec1eb98573c9c5e8b1207605fad6d523def9399ed889694c0211d2694233ae8b81ecab98746", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5c873d517581b6a9aaf7a9c881140d7669fc0e802949fb254b9c7a8847f6e244e2c80405ae92e72a4f7b46ab2d91bf6d19567e19bb003f4c0c62e4400b22805", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5b10c8831680255e6bd1465565f986eec9afebe3a7219b7d11b2bc2d5a619a4de926a640b92b039cf2eb030adf8f53607f1a94b439c76c257e4aa33a297f3f6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0469d2058e0b29633bed5eb77aa431a79e1e9710cc450b933e7ba5ce5cf672a7a5d52e5c6bd023a3942c64288a5dd41b18e7b78485500ca08792ce5a966d51e9"} 04:48:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:48:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:48:19 INFO - Contents: 04:48:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c4ec480716ef21e0d12eff83c87309da1fb364be3c463b7eeabbec1eb98573c9c5e8b1207605fad6d523def9399ed889694c0211d2694233ae8b81ecab98746", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5c873d517581b6a9aaf7a9c881140d7669fc0e802949fb254b9c7a8847f6e244e2c80405ae92e72a4f7b46ab2d91bf6d19567e19bb003f4c0c62e4400b22805", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5b10c8831680255e6bd1465565f986eec9afebe3a7219b7d11b2bc2d5a619a4de926a640b92b039cf2eb030adf8f53607f1a94b439c76c257e4aa33a297f3f6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0469d2058e0b29633bed5eb77aa431a79e1e9710cc450b933e7ba5ce5cf672a7a5d52e5c6bd023a3942c64288a5dd41b18e7b78485500ca08792ce5a966d51e9"} 04:48:19 INFO - Running post-run listener: copy_logs_to_upload_dir 04:48:19 INFO - Copying logs to upload dir... 04:48:19 INFO - mkdir: /builds/slave/test/build/upload/logs 04:48:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1291.017066 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2017-04-22 04:48:19.771225) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-22 04:48:19.776831) ========= 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.KRIDkGrirE/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.6mlxGQEyYw/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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/6c4ec480716ef21e0d12eff83c87309da1fb364be3c463b7eeabbec1eb98573c9c5e8b1207605fad6d523def9399ed889694c0211d2694233ae8b81ecab98746", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5c873d517581b6a9aaf7a9c881140d7669fc0e802949fb254b9c7a8847f6e244e2c80405ae92e72a4f7b46ab2d91bf6d19567e19bb003f4c0c62e4400b22805", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5b10c8831680255e6bd1465565f986eec9afebe3a7219b7d11b2bc2d5a619a4de926a640b92b039cf2eb030adf8f53607f1a94b439c76c257e4aa33a297f3f6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0469d2058e0b29633bed5eb77aa431a79e1e9710cc450b933e7ba5ce5cf672a7a5d52e5c6bd023a3942c64288a5dd41b18e7b78485500ca08792ce5a966d51e9"} build_url:https://queue.taskcluster.net/v1/task/LS5Yufv8T_KdVlaWrJUi5A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011282 build_url: 'https://queue.taskcluster.net/v1/task/LS5Yufv8T_KdVlaWrJUi5A/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/6c4ec480716ef21e0d12eff83c87309da1fb364be3c463b7eeabbec1eb98573c9c5e8b1207605fad6d523def9399ed889694c0211d2694233ae8b81ecab98746", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5c873d517581b6a9aaf7a9c881140d7669fc0e802949fb254b9c7a8847f6e244e2c80405ae92e72a4f7b46ab2d91bf6d19567e19bb003f4c0c62e4400b22805", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5b10c8831680255e6bd1465565f986eec9afebe3a7219b7d11b2bc2d5a619a4de926a640b92b039cf2eb030adf8f53607f1a94b439c76c257e4aa33a297f3f6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0469d2058e0b29633bed5eb77aa431a79e1e9710cc450b933e7ba5ce5cf672a7a5d52e5c6bd023a3942c64288a5dd41b18e7b78485500ca08792ce5a966d51e9"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-22 04:48:19.814878) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-22 04:48:19.815392) ========= 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.KRIDkGrirE/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.6mlxGQEyYw/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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.005168 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-22 04:48:19.865997) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-22 04:48:19.866550) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-22 04:48:19.867082) ========= ========= Total master_lag: 0.18 =========