builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0033 starttime: 1489236390.77 results: success (0) buildid: 20170311030203 builduid: ca637b10ecc74742ba80a8ed43daaaa4 revision: 4ceb9062ea8f4113bfd1b3536ace4a840a72faa7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-11 04:46:30.774590) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-11 04:46:30.775906) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-11 04:46:30.776239) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-11 04:46:31.118425) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-11 04:46:31.118722) ========= 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.39sapab4gB/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.dq0WxAhZ1G/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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-03-11 04:46:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 90.0M=0s 2017-03-11 04:46:31 (90.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.458007 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-11 04:46:31.602529) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-11 04:46:31.602856) ========= 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.39sapab4gB/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.dq0WxAhZ1G/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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.026208 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-11 04:46:31.656199) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-11 04:46:31.656869) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4ceb9062ea8f4113bfd1b3536ace4a840a72faa7 --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 4ceb9062ea8f4113bfd1b3536ace4a840a72faa7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.39sapab4gB/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.dq0WxAhZ1G/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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-03-11 04:46:32,124 truncating revision to first 12 chars 2017-03-11 04:46:32,125 Setting DEBUG logging. 2017-03-11 04:46:32,125 attempt 1/10 2017-03-11 04:46:32,125 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4ceb9062ea8f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-11 04:46:32,792 unpacking tar archive at: mozilla-central-4ceb9062ea8f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.942753 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-11 04:46:32.629464) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-11 04:46:32.630116) ========= script_repo_revision: 4ceb9062ea8f4113bfd1b3536ace4a840a72faa7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-11 04:46:32.630544) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-11 04:46:32.630850) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-11 04:46:32.652469) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-11 04:46:32.653224) ========= /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.39sapab4gB/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.dq0WxAhZ1G/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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:46:33 INFO - MultiFileLogger online at 20170311 04:46:33 in /builds/slave/test 04:46:33 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:46:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:46:33 INFO - {'append_to_log': False, 04:46:33 INFO - 'base_work_dir': '/builds/slave/test', 04:46:33 INFO - 'blob_upload_branch': 'Firefox', 04:46:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:46:33 INFO - 'branch': 'Firefox', 04:46:33 INFO - 'buildbot_json_path': 'buildprops.json', 04:46:33 INFO - 'config_files': ('talos/mac_config.py',), 04:46:33 INFO - 'default_actions': ('clobber', 04:46:33 INFO - 'read-buildbot-config', 04:46:33 INFO - 'download-and-extract', 04:46:33 INFO - 'populate-webroot', 04:46:33 INFO - 'create-virtualenv', 04:46:33 INFO - 'install', 04:46:33 INFO - 'run-tests'), 04:46:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:46:33 INFO - 'download_minidump_stackwalk': True, 04:46:33 INFO - 'download_symbols': 'ondemand', 04:46:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:46:33 INFO - 'tooltool.py': '/tools/tooltool.py', 04:46:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:46:33 INFO - '/tools/misc-python/virtualenv.py')}, 04:46:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:46:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:46:33 INFO - 'gecko_profile': False, 04:46:33 INFO - 'gecko_profile_interval': 0, 04:46:33 INFO - 'installer_path': 'installer.exe', 04:46:33 INFO - 'log_level': 'info', 04:46:33 INFO - 'log_name': 'talos', 04:46:33 INFO - 'log_to_console': True, 04:46:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:46:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:46:33 INFO - 'opt_config_files': (), 04:46:33 INFO - 'pip_index': False, 04:46:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:46:33 INFO - 'cmd': ('bash', 04:46:33 INFO - '-c', 04:46:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:46:33 INFO - 'enabled': True, 04:46:33 INFO - 'halt_on_failure': False, 04:46:33 INFO - 'name': 'check_screen_resolution'},), 04:46:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:46:33 INFO - 'cmd': ('bash', 04:46:33 INFO - '-c', 04:46:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:46:33 INFO - 'enabled': True, 04:46:33 INFO - 'halt_on_failure': False, 04:46:33 INFO - 'name': 'check_screen_resolution'},), 04:46:33 INFO - 'run_cmd_checks_enabled': True, 04:46:33 INFO - 'suite': 'dromaeojs', 04:46:33 INFO - 'system_bits': '32', 04:46:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:46:33 INFO - 'title': 't-yosemite-r7-0033', 04:46:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:46:33 INFO - 'use_talos_json': True, 04:46:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:46:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:46:33 INFO - 'work_dir': 'build'} 04:46:33 INFO - [mozharness: 2017-03-11 12:46:33.230414Z] Running clobber step. 04:46:33 INFO - Running pre-action listener: _resource_record_pre_action 04:46:33 INFO - Running main action method: clobber 04:46:33 INFO - rmtree: /builds/slave/test/build 04:46:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:46:35 INFO - Running post-action listener: _resource_record_post_action 04:46:35 INFO - [mozharness: 2017-03-11 12:46:35.742772Z] Finished clobber step (success) 04:46:35 INFO - [mozharness: 2017-03-11 12:46:35.742899Z] Running read-buildbot-config step. 04:46:35 INFO - Running pre-action listener: _resource_record_pre_action 04:46:35 INFO - Running main action method: read_buildbot_config 04:46:35 INFO - Using buildbot properties: 04:46:35 INFO - { 04:46:35 INFO - "project": "", 04:46:35 INFO - "product": "firefox", 04:46:35 INFO - "script_repo_revision": "production", 04:46:35 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:46:35 INFO - "repository": "", 04:46:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:46:35 INFO - "buildid": "20170311030203", 04:46:35 INFO - "stage_platform": "macosx64", 04:46:35 INFO - "basedir": "/builds/slave/test", 04:46:35 INFO - "nightly_build": "True", 04:46:35 INFO - "buildnumber": 65, 04:46:35 INFO - "slavename": "t-yosemite-r7-0033", 04:46:35 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:46:35 INFO - "platform": "yosemite_r7", 04:46:35 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:46:35 INFO - "branch": "mozilla-central", 04:46:35 INFO - "repo_path": "mozilla-central", 04:46:35 INFO - "revision": "4ceb9062ea8f4113bfd1b3536ace4a840a72faa7", 04:46:35 INFO - "pgo_build": "False", 04:46:35 INFO - "builduid": "ca637b10ecc74742ba80a8ed43daaaa4", 04:46:35 INFO - "slavebuilddir": "test" 04:46:35 INFO - } 04:46:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/eVHmAx_iT7KiWWTpXpiSjw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:46:35 INFO - Running post-action listener: _resource_record_post_action 04:46:35 INFO - [mozharness: 2017-03-11 12:46:35.746488Z] Finished read-buildbot-config step (success) 04:46:35 INFO - [mozharness: 2017-03-11 12:46:35.746599Z] Running download-and-extract step. 04:46:35 INFO - Running pre-action listener: _resource_record_pre_action 04:46:35 INFO - Running main action method: download_and_extract 04:46:35 INFO - mkdir: /builds/slave/test/build/tests 04:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:35 INFO - trying https://queue.taskcluster.net/v1/task/eVHmAx_iT7KiWWTpXpiSjw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:46:35 INFO - Downloading https://queue.taskcluster.net/v1/task/eVHmAx_iT7KiWWTpXpiSjw/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:46:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eVHmAx_iT7KiWWTpXpiSjw/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:46:36 INFO - Downloaded 1199 bytes. 04:46:36 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:46:36 INFO - Using the following test package requirements: 04:46:36 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:46:36 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:46:36 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:46:36 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:46:36 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:46:36 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:46:36 INFO - u'jsshell-mac.zip'], 04:46:36 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:46:36 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:46:36 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:46:36 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:46:36 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:46:36 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:46:36 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:46:36 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:46:36 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:46:36 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:46:36 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:46:36 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:46:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eVHmAx_iT7KiWWTpXpiSjw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:46:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eVHmAx_iT7KiWWTpXpiSjw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:46:36 INFO - Fetch https://queue.taskcluster.net/v1/task/eVHmAx_iT7KiWWTpXpiSjw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:46:38 INFO - Expected file size: 51787945 04:46:38 INFO - Obtained file size: 51787945 04:46:55 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:46:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eVHmAx_iT7KiWWTpXpiSjw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:46:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eVHmAx_iT7KiWWTpXpiSjw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:46:55 INFO - Fetch https://queue.taskcluster.net/v1/task/eVHmAx_iT7KiWWTpXpiSjw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:46:56 INFO - Expected file size: 51787945 04:46:56 INFO - Obtained file size: 51787945 04:47:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eVHmAx_iT7KiWWTpXpiSjw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:47:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eVHmAx_iT7KiWWTpXpiSjw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:47:12 INFO - Fetch https://queue.taskcluster.net/v1/task/eVHmAx_iT7KiWWTpXpiSjw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:47:12 INFO - Expected file size: 14404438 04:47:12 INFO - Obtained file size: 14404438 04:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:13 INFO - trying https://queue.taskcluster.net/v1/task/eVHmAx_iT7KiWWTpXpiSjw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:47:13 INFO - Downloading https://queue.taskcluster.net/v1/task/eVHmAx_iT7KiWWTpXpiSjw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:47:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eVHmAx_iT7KiWWTpXpiSjw/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:47:15 INFO - Downloaded 75022186 bytes. 04:47:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eVHmAx_iT7KiWWTpXpiSjw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:47:15 INFO - mkdir: /builds/slave/test/properties 04:47:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:47:15 INFO - Writing to file /builds/slave/test/properties/build_url 04:47:15 INFO - Contents: 04:47:15 INFO - build_url:https://queue.taskcluster.net/v1/task/eVHmAx_iT7KiWWTpXpiSjw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:47:16 INFO - Running post-action listener: _resource_record_post_action 04:47:16 INFO - Running post-action listener: set_extra_try_arguments 04:47:16 INFO - [mozharness: 2017-03-11 12:47:16.411806Z] Finished download-and-extract step (success) 04:47:16 INFO - [mozharness: 2017-03-11 12:47:16.411945Z] Running populate-webroot step. 04:47:16 INFO - Running pre-action listener: _resource_record_pre_action 04:47:16 INFO - Running main action method: populate_webroot 04:47:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:47:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:47:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:47:16 INFO - '--tppagecycles', 04:47:16 INFO - '7'], 04:47:16 INFO - 'tests': ['tsvgm']}}, 04:47:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:47:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:47:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:47:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:47:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:47:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:47:16 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:47:16 INFO - 'talos_options': ['--disable-e10s'], 04:47:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:47:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:47:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:47:16 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:47:16 INFO - 'talos_options': ['--disable-e10s'], 04:47:16 INFO - 'tests': ['damp', 'tps']}, 04:47:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:47:16 INFO - 'tests': ['damp', 'tps']}, 04:47:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:47:16 INFO - 'tests': ['dromaeo_dom']}, 04:47:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:47:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:47:16 INFO - 'tests': ['basic_compositor_video']}, 04:47:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:47:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:47:16 INFO - 'tests': ['a11yr', 04:47:16 INFO - 'ts_paint', 04:47:16 INFO - 'tpaint', 04:47:16 INFO - 'sessionrestore', 04:47:16 INFO - 'sessionrestore_no_auto_restore', 04:47:16 INFO - 'tabpaint']}, 04:47:16 INFO - 'other-e10s': {'tests': ['a11yr', 04:47:16 INFO - 'ts_paint', 04:47:16 INFO - 'tpaint', 04:47:16 INFO - 'sessionrestore', 04:47:16 INFO - 'sessionrestore_no_auto_restore', 04:47:16 INFO - 'tabpaint']}, 04:47:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:47:16 INFO - 'ts_paint', 04:47:16 INFO - 'tpaint', 04:47:16 INFO - 'sessionrestore', 04:47:16 INFO - 'sessionrestore_no_auto_restore', 04:47:16 INFO - 'tabpaint']}, 04:47:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:47:16 INFO - 'ts_paint', 04:47:16 INFO - 'tpaint', 04:47:16 INFO - 'sessionrestore', 04:47:16 INFO - 'sessionrestore_no_auto_restore', 04:47:16 INFO - 'tabpaint']}, 04:47:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:47:16 INFO - 'tests': ['a11yr', 04:47:16 INFO - 'ts_paint', 04:47:16 INFO - 'tpaint', 04:47:16 INFO - 'sessionrestore', 04:47:16 INFO - 'sessionrestore_no_auto_restore', 04:47:16 INFO - 'tabpaint']}, 04:47:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:47:16 INFO - 'tests': ['a11yr', 04:47:16 INFO - 'ts_paint', 04:47:16 INFO - 'tpaint', 04:47:16 INFO - 'sessionrestore', 04:47:16 INFO - 'sessionrestore_no_auto_restore', 04:47:16 INFO - 'tabpaint']}, 04:47:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:47:16 INFO - 'tests': ['tsvgx', 04:47:16 INFO - 'tsvgr_opacity', 04:47:16 INFO - 'tart', 04:47:16 INFO - 'tscrollx', 04:47:16 INFO - 'cart', 04:47:16 INFO - 'tsvg_static']}, 04:47:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:47:16 INFO - 'tsvgr_opacity', 04:47:16 INFO - 'tart', 04:47:16 INFO - 'tscrollx', 04:47:16 INFO - 'cart', 04:47:16 INFO - 'tsvg_static']}, 04:47:16 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:47:16 INFO - 'talos_options': ['--disable-e10s'], 04:47:16 INFO - 'tests': ['tp5o']}, 04:47:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:47:16 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:47:16 INFO - 'talos_options': ['--disable-e10s', 04:47:16 INFO - '--xperf_path', 04:47:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:47:16 INFO - 'tests': ['tp5n']}, 04:47:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:47:16 INFO - 'talos_options': ['--xperf_path', 04:47:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:47:16 INFO - 'tests': ['tp5n']}}, 04:47:16 INFO - 'talos.zip': {'path': '', 04:47:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:47:16 INFO - Running post-action listener: _resource_record_post_action 04:47:16 INFO - [mozharness: 2017-03-11 12:47:16.430063Z] Finished populate-webroot step (success) 04:47:16 INFO - [mozharness: 2017-03-11 12:47:16.430201Z] Running create-virtualenv step. 04:47:16 INFO - Running pre-action listener: _resource_record_pre_action 04:47:16 INFO - Running main action method: create_virtualenv 04:47:16 INFO - Creating virtualenv /builds/slave/test/build/venv 04:47:16 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:47:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:47:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:47:16 INFO - Using real prefix '/tools/python27' 04:47:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:47:17 INFO - Installing distribute.............................................................................................................................................................................................done. 04:47:20 INFO - Installing pip.................done. 04:47:20 INFO - Return code: 0 04:47:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:47:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:47:20 INFO - Reading from file tmpfile_stdout 04:47:20 INFO - Output received: 04:47:20 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:47:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:47:20 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:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:20 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:47:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:20 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 0x104cdeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ce1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfb04aae40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104abcd30>, '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 0x1049e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ab1be8>, '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.39sapab4gB/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.dq0WxAhZ1G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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:47:20 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:47:20 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:47:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.39sapab4gB/Render', 04:47:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:20 INFO - 'HOME': '/Users/cltbld', 04:47:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:20 INFO - 'LOGNAME': 'cltbld', 04:47:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:20 INFO - 'MOZ_NO_REMOTE': '1', 04:47:20 INFO - 'NO_EM_RESTART': '1', 04:47:20 INFO - 'PAGER': '/bin/cat', 04:47:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:20 INFO - 'PWD': '/builds/slave/test', 04:47:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:20 INFO - 'SHELL': '/bin/bash', 04:47:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dq0WxAhZ1G/Listeners', 04:47:20 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 04:47:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:20 INFO - 'USER': 'cltbld', 04:47:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:20 INFO - 'XPC_FLAGS': '0x0', 04:47:20 INFO - 'XPC_SERVICE_NAME': '0', 04:47:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:20 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:47:20 INFO - Cleaning up... 04:47:20 INFO - Return code: 0 04:47:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:47:20 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:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:20 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:47:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:20 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 0x104cdeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ce1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfb04aae40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104abcd30>, '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 0x1049e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ab1be8>, '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.39sapab4gB/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.dq0WxAhZ1G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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:47:20 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:47:20 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:47:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.39sapab4gB/Render', 04:47:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:20 INFO - 'HOME': '/Users/cltbld', 04:47:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:20 INFO - 'LOGNAME': 'cltbld', 04:47:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:20 INFO - 'MOZ_NO_REMOTE': '1', 04:47:20 INFO - 'NO_EM_RESTART': '1', 04:47:20 INFO - 'PAGER': '/bin/cat', 04:47:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:20 INFO - 'PWD': '/builds/slave/test', 04:47:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:20 INFO - 'SHELL': '/bin/bash', 04:47:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dq0WxAhZ1G/Listeners', 04:47:20 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 04:47:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:20 INFO - 'USER': 'cltbld', 04:47:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:20 INFO - 'XPC_FLAGS': '0x0', 04:47:20 INFO - 'XPC_SERVICE_NAME': '0', 04:47:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:20 INFO - Downloading/unpacking psutil>=3.1.1 04:47:20 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:47:20 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:47:20 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:47:20 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:47:20 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:47:20 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:47:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:47:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:47:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:47:25 INFO - Installing collected packages: psutil 04:47:25 INFO - Running setup.py install for psutil 04:47:25 INFO - building 'psutil._psutil_osx' extension 04:47:25 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:47:25 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:47:25 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:47:25 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:47:25 INFO - building 'psutil._psutil_posix' extension 04:47:25 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:47:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:47:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:47:25 INFO - ^ 04:47:26 INFO - 1 warning generated. 04:47:26 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:47:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:47:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:47:26 INFO - Successfully installed psutil 04:47:26 INFO - Cleaning up... 04:47:26 INFO - Return code: 0 04:47:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:47:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104cdeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ce1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfb04aae40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104abcd30>, '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 0x1049e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ab1be8>, '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.39sapab4gB/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.dq0WxAhZ1G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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:47:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:47:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:47:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.39sapab4gB/Render', 04:47:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:26 INFO - 'HOME': '/Users/cltbld', 04:47:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:26 INFO - 'LOGNAME': 'cltbld', 04:47:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:26 INFO - 'MOZ_NO_REMOTE': '1', 04:47:26 INFO - 'NO_EM_RESTART': '1', 04:47:26 INFO - 'PAGER': '/bin/cat', 04:47:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:26 INFO - 'PWD': '/builds/slave/test', 04:47:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:26 INFO - 'SHELL': '/bin/bash', 04:47:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dq0WxAhZ1G/Listeners', 04:47:26 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 04:47:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:26 INFO - 'USER': 'cltbld', 04:47:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:26 INFO - 'XPC_FLAGS': '0x0', 04:47:26 INFO - 'XPC_SERVICE_NAME': '0', 04:47:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:47:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:47:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:47:29 INFO - Installing collected packages: mozsystemmonitor 04:47:29 INFO - Running setup.py install for mozsystemmonitor 04:47:29 INFO - Successfully installed mozsystemmonitor 04:47:29 INFO - Cleaning up... 04:47:29 INFO - Return code: 0 04:47:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:47:29 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:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:29 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:47:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:29 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 0x104cdeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ce1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfb04aae40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104abcd30>, '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 0x1049e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ab1be8>, '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.39sapab4gB/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.dq0WxAhZ1G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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:47:29 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:47:29 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:47:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.39sapab4gB/Render', 04:47:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:29 INFO - 'HOME': '/Users/cltbld', 04:47:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:29 INFO - 'LOGNAME': 'cltbld', 04:47:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:29 INFO - 'MOZ_NO_REMOTE': '1', 04:47:29 INFO - 'NO_EM_RESTART': '1', 04:47:29 INFO - 'PAGER': '/bin/cat', 04:47:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:29 INFO - 'PWD': '/builds/slave/test', 04:47:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:29 INFO - 'SHELL': '/bin/bash', 04:47:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dq0WxAhZ1G/Listeners', 04:47:29 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 04:47:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:29 INFO - 'USER': 'cltbld', 04:47:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:29 INFO - 'XPC_FLAGS': '0x0', 04:47:29 INFO - 'XPC_SERVICE_NAME': '0', 04:47:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:29 INFO - Downloading/unpacking jsonschema==2.5.1 04:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:47:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:47:32 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:47:32 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:47:32 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:47:32 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:47:32 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:47:32 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:47:32 INFO - Downloading functools32-3.2.3-2.tar.gz 04:47:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:47:32 INFO - warning: no files found matching '*.txt' 04:47:32 INFO - no previously-included directories found matching 'build' 04:47:32 INFO - no previously-included directories found matching 'dist' 04:47:32 INFO - no previously-included directories found matching '.git*' 04:47:32 INFO - Installing collected packages: jsonschema, functools32 04:47:32 INFO - Running setup.py install for functools32 04:47:33 INFO - warning: no files found matching '*.txt' 04:47:33 INFO - no previously-included directories found matching 'build' 04:47:33 INFO - no previously-included directories found matching 'dist' 04:47:33 INFO - no previously-included directories found matching '.git*' 04:47:33 INFO - Successfully installed jsonschema functools32 04:47:33 INFO - Cleaning up... 04:47:33 INFO - Return code: 0 04:47:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:47:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:33 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 0x104cdeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ce1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfb04aae40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104abcd30>, '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 0x1049e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ab1be8>, '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.39sapab4gB/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.dq0WxAhZ1G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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:47:33 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:47:33 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:47:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.39sapab4gB/Render', 04:47:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:33 INFO - 'HOME': '/Users/cltbld', 04:47:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:33 INFO - 'LOGNAME': 'cltbld', 04:47:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:33 INFO - 'MOZ_NO_REMOTE': '1', 04:47:33 INFO - 'NO_EM_RESTART': '1', 04:47:33 INFO - 'PAGER': '/bin/cat', 04:47:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:33 INFO - 'PWD': '/builds/slave/test', 04:47:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:33 INFO - 'SHELL': '/bin/bash', 04:47:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dq0WxAhZ1G/Listeners', 04:47:33 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 04:47:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:33 INFO - 'USER': 'cltbld', 04:47:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:33 INFO - 'XPC_FLAGS': '0x0', 04:47:33 INFO - 'XPC_SERVICE_NAME': '0', 04:47:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:47:33 INFO - Cleaning up... 04:47:33 INFO - Return code: 0 04:47:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:47:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:33 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 0x104cdeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ce1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfb04aae40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104abcd30>, '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 0x1049e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ab1be8>, '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.39sapab4gB/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.dq0WxAhZ1G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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:47:33 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:47:33 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:47:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.39sapab4gB/Render', 04:47:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:33 INFO - 'HOME': '/Users/cltbld', 04:47:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:33 INFO - 'LOGNAME': 'cltbld', 04:47:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:33 INFO - 'MOZ_NO_REMOTE': '1', 04:47:33 INFO - 'NO_EM_RESTART': '1', 04:47:33 INFO - 'PAGER': '/bin/cat', 04:47:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:33 INFO - 'PWD': '/builds/slave/test', 04:47:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:33 INFO - 'SHELL': '/bin/bash', 04:47:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dq0WxAhZ1G/Listeners', 04:47:33 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 04:47:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:33 INFO - 'USER': 'cltbld', 04:47:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:33 INFO - 'XPC_FLAGS': '0x0', 04:47:33 INFO - 'XPC_SERVICE_NAME': '0', 04:47:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:33 INFO - Downloading/unpacking blobuploader==1.2.4 04:47:33 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:47:33 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:47:33 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:47:33 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:47:33 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:47:33 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:47:36 INFO - Downloading blobuploader-1.2.4.tar.gz 04:47:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:47:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:47:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:47:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:47:37 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:47:37 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:47:37 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:47:37 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:47:37 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:47:37 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:47:37 INFO - Downloading docopt-0.6.1.tar.gz 04:47:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:47:37 INFO - Installing collected packages: blobuploader, requests, docopt 04:47:37 INFO - Running setup.py install for blobuploader 04:47:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:47:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:47:37 INFO - Running setup.py install for requests 04:47:38 INFO - Running setup.py install for docopt 04:47:38 INFO - Successfully installed blobuploader requests docopt 04:47:38 INFO - Cleaning up... 04:47:38 INFO - Return code: 0 04:47:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47:38 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:47:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:38 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:47:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:38 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 0x104cdeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ce1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfb04aae40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104abcd30>, '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 0x1049e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ab1be8>, '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.39sapab4gB/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.dq0WxAhZ1G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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:47:38 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:47:38 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:47:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.39sapab4gB/Render', 04:47:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:38 INFO - 'HOME': '/Users/cltbld', 04:47:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:38 INFO - 'LOGNAME': 'cltbld', 04:47:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:38 INFO - 'MOZ_NO_REMOTE': '1', 04:47:38 INFO - 'NO_EM_RESTART': '1', 04:47:38 INFO - 'PAGER': '/bin/cat', 04:47:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:38 INFO - 'PWD': '/builds/slave/test', 04:47:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:38 INFO - 'SHELL': '/bin/bash', 04:47:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dq0WxAhZ1G/Listeners', 04:47:38 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 04:47:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:38 INFO - 'USER': 'cltbld', 04:47:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:38 INFO - 'XPC_FLAGS': '0x0', 04:47:38 INFO - 'XPC_SERVICE_NAME': '0', 04:47:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:47:38 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-pXYagO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:47:38 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-_BFRox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:47:39 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-WuVPXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:47:39 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-0r2bvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:47:39 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-8o2pF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:47:39 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-kic_vv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:47:39 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-yuj02J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:47:39 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-BfAGHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:47:39 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-3UVpEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:47:39 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-VhuXk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:47:39 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-84DDNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:47:39 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-ZBa7D5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:47:40 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-9WzYBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:47:40 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-_P1cfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:40 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-oPoIW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:47:40 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-7rscG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:47:40 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-XygNgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:47:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:47:40 INFO - Running setup.py install for manifestparser 04:47:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:47:40 INFO - Running setup.py install for mozcrash 04:47:40 INFO - Running setup.py install for mozdebug 04:47:40 INFO - Running setup.py install for mozdevice 04:47:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:47:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:47:41 INFO - Running setup.py install for mozfile 04:47:41 INFO - Running setup.py install for mozhttpd 04:47:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:47:41 INFO - Running setup.py install for mozinfo 04:47:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:47:41 INFO - Running setup.py install for mozInstall 04:47:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:47:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:47:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:47:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:47:41 INFO - Running setup.py install for mozleak 04:47:41 INFO - Running setup.py install for mozlog 04:47:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:47:42 INFO - Running setup.py install for moznetwork 04:47:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:47:42 INFO - Running setup.py install for mozprocess 04:47:42 INFO - Running setup.py install for mozprofile 04:47:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:47:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:47:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:47:42 INFO - Running setup.py install for mozrunner 04:47:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:47:42 INFO - Running setup.py install for mozscreenshot 04:47:42 INFO - Running setup.py install for moztest 04:47:43 INFO - Running setup.py install for mozversion 04:47:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:47:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:47:43 INFO - Cleaning up... 04:47:43 INFO - Return code: 0 04:47:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47: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:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47: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:47:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:43 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 0x104cdeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ce1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfb04aae40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104abcd30>, '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 0x1049e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ab1be8>, '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.39sapab4gB/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.dq0WxAhZ1G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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:47:43 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:47:43 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:47:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.39sapab4gB/Render', 04:47:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:43 INFO - 'HOME': '/Users/cltbld', 04:47:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:43 INFO - 'LOGNAME': 'cltbld', 04:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:43 INFO - 'MOZ_NO_REMOTE': '1', 04:47:43 INFO - 'NO_EM_RESTART': '1', 04:47:43 INFO - 'PAGER': '/bin/cat', 04:47:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:43 INFO - 'PWD': '/builds/slave/test', 04:47:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:43 INFO - 'SHELL': '/bin/bash', 04:47:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dq0WxAhZ1G/Listeners', 04:47:43 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 04:47:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:43 INFO - 'USER': 'cltbld', 04:47:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:43 INFO - 'XPC_FLAGS': '0x0', 04:47:43 INFO - 'XPC_SERVICE_NAME': '0', 04:47:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:47:43 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-xm_rjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:47:43 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:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:47:43 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-wPe_2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:47:43 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:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:47:43 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-fro93Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:47:43 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:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:47:43 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-Wd8oRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:47:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:47:43 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-pkgP8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:47:43 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:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:47:43 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-S2fUAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:47:44 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:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:47:44 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-M6ZmPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:47:44 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:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:47:44 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-rt_URV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:47:44 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:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:47:44 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-WFslsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:47:44 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:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:47:44 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-jj5qth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:47:44 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:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:47:44 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-6VrBmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:47:44 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:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:47:44 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-ZyD9Vl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:47:44 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:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:47:44 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-MkYXCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:47:44 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:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:47:44 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-3xOnH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:47:44 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:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:44 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-LCnAw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:45 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:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:47:45 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-DtenwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:47:45 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:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:47:45 INFO - Running setup.py (path:/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/pip-9J_Moe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:47:45 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:47:45 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:47:45 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:47:45 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:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:47:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:47:45 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:47:45 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:47:45 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:47:45 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:47:45 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:47:45 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:47:47 INFO - Downloading blessings-1.6.tar.gz 04:47:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:47:47 INFO - Installing collected packages: blessings 04:47:47 INFO - Running setup.py install for blessings 04:47:48 INFO - Successfully installed blessings 04:47:48 INFO - Cleaning up... 04:47:48 INFO - Return code: 0 04:47:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:47:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:47:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:47:48 INFO - Reading from file tmpfile_stdout 04:47:48 INFO - Current package versions: 04:47:48 INFO - blessings == 1.6 04:47:48 INFO - blobuploader == 1.2.4 04:47:48 INFO - docopt == 0.6.1 04:47:48 INFO - functools32 == 3.2.3-2 04:47:48 INFO - jsonschema == 2.5.1 04:47:48 INFO - manifestparser == 1.1 04:47:48 INFO - mozInstall == 1.12 04:47:48 INFO - mozcrash == 1.0 04:47:48 INFO - mozdebug == 0.1 04:47:48 INFO - mozdevice == 0.49 04:47:48 INFO - mozfile == 1.2 04:47:48 INFO - mozhttpd == 0.7 04:47:48 INFO - mozinfo == 0.9 04:47:48 INFO - mozleak == 0.1 04:47:48 INFO - mozlog == 3.4 04:47:48 INFO - moznetwork == 0.27 04:47:48 INFO - mozprocess == 0.25 04:47:48 INFO - mozprofile == 0.28 04:47:48 INFO - mozrunner == 6.13 04:47:48 INFO - mozscreenshot == 0.1 04:47:48 INFO - mozsystemmonitor == 0.3 04:47:48 INFO - moztest == 0.8 04:47:48 INFO - mozversion == 1.4 04:47:48 INFO - psutil == 3.1.1 04:47:48 INFO - requests == 1.2.3 04:47:48 INFO - wsgiref == 0.1.2 04:47:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47:48 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:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:48 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:47:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:48 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 0x104cdeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ce1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfb04aae40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104abcd30>, '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 0x1049e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ab1be8>, '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.39sapab4gB/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.dq0WxAhZ1G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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:47:48 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:47:48 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:47:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.39sapab4gB/Render', 04:47:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:48 INFO - 'HOME': '/Users/cltbld', 04:47:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:48 INFO - 'LOGNAME': 'cltbld', 04:47:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:48 INFO - 'MOZ_NO_REMOTE': '1', 04:47:48 INFO - 'NO_EM_RESTART': '1', 04:47:48 INFO - 'PAGER': '/bin/cat', 04:47:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:48 INFO - 'PWD': '/builds/slave/test', 04:47:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:48 INFO - 'SHELL': '/bin/bash', 04:47:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dq0WxAhZ1G/Listeners', 04:47:48 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 04:47:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:48 INFO - 'USER': 'cltbld', 04:47:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:48 INFO - 'XPC_FLAGS': '0x0', 04:47:48 INFO - 'XPC_SERVICE_NAME': '0', 04:47:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:48 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:47:48 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:47:48 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:47:48 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:47:48 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:47:48 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:47:48 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:47:48 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:47:48 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:47:48 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:47:48 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:47:48 INFO - Cleaning up... 04:47:48 INFO - Return code: 0 04:47:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:47:48 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:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:48 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:47:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:48 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 0x104cdeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ce1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfb04aae40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104abcd30>, '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 0x1049e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ab1be8>, '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.39sapab4gB/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.dq0WxAhZ1G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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:47:48 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:47:48 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:47:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.39sapab4gB/Render', 04:47:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:48 INFO - 'HOME': '/Users/cltbld', 04:47:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:48 INFO - 'LOGNAME': 'cltbld', 04:47:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:48 INFO - 'MOZ_NO_REMOTE': '1', 04:47:48 INFO - 'NO_EM_RESTART': '1', 04:47:48 INFO - 'PAGER': '/bin/cat', 04:47:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:48 INFO - 'PWD': '/builds/slave/test', 04:47:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:48 INFO - 'SHELL': '/bin/bash', 04:47:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dq0WxAhZ1G/Listeners', 04:47:48 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 04:47:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:48 INFO - 'USER': 'cltbld', 04:47:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:48 INFO - 'XPC_FLAGS': '0x0', 04:47:48 INFO - 'XPC_SERVICE_NAME': '0', 04:47:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:47:49 INFO - Cleaning up... 04:47:49 INFO - Return code: 0 04:47:49 INFO - Running post-action listener: _resource_record_post_action 04:47:49 INFO - Running post-action listener: _start_resource_monitoring 04:47:49 INFO - Starting resource monitoring. 04:47:49 INFO - [mozharness: 2017-03-11 12:47:49.111682Z] Finished create-virtualenv step (success) 04:47:49 INFO - [mozharness: 2017-03-11 12:47:49.112641Z] Running install step. 04:47:49 INFO - Running pre-action listener: _resource_record_pre_action 04:47:49 INFO - Running main action method: install 04:47:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:47:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:47:49 INFO - Reading from file tmpfile_stdout 04:47:49 INFO - Detecting whether we're running mozinstall >=1.0... 04:47:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:47:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:47:49 INFO - Reading from file tmpfile_stdout 04:47:49 INFO - Output received: 04:47:49 INFO - Usage: mozinstall [options] installer 04:47:49 INFO - Options: 04:47:49 INFO - -h, --help show this help message and exit 04:47:49 INFO - -d DEST, --destination=DEST 04:47:49 INFO - Directory to install application into. [default: 04:47:49 INFO - "/builds/slave/test"] 04:47:49 INFO - --app=APP Application being installed. [default: firefox] 04:47:49 INFO - mkdir: /builds/slave/test/build/application 04:47:49 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:47:49 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:48:09 INFO - Reading from file tmpfile_stdout 04:48:09 INFO - Output received: 04:48:09 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:48:09 INFO - Running post-action listener: _resource_record_post_action 04:48:09 INFO - [mozharness: 2017-03-11 12:48:09.628250Z] Finished install step (success) 04:48:09 INFO - [mozharness: 2017-03-11 12:48:09.628387Z] Running run-tests step. 04:48:09 INFO - Running pre-action listener: _resource_record_pre_action 04:48:09 INFO - Running main action method: run_tests 04:48:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:48:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:48:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:48:09 INFO - 2017-03-11 04:48:09.642 screenresolution[1674:15871] starting screenresolution argv=screenresolution get 04:48:09 INFO - 2017-03-11 04:48:09.645 screenresolution[1674:15871] Display 0: 1600x1200x32@60 04:48:09 INFO - 2017-03-11 04:48:09.650 screenresolution[1675:15873] starting screenresolution argv=screenresolution list 04:48:09 INFO - Available Modes on Display 0 04:48:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:48:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:48:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:48:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:48:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:48:09 INFO - Intel Iris: 04:48:09 INFO - Chipset Model: Intel Iris 04:48:09 INFO - Type: GPU 04:48:09 INFO - Bus: Built-In 04:48:09 INFO - VRAM (Dynamic, Max): 1536 MB 04:48:09 INFO - Vendor: Intel (0x8086) 04:48:09 INFO - Device ID: 0x0a2e 04:48:09 INFO - Revision ID: 0x0009 04:48:09 INFO - Displays: 04:48:09 INFO - Display: 04:48:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:48:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:48:09 INFO - Display Serial Number: 1600x1200 60 04:48:09 INFO - Main Display: Yes 04:48:09 INFO - Mirror: Off 04:48:09 INFO - Online: Yes 04:48:09 INFO - Rotation: Supported 04:48:09 INFO - Return code: 0 04:48:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:48:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:48:09 INFO - Python 2.7.3 04:48:09 INFO - Return code: 0 04:48:09 INFO - grabbing minidump binary from tooltool 04:48:09 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:48:09 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 0x104abcd30>, '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 0x1049e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ab1be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:48:09 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:48:09 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:48:09 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:48:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:48:10 INFO - Return code: 0 04:48:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:48:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:48:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:48:10 INFO - ENV: RUST_BACKTRACE is now 1 04:48:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:48:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:48:10 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/eVHmAx_iT7KiWWTpXpiSjw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0033', '--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:48:10 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/eVHmAx_iT7KiWWTpXpiSjw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0033 --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:48:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.39sapab4gB/Render', 04:48:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:48:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:48:10 INFO - 'HOME': '/Users/cltbld', 04:48:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:48:10 INFO - 'LOGNAME': 'cltbld', 04:48:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:48:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:10 INFO - 'MOZ_NO_REMOTE': '1', 04:48:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:48:10 INFO - 'NO_EM_RESTART': '1', 04:48:10 INFO - 'PAGER': '/bin/cat', 04:48:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:10 INFO - 'PWD': '/builds/slave/test', 04:48:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:48:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:48:10 INFO - 'RUST_BACKTRACE': '1', 04:48:10 INFO - 'SHELL': '/bin/bash', 04:48:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dq0WxAhZ1G/Listeners', 04:48:10 INFO - 'TMPDIR': '/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/', 04:48:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:48:10 INFO - 'USER': 'cltbld', 04:48:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:48:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:10 INFO - 'XPC_FLAGS': '0x0', 04:48:10 INFO - 'XPC_SERVICE_NAME': '0', 04:48:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:48:10 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/eVHmAx_iT7KiWWTpXpiSjw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0033', '--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:48:10 INFO - mozversion application_buildid: 20170311030203 04:48:10 INFO - mozversion application_changeset: 4ceb9062ea8f4113bfd1b3536ace4a840a72faa7 04:48:10 INFO - mozversion application_display_name: Nightly 04:48:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:48:10 INFO - mozversion application_name: Firefox 04:48:10 INFO - mozversion application_remotingname: firefox 04:48:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:48:10 INFO - mozversion application_vendor: Mozilla 04:48:10 INFO - mozversion application_version: 55.0a1 04:48:10 INFO - mozversion platform_buildid: 20170311030203 04:48:10 INFO - mozversion platform_changeset: 4ceb9062ea8f4113bfd1b3536ace4a840a72faa7 04:48:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:48:10 INFO - mozversion platform_version: 55.0a1 04:48:10 INFO - using testdate: 1489236490 04:48:10 INFO - actual date: 1489236490 04:48:10 INFO - starting webserver on 'localhost:49242' 04:48:10 INFO - SUITE-START | Running 2 tests 04:48:10 INFO - TEST-START | dromaeo_css 04:48:10 INFO - operating with platform_type : mac_ 04:48:10 INFO - Initialising browser for dromaeo_css test... 04:48:10 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/tmpQvdIOp/profile http://localhost:49242/getInfo.html) 04:48:12 INFO - PROCESS | 1685 | __metrics Screen width/height:1600/1200 04:48:12 INFO - PROCESS | 1685 | colorDepth:24 04:48:12 INFO - PROCESS | 1685 | Browser inner width/height: 1024/689 04:48:12 INFO - PROCESS | 1685 | __metrics 04:48:12 INFO - PROCESS | 1685 | 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:48:12 INFO - PROCESS | 1685 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:48:13 INFO - TEST-INFO | 1685: exit 0 04:48:13 INFO - Browser initialized. 04:48:13 INFO - Running cycle 1/1 for dromaeo_css test... 04:48:13 INFO - TEST-INFO | started process 1689 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/tmpQvdIOp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:48:25 INFO - PROCESS | 1689 | RSS: Main: 232701952 04:48:25 INFO - PROCESS | 1689 | 04:51:29 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 04:51:32 INFO - PROCESS | 1689 | RSS: Main: 499306496 04:51:32 INFO - PROCESS | 1689 | 04:53:16 INFO - PROCESS | 1689 | ************************* 04:53:16 INFO - PROCESS | 1689 | A coding exception was thrown and uncaught in a Task. 04:53:16 INFO - PROCESS | 1689 | 04:53:16 ERROR - PROCESS | 1689 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:53:16 INFO - PROCESS | 1689 | Full stack: 04:53:16 INFO - PROCESS | 1689 | ************************* 04:54:36 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 04:54:36 INFO - PROCESS | 1689 | RSS: Main: 466812928 04:54:36 INFO - PROCESS | 1689 | 04:57:39 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 04:57:39 INFO - PROCESS | 1689 | RSS: Main: 345935872 04:57:39 INFO - PROCESS | 1689 | 05:00:42 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 05:00:42 INFO - PROCESS | 1689 | RSS: Main: 332185600 05:00:42 INFO - PROCESS | 1689 | 05:03:46 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 05:03:47 INFO - PROCESS | 1689 | RSS: Main: 341708800 05:03:47 INFO - PROCESS | 1689 | 05:06:50 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 05:06:51 INFO - PROCESS | 1689 | RSS: Main: 376020992 05:06:51 INFO - PROCESS | 1689 | 05:06:51 INFO - PROCESS | 1689 | __start_tp_report 05:06:51 INFO - PROCESS | 1689 | _x_x_mozilla_page_load 05:06:51 INFO - PROCESS | 1689 | _x_x_mozilla_page_load_details 05:06:51 INFO - PROCESS | 1689 | |i|pagename|runs| 05:06:51 INFO - PROCESS | 1689 | |0;dojo.html;3375.8480868360934;3390;3394.083597428696;3398.1674489750017;3441.3289408565324;5002.324686167366;5587.664740115596;5848.59059865809;5931.258592675916;5957.344692083872;5598.328200615922;5690.118031705082;5730.4269573042675;5814.5057670098095;5870.207521984531;5175.508326708957;5236.31927849379;5256.001359741656;5273.841784746463;5276.7097809620645;5271.472852714736;5274.314339135907;5284.180951952453;5302.734863256841;5318.9202161967405;5204.739763011834;5236.3978142513715;5271.235670827708;5317.3619165700175;5353.2237825515085;5265.394479634852;5268;5268.81559145428;5282.709450980195;5288.444713305124;5186;5218.243354713583;5226.320578324793;5236.266922630834;5243.816466423695;5766.509846663039;5784.1034639630925;5785.045467497858;5787.1608616750755;5812.331581868055;6177.3822617738315;6198.938010619881;6202.751889924398;6206.906896396557;6231.3145553989025;5105.846824595231;6161.969190154021;6176.752929882799;6186.9381306186815;6198.535109866778;6042;6057.454829065361;6099.451049405575;6100.23747031621;6102.7864024759365;6380.7447702091395;6405.327440618668;6425.485961123099;6428.582142160744;6431.871362572816;6100.908486372708;6110.01202914832;6174.876502469925;6248;6258;6201.56589038772;6228.532860035515;6233.1273621693;6235.532335074888;6287.779927702509;6177.876442471125;6188.721507532172;6194.566380353332;6200.441960223601;6228.34602366754;6263.937360626426;6316.30520642729;6328.493720502349;6328.6835658216905;6376.904346434807;4960.801567937242;5031.874203144877;5045.041442125985;5050.696958182521;5053.9241911371355;4442.489113751895;4457.3091170868565;4504.504504504502;4536.79584418702;4608.677392582487;5636.04187288162;5666.46168613981;5712.857178570486;5715.199872017921;5732;6278.4035516625845;6279.717412716439;6287.434130928238;6291.433770960635;6309.92731235691;5623.5220006299105;5737.454941780524;5743.59794814359;5757.8560535986935;5839.970800146057;5523.950449414599;5527.585431092684;5532.446755324436;5536.501714845684;5571.637843540157;6433.002884552901;6442.194725659293;6448.871022579522;6452.838679033061;6465.9331210349765;6194.5354098443695;6241.21984751906;6281.057841323838;6290.748370065146;6304.306526282014;6278.780242691484;6285.528585356025;6301.747930082745;6312.968435157794;6336.239651241881;6222.408871157233;6226.1905952225925;6229.626222426669;6236.126942228001;6308.400701933309;5290.470952904832;6267.62394256346;6282.905756413749;6296.653684047421;6304.621722696653;6210.844728881814;6217.100015951457;6225.159603453476;6228.968855155696;6234.251889773256;4754.477007529238;6024.608400453956;6080.2399700037495;6100.969495152496;6205.906911396242;4961.900761984668;5866.2373891395555;5965.91051134242;5976.850578735566;5979.641221526722;4975.850724478127;6101.084837274444;6109.677964500999;6130.846728831636;6136.631802091889;5958.910616340845;5968.403159683997;5985;5991.910121348271;5997 05:06:51 INFO - PROCESS | 1689 | |1;ext.html;771.1324759645399;790.6758229126058;848.6605357856856;872.7992561710806;873;26822.195334139957;27892.88428462859;38347.84956451304;38531.22937541254;40442;39240.41139382911;39319.41020884689;39397;39499.60500394995;39567.40648890269;8872.600732967;9035.27717782579;9052;9054.637814487445;9061.864072038925;7161.176464706547;7370.189279179286;7400.481966262364;7416.221296763843;7418.554886706788;10614.991575800286;10874.891251087467;10878.966498182699;10881.347119172875;10882.020618144365;10708.30396024256;10766.407847568342;10781.5687372505;10783.029527342576;10814.188935829765;7068.823279418004;10543.31468454548;10585.311954722996;10588.470576471223;10591.311564748266;26917.730822691916;37045.62954370449;37554.62445375539;38733.61266387328;38795;3745.978320051472;3758.0980564664555;3786.091338078869;3803.619638036202;3889.397143442771;26823.744892220217;27194.728052719416;27807.165785026482;27845.58231626527;27922.3019424514;3051.5422686596967;3170.619525656913;3240.7569432292435;3268.2319654881085;3290.572225610679;351279;351356;351958;351998;352494;40422.79788601038;48874;49059.26411103836;49262;49483;44292.11415771666;44407.11185776266;51325.23012154821;52166.21750673743;54783.726081369336;14405;14623.488177913721;14640.560783176521;14698.26508674562;14700.926495367668;11939.223950443367;11948.880511194951;11949.820752688716;11958.760824783456;11978.520859165536;12722.427490762939;12726.80909786354;12737.745245095231;12782.977361811032;12851.614451566467;5197.194434862602;5224.320838290998;5227.921581176285;5233.869153271123;5243.5542978847225;1058.222206678091;1067.8451624514557;1075.9025793690548;1090.220492347975;1136.1478890831877;24693;24715.87642061778;26089.81609275594;26677.733222667914;27727.861360693067;982.6953644370268;1127.7800828838297;1152.0438036429744;1164.574930150489;1181.373871847922;12170.81743773844;13230.338483075808;13658;14057.297135143406;14058.929705351407;422182;422258;423141;423466;423638.7636123661;52617;52773.73613131986;52858.73570632199;52945.7352713234;53022.93954120973;1393.108410617206;1443.1052747296744;1444.2562080528746;1446.320229492137;1450.0357262420582;23875.522489550458;24670;25029.998800047793;26077.608835867857;26201.082962096236;43876.780616096716;43916.78041609772;43946.34080488731;43972;44012.559874400846;389221;389316;389651;390679;390744;26426.603600946386;26728.46543069089;26991.730082698923;30027;31738.04785856428;42031.57968420276;42077.579224207366;42139.31442742256;42269;43804.78097609492;29106.56340154857;30800.49163428827;33615.66384336223;34484.65515344815;36167.638323616426;34635;34883.9534813956;35011.82494087513;36140;36252.73115440947;35565.82217088898;36348;36419.817900910326;36444.63555364519;36448;26670.59994100129;31422.22933248025;31512;31686.049418517483;31716.04851854448;19169.424917252505;23069.65395519035;23954.40113997094;24076.39809004789;24182.75817241805 05:06:51 INFO - PROCESS | 1689 | |2;jquery.html;377.609174504388;381.96944244460445;413.3943772373473;422.54998426675587;428.8713385984206;12803.399575053118;18466.261349546017;21334.46663833405;21912;22159.667604985938;21972.89013554934;22700.432489187777;23103.653445198335;23374.065037398526;23409.18067867625;5485.725713714318;6673.4661227101715;6702.564333318343;6911.654417279141;6980.965095174517;6897.310268973113;6918.75784347548;6968.44252459802;6984.266652001543;6994.510384273103;5642.830715078554;6613.537052406334;6912.066870972405;6944.861102777942;6945.861082778341;6647.401733843977;6858.348456896637;6956.304369563054;7015.543989640657;7061.258567850405;6749.460043196533;6765.594064356154;6776.085228494188;6776.136562445367;6796.320367963164;28029;28415;28473.430531389255;28487.72098232157;28725;3352.5641666583188;3379.4423920053164;3384.1032126486502;3436;3478.5999610044914;16229.756553651705;17198.1400929953;17502.29990800379;17587;18233.361832335806;2031.25859061443;2035.460602940222;2060.64968955278;2104.8947552622462;2221.622324204889;159783;159876;167537.1623141901;168584;173373.13313433478;17419.82580174182;23519.294421167393;23911.641325380133;24126.87936560306;24306.149284774947;42162.36756448656;42653;42826.286948522335;42985;43008.784956075644;11159.888401116048;11164.944175279072;11319.207655464039;11325.830112548318;11462.083033357312;8902.554872256362;8911.06433824439;8934.642614295486;9112;9126.170887025044;11341.886581134084;11431.885681143249;11443.313401195956;11573.826392604118;11585.6524304271;4296.312589985588;4443.178012067778;4466.240739074366;4481.932771008437;4482.372467854503;787.0909099989522;867.3624885708999;870.1516021878745;927.3879239701764;933.7898972731217;18785.812141878407;23173.304800856;23517.88241058818;23700.64449033266;23703.525929481315;924.496149598457;930.5254320296698;941.491594538955;944.15026476172;953.955418816395;9473.336866419422;11903.761924761457;12113.68271001216;12128.878711212776;12164.81752773709;393523;398045;401359;515926;670965.6451717711;140552;145643;148568.2571587135;148754;153547;1234.3766397969148;1254.8933340665963;1285.2738202915323;1286.2539726958341;1286.9742605147844;15354.769678454608;18443.985580792647;20000.19999200074;20189.394318170478;20227;43570;60682;60787.78424431398;61028.694856525435;61396;79943.60028199822;83678.58160709158;85650.14349856671;88186;89221;9371;12124.939375303067;12424.378781061092;12742.299173545543;12755.170913890568;13716.245606491739;13866.306684665928;13883.791743124064;14286.714265714836;14332.140071595737;11579.652610421701;11586;11773.234739741889;11959.342236176746;12005.75988480243;9339.766505837408;11658.533658653898;11754.70613234676;11793.587224447103;12043.819342710041;11912.821307680566;11931.387085736224;12170.452329645364;12207.267563946192;12253.448594813077;12285.754284914074;12300.938495307466;12416.192947458387;12579.685507862378;12645.051621128636;9849.310548261554;11278.943605281922;11740.941295293469;12005.579804706793;12154.513819447124 05:06:51 INFO - PROCESS | 1689 | |3;mootools.html;1551.5345396381083;1571.387159007987;1597.377022961045;1600.8399160083993;1608.5254849819303;10420.374777513345;11023.06303964164;11029.724256893582;11032.22774405792;11032.779344413108;8168.387370947173;10843.403612801292;11009.724756881082;11021.504032318544;11041.668749937495;2237.9888100559515;2279.509905370345;2281.315605318406;2283.315005498352;2284.3946354216146;2223.5997520446313;2248.9887550562225;2249.662550617404;2256.6727824465443;2257.841951063426;2219.5449932763745;2230.230570453191;2239.958419335009;2244.5847518209102;2246.1913711064003;2192.75879653238;2206.4263291544235;2216.0803266644325;2216.390492614528;2218.0462401167492;1802.5854053567753;2207.095091012677;2305.296884450242;2307.238611258281;2311.191083120911;10840.945795270973;10948.616798412097;10956.616518421817;10960.945195274053;10993.395363255018;5508.091164957777;5691.829245122612;5697.572682048822;5699.202111704323;5701.458361455655;3291.670832916713;3363.923544465772;3585.0678823505814;3585.175409655794;3589.0489020409614;1209.7338585511172;1252.642996745923;1775.8046614872353;1800.3788692900928;1908.475169328432;14633.634159146;14662.633434164125;14723.411063557338;14815;14910.62723431912;4293.334533147367;4329.307310830252;4449.243628583149;4453.283497066786;4458.331250312414;11553.36456494884;11559.595414160463;11561.190716649753;11573.363465009505;11575.76848463026;5446.101393270145;5447.536959358499;5455.5908306877145;5458.426865179178;5465.754041068161;4855.490173531799;5055.191169412877;5063.544281014726;5076.543111120017;5148.897022059537;3671.173985853215;3732.8880133596035;3749.343864823645;3790.5640851302455;3804.9809750951067;997.1125698128672;1006.8439391894268;1014.2899970021015;1018.1701912940929;1021.9846702299471;908.5366463103865;926.2080920812608;931.9254459643212;948.2035090523993;972.9659461918799;5998.310194327621;6390.808275751735;6554.70503827329;6603.20761508622;6629.834254143685;952.9891928031848;955.47926380123;1003.9949800250952;1009.3086235928266;1020.8009438159488;3639.66970222249;4025.577314382006;4163.75017498951;4308.913821723548;4538.546145385435;10339.586416543254;12982.896453801533;13763.793543096861;13773.931130344285;13822.516211932534;11864.881351186377;12579.559715409916;13074.542391016268;13564.982626303066;13711.451541938211;6876.793696189123;8615.526146061902;8897.911020889838;9740.610375585038;9830.901690982999;6576.76981305652;6610.537262391779;6849.760258390932;6851.48613853953;6857.177138743383;11727.706807329885;11738.41307934617;12061.939690301493;12063.095267855122;12093.395330233629;11685.941570292094;12056.75886482283;12136.33250171249;12365.258084514959;12405.937970310091;8785.780355491164;9068.818623627358;9071.59177837012;9072.727818165466;9080.59137338808;9621.807563848824;9739.172170365599;9869.161121304769;9872.210223181984;9894.208463322773;8530.061693213866;8687.131286871263;8737.082606326498;8840.160184782435;8883.244924181517;8448.408611397143;8449.577521124042;8492.70275540353;8602.612882420432;8750.037495875322;7440.851182976202;7584.924150758422;7689.6539655714505;7691.692332306869;7696;4762.476127626028;5560.277163968658;5580.888382232414;5706.9714651426475;5935.228420305332;5693.572982026448;5761.934042202206;5878.29460464747;6051;6063.636181829104 05:06:51 INFO - PROCESS | 1689 | |4;prototype.html;334.28296304427005;377.7752237418737;384.63267579461615;388.4251308064067;388.42707007164427;4337.783110844457;4817.831375901844;4943.431505376878;5051.267566202899;5065.442801291855;4326.3510473429005;4404.405405270288;4529.886752831181;4929.718273248955;4970.130227210242;3274.5743053403085;4063.3701776224734;4103.220388126247;4110.856120035799;4152.401325489693;4088.1823635272917;4090.1206240658253;4114.753114813106;4125.0093682080405;4146.813393397304;3537.6462353764546;4100.979495102521;4139.503259608851;4142.233686767942;4152.252594532983;3401.642827503101;3718.5869369639363;4058.634722874926;4120.75275483472;4149.481314835645;3230.9838450807597;3440.53777144715;3709.27669104522;3764.416515440084;3788.412796016622;4114.979425102885;4285.57144285572;4331.3540854475095;4816.325714399987;4832.9275060874115;4350.6736994725525;4439.866803995886;4579.641819071694;4743;4789.227985645299;4300.806463709109;5190.92213616796;5204.438668399503;5205.427402985669;5235.685858848443;3665.596784353719;3753.6621704046493;3771.113788259784;4186.66506679468;4250.426192464009;4866.330724705714;5200.609954253446;5311.937612477482;5369.5972802040005;5453.646007705312;3551.662592053751;3886.4753258309765;4116.794160291974;4302.483701955723;4307.375430562551;4114.305130139764;4389.934150987738;4400.691951563424;4428.446444194476;4452.9554704453185;4053.6554392876346;4139.785214910069;4437.534058923831;4490.438695163105;4781.641376896747;5045.7981680732355;5200.952576955873;5239;5316.787328506894;5390.8921821563345;1331.9200847949155;1433.7956116861885;1470.7278204353372;1485.2202593638426;1488.2112480385413;1060.5174645536263;1108.695108845074;1118.2507719827736;1139.6467095200514;1148.7702459508132;4183.6653067754505;4249.936250956176;4397.2964325707735;4441.844535441309;4535.0137818080475;5016.849494515171;5456.699881506555;5487.5609951203805;5502.504774570308;5506;4420.695894711068;4486.6220902921505;4675.742834144155;4691.319758634979;4910.926336104962;2490.9537994042184;2733.5352989991748;2760.5997130415976;2785.5543113102212;2825.5479123340165;5139.049275883899;5288.2596436498925;5654.4062873398525;5693.68684722336;5719.599628025998;4745.596624286905;5254.2957215163215;5424.755885985141;5610.691411972299;5642.379338272786;4892.8532144035735;5103.821366252163;5271.525562699376;5431.805002899356;5552.833414997556;5419.83740487786;5433.7554810034435;5443.59173062014;5478.534993979893;5481.342238931354;4826.58973987201;5107.821226257063;5400.378956419905;5401.297831281908;5424.457554244544;4686.64850136248;4957.206846904478;4986.9251961221335;5314.973425133005;5666.291713535808;3644.2347107107803;3737.5888652247686;4233.97883010583;4263.637590804817;4309.892252693708;5015;5114.2840002400435;5486.643368181056;5501.559875210054;5527.484994327651;4267.1465706858135;4595.6783025187915;4806.639502037431;4834.250691142878;5102.4897510248675;4688.413948256468;5156.020356132323;5248.763805628832;5269.394019687785;5275.630705850554;4753.857384278477;4759.904801903874;4809.182438985451;4828.5412885775795;5041.915988062584;4343.652507799306;4592.425946756655;4953.628477864247;4983.476734942924;5305.787768489217;4755.334253204485;5096.337476128079;5133.922991155061;5139.331886854835;5139.768710408115 05:06:51 INFO - PROCESS | 1689 | |5;yui.html;728.0789800901857;748.8502299540091;754.7094368668061;780.796992781877;839.5004972041635;14934.616321316924;15822;15832;15839.208039598032;15845.366185352586;14341.354639041243;14355;14460.566183014527;14473.34869930853;14528.782068268958;922.0134456131941;948.1987720376271;948.7865230323157;950.1686024728363;952.4190243951184;962.6245764151986;991.3110388280148;1002.6089824968268;1010.9292349535499;1015.4567306491028;981.1316984468725;1028.8250997330472;1038.678009816959;1041.2659075351896;1048.1928914735688;1003.9498025098716;1005.4922264256577;1006.8741407324085;1006.9295149339549;1010.0808264479361;765.8047197964539;766.3218052023943;767.4205974489225;768.7309441695418;771.3482107619109;15914.76127858083;16101;16168.029918204827;16181.19094045293;16265.91867040669;14624.122552646875;14820.184889831055;14874.479393221185;14915.030523016077;14920.477783277533;11663.766724665544;11732.923960285458;11828.526858925632;11904.345261010641;12201.742677604672;3591.4612808078737;3603.7733977442917;3666.3400587894166;3758.2483503299177;3866.4973553438153;89416.55291723499;91097;104501.95498044998;108773;111440.88559114386;10018.448985305733;10831.241813073168;11459.083273338112;11532.004093026826;11619.128565357632;18426.907865460587;24757.62863557048;25233.11684091048;25288.747112529007;25339.61990570143;6336.461400780985;7820.765377038698;7951.642176102089;8015.879761803578;8074.798130046795;4072.572379900127;4226.894327641833;4291.74249545022;4359.825606975749;4375.124975005012;3542.8582856685443;3642.2715456908722;3643.508126402902;3645.453182022718;3661.1213308806227;633.5375176121457;651.1697585578426;656.2617055812211;671.5232185148599;672.9192496900404;652.8335274504971;667.7395815631908;688.4079691465336;697.5605368617738;707.4305184326666;9168.724938251864;9571;10145.64490242838;10171.520938725353;10186.236032297607;633.5375176121457;669.6149713914518;686.2725510958301;694.9013977787055;708.2032713197652;4550.408446901882;4571.1543364477675;4792.592629626451;4837.975810120927;4867.294242334912;97324.51337743408;99857.50071249597;100770.40369953756;100837;102746.48626756818;53266.73366633142;59916.101258481154;83163.5841820787;84415.57792211;85994.14005859986;56784.901887264095;57703.422965770646;65666.67166664136;71379.64310178415;73188;10028.899711002796;10444.321119127537;10795.676129716121;10821.242513024328;10913.727156820825;44770.74857811172;45315;45374.546254538356;45671.771641142914;46478.76760616311;47114.528854712386;60929.08606370819;61022;61135.69432152989;61221.69389153026;13102.213867168;13163.275915849168;13177.604671859859;13191.67020824487;13599.59201223965;14159.433622654979;14214.644633884236;14497.130172189702;14515.782263265848;15153.090814551162;12903.48322227999;13170.341482926007;13395.263260520765;13396.866031339561;13649.658758531115;13266.336683165997;13457.259850707913;13516.053876228569;13615.52345667897;13928;13115.274218095454;13141.868581314448;13241.139325943783;13604.86395136036;13669.453221871014;10667.359958402521;10852.952297558362;10895.182861285277;11037.503312350804;11817.995470384769;8052.2587722565195;9495.382800118246;10430.737576597909;10945.288556243819;11291 05:06:51 INFO - PROCESS | 1689 | __end_tp_report 05:06:51 INFO - PROCESS | 1689 | __start_cc_report 05:06:51 INFO - PROCESS | 1689 | _x_x_mozilla_cycle_collect,3563 05:06:51 INFO - PROCESS | 1689 | __end_cc_report 05:06:51 INFO - PROCESS | 1689 | __startTimestamp1489237611100__endTimestamp 05:06:51 INFO - PROCESS | 1689 | 05:06:51 INFO - PROCESS | 1689 | ------- Summary: start ------- 05:06:51 INFO - PROCESS | 1689 | Number of tests: 6 05:06:51 INFO - PROCESS | 1689 | 05:06:51 INFO - PROCESS | 1689 | [#0] dojo.html Cycles:165 Average:5767.43 Median:5991.91 stddev:647.64 (10.8%) stddev-sans-first:621.85 05:06:51 INFO - PROCESS | 1689 | Values: 3375.8 3390.0 3394.1 3398.2 3441.3 5002.3 5587.7 5848.6 5931.3 5957.3 5598.3 5690.1 5730.4 5814.5 5870.2 5175.5 5236.3 5256.0 5273.8 5276.7 5271.5 5274.3 5284.2 5302.7 5318.9 5204.7 5236.4 5271.2 5317.4 5353.2 5265.4 5268.0 5268.8 5282.7 5288.4 5186.0 5218.2 5226.3 5236.3 5243.8 5766.5 5784.1 5785.0 5787.2 5812.3 6177.4 6198.9 6202.8 6206.9 6231.3 5105.8 6162.0 6176.8 6186.9 6198.5 6042.0 6057.5 6099.5 6100.2 6102.8 6380.7 6405.3 6425.5 6428.6 6431.9 6100.9 6110.0 6174.9 6248.0 6258.0 6201.6 6228.5 6233.1 6235.5 6287.8 6177.9 6188.7 6194.6 6200.4 6228.3 6263.9 6316.3 6328.5 6328.7 6376.9 4960.8 5031.9 5045.0 5050.7 5053.9 4442.5 4457.3 4504.5 4536.8 4608.7 5636.0 5666.5 5712.9 5715.2 5732.0 6278.4 6279.7 6287.4 6291.4 6309.9 5623.5 5737.5 5743.6 5757.9 5840.0 5524.0 5527.6 5532.4 5536.5 5571.6 6433.0 6442.2 6448.9 6452.8 6465.9 6194.5 6241.2 6281.1 6290.7 6304.3 6278.8 6285.5 6301.7 6313.0 6336.2 6222.4 6226.2 6229.6 6236.1 6308.4 5290.5 6267.6 6282.9 6296.7 6304.6 6210.8 6217.1 6225.2 6229.0 6234.3 4754.5 6024.6 6080.2 6101.0 6205.9 4961.9 5866.2 5965.9 5976.9 5979.6 4975.9 6101.1 6109.7 6130.8 6136.6 5958.9 5968.4 5985.0 5991.9 5997.0 05:06:51 INFO - PROCESS | 1689 | 05:06:51 INFO - PROCESS | 1689 | [#1] ext.html Cycles:180 Average:52574.58 Median:34759.48 stddev:102989.72 (296.3%) stddev-sans-first:103205.19 05:06:51 INFO - PROCESS | 1689 | Values: 771.1 790.7 848.7 872.8 873.0 26822.2 27892.9 38347.8 38531.2 40442.0 39240.4 39319.4 39397.0 39499.6 39567.4 8872.6 9035.3 9052.0 9054.6 9061.9 7161.2 7370.2 7400.5 7416.2 7418.6 10615.0 10874.9 10879.0 10881.3 10882.0 10708.3 10766.4 10781.6 10783.0 10814.2 7068.8 10543.3 10585.3 10588.5 10591.3 26917.7 37045.6 37554.6 38733.6 38795.0 3746.0 3758.1 3786.1 3803.6 3889.4 26823.7 27194.7 27807.2 27845.6 27922.3 3051.5 3170.6 3240.8 3268.2 3290.6 351279.0 351356.0 351958.0 351998.0 352494.0 40422.8 48874.0 49059.3 49262.0 49483.0 44292.1 44407.1 51325.2 52166.2 54783.7 14405.0 14623.5 14640.6 14698.3 14700.9 11939.2 11948.9 11949.8 11958.8 11978.5 12722.4 12726.8 12737.7 12783.0 12851.6 5197.2 5224.3 5227.9 5233.9 5243.6 1058.2 1067.8 1075.9 1090.2 1136.1 24693.0 24715.9 26089.8 26677.7 27727.9 982.7 1127.8 1152.0 1164.6 1181.4 12170.8 13230.3 13658.0 14057.3 14058.9 422182.0 422258.0 423141.0 423466.0 423638.8 52617.0 52773.7 52858.7 52945.7 53022.9 1393.1 1443.1 1444.3 1446.3 1450.0 23875.5 24670.0 25030.0 26077.6 26201.1 43876.8 43916.8 43946.3 43972.0 44012.6 389221.0 389316.0 389651.0 390679.0 390744.0 26426.6 26728.5 26991.7 30027.0 31738.0 42031.6 42077.6 42139.3 42269.0 43804.8 29106.6 30800.5 33615.7 34484.7 36167.6 34635.0 34884.0 35011.8 36140.0 36252.7 35565.8 36348.0 36419.8 36444.6 36448.0 26670.6 31422.2 31512.0 31686.0 31716.0 19169.4 23069.7 23954.4 24076.4 24182.8 05:06:51 INFO - PROCESS | 1689 | 05:06:51 INFO - PROCESS | 1689 | [#2] jquery.html Cycles:180 Average:36176.16 Median:23609.97 stddev:84889.63 (359.5%) stddev-sans-first:85085.22 05:06:51 INFO - PROCESS | 1689 | Values: 377.6 382.0 413.4 422.5 428.9 12803.4 18466.3 21334.5 21912.0 22159.7 21972.9 22700.4 23103.7 23374.1 23409.2 5485.7 6673.5 6702.6 6911.7 6981.0 6897.3 6918.8 6968.4 6984.3 6994.5 5642.8 6613.5 6912.1 6944.9 6945.9 6647.4 6858.3 6956.3 7015.5 7061.3 6749.5 6765.6 6776.1 6776.1 6796.3 28029.0 28415.0 28473.4 28487.7 28725.0 3352.6 3379.4 3384.1 3436.0 3478.6 16229.8 17198.1 17502.3 17587.0 18233.4 2031.3 2035.5 2060.6 2104.9 2221.6 159783.0 159876.0 167537.2 168584.0 173373.1 17419.8 23519.3 23911.6 24126.9 24306.1 42162.4 42653.0 42826.3 42985.0 43008.8 11159.9 11164.9 11319.2 11325.8 11462.1 8902.6 8911.1 8934.6 9112.0 9126.2 11341.9 11431.9 11443.3 11573.8 11585.7 4296.3 4443.2 4466.2 4481.9 4482.4 787.1 867.4 870.2 927.4 933.8 18785.8 23173.3 23517.9 23700.6 23703.5 924.5 930.5 941.5 944.2 954.0 9473.3 11903.8 12113.7 12128.9 12164.8 393523.0 398045.0 401359.0 515926.0 670965.6 140552.0 145643.0 148568.3 148754.0 153547.0 1234.4 1254.9 1285.3 1286.3 1287.0 15354.8 18444.0 20000.2 20189.4 20227.0 43570.0 60682.0 60787.8 61028.7 61396.0 79943.6 83678.6 85650.1 88186.0 89221.0 9371.0 12124.9 12424.4 12742.3 12755.2 13716.2 13866.3 13883.8 14286.7 14332.1 11579.7 11586.0 11773.2 11959.3 12005.8 9339.8 11658.5 11754.7 11793.6 12043.8 11912.8 11931.4 12170.5 12207.3 12253.4 12285.8 12300.9 12416.2 12579.7 12645.1 9849.3 11278.9 11740.9 12005.6 12154.5 05:06:51 INFO - PROCESS | 1689 | 05:06:51 INFO - PROCESS | 1689 | [#3] mootools.html Cycles:180 Average:6522.84 Median:3614.36 stddev:4072.49 (112.7%) stddev-sans-first:4066.79 05:06:51 INFO - PROCESS | 1689 | Values: 1551.5 1571.4 1597.4 1600.8 1608.5 10420.4 11023.1 11029.7 11032.2 11032.8 8168.4 10843.4 11009.7 11021.5 11041.7 2238.0 2279.5 2281.3 2283.3 2284.4 2223.6 2249.0 2249.7 2256.7 2257.8 2219.5 2230.2 2240.0 2244.6 2246.2 2192.8 2206.4 2216.1 2216.4 2218.0 1802.6 2207.1 2305.3 2307.2 2311.2 10840.9 10948.6 10956.6 10960.9 10993.4 5508.1 5691.8 5697.6 5699.2 5701.5 3291.7 3363.9 3585.1 3585.2 3589.0 1209.7 1252.6 1775.8 1800.4 1908.5 14633.6 14662.6 14723.4 14815.0 14910.6 4293.3 4329.3 4449.2 4453.3 4458.3 11553.4 11559.6 11561.2 11573.4 11575.8 5446.1 5447.5 5455.6 5458.4 5465.8 4855.5 5055.2 5063.5 5076.5 5148.9 3671.2 3732.9 3749.3 3790.6 3805.0 997.1 1006.8 1014.3 1018.2 1022.0 908.5 926.2 931.9 948.2 973.0 5998.3 6390.8 6554.7 6603.2 6629.8 953.0 955.5 1004.0 1009.3 1020.8 3639.7 4025.6 4163.8 4308.9 4538.5 10339.6 12982.9 13763.8 13773.9 13822.5 11864.9 12579.6 13074.5 13565.0 13711.5 6876.8 8615.5 8897.9 9740.6 9830.9 6576.8 6610.5 6849.8 6851.5 6857.2 11727.7 11738.4 12061.9 12063.1 12093.4 11685.9 12056.8 12136.3 12365.3 12405.9 8785.8 9068.8 9071.6 9072.7 9080.6 9621.8 9739.2 9869.2 9872.2 9894.2 8530.1 8687.1 8737.1 8840.2 8883.2 8448.4 8449.6 8492.7 8602.6 8750.0 7440.9 7584.9 7689.7 7691.7 7696.0 4762.5 5560.3 5580.9 5707.0 5935.2 5693.6 5761.9 5878.3 6051.0 6063.6 05:06:51 INFO - PROCESS | 1689 | 05:06:51 INFO - PROCESS | 1689 | [#4] prototype.html Cycles:180 Average:4337.71 Median:4635.71 stddev:1213.44 (26.2%) stddev-sans-first:1179.05 05:06:51 INFO - PROCESS | 1689 | Values: 334.3 377.8 384.6 388.4 388.4 4337.8 4817.8 4943.4 5051.3 5065.4 4326.4 4404.4 4529.9 4929.7 4970.1 3274.6 4063.4 4103.2 4110.9 4152.4 4088.2 4090.1 4114.8 4125.0 4146.8 3537.6 4101.0 4139.5 4142.2 4152.3 3401.6 3718.6 4058.6 4120.8 4149.5 3231.0 3440.5 3709.3 3764.4 3788.4 4115.0 4285.6 4331.4 4816.3 4832.9 4350.7 4439.9 4579.6 4743.0 4789.2 4300.8 5190.9 5204.4 5205.4 5235.7 3665.6 3753.7 3771.1 4186.7 4250.4 4866.3 5200.6 5311.9 5369.6 5453.6 3551.7 3886.5 4116.8 4302.5 4307.4 4114.3 4389.9 4400.7 4428.4 4453.0 4053.7 4139.8 4437.5 4490.4 4781.6 5045.8 5201.0 5239.0 5316.8 5390.9 1331.9 1433.8 1470.7 1485.2 1488.2 1060.5 1108.7 1118.3 1139.6 1148.8 4183.7 4249.9 4397.3 4441.8 4535.0 5016.8 5456.7 5487.6 5502.5 5506.0 4420.7 4486.6 4675.7 4691.3 4910.9 2491.0 2733.5 2760.6 2785.6 2825.5 5139.0 5288.3 5654.4 5693.7 5719.6 4745.6 5254.3 5424.8 5610.7 5642.4 4892.9 5103.8 5271.5 5431.8 5552.8 5419.8 5433.8 5443.6 5478.5 5481.3 4826.6 5107.8 5400.4 5401.3 5424.5 4686.6 4957.2 4986.9 5315.0 5666.3 3644.2 3737.6 4234.0 4263.6 4309.9 5015.0 5114.3 5486.6 5501.6 5527.5 4267.1 4595.7 4806.6 4834.3 5102.5 4688.4 5156.0 5248.8 5269.4 5275.6 4753.9 4759.9 4809.2 4828.5 5041.9 4343.7 4592.4 4953.6 4983.5 5305.8 4755.3 5096.3 5133.9 5139.3 5139.8 05:06:51 INFO - PROCESS | 1689 | 05:06:51 INFO - PROCESS | 1689 | [#5] yui.html Cycles:180 Average:19229.65 Median:24995.37 stddev:26765.68 (107.1%) stddev-sans-first:26804.71 05:06:51 INFO - PROCESS | 1689 | Values: 728.1 748.9 754.7 780.8 839.5 14934.6 15822.0 15832.0 15839.2 15845.4 14341.4 14355.0 14460.6 14473.3 14528.8 922.0 948.2 948.8 950.2 952.4 962.6 991.3 1002.6 1010.9 1015.5 981.1 1028.8 1038.7 1041.3 1048.2 1003.9 1005.5 1006.9 1006.9 1010.1 765.8 766.3 767.4 768.7 771.3 15914.8 16101.0 16168.0 16181.2 16265.9 14624.1 14820.2 14874.5 14915.0 14920.5 11663.8 11732.9 11828.5 11904.3 12201.7 3591.5 3603.8 3666.3 3758.2 3866.5 89416.6 91097.0 104502.0 108773.0 111440.9 10018.4 10831.2 11459.1 11532.0 11619.1 18426.9 24757.6 25233.1 25288.7 25339.6 6336.5 7820.8 7951.6 8015.9 8074.8 4072.6 4226.9 4291.7 4359.8 4375.1 3542.9 3642.3 3643.5 3645.5 3661.1 633.5 651.2 656.3 671.5 672.9 652.8 667.7 688.4 697.6 707.4 9168.7 9571.0 10145.6 10171.5 10186.2 633.5 669.6 686.3 694.9 708.2 4550.4 4571.2 4792.6 4838.0 4867.3 97324.5 99857.5 100770.4 100837.0 102746.5 53266.7 59916.1 83163.6 84415.6 85994.1 56784.9 57703.4 65666.7 71379.6 73188.0 10028.9 10444.3 10795.7 10821.2 10913.7 44770.7 45315.0 45374.5 45671.8 46478.8 47114.5 60929.1 61022.0 61135.7 61221.7 13102.2 13163.3 13177.6 13191.7 13599.6 14159.4 14214.6 14497.1 14515.8 15153.1 12903.5 13170.3 13395.3 13396.9 13649.7 13266.3 13457.3 13516.1 13615.5 13928.0 13115.3 13141.9 13241.1 13604.9 13669.5 10667.4 10853.0 10895.2 11037.5 11818.0 8052.3 9495.4 10430.7 10945.3 11291.0 05:06:51 INFO - PROCESS | 1689 | -------- Summary: end -------- 05:06:51 INFO - PROCESS | 1689 | 05:06:51 INFO - TEST-INFO | 1689: exit 0 05:06:51 INFO - TEST-OK | dromaeo_css | took 1121528ms 05:06:51 INFO - TEST-START | kraken 05:06:51 INFO - operating with platform_type : mac_ 05:06:51 INFO - Initialising browser for kraken test... 05:06:51 INFO - TEST-INFO | started process 1759 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/tmpIxPpeB/profile http://localhost:49242/getInfo.html) 05:06:54 INFO - PROCESS | 1759 | __metrics Screen width/height:1600/1200 05:06:54 INFO - PROCESS | 1759 | colorDepth:24 05:06:54 INFO - PROCESS | 1759 | Browser inner width/height: 1024/689 05:06:54 INFO - PROCESS | 1759 | __metrics 05:06:54 INFO - PROCESS | 1759 | 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" 05:06:54 INFO - PROCESS | 1759 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:06:55 INFO - TEST-INFO | 1759: exit 0 05:06:55 INFO - Browser initialized. 05:06:55 INFO - Running cycle 1/1 for kraken test... 05:06:55 INFO - TEST-INFO | started process 1761 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/T/tmpIxPpeB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:07:07 INFO - PROCESS | 1761 | RSS: Main: 233185280 05:07:07 INFO - PROCESS | 1761 | 05:07:10 INFO - PROCESS | 1761 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 05:07:11 INFO - PROCESS | 1761 | RSS: Main: 284508160 05:07:11 INFO - PROCESS | 1761 | 05:07:13 INFO - PROCESS | 1761 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 05:07:14 INFO - PROCESS | 1761 | RSS: Main: 286269440 05:07:14 INFO - PROCESS | 1761 | 05:07:17 INFO - PROCESS | 1761 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 05:07:18 INFO - PROCESS | 1761 | RSS: Main: 377184256 05:07:18 INFO - PROCESS | 1761 | 05:07:20 INFO - PROCESS | 1761 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 05:07:20 INFO - PROCESS | 1761 | RSS: Main: 282103808 05:07:20 INFO - PROCESS | 1761 | 05:07:22 INFO - PROCESS | 1761 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:07:23 INFO - PROCESS | 1761 | RSS: Main: 283746304 05:07:23 INFO - PROCESS | 1761 | 05:07:26 INFO - PROCESS | 1761 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 05:07:27 INFO - PROCESS | 1761 | RSS: Main: 327303168 05:07:27 INFO - PROCESS | 1761 | 05:07:30 INFO - PROCESS | 1761 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 05:07:30 INFO - PROCESS | 1761 | RSS: Main: 330715136 05:07:30 INFO - PROCESS | 1761 | 05:07:33 INFO - PROCESS | 1761 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 05:07:34 INFO - PROCESS | 1761 | RSS: Main: 327544832 05:07:34 INFO - PROCESS | 1761 | 05:07:35 INFO - PROCESS | 1761 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:07:36 INFO - PROCESS | 1761 | RSS: Main: 304119808 05:07:36 INFO - PROCESS | 1761 | 05:07:38 INFO - PROCESS | 1761 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:07:39 INFO - PROCESS | 1761 | RSS: Main: 307638272 05:07:39 INFO - PROCESS | 1761 | 05:07:41 INFO - PROCESS | 1761 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:07:41 INFO - PROCESS | 1761 | RSS: Main: 308965376 05:07:41 INFO - PROCESS | 1761 | 05:07:44 INFO - PROCESS | 1761 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:07:45 INFO - PROCESS | 1761 | RSS: Main: 325533696 05:07:45 INFO - PROCESS | 1761 | 05:07:48 INFO - PROCESS | 1761 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:07:49 INFO - PROCESS | 1761 | RSS: Main: 319864832 05:07:49 INFO - PROCESS | 1761 | 05:07:51 INFO - PROCESS | 1761 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 05:07:51 INFO - PROCESS | 1761 | RSS: Main: 364883968 05:07:51 INFO - PROCESS | 1761 | 05:07:51 INFO - PROCESS | 1761 | __start_tp_report 05:07:51 INFO - PROCESS | 1761 | _x_x_mozilla_page_load 05:07:51 INFO - PROCESS | 1761 | _x_x_mozilla_page_load_details 05:07:51 INFO - PROCESS | 1761 | |i|pagename|runs| 05:07:51 INFO - PROCESS | 1761 | |0;ai-astar;117;167;175;118;115;115;111;115;115;115 05:07:51 INFO - PROCESS | 1761 | |1;audio-beat-detection;141;114;111;152;113;112;110;109;131;111 05:07:51 INFO - PROCESS | 1761 | |2;audio-dft;187;185;185;188;187;183;182;187;184;186 05:07:51 INFO - PROCESS | 1761 | |3;audio-fft;80;60;60;90;61;61;62;61;76;59 05:07:51 INFO - PROCESS | 1761 | |4;audio-oscillator;87;70;91;70;70;66;84;69;68;84 05:07:51 INFO - PROCESS | 1761 | |5;imaging-gaussian-blur;87;86;86;86;87;86;86;86;86;86 05:07:51 INFO - PROCESS | 1761 | |6;imaging-darkroom;94;94;93;95;93;94;94;94;94;94 05:07:51 INFO - PROCESS | 1761 | |7;imaging-desaturate;84;83;86;92;129;87;83;83;84;84 05:07:51 INFO - PROCESS | 1761 | |8;json-parse-financial;67;66;65;64;63;63;64;65;66;63 05:07:51 INFO - PROCESS | 1761 | |9;json-stringify-tinderbox;53;58;65;64;61;56;57;57;56;72 05:07:51 INFO - PROCESS | 1761 | |10;stanford-crypto-aes;86;86;108;102;87;86;85;84;85;87 05:07:51 INFO - PROCESS | 1761 | |11;stanford-crypto-ccm;132;158;147;152;139;138;138;140;177;134 05:07:51 INFO - PROCESS | 1761 | |12;stanford-crypto-pbkdf2;169;171;230;199;171;173;167;173;172;168 05:07:51 INFO - PROCESS | 1761 | |13;stanford-crypto-sha256-iterative;67;67;68;65;66;64;67;65;65;65 05:07:51 INFO - PROCESS | 1761 | __end_tp_report 05:07:51 INFO - PROCESS | 1761 | __start_cc_report 05:07:51 INFO - PROCESS | 1761 | _x_x_mozilla_cycle_collect,2287 05:07:51 INFO - PROCESS | 1761 | __end_cc_report 05:07:51 INFO - PROCESS | 1761 | __startTimestamp1489237671316__endTimestamp 05:07:51 INFO - PROCESS | 1761 | 05:07:51 INFO - PROCESS | 1761 | ------- Summary: start ------- 05:07:51 INFO - PROCESS | 1761 | Number of tests: 14 05:07:51 INFO - PROCESS | 1761 | 05:07:51 INFO - PROCESS | 1761 | [#0] ai-astar Cycles:10 Average:126.30 Median:116.00 stddev:23.70 (20.4%) stddev-sans-first:24.90 05:07:51 INFO - PROCESS | 1761 | Values: 117.0 167.0 175.0 118.0 115.0 115.0 111.0 115.0 115.0 115.0 05:07:51 INFO - PROCESS | 1761 | 05:07:51 INFO - PROCESS | 1761 | [#1] audio-beat-detection Cycles:10 Average:120.40 Median:113.50 stddev:15.33 (13.5%) stddev-sans-first:14.34 05:07:51 INFO - PROCESS | 1761 | Values: 141.0 114.0 111.0 152.0 113.0 112.0 110.0 109.0 131.0 111.0 05:07:51 INFO - PROCESS | 1761 | 05:07:51 INFO - PROCESS | 1761 | [#2] audio-dft Cycles:10 Average:185.40 Median:186.50 stddev:1.96 (1.0%) stddev-sans-first:1.99 05:07:51 INFO - PROCESS | 1761 | Values: 187.0 185.0 185.0 188.0 187.0 183.0 182.0 187.0 184.0 186.0 05:07:51 INFO - PROCESS | 1761 | 05:07:51 INFO - PROCESS | 1761 | [#3] audio-fft Cycles:10 Average:67.00 Median:61.50 stddev:10.92 (17.8%) stddev-sans-first:10.53 05:07:51 INFO - PROCESS | 1761 | Values: 80.0 60.0 60.0 90.0 61.0 61.0 62.0 61.0 76.0 59.0 05:07:51 INFO - PROCESS | 1761 | 05:07:51 INFO - PROCESS | 1761 | [#4] audio-oscillator Cycles:10 Average:75.90 Median:77.00 stddev:9.40 (12.2%) stddev-sans-first:9.07 05:07:51 INFO - PROCESS | 1761 | Values: 87.0 70.0 91.0 70.0 70.0 66.0 84.0 69.0 68.0 84.0 05:07:51 INFO - PROCESS | 1761 | 05:07:51 INFO - PROCESS | 1761 | [#5] imaging-gaussian-blur Cycles:10 Average:86.20 Median:86.00 stddev:0.42 (0.5%) stddev-sans-first:0.33 05:07:51 INFO - PROCESS | 1761 | Values: 87.0 86.0 86.0 86.0 87.0 86.0 86.0 86.0 86.0 86.0 05:07:51 INFO - PROCESS | 1761 | 05:07:51 INFO - PROCESS | 1761 | [#6] imaging-darkroom Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 05:07:51 INFO - PROCESS | 1761 | Values: 94.0 94.0 93.0 95.0 93.0 94.0 94.0 94.0 94.0 94.0 05:07:51 INFO - PROCESS | 1761 | 05:07:51 INFO - PROCESS | 1761 | [#7] imaging-desaturate Cycles:10 Average:89.50 Median:84.00 stddev:14.15 (16.8%) stddev-sans-first:14.87 05:07:51 INFO - PROCESS | 1761 | Values: 84.0 83.0 86.0 92.0 129.0 87.0 83.0 83.0 84.0 84.0 05:07:51 INFO - PROCESS | 1761 | 05:07:51 INFO - PROCESS | 1761 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:65.00 stddev:1.43 (2.2%) stddev-sans-first:1.22 05:07:51 INFO - PROCESS | 1761 | Values: 67.0 66.0 65.0 64.0 63.0 63.0 64.0 65.0 66.0 63.0 05:07:51 INFO - PROCESS | 1761 | 05:07:51 INFO - PROCESS | 1761 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:59.50 stddev:5.67 (9.5%) stddev-sans-first:5.43 05:07:51 INFO - PROCESS | 1761 | Values: 53.0 58.0 65.0 64.0 61.0 56.0 57.0 57.0 56.0 72.0 05:07:51 INFO - PROCESS | 1761 | 05:07:51 INFO - PROCESS | 1761 | [#10] stanford-crypto-aes Cycles:10 Average:89.60 Median:86.00 stddev:8.29 (9.6%) stddev-sans-first:8.69 05:07:51 INFO - PROCESS | 1761 | Values: 86.0 86.0 108.0 102.0 87.0 86.0 85.0 84.0 85.0 87.0 05:07:51 INFO - PROCESS | 1761 | 05:07:51 INFO - PROCESS | 1761 | [#11] stanford-crypto-ccm Cycles:10 Average:145.50 Median:143.50 stddev:13.71 (9.6%) stddev-sans-first:13.65 05:07:51 INFO - PROCESS | 1761 | Values: 132.0 158.0 147.0 152.0 139.0 138.0 138.0 140.0 177.0 134.0 05:07:51 INFO - PROCESS | 1761 | 05:07:51 INFO - PROCESS | 1761 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.30 Median:172.50 stddev:20.04 (11.6%) stddev-sans-first:20.91 05:07:51 INFO - PROCESS | 1761 | Values: 169.0 171.0 230.0 199.0 171.0 173.0 167.0 173.0 172.0 168.0 05:07:51 INFO - PROCESS | 1761 | 05:07:51 INFO - PROCESS | 1761 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.50 stddev:1.29 (1.9%) stddev-sans-first:1.30 05:07:51 INFO - PROCESS | 1761 | Values: 67.0 67.0 68.0 65.0 66.0 64.0 67.0 65.0 65.0 65.0 05:07:51 INFO - PROCESS | 1761 | -------- Summary: end -------- 05:07:51 INFO - PROCESS | 1761 | 05:07:52 INFO - TEST-INFO | 1761: exit 0 05:07:52 INFO - TEST-OK | kraken | took 60532ms 05:07:52 INFO - SUITE-END | took 1182s 05:07:52 INFO - Completed test suite (00:19:42) 05:07:52 INFO - javascript benchmark 05:07:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7560.029268297812, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3375.8480868360934, 3390.0, 3394.083597428696, 3398.1674489750017, 3441.3289408565324, 5002.324686167366, 5587.664740115596, 5848.59059865809, 5931.258592675916, 5957.344692083872, 5598.328200615922, 5690.118031705082, 5730.4269573042675, 5814.5057670098095, 5870.207521984531, 5175.508326708957, 5236.31927849379, 5256.001359741656, 5273.841784746463, 5276.7097809620645, 5271.472852714736, 5274.314339135907, 5284.180951952453, 5302.734863256841, 5318.9202161967405, 5204.739763011834, 5236.3978142513715, 5271.235670827708, 5317.3619165700175, 5353.2237825515085, 5265.394479634852, 5268.0, 5268.81559145428, 5282.709450980195, 5288.444713305124, 5186.0, 5218.243354713583, 5226.320578324793, 5236.266922630834, 5243.816466423695, 5766.509846663039, 5784.1034639630925, 5785.045467497858, 5787.1608616750755, 5812.331581868055, 6177.3822617738315, 6198.938010619881, 6202.751889924398, 6206.906896396557, 6231.3145553989025, 5105.846824595231, 6161.969190154021, 6176.752929882799, 6186.9381306186815, 6198.535109866778, 6042.0, 6057.454829065361, 6099.451049405575, 6100.23747031621, 6102.7864024759365, 6380.7447702091395, 6405.327440618668, 6425.485961123099, 6428.582142160744, 6431.871362572816, 6100.908486372708, 6110.01202914832, 6174.876502469925, 6248.0, 6258.0, 6201.56589038772, 6228.532860035515, 6233.1273621693, 6235.532335074888, 6287.779927702509, 6177.876442471125, 6188.721507532172, 6194.566380353332, 6200.441960223601, 6228.34602366754, 6263.937360626426, 6316.30520642729, 6328.493720502349, 6328.6835658216905, 6376.904346434807, 4960.801567937242, 5031.874203144877, 5045.041442125985, 5050.696958182521, 5053.9241911371355, 4442.489113751895, 4457.3091170868565, 4504.504504504502, 4536.79584418702, 4608.677392582487, 5636.04187288162, 5666.46168613981, 5712.857178570486, 5715.199872017921, 5732.0, 6278.4035516625845, 6279.717412716439, 6287.434130928238, 6291.433770960635, 6309.92731235691, 5623.5220006299105, 5737.454941780524, 5743.59794814359, 5757.8560535986935, 5839.970800146057, 5523.950449414599, 5527.585431092684, 5532.446755324436, 5536.501714845684, 5571.637843540157, 6433.002884552901, 6442.194725659293, 6448.871022579522, 6452.838679033061, 6465.9331210349765, 6194.5354098443695, 6241.21984751906, 6281.057841323838, 6290.748370065146, 6304.306526282014, 6278.780242691484, 6285.528585356025, 6301.747930082745, 6312.968435157794, 6336.239651241881, 6222.408871157233, 6226.1905952225925, 6229.626222426669, 6236.126942228001, 6308.400701933309, 5290.470952904832, 6267.62394256346, 6282.905756413749, 6296.653684047421, 6304.621722696653, 6210.844728881814, 6217.100015951457, 6225.159603453476, 6228.968855155696, 6234.251889773256, 4754.477007529238, 6024.608400453956, 6080.2399700037495, 6100.969495152496, 6205.906911396242, 4961.900761984668, 5866.2373891395555, 5965.91051134242, 5976.850578735566, 5979.641221526722, 4975.850724478127, 6101.084837274444, 6109.677964500999, 6130.846728831636, 6136.631802091889, 5958.910616340845, 5968.403159683997, 5985.0, 5991.910121348271, 5997.0], "value": 5728.044413906989, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [771.1324759645399, 790.6758229126058, 848.6605357856856, 872.7992561710806, 873.0, 26822.195334139957, 27892.88428462859, 38347.84956451304, 38531.22937541254, 40442.0, 39240.41139382911, 39319.41020884689, 39397.0, 39499.60500394995, 39567.40648890269, 8872.600732967, 9035.27717782579, 9052.0, 9054.637814487445, 9061.864072038925, 7161.176464706547, 7370.189279179286, 7400.481966262364, 7416.221296763843, 7418.554886706788, 10614.991575800286, 10874.891251087467, 10878.966498182699, 10881.347119172875, 10882.020618144365, 10708.30396024256, 10766.407847568342, 10781.5687372505, 10783.029527342576, 10814.188935829765, 7068.823279418004, 10543.31468454548, 10585.311954722996, 10588.470576471223, 10591.311564748266, 26917.730822691916, 37045.62954370449, 37554.62445375539, 38733.61266387328, 38795.0, 3745.978320051472, 3758.0980564664555, 3786.091338078869, 3803.619638036202, 3889.397143442771, 26823.744892220217, 27194.728052719416, 27807.165785026482, 27845.58231626527, 27922.3019424514, 3051.5422686596967, 3170.619525656913, 3240.7569432292435, 3268.2319654881085, 3290.572225610679, 351279.0, 351356.0, 351958.0, 351998.0, 352494.0, 40422.79788601038, 48874.0, 49059.26411103836, 49262.0, 49483.0, 44292.11415771666, 44407.11185776266, 51325.23012154821, 52166.21750673743, 54783.726081369336, 14405.0, 14623.488177913721, 14640.560783176521, 14698.26508674562, 14700.926495367668, 11939.223950443367, 11948.880511194951, 11949.820752688716, 11958.760824783456, 11978.520859165536, 12722.427490762939, 12726.80909786354, 12737.745245095231, 12782.977361811032, 12851.614451566467, 5197.194434862602, 5224.320838290998, 5227.921581176285, 5233.869153271123, 5243.5542978847225, 1058.222206678091, 1067.8451624514557, 1075.9025793690548, 1090.220492347975, 1136.1478890831877, 24693.0, 24715.87642061778, 26089.81609275594, 26677.733222667914, 27727.861360693067, 982.6953644370268, 1127.7800828838297, 1152.0438036429744, 1164.574930150489, 1181.373871847922, 12170.81743773844, 13230.338483075808, 13658.0, 14057.297135143406, 14058.929705351407, 422182.0, 422258.0, 423141.0, 423466.0, 423638.7636123661, 52617.0, 52773.73613131986, 52858.73570632199, 52945.7352713234, 53022.93954120973, 1393.108410617206, 1443.1052747296744, 1444.2562080528746, 1446.320229492137, 1450.0357262420582, 23875.522489550458, 24670.0, 25029.998800047793, 26077.608835867857, 26201.082962096236, 43876.780616096716, 43916.78041609772, 43946.34080488731, 43972.0, 44012.559874400846, 389221.0, 389316.0, 389651.0, 390679.0, 390744.0, 26426.603600946386, 26728.46543069089, 26991.730082698923, 30027.0, 31738.04785856428, 42031.57968420276, 42077.579224207366, 42139.31442742256, 42269.0, 43804.78097609492, 29106.56340154857, 30800.49163428827, 33615.66384336223, 34484.65515344815, 36167.638323616426, 34635.0, 34883.9534813956, 35011.82494087513, 36140.0, 36252.73115440947, 35565.82217088898, 36348.0, 36419.817900910326, 36444.63555364519, 36448.0, 26670.59994100129, 31422.22933248025, 31512.0, 31686.049418517483, 31716.04851854448, 19169.424917252505, 23069.65395519035, 23954.40113997094, 24076.39809004789, 24182.75817241805], "value": 18148.020032793593, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.609174504388, 381.96944244460445, 413.3943772373473, 422.54998426675587, 428.8713385984206, 12803.399575053118, 18466.261349546017, 21334.46663833405, 21912.0, 22159.667604985938, 21972.89013554934, 22700.432489187777, 23103.653445198335, 23374.065037398526, 23409.18067867625, 5485.725713714318, 6673.4661227101715, 6702.564333318343, 6911.654417279141, 6980.965095174517, 6897.310268973113, 6918.75784347548, 6968.44252459802, 6984.266652001543, 6994.510384273103, 5642.830715078554, 6613.537052406334, 6912.066870972405, 6944.861102777942, 6945.861082778341, 6647.401733843977, 6858.348456896637, 6956.304369563054, 7015.543989640657, 7061.258567850405, 6749.460043196533, 6765.594064356154, 6776.085228494188, 6776.136562445367, 6796.320367963164, 28029.0, 28415.0, 28473.430531389255, 28487.72098232157, 28725.0, 3352.5641666583188, 3379.4423920053164, 3384.1032126486502, 3436.0, 3478.5999610044914, 16229.756553651705, 17198.1400929953, 17502.29990800379, 17587.0, 18233.361832335806, 2031.25859061443, 2035.460602940222, 2060.64968955278, 2104.8947552622462, 2221.622324204889, 159783.0, 159876.0, 167537.1623141901, 168584.0, 173373.13313433478, 17419.82580174182, 23519.294421167393, 23911.641325380133, 24126.87936560306, 24306.149284774947, 42162.36756448656, 42653.0, 42826.286948522335, 42985.0, 43008.784956075644, 11159.888401116048, 11164.944175279072, 11319.207655464039, 11325.830112548318, 11462.083033357312, 8902.554872256362, 8911.06433824439, 8934.642614295486, 9112.0, 9126.170887025044, 11341.886581134084, 11431.885681143249, 11443.313401195956, 11573.826392604118, 11585.6524304271, 4296.312589985588, 4443.178012067778, 4466.240739074366, 4481.932771008437, 4482.372467854503, 787.0909099989522, 867.3624885708999, 870.1516021878745, 927.3879239701764, 933.7898972731217, 18785.812141878407, 23173.304800856, 23517.88241058818, 23700.64449033266, 23703.525929481315, 924.496149598457, 930.5254320296698, 941.491594538955, 944.15026476172, 953.955418816395, 9473.336866419422, 11903.761924761457, 12113.68271001216, 12128.878711212776, 12164.81752773709, 393523.0, 398045.0, 401359.0, 515926.0, 670965.6451717711, 140552.0, 145643.0, 148568.2571587135, 148754.0, 153547.0, 1234.3766397969148, 1254.8933340665963, 1285.2738202915323, 1286.2539726958341, 1286.9742605147844, 15354.769678454608, 18443.985580792647, 20000.19999200074, 20189.394318170478, 20227.0, 43570.0, 60682.0, 60787.78424431398, 61028.694856525435, 61396.0, 79943.60028199822, 83678.58160709158, 85650.14349856671, 88186.0, 89221.0, 9371.0, 12124.939375303067, 12424.378781061092, 12742.299173545543, 12755.170913890568, 13716.245606491739, 13866.306684665928, 13883.791743124064, 14286.714265714836, 14332.140071595737, 11579.652610421701, 11586.0, 11773.234739741889, 11959.342236176746, 12005.75988480243, 9339.766505837408, 11658.533658653898, 11754.70613234676, 11793.587224447103, 12043.819342710041, 11912.821307680566, 11931.387085736224, 12170.452329645364, 12207.267563946192, 12253.448594813077, 12285.754284914074, 12300.938495307466, 12416.192947458387, 12579.685507862378, 12645.051621128636, 9849.310548261554, 11278.943605281922, 11740.941295293469, 12005.579804706793, 12154.513819447124], "value": 11883.916960300652, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1551.5345396381083, 1571.387159007987, 1597.377022961045, 1600.8399160083993, 1608.5254849819303, 10420.374777513345, 11023.06303964164, 11029.724256893582, 11032.22774405792, 11032.779344413108, 8168.387370947173, 10843.403612801292, 11009.724756881082, 11021.504032318544, 11041.668749937495, 2237.9888100559515, 2279.509905370345, 2281.315605318406, 2283.315005498352, 2284.3946354216146, 2223.5997520446313, 2248.9887550562225, 2249.662550617404, 2256.6727824465443, 2257.841951063426, 2219.5449932763745, 2230.230570453191, 2239.958419335009, 2244.5847518209102, 2246.1913711064003, 2192.75879653238, 2206.4263291544235, 2216.0803266644325, 2216.390492614528, 2218.0462401167492, 1802.5854053567753, 2207.095091012677, 2305.296884450242, 2307.238611258281, 2311.191083120911, 10840.945795270973, 10948.616798412097, 10956.616518421817, 10960.945195274053, 10993.395363255018, 5508.091164957777, 5691.829245122612, 5697.572682048822, 5699.202111704323, 5701.458361455655, 3291.670832916713, 3363.923544465772, 3585.0678823505814, 3585.175409655794, 3589.0489020409614, 1209.7338585511172, 1252.642996745923, 1775.8046614872353, 1800.3788692900928, 1908.475169328432, 14633.634159146, 14662.633434164125, 14723.411063557338, 14815.0, 14910.62723431912, 4293.334533147367, 4329.307310830252, 4449.243628583149, 4453.283497066786, 4458.331250312414, 11553.36456494884, 11559.595414160463, 11561.190716649753, 11573.363465009505, 11575.76848463026, 5446.101393270145, 5447.536959358499, 5455.5908306877145, 5458.426865179178, 5465.754041068161, 4855.490173531799, 5055.191169412877, 5063.544281014726, 5076.543111120017, 5148.897022059537, 3671.173985853215, 3732.8880133596035, 3749.343864823645, 3790.5640851302455, 3804.9809750951067, 997.1125698128672, 1006.8439391894268, 1014.2899970021015, 1018.1701912940929, 1021.9846702299471, 908.5366463103865, 926.2080920812608, 931.9254459643212, 948.2035090523993, 972.9659461918799, 5998.310194327621, 6390.808275751735, 6554.70503827329, 6603.20761508622, 6629.834254143685, 952.9891928031848, 955.47926380123, 1003.9949800250952, 1009.3086235928266, 1020.8009438159488, 3639.66970222249, 4025.577314382006, 4163.75017498951, 4308.913821723548, 4538.546145385435, 10339.586416543254, 12982.896453801533, 13763.793543096861, 13773.931130344285, 13822.516211932534, 11864.881351186377, 12579.559715409916, 13074.542391016268, 13564.982626303066, 13711.451541938211, 6876.793696189123, 8615.526146061902, 8897.911020889838, 9740.610375585038, 9830.901690982999, 6576.76981305652, 6610.537262391779, 6849.760258390932, 6851.48613853953, 6857.177138743383, 11727.706807329885, 11738.41307934617, 12061.939690301493, 12063.095267855122, 12093.395330233629, 11685.941570292094, 12056.75886482283, 12136.33250171249, 12365.258084514959, 12405.937970310091, 8785.780355491164, 9068.818623627358, 9071.59177837012, 9072.727818165466, 9080.59137338808, 9621.807563848824, 9739.172170365599, 9869.161121304769, 9872.210223181984, 9894.208463322773, 8530.061693213866, 8687.131286871263, 8737.082606326498, 8840.160184782435, 8883.244924181517, 8448.408611397143, 8449.577521124042, 8492.70275540353, 8602.612882420432, 8750.037495875322, 7440.851182976202, 7584.924150758422, 7689.6539655714505, 7691.692332306869, 7696.0, 4762.476127626028, 5560.277163968658, 5580.888382232414, 5706.9714651426475, 5935.228420305332, 5693.572982026448, 5761.934042202206, 5878.29460464747, 6051.0, 6063.636181829104], "value": 5008.815795803874, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.28296304427005, 377.7752237418737, 384.63267579461615, 388.4251308064067, 388.42707007164427, 4337.783110844457, 4817.831375901844, 4943.431505376878, 5051.267566202899, 5065.442801291855, 4326.3510473429005, 4404.405405270288, 4529.886752831181, 4929.718273248955, 4970.130227210242, 3274.5743053403085, 4063.3701776224734, 4103.220388126247, 4110.856120035799, 4152.401325489693, 4088.1823635272917, 4090.1206240658253, 4114.753114813106, 4125.0093682080405, 4146.813393397304, 3537.6462353764546, 4100.979495102521, 4139.503259608851, 4142.233686767942, 4152.252594532983, 3401.642827503101, 3718.5869369639363, 4058.634722874926, 4120.75275483472, 4149.481314835645, 3230.9838450807597, 3440.53777144715, 3709.27669104522, 3764.416515440084, 3788.412796016622, 4114.979425102885, 4285.57144285572, 4331.3540854475095, 4816.325714399987, 4832.9275060874115, 4350.6736994725525, 4439.866803995886, 4579.641819071694, 4743.0, 4789.227985645299, 4300.806463709109, 5190.92213616796, 5204.438668399503, 5205.427402985669, 5235.685858848443, 3665.596784353719, 3753.6621704046493, 3771.113788259784, 4186.66506679468, 4250.426192464009, 4866.330724705714, 5200.609954253446, 5311.937612477482, 5369.5972802040005, 5453.646007705312, 3551.662592053751, 3886.4753258309765, 4116.794160291974, 4302.483701955723, 4307.375430562551, 4114.305130139764, 4389.934150987738, 4400.691951563424, 4428.446444194476, 4452.9554704453185, 4053.6554392876346, 4139.785214910069, 4437.534058923831, 4490.438695163105, 4781.641376896747, 5045.7981680732355, 5200.952576955873, 5239.0, 5316.787328506894, 5390.8921821563345, 1331.9200847949155, 1433.7956116861885, 1470.7278204353372, 1485.2202593638426, 1488.2112480385413, 1060.5174645536263, 1108.695108845074, 1118.2507719827736, 1139.6467095200514, 1148.7702459508132, 4183.6653067754505, 4249.936250956176, 4397.2964325707735, 4441.844535441309, 4535.0137818080475, 5016.849494515171, 5456.699881506555, 5487.5609951203805, 5502.504774570308, 5506.0, 4420.695894711068, 4486.6220902921505, 4675.742834144155, 4691.319758634979, 4910.926336104962, 2490.9537994042184, 2733.5352989991748, 2760.5997130415976, 2785.5543113102212, 2825.5479123340165, 5139.049275883899, 5288.2596436498925, 5654.4062873398525, 5693.68684722336, 5719.599628025998, 4745.596624286905, 5254.2957215163215, 5424.755885985141, 5610.691411972299, 5642.379338272786, 4892.8532144035735, 5103.821366252163, 5271.525562699376, 5431.805002899356, 5552.833414997556, 5419.83740487786, 5433.7554810034435, 5443.59173062014, 5478.534993979893, 5481.342238931354, 4826.58973987201, 5107.821226257063, 5400.378956419905, 5401.297831281908, 5424.457554244544, 4686.64850136248, 4957.206846904478, 4986.9251961221335, 5314.973425133005, 5666.291713535808, 3644.2347107107803, 3737.5888652247686, 4233.97883010583, 4263.637590804817, 4309.892252693708, 5015.0, 5114.2840002400435, 5486.643368181056, 5501.559875210054, 5527.484994327651, 4267.1465706858135, 4595.6783025187915, 4806.639502037431, 4834.250691142878, 5102.4897510248675, 4688.413948256468, 5156.020356132323, 5248.763805628832, 5269.394019687785, 5275.630705850554, 4753.857384278477, 4759.904801903874, 4809.182438985451, 4828.5412885775795, 5041.915988062584, 4343.652507799306, 4592.425946756655, 4953.628477864247, 4983.476734942924, 5305.787768489217, 4755.334253204485, 5096.337476128079, 5133.922991155061, 5139.331886854835, 5139.768710408115], "value": 3990.274717131283, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.0789800901857, 748.8502299540091, 754.7094368668061, 780.796992781877, 839.5004972041635, 14934.616321316924, 15822.0, 15832.0, 15839.208039598032, 15845.366185352586, 14341.354639041243, 14355.0, 14460.566183014527, 14473.34869930853, 14528.782068268958, 922.0134456131941, 948.1987720376271, 948.7865230323157, 950.1686024728363, 952.4190243951184, 962.6245764151986, 991.3110388280148, 1002.6089824968268, 1010.9292349535499, 1015.4567306491028, 981.1316984468725, 1028.8250997330472, 1038.678009816959, 1041.2659075351896, 1048.1928914735688, 1003.9498025098716, 1005.4922264256577, 1006.8741407324085, 1006.9295149339549, 1010.0808264479361, 765.8047197964539, 766.3218052023943, 767.4205974489225, 768.7309441695418, 771.3482107619109, 15914.76127858083, 16101.0, 16168.029918204827, 16181.19094045293, 16265.91867040669, 14624.122552646875, 14820.184889831055, 14874.479393221185, 14915.030523016077, 14920.477783277533, 11663.766724665544, 11732.923960285458, 11828.526858925632, 11904.345261010641, 12201.742677604672, 3591.4612808078737, 3603.7733977442917, 3666.3400587894166, 3758.2483503299177, 3866.4973553438153, 89416.55291723499, 91097.0, 104501.95498044998, 108773.0, 111440.88559114386, 10018.448985305733, 10831.241813073168, 11459.083273338112, 11532.004093026826, 11619.128565357632, 18426.907865460587, 24757.62863557048, 25233.11684091048, 25288.747112529007, 25339.61990570143, 6336.461400780985, 7820.765377038698, 7951.642176102089, 8015.879761803578, 8074.798130046795, 4072.572379900127, 4226.894327641833, 4291.74249545022, 4359.825606975749, 4375.124975005012, 3542.8582856685443, 3642.2715456908722, 3643.508126402902, 3645.453182022718, 3661.1213308806227, 633.5375176121457, 651.1697585578426, 656.2617055812211, 671.5232185148599, 672.9192496900404, 652.8335274504971, 667.7395815631908, 688.4079691465336, 697.5605368617738, 707.4305184326666, 9168.724938251864, 9571.0, 10145.64490242838, 10171.520938725353, 10186.236032297607, 633.5375176121457, 669.6149713914518, 686.2725510958301, 694.9013977787055, 708.2032713197652, 4550.408446901882, 4571.1543364477675, 4792.592629626451, 4837.975810120927, 4867.294242334912, 97324.51337743408, 99857.50071249597, 100770.40369953756, 100837.0, 102746.48626756818, 53266.73366633142, 59916.101258481154, 83163.5841820787, 84415.57792211, 85994.14005859986, 56784.901887264095, 57703.422965770646, 65666.67166664136, 71379.64310178415, 73188.0, 10028.899711002796, 10444.321119127537, 10795.676129716121, 10821.242513024328, 10913.727156820825, 44770.74857811172, 45315.0, 45374.546254538356, 45671.771641142914, 46478.76760616311, 47114.528854712386, 60929.08606370819, 61022.0, 61135.69432152989, 61221.69389153026, 13102.213867168, 13163.275915849168, 13177.604671859859, 13191.67020824487, 13599.59201223965, 14159.433622654979, 14214.644633884236, 14497.130172189702, 14515.782263265848, 15153.090814551162, 12903.48322227999, 13170.341482926007, 13395.263260520765, 13396.866031339561, 13649.658758531115, 13266.336683165997, 13457.259850707913, 13516.053876228569, 13615.52345667897, 13928.0, 13115.274218095454, 13141.868581314448, 13241.139325943783, 13604.86395136036, 13669.453221871014, 10667.359958402521, 10852.952297558362, 10895.182861285277, 11037.503312350804, 11817.995470384769, 8052.2587722565195, 9495.382800118246, 10430.737576597909, 10945.288556243819, 11291.0], "value": 7560.72041090632, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1449.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 167.0, 175.0, 118.0, 115.0, 115.0, 111.0, 115.0, 115.0, 115.0], "value": 126.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 114.0, 111.0, 152.0, 113.0, 112.0, 110.0, 109.0, 131.0, 111.0], "value": 120.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 185.0, 185.0, 188.0, 187.0, 183.0, 182.0, 187.0, 184.0, 186.0], "value": 185.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 60.0, 90.0, 61.0, 61.0, 62.0, 61.0, 76.0, 59.0], "value": 67.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 91.0, 70.0, 70.0, 66.0, 84.0, 69.0, 68.0, 84.0], "value": 75.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 86.0, 86.0, 87.0, 86.0, 86.0, 86.0, 86.0, 86.0], "value": 86.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 95.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 86.0, 92.0, 129.0, 87.0, 83.0, 83.0, 84.0, 84.0], "value": 89.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 65.0, 64.0, 63.0, 63.0, 64.0, 65.0, 66.0, 63.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 58.0, 65.0, 64.0, 61.0, 56.0, 57.0, 57.0, 56.0, 72.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 108.0, 102.0, 87.0, 86.0, 85.0, 84.0, 85.0, 87.0], "value": 89.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 158.0, 147.0, 152.0, 139.0, 138.0, 138.0, 140.0, 177.0, 134.0], "value": 145.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 171.0, 230.0, 199.0, 171.0, 173.0, 167.0, 173.0, 172.0, 168.0], "value": 179.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 65.0, 66.0, 64.0, 67.0, 65.0, 65.0, 65.0], "value": 65.9, "unit": "score"}]}]} 05:07:52 INFO - Return code: 0 05:07:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:07:52 ERROR - # TBPL SUCCESS # 05:07:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:07:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:07:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:07:52 INFO - 2017-03-11 05:07:52.648 screenresolution[1765:18563] starting screenresolution argv=screenresolution get 05:07:52 INFO - 2017-03-11 05:07:52.651 screenresolution[1765:18563] Display 0: 1600x1200x32@60 05:07:52 INFO - 2017-03-11 05:07:52.658 screenresolution[1766:18566] starting screenresolution argv=screenresolution list 05:07:52 INFO - Available Modes on Display 0 05:07:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:07:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:07:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:07:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:07:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:07:52 INFO - Intel Iris: 05:07:52 INFO - Chipset Model: Intel Iris 05:07:52 INFO - Type: GPU 05:07:52 INFO - Bus: Built-In 05:07:52 INFO - VRAM (Dynamic, Max): 1536 MB 05:07:52 INFO - Vendor: Intel (0x8086) 05:07:52 INFO - Device ID: 0x0a2e 05:07:52 INFO - Revision ID: 0x0009 05:07:52 INFO - Displays: 05:07:52 INFO - Display: 05:07:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:07:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:07:52 INFO - Display Serial Number: 1600x1200 60 05:07:52 INFO - Main Display: Yes 05:07:52 INFO - Mirror: Off 05:07:52 INFO - Online: Yes 05:07:52 INFO - Rotation: Supported 05:07:52 INFO - Return code: 0 05:07:52 INFO - Running post-action listener: _resource_record_post_action 05:07:52 INFO - [mozharness: 2017-03-11 13:07:52.896407Z] Finished run-tests step (success) 05:07:52 INFO - Running post-run listener: _resource_record_post_run 05:07:52 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 33942528; Write bytes: 513768448; Read time: 308; Write time: 1719 05:07:52 INFO - TinderboxPrint: CPU usage
54.1% 05:07:52 INFO - TinderboxPrint: I/O read bytes / time
33,942,528 / 308 05:07:52 INFO - TinderboxPrint: I/O write bytes / time
513,768,448 / 1,719 05:07:52 INFO - TinderboxPrint: CPU idle
2,209.1 (45.9%) 05:07:52 INFO - TinderboxPrint: CPU system
960.2 (19.9%) 05:07:52 INFO - TinderboxPrint: CPU user
1,644.4 (34.2%) 05:07:52 INFO - TinderboxPrint: Swap in / out
239,091,712 / 0 05:07:52 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 205429248; Write bytes: 202758144; Read time: 15660; Write time: 412 05:07:52 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 31972352; Write bytes: 300225536; Read time: 288; Write time: 1277 05:07:53 INFO - Running post-run listener: _upload_blobber_files 05:07:53 INFO - Blob upload gear active. 05:07:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:07:53 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 05:07:53 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'] 05:07:53 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 05:07:53 INFO - (blobuploader) - INFO - Open directory for files ... 05:07:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:07:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:07:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:54 INFO - (blobuploader) - INFO - Done attempting. 05:07:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:07:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:07:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:55 INFO - (blobuploader) - INFO - Done attempting. 05:07:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:07:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:07:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:56 INFO - (blobuploader) - INFO - Done attempting. 05:07:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:07:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:07:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:58 INFO - (blobuploader) - INFO - Done attempting. 05:07:58 INFO - (blobuploader) - INFO - Iteration through files over. 05:07:58 INFO - Return code: 0 05:07:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:07:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:07:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fe11cb13ec981a3997c54721fbb1ed79ef8c04ef67df9b87c82363f22e2bb5e82d283453878639bf1dd8a2d3656986f91845e95126a6373fbbb098cc34afce5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e6786f140c7f3df9369514df359b91bc1b7f9d7a0ec5fadf182a9433a6f37a387ee8f891d93ed7f4dc89906ba20b7f5778ae4e93d3880d81aa7badd2aab0bbb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8a5a8f240dec37c73ceb00bdc3b0f134ac607a888fb644497156e7bfbafddc29c62ce5e31a05a7cef604c4f1f06725611e6aff43262510e2ac548e3e7f421f5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66544a3327194527ee44e8229a057b96d37e9082edfcca933002c647cf7afd21ea7d45e1c419a3933e6942c9e3a77e271cf74bb113bba19302387fc83201f7c1"} 05:07:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:07:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:07:58 INFO - Contents: 05:07:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fe11cb13ec981a3997c54721fbb1ed79ef8c04ef67df9b87c82363f22e2bb5e82d283453878639bf1dd8a2d3656986f91845e95126a6373fbbb098cc34afce5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e6786f140c7f3df9369514df359b91bc1b7f9d7a0ec5fadf182a9433a6f37a387ee8f891d93ed7f4dc89906ba20b7f5778ae4e93d3880d81aa7badd2aab0bbb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8a5a8f240dec37c73ceb00bdc3b0f134ac607a888fb644497156e7bfbafddc29c62ce5e31a05a7cef604c4f1f06725611e6aff43262510e2ac548e3e7f421f5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66544a3327194527ee44e8229a057b96d37e9082edfcca933002c647cf7afd21ea7d45e1c419a3933e6942c9e3a77e271cf74bb113bba19302387fc83201f7c1"} 05:07:58 INFO - Running post-run listener: copy_logs_to_upload_dir 05:07:58 INFO - Copying logs to upload dir... 05:07:58 INFO - mkdir: /builds/slave/test/build/upload/logs 05:07:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.240579 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-11 05:07:57.927464) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-11 05:07:57.931704) ========= 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.39sapab4gB/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.dq0WxAhZ1G/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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/8fe11cb13ec981a3997c54721fbb1ed79ef8c04ef67df9b87c82363f22e2bb5e82d283453878639bf1dd8a2d3656986f91845e95126a6373fbbb098cc34afce5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e6786f140c7f3df9369514df359b91bc1b7f9d7a0ec5fadf182a9433a6f37a387ee8f891d93ed7f4dc89906ba20b7f5778ae4e93d3880d81aa7badd2aab0bbb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8a5a8f240dec37c73ceb00bdc3b0f134ac607a888fb644497156e7bfbafddc29c62ce5e31a05a7cef604c4f1f06725611e6aff43262510e2ac548e3e7f421f5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66544a3327194527ee44e8229a057b96d37e9082edfcca933002c647cf7afd21ea7d45e1c419a3933e6942c9e3a77e271cf74bb113bba19302387fc83201f7c1"} build_url:https://queue.taskcluster.net/v1/task/eVHmAx_iT7KiWWTpXpiSjw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010977 build_url: 'https://queue.taskcluster.net/v1/task/eVHmAx_iT7KiWWTpXpiSjw/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/8fe11cb13ec981a3997c54721fbb1ed79ef8c04ef67df9b87c82363f22e2bb5e82d283453878639bf1dd8a2d3656986f91845e95126a6373fbbb098cc34afce5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e6786f140c7f3df9369514df359b91bc1b7f9d7a0ec5fadf182a9433a6f37a387ee8f891d93ed7f4dc89906ba20b7f5778ae4e93d3880d81aa7badd2aab0bbb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8a5a8f240dec37c73ceb00bdc3b0f134ac607a888fb644497156e7bfbafddc29c62ce5e31a05a7cef604c4f1f06725611e6aff43262510e2ac548e3e7f421f5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66544a3327194527ee44e8229a057b96d37e9082edfcca933002c647cf7afd21ea7d45e1c419a3933e6942c9e3a77e271cf74bb113bba19302387fc83201f7c1"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-11 05:07:57.973186) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-11 05:07:57.974003) ========= 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.39sapab4gB/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.dq0WxAhZ1G/Listeners TMPDIR=/var/folders/0j/h0q2j0xx3k5cx8qlz357zmjr00000w/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.005096 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-11 05:07:58.028480) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-11 05:07:58.029314) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-11 05:07:58.030157) ========= ========= Total master_lag: 0.20 =========