builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0197 starttime: 1487165985.33 results: success (0) buildid: 20170215045044 builduid: 5fec6d64bbe44f1ab0f1a4ed9756a8c8 revision: 6c660ca9126fbc8f2c9fd91d7c48853d2268d136 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-15 05:39:45.326873) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-15 05:39:45.327286) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-15 05:39:45.327570) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-15 05:39:45.353735) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 05:39:45.353997) ========= 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.oPjRj4BfFu/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.Vc3sRddbA8/Listeners TMPDIR=/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-15 05:39:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 145M=0s 2017-02-15 05:39:45 (145 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.097164 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 05:39:45.478557) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 05:39:45.479280) ========= 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.oPjRj4BfFu/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.Vc3sRddbA8/Listeners TMPDIR=/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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.028263 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 05:39:45.530539) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-15 05:39:45.530858) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6c660ca9126fbc8f2c9fd91d7c48853d2268d136 --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 6c660ca9126fbc8f2c9fd91d7c48853d2268d136 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oPjRj4BfFu/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.Vc3sRddbA8/Listeners TMPDIR=/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-15 05:39:45,643 truncating revision to first 12 chars 2017-02-15 05:39:45,643 Setting DEBUG logging. 2017-02-15 05:39:45,643 attempt 1/10 2017-02-15 05:39:45,644 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6c660ca9126f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-15 05:39:47,368 unpacking tar archive at: mozilla-aurora-6c660ca9126f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.988374 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-15 05:39:47.543929) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-15 05:39:47.544509) ========= script_repo_revision: 6c660ca9126fbc8f2c9fd91d7c48853d2268d136 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-15 05:39:47.545197) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-15 05:39:47.545706) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-15 05:39:47.566817) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-02-15 05:39:47.567139) ========= /tools/buildbot/bin/python -u 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', '-u', '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.oPjRj4BfFu/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.Vc3sRddbA8/Listeners TMPDIR=/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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:39:47 INFO - MultiFileLogger online at 20170215 05:39:47 in /builds/slave/test 05:39:47 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:39:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:39:47 INFO - {'append_to_log': False, 05:39:47 INFO - 'base_work_dir': '/builds/slave/test', 05:39:47 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:39:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:39:47 INFO - 'branch': 'Mozilla-Aurora', 05:39:47 INFO - 'buildbot_json_path': 'buildprops.json', 05:39:47 INFO - 'config_files': ('talos/mac_config.py',), 05:39:47 INFO - 'default_actions': ('clobber', 05:39:47 INFO - 'read-buildbot-config', 05:39:47 INFO - 'download-and-extract', 05:39:47 INFO - 'populate-webroot', 05:39:47 INFO - 'create-virtualenv', 05:39:47 INFO - 'install', 05:39:47 INFO - 'run-tests'), 05:39:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:39:47 INFO - 'download_minidump_stackwalk': True, 05:39:47 INFO - 'download_symbols': 'ondemand', 05:39:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:39:47 INFO - 'tooltool.py': '/tools/tooltool.py', 05:39:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:39:47 INFO - '/tools/misc-python/virtualenv.py')}, 05:39:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:39:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:39:47 INFO - 'installer_path': 'installer.exe', 05:39:47 INFO - 'log_level': 'info', 05:39:47 INFO - 'log_name': 'talos', 05:39:47 INFO - 'log_to_console': True, 05:39:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:39:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:39:47 INFO - 'opt_config_files': (), 05:39:47 INFO - 'pip_index': False, 05:39:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:39:47 INFO - 'cmd': ('bash', 05:39:47 INFO - '-c', 05:39:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:39:47 INFO - 'enabled': True, 05:39:47 INFO - 'halt_on_failure': False, 05:39:47 INFO - 'name': 'check_screen_resolution'},), 05:39:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:39:47 INFO - 'cmd': ('bash', 05:39:47 INFO - '-c', 05:39:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:39:47 INFO - 'enabled': True, 05:39:47 INFO - 'halt_on_failure': False, 05:39:47 INFO - 'name': 'check_screen_resolution'},), 05:39:47 INFO - 'run_cmd_checks_enabled': True, 05:39:47 INFO - 'sps_profile': False, 05:39:47 INFO - 'sps_profile_interval': 0, 05:39:47 INFO - 'suite': 'dromaeojs', 05:39:47 INFO - 'system_bits': '32', 05:39:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:39:47 INFO - 'title': 't-yosemite-r7-0197', 05:39:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:39:47 INFO - 'use_talos_json': True, 05:39:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:39:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:39:47 INFO - 'work_dir': 'build'} 05:39:47 INFO - [mozharness: 2017-02-15 13:39:47.778812Z] Running clobber step. 05:39:47 INFO - Running pre-action listener: _resource_record_pre_action 05:39:47 INFO - Running main action method: clobber 05:39:47 INFO - rmtree: /builds/slave/test/build 05:39:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:39:52 INFO - Running post-action listener: _resource_record_post_action 05:39:52 INFO - [mozharness: 2017-02-15 13:39:52.156189Z] Finished clobber step (success) 05:39:52 INFO - [mozharness: 2017-02-15 13:39:52.156503Z] Running read-buildbot-config step. 05:39:52 INFO - Running pre-action listener: _resource_record_pre_action 05:39:52 INFO - Running main action method: read_buildbot_config 05:39:52 INFO - Using buildbot properties: 05:39:52 INFO - { 05:39:52 INFO - "project": "", 05:39:52 INFO - "product": "firefox", 05:39:52 INFO - "script_repo_revision": "production", 05:39:52 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 05:39:52 INFO - "repository": "", 05:39:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 05:39:52 INFO - "buildid": "20170215045044", 05:39:52 INFO - "pgo_build": "False", 05:39:52 INFO - "basedir": "/builds/slave/test", 05:39:52 INFO - "buildnumber": 3, 05:39:52 INFO - "slavename": "t-yosemite-r7-0197", 05:39:52 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:39:52 INFO - "platform": "yosemite_r7", 05:39:52 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 05:39:52 INFO - "branch": "mozilla-aurora", 05:39:52 INFO - "repo_path": "releases/mozilla-aurora", 05:39:52 INFO - "revision": "6c660ca9126fbc8f2c9fd91d7c48853d2268d136", 05:39:52 INFO - "stage_platform": "macosx64", 05:39:52 INFO - "builduid": "5fec6d64bbe44f1ab0f1a4ed9756a8c8", 05:39:52 INFO - "slavebuilddir": "test" 05:39:52 INFO - } 05:39:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/WK11h5tuSvmMms1lC-S2ZQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 05:39:52 INFO - Running post-action listener: _resource_record_post_action 05:39:52 INFO - [mozharness: 2017-02-15 13:39:52.162251Z] Finished read-buildbot-config step (success) 05:39:52 INFO - [mozharness: 2017-02-15 13:39:52.162446Z] Running download-and-extract step. 05:39:52 INFO - Running pre-action listener: _resource_record_pre_action 05:39:52 INFO - Running main action method: download_and_extract 05:39:52 INFO - mkdir: /builds/slave/test/build/tests 05:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:52 INFO - trying https://queue.taskcluster.net/v1/task/WK11h5tuSvmMms1lC-S2ZQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 05:39:52 INFO - Downloading https://queue.taskcluster.net/v1/task/WK11h5tuSvmMms1lC-S2ZQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 05:39:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WK11h5tuSvmMms1lC-S2ZQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 05:39:53 INFO - Downloaded 1199 bytes. 05:39:53 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 05:39:53 INFO - Using the following test package requirements: 05:39:53 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 05:39:53 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 05:39:53 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 05:39:53 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 05:39:53 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 05:39:53 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 05:39:53 INFO - u'jsshell-mac.zip'], 05:39:53 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 05:39:53 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 05:39:53 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 05:39:53 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 05:39:53 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 05:39:53 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 05:39:53 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 05:39:53 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 05:39:53 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 05:39:53 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 05:39:53 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 05:39:53 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 05:39:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WK11h5tuSvmMms1lC-S2ZQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 05:39:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WK11h5tuSvmMms1lC-S2ZQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:39:53 INFO - Fetch https://queue.taskcluster.net/v1/task/WK11h5tuSvmMms1lC-S2ZQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 05:39:54 INFO - Expected file size: 16358340 05:39:54 INFO - Obtained file size: 16358340 05:40:01 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 05:40:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WK11h5tuSvmMms1lC-S2ZQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 05:40:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WK11h5tuSvmMms1lC-S2ZQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:40:01 INFO - Fetch https://queue.taskcluster.net/v1/task/WK11h5tuSvmMms1lC-S2ZQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 05:40:02 INFO - Expected file size: 16358340 05:40:02 INFO - Obtained file size: 16358340 05:40:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WK11h5tuSvmMms1lC-S2ZQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 05:40:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WK11h5tuSvmMms1lC-S2ZQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 05:40:08 INFO - Fetch https://queue.taskcluster.net/v1/task/WK11h5tuSvmMms1lC-S2ZQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 05:40:09 INFO - Expected file size: 14403485 05:40:09 INFO - Obtained file size: 14403485 05:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:09 INFO - trying https://queue.taskcluster.net/v1/task/WK11h5tuSvmMms1lC-S2ZQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 05:40:09 INFO - Downloading https://queue.taskcluster.net/v1/task/WK11h5tuSvmMms1lC-S2ZQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 05:40:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WK11h5tuSvmMms1lC-S2ZQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 05:40:11 INFO - Downloaded 73951903 bytes. 05:40:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WK11h5tuSvmMms1lC-S2ZQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 05:40:11 INFO - mkdir: /builds/slave/test/properties 05:40:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:40:11 INFO - Writing to file /builds/slave/test/properties/build_url 05:40:11 INFO - Contents: 05:40:11 INFO - build_url:https://queue.taskcluster.net/v1/task/WK11h5tuSvmMms1lC-S2ZQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 05:40:12 INFO - Running post-action listener: _resource_record_post_action 05:40:12 INFO - Running post-action listener: set_extra_try_arguments 05:40:12 INFO - [mozharness: 2017-02-15 13:40:12.486001Z] Finished download-and-extract step (success) 05:40:12 INFO - [mozharness: 2017-02-15 13:40:12.486135Z] Running populate-webroot step. 05:40:12 INFO - Running pre-action listener: _resource_record_pre_action 05:40:12 INFO - Running main action method: populate_webroot 05:40:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:40:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:40:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:40:12 INFO - '--tppagecycles', 05:40:12 INFO - '7'], 05:40:12 INFO - 'tests': ['tsvgm']}}, 05:40:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:40:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:40:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:40:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:40:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:40:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:40:12 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:40:12 INFO - 'talos_options': ['--disable-e10s'], 05:40:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:40:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:40:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:40:12 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:40:12 INFO - 'talos_options': ['--disable-e10s'], 05:40:12 INFO - 'tests': ['damp', 'tps']}, 05:40:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:40:12 INFO - 'tests': ['damp', 'tps']}, 05:40:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:40:12 INFO - 'tests': ['dromaeo_dom']}, 05:40:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:40:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:40:12 INFO - 'tests': ['basic_compositor_video']}, 05:40:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:40:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:40:12 INFO - 'tests': ['a11yr', 05:40:12 INFO - 'ts_paint', 05:40:12 INFO - 'tpaint', 05:40:12 INFO - 'sessionrestore', 05:40:12 INFO - 'sessionrestore_no_auto_restore', 05:40:12 INFO - 'tabpaint']}, 05:40:12 INFO - 'other-e10s': {'tests': ['a11yr', 05:40:12 INFO - 'ts_paint', 05:40:12 INFO - 'tpaint', 05:40:12 INFO - 'sessionrestore', 05:40:12 INFO - 'sessionrestore_no_auto_restore', 05:40:12 INFO - 'tabpaint']}, 05:40:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:40:12 INFO - 'ts_paint', 05:40:12 INFO - 'tpaint', 05:40:12 INFO - 'sessionrestore', 05:40:12 INFO - 'sessionrestore_no_auto_restore', 05:40:12 INFO - 'tabpaint']}, 05:40:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:40:12 INFO - 'ts_paint', 05:40:12 INFO - 'tpaint', 05:40:12 INFO - 'sessionrestore', 05:40:12 INFO - 'sessionrestore_no_auto_restore', 05:40:12 INFO - 'tabpaint']}, 05:40:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:40:12 INFO - 'tests': ['a11yr', 05:40:12 INFO - 'ts_paint', 05:40:12 INFO - 'tpaint', 05:40:12 INFO - 'sessionrestore', 05:40:12 INFO - 'sessionrestore_no_auto_restore', 05:40:12 INFO - 'tabpaint']}, 05:40:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:40:12 INFO - 'tests': ['a11yr', 05:40:12 INFO - 'ts_paint', 05:40:12 INFO - 'tpaint', 05:40:12 INFO - 'sessionrestore', 05:40:12 INFO - 'sessionrestore_no_auto_restore', 05:40:12 INFO - 'tabpaint']}, 05:40:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:40:12 INFO - 'tests': ['tsvgx', 05:40:12 INFO - 'tsvgr_opacity', 05:40:12 INFO - 'tart', 05:40:12 INFO - 'tscrollx', 05:40:12 INFO - 'cart', 05:40:12 INFO - 'tsvg_static']}, 05:40:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:40:12 INFO - 'tsvgr_opacity', 05:40:12 INFO - 'tart', 05:40:12 INFO - 'tscrollx', 05:40:12 INFO - 'cart', 05:40:12 INFO - 'tsvg_static']}, 05:40:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:40:12 INFO - 'talos_options': ['--disable-e10s'], 05:40:12 INFO - 'tests': ['tp5o']}, 05:40:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:40:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:40:12 INFO - 'talos_options': ['--disable-e10s', 05:40:12 INFO - '--xperf_path', 05:40:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:40:12 INFO - 'tests': ['tp5n']}, 05:40:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:40:12 INFO - 'talos_options': ['--xperf_path', 05:40:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:40:12 INFO - 'tests': ['tp5n']}}, 05:40:12 INFO - 'talos.zip': {'path': '', 05:40:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:40:12 INFO - Running post-action listener: _resource_record_post_action 05:40:12 INFO - [mozharness: 2017-02-15 13:40:12.504961Z] Finished populate-webroot step (success) 05:40:12 INFO - [mozharness: 2017-02-15 13:40:12.505074Z] Running create-virtualenv step. 05:40:12 INFO - Running pre-action listener: _resource_record_pre_action 05:40:12 INFO - Running main action method: create_virtualenv 05:40:12 INFO - Creating virtualenv /builds/slave/test/build/venv 05:40:12 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:40:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:40:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:40:12 INFO - Using real prefix '/tools/python27' 05:40:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:40:13 INFO - Installing distribute.............................................................................................................................................................................................done. 05:40:16 INFO - Installing pip.................done. 05:40:16 INFO - Return code: 0 05:40:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:40:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:40:16 INFO - Reading from file tmpfile_stdout 05:40:16 INFO - Output received: 05:40:16 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:40:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:40:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:16 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 0x107c1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd091c89cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079fdd30>, '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 0x107924db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079f2be8>, '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.oPjRj4BfFu/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.Vc3sRddbA8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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:40:16 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:40:16 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:40:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oPjRj4BfFu/Render', 05:40:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:16 INFO - 'HOME': '/Users/cltbld', 05:40:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:16 INFO - 'LOGNAME': 'cltbld', 05:40:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:16 INFO - 'MOZ_NO_REMOTE': '1', 05:40:16 INFO - 'NO_EM_RESTART': '1', 05:40:16 INFO - 'PAGER': '/bin/cat', 05:40:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:16 INFO - 'PWD': '/builds/slave/test', 05:40:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:16 INFO - 'SHELL': '/bin/bash', 05:40:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vc3sRddbA8/Listeners', 05:40:16 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 05:40:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:16 INFO - 'USER': 'cltbld', 05:40:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:16 INFO - 'XPC_FLAGS': '0x0', 05:40:16 INFO - 'XPC_SERVICE_NAME': '0', 05:40:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:16 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:40:16 INFO - Cleaning up... 05:40:16 INFO - Return code: 0 05:40:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:40:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:16 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 0x107c1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd091c89cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079fdd30>, '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 0x107924db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079f2be8>, '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.oPjRj4BfFu/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.Vc3sRddbA8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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:40:16 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:40:16 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:40:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oPjRj4BfFu/Render', 05:40:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:16 INFO - 'HOME': '/Users/cltbld', 05:40:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:16 INFO - 'LOGNAME': 'cltbld', 05:40:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:16 INFO - 'MOZ_NO_REMOTE': '1', 05:40:16 INFO - 'NO_EM_RESTART': '1', 05:40:16 INFO - 'PAGER': '/bin/cat', 05:40:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:16 INFO - 'PWD': '/builds/slave/test', 05:40:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:16 INFO - 'SHELL': '/bin/bash', 05:40:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vc3sRddbA8/Listeners', 05:40:16 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 05:40:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:16 INFO - 'USER': 'cltbld', 05:40:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:16 INFO - 'XPC_FLAGS': '0x0', 05:40:16 INFO - 'XPC_SERVICE_NAME': '0', 05:40:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:17 INFO - Downloading/unpacking psutil>=3.1.1 05:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:40:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:40:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:40:20 INFO - Installing collected packages: psutil 05:40:20 INFO - Running setup.py install for psutil 05:40:20 INFO - building 'psutil._psutil_osx' extension 05:40:20 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:40:21 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:40:21 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:40:21 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:40:21 INFO - building 'psutil._psutil_posix' extension 05:40:21 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:40:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:40:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:40:21 INFO - ^ 05:40:21 INFO - 1 warning generated. 05:40:21 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:40:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:40:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:40:21 INFO - Successfully installed psutil 05:40:21 INFO - Cleaning up... 05:40:21 INFO - Return code: 0 05:40:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:40:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:21 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 0x107c1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd091c89cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079fdd30>, '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 0x107924db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079f2be8>, '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.oPjRj4BfFu/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.Vc3sRddbA8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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:40:21 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:40:21 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:40:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oPjRj4BfFu/Render', 05:40:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:21 INFO - 'HOME': '/Users/cltbld', 05:40:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:21 INFO - 'LOGNAME': 'cltbld', 05:40:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:21 INFO - 'MOZ_NO_REMOTE': '1', 05:40:21 INFO - 'NO_EM_RESTART': '1', 05:40:21 INFO - 'PAGER': '/bin/cat', 05:40:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:21 INFO - 'PWD': '/builds/slave/test', 05:40:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:21 INFO - 'SHELL': '/bin/bash', 05:40:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vc3sRddbA8/Listeners', 05:40:21 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 05:40:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:21 INFO - 'USER': 'cltbld', 05:40:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:21 INFO - 'XPC_FLAGS': '0x0', 05:40:21 INFO - 'XPC_SERVICE_NAME': '0', 05:40:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:40:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:40:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:40:24 INFO - Installing collected packages: mozsystemmonitor 05:40:24 INFO - Running setup.py install for mozsystemmonitor 05:40:24 INFO - Successfully installed mozsystemmonitor 05:40:24 INFO - Cleaning up... 05:40:24 INFO - Return code: 0 05:40:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:40:24 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:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:24 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:40:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:24 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 0x107c1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd091c89cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079fdd30>, '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 0x107924db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079f2be8>, '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.oPjRj4BfFu/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.Vc3sRddbA8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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:40:24 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:40:24 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:40:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oPjRj4BfFu/Render', 05:40:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:24 INFO - 'HOME': '/Users/cltbld', 05:40:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:24 INFO - 'LOGNAME': 'cltbld', 05:40:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:24 INFO - 'MOZ_NO_REMOTE': '1', 05:40:24 INFO - 'NO_EM_RESTART': '1', 05:40:24 INFO - 'PAGER': '/bin/cat', 05:40:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:24 INFO - 'PWD': '/builds/slave/test', 05:40:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:24 INFO - 'SHELL': '/bin/bash', 05:40:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vc3sRddbA8/Listeners', 05:40:24 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 05:40:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:24 INFO - 'USER': 'cltbld', 05:40:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:24 INFO - 'XPC_FLAGS': '0x0', 05:40:24 INFO - 'XPC_SERVICE_NAME': '0', 05:40:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:25 INFO - Downloading/unpacking jsonschema==2.5.1 05:40:25 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:40:25 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:40:25 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:40:25 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:40:25 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:40:25 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:40:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:40:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:40:27 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:40:27 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:40:27 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:40:27 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:40:27 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:40:27 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:40:28 INFO - Downloading functools32-3.2.3-2.tar.gz 05:40:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:40:28 INFO - warning: no files found matching '*.txt' 05:40:28 INFO - no previously-included directories found matching 'build' 05:40:28 INFO - no previously-included directories found matching 'dist' 05:40:28 INFO - no previously-included directories found matching '.git*' 05:40:28 INFO - Installing collected packages: jsonschema, functools32 05:40:28 INFO - Running setup.py install for functools32 05:40:28 INFO - warning: no files found matching '*.txt' 05:40:28 INFO - no previously-included directories found matching 'build' 05:40:28 INFO - no previously-included directories found matching 'dist' 05:40:28 INFO - no previously-included directories found matching '.git*' 05:40:28 INFO - Successfully installed jsonschema functools32 05:40:28 INFO - Cleaning up... 05:40:28 INFO - Return code: 0 05:40:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:40:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:28 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 0x107c1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd091c89cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079fdd30>, '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 0x107924db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079f2be8>, '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.oPjRj4BfFu/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.Vc3sRddbA8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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:40:28 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:40:28 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:40:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oPjRj4BfFu/Render', 05:40:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:28 INFO - 'HOME': '/Users/cltbld', 05:40:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:28 INFO - 'LOGNAME': 'cltbld', 05:40:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:28 INFO - 'MOZ_NO_REMOTE': '1', 05:40:28 INFO - 'NO_EM_RESTART': '1', 05:40:28 INFO - 'PAGER': '/bin/cat', 05:40:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:28 INFO - 'PWD': '/builds/slave/test', 05:40:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:28 INFO - 'SHELL': '/bin/bash', 05:40:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vc3sRddbA8/Listeners', 05:40:28 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 05:40:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:28 INFO - 'USER': 'cltbld', 05:40:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:28 INFO - 'XPC_FLAGS': '0x0', 05:40:28 INFO - 'XPC_SERVICE_NAME': '0', 05:40:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:40:28 INFO - Cleaning up... 05:40:28 INFO - Return code: 0 05:40:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:40:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:28 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 0x107c1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd091c89cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079fdd30>, '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 0x107924db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079f2be8>, '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.oPjRj4BfFu/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.Vc3sRddbA8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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:40:28 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:40:28 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:40:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oPjRj4BfFu/Render', 05:40:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:28 INFO - 'HOME': '/Users/cltbld', 05:40:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:28 INFO - 'LOGNAME': 'cltbld', 05:40:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:28 INFO - 'MOZ_NO_REMOTE': '1', 05:40:28 INFO - 'NO_EM_RESTART': '1', 05:40:28 INFO - 'PAGER': '/bin/cat', 05:40:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:28 INFO - 'PWD': '/builds/slave/test', 05:40:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:28 INFO - 'SHELL': '/bin/bash', 05:40:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vc3sRddbA8/Listeners', 05:40:28 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 05:40:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:28 INFO - 'USER': 'cltbld', 05:40:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:28 INFO - 'XPC_FLAGS': '0x0', 05:40:28 INFO - 'XPC_SERVICE_NAME': '0', 05:40:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:29 INFO - Downloading/unpacking blobuploader==1.2.4 05:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:31 INFO - Downloading blobuploader-1.2.4.tar.gz 05:40:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:40:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:40:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:40:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:33 INFO - Downloading docopt-0.6.1.tar.gz 05:40:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:40:33 INFO - Installing collected packages: blobuploader, requests, docopt 05:40:33 INFO - Running setup.py install for blobuploader 05:40:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:40:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:40:33 INFO - Running setup.py install for requests 05:40:33 INFO - Running setup.py install for docopt 05:40:34 INFO - Successfully installed blobuploader requests docopt 05:40:34 INFO - Cleaning up... 05:40:34 INFO - Return code: 0 05:40:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:34 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 0x107c1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd091c89cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079fdd30>, '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 0x107924db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079f2be8>, '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.oPjRj4BfFu/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.Vc3sRddbA8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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:40:34 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:40:34 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:40:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oPjRj4BfFu/Render', 05:40:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:34 INFO - 'HOME': '/Users/cltbld', 05:40:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:34 INFO - 'LOGNAME': 'cltbld', 05:40:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:34 INFO - 'MOZ_NO_REMOTE': '1', 05:40:34 INFO - 'NO_EM_RESTART': '1', 05:40:34 INFO - 'PAGER': '/bin/cat', 05:40:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:34 INFO - 'PWD': '/builds/slave/test', 05:40:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:34 INFO - 'SHELL': '/bin/bash', 05:40:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vc3sRddbA8/Listeners', 05:40:34 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 05:40:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:34 INFO - 'USER': 'cltbld', 05:40:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:34 INFO - 'XPC_FLAGS': '0x0', 05:40:34 INFO - 'XPC_SERVICE_NAME': '0', 05:40:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:40:34 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-NTxQTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:40:34 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-5egoCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:40:34 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-6E5XZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:40:34 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-HDDhLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:40:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:40:34 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-UkGzne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:40:35 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-E_Sbd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:40:35 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-4qnpwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:40:35 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-iRTus6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:40:35 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-bkRve8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:40:35 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-Vt0Qxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:40:35 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-m9LVun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:40:35 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-R2KlQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:40:35 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-jsPpXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:40:35 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-eaYPQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:40:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:35 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-fhmbtt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:40:36 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-waRnCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:40:36 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-JT25UG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:40:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:40:36 INFO - Running setup.py install for manifestparser 05:40:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:40:36 INFO - Running setup.py install for mozcrash 05:40:36 INFO - Running setup.py install for mozdebug 05:40:36 INFO - Running setup.py install for mozdevice 05:40:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:40:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:40:36 INFO - Running setup.py install for mozfile 05:40:36 INFO - Running setup.py install for mozhttpd 05:40:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:40:37 INFO - Running setup.py install for mozinfo 05:40:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:40:37 INFO - Running setup.py install for mozInstall 05:40:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:40:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:40:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:40:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:40:37 INFO - Running setup.py install for mozleak 05:40:37 INFO - Running setup.py install for mozlog 05:40:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:40:37 INFO - Running setup.py install for moznetwork 05:40:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:40:37 INFO - Running setup.py install for mozprocess 05:40:38 INFO - Running setup.py install for mozprofile 05:40:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:40:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:40:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:40:38 INFO - Running setup.py install for mozrunner 05:40:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:40:38 INFO - Running setup.py install for mozscreenshot 05:40:38 INFO - Running setup.py install for moztest 05:40:38 INFO - Running setup.py install for mozversion 05:40:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:40:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:40:38 INFO - Cleaning up... 05:40:38 INFO - Return code: 0 05:40:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:40:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:38 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 0x107c1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd091c89cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079fdd30>, '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 0x107924db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079f2be8>, '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.oPjRj4BfFu/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.Vc3sRddbA8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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:40:38 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:40:38 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:40:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oPjRj4BfFu/Render', 05:40:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:38 INFO - 'HOME': '/Users/cltbld', 05:40:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:38 INFO - 'LOGNAME': 'cltbld', 05:40:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:38 INFO - 'MOZ_NO_REMOTE': '1', 05:40:38 INFO - 'NO_EM_RESTART': '1', 05:40:38 INFO - 'PAGER': '/bin/cat', 05:40:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:38 INFO - 'PWD': '/builds/slave/test', 05:40:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:38 INFO - 'SHELL': '/bin/bash', 05:40:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vc3sRddbA8/Listeners', 05:40:38 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 05:40:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:38 INFO - 'USER': 'cltbld', 05:40:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:38 INFO - 'XPC_FLAGS': '0x0', 05:40:38 INFO - 'XPC_SERVICE_NAME': '0', 05:40:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:40:39 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-icbJJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:40:39 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:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:40:39 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-cl1Jhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:40:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:40:39 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-Qb1j3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:40:39 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:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:40:39 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-7U1yFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:40:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:40:39 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-DCxf8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:40:39 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:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:40:39 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-6xYTwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:40:39 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:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:40:39 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-EYfFZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:40:39 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:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:40:39 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-JH7Ist-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:40:39 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:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:40:39 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-UvVNdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:40:40 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:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:40:40 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-crUypA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:40:40 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:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:40:40 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-UhcRhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:40:40 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:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:40:40 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-5wp__6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:40:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:40:40 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-Ug7rIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:40:40 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:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:40:40 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-H8Kbvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:40:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:40 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-LqJNdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:40 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:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:40:40 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-6oh3U3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:40:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:40:40 INFO - Running setup.py (path:/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/pip-bEAQns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:40:40 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:40:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:40:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:40:40 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:40:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:40:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:40:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:43 INFO - Downloading blessings-1.6.tar.gz 05:40:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:40:43 INFO - Installing collected packages: blessings 05:40:43 INFO - Running setup.py install for blessings 05:40:43 INFO - Successfully installed blessings 05:40:43 INFO - Cleaning up... 05:40:43 INFO - Return code: 0 05:40:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:40:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:40:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:40:44 INFO - Reading from file tmpfile_stdout 05:40:44 INFO - Current package versions: 05:40:44 INFO - blessings == 1.6 05:40:44 INFO - blobuploader == 1.2.4 05:40:44 INFO - docopt == 0.6.1 05:40:44 INFO - functools32 == 3.2.3-2 05:40:44 INFO - jsonschema == 2.5.1 05:40:44 INFO - manifestparser == 1.1 05:40:44 INFO - mozInstall == 1.12 05:40:44 INFO - mozcrash == 1.0 05:40:44 INFO - mozdebug == 0.1 05:40:44 INFO - mozdevice == 0.49 05:40:44 INFO - mozfile == 1.2 05:40:44 INFO - mozhttpd == 0.7 05:40:44 INFO - mozinfo == 0.9 05:40:44 INFO - mozleak == 0.1 05:40:44 INFO - mozlog == 3.4 05:40:44 INFO - moznetwork == 0.27 05:40:44 INFO - mozprocess == 0.24 05:40:44 INFO - mozprofile == 0.28 05:40:44 INFO - mozrunner == 6.13 05:40:44 INFO - mozscreenshot == 0.1 05:40:44 INFO - mozsystemmonitor == 0.3 05:40:44 INFO - moztest == 0.8 05:40:44 INFO - mozversion == 1.4 05:40:44 INFO - psutil == 3.1.1 05:40:44 INFO - requests == 1.2.3 05:40:44 INFO - wsgiref == 0.1.2 05:40:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:40: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:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40: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:40:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:44 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 0x107c1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd091c89cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079fdd30>, '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 0x107924db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079f2be8>, '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.oPjRj4BfFu/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.Vc3sRddbA8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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:40:44 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:40:44 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:40:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oPjRj4BfFu/Render', 05:40:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:44 INFO - 'HOME': '/Users/cltbld', 05:40:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:44 INFO - 'LOGNAME': 'cltbld', 05:40:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:44 INFO - 'MOZ_NO_REMOTE': '1', 05:40:44 INFO - 'NO_EM_RESTART': '1', 05:40:44 INFO - 'PAGER': '/bin/cat', 05:40:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:44 INFO - 'PWD': '/builds/slave/test', 05:40:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:44 INFO - 'SHELL': '/bin/bash', 05:40:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vc3sRddbA8/Listeners', 05:40:44 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 05:40:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:44 INFO - 'USER': 'cltbld', 05:40:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:44 INFO - 'XPC_FLAGS': '0x0', 05:40:44 INFO - 'XPC_SERVICE_NAME': '0', 05:40:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:45 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:40:45 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:40:45 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:40:45 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:40:45 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:40:45 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:40:45 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:40:45 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:40:45 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:40:45 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:40:45 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:40:45 INFO - Cleaning up... 05:40:45 INFO - Return code: 0 05:40:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:40: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:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40: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:40:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107c1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd091c89cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079fdd30>, '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 0x107924db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079f2be8>, '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.oPjRj4BfFu/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.Vc3sRddbA8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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:40: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', 'jsonschema'] in /builds/slave/test/build 05:40: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 jsonschema 05:40:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oPjRj4BfFu/Render', 05:40:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:45 INFO - 'HOME': '/Users/cltbld', 05:40:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:45 INFO - 'LOGNAME': 'cltbld', 05:40:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:45 INFO - 'MOZ_NO_REMOTE': '1', 05:40:45 INFO - 'NO_EM_RESTART': '1', 05:40:45 INFO - 'PAGER': '/bin/cat', 05:40:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:45 INFO - 'PWD': '/builds/slave/test', 05:40:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:45 INFO - 'SHELL': '/bin/bash', 05:40:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vc3sRddbA8/Listeners', 05:40:45 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 05:40:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:45 INFO - 'USER': 'cltbld', 05:40:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:45 INFO - 'XPC_FLAGS': '0x0', 05:40:45 INFO - 'XPC_SERVICE_NAME': '0', 05:40:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:40:45 INFO - Cleaning up... 05:40:45 INFO - Return code: 0 05:40:45 INFO - Running post-action listener: _resource_record_post_action 05:40:45 INFO - Running post-action listener: _start_resource_monitoring 05:40:45 INFO - Starting resource monitoring. 05:40:45 INFO - [mozharness: 2017-02-15 13:40:45.830595Z] Finished create-virtualenv step (success) 05:40:45 INFO - [mozharness: 2017-02-15 13:40:45.831580Z] Running install step. 05:40:45 INFO - Running pre-action listener: _resource_record_pre_action 05:40:45 INFO - Running main action method: install 05:40:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:40:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:40:46 INFO - Reading from file tmpfile_stdout 05:40:46 INFO - Detecting whether we're running mozinstall >=1.0... 05:40:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:40:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:40:46 INFO - Reading from file tmpfile_stdout 05:40:46 INFO - Output received: 05:40:46 INFO - Usage: mozinstall [options] installer 05:40:46 INFO - Options: 05:40:46 INFO - -h, --help show this help message and exit 05:40:46 INFO - -d DEST, --destination=DEST 05:40:46 INFO - Directory to install application into. [default: 05:40:46 INFO - "/builds/slave/test"] 05:40:46 INFO - --app=APP Application being installed. [default: firefox] 05:40:46 INFO - mkdir: /builds/slave/test/build/application 05:40:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:40:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 05:41:06 INFO - Reading from file tmpfile_stdout 05:41:06 INFO - Output received: 05:41:06 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 05:41:06 INFO - Running post-action listener: _resource_record_post_action 05:41:06 INFO - [mozharness: 2017-02-15 13:41:06.063482Z] Finished install step (success) 05:41:06 INFO - [mozharness: 2017-02-15 13:41:06.063622Z] Running run-tests step. 05:41:06 INFO - Running pre-action listener: _resource_record_pre_action 05:41:06 INFO - Running main action method: run_tests 05:41:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:41:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:41:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:41:06 INFO - 2017-02-15 05:41:06.077 screenresolution[1621:7406] starting screenresolution argv=screenresolution get 05:41:06 INFO - 2017-02-15 05:41:06.080 screenresolution[1621:7406] Display 0: 1600x1200x32@60 05:41:06 INFO - 2017-02-15 05:41:06.086 screenresolution[1622:7408] starting screenresolution argv=screenresolution list 05:41:06 INFO - Available Modes on Display 0 05:41:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:41:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:41:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:41:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:41:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:41:06 INFO - Intel Iris: 05:41:06 INFO - Chipset Model: Intel Iris 05:41:06 INFO - Type: GPU 05:41:06 INFO - Bus: Built-In 05:41:06 INFO - VRAM (Dynamic, Max): 1536 MB 05:41:06 INFO - Vendor: Intel (0x8086) 05:41:06 INFO - Device ID: 0x0a2e 05:41:06 INFO - Revision ID: 0x0009 05:41:06 INFO - Displays: 05:41:06 INFO - Display: 05:41:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:41:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:41:06 INFO - Display Serial Number: 1600x1200 60 05:41:06 INFO - Main Display: Yes 05:41:06 INFO - Mirror: Off 05:41:06 INFO - Online: Yes 05:41:06 INFO - Rotation: Supported 05:41:06 INFO - Return code: 0 05:41:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:41:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:41:06 INFO - Python 2.7.3 05:41:06 INFO - Return code: 0 05:41:06 INFO - grabbing minidump binary from tooltool 05:41: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:41:06 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 0x1079fdd30>, '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 0x107924db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079f2be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:41:06 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:41:06 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:41:06 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:41:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:41:06 INFO - Return code: 0 05:41:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:41:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:41:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:41:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:41:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:41:06 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/WK11h5tuSvmMms1lC-S2ZQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0197', '--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:41:06 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/WK11h5tuSvmMms1lC-S2ZQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0197 --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:41:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oPjRj4BfFu/Render', 05:41:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:41:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:41:06 INFO - 'HOME': '/Users/cltbld', 05:41:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:41:06 INFO - 'LOGNAME': 'cltbld', 05:41:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:41:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:41:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:06 INFO - 'MOZ_NO_REMOTE': '1', 05:41:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:41:06 INFO - 'NO_EM_RESTART': '1', 05:41:06 INFO - 'PAGER': '/bin/cat', 05:41:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:41:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:06 INFO - 'PWD': '/builds/slave/test', 05:41:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:41:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:41:06 INFO - 'SHELL': '/bin/bash', 05:41:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vc3sRddbA8/Listeners', 05:41:06 INFO - 'TMPDIR': '/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/', 05:41:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:41:06 INFO - 'USER': 'cltbld', 05:41:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:41:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:41:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:06 INFO - 'XPC_FLAGS': '0x0', 05:41:06 INFO - 'XPC_SERVICE_NAME': '0', 05:41:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:41:06 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/WK11h5tuSvmMms1lC-S2ZQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0197', '--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:41:06 INFO - mozversion application_buildid: 20170215045044 05:41:06 INFO - mozversion application_changeset: 6c660ca9126fbc8f2c9fd91d7c48853d2268d136 05:41:06 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:41:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:41:06 INFO - mozversion application_name: Firefox 05:41:06 INFO - mozversion application_remotingname: firefox-dev 05:41:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:41:06 INFO - mozversion application_vendor: Mozilla 05:41:06 INFO - mozversion application_version: 53.0a2 05:41:06 INFO - mozversion platform_buildid: 20170215045044 05:41:06 INFO - mozversion platform_changeset: 6c660ca9126fbc8f2c9fd91d7c48853d2268d136 05:41:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:41:06 INFO - mozversion platform_version: 53.0a2 05:41:06 INFO - using testdate: 1487166066 05:41:06 INFO - actual date: 1487166066 05:41:06 INFO - starting webserver on 'localhost:49241' 05:41:06 INFO - SUITE-START | Running 2 tests 05:41:06 INFO - TEST-START | dromaeo_css 05:41:06 INFO - operating with platform_type : mac_ 05:41:06 INFO - Initialising browser for dromaeo_css test... 05:41:06 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/tmpInqf7A/profile http://localhost:49241/getInfo.html) 05:41:09 INFO - PROCESS | 1632 | __metrics Screen width/height:1600/1200 05:41:09 INFO - PROCESS | 1632 | colorDepth:24 05:41:09 INFO - PROCESS | 1632 | Browser inner width/height: 1024/689 05:41:09 INFO - PROCESS | 1632 | __metrics 05:41:09 INFO - PROCESS | 1632 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:41:09 INFO - PROCESS | 1632 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:41:10 INFO - TEST-INFO | 1632: exit 0 05:41:10 INFO - Browser initialized. 05:41:10 INFO - Running cycle 1/1 for dromaeo_css test... 05:41:10 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/tmpInqf7A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:41:22 INFO - PROCESS | 1634 | RSS: Main: 213340160 05:41:22 INFO - PROCESS | 1634 | 05:44:26 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 05:44:28 INFO - PROCESS | 1634 | RSS: Main: 364523520 05:44:28 INFO - PROCESS | 1634 | 05:46:11 INFO - PROCESS | 1634 | ************************* 05:46:11 INFO - PROCESS | 1634 | A coding exception was thrown and uncaught in a Task. 05:46:11 INFO - PROCESS | 1634 | 05:46:11 ERROR - PROCESS | 1634 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:46:11 INFO - PROCESS | 1634 | Full stack: 05:46:11 INFO - PROCESS | 1634 | ************************* 05:47:31 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 05:47:32 INFO - PROCESS | 1634 | RSS: Main: 349368320 05:47:32 INFO - PROCESS | 1634 | 05:50:34 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 05:50:35 INFO - PROCESS | 1634 | RSS: Main: 320663552 05:50:35 INFO - PROCESS | 1634 | 05:53:37 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 05:53:38 INFO - PROCESS | 1634 | RSS: Main: 327278592 05:53:38 INFO - PROCESS | 1634 | 05:56:41 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 05:56:42 INFO - PROCESS | 1634 | RSS: Main: 308826112 05:56:42 INFO - PROCESS | 1634 | 05:59:45 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 05:59:45 INFO - PROCESS | 1634 | RSS: Main: 546734080 05:59:45 INFO - PROCESS | 1634 | 05:59:45 INFO - PROCESS | 1634 | __start_tp_report 05:59:45 INFO - PROCESS | 1634 | _x_x_mozilla_page_load 05:59:45 INFO - PROCESS | 1634 | _x_x_mozilla_page_load_details 05:59:45 INFO - PROCESS | 1634 | |i|pagename|runs| 05:59:45 INFO - PROCESS | 1634 | |0;dojo.html;3309.635940046595;3312.354090952264;3319.4688849784025;3338.0486561330026;3382.3573521031003;5599;5637.323521177459;5671.829845104643;5679.602427830054;5695.458931401516;5650.378458369576;5651.689157096368;5700.572457065727;5731.684757338345;5734.913976290349;4938.555530002299;4944.703317800943;5180.4560521145395;5209.609279304048;5223.112070947929;5104.923426148611;5109.642325037249;5114.977004599076;5292.5765938725;5293.232481290211;5192.896142077157;5226.425093239741;5240.842774716764;5262.763175657085;5297.496737809902;5255.921161182585;5266.710330931797;5272;5278.102722537178;5279.841604751864;5051.873703157414;5142.562882155022;5214;5218.399884013311;5253.474652534755;5569.0254205513875;5628.493435590816;5637.520810731093;5690.516306113986;5709.914351284734;6247.656378899159;6279.8744025119695;6299.401556852092;6302.590331628429;6309.652969086698;6334.049892516114;6345.048242763576;6353.5234857385885;6364.6181229126405;6364.936350636481;5589.329280486368;5607.327120745536;5665.065264231355;5723.255976723082;5774.653520788682;6312.652804095727;6317;6319.494440444753;6325.177726895567;6327.905081423783;6175.413335733098;6189.442950134509;6189.473894718909;6190.473809726223;6199.442050215503;6129.785457508966;6167.321594624587;6168.1056246844855;6236.563440559117;6278.121063051177;6133.662648554283;6200.472959798378;6214.502839772807;6252.968735156295;6282.780102696383;5214.869628259324;6282.120503129566;6287.245530536274;6293.779717709858;6299.905501417483;4850.417949846041;4956.950430495721;4983.152864013054;4987.127252730757;4992.8751781205765;4376.693631445768;4401.911961760811;4411.602955733999;4425.491068527096;4445.911081778347;5683.261176047087;5759.913601295984;5783.942160578425;5792.247007889032;5836.445537673914;6137.622145770991;6142.959235178526;6210.534209934273;6288.5598008139905;6292.779752708725;5741.942580574141;5814.04068328721;5815;5824.737886795105;5851.444112809277;5296.1261391870685;5353.2237825515085;5361.142217245222;5405.78376864921;5425.864353391197;6321.431071203614;6332.683365831598;6338.461230795434;6341.460975817107;6359.841003974938;6335.366463353628;6352.237731472253;6352.36476352361;6358.0780786784735;6360;5237.371515418022;6240.282367527792;6293.118963345044;6330.208723909512;6332.240131184288;6166.321704612579;6272.905906411499;6273.874522509433;6276.623402595859;6291.087792270187;5206.479352064764;6197.659128747782;6326.272478664829;6327.829351569791;6343.841403964938;5032.917922646649;5682.77268909239;5937.881242375042;6166.537509686881;6189.6286222826775;6072.72672729737;6077.6353418795015;6139.140520327069;6175.44421002112;6190.978488549339;6041.093835924471;6046.425589568984;6046.788362407295;6047.5464340173785;6056.031035034373;5920.555958303231;6151.2618485781995;6162.075688646739;6173.660448675366;6196.566240363131;5864.354920958776;5929.940700592939;5930.851728706644;5940.287165540163;5954.19618351517 05:59:45 INFO - PROCESS | 1634 | |1;ext.html;450.8331917190638;464.4728233455028;477.99522004779953;503.99999999999994;512.9435762066172;30142.849285753568;39217.41173882394;41086.58913410865;41121.794391028;41325.96685082874;42420.575794242046;42980;43022.35466468005;43094.138117237635;43157;8279.089300177005;9249.352545321814;9444.1972432343;9459.57431915562;9522.714318570454;8273.46222495536;9722.368046077017;11081.612143574977;11304.434778261055;11316.717082072932;11387.032102271316;11483.483243254032;11483.59807406741;11495.540178392854;11499;8347.916520834835;11363.659090227306;11442.942785286103;11443.828342574869;11468;8318.70884519045;10984.231103822736;11243.550257989671;11278.984891359816;11425.542978280859;39821;40132.79933600313;40172;40211.39682904759;40244.798776006224;3966.702497312713;3966.920661586781;3978.761274323521;3993.3211354069877;4058.228936502055;27798.16605501838;28743;29492.8525357374;30922.226944326347;31060.223494412596;3141.575887255237;3155.5739975103297;3242.789218700777;3343.130785995634;3374.4432168692138;349662;350890;350919;352409;481220;61463.38536614577;61891.690541547905;61936;62087.37912620906;62178.68910655418;65341.67329163324;65357.67321163459;65462.67268663721;65483;65500.68998620001;15982.920085399499;16438.917805410896;16475.517203451745;16492.505224843033;16507.752383714254;11332.716682083013;11698.590549330733;12496.50013999448;12590.874091259153;12597.118201725974;14578;15697.921510392374;16291.348346066025;16362.67274654524;16513.752293715603;6425.3574642536305;7514.473986820979;7571.069377308751;7588.354989825927;7650.349720273728;867.5488745852122;875.934304927133;888.5912480259024;892.1034360467688;893.4237416866085;28819.711802881702;29738.702612973593;29771;30217;30623.8468807659;930.6137952749668;1051.4217180550665;1080.065743132185;1085.234909388879;1219.0978675779859;13079.95360371168;13898.722025559433;15042.774358384633;15457.149856757986;15767.842321576867;497620;601180;602807;604270;607232;60020.699896500235;60093.39906600965;60279;60323.39676603265;60329;1448.7504527344963;1451.7822326651087;1458.9197594132424;1482.7331080405415;1486.1306135910397;22737;25754.991969224655;29008;29394.85302573559;29973.250668732584;50611.74694126506;50945.74527127341;51137;51283.48716512787;51336.229956551426;430737;518073;519186;519513;519966;33695.15762105967;39098.804505977285;39926.80036599799;39971.60028399795;40352.99117521968;37727.86816395513;38998;46812.82967925829;47572.04855902932;49667;32801.523931422664;37282;38076.23847523089;38837.41743873787;40440.59559404486;37927.62072379241;38121;38486.84539463821;38681.613183868925;39255.80372098121;37219.44170837385;37743.62256377511;38362.61637383702;38422;38665.42001869918;32554.34891302208;33354.99935001954;33517.16207094842;33660.15849603681;34938.47592286067;20897.477563061046;22347.217847375265;24321.51356972886;24337.75662243355;24499.38751531226 05:59:45 INFO - PROCESS | 1634 | |2;jquery.html;338.13100332146377;353.3022280995035;403.3385248192963;413.32834144515164;423.50449973530965;19145.52136196594;20187.99060046999;20923.790762092376;21225.36323910281;21300.124483194784;11921.701957451047;12178.086643501729;12202.755944881119;12344.95067919228;12375.876241237585;5170.017696637637;5378.489043540857;5389.865253368658;5395.676259424427;5407.83776486706;3891.0855948851995;4070.857519986801;5278.445763194867;7314.926850731478;7754.379649628045;7577;7746.088225446142;7797.961010194941;7918.049834019926;7942.205779422069;7698.923010769877;7735.922640773577;7789.337906278001;7798.415118866051;7804.843903121962;7421.888671669929;7519.924800751977;7569.356604688608;7672.3478504327195;7675.53946763196;29333.70666293331;29779.851100744356;29908.55137172944;30045.549316760265;30169.396612067856;2827.717228277176;2915.6792752797173;2934.325105225789;3361.126107212118;3363.730901527872;16845.747313790303;17015.149242537824;17021.659566808594;17481.47555573335;18116.365927192484;1936.3610008697237;1966.8918209498472;1985.0967809646577;2026.2097781865084;2039.51051747581;117681.4695559126;131523;152861;154771.63383959918;160429.19785401114;22606.208782692527;23948.640770388458;23997.640035399483;24062.278131655727;24247.7575224249;41683.5410760628;42193;42795.502157424344;42887.35668964968;42923;11268.774624507463;11319.660410187707;11571.42142892852;11574.88425115755;11742.530298788124;7772;8923.375363724606;9160.267178625694;9166.86249706255;9322.813543729088;9064.592093355683;10924.453777311262;11041.282316649393;11081.5567377304;11150.944245278723;3010.4345740214967;3901.648851603369;4105.568915263914;4121.979390103031;4156.605122513356;990.5294984882123;1009.7223263602568;1017.9338343007681;1020.5254556631202;1037.8754549453963;20847.791522084586;21227.89386053091;21267.93660316978;21318.360449186548;21562.676559851614;996.4071377530503;1035.1873779083382;1044.1438020822852;1074.586284280542;1079.8434227037192;10957.890421095846;11256.831147532794;11277.32336059839;11288.04051655602;11297.943510282395;622938;623031;630216;649631;750134;123589;147696;149169.76245356328;149359;152145.23927380514;979.3095867413457;997.4563862694848;1014.5282443663584;1044.9582016719398;1049.4700176410863;17677.85093968888;18255.726164107815;19147.71278430797;20026.699599505726;20072.19711211535;58856;59887.70056149692;61252.69373653103;61622.38377616167;61846.69076654588;71766.64116679384;88320;88910;90586.13857443017;91879.54060229656;7444.255574442729;8043;8059.153788852086;8167;8571.057183709912;9677.951610241904;11460.541578336773;12866.806997894852;13291.933540332237;13952.720945580828;10081.949590252001;11601.651950441501;11828.585999489977;11841.644750657493;11861.347625880659;9837.655682051094;11549.595764148215;11610.593629222936;12034.977026952807;12156.088293377856;10903.618373357212;10915.635545556805;11743.823842642196;12134.393280335771;12223.449944752685;12722.427490763122;13044.739105217654;13052.34738263102;13391.196528208338;13397.12918660284;11610.76778464443;11729.706757331134;11778.352190629597;12049.759004820029;12128.211666241667 05:59:45 INFO - PROCESS | 1634 | |3;mootools.html;1428.4357678716908;1431.59199628106;1443.6318738721625;1450.8186476690414;1455.8980871339006;7994.560299183542;8393.70622028229;8409.117042710512;8449.662013519459;8454.112318206591;5634.887302253953;7428.294312040348;7447.069116360455;7952.085510166333;8277.634190358598;2238.7089678341795;2308.9307320780404;2310.6534019897067;2312.8496647717843;2312.9653055204185;2312.2138472919205;2335.2643917166124;2348.283773449097;2349.9999999999914;2352.2237661571726;2002.7596688397414;2083.395815213586;2227.354067320475;2288.324944141474;2292.908283668651;2290.633498640218;2302.090674183705;2305.4005958450757;2309.376468353552;2311.838171328008;2243.270936945499;2283.931482055541;2286.399520335755;2320.1763374002326;2323.512062466884;8271.007479102485;8356.707515236998;8359.623816928253;8361.581920903991;8375.748727538183;5004.299398084271;5125.282460455539;5178.14560597501;5195.42850286472;5197.428282888879;3308.4541050726602;3466.532018177539;3479.530263414432;3547.2728090741593;3636.5454318210222;1150.6893138852463;1202.206543681175;1215.2647648172817;1229.5880879905242;1240.6092080994458;10340.586376544928;10675.733106672318;10848;10848.945755271252;10864.782704345947;3615.9096022599647;4334.566543345703;4517.774111294422;4534.818607255673;4535.092981403666;8609.69866054685;8610.44032137909;8618.655253789904;8621.396502244908;8630.223279904838;5110.28456016158;5120.513551212629;5122.513361230677;5126.179811230185;5126.1798112302595;4217.240896638573;4217.536071032184;4709.740964246999;4739.170645137087;4816.975915120402;3326.6507016763376;3680.9263814723554;3705.4256590228556;3776.811159442017;3790.905227369283;1113.604670342017;1160.6634076118;1163.5055101581793;1170.3329102411715;1172.8709841917382;774.3302043732243;870.1385628228008;876.386529429402;883.6774577279247;894.7539426657592;4956.3804524434445;5379.838604841861;5522.779088836402;5636.519931230246;5976.8804623908145;918.7657147427363;974.2498276327188;991.8313886639289;998.4758002048983;1003.6587560229557;3518.630543792916;3720.2001569662652;3756.8497260109834;3776.244751049801;3835.980820095882;9748.561314740853;9987.550560224807;10026.598936042477;10109.34289271195;10132.797344053077;9953.502324883726;9964.35231709951;9976.551055202533;9978;9990.500474976223;7298.379637730746;7657.310842024244;7662.233776622294;7723.575203363869;7758.728444504415;5551.278333816578;5614.747336369955;5637.154426836008;5745.023346031101;5772.336181339199;8717.65129394817;9084.318676099187;9307.441553506811;9352.485613291334;9358.625654973725;8512.276456501268;8514.233718965323;9290.303227257848;9523.28575356837;9541.427514349161;6355.3644635536075;6556.3443655634055;6961.686724097326;7106.6446677666945;7216.5670059796585;7819.452638315263;7938.761837144895;7991.84016319682;7993.920060799318;7997.320227780704;6995.510314277952;7115.217326094229;7153.427725781821;7190.7483238086415;7238.203797582367;6772.52592318533;6814.182298124058;6949.003995900293;6964.373206411447;6985.79042628722;6258.593191442542;6277.811665650038;6326;6347.90478142819;6449.290578036318;4903.730294833818;4916.410030796184;4930.728809915489;4951.1088004158155;4989.625778066587;4856.320115183807;4873.195922672861;4892.633052521146;5025.723585202702;5050.823221187241 05:59:45 INFO - PROCESS | 1634 | |4;prototype.html;309.58670175315956;353.64812012048014;364.3369068295703;367.08229426433917;372.81545634910725;3942.901427464315;5186.974065129669;5250.396204436491;5264.894702105956;5328.200769884519;4229.68277379197;4494.123645889044;4998.375203099613;5114.158902794991;5196.480351964801;4069.308217603015;4097.528784189812;4107.609777071173;4116.938245926306;4119.299719047769;3294.96705032949;3727.1054946812706;4128.649064829478;4134;4139.048018955642;4049.8380064797375;4060.2285565742413;4062.8577999770014;4064.9390259146135;4090.468239128909;3748.175401411685;3817.7210634437497;3839.9808000959956;3981.9203615927518;4054.594540545922;3609.8882153939976;3614.8011859347725;3641.635836416364;3642.562892452923;3644.763090399142;4177.057668184279;4267.146570685875;4744.691595046311;4943;5159.535641792257;4454.57681520255;4518.728876267434;4605.08888811143;4651.88370290742;4657.813687452498;4573;5036.736610242269;5218.825764203024;5490.862728431781;5516.420775818561;3486.9476957845654;3869.529578760081;3880.902977425587;4039.2527382434346;4044.2811804983057;4809.78355973982;4951.653384263067;5053.6967781932835;5530.640508366943;5767.682777447197;3743.812809359521;4084.7344922579937;4105.2405305018665;4114.107510545123;4114.238865809834;3716.851325946932;3888.7723189752437;3903.882883513499;4137.131202447459;4141.399497072968;4368.956310436918;4550.633670491326;4603.125406172817;4621.838235661736;4625.427354699418;4346.847860324873;5046.873828154326;5416.21464887597;5442.537384322377;5544.615815199422;1116.553378648547;1173.4250217393587;1242.6520574239228;1275.6364436135657;1332.7334533093226;850.6602101689863;885.066130504849;908.246155690775;959.8752162218867;967.0039858945297;4135.731177473514;4169.519820463753;4272.7222730523035;4473.411938761693;4648.814047438064;4701.777537840187;4907.803687852446;5317.8936421271355;5439.891202176013;5446.576273558228;4714.57568818808;4748.6675932685075;4915.48387419323;5113.8721531962;5125.616083657392;2498.575242208829;2596.6364708940764;2633.8288011279205;2693.6902256240783;2806.396624725653;4181.456410666655;5089;5135.306733590992;5284.233786101071;5291.735413229323;5325.3875804282225;5758.366579676316;5808.564357673107;5816.447437493432;5866.2960444746905;4883.95116048835;4890.828820991248;5879.941200588025;5880.4416829540205;5895.7618900031475;5292.036459582646;5360.284708893117;5435.592330575144;5668.574856885833;5705.62913410627;4885.828995985124;5179.507946745053;5454.645448045864;5593.384727680033;5618.831435056954;4719.787609557647;5106.693598384109;5344.499352923841;5348.705821179717;5904.114382842608;3398.337324221753;3531.6644918732677;3631.5279013729105;3797.867074652374;3840.8271627776257;5125.359330083739;5312.5484333832055;5544.667319960815;5620;5639.887202256014;5238.659487133325;5451.609839490904;5464.480874316933;5482.91522815505;5510.3938566758425;4187.895302617459;4237.533871274219;4812.112732360556;4936.5190442867715;5465.398806131402;4782.689125206851;5152.355955505562;5315.654482458628;5316.787328506816;5335.719427337333;5427.3134798275105;5469.480399362054;5470.59293910678;5513.531349835149;5521.1442226454965;4655.348251244761;4962.975185124052;5372.704501252312;5378.139497680352;5407.02643535099 05:59:45 INFO - PROCESS | 1634 | |5;yui.html;624.9126519855453;718.5832217313958;751.177460680555;805.9798505037376;827.7599496146117;13229.933850330746;14793.556193314218;15265.847341526594;15394.69210615787;15441.227938603068;13594.524191653294;13910.860891391108;13991.440342386319;14173.71652566948;14196.219207943584;665.6671664167916;856.5203486047817;876.1107475911955;876.119499902597;879.2131042716765;682.9214640316377;687.6871023684212;742.5693098003145;866.5840396609631;878.7890906182535;872.1932212703256;925.4771054354268;926.4996901673122;927.5825878354734;927.601131513449;918.6049998500642;918.9816203675956;919.7332773495679;920.4339331311229;922.7093465558361;510.7369704602133;526.512975497667;662.9270780214173;677.7526202935942;684.7945616315135;14715.190664513448;14754.336054877556;14763.188024658639;14775.81793456521;14777.482788102472;13393.598192054254;13396.531121410704;13430.597082087554;13476;13546.322683865867;11958.880411195863;12058;12330.19853709506;12333.93833030829;12673.112882098258;4208.305629571117;4301.913961720748;4454.554544545552;4491.708038977488;4552.68131230814;102085.48957255167;104803;106980;107365;107676;10245.948770256102;10351.06840384369;10443.791124177475;10998.285111467889;11143.72140696489;21080.262190823247;21084.262050828147;21118.78881211199;21121.78878211229;21133.68299475509;7260.346568808727;7489.962550187323;7715.922840771633;7746.922530774733;7774.572398518136;4192.622663960258;4237.555056719062;4287.078278170208;4311.978440107842;4383.969767104728;3167.445697003015;3250.593675790526;3251.7073463387937;3252.1381833814057;3253.4957081652383;627.6704730016686;634.7492740367529;635.8251480842713;637.757652092202;649.82129914273;640.6707268844405;644.2944975252092;645.583598578914;661.256086902235;666.7599664120912;9057.864132038025;9339.766505837273;9366.608042329075;9742.805143897082;9879.950600246953;553.2282465960044;577.7429044075346;605.748614325059;665.5640555436197;701.435344547644;4582.404287442611;4786.593139583175;4974.427940786856;5020.395980499424;5075.5178258065425;76899.61550192325;93338;96553.51723241339;98654.50672746733;99681.50159249302;69716.60566788635;88725;89769;92000;92728;80431;80592.59703701561;81124.59437702774;81285.59357203176;81329.18670813453;9761.17030052425;9803.803923921625;9826.852597210904;9837.950810245902;9870.605175793175;51472.22791658203;51741.41292935263;52073;52422.689432764484;52722.736386317825;68791.65604171947;69310;70009.59980800253;71340;72416;11855.466504007169;11897.643070707893;12203.450844711831;12254.571090011807;12620.053495987653;12113.515459381526;12188.022666566743;12526;13047.543335983195;13387.397567109698;11345.659630211107;12028.75942481128;12260;12334.938325308316;12527.749445011232;12042.518299267931;12132.575359862363;12298.569550065704;12535.93732031334;12542.686432839251;11071.723206919569;11996.160268781101;12000.879991199976;12033.699157521132;12426.37868106573;9394.859077113986;10185.33795303303;10272.537735802056;10361.585536578452;10478.183291169487;7747.225277472207;8391.622376993171;9511.381760185566;9924.007599240307;9959.800803983735 05:59:45 INFO - PROCESS | 1634 | __end_tp_report 05:59:45 INFO - PROCESS | 1634 | __start_cc_report 05:59:45 INFO - PROCESS | 1634 | _x_x_mozilla_cycle_collect,1667 05:59:45 INFO - PROCESS | 1634 | __end_cc_report 05:59:45 INFO - PROCESS | 1634 | __startTimestamp1487167185753__endTimestamp 05:59:45 INFO - PROCESS | 1634 | 05:59:45 INFO - PROCESS | 1634 | ------- Summary: start ------- 05:59:45 INFO - PROCESS | 1634 | Number of tests: 6 05:59:45 INFO - PROCESS | 1634 | 05:59:45 INFO - PROCESS | 1634 | [#0] dojo.html Cycles:165 Average:5735.82 Median:5929.94 stddev:660.73 (11.1%) stddev-sans-first:634.75 05:59:45 INFO - PROCESS | 1634 | Values: 3309.6 3312.4 3319.5 3338.0 3382.4 5599.0 5637.3 5671.8 5679.6 5695.5 5650.4 5651.7 5700.6 5731.7 5734.9 4938.6 4944.7 5180.5 5209.6 5223.1 5104.9 5109.6 5115.0 5292.6 5293.2 5192.9 5226.4 5240.8 5262.8 5297.5 5255.9 5266.7 5272.0 5278.1 5279.8 5051.9 5142.6 5214.0 5218.4 5253.5 5569.0 5628.5 5637.5 5690.5 5709.9 6247.7 6279.9 6299.4 6302.6 6309.7 6334.0 6345.0 6353.5 6364.6 6364.9 5589.3 5607.3 5665.1 5723.3 5774.7 6312.7 6317.0 6319.5 6325.2 6327.9 6175.4 6189.4 6189.5 6190.5 6199.4 6129.8 6167.3 6168.1 6236.6 6278.1 6133.7 6200.5 6214.5 6253.0 6282.8 5214.9 6282.1 6287.2 6293.8 6299.9 4850.4 4957.0 4983.2 4987.1 4992.9 4376.7 4401.9 4411.6 4425.5 4445.9 5683.3 5759.9 5783.9 5792.2 5836.4 6137.6 6143.0 6210.5 6288.6 6292.8 5741.9 5814.0 5815.0 5824.7 5851.4 5296.1 5353.2 5361.1 5405.8 5425.9 6321.4 6332.7 6338.5 6341.5 6359.8 6335.4 6352.2 6352.4 6358.1 6360.0 5237.4 6240.3 6293.1 6330.2 6332.2 6166.3 6272.9 6273.9 6276.6 6291.1 5206.5 6197.7 6326.3 6327.8 6343.8 5032.9 5682.8 5937.9 6166.5 6189.6 6072.7 6077.6 6139.1 6175.4 6191.0 6041.1 6046.4 6046.8 6047.5 6056.0 5920.6 6151.3 6162.1 6173.7 6196.6 5864.4 5929.9 5930.9 5940.3 5954.2 05:59:45 INFO - PROCESS | 1634 | 05:59:45 INFO - PROCESS | 1634 | [#1] ext.html Cycles:180 Average:63664.69 Median:38454.42 stddev:132213.58 (343.8%) stddev-sans-first:132499.29 05:59:45 INFO - PROCESS | 1634 | Values: 450.8 464.5 478.0 504.0 512.9 30142.8 39217.4 41086.6 41121.8 41326.0 42420.6 42980.0 43022.4 43094.1 43157.0 8279.1 9249.4 9444.2 9459.6 9522.7 8273.5 9722.4 11081.6 11304.4 11316.7 11387.0 11483.5 11483.6 11495.5 11499.0 8347.9 11363.7 11442.9 11443.8 11468.0 8318.7 10984.2 11243.6 11279.0 11425.5 39821.0 40132.8 40172.0 40211.4 40244.8 3966.7 3966.9 3978.8 3993.3 4058.2 27798.2 28743.0 29492.9 30922.2 31060.2 3141.6 3155.6 3242.8 3343.1 3374.4 349662.0 350890.0 350919.0 352409.0 481220.0 61463.4 61891.7 61936.0 62087.4 62178.7 65341.7 65357.7 65462.7 65483.0 65500.7 15982.9 16438.9 16475.5 16492.5 16507.8 11332.7 11698.6 12496.5 12590.9 12597.1 14578.0 15697.9 16291.3 16362.7 16513.8 6425.4 7514.5 7571.1 7588.4 7650.3 867.5 875.9 888.6 892.1 893.4 28819.7 29738.7 29771.0 30217.0 30623.8 930.6 1051.4 1080.1 1085.2 1219.1 13080.0 13898.7 15042.8 15457.1 15767.8 497620.0 601180.0 602807.0 604270.0 607232.0 60020.7 60093.4 60279.0 60323.4 60329.0 1448.8 1451.8 1458.9 1482.7 1486.1 22737.0 25755.0 29008.0 29394.9 29973.3 50611.7 50945.7 51137.0 51283.5 51336.2 430737.0 518073.0 519186.0 519513.0 519966.0 33695.2 39098.8 39926.8 39971.6 40353.0 37727.9 38998.0 46812.8 47572.0 49667.0 32801.5 37282.0 38076.2 38837.4 40440.6 37927.6 38121.0 38486.8 38681.6 39255.8 37219.4 37743.6 38362.6 38422.0 38665.4 32554.3 33355.0 33517.2 33660.2 34938.5 20897.5 22347.2 24321.5 24337.8 24499.4 05:59:45 INFO - PROCESS | 1634 | 05:59:45 INFO - PROCESS | 1634 | [#2] jquery.html Cycles:180 Average:40138.89 Median:21309.24 stddev:110003.72 (516.2%) stddev-sans-first:110271.71 05:59:45 INFO - PROCESS | 1634 | Values: 338.1 353.3 403.3 413.3 423.5 19145.5 20188.0 20923.8 21225.4 21300.1 11921.7 12178.1 12202.8 12345.0 12375.9 5170.0 5378.5 5389.9 5395.7 5407.8 3891.1 4070.9 5278.4 7314.9 7754.4 7577.0 7746.1 7798.0 7918.0 7942.2 7698.9 7735.9 7789.3 7798.4 7804.8 7421.9 7519.9 7569.4 7672.3 7675.5 29333.7 29779.9 29908.6 30045.5 30169.4 2827.7 2915.7 2934.3 3361.1 3363.7 16845.7 17015.1 17021.7 17481.5 18116.4 1936.4 1966.9 1985.1 2026.2 2039.5 117681.5 131523.0 152861.0 154771.6 160429.2 22606.2 23948.6 23997.6 24062.3 24247.8 41683.5 42193.0 42795.5 42887.4 42923.0 11268.8 11319.7 11571.4 11574.9 11742.5 7772.0 8923.4 9160.3 9166.9 9322.8 9064.6 10924.5 11041.3 11081.6 11150.9 3010.4 3901.6 4105.6 4122.0 4156.6 990.5 1009.7 1017.9 1020.5 1037.9 20847.8 21227.9 21267.9 21318.4 21562.7 996.4 1035.2 1044.1 1074.6 1079.8 10957.9 11256.8 11277.3 11288.0 11297.9 622938.0 623031.0 630216.0 649631.0 750134.0 123589.0 147696.0 149169.8 149359.0 152145.2 979.3 997.5 1014.5 1045.0 1049.5 17677.9 18255.7 19147.7 20026.7 20072.2 58856.0 59887.7 61252.7 61622.4 61846.7 71766.6 88320.0 88910.0 90586.1 91879.5 7444.3 8043.0 8059.2 8167.0 8571.1 9678.0 11460.5 12866.8 13291.9 13952.7 10081.9 11601.7 11828.6 11841.6 11861.3 9837.7 11549.6 11610.6 12035.0 12156.1 10903.6 10915.6 11743.8 12134.4 12223.4 12722.4 13044.7 13052.3 13391.2 13397.1 11610.8 11729.7 11778.4 12049.8 12128.2 05:59:45 INFO - PROCESS | 1634 | 05:59:45 INFO - PROCESS | 1634 | [#3] mootools.html Cycles:180 Average:5345.03 Median:5126.18 stddev:2908.80 (56.7%) stddev-sans-first:2902.06 05:59:45 INFO - PROCESS | 1634 | Values: 1428.4 1431.6 1443.6 1450.8 1455.9 7994.6 8393.7 8409.1 8449.7 8454.1 5634.9 7428.3 7447.1 7952.1 8277.6 2238.7 2308.9 2310.7 2312.8 2313.0 2312.2 2335.3 2348.3 2350.0 2352.2 2002.8 2083.4 2227.4 2288.3 2292.9 2290.6 2302.1 2305.4 2309.4 2311.8 2243.3 2283.9 2286.4 2320.2 2323.5 8271.0 8356.7 8359.6 8361.6 8375.7 5004.3 5125.3 5178.1 5195.4 5197.4 3308.5 3466.5 3479.5 3547.3 3636.5 1150.7 1202.2 1215.3 1229.6 1240.6 10340.6 10675.7 10848.0 10848.9 10864.8 3615.9 4334.6 4517.8 4534.8 4535.1 8609.7 8610.4 8618.7 8621.4 8630.2 5110.3 5120.5 5122.5 5126.2 5126.2 4217.2 4217.5 4709.7 4739.2 4817.0 3326.7 3680.9 3705.4 3776.8 3790.9 1113.6 1160.7 1163.5 1170.3 1172.9 774.3 870.1 876.4 883.7 894.8 4956.4 5379.8 5522.8 5636.5 5976.9 918.8 974.2 991.8 998.5 1003.7 3518.6 3720.2 3756.8 3776.2 3836.0 9748.6 9987.6 10026.6 10109.3 10132.8 9953.5 9964.4 9976.6 9978.0 9990.5 7298.4 7657.3 7662.2 7723.6 7758.7 5551.3 5614.7 5637.2 5745.0 5772.3 8717.7 9084.3 9307.4 9352.5 9358.6 8512.3 8514.2 9290.3 9523.3 9541.4 6355.4 6556.3 6961.7 7106.6 7216.6 7819.5 7938.8 7991.8 7993.9 7997.3 6995.5 7115.2 7153.4 7190.7 7238.2 6772.5 6814.2 6949.0 6964.4 6985.8 6258.6 6277.8 6326.0 6347.9 6449.3 4903.7 4916.4 4930.7 4951.1 4989.6 4856.3 4873.2 4892.6 5025.7 5050.8 05:59:45 INFO - PROCESS | 1634 | 05:59:45 INFO - PROCESS | 1634 | [#4] prototype.html Cycles:180 Average:4375.50 Median:4765.68 stddev:1303.30 (27.3%) stddev-sans-first:1270.72 05:59:45 INFO - PROCESS | 1634 | Values: 309.6 353.6 364.3 367.1 372.8 3942.9 5187.0 5250.4 5264.9 5328.2 4229.7 4494.1 4998.4 5114.2 5196.5 4069.3 4097.5 4107.6 4116.9 4119.3 3295.0 3727.1 4128.6 4134.0 4139.0 4049.8 4060.2 4062.9 4064.9 4090.5 3748.2 3817.7 3840.0 3981.9 4054.6 3609.9 3614.8 3641.6 3642.6 3644.8 4177.1 4267.1 4744.7 4943.0 5159.5 4454.6 4518.7 4605.1 4651.9 4657.8 4573.0 5036.7 5218.8 5490.9 5516.4 3486.9 3869.5 3880.9 4039.3 4044.3 4809.8 4951.7 5053.7 5530.6 5767.7 3743.8 4084.7 4105.2 4114.1 4114.2 3716.9 3888.8 3903.9 4137.1 4141.4 4369.0 4550.6 4603.1 4621.8 4625.4 4346.8 5046.9 5416.2 5442.5 5544.6 1116.6 1173.4 1242.7 1275.6 1332.7 850.7 885.1 908.2 959.9 967.0 4135.7 4169.5 4272.7 4473.4 4648.8 4701.8 4907.8 5317.9 5439.9 5446.6 4714.6 4748.7 4915.5 5113.9 5125.6 2498.6 2596.6 2633.8 2693.7 2806.4 4181.5 5089.0 5135.3 5284.2 5291.7 5325.4 5758.4 5808.6 5816.4 5866.3 4884.0 4890.8 5879.9 5880.4 5895.8 5292.0 5360.3 5435.6 5668.6 5705.6 4885.8 5179.5 5454.6 5593.4 5618.8 4719.8 5106.7 5344.5 5348.7 5904.1 3398.3 3531.7 3631.5 3797.9 3840.8 5125.4 5312.5 5544.7 5620.0 5639.9 5238.7 5451.6 5464.5 5482.9 5510.4 4187.9 4237.5 4812.1 4936.5 5465.4 4782.7 5152.4 5315.7 5316.8 5335.7 5427.3 5469.5 5470.6 5513.5 5521.1 4655.3 4963.0 5372.7 5378.1 5407.0 05:59:45 INFO - PROCESS | 1634 | 05:59:45 INFO - PROCESS | 1634 | [#5] yui.html Cycles:180 Average:20017.09 Median:51606.82 stddev:28979.40 (56.2%) stddev-sans-first:29024.11 05:59:45 INFO - PROCESS | 1634 | Values: 624.9 718.6 751.2 806.0 827.8 13229.9 14793.6 15265.8 15394.7 15441.2 13594.5 13910.9 13991.4 14173.7 14196.2 665.7 856.5 876.1 876.1 879.2 682.9 687.7 742.6 866.6 878.8 872.2 925.5 926.5 927.6 927.6 918.6 919.0 919.7 920.4 922.7 510.7 526.5 662.9 677.8 684.8 14715.2 14754.3 14763.2 14775.8 14777.5 13393.6 13396.5 13430.6 13476.0 13546.3 11958.9 12058.0 12330.2 12333.9 12673.1 4208.3 4301.9 4454.6 4491.7 4552.7 102085.5 104803.0 106980.0 107365.0 107676.0 10245.9 10351.1 10443.8 10998.3 11143.7 21080.3 21084.3 21118.8 21121.8 21133.7 7260.3 7490.0 7715.9 7746.9 7774.6 4192.6 4237.6 4287.1 4312.0 4384.0 3167.4 3250.6 3251.7 3252.1 3253.5 627.7 634.7 635.8 637.8 649.8 640.7 644.3 645.6 661.3 666.8 9057.9 9339.8 9366.6 9742.8 9880.0 553.2 577.7 605.7 665.6 701.4 4582.4 4786.6 4974.4 5020.4 5075.5 76899.6 93338.0 96553.5 98654.5 99681.5 69716.6 88725.0 89769.0 92000.0 92728.0 80431.0 80592.6 81124.6 81285.6 81329.2 9761.2 9803.8 9826.9 9838.0 9870.6 51472.2 51741.4 52073.0 52422.7 52722.7 68791.7 69310.0 70009.6 71340.0 72416.0 11855.5 11897.6 12203.5 12254.6 12620.1 12113.5 12188.0 12526.0 13047.5 13387.4 11345.7 12028.8 12260.0 12334.9 12527.7 12042.5 12132.6 12298.6 12535.9 12542.7 11071.7 11996.2 12000.9 12033.7 12426.4 9394.9 10185.3 10272.5 10361.6 10478.2 7747.2 8391.6 9511.4 9924.0 9959.8 05:59:45 INFO - PROCESS | 1634 | -------- Summary: end -------- 05:59:45 INFO - PROCESS | 1634 | 05:59:46 INFO - TEST-INFO | 1634: exit 0 05:59:46 INFO - TEST-OK | dromaeo_css | took 1119755ms 05:59:46 INFO - TEST-START | kraken 05:59:46 INFO - operating with platform_type : mac_ 05:59:46 INFO - Initialising browser for kraken test... 05:59:46 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/tmp5hcylZ/profile http://localhost:49241/getInfo.html) 05:59:48 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 05:59:48 INFO - PROCESS | 1643 | colorDepth:24 05:59:48 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 05:59:48 INFO - PROCESS | 1643 | __metrics 05:59:48 INFO - PROCESS | 1643 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:59:48 INFO - PROCESS | 1643 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:59:49 INFO - TEST-INFO | 1643: exit 0 05:59:49 INFO - Browser initialized. 05:59:49 INFO - Running cycle 1/1 for kraken test... 05:59:49 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/T/tmp5hcylZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:00:01 INFO - PROCESS | 1644 | RSS: Main: 213061632 06:00:01 INFO - PROCESS | 1644 | 06:00:04 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 06:00:05 INFO - PROCESS | 1644 | RSS: Main: 265740288 06:00:05 INFO - PROCESS | 1644 | 06:00:07 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 06:00:08 INFO - PROCESS | 1644 | RSS: Main: 276480000 06:00:08 INFO - PROCESS | 1644 | 06:00:11 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 06:00:12 INFO - PROCESS | 1644 | RSS: Main: 373264384 06:00:12 INFO - PROCESS | 1644 | 06:00:14 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 06:00:14 INFO - PROCESS | 1644 | RSS: Main: 276586496 06:00:14 INFO - PROCESS | 1644 | 06:00:16 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:00:17 INFO - PROCESS | 1644 | RSS: Main: 278634496 06:00:17 INFO - PROCESS | 1644 | 06:00:20 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 06:00:20 INFO - PROCESS | 1644 | RSS: Main: 317890560 06:00:20 INFO - PROCESS | 1644 | 06:00:23 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 06:00:24 INFO - PROCESS | 1644 | RSS: Main: 320008192 06:00:24 INFO - PROCESS | 1644 | 06:00:27 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 06:00:28 INFO - PROCESS | 1644 | RSS: Main: 314699776 06:00:28 INFO - PROCESS | 1644 | 06:00:29 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:00:30 INFO - PROCESS | 1644 | RSS: Main: 294674432 06:00:30 INFO - PROCESS | 1644 | 06:00:32 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:00:32 INFO - PROCESS | 1644 | RSS: Main: 298274816 06:00:32 INFO - PROCESS | 1644 | 06:00:34 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:00:35 INFO - PROCESS | 1644 | RSS: Main: 300220416 06:00:35 INFO - PROCESS | 1644 | 06:00:38 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:00:39 INFO - PROCESS | 1644 | RSS: Main: 317526016 06:00:39 INFO - PROCESS | 1644 | 06:00:42 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:00:42 INFO - PROCESS | 1644 | RSS: Main: 311508992 06:00:42 INFO - PROCESS | 1644 | 06:00:44 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 06:00:44 INFO - PROCESS | 1644 | RSS: Main: 355938304 06:00:44 INFO - PROCESS | 1644 | 06:00:44 INFO - PROCESS | 1644 | __start_tp_report 06:00:44 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 06:00:44 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 06:00:44 INFO - PROCESS | 1644 | |i|pagename|runs| 06:00:44 INFO - PROCESS | 1644 | |0;ai-astar;115;113;115;114;112;114;113;113;113;114 06:00:44 INFO - PROCESS | 1644 | |1;audio-beat-detection;140;108;108;140;111;107;92;114;180;137 06:00:44 INFO - PROCESS | 1644 | |2;audio-dft;184;181;182;185;183;185;182;185;184;184 06:00:44 INFO - PROCESS | 1644 | |3;audio-fft;81;58;58;89;61;60;59;76;72;58 06:00:44 INFO - PROCESS | 1644 | |4;audio-oscillator;111;97;119;74;68;68;81;69;68;81 06:00:44 INFO - PROCESS | 1644 | |5;imaging-gaussian-blur;88;86;88;86;88;85;88;85;88;84 06:00:44 INFO - PROCESS | 1644 | |6;imaging-darkroom;102;155;97;97;97;115;170;97;98;97 06:00:44 INFO - PROCESS | 1644 | |7;imaging-desaturate;86;85;85;87;99;136;141;87;108;141 06:00:44 INFO - PROCESS | 1644 | |8;json-parse-financial;55;53;54;53;57;57;56;56;57;56 06:00:44 INFO - PROCESS | 1644 | |9;json-stringify-tinderbox;65;73;72;73;70;67;69;66;70;69 06:00:44 INFO - PROCESS | 1644 | |10;stanford-crypto-aes;87;84;83;84;83;86;98;87;87;85 06:00:44 INFO - PROCESS | 1644 | |11;stanford-crypto-ccm;137;137;138;137;134;139;140;140;207;171 06:00:44 INFO - PROCESS | 1644 | |12;stanford-crypto-pbkdf2;155;166;167;168;167;168;167;165;163;226 06:00:44 INFO - PROCESS | 1644 | |13;stanford-crypto-sha256-iterative;66;67;65;66;64;65;63;65;64;62 06:00:44 INFO - PROCESS | 1644 | __end_tp_report 06:00:44 INFO - PROCESS | 1644 | __start_cc_report 06:00:44 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,2011 06:00:44 INFO - PROCESS | 1644 | __end_cc_report 06:00:44 INFO - PROCESS | 1644 | __startTimestamp1487167244717__endTimestamp 06:00:44 INFO - PROCESS | 1644 | 06:00:44 INFO - PROCESS | 1644 | ------- Summary: start ------- 06:00:44 INFO - PROCESS | 1644 | Number of tests: 14 06:00:44 INFO - PROCESS | 1644 | 06:00:44 INFO - PROCESS | 1644 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:0.97 (0.8%) stddev-sans-first:0.88 06:00:44 INFO - PROCESS | 1644 | Values: 115.0 113.0 115.0 114.0 112.0 114.0 113.0 113.0 113.0 114.0 06:00:44 INFO - PROCESS | 1644 | 06:00:44 INFO - PROCESS | 1644 | [#1] audio-beat-detection Cycles:10 Average:123.70 Median:138.50 stddev:25.63 (18.5%) stddev-sans-first:26.49 06:00:44 INFO - PROCESS | 1644 | Values: 140.0 108.0 108.0 140.0 111.0 107.0 92.0 114.0 180.0 137.0 06:00:44 INFO - PROCESS | 1644 | 06:00:44 INFO - PROCESS | 1644 | [#2] audio-dft Cycles:10 Average:183.50 Median:184.00 stddev:1.43 (0.8%) stddev-sans-first:1.51 06:00:44 INFO - PROCESS | 1644 | Values: 184.0 181.0 182.0 185.0 183.0 185.0 182.0 185.0 184.0 184.0 06:00:44 INFO - PROCESS | 1644 | 06:00:44 INFO - PROCESS | 1644 | [#3] audio-fft Cycles:10 Average:67.20 Median:66.50 stddev:11.44 (17.2%) stddev-sans-first:10.99 06:00:44 INFO - PROCESS | 1644 | Values: 81.0 58.0 58.0 89.0 61.0 60.0 59.0 76.0 72.0 58.0 06:00:44 INFO - PROCESS | 1644 | 06:00:44 INFO - PROCESS | 1644 | [#4] audio-oscillator Cycles:10 Average:83.60 Median:71.50 stddev:18.95 (26.5%) stddev-sans-first:17.31 06:00:44 INFO - PROCESS | 1644 | Values: 111.0 97.0 119.0 74.0 68.0 68.0 81.0 69.0 68.0 81.0 06:00:44 INFO - PROCESS | 1644 | 06:00:44 INFO - PROCESS | 1644 | [#5] imaging-gaussian-blur Cycles:10 Average:86.60 Median:88.00 stddev:1.58 (1.8%) stddev-sans-first:1.59 06:00:44 INFO - PROCESS | 1644 | Values: 88.0 86.0 88.0 86.0 88.0 85.0 88.0 85.0 88.0 84.0 06:00:44 INFO - PROCESS | 1644 | 06:00:44 INFO - PROCESS | 1644 | [#6] imaging-darkroom Cycles:10 Average:112.50 Median:97.00 stddev:27.16 (28.0%) stddev-sans-first:28.54 06:00:44 INFO - PROCESS | 1644 | Values: 102.0 155.0 97.0 97.0 97.0 115.0 170.0 97.0 98.0 97.0 06:00:44 INFO - PROCESS | 1644 | 06:00:44 INFO - PROCESS | 1644 | [#7] imaging-desaturate Cycles:10 Average:105.50 Median:85.50 stddev:24.51 (28.7%) stddev-sans-first:24.95 06:00:44 INFO - PROCESS | 1644 | Values: 86.0 85.0 85.0 87.0 99.0 136.0 141.0 87.0 108.0 141.0 06:00:44 INFO - PROCESS | 1644 | 06:00:44 INFO - PROCESS | 1644 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:56.00 stddev:1.58 (2.8%) stddev-sans-first:1.67 06:00:44 INFO - PROCESS | 1644 | Values: 55.0 53.0 54.0 53.0 57.0 57.0 56.0 56.0 57.0 56.0 06:00:44 INFO - PROCESS | 1644 | 06:00:44 INFO - PROCESS | 1644 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:70.00 stddev:2.80 (4.0%) stddev-sans-first:2.47 06:00:44 INFO - PROCESS | 1644 | Values: 65.0 73.0 72.0 73.0 70.0 67.0 69.0 66.0 70.0 69.0 06:00:44 INFO - PROCESS | 1644 | 06:00:44 INFO - PROCESS | 1644 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:86.50 stddev:4.38 (5.1%) stddev-sans-first:4.64 06:00:44 INFO - PROCESS | 1644 | Values: 87.0 84.0 83.0 84.0 83.0 86.0 98.0 87.0 87.0 85.0 06:00:44 INFO - PROCESS | 1644 | 06:00:44 INFO - PROCESS | 1644 | [#11] stanford-crypto-ccm Cycles:10 Average:148.00 Median:139.50 stddev:23.28 (16.7%) stddev-sans-first:24.35 06:00:44 INFO - PROCESS | 1644 | Values: 137.0 137.0 138.0 137.0 134.0 139.0 140.0 140.0 207.0 171.0 06:00:44 INFO - PROCESS | 1644 | 06:00:44 INFO - PROCESS | 1644 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.20 Median:167.00 stddev:19.64 (11.8%) stddev-sans-first:19.94 06:00:44 INFO - PROCESS | 1644 | Values: 155.0 166.0 167.0 168.0 167.0 168.0 167.0 165.0 163.0 226.0 06:00:44 INFO - PROCESS | 1644 | 06:00:44 INFO - PROCESS | 1644 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:1.49 (2.3%) stddev-sans-first:1.51 06:00:44 INFO - PROCESS | 1644 | Values: 66.0 67.0 65.0 66.0 64.0 65.0 63.0 65.0 64.0 62.0 06:00:44 INFO - PROCESS | 1644 | -------- Summary: end -------- 06:00:44 INFO - PROCESS | 1644 | 06:00:45 INFO - TEST-INFO | 1644: exit 0 06:00:45 INFO - TEST-OK | kraken | took 59211ms 06:00:45 INFO - SUITE-END | took 1178s 06:00:45 INFO - Completed test suite (00:19:39) 06:00:45 INFO - javascript benchmark 06:00:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3309.635940046595, 3312.354090952264, 3319.4688849784025, 3338.0486561330026, 3382.3573521031003, 5599.0, 5637.323521177459, 5671.829845104643, 5679.602427830054, 5695.458931401516, 5650.378458369576, 5651.689157096368, 5700.572457065727, 5731.684757338345, 5734.913976290349, 4938.555530002299, 4944.703317800943, 5180.4560521145395, 5209.609279304048, 5223.112070947929, 5104.923426148611, 5109.642325037249, 5114.977004599076, 5292.5765938725, 5293.232481290211, 5192.896142077157, 5226.425093239741, 5240.842774716764, 5262.763175657085, 5297.496737809902, 5255.921161182585, 5266.710330931797, 5272.0, 5278.102722537178, 5279.841604751864, 5051.873703157414, 5142.562882155022, 5214.0, 5218.399884013311, 5253.474652534755, 5569.0254205513875, 5628.493435590816, 5637.520810731093, 5690.516306113986, 5709.914351284734, 6247.656378899159, 6279.8744025119695, 6299.401556852092, 6302.590331628429, 6309.652969086698, 6334.049892516114, 6345.048242763576, 6353.5234857385885, 6364.6181229126405, 6364.936350636481, 5589.329280486368, 5607.327120745536, 5665.065264231355, 5723.255976723082, 5774.653520788682, 6312.652804095727, 6317.0, 6319.494440444753, 6325.177726895567, 6327.905081423783, 6175.413335733098, 6189.442950134509, 6189.473894718909, 6190.473809726223, 6199.442050215503, 6129.785457508966, 6167.321594624587, 6168.1056246844855, 6236.563440559117, 6278.121063051177, 6133.662648554283, 6200.472959798378, 6214.502839772807, 6252.968735156295, 6282.780102696383, 5214.869628259324, 6282.120503129566, 6287.245530536274, 6293.779717709858, 6299.905501417483, 4850.417949846041, 4956.950430495721, 4983.152864013054, 4987.127252730757, 4992.8751781205765, 4376.693631445768, 4401.911961760811, 4411.602955733999, 4425.491068527096, 4445.911081778347, 5683.261176047087, 5759.913601295984, 5783.942160578425, 5792.247007889032, 5836.445537673914, 6137.622145770991, 6142.959235178526, 6210.534209934273, 6288.5598008139905, 6292.779752708725, 5741.942580574141, 5814.04068328721, 5815.0, 5824.737886795105, 5851.444112809277, 5296.1261391870685, 5353.2237825515085, 5361.142217245222, 5405.78376864921, 5425.864353391197, 6321.431071203614, 6332.683365831598, 6338.461230795434, 6341.460975817107, 6359.841003974938, 6335.366463353628, 6352.237731472253, 6352.36476352361, 6358.0780786784735, 6360.0, 5237.371515418022, 6240.282367527792, 6293.118963345044, 6330.208723909512, 6332.240131184288, 6166.321704612579, 6272.905906411499, 6273.874522509433, 6276.623402595859, 6291.087792270187, 5206.479352064764, 6197.659128747782, 6326.272478664829, 6327.829351569791, 6343.841403964938, 5032.917922646649, 5682.77268909239, 5937.881242375042, 6166.537509686881, 6189.6286222826775, 6072.72672729737, 6077.6353418795015, 6139.140520327069, 6175.44421002112, 6190.978488549339, 6041.093835924471, 6046.425589568984, 6046.788362407295, 6047.5464340173785, 6056.031035034373, 5920.555958303231, 6151.2618485781995, 6162.075688646739, 6173.660448675366, 6196.566240363131, 5864.354920958776, 5929.940700592939, 5930.851728706644, 5940.287165540163, 5954.19618351517], "value": 5693.252536249286, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [450.8331917190638, 464.4728233455028, 477.99522004779953, 503.99999999999994, 512.9435762066172, 30142.849285753568, 39217.41173882394, 41086.58913410865, 41121.794391028, 41325.96685082874, 42420.575794242046, 42980.0, 43022.35466468005, 43094.138117237635, 43157.0, 8279.089300177005, 9249.352545321814, 9444.1972432343, 9459.57431915562, 9522.714318570454, 8273.46222495536, 9722.368046077017, 11081.612143574977, 11304.434778261055, 11316.717082072932, 11387.032102271316, 11483.483243254032, 11483.59807406741, 11495.540178392854, 11499.0, 8347.916520834835, 11363.659090227306, 11442.942785286103, 11443.828342574869, 11468.0, 8318.70884519045, 10984.231103822736, 11243.550257989671, 11278.984891359816, 11425.542978280859, 39821.0, 40132.79933600313, 40172.0, 40211.39682904759, 40244.798776006224, 3966.702497312713, 3966.920661586781, 3978.761274323521, 3993.3211354069877, 4058.228936502055, 27798.16605501838, 28743.0, 29492.8525357374, 30922.226944326347, 31060.223494412596, 3141.575887255237, 3155.5739975103297, 3242.789218700777, 3343.130785995634, 3374.4432168692138, 349662.0, 350890.0, 350919.0, 352409.0, 481220.0, 61463.38536614577, 61891.690541547905, 61936.0, 62087.37912620906, 62178.68910655418, 65341.67329163324, 65357.67321163459, 65462.67268663721, 65483.0, 65500.68998620001, 15982.920085399499, 16438.917805410896, 16475.517203451745, 16492.505224843033, 16507.752383714254, 11332.716682083013, 11698.590549330733, 12496.50013999448, 12590.874091259153, 12597.118201725974, 14578.0, 15697.921510392374, 16291.348346066025, 16362.67274654524, 16513.752293715603, 6425.3574642536305, 7514.473986820979, 7571.069377308751, 7588.354989825927, 7650.349720273728, 867.5488745852122, 875.934304927133, 888.5912480259024, 892.1034360467688, 893.4237416866085, 28819.711802881702, 29738.702612973593, 29771.0, 30217.0, 30623.8468807659, 930.6137952749668, 1051.4217180550665, 1080.065743132185, 1085.234909388879, 1219.0978675779859, 13079.95360371168, 13898.722025559433, 15042.774358384633, 15457.149856757986, 15767.842321576867, 497620.0, 601180.0, 602807.0, 604270.0, 607232.0, 60020.699896500235, 60093.39906600965, 60279.0, 60323.39676603265, 60329.0, 1448.7504527344963, 1451.7822326651087, 1458.9197594132424, 1482.7331080405415, 1486.1306135910397, 22737.0, 25754.991969224655, 29008.0, 29394.85302573559, 29973.250668732584, 50611.74694126506, 50945.74527127341, 51137.0, 51283.48716512787, 51336.229956551426, 430737.0, 518073.0, 519186.0, 519513.0, 519966.0, 33695.15762105967, 39098.804505977285, 39926.80036599799, 39971.60028399795, 40352.99117521968, 37727.86816395513, 38998.0, 46812.82967925829, 47572.04855902932, 49667.0, 32801.523931422664, 37282.0, 38076.23847523089, 38837.41743873787, 40440.59559404486, 37927.62072379241, 38121.0, 38486.84539463821, 38681.613183868925, 39255.80372098121, 37219.44170837385, 37743.62256377511, 38362.61637383702, 38422.0, 38665.42001869918, 32554.34891302208, 33354.99935001954, 33517.16207094842, 33660.15849603681, 34938.47592286067, 20897.477563061046, 22347.217847375265, 24321.51356972886, 24337.75662243355, 24499.38751531226], "value": 19927.61517716982, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.13100332146377, 353.3022280995035, 403.3385248192963, 413.32834144515164, 423.50449973530965, 19145.52136196594, 20187.99060046999, 20923.790762092376, 21225.36323910281, 21300.124483194784, 11921.701957451047, 12178.086643501729, 12202.755944881119, 12344.95067919228, 12375.876241237585, 5170.017696637637, 5378.489043540857, 5389.865253368658, 5395.676259424427, 5407.83776486706, 3891.0855948851995, 4070.857519986801, 5278.445763194867, 7314.926850731478, 7754.379649628045, 7577.0, 7746.088225446142, 7797.961010194941, 7918.049834019926, 7942.205779422069, 7698.923010769877, 7735.922640773577, 7789.337906278001, 7798.415118866051, 7804.843903121962, 7421.888671669929, 7519.924800751977, 7569.356604688608, 7672.3478504327195, 7675.53946763196, 29333.70666293331, 29779.851100744356, 29908.55137172944, 30045.549316760265, 30169.396612067856, 2827.717228277176, 2915.6792752797173, 2934.325105225789, 3361.126107212118, 3363.730901527872, 16845.747313790303, 17015.149242537824, 17021.659566808594, 17481.47555573335, 18116.365927192484, 1936.3610008697237, 1966.8918209498472, 1985.0967809646577, 2026.2097781865084, 2039.51051747581, 117681.4695559126, 131523.0, 152861.0, 154771.63383959918, 160429.19785401114, 22606.208782692527, 23948.640770388458, 23997.640035399483, 24062.278131655727, 24247.7575224249, 41683.5410760628, 42193.0, 42795.502157424344, 42887.35668964968, 42923.0, 11268.774624507463, 11319.660410187707, 11571.42142892852, 11574.88425115755, 11742.530298788124, 7772.0, 8923.375363724606, 9160.267178625694, 9166.86249706255, 9322.813543729088, 9064.592093355683, 10924.453777311262, 11041.282316649393, 11081.5567377304, 11150.944245278723, 3010.4345740214967, 3901.648851603369, 4105.568915263914, 4121.979390103031, 4156.605122513356, 990.5294984882123, 1009.7223263602568, 1017.9338343007681, 1020.5254556631202, 1037.8754549453963, 20847.791522084586, 21227.89386053091, 21267.93660316978, 21318.360449186548, 21562.676559851614, 996.4071377530503, 1035.1873779083382, 1044.1438020822852, 1074.586284280542, 1079.8434227037192, 10957.890421095846, 11256.831147532794, 11277.32336059839, 11288.04051655602, 11297.943510282395, 622938.0, 623031.0, 630216.0, 649631.0, 750134.0, 123589.0, 147696.0, 149169.76245356328, 149359.0, 152145.23927380514, 979.3095867413457, 997.4563862694848, 1014.5282443663584, 1044.9582016719398, 1049.4700176410863, 17677.85093968888, 18255.726164107815, 19147.71278430797, 20026.699599505726, 20072.19711211535, 58856.0, 59887.70056149692, 61252.69373653103, 61622.38377616167, 61846.69076654588, 71766.64116679384, 88320.0, 88910.0, 90586.13857443017, 91879.54060229656, 7444.255574442729, 8043.0, 8059.153788852086, 8167.0, 8571.057183709912, 9677.951610241904, 11460.541578336773, 12866.806997894852, 13291.933540332237, 13952.720945580828, 10081.949590252001, 11601.651950441501, 11828.585999489977, 11841.644750657493, 11861.347625880659, 9837.655682051094, 11549.595764148215, 11610.593629222936, 12034.977026952807, 12156.088293377856, 10903.618373357212, 10915.635545556805, 11743.823842642196, 12134.393280335771, 12223.449944752685, 12722.427490763122, 13044.739105217654, 13052.34738263102, 13391.196528208338, 13397.12918660284, 11610.76778464443, 11729.706757331134, 11778.352190629597, 12049.759004820029, 12128.211666241667], "value": 11487.144624727069, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1428.4357678716908, 1431.59199628106, 1443.6318738721625, 1450.8186476690414, 1455.8980871339006, 7994.560299183542, 8393.70622028229, 8409.117042710512, 8449.662013519459, 8454.112318206591, 5634.887302253953, 7428.294312040348, 7447.069116360455, 7952.085510166333, 8277.634190358598, 2238.7089678341795, 2308.9307320780404, 2310.6534019897067, 2312.8496647717843, 2312.9653055204185, 2312.2138472919205, 2335.2643917166124, 2348.283773449097, 2349.9999999999914, 2352.2237661571726, 2002.7596688397414, 2083.395815213586, 2227.354067320475, 2288.324944141474, 2292.908283668651, 2290.633498640218, 2302.090674183705, 2305.4005958450757, 2309.376468353552, 2311.838171328008, 2243.270936945499, 2283.931482055541, 2286.399520335755, 2320.1763374002326, 2323.512062466884, 8271.007479102485, 8356.707515236998, 8359.623816928253, 8361.581920903991, 8375.748727538183, 5004.299398084271, 5125.282460455539, 5178.14560597501, 5195.42850286472, 5197.428282888879, 3308.4541050726602, 3466.532018177539, 3479.530263414432, 3547.2728090741593, 3636.5454318210222, 1150.6893138852463, 1202.206543681175, 1215.2647648172817, 1229.5880879905242, 1240.6092080994458, 10340.586376544928, 10675.733106672318, 10848.0, 10848.945755271252, 10864.782704345947, 3615.9096022599647, 4334.566543345703, 4517.774111294422, 4534.818607255673, 4535.092981403666, 8609.69866054685, 8610.44032137909, 8618.655253789904, 8621.396502244908, 8630.223279904838, 5110.28456016158, 5120.513551212629, 5122.513361230677, 5126.179811230185, 5126.1798112302595, 4217.240896638573, 4217.536071032184, 4709.740964246999, 4739.170645137087, 4816.975915120402, 3326.6507016763376, 3680.9263814723554, 3705.4256590228556, 3776.811159442017, 3790.905227369283, 1113.604670342017, 1160.6634076118, 1163.5055101581793, 1170.3329102411715, 1172.8709841917382, 774.3302043732243, 870.1385628228008, 876.386529429402, 883.6774577279247, 894.7539426657592, 4956.3804524434445, 5379.838604841861, 5522.779088836402, 5636.519931230246, 5976.8804623908145, 918.7657147427363, 974.2498276327188, 991.8313886639289, 998.4758002048983, 1003.6587560229557, 3518.630543792916, 3720.2001569662652, 3756.8497260109834, 3776.244751049801, 3835.980820095882, 9748.561314740853, 9987.550560224807, 10026.598936042477, 10109.34289271195, 10132.797344053077, 9953.502324883726, 9964.35231709951, 9976.551055202533, 9978.0, 9990.500474976223, 7298.379637730746, 7657.310842024244, 7662.233776622294, 7723.575203363869, 7758.728444504415, 5551.278333816578, 5614.747336369955, 5637.154426836008, 5745.023346031101, 5772.336181339199, 8717.65129394817, 9084.318676099187, 9307.441553506811, 9352.485613291334, 9358.625654973725, 8512.276456501268, 8514.233718965323, 9290.303227257848, 9523.28575356837, 9541.427514349161, 6355.3644635536075, 6556.3443655634055, 6961.686724097326, 7106.6446677666945, 7216.5670059796585, 7819.452638315263, 7938.761837144895, 7991.84016319682, 7993.920060799318, 7997.320227780704, 6995.510314277952, 7115.217326094229, 7153.427725781821, 7190.7483238086415, 7238.203797582367, 6772.52592318533, 6814.182298124058, 6949.003995900293, 6964.373206411447, 6985.79042628722, 6258.593191442542, 6277.811665650038, 6326.0, 6347.90478142819, 6449.290578036318, 4903.730294833818, 4916.410030796184, 4930.728809915489, 4951.1088004158155, 4989.625778066587, 4856.320115183807, 4873.195922672861, 4892.633052521146, 5025.723585202702, 5050.823221187241], "value": 4352.094410894886, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.58670175315956, 353.64812012048014, 364.3369068295703, 367.08229426433917, 372.81545634910725, 3942.901427464315, 5186.974065129669, 5250.396204436491, 5264.894702105956, 5328.200769884519, 4229.68277379197, 4494.123645889044, 4998.375203099613, 5114.158902794991, 5196.480351964801, 4069.308217603015, 4097.528784189812, 4107.609777071173, 4116.938245926306, 4119.299719047769, 3294.96705032949, 3727.1054946812706, 4128.649064829478, 4134.0, 4139.048018955642, 4049.8380064797375, 4060.2285565742413, 4062.8577999770014, 4064.9390259146135, 4090.468239128909, 3748.175401411685, 3817.7210634437497, 3839.9808000959956, 3981.9203615927518, 4054.594540545922, 3609.8882153939976, 3614.8011859347725, 3641.635836416364, 3642.562892452923, 3644.763090399142, 4177.057668184279, 4267.146570685875, 4744.691595046311, 4943.0, 5159.535641792257, 4454.57681520255, 4518.728876267434, 4605.08888811143, 4651.88370290742, 4657.813687452498, 4573.0, 5036.736610242269, 5218.825764203024, 5490.862728431781, 5516.420775818561, 3486.9476957845654, 3869.529578760081, 3880.902977425587, 4039.2527382434346, 4044.2811804983057, 4809.78355973982, 4951.653384263067, 5053.6967781932835, 5530.640508366943, 5767.682777447197, 3743.812809359521, 4084.7344922579937, 4105.2405305018665, 4114.107510545123, 4114.238865809834, 3716.851325946932, 3888.7723189752437, 3903.882883513499, 4137.131202447459, 4141.399497072968, 4368.956310436918, 4550.633670491326, 4603.125406172817, 4621.838235661736, 4625.427354699418, 4346.847860324873, 5046.873828154326, 5416.21464887597, 5442.537384322377, 5544.615815199422, 1116.553378648547, 1173.4250217393587, 1242.6520574239228, 1275.6364436135657, 1332.7334533093226, 850.6602101689863, 885.066130504849, 908.246155690775, 959.8752162218867, 967.0039858945297, 4135.731177473514, 4169.519820463753, 4272.7222730523035, 4473.411938761693, 4648.814047438064, 4701.777537840187, 4907.803687852446, 5317.8936421271355, 5439.891202176013, 5446.576273558228, 4714.57568818808, 4748.6675932685075, 4915.48387419323, 5113.8721531962, 5125.616083657392, 2498.575242208829, 2596.6364708940764, 2633.8288011279205, 2693.6902256240783, 2806.396624725653, 4181.456410666655, 5089.0, 5135.306733590992, 5284.233786101071, 5291.735413229323, 5325.3875804282225, 5758.366579676316, 5808.564357673107, 5816.447437493432, 5866.2960444746905, 4883.95116048835, 4890.828820991248, 5879.941200588025, 5880.4416829540205, 5895.7618900031475, 5292.036459582646, 5360.284708893117, 5435.592330575144, 5668.574856885833, 5705.62913410627, 4885.828995985124, 5179.507946745053, 5454.645448045864, 5593.384727680033, 5618.831435056954, 4719.787609557647, 5106.693598384109, 5344.499352923841, 5348.705821179717, 5904.114382842608, 3398.337324221753, 3531.6644918732677, 3631.5279013729105, 3797.867074652374, 3840.8271627776257, 5125.359330083739, 5312.5484333832055, 5544.667319960815, 5620.0, 5639.887202256014, 5238.659487133325, 5451.609839490904, 5464.480874316933, 5482.91522815505, 5510.3938566758425, 4187.895302617459, 4237.533871274219, 4812.112732360556, 4936.5190442867715, 5465.398806131402, 4782.689125206851, 5152.355955505562, 5315.654482458628, 5316.787328506816, 5335.719427337333, 5427.3134798275105, 5469.480399362054, 5470.59293910678, 5513.531349835149, 5521.1442226454965, 4655.348251244761, 4962.975185124052, 5372.704501252312, 5378.139497680352, 5407.02643535099], "value": 3977.485190890202, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [624.9126519855453, 718.5832217313958, 751.177460680555, 805.9798505037376, 827.7599496146117, 13229.933850330746, 14793.556193314218, 15265.847341526594, 15394.69210615787, 15441.227938603068, 13594.524191653294, 13910.860891391108, 13991.440342386319, 14173.71652566948, 14196.219207943584, 665.6671664167916, 856.5203486047817, 876.1107475911955, 876.119499902597, 879.2131042716765, 682.9214640316377, 687.6871023684212, 742.5693098003145, 866.5840396609631, 878.7890906182535, 872.1932212703256, 925.4771054354268, 926.4996901673122, 927.5825878354734, 927.601131513449, 918.6049998500642, 918.9816203675956, 919.7332773495679, 920.4339331311229, 922.7093465558361, 510.7369704602133, 526.512975497667, 662.9270780214173, 677.7526202935942, 684.7945616315135, 14715.190664513448, 14754.336054877556, 14763.188024658639, 14775.81793456521, 14777.482788102472, 13393.598192054254, 13396.531121410704, 13430.597082087554, 13476.0, 13546.322683865867, 11958.880411195863, 12058.0, 12330.19853709506, 12333.93833030829, 12673.112882098258, 4208.305629571117, 4301.913961720748, 4454.554544545552, 4491.708038977488, 4552.68131230814, 102085.48957255167, 104803.0, 106980.0, 107365.0, 107676.0, 10245.948770256102, 10351.06840384369, 10443.791124177475, 10998.285111467889, 11143.72140696489, 21080.262190823247, 21084.262050828147, 21118.78881211199, 21121.78878211229, 21133.68299475509, 7260.346568808727, 7489.962550187323, 7715.922840771633, 7746.922530774733, 7774.572398518136, 4192.622663960258, 4237.555056719062, 4287.078278170208, 4311.978440107842, 4383.969767104728, 3167.445697003015, 3250.593675790526, 3251.7073463387937, 3252.1381833814057, 3253.4957081652383, 627.6704730016686, 634.7492740367529, 635.8251480842713, 637.757652092202, 649.82129914273, 640.6707268844405, 644.2944975252092, 645.583598578914, 661.256086902235, 666.7599664120912, 9057.864132038025, 9339.766505837273, 9366.608042329075, 9742.805143897082, 9879.950600246953, 553.2282465960044, 577.7429044075346, 605.748614325059, 665.5640555436197, 701.435344547644, 4582.404287442611, 4786.593139583175, 4974.427940786856, 5020.395980499424, 5075.5178258065425, 76899.61550192325, 93338.0, 96553.51723241339, 98654.50672746733, 99681.50159249302, 69716.60566788635, 88725.0, 89769.0, 92000.0, 92728.0, 80431.0, 80592.59703701561, 81124.59437702774, 81285.59357203176, 81329.18670813453, 9761.17030052425, 9803.803923921625, 9826.852597210904, 9837.950810245902, 9870.605175793175, 51472.22791658203, 51741.41292935263, 52073.0, 52422.689432764484, 52722.736386317825, 68791.65604171947, 69310.0, 70009.59980800253, 71340.0, 72416.0, 11855.466504007169, 11897.643070707893, 12203.450844711831, 12254.571090011807, 12620.053495987653, 12113.515459381526, 12188.022666566743, 12526.0, 13047.543335983195, 13387.397567109698, 11345.659630211107, 12028.75942481128, 12260.0, 12334.938325308316, 12527.749445011232, 12042.518299267931, 12132.575359862363, 12298.569550065704, 12535.93732031334, 12542.686432839251, 11071.723206919569, 11996.160268781101, 12000.879991199976, 12033.699157521132, 12426.37868106573, 9394.859077113986, 10185.33795303303, 10272.537735802056, 10361.585536578452, 10478.183291169487, 7747.225277472207, 8391.622376993171, 9511.381760185566, 9924.007599240307, 9959.800803983735], "value": 7258.28214725216, "unit": "score"}], "name": "dromaeo_css", "value": 7396.680001912953, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 115.0, 114.0, 112.0, 114.0, 113.0, 113.0, 113.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 108.0, 108.0, 140.0, 111.0, 107.0, 92.0, 114.0, 180.0, 137.0], "value": 123.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 181.0, 182.0, 185.0, 183.0, 185.0, 182.0, 185.0, 184.0, 184.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 58.0, 89.0, 61.0, 60.0, 59.0, 76.0, 72.0, 58.0], "value": 67.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 97.0, 119.0, 74.0, 68.0, 68.0, 81.0, 69.0, 68.0, 81.0], "value": 83.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 86.0, 88.0, 85.0, 88.0, 85.0, 88.0, 84.0], "value": 86.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 155.0, 97.0, 97.0, 97.0, 115.0, 170.0, 97.0, 98.0, 97.0], "value": 112.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 87.0, 99.0, 136.0, 141.0, 87.0, 108.0, 141.0], "value": 105.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 53.0, 57.0, 57.0, 56.0, 56.0, 57.0, 56.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 72.0, 73.0, 70.0, 67.0, 69.0, 66.0, 70.0, 69.0], "value": 69.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 83.0, 84.0, 83.0, 86.0, 98.0, 87.0, 87.0, 85.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 137.0, 138.0, 137.0, 134.0, 139.0, 140.0, 140.0, 207.0, 171.0], "value": 148.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 166.0, 167.0, 168.0, 167.0, 168.0, 167.0, 165.0, 163.0, 226.0], "value": 171.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 66.0, 64.0, 65.0, 63.0, 65.0, 64.0, 62.0], "value": 64.7, "unit": "score"}], "name": "kraken", "value": 1471.3000000000002, "alertThreshold": 2.0}]} 06:00:45 INFO - Return code: 0 06:00:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:00:46 ERROR - # TBPL SUCCESS # 06:00:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:00:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:00:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:00:46 INFO - 2017-02-15 06:00:46.041 screenresolution[1648:9897] starting screenresolution argv=screenresolution get 06:00:46 INFO - 2017-02-15 06:00:46.044 screenresolution[1648:9897] Display 0: 1600x1200x32@60 06:00:46 INFO - 2017-02-15 06:00:46.050 screenresolution[1649:9900] starting screenresolution argv=screenresolution list 06:00:46 INFO - Available Modes on Display 0 06:00:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:00:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:00:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:00:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:00:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:00:46 INFO - Intel Iris: 06:00:46 INFO - Chipset Model: Intel Iris 06:00:46 INFO - Type: GPU 06:00:46 INFO - Bus: Built-In 06:00:46 INFO - VRAM (Dynamic, Max): 1536 MB 06:00:46 INFO - Vendor: Intel (0x8086) 06:00:46 INFO - Device ID: 0x0a2e 06:00:46 INFO - Revision ID: 0x0009 06:00:46 INFO - Displays: 06:00:46 INFO - Display: 06:00:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:00:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:00:46 INFO - Display Serial Number: 1600x1200 60 06:00:46 INFO - Main Display: Yes 06:00:46 INFO - Mirror: Off 06:00:46 INFO - Online: Yes 06:00:46 INFO - Rotation: Supported 06:00:46 INFO - Return code: 0 06:00:46 INFO - Running post-action listener: _resource_record_post_action 06:00:46 INFO - [mozharness: 2017-02-15 14:00:46.298439Z] Finished run-tests step (success) 06:00:46 INFO - Running post-run listener: _resource_record_post_run 06:00:46 INFO - Total resource usage - Wall time: 1200s; CPU: 53.0%; Read bytes: 39146496; Write bytes: 507295744; Read time: 384; Write time: 1816 06:00:46 INFO - TinderboxPrint: CPU usage
53.5% 06:00:46 INFO - TinderboxPrint: I/O read bytes / time
39,146,496 / 384 06:00:46 INFO - TinderboxPrint: I/O write bytes / time
507,295,744 / 1,816 06:00:46 INFO - TinderboxPrint: CPU idle
2,233.1 (46.5%) 06:00:46 INFO - TinderboxPrint: CPU system
960.0 (20.0%) 06:00:46 INFO - TinderboxPrint: CPU user
1,608.4 (33.5%) 06:00:46 INFO - TinderboxPrint: Swap in / out
246,190,080 / 0 06:00:46 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207704576; Write bytes: 200011776; Read time: 15993; Write time: 382 06:00:46 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 34927616; Write bytes: 297228288; Read time: 352; Write time: 1404 06:00:46 INFO - Running post-run listener: _upload_blobber_files 06:00:46 INFO - Blob upload gear active. 06:00:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:00:46 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 06:00:46 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'] 06:00:46 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 06:00:47 INFO - (blobuploader) - INFO - Open directory for files ... 06:00:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:00:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:00:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:47 INFO - (blobuploader) - INFO - Done attempting. 06:00:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:00:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:00:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:48 INFO - (blobuploader) - INFO - Done attempting. 06:00:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:00:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:00:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:49 INFO - (blobuploader) - INFO - Done attempting. 06:00:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:00:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:00:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:52 INFO - (blobuploader) - INFO - Done attempting. 06:00:52 INFO - (blobuploader) - INFO - Iteration through files over. 06:00:52 INFO - Return code: 0 06:00:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:00:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:00:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82b0bc769c69fe26f9f60ad7bda4e4781b6ae843558b6edb49e0e0ec779f17f641b66bc89d60aa4f4760b8fddd7f191117f1b1767553101c4f5a99a0f1458d62", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd8872aa0aafdab422c9fc18da6b0f1324dd52b6f62204ea79e05489f81cb4f6b7150681846cf466ec17e4e3fbd03aff4362f8ad73fffd4dcf1f4395f8fc6a42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd31509be436bf8a4d516b753085d299f724d96cd710333352caa402149dee4f4e454275b65e5e2f1d90320b954aec07ff96e370186f440d7e231a9e5c428edb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c173283522d76c31a6017d2ec4e253db98e5242f7cd2fe34cbc6646df0b5b43960917f41fda63645ff841e55c58c95542d56ba1b00d99d748ce2928782acaafa"} 06:00:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:00:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:00:52 INFO - Contents: 06:00:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82b0bc769c69fe26f9f60ad7bda4e4781b6ae843558b6edb49e0e0ec779f17f641b66bc89d60aa4f4760b8fddd7f191117f1b1767553101c4f5a99a0f1458d62", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd8872aa0aafdab422c9fc18da6b0f1324dd52b6f62204ea79e05489f81cb4f6b7150681846cf466ec17e4e3fbd03aff4362f8ad73fffd4dcf1f4395f8fc6a42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd31509be436bf8a4d516b753085d299f724d96cd710333352caa402149dee4f4e454275b65e5e2f1d90320b954aec07ff96e370186f440d7e231a9e5c428edb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c173283522d76c31a6017d2ec4e253db98e5242f7cd2fe34cbc6646df0b5b43960917f41fda63645ff841e55c58c95542d56ba1b00d99d748ce2928782acaafa"} 06:00:52 INFO - Running post-run listener: copy_logs_to_upload_dir 06:00:52 INFO - Copying logs to upload dir... 06:00:52 INFO - mkdir: /builds/slave/test/build/upload/logs 06:00:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.543612 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-02-15 06:00:52.168729) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-15 06:00:52.176054) ========= 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.oPjRj4BfFu/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.Vc3sRddbA8/Listeners TMPDIR=/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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/82b0bc769c69fe26f9f60ad7bda4e4781b6ae843558b6edb49e0e0ec779f17f641b66bc89d60aa4f4760b8fddd7f191117f1b1767553101c4f5a99a0f1458d62", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd8872aa0aafdab422c9fc18da6b0f1324dd52b6f62204ea79e05489f81cb4f6b7150681846cf466ec17e4e3fbd03aff4362f8ad73fffd4dcf1f4395f8fc6a42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd31509be436bf8a4d516b753085d299f724d96cd710333352caa402149dee4f4e454275b65e5e2f1d90320b954aec07ff96e370186f440d7e231a9e5c428edb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c173283522d76c31a6017d2ec4e253db98e5242f7cd2fe34cbc6646df0b5b43960917f41fda63645ff841e55c58c95542d56ba1b00d99d748ce2928782acaafa"} build_url:https://queue.taskcluster.net/v1/task/WK11h5tuSvmMms1lC-S2ZQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010996 build_url: 'https://queue.taskcluster.net/v1/task/WK11h5tuSvmMms1lC-S2ZQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82b0bc769c69fe26f9f60ad7bda4e4781b6ae843558b6edb49e0e0ec779f17f641b66bc89d60aa4f4760b8fddd7f191117f1b1767553101c4f5a99a0f1458d62", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd8872aa0aafdab422c9fc18da6b0f1324dd52b6f62204ea79e05489f81cb4f6b7150681846cf466ec17e4e3fbd03aff4362f8ad73fffd4dcf1f4395f8fc6a42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd31509be436bf8a4d516b753085d299f724d96cd710333352caa402149dee4f4e454275b65e5e2f1d90320b954aec07ff96e370186f440d7e231a9e5c428edb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c173283522d76c31a6017d2ec4e253db98e5242f7cd2fe34cbc6646df0b5b43960917f41fda63645ff841e55c58c95542d56ba1b00d99d748ce2928782acaafa"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-15 06:00:52.214445) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 06:00:52.218834) ========= 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.oPjRj4BfFu/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.Vc3sRddbA8/Listeners TMPDIR=/var/folders/n6/d_jx6m8x0qs8z3xjt5fbd5cm00000w/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.005364 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 06:00:52.267420) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-15 06:00:52.269789) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-15 06:00:52.270129) ========= ========= Total master_lag: 0.20 =========