builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0084 starttime: 1475582535.17 results: success (0) buildid: 20161004023801 builduid: 6613d6dc7fe644d093760566547fdf86 revision: 581e2e9b9d79cbaf4e333447e5966e03b92a2eb7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 05:02:15.175240) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 05:02:15.176284) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 05:02:15.176941) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 05:02:15.202600) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 05:02:15.203059) ========= 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.npNAZVvP6Z/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.INnG0e7s8m/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 --2016-10-04 05:02:15-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 73.3M=0s 2016-10-04 05:02:15 (73.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130031 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 05:02:15.359293) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 05:02:15.360090) ========= 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.npNAZVvP6Z/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.INnG0e7s8m/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.028720 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 05:02:15.412324) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-04 05:02:15.413118) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 581e2e9b9d79cbaf4e333447e5966e03b92a2eb7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 581e2e9b9d79cbaf4e333447e5966e03b92a2eb7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.npNAZVvP6Z/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.INnG0e7s8m/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 2016-10-04 05:02:15,478 truncating revision to first 12 chars 2016-10-04 05:02:15,478 Setting DEBUG logging. 2016-10-04 05:02:15,478 attempt 1/10 2016-10-04 05:02:15,478 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/581e2e9b9d79?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 05:02:16,514 unpacking tar archive at: mozilla-aurora-581e2e9b9d79/testing/mozharness/ program finished with exit code 0 elapsedTime=2.012910 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-04 05:02:17.450050) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 05:02:17.450432) ========= script_repo_revision: 581e2e9b9d79cbaf4e333447e5966e03b92a2eb7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 05:02:17.450902) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 05:02:17.451280) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 05:02:17.469754) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-04 05:02:17.470088) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.npNAZVvP6Z/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.INnG0e7s8m/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 05:02:17 INFO - MultiFileLogger online at 20161004 05:02:17 in /builds/slave/test 05:02:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:02:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:02:17 INFO - {'append_to_log': False, 05:02:17 INFO - 'base_work_dir': '/builds/slave/test', 05:02:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:02:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:02:17 INFO - 'branch': 'Mozilla-Aurora', 05:02:17 INFO - 'buildbot_json_path': 'buildprops.json', 05:02:17 INFO - 'config_files': ('talos/mac_config.py',), 05:02:17 INFO - 'default_actions': ('clobber', 05:02:17 INFO - 'read-buildbot-config', 05:02:17 INFO - 'download-and-extract', 05:02:17 INFO - 'populate-webroot', 05:02:17 INFO - 'create-virtualenv', 05:02:17 INFO - 'install', 05:02:17 INFO - 'run-tests'), 05:02:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:02:17 INFO - 'download_minidump_stackwalk': True, 05:02:17 INFO - 'download_symbols': 'ondemand', 05:02:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:02:17 INFO - 'tooltool.py': '/tools/tooltool.py', 05:02:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:02:17 INFO - '/tools/misc-python/virtualenv.py')}, 05:02:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:02:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:02:17 INFO - 'installer_path': 'installer.exe', 05:02:17 INFO - 'log_level': 'info', 05:02:17 INFO - 'log_name': 'talos', 05:02:17 INFO - 'log_to_console': True, 05:02:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:02:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:02:17 INFO - 'opt_config_files': (), 05:02:17 INFO - 'pip_index': False, 05:02:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:02:17 INFO - 'cmd': ('bash', 05:02:17 INFO - '-c', 05:02:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:02:17 INFO - 'enabled': True, 05:02:17 INFO - 'halt_on_failure': False, 05:02:17 INFO - 'name': 'check_screen_resolution'},), 05:02:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:02:17 INFO - 'cmd': ('bash', 05:02:17 INFO - '-c', 05:02:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:02:17 INFO - 'enabled': True, 05:02:17 INFO - 'halt_on_failure': False, 05:02:17 INFO - 'name': 'check_screen_resolution'},), 05:02:17 INFO - 'run_cmd_checks_enabled': True, 05:02:17 INFO - 'sps_profile': False, 05:02:17 INFO - 'sps_profile_interval': 0, 05:02:17 INFO - 'suite': 'dromaeojs', 05:02:17 INFO - 'system_bits': '32', 05:02:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:02:17 INFO - 'title': 't-yosemite-r7-0084', 05:02:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:02:17 INFO - 'use_talos_json': True, 05:02:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:02:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:02:17 INFO - 'work_dir': 'build'} 05:02:17 INFO - [mozharness: 2016-10-04 12:02:17.662870Z] Running clobber step. 05:02:17 INFO - Running pre-action listener: _resource_record_pre_action 05:02:17 INFO - Running main action method: clobber 05:02:17 INFO - rmtree: /builds/slave/test/build 05:02:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:02:19 INFO - Running post-action listener: _resource_record_post_action 05:02:19 INFO - [mozharness: 2016-10-04 12:02:19.914881Z] Finished clobber step (success) 05:02:19 INFO - [mozharness: 2016-10-04 12:02:19.915047Z] Running read-buildbot-config step. 05:02:19 INFO - Running pre-action listener: _resource_record_pre_action 05:02:19 INFO - Running main action method: read_buildbot_config 05:02:19 INFO - Using buildbot properties: 05:02:19 INFO - { 05:02:19 INFO - "project": "", 05:02:19 INFO - "product": "firefox", 05:02:19 INFO - "script_repo_revision": "production", 05:02:19 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 05:02:19 INFO - "repository": "", 05:02:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 05:02:19 INFO - "buildid": "20161004023801", 05:02:19 INFO - "pgo_build": "False", 05:02:19 INFO - "basedir": "/builds/slave/test", 05:02:19 INFO - "buildnumber": 32, 05:02:19 INFO - "slavename": "t-yosemite-r7-0084", 05:02:19 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:02:19 INFO - "platform": "yosemite_r7", 05:02:19 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 05:02:19 INFO - "branch": "mozilla-aurora", 05:02:19 INFO - "repo_path": "releases/mozilla-aurora", 05:02:19 INFO - "revision": "581e2e9b9d79cbaf4e333447e5966e03b92a2eb7", 05:02:19 INFO - "stage_platform": "macosx64", 05:02:19 INFO - "builduid": "6613d6dc7fe644d093760566547fdf86", 05:02:19 INFO - "slavebuilddir": "test" 05:02:19 INFO - } 05:02:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/fci21CAHT1mshEWyJQKfKQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 05:02:19 INFO - Running post-action listener: _resource_record_post_action 05:02:19 INFO - [mozharness: 2016-10-04 12:02:19.918544Z] Finished read-buildbot-config step (success) 05:02:19 INFO - [mozharness: 2016-10-04 12:02:19.918667Z] Running download-and-extract step. 05:02:19 INFO - Running pre-action listener: _resource_record_pre_action 05:02:19 INFO - Running main action method: download_and_extract 05:02:19 INFO - mkdir: /builds/slave/test/build/tests 05:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:19 INFO - trying https://queue.taskcluster.net/v1/task/fci21CAHT1mshEWyJQKfKQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 05:02:19 INFO - Downloading https://queue.taskcluster.net/v1/task/fci21CAHT1mshEWyJQKfKQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 05:02:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fci21CAHT1mshEWyJQKfKQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 05:02:20 INFO - Downloaded 1199 bytes. 05:02:20 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 05:02:20 INFO - Using the following test package requirements: 05:02:20 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 05:02:20 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:02:20 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 05:02:20 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:02:20 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 05:02:20 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:02:20 INFO - u'jsshell-mac.zip'], 05:02:20 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:02:20 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 05:02:20 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 05:02:20 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:02:20 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 05:02:20 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:02:20 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 05:02:20 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:02:20 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 05:02:20 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 05:02:20 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 05:02:20 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 05:02:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fci21CAHT1mshEWyJQKfKQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 05:02:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fci21CAHT1mshEWyJQKfKQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:02:20 INFO - Fetch https://queue.taskcluster.net/v1/task/fci21CAHT1mshEWyJQKfKQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 05:02:21 INFO - Expected file size: 16433937 05:02:28 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 05:02:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fci21CAHT1mshEWyJQKfKQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 05:02:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fci21CAHT1mshEWyJQKfKQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:02:28 INFO - Fetch https://queue.taskcluster.net/v1/task/fci21CAHT1mshEWyJQKfKQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 05:02:29 INFO - Expected file size: 16433937 05:02:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fci21CAHT1mshEWyJQKfKQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 05:02:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fci21CAHT1mshEWyJQKfKQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 05:02:35 INFO - Fetch https://queue.taskcluster.net/v1/task/fci21CAHT1mshEWyJQKfKQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 05:02:36 INFO - Expected file size: 14414059 05:02:37 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')]} 05:02:37 INFO - trying https://queue.taskcluster.net/v1/task/fci21CAHT1mshEWyJQKfKQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 05:02:37 INFO - Downloading https://queue.taskcluster.net/v1/task/fci21CAHT1mshEWyJQKfKQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 05:02:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fci21CAHT1mshEWyJQKfKQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 05:02:40 INFO - Downloaded 115271584 bytes. 05:02:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fci21CAHT1mshEWyJQKfKQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 05:02:40 INFO - mkdir: /builds/slave/test/properties 05:02:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:02:40 INFO - Writing to file /builds/slave/test/properties/build_url 05:02:40 INFO - Contents: 05:02:40 INFO - build_url:https://queue.taskcluster.net/v1/task/fci21CAHT1mshEWyJQKfKQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 05:02:41 INFO - Running post-action listener: _resource_record_post_action 05:02:41 INFO - Running post-action listener: set_extra_try_arguments 05:02:41 INFO - [mozharness: 2016-10-04 12:02:41.054292Z] Finished download-and-extract step (success) 05:02:41 INFO - [mozharness: 2016-10-04 12:02:41.054433Z] Running populate-webroot step. 05:02:41 INFO - Running pre-action listener: _resource_record_pre_action 05:02:41 INFO - Running main action method: populate_webroot 05:02:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:02:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:02:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:02:41 INFO - '--tppagecycles', 05:02:41 INFO - '7'], 05:02:41 INFO - 'tests': ['tsvgm']}}, 05:02:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:02:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:02:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:02:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:02:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:02:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:02:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:41 INFO - 'talos_options': ['--disable-e10s'], 05:02:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:02:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:02:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:41 INFO - 'talos_options': ['--disable-e10s'], 05:02:41 INFO - 'tests': ['damp', 'tps']}, 05:02:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:41 INFO - 'tests': ['damp', 'tps']}, 05:02:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:02:41 INFO - 'tests': ['dromaeo_dom']}, 05:02:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:02:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:02:41 INFO - 'tests': ['basic_compositor_video']}, 05:02:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:02:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:02:41 INFO - 'tests': ['a11yr', 05:02:41 INFO - 'ts_paint', 05:02:41 INFO - 'tpaint', 05:02:41 INFO - 'sessionrestore', 05:02:41 INFO - 'sessionrestore_no_auto_restore', 05:02:41 INFO - 'tabpaint']}, 05:02:41 INFO - 'other-e10s': {'tests': ['a11yr', 05:02:41 INFO - 'ts_paint', 05:02:41 INFO - 'tpaint', 05:02:41 INFO - 'sessionrestore', 05:02:41 INFO - 'sessionrestore_no_auto_restore', 05:02:41 INFO - 'tabpaint']}, 05:02:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:02:41 INFO - 'ts_paint', 05:02:41 INFO - 'tpaint', 05:02:41 INFO - 'sessionrestore', 05:02:41 INFO - 'sessionrestore_no_auto_restore', 05:02:41 INFO - 'tabpaint']}, 05:02:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:02:41 INFO - 'ts_paint', 05:02:41 INFO - 'tpaint', 05:02:41 INFO - 'sessionrestore', 05:02:41 INFO - 'sessionrestore_no_auto_restore', 05:02:41 INFO - 'tabpaint']}, 05:02:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:02:41 INFO - 'tests': ['a11yr', 05:02:41 INFO - 'ts_paint', 05:02:41 INFO - 'tpaint', 05:02:41 INFO - 'sessionrestore', 05:02:41 INFO - 'sessionrestore_no_auto_restore', 05:02:41 INFO - 'tabpaint']}, 05:02:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:02:41 INFO - 'tests': ['a11yr', 05:02:41 INFO - 'ts_paint', 05:02:41 INFO - 'tpaint', 05:02:41 INFO - 'sessionrestore', 05:02:41 INFO - 'sessionrestore_no_auto_restore', 05:02:41 INFO - 'tabpaint']}, 05:02:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:02:41 INFO - 'tests': ['tsvgx', 05:02:41 INFO - 'tsvgr_opacity', 05:02:41 INFO - 'tart', 05:02:41 INFO - 'tscrollx', 05:02:41 INFO - 'cart']}, 05:02:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:02:41 INFO - 'tsvgr_opacity', 05:02:41 INFO - 'tart', 05:02:41 INFO - 'tscrollx', 05:02:41 INFO - 'cart']}, 05:02:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:41 INFO - 'talos_options': ['--disable-e10s'], 05:02:41 INFO - 'tests': ['tp5o']}, 05:02:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:41 INFO - 'tests': ['tp5o']}, 05:02:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:41 INFO - 'talos_options': ['--disable-e10s', 05:02:41 INFO - '--xperf_path', 05:02:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:02:41 INFO - 'tests': ['tp5n']}, 05:02:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:41 INFO - 'talos_options': ['--xperf_path', 05:02:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:02:41 INFO - 'tests': ['tp5n']}}, 05:02:41 INFO - 'talos.zip': {'path': '', 05:02:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:02:41 INFO - Running post-action listener: _resource_record_post_action 05:02:41 INFO - [mozharness: 2016-10-04 12:02:41.073254Z] Finished populate-webroot step (success) 05:02:41 INFO - [mozharness: 2016-10-04 12:02:41.073390Z] Running create-virtualenv step. 05:02:41 INFO - Running pre-action listener: _resource_record_pre_action 05:02:41 INFO - Running main action method: create_virtualenv 05:02:41 INFO - Creating virtualenv /builds/slave/test/build/venv 05:02:41 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 05:02:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:02:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:02:41 INFO - Using real prefix '/tools/python27' 05:02:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:02:41 INFO - Installing distribute.............................................................................................................................................................................................done. 05:02:44 INFO - Installing pip.................done. 05:02:44 INFO - Return code: 0 05:02:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:02:44 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')]} 05:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:44 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')]} 05:02:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:44 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 0x10ba7e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaf8d95bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b892d30>, '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 0x10b6f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b88ab20>, '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.npNAZVvP6Z/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.INnG0e7s8m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 05:02:44 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 05:02:44 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 05:02:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.npNAZVvP6Z/Render', 05:02:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:02:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:02:44 INFO - 'HOME': '/Users/cltbld', 05:02:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:02:44 INFO - 'LOGNAME': 'cltbld', 05:02:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:44 INFO - 'MOZ_NO_REMOTE': '1', 05:02:44 INFO - 'NO_EM_RESTART': '1', 05:02:44 INFO - 'PAGER': '/bin/cat', 05:02:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:02:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:44 INFO - 'PWD': '/builds/slave/test', 05:02:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:02:44 INFO - 'SHELL': '/bin/bash', 05:02:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.INnG0e7s8m/Listeners', 05:02:44 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 05:02:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:02:44 INFO - 'USER': 'cltbld', 05:02:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:02:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:44 INFO - 'XPC_FLAGS': '0x0', 05:02:44 INFO - 'XPC_SERVICE_NAME': '0', 05:02:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:02:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:45 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 05:02:45 INFO - Cleaning up... 05:02:45 INFO - Return code: 0 05:02:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:02:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:45 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 0x10ba7e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaf8d95bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b892d30>, '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 0x10b6f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b88ab20>, '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.npNAZVvP6Z/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.INnG0e7s8m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 05:02:45 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 05:02:45 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 05:02:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.npNAZVvP6Z/Render', 05:02:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:02:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:02:45 INFO - 'HOME': '/Users/cltbld', 05:02:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:02:45 INFO - 'LOGNAME': 'cltbld', 05:02:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:45 INFO - 'MOZ_NO_REMOTE': '1', 05:02:45 INFO - 'NO_EM_RESTART': '1', 05:02:45 INFO - 'PAGER': '/bin/cat', 05:02:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:02:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:45 INFO - 'PWD': '/builds/slave/test', 05:02:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:02:45 INFO - 'SHELL': '/bin/bash', 05:02:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.INnG0e7s8m/Listeners', 05:02:45 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 05:02:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:02:45 INFO - 'USER': 'cltbld', 05:02:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:02:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:02:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:45 INFO - 'XPC_FLAGS': '0x0', 05:02:45 INFO - 'XPC_SERVICE_NAME': '0', 05:02:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:02:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:45 INFO - Downloading/unpacking psutil>=3.1.1 05:02: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 05:02: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 05:02: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 05:02: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 05:02: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 05:02: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 05:02:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:02:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:02:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:02:48 INFO - Installing collected packages: psutil 05:02:48 INFO - Running setup.py install for psutil 05:02:48 INFO - building 'psutil._psutil_osx' extension 05:02:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:02:49 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 05:02:49 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 05:02:49 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 05:02:49 INFO - building 'psutil._psutil_posix' extension 05:02:49 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 05:02:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:02:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:02:49 INFO - ^ 05:02:49 INFO - 1 warning generated. 05:02:49 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 05:02:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:02:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:02:49 INFO - Successfully installed psutil 05:02:49 INFO - Cleaning up... 05:02:50 INFO - Return code: 0 05:02:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:02:50 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')]} 05:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:50 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')]} 05:02:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:50 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 0x10ba7e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaf8d95bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b892d30>, '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 0x10b6f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b88ab20>, '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.npNAZVvP6Z/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.INnG0e7s8m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 05:02:50 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 05:02:50 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 05:02:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.npNAZVvP6Z/Render', 05:02:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:02:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:02:50 INFO - 'HOME': '/Users/cltbld', 05:02:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:02:50 INFO - 'LOGNAME': 'cltbld', 05:02:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:50 INFO - 'MOZ_NO_REMOTE': '1', 05:02:50 INFO - 'NO_EM_RESTART': '1', 05:02:50 INFO - 'PAGER': '/bin/cat', 05:02:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:02:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:50 INFO - 'PWD': '/builds/slave/test', 05:02:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:02:50 INFO - 'SHELL': '/bin/bash', 05:02:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.INnG0e7s8m/Listeners', 05:02:50 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 05:02:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:02:50 INFO - 'USER': 'cltbld', 05:02:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:02:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:02:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:50 INFO - 'XPC_FLAGS': '0x0', 05:02:50 INFO - 'XPC_SERVICE_NAME': '0', 05:02:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:02:50 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 05:02:50 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 05:02:50 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 05:02:50 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 05:02:50 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 05:02:50 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 05:02:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:02:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:02:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:02:52 INFO - Installing collected packages: mozsystemmonitor 05:02:52 INFO - Running setup.py install for mozsystemmonitor 05:02:53 INFO - Successfully installed mozsystemmonitor 05:02:53 INFO - Cleaning up... 05:02:53 INFO - Return code: 0 05:02:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:02:53 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')]} 05:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:53 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')]} 05:02:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:53 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 0x10ba7e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaf8d95bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b892d30>, '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 0x10b6f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b88ab20>, '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.npNAZVvP6Z/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.INnG0e7s8m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 05:02:53 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 05:02:53 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 05:02:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.npNAZVvP6Z/Render', 05:02:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:02:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:02:53 INFO - 'HOME': '/Users/cltbld', 05:02:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:02:53 INFO - 'LOGNAME': 'cltbld', 05:02:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:53 INFO - 'MOZ_NO_REMOTE': '1', 05:02:53 INFO - 'NO_EM_RESTART': '1', 05:02:53 INFO - 'PAGER': '/bin/cat', 05:02:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:02:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:53 INFO - 'PWD': '/builds/slave/test', 05:02:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:02:53 INFO - 'SHELL': '/bin/bash', 05:02:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.INnG0e7s8m/Listeners', 05:02:53 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 05:02:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:02:53 INFO - 'USER': 'cltbld', 05:02:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:02:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:02:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:53 INFO - 'XPC_FLAGS': '0x0', 05:02:53 INFO - 'XPC_SERVICE_NAME': '0', 05:02:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:02:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:53 INFO - Downloading/unpacking jsonschema==2.5.1 05:02:53 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 05:02:53 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 05:02:53 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 05:02:53 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 05:02:53 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 05:02:53 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 05:02:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:02:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:56 INFO - Downloading functools32-3.2.3-2.tar.gz 05:02:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:02:56 INFO - warning: no files found matching '*.txt' 05:02:56 INFO - no previously-included directories found matching 'build' 05:02:56 INFO - no previously-included directories found matching 'dist' 05:02:56 INFO - no previously-included directories found matching '.git*' 05:02:56 INFO - Installing collected packages: jsonschema, functools32 05:02:56 INFO - Running setup.py install for functools32 05:02:56 INFO - warning: no files found matching '*.txt' 05:02:56 INFO - no previously-included directories found matching 'build' 05:02:56 INFO - no previously-included directories found matching 'dist' 05:02:56 INFO - no previously-included directories found matching '.git*' 05:02:56 INFO - Successfully installed jsonschema functools32 05:02:56 INFO - Cleaning up... 05:02:56 INFO - Return code: 0 05:02:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ba7e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaf8d95bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b892d30>, '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 0x10b6f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b88ab20>, '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.npNAZVvP6Z/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.INnG0e7s8m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 05:02:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:02:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:02:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.npNAZVvP6Z/Render', 05:02:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:02:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:02:56 INFO - 'HOME': '/Users/cltbld', 05:02:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:02:56 INFO - 'LOGNAME': 'cltbld', 05:02:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:56 INFO - 'MOZ_NO_REMOTE': '1', 05:02:56 INFO - 'NO_EM_RESTART': '1', 05:02:56 INFO - 'PAGER': '/bin/cat', 05:02:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:02:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:56 INFO - 'PWD': '/builds/slave/test', 05:02:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:02:56 INFO - 'SHELL': '/bin/bash', 05:02:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.INnG0e7s8m/Listeners', 05:02:56 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 05:02:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:02:56 INFO - 'USER': 'cltbld', 05:02:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:02:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:02:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:56 INFO - 'XPC_FLAGS': '0x0', 05:02:56 INFO - 'XPC_SERVICE_NAME': '0', 05:02:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:02:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:02:56 INFO - Cleaning up... 05:02:56 INFO - Return code: 0 05:02:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ba7e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaf8d95bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b892d30>, '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 0x10b6f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b88ab20>, '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.npNAZVvP6Z/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.INnG0e7s8m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 05:02:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:02:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:02:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.npNAZVvP6Z/Render', 05:02:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:02:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:02:56 INFO - 'HOME': '/Users/cltbld', 05:02:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:02:56 INFO - 'LOGNAME': 'cltbld', 05:02:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:56 INFO - 'MOZ_NO_REMOTE': '1', 05:02:56 INFO - 'NO_EM_RESTART': '1', 05:02:56 INFO - 'PAGER': '/bin/cat', 05:02:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:02:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:56 INFO - 'PWD': '/builds/slave/test', 05:02:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:02:56 INFO - 'SHELL': '/bin/bash', 05:02:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.INnG0e7s8m/Listeners', 05:02:56 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 05:02:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:02:56 INFO - 'USER': 'cltbld', 05:02:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:02:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:02:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:56 INFO - 'XPC_FLAGS': '0x0', 05:02:56 INFO - 'XPC_SERVICE_NAME': '0', 05:02:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:02:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:57 INFO - Downloading/unpacking blobuploader==1.2.4 05:02:57 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 05:02:57 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 05:02:57 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 05:02:57 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 05:02:57 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 05:02:57 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 05:02:59 INFO - Downloading blobuploader-1.2.4.tar.gz 05:02:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:02:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:03:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:03:00 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 05:03:00 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 05:03:00 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 05:03:00 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 05:03:00 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 05:03:00 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 05:03:00 INFO - Downloading docopt-0.6.1.tar.gz 05:03:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:03:00 INFO - Installing collected packages: blobuploader, requests, docopt 05:03:00 INFO - Running setup.py install for blobuploader 05:03:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:03:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:03:01 INFO - Running setup.py install for requests 05:03:01 INFO - Running setup.py install for docopt 05:03:01 INFO - Successfully installed blobuploader requests docopt 05:03:01 INFO - Cleaning up... 05:03:01 INFO - Return code: 0 05:03:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ba7e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaf8d95bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b892d30>, '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 0x10b6f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b88ab20>, '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.npNAZVvP6Z/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.INnG0e7s8m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 05:03:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:03:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:03:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.npNAZVvP6Z/Render', 05:03:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:01 INFO - 'HOME': '/Users/cltbld', 05:03:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:01 INFO - 'LOGNAME': 'cltbld', 05:03:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:01 INFO - 'MOZ_NO_REMOTE': '1', 05:03:01 INFO - 'NO_EM_RESTART': '1', 05:03:01 INFO - 'PAGER': '/bin/cat', 05:03:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:01 INFO - 'PWD': '/builds/slave/test', 05:03:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:01 INFO - 'SHELL': '/bin/bash', 05:03:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.INnG0e7s8m/Listeners', 05:03:01 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 05:03:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:01 INFO - 'USER': 'cltbld', 05:03:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:01 INFO - 'XPC_FLAGS': '0x0', 05:03:01 INFO - 'XPC_SERVICE_NAME': '0', 05:03:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:03:02 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-Q25CtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:03:02 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-H2pGsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:03:02 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-rHP9w0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:03:02 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-vWwnHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:03:02 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-Tcfdev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:03:02 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-zt9x9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:03:02 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-pp93cJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:03:02 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-ITwgDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:03:02 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-lZH7zK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:03:03 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-4pX5C0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:03:03 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-9Cw2bL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:03:03 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-ffSfZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:03:03 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-jz9rc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:03:03 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-c5IDEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:03 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-sY9sii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:03:03 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-c4VRqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:03:03 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-z1j3uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:03:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:03:03 INFO - Running setup.py install for manifestparser 05:03:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:03:04 INFO - Running setup.py install for mozcrash 05:03:04 INFO - Running setup.py install for mozdebug 05:03:04 INFO - Running setup.py install for mozdevice 05:03:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:03:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:03:04 INFO - Running setup.py install for mozfile 05:03:04 INFO - Running setup.py install for mozhttpd 05:03:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:03:04 INFO - Running setup.py install for mozinfo 05:03:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:03:04 INFO - Running setup.py install for mozInstall 05:03:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:03:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:03:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:03:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:03:05 INFO - Running setup.py install for mozleak 05:03:05 INFO - Running setup.py install for mozlog 05:03:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:03:05 INFO - Running setup.py install for moznetwork 05:03:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:03:05 INFO - Running setup.py install for mozprocess 05:03:05 INFO - Running setup.py install for mozprofile 05:03:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:03:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:03:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:03:05 INFO - Running setup.py install for mozrunner 05:03:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:03:06 INFO - Running setup.py install for mozscreenshot 05:03:06 INFO - Running setup.py install for moztest 05:03:06 INFO - Running setup.py install for mozversion 05:03:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:03:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:03:06 INFO - Cleaning up... 05:03:06 INFO - Return code: 0 05:03:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ba7e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaf8d95bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b892d30>, '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 0x10b6f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b88ab20>, '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.npNAZVvP6Z/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.INnG0e7s8m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 05:03:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:03:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.npNAZVvP6Z/Render', 05:03:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:06 INFO - 'HOME': '/Users/cltbld', 05:03:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:06 INFO - 'LOGNAME': 'cltbld', 05:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:06 INFO - 'MOZ_NO_REMOTE': '1', 05:03:06 INFO - 'NO_EM_RESTART': '1', 05:03:06 INFO - 'PAGER': '/bin/cat', 05:03:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:06 INFO - 'PWD': '/builds/slave/test', 05:03:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:06 INFO - 'SHELL': '/bin/bash', 05:03:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.INnG0e7s8m/Listeners', 05:03:06 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 05:03:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:06 INFO - 'USER': 'cltbld', 05:03:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:06 INFO - 'XPC_FLAGS': '0x0', 05:03:06 INFO - 'XPC_SERVICE_NAME': '0', 05:03:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:03:06 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-B3eTHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:03:06 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-enzmXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 05:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:03:06 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-TpeL_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:03:07 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)) 05:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:03:07 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-MlHfHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 05:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:03:07 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-ABtRWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:03:07 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)) 05:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:03:07 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-9cfr_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:03:07 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)) 05:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:03:07 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-fvfs1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:03:07 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-TCa1kD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:03:07 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-AgZlLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:03:07 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-ls9FLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:03:07 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-peDqG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:03:07 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-4xSg0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:03:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 05:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:03:08 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-ZXlOTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:03:08 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)) 05:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:03:08 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-BZUtEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:03:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 05:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:08 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-QKfKvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:08 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)) 05:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:03:08 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-OvErNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:03:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 05:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:03:08 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-Zlc5Bz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:03:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:03:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:03:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:03:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:03:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:03:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:03:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:11 INFO - Downloading blessings-1.6.tar.gz 05:03:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:03:11 INFO - Installing collected packages: blessings 05:03:11 INFO - Running setup.py install for blessings 05:03:11 INFO - Successfully installed blessings 05:03:11 INFO - Cleaning up... 05:03:11 INFO - Return code: 0 05:03:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:03:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:03:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:03:11 INFO - Reading from file tmpfile_stdout 05:03:11 INFO - Current package versions: 05:03:11 INFO - blessings == 1.6 05:03:11 INFO - blobuploader == 1.2.4 05:03:11 INFO - docopt == 0.6.1 05:03:11 INFO - functools32 == 3.2.3-2 05:03:11 INFO - jsonschema == 2.5.1 05:03:11 INFO - manifestparser == 1.1 05:03:11 INFO - mozInstall == 1.12 05:03:11 INFO - mozcrash == 0.17 05:03:11 INFO - mozdebug == 0.1 05:03:11 INFO - mozdevice == 0.48 05:03:11 INFO - mozfile == 1.2 05:03:11 INFO - mozhttpd == 0.7 05:03:11 INFO - mozinfo == 0.9 05:03:11 INFO - mozleak == 0.1 05:03:11 INFO - mozlog == 3.4 05:03:11 INFO - moznetwork == 0.27 05:03:11 INFO - mozprocess == 0.23 05:03:11 INFO - mozprofile == 0.28 05:03:11 INFO - mozrunner == 6.12 05:03:11 INFO - mozscreenshot == 0.1 05:03:11 INFO - mozsystemmonitor == 0.3 05:03:11 INFO - moztest == 0.7 05:03:11 INFO - mozversion == 1.4 05:03:11 INFO - psutil == 3.1.1 05:03:11 INFO - requests == 1.2.3 05:03:11 INFO - wsgiref == 0.1.2 05:03:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:03:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:12 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')]} 05:03:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:12 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 0x10ba7e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaf8d95bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b892d30>, '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 0x10b6f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b88ab20>, '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.npNAZVvP6Z/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.INnG0e7s8m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 05:03:12 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 05:03:12 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 05:03:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.npNAZVvP6Z/Render', 05:03:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:12 INFO - 'HOME': '/Users/cltbld', 05:03:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:12 INFO - 'LOGNAME': 'cltbld', 05:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:12 INFO - 'MOZ_NO_REMOTE': '1', 05:03:12 INFO - 'NO_EM_RESTART': '1', 05:03:12 INFO - 'PAGER': '/bin/cat', 05:03:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:12 INFO - 'PWD': '/builds/slave/test', 05:03:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:12 INFO - 'SHELL': '/bin/bash', 05:03:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.INnG0e7s8m/Listeners', 05:03:12 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 05:03:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:12 INFO - 'USER': 'cltbld', 05:03:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:12 INFO - 'XPC_FLAGS': '0x0', 05:03:12 INFO - 'XPC_SERVICE_NAME': '0', 05:03:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:12 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)) 05:03:12 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)) 05:03:12 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)) 05:03:12 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)) 05:03:12 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)) 05:03:12 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)) 05:03:12 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)) 05:03:12 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)) 05:03:12 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)) 05:03:12 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)) 05:03:12 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)) 05:03:12 INFO - Cleaning up... 05:03:12 INFO - Return code: 0 05:03:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:03:12 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')]} 05:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:12 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')]} 05:03:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:12 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 0x10ba7e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9f4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaf8d95bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b892d30>, '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 0x10b6f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b88ab20>, '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.npNAZVvP6Z/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.INnG0e7s8m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 05:03:12 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 05:03:12 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 05:03:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.npNAZVvP6Z/Render', 05:03:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:12 INFO - 'HOME': '/Users/cltbld', 05:03:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:12 INFO - 'LOGNAME': 'cltbld', 05:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:12 INFO - 'MOZ_NO_REMOTE': '1', 05:03:12 INFO - 'NO_EM_RESTART': '1', 05:03:12 INFO - 'PAGER': '/bin/cat', 05:03:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:12 INFO - 'PWD': '/builds/slave/test', 05:03:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:12 INFO - 'SHELL': '/bin/bash', 05:03:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.INnG0e7s8m/Listeners', 05:03:12 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 05:03:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:12 INFO - 'USER': 'cltbld', 05:03:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:12 INFO - 'XPC_FLAGS': '0x0', 05:03:12 INFO - 'XPC_SERVICE_NAME': '0', 05:03:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:03:12 INFO - Cleaning up... 05:03:12 INFO - Return code: 0 05:03:12 INFO - Running post-action listener: _resource_record_post_action 05:03:12 INFO - Running post-action listener: _start_resource_monitoring 05:03:12 INFO - Starting resource monitoring. 05:03:12 INFO - [mozharness: 2016-10-04 12:03:12.973126Z] Finished create-virtualenv step (success) 05:03:12 INFO - [mozharness: 2016-10-04 12:03:12.973929Z] Running install step. 05:03:12 INFO - Running pre-action listener: _resource_record_pre_action 05:03:12 INFO - Running main action method: install 05:03:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:03:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:03:13 INFO - Reading from file tmpfile_stdout 05:03:13 INFO - Detecting whether we're running mozinstall >=1.0... 05:03:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:03:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:03:13 INFO - Reading from file tmpfile_stdout 05:03:13 INFO - Output received: 05:03:13 INFO - Usage: mozinstall [options] installer 05:03:13 INFO - Options: 05:03:13 INFO - -h, --help show this help message and exit 05:03:13 INFO - -d DEST, --destination=DEST 05:03:13 INFO - Directory to install application into. [default: 05:03:13 INFO - "/builds/slave/test"] 05:03:13 INFO - --app=APP Application being installed. [default: firefox] 05:03:13 INFO - mkdir: /builds/slave/test/build/application 05:03:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:03:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 05:03:45 INFO - Reading from file tmpfile_stdout 05:03:45 INFO - Output received: 05:03:45 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 05:03:45 INFO - Running post-action listener: _resource_record_post_action 05:03:45 INFO - [mozharness: 2016-10-04 12:03:45.830909Z] Finished install step (success) 05:03:45 INFO - [mozharness: 2016-10-04 12:03:45.831049Z] Running run-tests step. 05:03:45 INFO - Running pre-action listener: _resource_record_pre_action 05:03:45 INFO - Running main action method: run_tests 05:03:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:03:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:03:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:03:45 INFO - 2016-10-04 05:03:45.845 screenresolution[1636:7529] starting screenresolution argv=screenresolution get 05:03:45 INFO - 2016-10-04 05:03:45.848 screenresolution[1636:7529] Display 0: 1600x1200x32@60 05:03:45 INFO - 2016-10-04 05:03:45.854 screenresolution[1637:7532] starting screenresolution argv=screenresolution list 05:03:45 INFO - Available Modes on Display 0 05:03:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:03:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:03:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:03:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:03:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:03:46 INFO - Intel Iris: 05:03:46 INFO - Chipset Model: Intel Iris 05:03:46 INFO - Type: GPU 05:03:46 INFO - Bus: Built-In 05:03:46 INFO - VRAM (Dynamic, Max): 1536 MB 05:03:46 INFO - Vendor: Intel (0x8086) 05:03:46 INFO - Device ID: 0x0a2e 05:03:46 INFO - Revision ID: 0x0009 05:03:46 INFO - Displays: 05:03:46 INFO - Display: 05:03:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:03:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:03:46 INFO - Display Serial Number: 1600x1200 60 05:03:46 INFO - Main Display: Yes 05:03:46 INFO - Mirror: Off 05:03:46 INFO - Online: Yes 05:03:46 INFO - Rotation: Supported 05:03:46 INFO - Return code: 0 05:03:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:03:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:03:46 INFO - Python 2.7.3 05:03:46 INFO - Return code: 0 05:03:46 INFO - grabbing minidump binary from tooltool 05:03:46 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')]} 05:03:46 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 0x10b892d30>, '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 0x10b6f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b88ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:03:46 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 05:03:46 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 05:03:46 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 05:03:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:03:46 INFO - Return code: 0 05:03:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:03:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:03:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:03:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:03:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:03:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fci21CAHT1mshEWyJQKfKQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--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 05:03:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fci21CAHT1mshEWyJQKfKQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0084 --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 05:03:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.npNAZVvP6Z/Render', 05:03:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:46 INFO - 'HOME': '/Users/cltbld', 05:03:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:46 INFO - 'LOGNAME': 'cltbld', 05:03:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:03:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:03:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:46 INFO - 'MOZ_NO_REMOTE': '1', 05:03:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:03:46 INFO - 'NO_EM_RESTART': '1', 05:03:46 INFO - 'PAGER': '/bin/cat', 05:03:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:46 INFO - 'PWD': '/builds/slave/test', 05:03:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:03:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:46 INFO - 'SHELL': '/bin/bash', 05:03:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.INnG0e7s8m/Listeners', 05:03:46 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 05:03:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:46 INFO - 'USER': 'cltbld', 05:03:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:46 INFO - 'XPC_FLAGS': '0x0', 05:03:46 INFO - 'XPC_SERVICE_NAME': '0', 05:03:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fci21CAHT1mshEWyJQKfKQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--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 05:03:46 INFO - mozversion application_buildid: 20161004023801 05:03:46 INFO - mozversion application_changeset: 581e2e9b9d79cbaf4e333447e5966e03b92a2eb7 05:03:46 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:03:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:03:46 INFO - mozversion application_name: Firefox 05:03:46 INFO - mozversion application_remotingname: firefox-dev 05:03:46 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:03:46 INFO - mozversion application_vendor: Mozilla 05:03:46 INFO - mozversion application_version: 51.0a2 05:03:46 INFO - mozversion platform_buildid: 20161004023801 05:03:46 INFO - mozversion platform_changeset: 581e2e9b9d79cbaf4e333447e5966e03b92a2eb7 05:03:46 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:03:46 INFO - mozversion platform_version: 51.0a2 05:03:46 INFO - using testdate: 1475582626 05:03:46 INFO - actual date: 1475582626 05:03:46 INFO - starting webserver on 'localhost:49274' 05:03:46 INFO - SUITE-START | Running 2 tests 05:03:46 INFO - TEST-START | dromaeo_css 05:03:46 INFO - operating with platform_type : mac_ 05:03:46 INFO - Initialising browser for dromaeo_css test... 05:03:46 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmp68oSdH/profile http://localhost:49274/getInfo.html) 05:03:48 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 05:03:48 INFO - PROCESS | 1647 | colorDepth:24 05:03:48 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 05:03:48 INFO - PROCESS | 1647 | __metrics 05:03:49 INFO - PROCESS | 1647 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:03:49 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:03:49 INFO - TEST-INFO | 1647: exit 0 05:03:49 INFO - Browser initialized. 05:03:49 INFO - Running cycle 1/1 for dromaeo_css test... 05:03:49 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmp68oSdH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:04:01 INFO - PROCESS | 1649 | RSS: Main: 219402240 05:04:01 INFO - PROCESS | 1649 | 05:04:53 INFO - PROCESS | 1649 | 1475582693330 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:07:04 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 05:07:07 INFO - PROCESS | 1649 | RSS: Main: 426516480 05:07:07 INFO - PROCESS | 1649 | 05:10:10 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 05:10:10 INFO - PROCESS | 1649 | RSS: Main: 349270016 05:10:10 INFO - PROCESS | 1649 | 05:13:13 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 05:13:13 INFO - PROCESS | 1649 | RSS: Main: 319512576 05:13:13 INFO - PROCESS | 1649 | 05:16:16 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 05:16:16 INFO - PROCESS | 1649 | RSS: Main: 342749184 05:16:16 INFO - PROCESS | 1649 | 05:19:20 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 05:19:20 INFO - PROCESS | 1649 | RSS: Main: 317919232 05:19:20 INFO - PROCESS | 1649 | 05:22:23 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 05:22:23 INFO - PROCESS | 1649 | RSS: Main: 449220608 05:22:23 INFO - PROCESS | 1649 | 05:22:23 INFO - PROCESS | 1649 | __start_tp_report 05:22:23 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 05:22:23 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 05:22:23 INFO - PROCESS | 1649 | |i|pagename|runs| 05:22:23 INFO - PROCESS | 1649 | |0;dojo.html;2879.712028797122;3166.762492813039;3372.64587218342;3390.13551544356;3439.7936123832574;5685.829425117248;5798.246227990366;5821;5822.737976791044;5827.9999999999945;5671.347795003576;5691.032524470839;5705.4294570542925;5740;5747.42525747425;5209.7134657593815;5215.061288967984;5230.7646155922885;5245.44922783108;5270.894582108355;5218.843434696965;5221.503957124067;5235.345581802275;5253.842384728464;5317;5301.575873930095;5325.147976323789;5360.410354860962;5366.570674346043;5405.027095122877;5309.548688361475;5315.73421328932;5327.334083239595;5339.919901201485;5353.705546194958;5143.074246635604;5211.7133557654315;5284.101702710548;5288.391834938954;5321.414644389114;5648.406917273668;5751.166080918243;5752.913706294409;5756.884862302731;5769.278840144982;6152.753889844401;6179;6194.597351172204;6217.87564248717;6236.719347629368;6170.784022559234;6241.65670888101;6274.968625156891;6295.748170073191;6314.62112273265;4899.926501102486;5829.679367634736;5838.124281357788;5846.766129354778;5904.2029326040865;6249.78125765596;6311.779087731908;6324.494040476751;6324.557280990379;6329.588576742497;6101.542384321105;6133.355997620186;6149;6224.1597384352535;6229.003359462555;6314.336994615591;6318.020706790455;6342.238931328178;6357.427831495188;6369.681515924185;6115.541334399938;6141.7543298268465;6306.747730090837;6307.905381419282;6323.715432805535;6156.107364432132;6214.875702485925;6252.062190671436;6277.403646653561;6346.809595712136;4968;4968.627352948543;4976.925346119811;4988.800447982113;4997.250412438163;4407.757573333497;4425.579569940851;4483.08096840147;4486.798094085774;4501.932471012938;4596.287575425815;5750.769969201185;5830.504407125357;5834.620749651259;5851.180834683148;6325.873482530324;6355.459785918156;6360.14138091361;6361.936380636227;6376.426121649074;5886.0288052471715;5908.793192238337;5932.673702946293;5932.703364831741;5958.940410595926;5352.545033672103;5368.382635996911;5404.0272750905215;5468.781248750085;5471.835844924659;6286.371362863769;6310.968445157745;6335.90496142549;6382.393672601095;6407.199100112486;6303.338149494421;6362.363763623601;6378.2027246592315;6393.360663933569;6403.423691867754;5011.972545628065;5384.273123128484;6207;6290.339514350927;6389.87220255583;5179.430262671028;6144.924638188389;6216.44052035319;6257.342978987141;6270.2475702915945;4828.493008234085;5443.891122177613;6136.447719705248;6327.651979141191;6342.587731797418;5895.587308888336;6122;6158.414950579688;6181.320054794059;6193.380661933951;6063.242094738158;6084.239470066242;6112.169143789106;6115.179495343419;6128.877422451436;6021.939780602138;6060.151578779062;6070.271567411939;6070.484008859296;6077;5989.071693887455;6107.4197951194565;6108.57239993214;6192.721327540362;6214.005759078525;5855.560832937462;5968.46283834457;5983.34183239852;5993.760249589967;5995.250593675791 05:22:23 INFO - PROCESS | 1649 | |1;ext.html;491.5207672519294;531.5720844720001;540.087252543202;549.1680104641466;559.3008739076153;30725.38549229014;32917.67082329173;40322.7983860081;41512.58487415125;43674;42672.35991460123;42785.57214427855;42807.92980175489;42957;43009.569904300944;8669.479831210148;9676.129148376645;9863.063009014168;9864.753381165492;9902.356346837432;8741.650333986665;11948.283103013804;12269.018478521697;12290.508379664847;12305.569305074325;12096.637100886988;12171.57399491018;12179.147459677826;12185.147039707179;12241.26552406854;8719.258862996652;8909.287257019423;12035.578754743587;12094.697632559168;12121;11698.122640801974;12024.939875300655;12034.157608967376;12288;12303.876961230362;41113.944302784745;41582.37626435606;41593.1681366374;41612.79193604013;41672.374914376305;3326.7172290355347;3342.8997130086136;3367.5453813735076;3510.3505851417312;3673.669369756735;29500.852495737385;29581;29640.555391669142;30509.847450762827;30769.84615076933;3118.9064328070194;3382.7124694401004;3389.7288216942834;3420.1791570023015;3422.4524076147945;454159;455327;455553;456619;457232.713836432;56692.43307566954;57040.429595703514;57077.71461142751;57118;57121.71439142778;60227.69886150629;60238.39761602328;60278;60305.69847150736;60424;16498.75251871223;16769.161541922855;16786.076765777754;16800.991940483367;16802.41191558314;11768.411579421167;11888.643340699793;11902;13051.21692698441;13166.605001849959;15485.845141548665;15721.842781572037;15751.842481575037;16128.790340724492;16248.268827902773;6711.516738806673;6828.2147553031045;6830.7609233676585;6906.136732908387;6935.826604334932;844.5861527851308;920.5167287174287;931.9813603727888;978.505854543451;1063.8563793887881;28539;29373.26566835846;29423.558646620317;30231.395372092877;30317.848410757804;1061.77702682436;1067.0183431243274;1125.6172901213627;1135.9602413915472;1240.522398876421;15231.390744370323;15242.466513671969;15281.617959550878;15490.62816995724;15503.99224050433;626923;631199;633981;635451;638690;56048.719756400955;56149.31552053445;56178;56347.43652563422;56361;1247.7504499100216;1276.8723127687158;1277.125169259042;1384.190248704499;1402.9859701403059;26226.73773262243;30509.847450762605;32078.679213207568;32272;32320;48742.78143046452;49104.75447622739;49230.76923076952;49235.52293431203;49445.752771237356;487078;493426;494990;495047;496674;25347;26132.73867261303;26187.083452079085;39442.40836387399;39843.40234896537;44977.77511112423;45857.541424585324;46031.76984115058;46137;46476;36105.63894361128;38360.616393835706;38638.02600349337;38665.226695466496;39648.80175599219;38384.84845454641;39001.2199756009;39268.80365598154;41896.371554427315;43658.34512482379;35391.646083538835;39377.60622393739;41340.37989430221;42332.788336058125;42486.78756606197;40371.59628403679;40491.79754101211;40878.38682419706;40902.18195636011;41601;30834.229144271572;31017.224569385948;31185.53221701722;31279.687203127676;31728.206794830316 05:22:23 INFO - PROCESS | 1649 | |2;jquery.html;350.9245512214873;357.1677990282641;366.96513831186047;369.0681030398244;381.2565497280304;15265.313060912258;15376.077435353873;16535.007899526023;21194;21631.891840540775;20300.695489567668;20557.794422055777;21198.470038249012;21323.040463179157;21446.678299825515;4711.835085771999;5941.762329506814;6208.906866397007;6211.161493198428;6218.4714299284615;5970.73131709072;6017.308009578911;6190.164327815754;6204.255489341285;6205.131281620555;5984.072468767348;6031.758729650809;6043.244594425697;6119.510439164878;6151.661658608775;5865.442782935615;6001.279846418458;6039.335673075958;6049.425304596057;6056.515478761688;5228.686278823283;5268.394134674523;5480.068388373986;5547.944520554784;5572.442755724435;13258.801117983237;13528.59414217575;13531.661708457268;22548.210812621644;25187.62218566723;2188.803007729312;2188.8686678799163;2239.283429302624;2372.146027430124;2929.4580502607087;16293.59266018347;16395.59011024722;17793.373722832028;17807.19867605961;18348.99080550569;1694.6441247338073;1890.905454727272;1918.7793403758608;2070.1822780001817;2139.839512036588;104989.47505262424;136220.31889840585;138341.61658383388;146438.26780866028;152764;21320.573588528452;21926.45183870416;22050.558988820132;22149.557008859734;22348.88255587214;34656.65343346585;35224.82387588046;35288.29423411517;35616.821915890774;36212.09469763277;10877.619283325204;11204.159688023268;11278.041366483942;11336.886631133748;11527.76944461123;9210.447373157633;9217.210783188377;9256.259499240045;9372.812543749087;9447.291453140904;8142.430029897969;9668.371555848847;9793.167580755573;9857.239972807625;9891;2893.69616190297;3137.388209299165;3654.3007501511393;3706.425504046877;3828.679105708526;796.5340275938524;926.1571969507715;952.066974365126;972.6936015155203;991.6166947108743;20365.19098609537;21652.891735541536;21725.348239552837;21746;21779.346619601438;888.7822483491586;906.8866391701038;909.286210324905;944.1313991128178;956.7753275806979;8872.822543549093;11295.322280663186;11306.152038597138;11338.149638777124;11352.318860868374;607839;610030;621630;621768;622802;134534;136562.31718841344;138332.61667383197;139232;140200.2989985064;948.5873644964324;957.2198658093631;962.6245764151986;963.1283688262134;963.3834346018554;18706.438806835817;18956.146973386505;19395.030248487237;19403.805961940765;19409.93245371518;55382.72308638592;56411;56615.150772737616;56790;57769;77991.75444806177;80712.3779131145;80809.59595201987;81294;84394.57802710947;8056.274935255855;8141.959290203511;8302;8330.166983301622;8458.196471335214;11509;12361.876381236072;12643.304618246084;12707.04697147736;12870.420831062438;5435.755391007335;10602.575896964343;10964.890351096707;11063.617047869016;11295.3787541686;7637.8925055865475;10868.293560918515;11039.116870650168;11371.886281137082;11488.597899073826;11348.921852424006;11575.536978521102;11644.2431241969;11725.120615953667;11872.940635297115;7007.229204787367;7128.679209435484;7353.455774287246;7482.064741907262;8359.456635318686;10703.464826758474;10972.670819875417;11142.72143196394;11182.32906025641;11244.775104498029 05:22:23 INFO - PROCESS | 1649 | |3;mootools.html;1489.6871656952044;1502.3614963640453;1671.557037385093;1839.089650622942;1841.2542920117357;8450.788730281738;8927.598258078386;8939.821203575924;8939.865902011476;8956.149165829253;7821.726239581616;8107.878381824263;8519.914800852006;8781.91218087819;8805.91194088059;2377.3699969508093;2403.471236328005;2410.09621391978;2411.457422080027;2412.746661600533;2008.4476768888526;2374.7862692357685;2418.093215044358;2419.370963549481;2424.151546958568;2356.26955643751;2364.172539611131;2372.7034120734907;2384.4158181245534;2389.3668177932773;2331.5336932613545;2338.894749736266;2390.95218095638;2397.3886658902043;2401.1595941420537;2361.480474295652;2373.4659701567184;2380.0955636858057;2381.1546900850294;2387.844790088656;8835.160659737314;8863.778405539848;8941.374103812735;8955.37312388133;8961.462312261285;5218.791248350061;5385.3268341457315;5390.6226564140525;5397.595180361489;5417.945820541823;3612.6026137124895;3638.43604241343;3661.7802931824176;3710.07248187953;3715.2198038411966;1101.9724506887392;1102.0962810495398;1104.7127746785893;1118.7762447510531;1125.7861006408757;11692.181547291693;11805.645830625095;11806.291622502591;11809.23239989398;11815.172937894351;4615.838445654386;4703.576678098988;4718.363020992191;4730.665994825507;4881;9893.109620134222;10011.549480273405;10027.899721002843;10027.949860250652;10034.74913127163;5299.4700529946695;5300.390455097636;5312.654677445954;5313.946860531345;5322.787088516416;4251.128518653669;4447.710898791633;4599.5400459953735;4857.149998750276;4884.242942343943;3891.416287556889;3901.1027463683513;4038.757674539537;4047.3321901886447;4056.3915412688334;1113.8162203236536;1123.2421260726935;1265.7468506298776;1286.1061562214359;1290.5547586082787;867.2888231649987;917.825899899607;927.355487935878;931.38993958957;980.568549838069;5776.018076926848;5815.505682017076;5925.525957923356;6056.424639659225;6153.7230824613;438.87053319270893;458.38805195064293;458.9128065667579;462.6715032327086;470.09272104837993;3944;3978.6817054635558;3992.2215168041953;4023.8994025149605;4092;10551.472426378803;10610.151187905103;10814.837777433344;10955.287906286067;10957.726056848642;10874.401907895142;10879.83680244797;10883.564657413774;10887.945560272148;10907;7901.486403383877;8210.384221183434;8292.83414331722;8373.95813020931;8393.748187554384;5974;6006.969965150146;6012.8797424052145;6147.047207682816;6200.472959798287;9800.607975680892;10011.849822252818;10078.395296282246;10221.33561318512;10332.431716255678;10319.793604128026;10352.741181470223;10409.9479502602;10420.583176673152;10461.424621645883;6957.304269573205;7172.713091476283;7472.40220782347;7599.126100498514;7608.923910760822;7238.203797582367;7531.849363012819;8269.338452923872;8341.040780310099;8455.492670439793;7414.62926853666;7533.962330188314;7560.281773231534;7590.468667193243;7663.233676632292;7297.854042919218;7325.926740732524;7340.596267205355;7373.889391659237;7485.1017877855;6993.160820701549;7031.43748500129;7100.715971361088;7104.289571043061;7114.822129446598;4307.65538756905;4903.313536104877;4959.97520012412;5015.17249653803;5082.034413461431;4963.70217786934;4978.228374601942;4979.502049795136;5149.9227511586605;5161.432242453252 05:22:23 INFO - PROCESS | 1649 | |4;prototype.html;301.6621384049864;304.9070033639739;310.7467414057543;319.1606076020067;319.7633751024243;4434.445694288214;5237.612032811298;5289.259503669489;5303.337082864642;5310.522053015228;4068.8779336619873;4883.316335713003;5103.617228707843;5122.974385128069;5251.317328747267;3968.285708572456;3983.223271462066;3986.4418981342637;3991.121953170305;4015.07653239755;3403.4724617684296;3881.961180388202;3974.3641017437217;3991.960080399188;4034.9596504034876;3523.344028306705;3684.465752465891;3937.98031009846;3962.5839286874893;3972.82122304497;3987.7009224308295;4012.498437695288;4024.175044115964;4026.778527181004;4030.8992275193064;3482.2687235680537;3482.9129271768156;3485.372632926072;3528.3825330567306;3530.452779819132;4705.294205869147;5109.8722531937;5121.156383701865;5149.30484384607;5157.762137087109;3889.747166434201;4247.341662042389;4526.52471490492;4596.460185837748;4607.608353289975;4628.39830821991;5563;5583.581231407661;5594.258813181553;5602.691851948141;3231;3814.256220037094;3814.4850445189822;3826.4834247376525;3839.0978120141745;5383.757730902119;5431.266778984826;5602.523785478198;5847.754496254577;5847.976604094267;3236.5145228215956;3802.7718336899875;3825.9096157594954;3828.904277393032;3836.3094642964534;3289.588801399825;3442.662245570549;3619.2761447710564;3710.7773533587533;3841.2125514269505;3835;4069.023434375788;4305.987750976166;4381.342798580238;4524.592786649151;5018.799248030111;5281.39263984639;5510.669359838423;5512.503874651301;5514;1205.9638210853689;1294.6180876641413;1304.3282709404664;1321.478016183602;1321.4780161836213;725.3979197266257;829.6722794496261;861.5175501719058;863.6718047142045;866.7963028688254;4142.875713728593;4295.723266668608;4501.279795232747;4736.621070314367;5023.748812559357;5683.687397193112;5696.857578560486;5697.9430205698245;5712.857178570486;5743.597948143673;4716.245400735866;4783.545563171493;5165.66423182492;5199.896002079937;5199.974000129975;2404.7955923746676;2965.569992351097;2975.4495418347674;3014.8341841198508;3022.818630882154;5023.497650234947;5622.907400929473;5631.352394474688;5904.663864916309;5949.970250148722;5701.686407247558;5789.218455508537;5797.652140871477;5835.649861008353;5853;5853;5886.558508111909;5895.911561326584;5896.882062358729;5923.822285331447;5349.1976203569775;5380.901448435192;5652.971735141298;5741.741621626953;5754.69105264483;5083.38999320084;5564.054110801093;5572.801847602785;5584.497395234448;5595.8880822384135;4725.621950244041;5837.270341207349;5887.911681324869;5889.792592518438;5918.23063001807;3138.8430578471443;3210.630777460622;3492.6856582907662;3812.199438117915;3822.6177382261553;5340.866478338073;5610.547869949591;5676.602637815313;5678.2050512929045;5688.715564221855;5536.944630553804;5555.861103472445;5584.357798853021;5612.691301978431;5640.71796410186;4645.420557010632;4997.2021263839015;5077.543021127968;5138.3577052868395;5496.570891568301;4332.935005974976;5389.56883449331;5405.108157154025;5416.452223793422;5465.508104270635;4777.737224452689;5414.269073675004;5435.728213589226;5545.750441230235;5651.689157096399;4705.976470117627;5354.892902142014;5432.945670543244;5450.618456707993;5462.590305727007 05:22:23 INFO - PROCESS | 1649 | |5;yui.html;696.7526528082531;729.9489035767492;752.9940715394106;794.0788685125256;794.542099352394;14764.187969661678;17046.914765426187;17474.737878931825;17751.28994840205;17795.110244487787;16342.019478831278;16775.664486710288;16946.83053169471;16962.575935601617;17030.063346515937;821.4660470694037;858.6222062292602;859;860.1054902900976;862.5428522882883;674.6222115615271;680.7277089164324;699.7900629811062;842.465034702965;853.6201390381283;896.9461832290051;898.7079199260234;898.8651702244683;899.2850683706437;900.3742399032675;894.5884892949251;894.8702438146497;895.7223260789143;896.4128495835238;900.8828852249231;521.0178812937602;536.9301990741218;644.7711062572766;667.7362441835447;668.1147479589515;15217.6195595111;15802.60493487672;15821.208939553091;15821.92089039559;15862.36550537977;13510.256935868523;13716.931415342959;13752.793708094387;13975.301234938313;13978.510752123628;12608;12738.80891786624;12803.071859572115;12834.229946203257;13113.672158196121;4408.237202774934;4496.595306422405;4606.746628935407;4648.209804333272;4654.325122857201;120647.3967630165;120933.79066209313;121966.17050744245;121980.17029744561;123790;10386.688399348031;10707.411092389993;10710.303830251165;10846.891531084746;11158.386288754196;20850.687239691415;20925.895370523354;21025.15899364039;21044.684329735068;21081.78918210829;7750.612469376509;7767.72812951544;7768.65041073153;7798;7945.801354966056;4260.744355338689;4321.459817522809;4348.1286346239995;4411.470623525198;4506.2564676828615;3460.3425349184076;3571.196480791801;3576.803275819803;3578.6779189873037;3579.803110828929;668.6021817018964;674.0664180110582;675.4393853101914;713.864365770502;751.8345963887936;553.3111276460752;604.4529700620946;616.3035769580346;638.9137466442064;677.2076670295766;7908.604569771488;8981;9501.862428606903;9916.752081198028;10050.899491004997;560.1738333034338;662.6322391073;687.3229868579446;693.5180049865396;697.9336962988508;4548.681592288508;4648.488666246778;4708.670393072521;4715.104130215248;4782.52174782519;145740;145882;151228;157314;162425.18787405986;131347.68652313546;135295;136011;137326.31336843251;138867;111501.99999999837;113009;115288.2706759416;116524;118237;8674.479531228146;8983.595738191927;8990.955045224731;9080.727578172666;9169.816603668023;65041.34958650542;65121;65429.67285163734;66665.00002499869;68392.63214735777;83638.3272334562;99043.00956990338;103150.48424757828;104026;106833;12117.636470905887;12128.575499857816;12147.331896745764;12330.938345308216;12423.62729118128;12558.246505209716;12881;13143.579317544829;13276.867231327564;13374.933125334312;12172.817407738714;12443;12735.108542401942;12763.234205947672;13810.964177686512;13613.11514751538;13723.245221512912;13744.587662370144;14169.574912752634;14187.290635468391;12636.025164965211;12977.545785897448;13486.325683715972;13932.512362067278;14571.198584077978;9435.481048542397;11697.941510292394;11705.824412633647;11861.822072668745;11888.28670279786;10081.848772268275;10584.41785701763;11730.88269117298;11781.52873885035;11870.406479676154 05:22:23 INFO - PROCESS | 1649 | __end_tp_report 05:22:23 INFO - PROCESS | 1649 | __start_cc_report 05:22:23 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,2284 05:22:23 INFO - PROCESS | 1649 | __end_cc_report 05:22:23 INFO - PROCESS | 1649 | __startTimestamp1475583743977__endTimestamp 05:22:23 INFO - PROCESS | 1649 | 05:22:23 INFO - PROCESS | 1649 | ------- Summary: start ------- 05:22:23 INFO - PROCESS | 1649 | Number of tests: 6 05:22:23 INFO - PROCESS | 1649 | 05:22:23 INFO - PROCESS | 1649 | [#0] dojo.html Cycles:165 Average:5751.03 Median:5968.46 stddev:667.63 (11.2%) stddev-sans-first:630.54 05:22:23 INFO - PROCESS | 1649 | Values: 2879.7 3166.8 3372.6 3390.1 3439.8 5685.8 5798.2 5821.0 5822.7 5828.0 5671.3 5691.0 5705.4 5740.0 5747.4 5209.7 5215.1 5230.8 5245.4 5270.9 5218.8 5221.5 5235.3 5253.8 5317.0 5301.6 5325.1 5360.4 5366.6 5405.0 5309.5 5315.7 5327.3 5339.9 5353.7 5143.1 5211.7 5284.1 5288.4 5321.4 5648.4 5751.2 5752.9 5756.9 5769.3 6152.8 6179.0 6194.6 6217.9 6236.7 6170.8 6241.7 6275.0 6295.7 6314.6 4899.9 5829.7 5838.1 5846.8 5904.2 6249.8 6311.8 6324.5 6324.6 6329.6 6101.5 6133.4 6149.0 6224.2 6229.0 6314.3 6318.0 6342.2 6357.4 6369.7 6115.5 6141.8 6306.7 6307.9 6323.7 6156.1 6214.9 6252.1 6277.4 6346.8 4968.0 4968.6 4976.9 4988.8 4997.3 4407.8 4425.6 4483.1 4486.8 4501.9 4596.3 5750.8 5830.5 5834.6 5851.2 6325.9 6355.5 6360.1 6361.9 6376.4 5886.0 5908.8 5932.7 5932.7 5958.9 5352.5 5368.4 5404.0 5468.8 5471.8 6286.4 6311.0 6335.9 6382.4 6407.2 6303.3 6362.4 6378.2 6393.4 6403.4 5012.0 5384.3 6207.0 6290.3 6389.9 5179.4 6144.9 6216.4 6257.3 6270.2 4828.5 5443.9 6136.4 6327.7 6342.6 5895.6 6122.0 6158.4 6181.3 6193.4 6063.2 6084.2 6112.2 6115.2 6128.9 6021.9 6060.2 6070.3 6070.5 6077.0 5989.1 6107.4 6108.6 6192.7 6214.0 5855.6 5968.5 5983.3 5993.8 5995.3 05:22:23 INFO - PROCESS | 1649 | 05:22:23 INFO - PROCESS | 1649 | [#1] ext.html Cycles:180 Average:67217.80 Median:39323.20 stddev:142006.66 (361.1%) stddev-sans-first:142316.65 05:22:23 INFO - PROCESS | 1649 | Values: 491.5 531.6 540.1 549.2 559.3 30725.4 32917.7 40322.8 41512.6 43674.0 42672.4 42785.6 42807.9 42957.0 43009.6 8669.5 9676.1 9863.1 9864.8 9902.4 8741.7 11948.3 12269.0 12290.5 12305.6 12096.6 12171.6 12179.1 12185.1 12241.3 8719.3 8909.3 12035.6 12094.7 12121.0 11698.1 12024.9 12034.2 12288.0 12303.9 41113.9 41582.4 41593.2 41612.8 41672.4 3326.7 3342.9 3367.5 3510.4 3673.7 29500.9 29581.0 29640.6 30509.8 30769.8 3118.9 3382.7 3389.7 3420.2 3422.5 454159.0 455327.0 455553.0 456619.0 457232.7 56692.4 57040.4 57077.7 57118.0 57121.7 60227.7 60238.4 60278.0 60305.7 60424.0 16498.8 16769.2 16786.1 16801.0 16802.4 11768.4 11888.6 11902.0 13051.2 13166.6 15485.8 15721.8 15751.8 16128.8 16248.3 6711.5 6828.2 6830.8 6906.1 6935.8 844.6 920.5 932.0 978.5 1063.9 28539.0 29373.3 29423.6 30231.4 30317.8 1061.8 1067.0 1125.6 1136.0 1240.5 15231.4 15242.5 15281.6 15490.6 15504.0 626923.0 631199.0 633981.0 635451.0 638690.0 56048.7 56149.3 56178.0 56347.4 56361.0 1247.8 1276.9 1277.1 1384.2 1403.0 26226.7 30509.8 32078.7 32272.0 32320.0 48742.8 49104.8 49230.8 49235.5 49445.8 487078.0 493426.0 494990.0 495047.0 496674.0 25347.0 26132.7 26187.1 39442.4 39843.4 44977.8 45857.5 46031.8 46137.0 46476.0 36105.6 38360.6 38638.0 38665.2 39648.8 38384.8 39001.2 39268.8 41896.4 43658.3 35391.6 39377.6 41340.4 42332.8 42486.8 40371.6 40491.8 40878.4 40902.2 41601.0 30834.2 31017.2 31185.5 31279.7 31728.2 05:22:23 INFO - PROCESS | 1649 | 05:22:23 INFO - PROCESS | 1649 | [#2] jquery.html Cycles:180 Average:37563.82 Median:17787.87 stddev:103366.26 (581.1%) stddev-sans-first:103618.46 05:22:23 INFO - PROCESS | 1649 | Values: 350.9 357.2 367.0 369.1 381.3 15265.3 15376.1 16535.0 21194.0 21631.9 20300.7 20557.8 21198.5 21323.0 21446.7 4711.8 5941.8 6208.9 6211.2 6218.5 5970.7 6017.3 6190.2 6204.3 6205.1 5984.1 6031.8 6043.2 6119.5 6151.7 5865.4 6001.3 6039.3 6049.4 6056.5 5228.7 5268.4 5480.1 5547.9 5572.4 13258.8 13528.6 13531.7 22548.2 25187.6 2188.8 2188.9 2239.3 2372.1 2929.5 16293.6 16395.6 17793.4 17807.2 18349.0 1694.6 1890.9 1918.8 2070.2 2139.8 104989.5 136220.3 138341.6 146438.3 152764.0 21320.6 21926.5 22050.6 22149.6 22348.9 34656.7 35224.8 35288.3 35616.8 36212.1 10877.6 11204.2 11278.0 11336.9 11527.8 9210.4 9217.2 9256.3 9372.8 9447.3 8142.4 9668.4 9793.2 9857.2 9891.0 2893.7 3137.4 3654.3 3706.4 3828.7 796.5 926.2 952.1 972.7 991.6 20365.2 21652.9 21725.3 21746.0 21779.3 888.8 906.9 909.3 944.1 956.8 8872.8 11295.3 11306.2 11338.1 11352.3 607839.0 610030.0 621630.0 621768.0 622802.0 134534.0 136562.3 138332.6 139232.0 140200.3 948.6 957.2 962.6 963.1 963.4 18706.4 18956.1 19395.0 19403.8 19409.9 55382.7 56411.0 56615.2 56790.0 57769.0 77991.8 80712.4 80809.6 81294.0 84394.6 8056.3 8142.0 8302.0 8330.2 8458.2 11509.0 12361.9 12643.3 12707.0 12870.4 5435.8 10602.6 10964.9 11063.6 11295.4 7637.9 10868.3 11039.1 11371.9 11488.6 11348.9 11575.5 11644.2 11725.1 11872.9 7007.2 7128.7 7353.5 7482.1 8359.5 10703.5 10972.7 11142.7 11182.3 11244.8 05:22:23 INFO - PROCESS | 1649 | 05:22:23 INFO - PROCESS | 1649 | [#3] mootools.html Cycles:180 Average:5734.98 Median:2539.25 stddev:3245.22 (127.8%) stddev-sans-first:3238.65 05:22:23 INFO - PROCESS | 1649 | Values: 1489.7 1502.4 1671.6 1839.1 1841.3 8450.8 8927.6 8939.8 8939.9 8956.1 7821.7 8107.9 8519.9 8781.9 8805.9 2377.4 2403.5 2410.1 2411.5 2412.7 2008.4 2374.8 2418.1 2419.4 2424.2 2356.3 2364.2 2372.7 2384.4 2389.4 2331.5 2338.9 2391.0 2397.4 2401.2 2361.5 2373.5 2380.1 2381.2 2387.8 8835.2 8863.8 8941.4 8955.4 8961.5 5218.8 5385.3 5390.6 5397.6 5417.9 3612.6 3638.4 3661.8 3710.1 3715.2 1102.0 1102.1 1104.7 1118.8 1125.8 11692.2 11805.6 11806.3 11809.2 11815.2 4615.8 4703.6 4718.4 4730.7 4881.0 9893.1 10011.5 10027.9 10027.9 10034.7 5299.5 5300.4 5312.7 5313.9 5322.8 4251.1 4447.7 4599.5 4857.1 4884.2 3891.4 3901.1 4038.8 4047.3 4056.4 1113.8 1123.2 1265.7 1286.1 1290.6 867.3 917.8 927.4 931.4 980.6 5776.0 5815.5 5925.5 6056.4 6153.7 438.9 458.4 458.9 462.7 470.1 3944.0 3978.7 3992.2 4023.9 4092.0 10551.5 10610.2 10814.8 10955.3 10957.7 10874.4 10879.8 10883.6 10887.9 10907.0 7901.5 8210.4 8292.8 8374.0 8393.7 5974.0 6007.0 6012.9 6147.0 6200.5 9800.6 10011.8 10078.4 10221.3 10332.4 10319.8 10352.7 10409.9 10420.6 10461.4 6957.3 7172.7 7472.4 7599.1 7608.9 7238.2 7531.8 8269.3 8341.0 8455.5 7414.6 7534.0 7560.3 7590.5 7663.2 7297.9 7325.9 7340.6 7373.9 7485.1 6993.2 7031.4 7100.7 7104.3 7114.8 4307.7 4903.3 4960.0 5015.2 5082.0 4963.7 4978.2 4979.5 5149.9 5161.4 05:22:24 INFO - PROCESS | 1649 | 05:22:24 INFO - PROCESS | 1649 | [#4] prototype.html Cycles:180 Average:4455.32 Median:5080.47 stddev:1396.29 (27.5%) stddev-sans-first:1364.96 05:22:24 INFO - PROCESS | 1649 | Values: 301.7 304.9 310.7 319.2 319.8 4434.4 5237.6 5289.3 5303.3 5310.5 4068.9 4883.3 5103.6 5123.0 5251.3 3968.3 3983.2 3986.4 3991.1 4015.1 3403.5 3882.0 3974.4 3992.0 4035.0 3523.3 3684.5 3938.0 3962.6 3972.8 3987.7 4012.5 4024.2 4026.8 4030.9 3482.3 3482.9 3485.4 3528.4 3530.5 4705.3 5109.9 5121.2 5149.3 5157.8 3889.7 4247.3 4526.5 4596.5 4607.6 4628.4 5563.0 5583.6 5594.3 5602.7 3231.0 3814.3 3814.5 3826.5 3839.1 5383.8 5431.3 5602.5 5847.8 5848.0 3236.5 3802.8 3825.9 3828.9 3836.3 3289.6 3442.7 3619.3 3710.8 3841.2 3835.0 4069.0 4306.0 4381.3 4524.6 5018.8 5281.4 5510.7 5512.5 5514.0 1206.0 1294.6 1304.3 1321.5 1321.5 725.4 829.7 861.5 863.7 866.8 4142.9 4295.7 4501.3 4736.6 5023.7 5683.7 5696.9 5697.9 5712.9 5743.6 4716.2 4783.5 5165.7 5199.9 5200.0 2404.8 2965.6 2975.4 3014.8 3022.8 5023.5 5622.9 5631.4 5904.7 5950.0 5701.7 5789.2 5797.7 5835.6 5853.0 5853.0 5886.6 5895.9 5896.9 5923.8 5349.2 5380.9 5653.0 5741.7 5754.7 5083.4 5564.1 5572.8 5584.5 5595.9 4725.6 5837.3 5887.9 5889.8 5918.2 3138.8 3210.6 3492.7 3812.2 3822.6 5340.9 5610.5 5676.6 5678.2 5688.7 5536.9 5555.9 5584.4 5612.7 5640.7 4645.4 4997.2 5077.5 5138.4 5496.6 4332.9 5389.6 5405.1 5416.5 5465.5 4777.7 5414.3 5435.7 5545.8 5651.7 4706.0 5354.9 5432.9 5450.6 5462.6 05:22:24 INFO - PROCESS | 1649 | 05:22:24 INFO - PROCESS | 1649 | [#5] yui.html Cycles:180 Average:26009.00 Median:21034.92 stddev:41921.87 (199.3%) stddev-sans-first:41996.39 05:22:24 INFO - PROCESS | 1649 | Values: 696.8 729.9 753.0 794.1 794.5 14764.2 17046.9 17474.7 17751.3 17795.1 16342.0 16775.7 16946.8 16962.6 17030.1 821.5 858.6 859.0 860.1 862.5 674.6 680.7 699.8 842.5 853.6 896.9 898.7 898.9 899.3 900.4 894.6 894.9 895.7 896.4 900.9 521.0 536.9 644.8 667.7 668.1 15217.6 15802.6 15821.2 15821.9 15862.4 13510.3 13716.9 13752.8 13975.3 13978.5 12608.0 12738.8 12803.1 12834.2 13113.7 4408.2 4496.6 4606.7 4648.2 4654.3 120647.4 120933.8 121966.2 121980.2 123790.0 10386.7 10707.4 10710.3 10846.9 11158.4 20850.7 20925.9 21025.2 21044.7 21081.8 7750.6 7767.7 7768.7 7798.0 7945.8 4260.7 4321.5 4348.1 4411.5 4506.3 3460.3 3571.2 3576.8 3578.7 3579.8 668.6 674.1 675.4 713.9 751.8 553.3 604.5 616.3 638.9 677.2 7908.6 8981.0 9501.9 9916.8 10050.9 560.2 662.6 687.3 693.5 697.9 4548.7 4648.5 4708.7 4715.1 4782.5 145740.0 145882.0 151228.0 157314.0 162425.2 131347.7 135295.0 136011.0 137326.3 138867.0 111502.0 113009.0 115288.3 116524.0 118237.0 8674.5 8983.6 8991.0 9080.7 9169.8 65041.3 65121.0 65429.7 66665.0 68392.6 83638.3 99043.0 103150.5 104026.0 106833.0 12117.6 12128.6 12147.3 12330.9 12423.6 12558.2 12881.0 13143.6 13276.9 13374.9 12172.8 12443.0 12735.1 12763.2 13811.0 13613.1 13723.2 13744.6 14169.6 14187.3 12636.0 12977.5 13486.3 13932.5 14571.2 9435.5 11697.9 11705.8 11861.8 11888.3 10081.8 10584.4 11730.9 11781.5 11870.4 05:22:24 INFO - PROCESS | 1649 | -------- Summary: end -------- 05:22:24 INFO - PROCESS | 1649 | 05:22:24 INFO - TEST-INFO | 1649: exit 0 05:22:24 INFO - TEST-OK | dromaeo_css | took 1118179ms 05:22:24 INFO - TEST-START | kraken 05:22:24 INFO - operating with platform_type : mac_ 05:22:24 INFO - Initialising browser for kraken test... 05:22:24 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpSTBQXe/profile http://localhost:49274/getInfo.html) 05:22:26 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 05:22:26 INFO - PROCESS | 1658 | colorDepth:24 05:22:26 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 05:22:26 INFO - PROCESS | 1658 | __metrics 05:22:26 INFO - PROCESS | 1658 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:22:26 INFO - PROCESS | 1658 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:22:27 INFO - TEST-INFO | 1658: exit 0 05:22:27 INFO - Browser initialized. 05:22:27 INFO - Running cycle 1/1 for kraken test... 05:22:27 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpSTBQXe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:22:39 INFO - PROCESS | 1659 | RSS: Main: 219471872 05:22:39 INFO - PROCESS | 1659 | 05:22:42 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 05:22:43 INFO - PROCESS | 1659 | RSS: Main: 269725696 05:22:43 INFO - PROCESS | 1659 | 05:22:45 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 05:22:46 INFO - PROCESS | 1659 | RSS: Main: 280641536 05:22:46 INFO - PROCESS | 1659 | 05:22:49 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 05:22:50 INFO - PROCESS | 1659 | RSS: Main: 377651200 05:22:50 INFO - PROCESS | 1659 | 05:22:52 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 05:22:52 INFO - PROCESS | 1659 | RSS: Main: 280190976 05:22:52 INFO - PROCESS | 1659 | 05:22:54 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:22:55 INFO - PROCESS | 1659 | RSS: Main: 281460736 05:22:55 INFO - PROCESS | 1659 | 05:22:58 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 05:22:58 INFO - PROCESS | 1659 | RSS: Main: 319545344 05:22:58 INFO - PROCESS | 1659 | 05:23:01 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 05:23:02 INFO - PROCESS | 1659 | RSS: Main: 319643648 05:23:02 INFO - PROCESS | 1659 | 05:23:05 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 05:23:05 INFO - PROCESS | 1659 | RSS: Main: 319488000 05:23:05 INFO - PROCESS | 1659 | 05:23:07 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:23:08 INFO - PROCESS | 1659 | RSS: Main: 290717696 05:23:08 INFO - PROCESS | 1659 | 05:23:09 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:23:10 INFO - PROCESS | 1659 | RSS: Main: 295563264 05:23:10 INFO - PROCESS | 1659 | 05:23:12 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:23:13 INFO - PROCESS | 1659 | RSS: Main: 297115648 05:23:13 INFO - PROCESS | 1659 | 05:23:16 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:23:17 INFO - PROCESS | 1659 | RSS: Main: 313327616 05:23:17 INFO - PROCESS | 1659 | 05:23:20 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:23:20 INFO - PROCESS | 1659 | RSS: Main: 309465088 05:23:20 INFO - PROCESS | 1659 | 05:23:22 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 05:23:22 INFO - PROCESS | 1659 | RSS: Main: 352940032 05:23:22 INFO - PROCESS | 1659 | 05:23:22 INFO - PROCESS | 1659 | __start_tp_report 05:23:22 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 05:23:22 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 05:23:22 INFO - PROCESS | 1659 | |i|pagename|runs| 05:23:22 INFO - PROCESS | 1659 | |0;ai-astar;117;116;116;115;115;114;113;116;115;116 05:23:22 INFO - PROCESS | 1659 | |1;audio-beat-detection;146;111;104;140;110;108;109;107;139;108 05:23:22 INFO - PROCESS | 1659 | |2;audio-dft;187;181;184;185;182;185;187;183;184;183 05:23:22 INFO - PROCESS | 1659 | |3;audio-fft;83;59;59;89;59;59;59;58;82;58 05:23:22 INFO - PROCESS | 1659 | |4;audio-oscillator;89;70;93;71;69;68;92;68;69;90 05:23:22 INFO - PROCESS | 1659 | |5;imaging-gaussian-blur;88;84;88;86;88;84;92;130;120;84 05:23:22 INFO - PROCESS | 1659 | |6;imaging-darkroom;97;98;97;97;96;95;96;118;161;95 05:23:22 INFO - PROCESS | 1659 | |7;imaging-desaturate;85;84;84;84;84;86;84;97;134;108 05:23:22 INFO - PROCESS | 1659 | |8;json-parse-financial;58;55;54;53;55;58;57;58;57;56 05:23:22 INFO - PROCESS | 1659 | |9;json-stringify-tinderbox;70;64;67;75;68;68;66;69;68;69 05:23:22 INFO - PROCESS | 1659 | |10;stanford-crypto-aes;81;83;93;99;100;100;103;84;85;91 05:23:22 INFO - PROCESS | 1659 | |11;stanford-crypto-ccm;140;146;152;147;152;138;139;134;229;155 05:23:22 INFO - PROCESS | 1659 | |12;stanford-crypto-pbkdf2;165;167;171;210;164;163;162;163;162;168 05:23:22 INFO - PROCESS | 1659 | |13;stanford-crypto-sha256-iterative;67;67;66;66;67;67;66;66;68;66 05:23:22 INFO - PROCESS | 1659 | __end_tp_report 05:23:22 INFO - PROCESS | 1659 | __start_cc_report 05:23:22 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1965 05:23:22 INFO - PROCESS | 1659 | __end_cc_report 05:23:22 INFO - PROCESS | 1659 | __startTimestamp1475583802636__endTimestamp 05:23:22 INFO - PROCESS | 1659 | 05:23:22 INFO - PROCESS | 1659 | ------- Summary: start ------- 05:23:22 INFO - PROCESS | 1659 | Number of tests: 14 05:23:22 INFO - PROCESS | 1659 | 05:23:22 INFO - PROCESS | 1659 | [#0] ai-astar Cycles:10 Average:115.30 Median:116.00 stddev:1.16 (1.0%) stddev-sans-first:1.05 05:23:22 INFO - PROCESS | 1659 | Values: 117.0 116.0 116.0 115.0 115.0 114.0 113.0 116.0 115.0 116.0 05:23:22 INFO - PROCESS | 1659 | 05:23:22 INFO - PROCESS | 1659 | [#1] audio-beat-detection Cycles:10 Average:118.20 Median:110.50 stddev:16.40 (14.8%) stddev-sans-first:13.97 05:23:22 INFO - PROCESS | 1659 | Values: 146.0 111.0 104.0 140.0 110.0 108.0 109.0 107.0 139.0 108.0 05:23:22 INFO - PROCESS | 1659 | 05:23:22 INFO - PROCESS | 1659 | [#2] audio-dft Cycles:10 Average:184.10 Median:184.50 stddev:1.97 (1.1%) stddev-sans-first:1.79 05:23:22 INFO - PROCESS | 1659 | Values: 187.0 181.0 184.0 185.0 182.0 185.0 187.0 183.0 184.0 183.0 05:23:22 INFO - PROCESS | 1659 | 05:23:22 INFO - PROCESS | 1659 | [#3] audio-fft Cycles:10 Average:66.50 Median:59.00 stddev:12.67 (21.5%) stddev-sans-first:11.95 05:23:22 INFO - PROCESS | 1659 | Values: 83.0 59.0 59.0 89.0 59.0 59.0 59.0 58.0 82.0 58.0 05:23:22 INFO - PROCESS | 1659 | 05:23:22 INFO - PROCESS | 1659 | [#4] audio-oscillator Cycles:10 Average:77.90 Median:80.00 stddev:11.36 (14.2%) stddev-sans-first:11.31 05:23:22 INFO - PROCESS | 1659 | Values: 89.0 70.0 93.0 71.0 69.0 68.0 92.0 68.0 69.0 90.0 05:23:22 INFO - PROCESS | 1659 | 05:23:22 INFO - PROCESS | 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:94.40 Median:87.00 stddev:16.49 (19.0%) stddev-sans-first:17.32 05:23:22 INFO - PROCESS | 1659 | Values: 88.0 84.0 88.0 86.0 88.0 84.0 92.0 130.0 120.0 84.0 05:23:22 INFO - PROCESS | 1659 | 05:23:22 INFO - PROCESS | 1659 | [#6] imaging-darkroom Cycles:10 Average:105.00 Median:96.50 stddev:20.84 (21.6%) stddev-sans-first:21.90 05:23:22 INFO - PROCESS | 1659 | Values: 97.0 98.0 97.0 97.0 96.0 95.0 96.0 118.0 161.0 95.0 05:23:22 INFO - PROCESS | 1659 | 05:23:22 INFO - PROCESS | 1659 | [#7] imaging-desaturate Cycles:10 Average:93.00 Median:84.00 stddev:16.47 (19.6%) stddev-sans-first:17.21 05:23:22 INFO - PROCESS | 1659 | Values: 85.0 84.0 84.0 84.0 84.0 86.0 84.0 97.0 134.0 108.0 05:23:22 INFO - PROCESS | 1659 | 05:23:22 INFO - PROCESS | 1659 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:57.00 stddev:1.79 (3.1%) stddev-sans-first:1.76 05:23:22 INFO - PROCESS | 1659 | Values: 58.0 55.0 54.0 53.0 55.0 58.0 57.0 58.0 57.0 56.0 05:23:22 INFO - PROCESS | 1659 | 05:23:22 INFO - PROCESS | 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.50 stddev:2.88 (4.2%) stddev-sans-first:2.99 05:23:22 INFO - PROCESS | 1659 | Values: 70.0 64.0 67.0 75.0 68.0 68.0 66.0 69.0 68.0 69.0 05:23:22 INFO - PROCESS | 1659 | 05:23:22 INFO - PROCESS | 1659 | [#10] stanford-crypto-aes Cycles:10 Average:91.90 Median:84.50 stddev:8.27 (9.8%) stddev-sans-first:7.77 05:23:22 INFO - PROCESS | 1659 | Values: 81.0 83.0 93.0 99.0 100.0 100.0 103.0 84.0 85.0 91.0 05:23:22 INFO - PROCESS | 1659 | 05:23:22 INFO - PROCESS | 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:153.20 Median:149.50 stddev:27.52 (18.4%) stddev-sans-first:28.77 05:23:22 INFO - PROCESS | 1659 | Values: 140.0 146.0 152.0 147.0 152.0 138.0 139.0 134.0 229.0 155.0 05:23:22 INFO - PROCESS | 1659 | 05:23:22 INFO - PROCESS | 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.50 Median:166.00 stddev:14.52 (8.7%) stddev-sans-first:15.31 05:23:22 INFO - PROCESS | 1659 | Values: 165.0 167.0 171.0 210.0 164.0 163.0 162.0 163.0 162.0 168.0 05:23:22 INFO - PROCESS | 1659 | 05:23:22 INFO - PROCESS | 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 05:23:22 INFO - PROCESS | 1659 | Values: 67.0 67.0 66.0 66.0 67.0 67.0 66.0 66.0 68.0 66.0 05:23:22 INFO - PROCESS | 1659 | -------- Summary: end -------- 05:23:22 INFO - PROCESS | 1659 | 05:23:23 INFO - TEST-INFO | 1659: exit 0 05:23:23 INFO - TEST-OK | kraken | took 58895ms 05:23:23 INFO - SUITE-END | took 1177s 05:23:23 INFO - Completed test suite (00:19:37) 05:23:23 INFO - javascript benchmark 05:23:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2879.712028797122, 3166.762492813039, 3372.64587218342, 3390.13551544356, 3439.7936123832574, 5685.829425117248, 5798.246227990366, 5821.0, 5822.737976791044, 5827.9999999999945, 5671.347795003576, 5691.032524470839, 5705.4294570542925, 5740.0, 5747.42525747425, 5209.7134657593815, 5215.061288967984, 5230.7646155922885, 5245.44922783108, 5270.894582108355, 5218.843434696965, 5221.503957124067, 5235.345581802275, 5253.842384728464, 5317.0, 5301.575873930095, 5325.147976323789, 5360.410354860962, 5366.570674346043, 5405.027095122877, 5309.548688361475, 5315.73421328932, 5327.334083239595, 5339.919901201485, 5353.705546194958, 5143.074246635604, 5211.7133557654315, 5284.101702710548, 5288.391834938954, 5321.414644389114, 5648.406917273668, 5751.166080918243, 5752.913706294409, 5756.884862302731, 5769.278840144982, 6152.753889844401, 6179.0, 6194.597351172204, 6217.87564248717, 6236.719347629368, 6170.784022559234, 6241.65670888101, 6274.968625156891, 6295.748170073191, 6314.62112273265, 4899.926501102486, 5829.679367634736, 5838.124281357788, 5846.766129354778, 5904.2029326040865, 6249.78125765596, 6311.779087731908, 6324.494040476751, 6324.557280990379, 6329.588576742497, 6101.542384321105, 6133.355997620186, 6149.0, 6224.1597384352535, 6229.003359462555, 6314.336994615591, 6318.020706790455, 6342.238931328178, 6357.427831495188, 6369.681515924185, 6115.541334399938, 6141.7543298268465, 6306.747730090837, 6307.905381419282, 6323.715432805535, 6156.107364432132, 6214.875702485925, 6252.062190671436, 6277.403646653561, 6346.809595712136, 4968.0, 4968.627352948543, 4976.925346119811, 4988.800447982113, 4997.250412438163, 4407.757573333497, 4425.579569940851, 4483.08096840147, 4486.798094085774, 4501.932471012938, 4596.287575425815, 5750.769969201185, 5830.504407125357, 5834.620749651259, 5851.180834683148, 6325.873482530324, 6355.459785918156, 6360.14138091361, 6361.936380636227, 6376.426121649074, 5886.0288052471715, 5908.793192238337, 5932.673702946293, 5932.703364831741, 5958.940410595926, 5352.545033672103, 5368.382635996911, 5404.0272750905215, 5468.781248750085, 5471.835844924659, 6286.371362863769, 6310.968445157745, 6335.90496142549, 6382.393672601095, 6407.199100112486, 6303.338149494421, 6362.363763623601, 6378.2027246592315, 6393.360663933569, 6403.423691867754, 5011.972545628065, 5384.273123128484, 6207.0, 6290.339514350927, 6389.87220255583, 5179.430262671028, 6144.924638188389, 6216.44052035319, 6257.342978987141, 6270.2475702915945, 4828.493008234085, 5443.891122177613, 6136.447719705248, 6327.651979141191, 6342.587731797418, 5895.587308888336, 6122.0, 6158.414950579688, 6181.320054794059, 6193.380661933951, 6063.242094738158, 6084.239470066242, 6112.169143789106, 6115.179495343419, 6128.877422451436, 6021.939780602138, 6060.151578779062, 6070.271567411939, 6070.484008859296, 6077.0, 5989.071693887455, 6107.4197951194565, 6108.57239993214, 6192.721327540362, 6214.005759078525, 5855.560832937462, 5968.46283834457, 5983.34183239852, 5993.760249589967, 5995.250593675791], "value": 5708.350933152993, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.5207672519294, 531.5720844720001, 540.087252543202, 549.1680104641466, 559.3008739076153, 30725.38549229014, 32917.67082329173, 40322.7983860081, 41512.58487415125, 43674.0, 42672.35991460123, 42785.57214427855, 42807.92980175489, 42957.0, 43009.569904300944, 8669.479831210148, 9676.129148376645, 9863.063009014168, 9864.753381165492, 9902.356346837432, 8741.650333986665, 11948.283103013804, 12269.018478521697, 12290.508379664847, 12305.569305074325, 12096.637100886988, 12171.57399491018, 12179.147459677826, 12185.147039707179, 12241.26552406854, 8719.258862996652, 8909.287257019423, 12035.578754743587, 12094.697632559168, 12121.0, 11698.122640801974, 12024.939875300655, 12034.157608967376, 12288.0, 12303.876961230362, 41113.944302784745, 41582.37626435606, 41593.1681366374, 41612.79193604013, 41672.374914376305, 3326.7172290355347, 3342.8997130086136, 3367.5453813735076, 3510.3505851417312, 3673.669369756735, 29500.852495737385, 29581.0, 29640.555391669142, 30509.847450762827, 30769.84615076933, 3118.9064328070194, 3382.7124694401004, 3389.7288216942834, 3420.1791570023015, 3422.4524076147945, 454159.0, 455327.0, 455553.0, 456619.0, 457232.713836432, 56692.43307566954, 57040.429595703514, 57077.71461142751, 57118.0, 57121.71439142778, 60227.69886150629, 60238.39761602328, 60278.0, 60305.69847150736, 60424.0, 16498.75251871223, 16769.161541922855, 16786.076765777754, 16800.991940483367, 16802.41191558314, 11768.411579421167, 11888.643340699793, 11902.0, 13051.21692698441, 13166.605001849959, 15485.845141548665, 15721.842781572037, 15751.842481575037, 16128.790340724492, 16248.268827902773, 6711.516738806673, 6828.2147553031045, 6830.7609233676585, 6906.136732908387, 6935.826604334932, 844.5861527851308, 920.5167287174287, 931.9813603727888, 978.505854543451, 1063.8563793887881, 28539.0, 29373.26566835846, 29423.558646620317, 30231.395372092877, 30317.848410757804, 1061.77702682436, 1067.0183431243274, 1125.6172901213627, 1135.9602413915472, 1240.522398876421, 15231.390744370323, 15242.466513671969, 15281.617959550878, 15490.62816995724, 15503.99224050433, 626923.0, 631199.0, 633981.0, 635451.0, 638690.0, 56048.719756400955, 56149.31552053445, 56178.0, 56347.43652563422, 56361.0, 1247.7504499100216, 1276.8723127687158, 1277.125169259042, 1384.190248704499, 1402.9859701403059, 26226.73773262243, 30509.847450762605, 32078.679213207568, 32272.0, 32320.0, 48742.78143046452, 49104.75447622739, 49230.76923076952, 49235.52293431203, 49445.752771237356, 487078.0, 493426.0, 494990.0, 495047.0, 496674.0, 25347.0, 26132.73867261303, 26187.083452079085, 39442.40836387399, 39843.40234896537, 44977.77511112423, 45857.541424585324, 46031.76984115058, 46137.0, 46476.0, 36105.63894361128, 38360.616393835706, 38638.02600349337, 38665.226695466496, 39648.80175599219, 38384.84845454641, 39001.2199756009, 39268.80365598154, 41896.371554427315, 43658.34512482379, 35391.646083538835, 39377.60622393739, 41340.37989430221, 42332.788336058125, 42486.78756606197, 40371.59628403679, 40491.79754101211, 40878.38682419706, 40902.18195636011, 41601.0, 30834.229144271572, 31017.224569385948, 31185.53221701722, 31279.687203127676, 31728.206794830316], "value": 20432.868598260797, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.9245512214873, 357.1677990282641, 366.96513831186047, 369.0681030398244, 381.2565497280304, 15265.313060912258, 15376.077435353873, 16535.007899526023, 21194.0, 21631.891840540775, 20300.695489567668, 20557.794422055777, 21198.470038249012, 21323.040463179157, 21446.678299825515, 4711.835085771999, 5941.762329506814, 6208.906866397007, 6211.161493198428, 6218.4714299284615, 5970.73131709072, 6017.308009578911, 6190.164327815754, 6204.255489341285, 6205.131281620555, 5984.072468767348, 6031.758729650809, 6043.244594425697, 6119.510439164878, 6151.661658608775, 5865.442782935615, 6001.279846418458, 6039.335673075958, 6049.425304596057, 6056.515478761688, 5228.686278823283, 5268.394134674523, 5480.068388373986, 5547.944520554784, 5572.442755724435, 13258.801117983237, 13528.59414217575, 13531.661708457268, 22548.210812621644, 25187.62218566723, 2188.803007729312, 2188.8686678799163, 2239.283429302624, 2372.146027430124, 2929.4580502607087, 16293.59266018347, 16395.59011024722, 17793.373722832028, 17807.19867605961, 18348.99080550569, 1694.6441247338073, 1890.905454727272, 1918.7793403758608, 2070.1822780001817, 2139.839512036588, 104989.47505262424, 136220.31889840585, 138341.61658383388, 146438.26780866028, 152764.0, 21320.573588528452, 21926.45183870416, 22050.558988820132, 22149.557008859734, 22348.88255587214, 34656.65343346585, 35224.82387588046, 35288.29423411517, 35616.821915890774, 36212.09469763277, 10877.619283325204, 11204.159688023268, 11278.041366483942, 11336.886631133748, 11527.76944461123, 9210.447373157633, 9217.210783188377, 9256.259499240045, 9372.812543749087, 9447.291453140904, 8142.430029897969, 9668.371555848847, 9793.167580755573, 9857.239972807625, 9891.0, 2893.69616190297, 3137.388209299165, 3654.3007501511393, 3706.425504046877, 3828.679105708526, 796.5340275938524, 926.1571969507715, 952.066974365126, 972.6936015155203, 991.6166947108743, 20365.19098609537, 21652.891735541536, 21725.348239552837, 21746.0, 21779.346619601438, 888.7822483491586, 906.8866391701038, 909.286210324905, 944.1313991128178, 956.7753275806979, 8872.822543549093, 11295.322280663186, 11306.152038597138, 11338.149638777124, 11352.318860868374, 607839.0, 610030.0, 621630.0, 621768.0, 622802.0, 134534.0, 136562.31718841344, 138332.61667383197, 139232.0, 140200.2989985064, 948.5873644964324, 957.2198658093631, 962.6245764151986, 963.1283688262134, 963.3834346018554, 18706.438806835817, 18956.146973386505, 19395.030248487237, 19403.805961940765, 19409.93245371518, 55382.72308638592, 56411.0, 56615.150772737616, 56790.0, 57769.0, 77991.75444806177, 80712.3779131145, 80809.59595201987, 81294.0, 84394.57802710947, 8056.274935255855, 8141.959290203511, 8302.0, 8330.166983301622, 8458.196471335214, 11509.0, 12361.876381236072, 12643.304618246084, 12707.04697147736, 12870.420831062438, 5435.755391007335, 10602.575896964343, 10964.890351096707, 11063.617047869016, 11295.3787541686, 7637.8925055865475, 10868.293560918515, 11039.116870650168, 11371.886281137082, 11488.597899073826, 11348.921852424006, 11575.536978521102, 11644.2431241969, 11725.120615953667, 11872.940635297115, 7007.229204787367, 7128.679209435484, 7353.455774287246, 7482.064741907262, 8359.456635318686, 10703.464826758474, 10972.670819875417, 11142.72143196394, 11182.32906025641, 11244.775104498029], "value": 10564.896701827534, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1489.6871656952044, 1502.3614963640453, 1671.557037385093, 1839.089650622942, 1841.2542920117357, 8450.788730281738, 8927.598258078386, 8939.821203575924, 8939.865902011476, 8956.149165829253, 7821.726239581616, 8107.878381824263, 8519.914800852006, 8781.91218087819, 8805.91194088059, 2377.3699969508093, 2403.471236328005, 2410.09621391978, 2411.457422080027, 2412.746661600533, 2008.4476768888526, 2374.7862692357685, 2418.093215044358, 2419.370963549481, 2424.151546958568, 2356.26955643751, 2364.172539611131, 2372.7034120734907, 2384.4158181245534, 2389.3668177932773, 2331.5336932613545, 2338.894749736266, 2390.95218095638, 2397.3886658902043, 2401.1595941420537, 2361.480474295652, 2373.4659701567184, 2380.0955636858057, 2381.1546900850294, 2387.844790088656, 8835.160659737314, 8863.778405539848, 8941.374103812735, 8955.37312388133, 8961.462312261285, 5218.791248350061, 5385.3268341457315, 5390.6226564140525, 5397.595180361489, 5417.945820541823, 3612.6026137124895, 3638.43604241343, 3661.7802931824176, 3710.07248187953, 3715.2198038411966, 1101.9724506887392, 1102.0962810495398, 1104.7127746785893, 1118.7762447510531, 1125.7861006408757, 11692.181547291693, 11805.645830625095, 11806.291622502591, 11809.23239989398, 11815.172937894351, 4615.838445654386, 4703.576678098988, 4718.363020992191, 4730.665994825507, 4881.0, 9893.109620134222, 10011.549480273405, 10027.899721002843, 10027.949860250652, 10034.74913127163, 5299.4700529946695, 5300.390455097636, 5312.654677445954, 5313.946860531345, 5322.787088516416, 4251.128518653669, 4447.710898791633, 4599.5400459953735, 4857.149998750276, 4884.242942343943, 3891.416287556889, 3901.1027463683513, 4038.757674539537, 4047.3321901886447, 4056.3915412688334, 1113.8162203236536, 1123.2421260726935, 1265.7468506298776, 1286.1061562214359, 1290.5547586082787, 867.2888231649987, 917.825899899607, 927.355487935878, 931.38993958957, 980.568549838069, 5776.018076926848, 5815.505682017076, 5925.525957923356, 6056.424639659225, 6153.7230824613, 438.87053319270893, 458.38805195064293, 458.9128065667579, 462.6715032327086, 470.09272104837993, 3944.0, 3978.6817054635558, 3992.2215168041953, 4023.8994025149605, 4092.0, 10551.472426378803, 10610.151187905103, 10814.837777433344, 10955.287906286067, 10957.726056848642, 10874.401907895142, 10879.83680244797, 10883.564657413774, 10887.945560272148, 10907.0, 7901.486403383877, 8210.384221183434, 8292.83414331722, 8373.95813020931, 8393.748187554384, 5974.0, 6006.969965150146, 6012.8797424052145, 6147.047207682816, 6200.472959798287, 9800.607975680892, 10011.849822252818, 10078.395296282246, 10221.33561318512, 10332.431716255678, 10319.793604128026, 10352.741181470223, 10409.9479502602, 10420.583176673152, 10461.424621645883, 6957.304269573205, 7172.713091476283, 7472.40220782347, 7599.126100498514, 7608.923910760822, 7238.203797582367, 7531.849363012819, 8269.338452923872, 8341.040780310099, 8455.492670439793, 7414.62926853666, 7533.962330188314, 7560.281773231534, 7590.468667193243, 7663.233676632292, 7297.854042919218, 7325.926740732524, 7340.596267205355, 7373.889391659237, 7485.1017877855, 6993.160820701549, 7031.43748500129, 7100.715971361088, 7104.289571043061, 7114.822129446598, 4307.65538756905, 4903.313536104877, 4959.97520012412, 5015.17249653803, 5082.034413461431, 4963.70217786934, 4978.228374601942, 4979.502049795136, 5149.9227511586605, 5161.432242453252], "value": 4531.169542802667, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.6621384049864, 304.9070033639739, 310.7467414057543, 319.1606076020067, 319.7633751024243, 4434.445694288214, 5237.612032811298, 5289.259503669489, 5303.337082864642, 5310.522053015228, 4068.8779336619873, 4883.316335713003, 5103.617228707843, 5122.974385128069, 5251.317328747267, 3968.285708572456, 3983.223271462066, 3986.4418981342637, 3991.121953170305, 4015.07653239755, 3403.4724617684296, 3881.961180388202, 3974.3641017437217, 3991.960080399188, 4034.9596504034876, 3523.344028306705, 3684.465752465891, 3937.98031009846, 3962.5839286874893, 3972.82122304497, 3987.7009224308295, 4012.498437695288, 4024.175044115964, 4026.778527181004, 4030.8992275193064, 3482.2687235680537, 3482.9129271768156, 3485.372632926072, 3528.3825330567306, 3530.452779819132, 4705.294205869147, 5109.8722531937, 5121.156383701865, 5149.30484384607, 5157.762137087109, 3889.747166434201, 4247.341662042389, 4526.52471490492, 4596.460185837748, 4607.608353289975, 4628.39830821991, 5563.0, 5583.581231407661, 5594.258813181553, 5602.691851948141, 3231.0, 3814.256220037094, 3814.4850445189822, 3826.4834247376525, 3839.0978120141745, 5383.757730902119, 5431.266778984826, 5602.523785478198, 5847.754496254577, 5847.976604094267, 3236.5145228215956, 3802.7718336899875, 3825.9096157594954, 3828.904277393032, 3836.3094642964534, 3289.588801399825, 3442.662245570549, 3619.2761447710564, 3710.7773533587533, 3841.2125514269505, 3835.0, 4069.023434375788, 4305.987750976166, 4381.342798580238, 4524.592786649151, 5018.799248030111, 5281.39263984639, 5510.669359838423, 5512.503874651301, 5514.0, 1205.9638210853689, 1294.6180876641413, 1304.3282709404664, 1321.478016183602, 1321.4780161836213, 725.3979197266257, 829.6722794496261, 861.5175501719058, 863.6718047142045, 866.7963028688254, 4142.875713728593, 4295.723266668608, 4501.279795232747, 4736.621070314367, 5023.748812559357, 5683.687397193112, 5696.857578560486, 5697.9430205698245, 5712.857178570486, 5743.597948143673, 4716.245400735866, 4783.545563171493, 5165.66423182492, 5199.896002079937, 5199.974000129975, 2404.7955923746676, 2965.569992351097, 2975.4495418347674, 3014.8341841198508, 3022.818630882154, 5023.497650234947, 5622.907400929473, 5631.352394474688, 5904.663864916309, 5949.970250148722, 5701.686407247558, 5789.218455508537, 5797.652140871477, 5835.649861008353, 5853.0, 5853.0, 5886.558508111909, 5895.911561326584, 5896.882062358729, 5923.822285331447, 5349.1976203569775, 5380.901448435192, 5652.971735141298, 5741.741621626953, 5754.69105264483, 5083.38999320084, 5564.054110801093, 5572.801847602785, 5584.497395234448, 5595.8880822384135, 4725.621950244041, 5837.270341207349, 5887.911681324869, 5889.792592518438, 5918.23063001807, 3138.8430578471443, 3210.630777460622, 3492.6856582907662, 3812.199438117915, 3822.6177382261553, 5340.866478338073, 5610.547869949591, 5676.602637815313, 5678.2050512929045, 5688.715564221855, 5536.944630553804, 5555.861103472445, 5584.357798853021, 5612.691301978431, 5640.71796410186, 4645.420557010632, 4997.2021263839015, 5077.543021127968, 5138.3577052868395, 5496.570891568301, 4332.935005974976, 5389.56883449331, 5405.108157154025, 5416.452223793422, 5465.508104270635, 4777.737224452689, 5414.269073675004, 5435.728213589226, 5545.750441230235, 5651.689157096399, 4705.976470117627, 5354.892902142014, 5432.945670543244, 5450.618456707993, 5462.590305727007], "value": 4010.990350468444, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.7526528082531, 729.9489035767492, 752.9940715394106, 794.0788685125256, 794.542099352394, 14764.187969661678, 17046.914765426187, 17474.737878931825, 17751.28994840205, 17795.110244487787, 16342.019478831278, 16775.664486710288, 16946.83053169471, 16962.575935601617, 17030.063346515937, 821.4660470694037, 858.6222062292602, 859.0, 860.1054902900976, 862.5428522882883, 674.6222115615271, 680.7277089164324, 699.7900629811062, 842.465034702965, 853.6201390381283, 896.9461832290051, 898.7079199260234, 898.8651702244683, 899.2850683706437, 900.3742399032675, 894.5884892949251, 894.8702438146497, 895.7223260789143, 896.4128495835238, 900.8828852249231, 521.0178812937602, 536.9301990741218, 644.7711062572766, 667.7362441835447, 668.1147479589515, 15217.6195595111, 15802.60493487672, 15821.208939553091, 15821.92089039559, 15862.36550537977, 13510.256935868523, 13716.931415342959, 13752.793708094387, 13975.301234938313, 13978.510752123628, 12608.0, 12738.80891786624, 12803.071859572115, 12834.229946203257, 13113.672158196121, 4408.237202774934, 4496.595306422405, 4606.746628935407, 4648.209804333272, 4654.325122857201, 120647.3967630165, 120933.79066209313, 121966.17050744245, 121980.17029744561, 123790.0, 10386.688399348031, 10707.411092389993, 10710.303830251165, 10846.891531084746, 11158.386288754196, 20850.687239691415, 20925.895370523354, 21025.15899364039, 21044.684329735068, 21081.78918210829, 7750.612469376509, 7767.72812951544, 7768.65041073153, 7798.0, 7945.801354966056, 4260.744355338689, 4321.459817522809, 4348.1286346239995, 4411.470623525198, 4506.2564676828615, 3460.3425349184076, 3571.196480791801, 3576.803275819803, 3578.6779189873037, 3579.803110828929, 668.6021817018964, 674.0664180110582, 675.4393853101914, 713.864365770502, 751.8345963887936, 553.3111276460752, 604.4529700620946, 616.3035769580346, 638.9137466442064, 677.2076670295766, 7908.604569771488, 8981.0, 9501.862428606903, 9916.752081198028, 10050.899491004997, 560.1738333034338, 662.6322391073, 687.3229868579446, 693.5180049865396, 697.9336962988508, 4548.681592288508, 4648.488666246778, 4708.670393072521, 4715.104130215248, 4782.52174782519, 145740.0, 145882.0, 151228.0, 157314.0, 162425.18787405986, 131347.68652313546, 135295.0, 136011.0, 137326.31336843251, 138867.0, 111501.99999999837, 113009.0, 115288.2706759416, 116524.0, 118237.0, 8674.479531228146, 8983.595738191927, 8990.955045224731, 9080.727578172666, 9169.816603668023, 65041.34958650542, 65121.0, 65429.67285163734, 66665.00002499869, 68392.63214735777, 83638.3272334562, 99043.00956990338, 103150.48424757828, 104026.0, 106833.0, 12117.636470905887, 12128.575499857816, 12147.331896745764, 12330.938345308216, 12423.62729118128, 12558.246505209716, 12881.0, 13143.579317544829, 13276.867231327564, 13374.933125334312, 12172.817407738714, 12443.0, 12735.108542401942, 12763.234205947672, 13810.964177686512, 13613.11514751538, 13723.245221512912, 13744.587662370144, 14169.574912752634, 14187.290635468391, 12636.025164965211, 12977.545785897448, 13486.325683715972, 13932.512362067278, 14571.198584077978, 9435.481048542397, 11697.941510292394, 11705.824412633647, 11861.822072668745, 11888.28670279786, 10081.848772268275, 10584.41785701763, 11730.88269117298, 11781.52873885035, 11870.406479676154], "value": 7934.924342944494, "unit": "score"}], "name": "dromaeo_css", "value": 7498.250722323667, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 115.0, 115.0, 114.0, 113.0, 116.0, 115.0, 116.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 111.0, 104.0, 140.0, 110.0, 108.0, 109.0, 107.0, 139.0, 108.0], "value": 118.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 181.0, 184.0, 185.0, 182.0, 185.0, 187.0, 183.0, 184.0, 183.0], "value": 184.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 59.0, 89.0, 59.0, 59.0, 59.0, 58.0, 82.0, 58.0], "value": 66.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 93.0, 71.0, 69.0, 68.0, 92.0, 68.0, 69.0, 90.0], "value": 77.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 88.0, 86.0, 88.0, 84.0, 92.0, 130.0, 120.0, 84.0], "value": 94.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 97.0, 97.0, 96.0, 95.0, 96.0, 118.0, 161.0, 95.0], "value": 105.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 84.0, 84.0, 86.0, 84.0, 97.0, 134.0, 108.0], "value": 93.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 54.0, 53.0, 55.0, 58.0, 57.0, 58.0, 57.0, 56.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 64.0, 67.0, 75.0, 68.0, 68.0, 66.0, 69.0, 68.0, 69.0], "value": 68.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 93.0, 99.0, 100.0, 100.0, 103.0, 84.0, 85.0, 91.0], "value": 91.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 146.0, 152.0, 147.0, 152.0, 138.0, 139.0, 134.0, 229.0, 155.0], "value": 153.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 171.0, 210.0, 164.0, 163.0, 162.0, 163.0, 162.0, 168.0], "value": 169.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 66.0, 67.0, 67.0, 66.0, 66.0, 68.0, 66.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1460.1, "alertThreshold": 2.0}]} 05:23:23 INFO - Return code: 0 05:23:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:23:23 INFO - # TBPL SUCCESS # 05:23:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:23:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:23:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:23:23 INFO - 2016-10-04 05:23:23.966 screenresolution[1663:10152] starting screenresolution argv=screenresolution get 05:23:23 INFO - 2016-10-04 05:23:23.969 screenresolution[1663:10152] Display 0: 1600x1200x32@60 05:23:23 INFO - 2016-10-04 05:23:23.975 screenresolution[1664:10155] starting screenresolution argv=screenresolution list 05:23:23 INFO - Available Modes on Display 0 05:23:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:23:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:23:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:23:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:23:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:23:24 INFO - Intel Iris: 05:23:24 INFO - Chipset Model: Intel Iris 05:23:24 INFO - Type: GPU 05:23:24 INFO - Bus: Built-In 05:23:24 INFO - VRAM (Dynamic, Max): 1536 MB 05:23:24 INFO - Vendor: Intel (0x8086) 05:23:24 INFO - Device ID: 0x0a2e 05:23:24 INFO - Revision ID: 0x0009 05:23:24 INFO - Displays: 05:23:24 INFO - Display: 05:23:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:23:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:23:24 INFO - Display Serial Number: 1600x1200 60 05:23:24 INFO - Main Display: Yes 05:23:24 INFO - Mirror: Off 05:23:24 INFO - Online: Yes 05:23:24 INFO - Rotation: Supported 05:23:24 INFO - Return code: 0 05:23:24 INFO - Running post-action listener: _resource_record_post_action 05:23:24 INFO - [mozharness: 2016-10-04 12:23:24.211754Z] Finished run-tests step (success) 05:23:24 INFO - Running post-run listener: _resource_record_post_run 05:23:24 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 38355968; Write bytes: 663993344; Read time: 376; Write time: 1889 05:23:24 INFO - TinderboxPrint: CPU usage
53.6% 05:23:24 INFO - TinderboxPrint: I/O read bytes / time
38,355,968 / 376 05:23:24 INFO - TinderboxPrint: I/O write bytes / time
663,993,344 / 1,889 05:23:24 INFO - TinderboxPrint: CPU idle
2,248.6 (46.4%) 05:23:24 INFO - TinderboxPrint: CPU system
972.3 (20.1%) 05:23:24 INFO - TinderboxPrint: CPU user
1,620.8 (33.5%) 05:23:24 INFO - TinderboxPrint: Swap in / out
401,231,872 / 0 05:23:24 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 354474496; Write bytes: 356460032; Read time: 27500; Write time: 672 05:23:24 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 37385216; Write bytes: 297350656; Read time: 360; Write time: 1185 05:23:24 INFO - Running post-run listener: _upload_blobber_files 05:23:24 INFO - Blob upload gear active. 05:23:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:23:24 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:23:24 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:23:24 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:23:25 INFO - (blobuploader) - INFO - Open directory for files ... 05:23:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:23:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:23:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:23:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:23:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:23:26 INFO - (blobuploader) - INFO - Done attempting. 05:23:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:23:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:23:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:23:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:23:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:23:27 INFO - (blobuploader) - INFO - Done attempting. 05:23:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:23:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:23:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:23:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:23:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:23:29 INFO - (blobuploader) - INFO - Done attempting. 05:23:29 INFO - (blobuploader) - INFO - Iteration through files over. 05:23:29 INFO - Return code: 0 05:23:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:23:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:23:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/201de29434e9aaf9859d2ac8bc1cb87b5d90524b5240cc115fd8a46ed9b79bf2e28446bc25259d1140ac92e4d527bb4c59cd22a685d5231c72bbf1b400d85938", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d718c73d1ce09267c9b413301a469dd963a48c988ebc1e6f9a3298f00ebcd396a5e668e7032161faa25d418b749d58c27c9f378fbd98a2c6cf1abe810f664f0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b969ab96411d385b077b0937e835479a301dfa05393c4fe044ef1565ec5d470a2d12d43c839928502aa37f789f29575c01bc1f417f866e9a261b978a268c4d07"} 05:23:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:23:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:23:29 INFO - Contents: 05:23:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/201de29434e9aaf9859d2ac8bc1cb87b5d90524b5240cc115fd8a46ed9b79bf2e28446bc25259d1140ac92e4d527bb4c59cd22a685d5231c72bbf1b400d85938", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d718c73d1ce09267c9b413301a469dd963a48c988ebc1e6f9a3298f00ebcd396a5e668e7032161faa25d418b749d58c27c9f378fbd98a2c6cf1abe810f664f0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b969ab96411d385b077b0937e835479a301dfa05393c4fe044ef1565ec5d470a2d12d43c839928502aa37f789f29575c01bc1f417f866e9a261b978a268c4d07"} 05:23:29 INFO - Running post-run listener: copy_logs_to_upload_dir 05:23:29 INFO - Copying logs to upload dir... 05:23:29 INFO - mkdir: /builds/slave/test/build/upload/logs 05:23:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.282594 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-04 05:23:29.793945) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 05:23:29.797384) ========= 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.npNAZVvP6Z/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.INnG0e7s8m/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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/Mozilla-Aurora/sha512/201de29434e9aaf9859d2ac8bc1cb87b5d90524b5240cc115fd8a46ed9b79bf2e28446bc25259d1140ac92e4d527bb4c59cd22a685d5231c72bbf1b400d85938", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d718c73d1ce09267c9b413301a469dd963a48c988ebc1e6f9a3298f00ebcd396a5e668e7032161faa25d418b749d58c27c9f378fbd98a2c6cf1abe810f664f0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b969ab96411d385b077b0937e835479a301dfa05393c4fe044ef1565ec5d470a2d12d43c839928502aa37f789f29575c01bc1f417f866e9a261b978a268c4d07"} build_url:https://queue.taskcluster.net/v1/task/fci21CAHT1mshEWyJQKfKQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011111 build_url: 'https://queue.taskcluster.net/v1/task/fci21CAHT1mshEWyJQKfKQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/201de29434e9aaf9859d2ac8bc1cb87b5d90524b5240cc115fd8a46ed9b79bf2e28446bc25259d1140ac92e4d527bb4c59cd22a685d5231c72bbf1b400d85938", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d718c73d1ce09267c9b413301a469dd963a48c988ebc1e6f9a3298f00ebcd396a5e668e7032161faa25d418b749d58c27c9f378fbd98a2c6cf1abe810f664f0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b969ab96411d385b077b0937e835479a301dfa05393c4fe044ef1565ec5d470a2d12d43c839928502aa37f789f29575c01bc1f417f866e9a261b978a268c4d07"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 05:23:29.830502) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 05:23:29.830879) ========= 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.npNAZVvP6Z/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.INnG0e7s8m/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 05:23:29.879885) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 05:23:29.880257) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 05:23:29.880601) ========= ========= Total master_lag: 0.18 =========