builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0234 starttime: 1494001379.25 results: success (0) buildid: 20170505080759 builduid: a39b009add9c4f009b469d018c47ddd7 revision: 23fe0b76a018a5077a0f7234cff91c41e4b6af64 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 09:22:59.252521) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 09:22:59.253319) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 09:22:59.253849) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 09:22:59.280607) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 09:22:59.280959) ========= 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.CCev7hD5Iw/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.V0HXqfNQlf/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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-05-05 09:22:59-- 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% 147M=0s 2017-05-05 09:22:59 (147 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134513 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 09:22:59.439673) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 09:22:59.439995) ========= 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.CCev7hD5Iw/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.V0HXqfNQlf/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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.029815 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 09:22:59.496057) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-05 09:22:59.499442) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 23fe0b76a018a5077a0f7234cff91c41e4b6af64 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 23fe0b76a018a5077a0f7234cff91c41e4b6af64 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CCev7hD5Iw/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.V0HXqfNQlf/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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-05-05 09:22:59,585 truncating revision to first 12 chars 2017-05-05 09:22:59,585 Setting DEBUG logging. 2017-05-05 09:22:59,585 attempt 1/10 2017-05-05 09:22:59,585 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/23fe0b76a018?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-05 09:23:00,647 unpacking tar archive at: mozilla-central-23fe0b76a018/testing/mozharness/ program finished with exit code 0 elapsedTime=1.344831 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-05 09:23:00.868805) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 09:23:00.869139) ========= script_repo_revision: 23fe0b76a018a5077a0f7234cff91c41e4b6af64 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 09:23:00.869539) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 09:23:00.869804) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 09:23:00.890443) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-05-05 09:23:00.891003) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CCev7hD5Iw/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.V0HXqfNQlf/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 09:23:01 INFO - MultiFileLogger online at 20170505 09:23:01 in /builds/slave/test 09:23:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:23:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:23:01 INFO - {'append_to_log': False, 09:23:01 INFO - 'base_work_dir': '/builds/slave/test', 09:23:01 INFO - 'blob_upload_branch': 'Firefox', 09:23:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:23:01 INFO - 'branch': 'Firefox', 09:23:01 INFO - 'buildbot_json_path': 'buildprops.json', 09:23:01 INFO - 'config_files': ('talos/mac_config.py',), 09:23:01 INFO - 'default_actions': ('clobber', 09:23:01 INFO - 'read-buildbot-config', 09:23:01 INFO - 'download-and-extract', 09:23:01 INFO - 'populate-webroot', 09:23:01 INFO - 'create-virtualenv', 09:23:01 INFO - 'install', 09:23:01 INFO - 'run-tests'), 09:23:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:23:01 INFO - 'download_minidump_stackwalk': True, 09:23:01 INFO - 'download_symbols': 'ondemand', 09:23:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:23:01 INFO - 'tooltool.py': '/tools/tooltool.py', 09:23:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:23:01 INFO - '/tools/misc-python/virtualenv.py')}, 09:23:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:23:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:23:01 INFO - 'gecko_profile': False, 09:23:01 INFO - 'gecko_profile_interval': 0, 09:23:01 INFO - 'installer_path': 'installer.exe', 09:23:01 INFO - 'log_level': 'info', 09:23:01 INFO - 'log_name': 'talos', 09:23:01 INFO - 'log_to_console': True, 09:23:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:23:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:23:01 INFO - 'opt_config_files': (), 09:23:01 INFO - 'pip_index': False, 09:23:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:23:01 INFO - 'cmd': ('bash', 09:23:01 INFO - '-c', 09:23:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:23:01 INFO - 'enabled': True, 09:23:01 INFO - 'halt_on_failure': False, 09:23:01 INFO - 'name': 'check_screen_resolution'},), 09:23:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:23:01 INFO - 'cmd': ('bash', 09:23:01 INFO - '-c', 09:23:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:23:01 INFO - 'enabled': True, 09:23:01 INFO - 'halt_on_failure': False, 09:23:01 INFO - 'name': 'check_screen_resolution'},), 09:23:01 INFO - 'run_cmd_checks_enabled': True, 09:23:01 INFO - 'suite': 'dromaeojs', 09:23:01 INFO - 'system_bits': '32', 09:23:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:23:01 INFO - 'title': 't-yosemite-r7-0234', 09:23:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:23:01 INFO - 'use_talos_json': True, 09:23:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:23:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:23:01 INFO - 'work_dir': 'build'} 09:23:01 INFO - [mozharness: 2017-05-05 16:23:01.099874Z] Running clobber step. 09:23:01 INFO - Running pre-action listener: _resource_record_pre_action 09:23:01 INFO - Running main action method: clobber 09:23:01 INFO - rmtree: /builds/slave/test/build 09:23:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:23:03 INFO - Running post-action listener: _resource_record_post_action 09:23:03 INFO - [mozharness: 2017-05-05 16:23:03.425662Z] Finished clobber step (success) 09:23:03 INFO - [mozharness: 2017-05-05 16:23:03.425806Z] Running read-buildbot-config step. 09:23:03 INFO - Running pre-action listener: _resource_record_pre_action 09:23:03 INFO - Running main action method: read_buildbot_config 09:23:03 INFO - Using buildbot properties: 09:23:03 INFO - { 09:23:03 INFO - "project": "", 09:23:03 INFO - "product": "firefox", 09:23:03 INFO - "script_repo_revision": "production", 09:23:03 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 09:23:03 INFO - "repository": "", 09:23:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 09:23:03 INFO - "buildid": "20170505080759", 09:23:03 INFO - "pgo_build": "False", 09:23:03 INFO - "basedir": "/builds/slave/test", 09:23:03 INFO - "buildnumber": 91, 09:23:03 INFO - "slavename": "t-yosemite-r7-0234", 09:23:03 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 09:23:03 INFO - "platform": "yosemite_r7", 09:23:03 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:23:03 INFO - "branch": "mozilla-central", 09:23:03 INFO - "repo_path": "mozilla-central", 09:23:03 INFO - "revision": "23fe0b76a018a5077a0f7234cff91c41e4b6af64", 09:23:03 INFO - "stage_platform": "macosx64", 09:23:03 INFO - "builduid": "a39b009add9c4f009b469d018c47ddd7", 09:23:03 INFO - "slavebuilddir": "test" 09:23:03 INFO - } 09:23:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 09:23:03 INFO - Running post-action listener: _resource_record_post_action 09:23:03 INFO - [mozharness: 2017-05-05 16:23:03.429187Z] Finished read-buildbot-config step (success) 09:23:03 INFO - [mozharness: 2017-05-05 16:23:03.429313Z] Running download-and-extract step. 09:23:03 INFO - Running pre-action listener: _resource_record_pre_action 09:23:03 INFO - Running main action method: download_and_extract 09:23:03 INFO - mkdir: /builds/slave/test/build/tests 09:23:03 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')]} 09:23:03 INFO - trying https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 09:23:03 INFO - Downloading https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:23:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 09:23:04 INFO - Downloaded 1325 bytes. 09:23:04 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:23:04 INFO - Using the following test package requirements: 09:23:04 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:23:04 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 09:23:04 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:23:04 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:23:04 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 09:23:04 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:23:04 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 09:23:04 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:23:04 INFO - u'jsshell-mac.zip'], 09:23:04 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:23:04 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 09:23:04 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:23:04 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:23:04 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 09:23:04 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:23:04 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 09:23:04 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:23:04 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 09:23:04 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:23:04 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 09:23:04 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:23:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:23:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:23:04 INFO - Fetch https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:23:06 INFO - Content-Length response header: 52711877 09:23:06 INFO - Bytes received: 52711877 09:23:23 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:23:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:23:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:23:23 INFO - Fetch https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:23:24 INFO - Content-Length response header: 52711877 09:23:24 INFO - Bytes received: 52711877 09:23:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 09:23:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:23:39 INFO - Fetch https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 09:23:41 INFO - Content-Length response header: 14408697 09:23:41 INFO - Bytes received: 14408697 09:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:41 INFO - trying https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:23:41 INFO - Downloading https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 09:23:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 09:23:43 INFO - Downloaded 70886158 bytes. 09:23:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:23:43 INFO - mkdir: /builds/slave/test/properties 09:23:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:23:43 INFO - Writing to file /builds/slave/test/properties/build_url 09:23:43 INFO - Contents: 09:23:43 INFO - build_url:https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:23:44 INFO - Running post-action listener: _resource_record_post_action 09:23:44 INFO - Running post-action listener: set_extra_try_arguments 09:23:44 INFO - [mozharness: 2017-05-05 16:23:44.566830Z] Finished download-and-extract step (success) 09:23:44 INFO - [mozharness: 2017-05-05 16:23:44.566987Z] Running populate-webroot step. 09:23:44 INFO - Running pre-action listener: _resource_record_pre_action 09:23:44 INFO - Running main action method: populate_webroot 09:23:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:23:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:23:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:23:44 INFO - '--tppagecycles', 09:23:44 INFO - '7'], 09:23:44 INFO - 'tests': ['tsvgm']}}, 09:23:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:23:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:23:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:23:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:23:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:23:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:23:44 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:23:44 INFO - 'talos_options': ['--disable-e10s'], 09:23:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:23:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:44 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:23:44 INFO - 'talos_options': ['--disable-e10s'], 09:23:44 INFO - 'tests': ['damp', 'tps']}, 09:23:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:23:44 INFO - 'tests': ['damp', 'tps']}, 09:23:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:23:44 INFO - 'tests': ['dromaeo_dom']}, 09:23:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:23:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:23:44 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:23:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:23:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:23:44 INFO - 'tests': ['a11yr', 09:23:44 INFO - 'ts_paint', 09:23:44 INFO - 'tpaint', 09:23:44 INFO - 'sessionrestore', 09:23:44 INFO - 'sessionrestore_no_auto_restore', 09:23:44 INFO - 'tabpaint']}, 09:23:44 INFO - 'other-e10s': {'tests': ['a11yr', 09:23:44 INFO - 'ts_paint', 09:23:44 INFO - 'tpaint', 09:23:44 INFO - 'sessionrestore', 09:23:44 INFO - 'sessionrestore_no_auto_restore', 09:23:44 INFO - 'tabpaint']}, 09:23:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:23:44 INFO - 'ts_paint', 09:23:44 INFO - 'tpaint', 09:23:44 INFO - 'sessionrestore', 09:23:44 INFO - 'sessionrestore_no_auto_restore', 09:23:44 INFO - 'tabpaint']}, 09:23:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:23:44 INFO - 'ts_paint', 09:23:44 INFO - 'tpaint', 09:23:44 INFO - 'sessionrestore', 09:23:44 INFO - 'sessionrestore_no_auto_restore', 09:23:44 INFO - 'tabpaint']}, 09:23:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:23:44 INFO - 'tests': ['a11yr', 09:23:44 INFO - 'ts_paint', 09:23:44 INFO - 'tpaint', 09:23:44 INFO - 'sessionrestore', 09:23:44 INFO - 'sessionrestore_no_auto_restore', 09:23:44 INFO - 'tabpaint']}, 09:23:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:23:44 INFO - 'tests': ['a11yr', 09:23:44 INFO - 'ts_paint', 09:23:44 INFO - 'tpaint', 09:23:44 INFO - 'sessionrestore', 09:23:44 INFO - 'sessionrestore_no_auto_restore', 09:23:44 INFO - 'tabpaint']}, 09:23:44 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:23:44 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:23:44 INFO - 'bloom_basic_ref']}, 09:23:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:23:44 INFO - 'tests': ['tsvgx', 09:23:44 INFO - 'tsvgr_opacity', 09:23:44 INFO - 'tart', 09:23:44 INFO - 'tscrollx', 09:23:44 INFO - 'cart', 09:23:44 INFO - 'tsvg_static']}, 09:23:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:23:44 INFO - 'tsvgr_opacity', 09:23:44 INFO - 'tart', 09:23:44 INFO - 'tscrollx', 09:23:44 INFO - 'cart', 09:23:44 INFO - 'tsvg_static']}, 09:23:44 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:23:44 INFO - 'talos_options': ['--disable-e10s'], 09:23:44 INFO - 'tests': ['tp5o']}, 09:23:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:23:44 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:23:44 INFO - 'talos_options': ['--disable-e10s', 09:23:44 INFO - '--xperf_path', 09:23:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:44 INFO - 'tests': ['tp5n']}, 09:23:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:23:44 INFO - 'talos_options': ['--xperf_path', 09:23:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:44 INFO - 'tests': ['tp5n']}}, 09:23:44 INFO - 'talos.zip': {'path': '', 09:23:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:23:44 INFO - Running post-action listener: _resource_record_post_action 09:23:44 INFO - [mozharness: 2017-05-05 16:23:44.586270Z] Finished populate-webroot step (success) 09:23:44 INFO - [mozharness: 2017-05-05 16:23:44.586409Z] Running create-virtualenv step. 09:23:44 INFO - Running pre-action listener: _resource_record_pre_action 09:23:44 INFO - Running main action method: create_virtualenv 09:23:44 INFO - Creating virtualenv /builds/slave/test/build/venv 09:23:44 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 09:23:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:23:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:23:44 INFO - Using real prefix '/tools/python27' 09:23:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:23:45 INFO - Installing distribute.............................................................................................................................................................................................done. 09:23:48 INFO - Installing pip.................done. 09:23:48 INFO - Return code: 0 09:23:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:23:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:23:48 INFO - Reading from file tmpfile_stdout 09:23:48 INFO - Output received: 09:23:48 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) 09:23:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:23:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102fa4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fa7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faffb587420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d82d30>, '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 0x102ca8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d77be8>, '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.CCev7hD5Iw/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.V0HXqfNQlf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 09:23:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:23:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:23:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CCev7hD5Iw/Render', 09:23:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:48 INFO - 'HOME': '/Users/cltbld', 09:23:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:48 INFO - 'LOGNAME': 'cltbld', 09:23:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:48 INFO - 'MOZ_NO_REMOTE': '1', 09:23:48 INFO - 'NO_EM_RESTART': '1', 09:23:48 INFO - 'PAGER': '/bin/cat', 09:23:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:48 INFO - 'PWD': '/builds/slave/test', 09:23:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:48 INFO - 'SHELL': '/bin/bash', 09:23:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V0HXqfNQlf/Listeners', 09:23:48 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 09:23:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:48 INFO - 'USER': 'cltbld', 09:23:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:48 INFO - 'XPC_FLAGS': '0x0', 09:23:48 INFO - 'XPC_SERVICE_NAME': '0', 09:23:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:48 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 09:23:48 INFO - Cleaning up... 09:23:48 INFO - Return code: 0 09:23:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:23:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102fa4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fa7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faffb587420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d82d30>, '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 0x102ca8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d77be8>, '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.CCev7hD5Iw/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.V0HXqfNQlf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 09:23:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:23:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:23:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CCev7hD5Iw/Render', 09:23:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:48 INFO - 'HOME': '/Users/cltbld', 09:23:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:48 INFO - 'LOGNAME': 'cltbld', 09:23:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:48 INFO - 'MOZ_NO_REMOTE': '1', 09:23:48 INFO - 'NO_EM_RESTART': '1', 09:23:48 INFO - 'PAGER': '/bin/cat', 09:23:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:48 INFO - 'PWD': '/builds/slave/test', 09:23:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:48 INFO - 'SHELL': '/bin/bash', 09:23:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V0HXqfNQlf/Listeners', 09:23:48 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 09:23:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:48 INFO - 'USER': 'cltbld', 09:23:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:48 INFO - 'XPC_FLAGS': '0x0', 09:23:48 INFO - 'XPC_SERVICE_NAME': '0', 09:23:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:49 INFO - Downloading/unpacking psutil>=3.1.1 09:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:23:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:23:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:23:51 INFO - Installing collected packages: psutil 09:23:51 INFO - Running setup.py install for psutil 09:23:51 INFO - building 'psutil._psutil_osx' extension 09:23:51 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 09:23:51 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 09:23:51 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 09:23:51 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 09:23:51 INFO - building 'psutil._psutil_posix' extension 09:23:51 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 09:23:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:23:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:23:52 INFO - ^ 09:23:52 INFO - 1 warning generated. 09:23:52 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 09:23:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:23:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:23:52 INFO - Successfully installed psutil 09:23:52 INFO - Cleaning up... 09:23:52 INFO - Return code: 0 09:23:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:23: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')]} 09:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23: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')]} 09:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102fa4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fa7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faffb587420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d82d30>, '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 0x102ca8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d77be8>, '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.CCev7hD5Iw/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.V0HXqfNQlf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 09:23:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:23:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:23:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CCev7hD5Iw/Render', 09:23:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:53 INFO - 'HOME': '/Users/cltbld', 09:23:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:53 INFO - 'LOGNAME': 'cltbld', 09:23:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:53 INFO - 'MOZ_NO_REMOTE': '1', 09:23:53 INFO - 'NO_EM_RESTART': '1', 09:23:53 INFO - 'PAGER': '/bin/cat', 09:23:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:53 INFO - 'PWD': '/builds/slave/test', 09:23:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:53 INFO - 'SHELL': '/bin/bash', 09:23:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V0HXqfNQlf/Listeners', 09:23:53 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 09:23:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:53 INFO - 'USER': 'cltbld', 09:23:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:53 INFO - 'XPC_FLAGS': '0x0', 09:23:53 INFO - 'XPC_SERVICE_NAME': '0', 09:23:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:23:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:23:55 INFO - Installing collected packages: mozsystemmonitor 09:23:55 INFO - Running setup.py install for mozsystemmonitor 09:23:55 INFO - Successfully installed mozsystemmonitor 09:23:55 INFO - Cleaning up... 09:23:55 INFO - Return code: 0 09:23:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:23:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102fa4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fa7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faffb587420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d82d30>, '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 0x102ca8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d77be8>, '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.CCev7hD5Iw/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.V0HXqfNQlf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 09:23:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:23:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:23:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CCev7hD5Iw/Render', 09:23:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:55 INFO - 'HOME': '/Users/cltbld', 09:23:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:55 INFO - 'LOGNAME': 'cltbld', 09:23:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:55 INFO - 'MOZ_NO_REMOTE': '1', 09:23:55 INFO - 'NO_EM_RESTART': '1', 09:23:55 INFO - 'PAGER': '/bin/cat', 09:23:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:55 INFO - 'PWD': '/builds/slave/test', 09:23:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:55 INFO - 'SHELL': '/bin/bash', 09:23:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V0HXqfNQlf/Listeners', 09:23:55 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 09:23:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:55 INFO - 'USER': 'cltbld', 09:23:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:55 INFO - 'XPC_FLAGS': '0x0', 09:23:55 INFO - 'XPC_SERVICE_NAME': '0', 09:23:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:55 INFO - Downloading/unpacking jsonschema==2.5.1 09:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:23:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:57 INFO - Downloading functools32-3.2.3-2.tar.gz 09:23:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:23:57 INFO - warning: no files found matching '*.txt' 09:23:57 INFO - no previously-included directories found matching 'build' 09:23:57 INFO - no previously-included directories found matching 'dist' 09:23:57 INFO - no previously-included directories found matching '.git*' 09:23:57 INFO - Installing collected packages: jsonschema, functools32 09:23:57 INFO - Running setup.py install for functools32 09:23:57 INFO - warning: no files found matching '*.txt' 09:23:57 INFO - no previously-included directories found matching 'build' 09:23:57 INFO - no previously-included directories found matching 'dist' 09:23:57 INFO - no previously-included directories found matching '.git*' 09:23:57 INFO - Successfully installed jsonschema functools32 09:23:57 INFO - Cleaning up... 09:23:57 INFO - Return code: 0 09:23:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:23:57 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')]} 09:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:57 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')]} 09:23:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:57 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 0x102fa4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fa7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faffb587420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d82d30>, '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 0x102ca8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d77be8>, '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.CCev7hD5Iw/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.V0HXqfNQlf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 09:23:57 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 09:23:57 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 09:23:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CCev7hD5Iw/Render', 09:23:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:57 INFO - 'HOME': '/Users/cltbld', 09:23:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:57 INFO - 'LOGNAME': 'cltbld', 09:23:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:57 INFO - 'MOZ_NO_REMOTE': '1', 09:23:57 INFO - 'NO_EM_RESTART': '1', 09:23:57 INFO - 'PAGER': '/bin/cat', 09:23:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:57 INFO - 'PWD': '/builds/slave/test', 09:23:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:57 INFO - 'SHELL': '/bin/bash', 09:23:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V0HXqfNQlf/Listeners', 09:23:57 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 09:23:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:57 INFO - 'USER': 'cltbld', 09:23:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:57 INFO - 'XPC_FLAGS': '0x0', 09:23:57 INFO - 'XPC_SERVICE_NAME': '0', 09:23:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:23:57 INFO - Cleaning up... 09:23:57 INFO - Return code: 0 09:23:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:23:57 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')]} 09:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:57 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')]} 09:23:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:57 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 0x102fa4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fa7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faffb587420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d82d30>, '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 0x102ca8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d77be8>, '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.CCev7hD5Iw/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.V0HXqfNQlf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 09:23:57 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 09:23:57 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 09:23:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CCev7hD5Iw/Render', 09:23:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:57 INFO - 'HOME': '/Users/cltbld', 09:23:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:57 INFO - 'LOGNAME': 'cltbld', 09:23:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:57 INFO - 'MOZ_NO_REMOTE': '1', 09:23:57 INFO - 'NO_EM_RESTART': '1', 09:23:57 INFO - 'PAGER': '/bin/cat', 09:23:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:57 INFO - 'PWD': '/builds/slave/test', 09:23:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:57 INFO - 'SHELL': '/bin/bash', 09:23:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V0HXqfNQlf/Listeners', 09:23:57 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 09:23:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:57 INFO - 'USER': 'cltbld', 09:23:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:57 INFO - 'XPC_FLAGS': '0x0', 09:23:57 INFO - 'XPC_SERVICE_NAME': '0', 09:23:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:58 INFO - Downloading/unpacking blobuploader==1.2.4 09:23:58 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 09:23:58 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 09:23:58 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 09:23:58 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 09:23:58 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 09:23:58 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 09:23:59 INFO - Downloading blobuploader-1.2.4.tar.gz 09:23:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:23:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:23:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:00 INFO - Downloading docopt-0.6.1.tar.gz 09:24:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:24:00 INFO - Installing collected packages: blobuploader, requests, docopt 09:24:00 INFO - Running setup.py install for blobuploader 09:24:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:24:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:24:00 INFO - Running setup.py install for requests 09:24:00 INFO - Running setup.py install for docopt 09:24:01 INFO - Successfully installed blobuploader requests docopt 09:24:01 INFO - Cleaning up... 09:24:01 INFO - Return code: 0 09:24:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102fa4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fa7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faffb587420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d82d30>, '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 0x102ca8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d77be8>, '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.CCev7hD5Iw/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.V0HXqfNQlf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 09:24:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:24:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:24:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CCev7hD5Iw/Render', 09:24:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:01 INFO - 'HOME': '/Users/cltbld', 09:24:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:01 INFO - 'LOGNAME': 'cltbld', 09:24:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:01 INFO - 'MOZ_NO_REMOTE': '1', 09:24:01 INFO - 'NO_EM_RESTART': '1', 09:24:01 INFO - 'PAGER': '/bin/cat', 09:24:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:01 INFO - 'PWD': '/builds/slave/test', 09:24:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:01 INFO - 'SHELL': '/bin/bash', 09:24:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V0HXqfNQlf/Listeners', 09:24:01 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 09:24:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:01 INFO - 'USER': 'cltbld', 09:24:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:01 INFO - 'XPC_FLAGS': '0x0', 09:24:01 INFO - 'XPC_SERVICE_NAME': '0', 09:24:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:24:01 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-qtTmHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:24:01 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-oWD60I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:24:01 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-hq0ouc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:24:01 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-VXEstg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:24:01 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-Y6uhKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:24:02 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-T1aSZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:24:02 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-ZqerSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:24:02 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-GZ3MxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:24:02 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-71fXW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:24:02 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-7JmW5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:24:02 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-0Ag6du-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:24:02 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-0zygbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:24:02 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-sbRa96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:24:02 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-3ocb4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:02 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-YgcVeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:24:03 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-WWCesN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:24:03 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-1cXJRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:24:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:24:03 INFO - Running setup.py install for manifestparser 09:24:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:24:03 INFO - Running setup.py install for mozcrash 09:24:03 INFO - Running setup.py install for mozdebug 09:24:03 INFO - Running setup.py install for mozdevice 09:24:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:24:03 INFO - Running setup.py install for mozfile 09:24:04 INFO - Running setup.py install for mozhttpd 09:24:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:24:04 INFO - Running setup.py install for mozinfo 09:24:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:24:04 INFO - Running setup.py install for mozInstall 09:24:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:24:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:24:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:24:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:24:04 INFO - Running setup.py install for mozleak 09:24:04 INFO - Running setup.py install for mozlog 09:24:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:24:04 INFO - Running setup.py install for moznetwork 09:24:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:24:04 INFO - Running setup.py install for mozprocess 09:24:05 INFO - Running setup.py install for mozprofile 09:24:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:24:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:24:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:24:05 INFO - Running setup.py install for mozrunner 09:24:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:24:05 INFO - Running setup.py install for mozscreenshot 09:24:05 INFO - Running setup.py install for moztest 09:24:05 INFO - Running setup.py install for mozversion 09:24:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:24:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:24:05 INFO - Cleaning up... 09:24:05 INFO - Return code: 0 09:24:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24:05 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')]} 09:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:05 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')]} 09:24:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:05 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 0x102fa4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fa7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faffb587420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d82d30>, '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 0x102ca8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d77be8>, '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.CCev7hD5Iw/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.V0HXqfNQlf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 09:24:05 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 09:24:05 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 09:24:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CCev7hD5Iw/Render', 09:24:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:05 INFO - 'HOME': '/Users/cltbld', 09:24:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:05 INFO - 'LOGNAME': 'cltbld', 09:24:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:05 INFO - 'MOZ_NO_REMOTE': '1', 09:24:05 INFO - 'NO_EM_RESTART': '1', 09:24:05 INFO - 'PAGER': '/bin/cat', 09:24:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:05 INFO - 'PWD': '/builds/slave/test', 09:24:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:05 INFO - 'SHELL': '/bin/bash', 09:24:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V0HXqfNQlf/Listeners', 09:24:05 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 09:24:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:05 INFO - 'USER': 'cltbld', 09:24:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:05 INFO - 'XPC_FLAGS': '0x0', 09:24:05 INFO - 'XPC_SERVICE_NAME': '0', 09:24:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:24:06 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-bbZgHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:24:06 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-G2sVZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:24:06 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-RFQYeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:24:06 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-9iRpCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:24:06 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-iPrNfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:24:06 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-hUtFiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:24:06 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-wDJpol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:24:06 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)) 09:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:24:06 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-9AOh76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:24:07 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-p3UZED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:24:07 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-nAMEZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:24:07 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-4oAZgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:24:07 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-vw_j1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:24:07 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-pkjItB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:24:07 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-3iMqQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:07 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-ZSOmHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:24:07 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-rWMZdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:24:07 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-ZsWwH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:24:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:24:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:24:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:24:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:24:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:24:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:24:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:09 INFO - Downloading blessings-1.6.tar.gz 09:24:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:24:09 INFO - Installing collected packages: blessings 09:24:09 INFO - Running setup.py install for blessings 09:24:09 INFO - Successfully installed blessings 09:24:09 INFO - Cleaning up... 09:24:09 INFO - Return code: 0 09:24:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:24:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:24:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:24:09 INFO - Reading from file tmpfile_stdout 09:24:09 INFO - Current package versions: 09:24:09 INFO - blessings == 1.6 09:24:09 INFO - blobuploader == 1.2.4 09:24:09 INFO - docopt == 0.6.1 09:24:09 INFO - functools32 == 3.2.3-2 09:24:09 INFO - jsonschema == 2.5.1 09:24:09 INFO - manifestparser == 1.1 09:24:09 INFO - mozInstall == 1.12 09:24:09 INFO - mozcrash == 1.0 09:24:09 INFO - mozdebug == 0.1 09:24:09 INFO - mozdevice == 0.50 09:24:09 INFO - mozfile == 1.2 09:24:09 INFO - mozhttpd == 0.7 09:24:09 INFO - mozinfo == 0.9 09:24:09 INFO - mozleak == 0.1 09:24:09 INFO - mozlog == 3.4 09:24:09 INFO - moznetwork == 0.27 09:24:09 INFO - mozprocess == 0.25 09:24:09 INFO - mozprofile == 0.28 09:24:09 INFO - mozrunner == 6.13 09:24:09 INFO - mozscreenshot == 0.1 09:24:09 INFO - mozsystemmonitor == 0.3 09:24:09 INFO - moztest == 0.8 09:24:09 INFO - mozversion == 1.4 09:24:09 INFO - psutil == 3.1.1 09:24:09 INFO - requests == 1.2.3 09:24:09 INFO - wsgiref == 0.1.2 09:24:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24: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')]} 09:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:10 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')]} 09:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:10 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 0x102fa4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fa7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faffb587420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d82d30>, '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 0x102ca8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d77be8>, '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.CCev7hD5Iw/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.V0HXqfNQlf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 09:24:10 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 09:24:10 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 09:24:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CCev7hD5Iw/Render', 09:24:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:10 INFO - 'HOME': '/Users/cltbld', 09:24:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:10 INFO - 'LOGNAME': 'cltbld', 09:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:10 INFO - 'MOZ_NO_REMOTE': '1', 09:24:10 INFO - 'NO_EM_RESTART': '1', 09:24:10 INFO - 'PAGER': '/bin/cat', 09:24:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:10 INFO - 'PWD': '/builds/slave/test', 09:24:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:10 INFO - 'SHELL': '/bin/bash', 09:24:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V0HXqfNQlf/Listeners', 09:24:10 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 09:24:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:10 INFO - 'USER': 'cltbld', 09:24:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:10 INFO - 'XPC_FLAGS': '0x0', 09:24:10 INFO - 'XPC_SERVICE_NAME': '0', 09:24:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:10 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)) 09:24:10 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)) 09:24:10 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)) 09:24:10 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)) 09:24:10 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)) 09:24:10 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)) 09:24:10 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)) 09:24:10 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)) 09:24:10 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)) 09:24:10 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)) 09:24:10 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)) 09:24:10 INFO - Cleaning up... 09:24:10 INFO - Return code: 0 09:24:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:24:10 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')]} 09:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:10 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')]} 09:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:10 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 0x102fa4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fa7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faffb587420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d82d30>, '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 0x102ca8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d77be8>, '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.CCev7hD5Iw/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.V0HXqfNQlf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 09:24:10 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 09:24:10 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 09:24:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CCev7hD5Iw/Render', 09:24:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:10 INFO - 'HOME': '/Users/cltbld', 09:24:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:10 INFO - 'LOGNAME': 'cltbld', 09:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:10 INFO - 'MOZ_NO_REMOTE': '1', 09:24:10 INFO - 'NO_EM_RESTART': '1', 09:24:10 INFO - 'PAGER': '/bin/cat', 09:24:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:10 INFO - 'PWD': '/builds/slave/test', 09:24:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:10 INFO - 'SHELL': '/bin/bash', 09:24:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V0HXqfNQlf/Listeners', 09:24:10 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 09:24:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:10 INFO - 'USER': 'cltbld', 09:24:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:10 INFO - 'XPC_FLAGS': '0x0', 09:24:10 INFO - 'XPC_SERVICE_NAME': '0', 09:24:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:24:10 INFO - Cleaning up... 09:24:10 INFO - Return code: 0 09:24:10 INFO - Running post-action listener: _resource_record_post_action 09:24:10 INFO - Running post-action listener: _start_resource_monitoring 09:24:10 INFO - Starting resource monitoring. 09:24:10 INFO - [mozharness: 2017-05-05 16:24:10.573586Z] Finished create-virtualenv step (success) 09:24:10 INFO - [mozharness: 2017-05-05 16:24:10.574655Z] Running install step. 09:24:10 INFO - Running pre-action listener: _resource_record_pre_action 09:24:10 INFO - Running main action method: install 09:24:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:24:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:24:10 INFO - Reading from file tmpfile_stdout 09:24:10 INFO - Detecting whether we're running mozinstall >=1.0... 09:24:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:24:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:24:10 INFO - Reading from file tmpfile_stdout 09:24:10 INFO - Output received: 09:24:10 INFO - Usage: mozinstall [options] installer 09:24:10 INFO - Options: 09:24:10 INFO - -h, --help show this help message and exit 09:24:10 INFO - -d DEST, --destination=DEST 09:24:10 INFO - Directory to install application into. [default: 09:24:10 INFO - "/builds/slave/test"] 09:24:10 INFO - --app=APP Application being installed. [default: firefox] 09:24:10 INFO - mkdir: /builds/slave/test/build/application 09:24:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:24:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:24:30 INFO - Reading from file tmpfile_stdout 09:24:30 INFO - Output received: 09:24:30 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:24:30 INFO - Running post-action listener: _resource_record_post_action 09:24:30 INFO - [mozharness: 2017-05-05 16:24:30.618233Z] Finished install step (success) 09:24:30 INFO - [mozharness: 2017-05-05 16:24:30.618385Z] Running run-tests step. 09:24:30 INFO - Running pre-action listener: _resource_record_pre_action 09:24:30 INFO - Running main action method: run_tests 09:24:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:24:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:24:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:24:30 INFO - 2017-05-05 09:24:30.633 screenresolution[7782:200054] starting screenresolution argv=screenresolution get 09:24:30 INFO - 2017-05-05 09:24:30.635 screenresolution[7782:200054] Display 0: 1600x1200x32@60 09:24:30 INFO - 2017-05-05 09:24:30.641 screenresolution[7783:200057] starting screenresolution argv=screenresolution list 09:24:30 INFO - Available Modes on Display 0 09:24:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:24:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:24:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:24:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:24:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:24:30 INFO - Intel Iris: 09:24:30 INFO - Chipset Model: Intel Iris 09:24:30 INFO - Type: GPU 09:24:30 INFO - Bus: Built-In 09:24:30 INFO - VRAM (Dynamic, Max): 1536 MB 09:24:30 INFO - Vendor: Intel (0x8086) 09:24:30 INFO - Device ID: 0x0a2e 09:24:30 INFO - Revision ID: 0x0009 09:24:30 INFO - Displays: 09:24:30 INFO - Display: 09:24:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:24:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:24:30 INFO - Display Serial Number: 1600x1200 60 09:24:30 INFO - Main Display: Yes 09:24:30 INFO - Mirror: Off 09:24:30 INFO - Online: Yes 09:24:30 INFO - Rotation: Supported 09:24:30 INFO - Return code: 0 09:24:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:24:30 INFO - Python 2.7.3 09:24:30 INFO - Return code: 0 09:24:30 INFO - grabbing minidump binary from tooltool 09:24:30 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')]} 09:24:30 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 0x102d82d30>, '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 0x102ca8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d77be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:24:30 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 09:24:30 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 09:24:30 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 09:24:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:24:31 INFO - Return code: 0 09:24:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:24:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:24:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:24:31 INFO - ENV: RUST_BACKTRACE is now 1 09:24:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:24:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:24:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0234', '--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 09:24:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0234 --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 09:24:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CCev7hD5Iw/Render', 09:24:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:31 INFO - 'HOME': '/Users/cltbld', 09:24:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:31 INFO - 'LOGNAME': 'cltbld', 09:24:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:24:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:24:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:31 INFO - 'MOZ_NO_REMOTE': '1', 09:24:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:24:31 INFO - 'NO_EM_RESTART': '1', 09:24:31 INFO - 'PAGER': '/bin/cat', 09:24:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:31 INFO - 'PWD': '/builds/slave/test', 09:24:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:24:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:31 INFO - 'RUST_BACKTRACE': '1', 09:24:31 INFO - 'SHELL': '/bin/bash', 09:24:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V0HXqfNQlf/Listeners', 09:24:31 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 09:24:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:31 INFO - 'USER': 'cltbld', 09:24:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:31 INFO - 'XPC_FLAGS': '0x0', 09:24:31 INFO - 'XPC_SERVICE_NAME': '0', 09:24:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0234', '--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 09:24:31 INFO - mozversion application_buildid: 20170505080759 09:24:31 INFO - mozversion application_changeset: 23fe0b76a018a5077a0f7234cff91c41e4b6af64 09:24:31 INFO - mozversion application_display_name: Nightly 09:24:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:24:31 INFO - mozversion application_name: Firefox 09:24:31 INFO - mozversion application_remotingname: firefox 09:24:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:24:31 INFO - mozversion application_vendor: Mozilla 09:24:31 INFO - mozversion application_version: 55.0a1 09:24:31 INFO - mozversion platform_buildid: 20170505080759 09:24:31 INFO - mozversion platform_changeset: 23fe0b76a018a5077a0f7234cff91c41e4b6af64 09:24:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:24:31 INFO - mozversion platform_version: 55.0a1 09:24:31 INFO - using testdate: 1494001471 09:24:31 INFO - actual date: 1494001471 09:24:31 INFO - starting webserver on 'localhost:63925' 09:24:31 INFO - SUITE-START | Running 2 tests 09:24:31 INFO - TEST-START | dromaeo_css 09:24:31 INFO - operating with platform_type : mac_ 09:24:31 INFO - Initialising browser for dromaeo_css test... 09:24:31 INFO - TEST-INFO | started process 7793 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/tmpYzZcnF/profile http://localhost:63925/getInfo.html) 09:24:33 INFO - PID 7793 | __metrics Screen width/height:1600/1200 09:24:33 INFO - PID 7793 | colorDepth:24 09:24:33 INFO - PID 7793 | Browser inner width/height: 1024/691 09:24:33 INFO - PID 7793 | __metrics 09:24:33 INFO - PID 7793 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:24:33 INFO - PID 7793 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:24:34 INFO - TEST-INFO | 7793: exit 0 09:24:34 INFO - Browser initialized. 09:24:34 INFO - Running cycle 1/1 for dromaeo_css test... 09:24:34 INFO - TEST-INFO | started process 7795 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/tmpYzZcnF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:24:47 INFO - PID 7795 | RSS: Main: 241336320 09:24:47 INFO - PID 7795 | 09:27:52 INFO - PID 7795 | Cycle 1(1): loaded http://localhost:63925/tests/dromaeo/cssquery-dojo.html (next: http://localhost:63925/tests/dromaeo/cssquery-ext.html) 09:27:53 INFO - PID 7795 | RSS: Main: 360988672 09:27:53 INFO - PID 7795 | 09:30:56 INFO - PID 7795 | Cycle 1(1): loaded http://localhost:63925/tests/dromaeo/cssquery-ext.html (next: http://localhost:63925/tests/dromaeo/cssquery-jquery.html) 09:30:57 INFO - PID 7795 | RSS: Main: 366428160 09:30:57 INFO - PID 7795 | 09:33:59 INFO - PID 7795 | Cycle 1(1): loaded http://localhost:63925/tests/dromaeo/cssquery-jquery.html (next: http://localhost:63925/tests/dromaeo/cssquery-mootools.html) 09:33:59 INFO - PID 7795 | RSS: Main: 334110720 09:33:59 INFO - PID 7795 | 09:37:02 INFO - PID 7795 | Cycle 1(1): loaded http://localhost:63925/tests/dromaeo/cssquery-mootools.html (next: http://localhost:63925/tests/dromaeo/cssquery-prototype.html) 09:37:02 INFO - PID 7795 | RSS: Main: 327057408 09:37:02 INFO - PID 7795 | 09:40:06 INFO - PID 7795 | Cycle 1(1): loaded http://localhost:63925/tests/dromaeo/cssquery-prototype.html (next: http://localhost:63925/tests/dromaeo/cssquery-yui.html) 09:40:06 INFO - PID 7795 | RSS: Main: 325300224 09:40:06 INFO - PID 7795 | 09:43:09 INFO - PID 7795 | Cycle 1(1): loaded http://localhost:63925/tests/dromaeo/cssquery-yui.html (next: http://localhost:63925/tests/dromaeo/cssquery-dojo.html) 09:43:09 INFO - PID 7795 | RSS: Main: 371286016 09:43:09 INFO - PID 7795 | 09:43:09 INFO - PID 7795 | __start_tp_report 09:43:09 INFO - PID 7795 | _x_x_mozilla_page_load 09:43:09 INFO - PID 7795 | _x_x_mozilla_page_load_details 09:43:09 INFO - PID 7795 | |i|pagename|runs| 09:43:09 INFO - PID 7795 | |0;dojo.html;3138.7802853800213;3508;3512.6662967018133;3516.665916737909;3528.0474271946573;6027.3972602739705;6130.4592857107245;6222.937770622298;6230.06549017647;6262.937370626292;5887.264091988502;6168.753249870011;6274.341194174614;6282.434580887719;6312.305646378894;4871.878203044935;5173.482651734834;5300.946990530084;5361.142217245241;5471.890562188753;5303.522682958533;5409.837704868841;5433.918491222635;5481.725913704299;5485.61600687952;5361.785528578852;5391.541718953894;5391.973040134774;5443.537299329561;5457.372402173761;5408.0535906216255;5415.729213539307;5424.674519528841;5490.011797876381;5496.642718223303;5371.758270877781;5394.91907621386;5398.379186393576;5414.214938833887;5438.945610543883;6137.8673257933415;6189.319174890758;6196.287426945869;6281.434670879597;6302.842428939313;6603.240627327871;6670.3329667033395;6682.599044057372;6684.097646817666;6701.497387695942;6754.8311292217595;6760.1549806274215;6764.0530325754435;6767.458603311772;6775.017622444718;6199.256089269316;6264.9373506265265;6369.458596019297;6375.2987171411105;6390.680465976682;6626.039224312448;6688.230853451818;6811.318868113149;6901.378875901193;6913.343232392915;6370.394812492806;6383.489320854321;6487.7080531376205;6581.308962558863;6599.934000660028;6637.502187335969;6723.596584204964;6735.629540375228;6741.831454213586;6751.628660423626;6357.554971151975;6627.03907933347;6632.403083722488;6634.933650663432;6646.20245570525;6402.423781859562;6514.348565143448;6594.406503414716;6635.834104147435;6637.568558043712;5241.109011468059;5281.471852814688;5294.7617357219015;5303.390110137307;5330.120530112566;4634.304854271886;4686.906261874743;4718.150732868048;4719.315699223594;4746.5490778376;6116.366205733216;6164.229471316085;6240.095186197976;6284.994400895835;6308.747650093945;6719.328067193339;6725.092112564839;6750.291219421988;6759.729610815611;6779.0509328694025;6323.873522529524;6324.557280990379;6327;6328.651924144124;6337.04944258365;5728.656280623176;5753.769849206069;5812.59311848175;5836;5876.6180198286975;6720.32796720324;6853.280405557544;6944.965275173592;6955.617441040589;6986.0219569259325;6715.1941766988275;6748.69630866622;6767.729290828312;6769.323067693192;6772.796816095525;6278.937210627835;6909.1018167639895;6939.861202775815;6973.476989225727;6975.616341101085;6123.510119190543;6488.902666459912;6524.282328943717;6579.078928949855;6608.768693095719;6490.383413575702;6742.325767423218;6777.661116944231;6780.050792888901;6793.184817821893;6322.083297921868;6354.269259035085;6468.029795530708;6565.704543295658;6575.178102737158;6399.424051835357;6551.574147680385;6552.3447655234095;6565.179352580927;6569.277379488157;6242.313345531897;6317.715702793477;6408.967955160381;6412.583182093149;6429.710663020269;6454.612723236621;6505.447037001908;6523.412892839668;6536.346365363425;6543.509236807164;6383.776567820104;6384.457321127757;6394.0408938659575;6416.422521973045;6421.7110230038825 09:43:09 INFO - PID 7795 | |1;ext.html;793.559574436188;802.1377019703818;1073.747669297715;1126.3579759537056;1129.2659771148753;33976.4903526447;37051.62948370519;37093.81453092731;37142.25715485689;37250.8137459313;38833.417498737545;39236;39241.21517569647;39260.80369598148;39356;5902.173695682608;6916.377526022657;8383.622736976851;8428.747137585882;8431.072582016004;5931.555133364994;8202.876956845652;8347.29048030918;8351.496730588491;8373.62318695657;8390;8435.83128337433;8437.071922088566;8439.987201535794;8487.702930397438;5878.823635290905;7231.421486281111;8275.337972962148;8410.78973025673;8413.95793021037;5979.611325263844;8116.797080072986;8312.002559692875;8314.41799074065;8354.122817104238;36940.81529592335;37280.44079338812;37302.81348593267;37311.06722331936;37416.812915935516;3521.8591256349714;3550.6449355064547;3551.662592053751;3558.2527669189503;3569.5359603251413;30116;30201.79192832284;30214.24464388386;30273.848630756704;30345.69654303473;3027.04648035868;3090.165655273086;3093.7834351595397;3107.3008573071106;3126.656067832537;293037;301006;302743;303367;303407.482962586;38498.03754906094;38713.612863871;48797.75601121972;49085.754571227626;49092.50907490951;39581.80209098936;46121.53878461239;47131.76434117876;47243.5275647246;47293;13496.797548036591;13601.387937542835;13602.795958060637;13616.93191534036;13628.318584070757;10999.34003959765;11009.669709908556;11021.669349919515;11032.227744058;11034.944825275983;12273.631791046282;12299.692507687201;12314.876851231373;12323.815142772866;12417.254964701966;5160.767765450564;5222.764975576109;5232.659877107976;5233.947660523422;5245.816396426107;1003.508280942333;1009.5860697114148;1010.3937637417491;1043.4574021508772;1054.615065501102;22473.43816404603;23480.060797568247;23547.646785298235;23564.882175589355;23954.760452395603;1087.842262871895;1092.4537731134433;1130.2088538023415;1132.9376884271444;1155.8324043013715;10604.469776511143;11203.383813890314;11377.658670239905;11965.76068478643;11999.220050696676;297361;298190;298629;298742;300137;51281;51364.743176284624;51432.485675143515;51447.22829157566;51492.48507514952;1501.1593507635541;1510.6978604279188;1562.3125824637123;1571.0966194438245;1572.4496426250948;21309.893450532647;21447;22942.655860162446;23052.884735576885;23077.653835192148;37674.81162594169;37737.62262377451;37750.2449950994;37793;37793.433098502996;256876;256880;257582.71208643838;258222;258828.70585646952;29034.564481532372;29144.562831557967;29182.416351673273;33342.333153337284;33432.49851252282;35955.820220899775;36003.73986910446;36018.4597231047;39651.20697585974;42813.14373712446;27872.44255114927;28549.857250713612;28712.138635840958;29469;29857.10428687143;30014;30051.549226762054;30225.848870755504;30312.393752124393;30663.240308372355;35996.4600530987;36891.81554092212;36918;36938.8153059233;37131.8143409292;24933.50132997366;29477.11568652944;29957.55063674003;30476.390472190877;30951.380972379975;19957.501062473555;22816.771832281465;23673.64489532624;23719.051237950287;24047.879760601085 09:43:09 INFO - PID 7795 | |2;jquery.html;374.3411595591759;419.2704693832732;431.71938240143925;433.31536172846893;456.58222726205526;20363.389098327036;20766.6884996725;21116.260930867422;21777.564448711055;22067.558648827053;20868.582628347423;22164.778352216472;22906.312810615666;23082.422939426524;23122.88438557809;5733.48398644123;6013.1581578579035;6017.007193813038;6022.247219097613;6026.246719160105;4145.626893579577;5992.161097446361;6017.428344307284;6019.939800601982;6025.6083354581815;5426.457354264562;5957.434043765836;5975.432333928292;5982.0727787193055;5986.910196347037;5117.283580298761;5713.628614140068;5780.1907732917425;5849.853753656172;5857.619254748449;5003.049420610108;5180.507851754077;5233.476652334774;5239.607029472805;5239.869003274911;25539.36151596225;25679.229623111336;25736.97052117932;25994.480110397875;26061.08786192493;2190.7622193460643;2224.0992398078806;2232.352617740853;2245.7641947595594;2256.165218869029;17242.56893577658;17275.913620431817;17503.38738144159;17748.645027099385;17780.933144011273;2092.591944570809;2115.2913773885766;2143.4781305273273;2148.946276343104;2163.2104281937136;140161;140341.2982935089;141686.87469687962;142883.2855835714;169897.15051424789;10339.948300258451;11807.350595717146;12429.192102513489;12442.937785311016;12858.67853303675;16676.6664666706;16680.66638667244;16706.49880503587;16719.996800191784;16722.82603261568;7783.727569535039;8514.191151840565;8889.733308000641;8895.955520222487;8967;7153.713851445884;7551.811204719926;8243.175682431829;8480.406371554056;8680.8697869532;7527.096748390119;7615.771526854203;7658.846823063507;7681.116671582728;7762.107357653829;1975.2888959974398;2044.8159665630164;2080.864743791649;2083.1354987680247;2089.7387826521685;906.5467266366817;939.7744541310036;980.3382716666222;989.1592146675413;1016.5679586175846;20426.69359959602;20955.790442095386;20992.895035524725;21061.473463163544;21455.570888582453;1003.5835128421623;1005.8139244239693;1015.4719545836124;1038.6260946059413;1044.1281529922448;10442.582296708199;10797.676069717922;10845.186611004048;10845.295055821347;10961.616343427942;542044;545278;552094.2395287998;560250;566497;91894;104963.95036049542;109852;133393;139579;1074.7635520185547;1166.2827361172817;1192.8807119288;1194.7729931313022;1197.060307658484;22286;22330.21844235444;22355.993980270603;22740.545189095796;22766;55652.721736392676;57259.42740572541;57403.712981436496;57504.987325443406;58234;76008;77153.61423192848;77717;78997.60501197458;79188.60405697934;7401.5189012714;7564;8205.71280005197;8786.813780139599;8898.55507224649;13491.86508134906;13594.388252528463;13641.181529108286;13981.23103229332;14043.016988810685;11621.12841536905;11647.59233426826;11747.29516229029;11930.284182949052;12013.63959081229;10987.725306867393;11023.007929286403;11117.16621253393;11309.321440713584;11329.376884271114;11517.07863370945;11695.88304116948;12000.519979201083;12068.155229133876;12105.69735756613;8422.073571906963;8473.824091110684;8515.957420212859;8974.461532308082;8986;11455.942720286344;11783.941080294544;11868.643940681794;11961.581344652895;11991.700207494883 09:43:09 INFO - PID 7795 | |3;mootools.html;1269.8031805070214;1409.133382969474;1425.7362387958221;1431.8067060946776;1431.9785203221954;9871.605135794569;11207.6637700869;11718.824217636742;11739.00218481428;11761.411929403528;9771.316007879434;11029.669109926715;11409.942950285236;11519.65441036768;11617.361045142514;2436.3543660929868;2523.2304147235086;2528.7091984421845;2531.1520640585427;2534.1383929463977;2091.7594476635154;2371.3952941999764;2508.5610018246825;2516.9119080832174;2517.924462266135;1789.3021721528614;2159.028437203257;2195.9451013724706;2514.421683012908;2525.0657256815;2277.2826559633663;2309.764276112289;2465.48224872776;2471.653968444419;2482.6524286599893;2354.270176245352;2389.808815294772;2390.3904504351453;2393.856368617871;2399.448126930798;11154.442277886073;11409.42952852354;11427.08583313333;11432.771344573144;11498.885011149949;6436.388543088399;6711.0269010993625;6722.327767223239;6728.226253980806;6728.83177920551;3785.791781452019;4101.52832424272;4138.937915931264;4251.06476575153;4251.80866860992;1247.3139773124744;1255.880691334331;1294.8316718826493;1299.6880748620358;1308.2608326295613;16074.5981350466;16461.917690411592;16484.258208380652;16487.917560412123;16513.091779952098;5695.487406133468;5749.3963133871175;5891.293044834561;6000.129981152709;6030.728617212236;13756.65608359779;13792.862071379157;13804;13808.654783630489;13826;6737.730490780412;6742.157230346207;6742.9662851685425;6752.898706519406;6755.898661520081;5266.7629956652045;5986.3714309997695;5997;6156.168917196122;6180.289266734293;4498.977505112453;4581.518940511199;4618.35343051973;4651.069786042805;4665.626749860003;1377.3870627570834;1425.9500917468047;1429.535400994681;1443.877270432025;1448.8696017358488;669.8698139915019;691.4192078653955;699.8915168148945;709.482078082992;809.1665584448028;6634.734610615521;6688.197416310074;6756.425703815133;6832.829179270459;6903.309669033157;532.7815595605783;589.9705014749245;594.2631137389606;595.7170344086611;710.5417006031081;3957.5250969883223;4146.253674338588;4308.202982448257;4447.288433850568;4552.11233809404;14604.488842890449;14983.101013939198;15028.94797364174;15055.849441505663;15061.472848450252;14277.928610356881;14676.926615366854;14973.775393368891;14986.625334366729;15041.924790375979;8277.420580559303;8516.06323304436;8533.701320453754;8535.061143274235;8537.871931921027;6839.1451068616425;6913.171321892434;6932.549384290207;7009.894851577333;7032.859342813217;11617.012553933011;13105.2136871788;13140;13218.735625287633;13524.323783810572;12851.485940562272;13387.464501419834;13390.995675324195;13671.863281367458;13803.274590676165;7868.370530357673;9007.819843603222;9094.59074341643;9158.496282704515;9207.58565864551;10199.643012494527;10427.68716938493;10434.478276086014;10439.425831579336;10439.895601043892;8637.265832404317;8816.471011739317;8916.955415222883;8974;8986.68546600866;8658.264047556027;8719.694810681596;8785.165409286108;8827.337949653931;8898.555072246232;7916.287534121957;7982.082060562877;8080.353571714131;8100.270975612223;8126.715564955198;5873.949831673383;5949.434803693643;5972.313183983723;6066.575339726177;6129.724162412791;4910.975445122752;5550.75021624036;5886.94113058864;6147.108669242845;6206.193194884636 09:43:09 INFO - PID 7795 | |4;prototype.html;386.6636026656808;389.43531878775764;396.10480314489257;398.5456579499369;401.63250625677506;4925.5813255873245;5956.404359564041;5984.832957573275;6006.249218847644;6010.8196754097335;4705.905881882369;5622.971885140569;5814.796482123116;5833.45413465432;5886.381929897363;3710.647488488603;4393.187260356828;4438.423005009345;4463.107378524292;4505.752183629907;3796.7152463565344;3942.369220924653;4318.157959197958;4404.229259879508;4455.883455358711;3240.9790915861545;4062.4921884764403;4142.233686767942;4463.772462572802;4481.887952801189;3594.7353167504566;4156.958430415702;4239.512456067561;4248;4254.978725106354;3664.340418724655;3669.6513831185994;3679.5952445231005;3686.1706116123923;3699.648533389324;5016.49835016499;5560.193771903051;5722.227499287585;5729.739457319383;5769.394213607595;5020.4226513951;5028.647994640377;5113.693178409308;5123.822375490402;5149.922751158736;4972.651914365996;5198.766055527472;6253.781117660906;6258.71835767387;6333.334999824998;4049.2711311963835;4146.212219678282;4154.148399578109;4163.646090082347;4212.262854000568;5456.645318054314;6181.979973304399;6509.316521765241;6569.967150164266;6614.801555953329;4052.804422695312;4065.634092931591;4073.5315438724333;4074.9796251019147;4096.344584866407;4242.024334403104;4269.7224680395675;4281;4288.7855607220135;4307.375430562551;4582.495925448198;4738.914877453909;5048.268001139814;5052.7726252318735;5064.873378165502;6115.877682446326;6368.363163683594;6370.936290637127;6381;6383.2978372379;1232.8041799454516;1436.3392839294042;1445.284584130841;1453.5058080252766;1456.4028748213182;920.2499962530517;942.4298299528823;948.9620415183454;949.5993409720606;968.4528241543505;4879.39007624047;4992.301077849104;5922.763089476372;5923.763049478059;5936.910946335808;5144;6280.309165991737;6546.476281897437;6557.868842623121;6610.909199982046;5265.947340526545;5860.267466566679;5879.794207202727;5949.672767997802;5961.165436838846;2747.931301717433;3169.920751981219;3209.51857221414;3417.837935102077;3439.7764145330475;5586.329640443173;6803.625800580917;6803.693833777492;6837.521373503807;6841;5769.9711501442225;6769.627670478072;6780.338617146785;6813.7955861324235;6836.38472537474;5287.444818294024;5988.461038506555;6305.96847015762;6851.314868513109;6853.623050732158;5521.806736764194;6594.307597702364;6612.5040621952585;6615.966920165369;6646.169228846395;5496.917546236889;6119.84700382494;6458.38645328693;6468.838279043061;6477.125588045554;6212.968935155476;6383.265924418752;6413.743450261937;6747.359000894907;6824.93175068243;4252.468441444819;4266.679999000025;4281.207976524353;4284.807183676679;4286.099919016917;5581.418581418581;6444.7744328948265;6652;6661.666916654245;6760.256371799196;5350.866228344167;5385.272988146707;6068.786242751379;6406.295307516262;6420.43182726913;5660.632058916157;6145.770845830941;6170.136180934763;6329.841753956188;6366.331535188739;5805.039429890701;6308.873822523616;6360.045993101072;6366.29970703213;6390.207344491631;5907.616004959664;5913.231279933581;6358.078078678658;6497.577657452251;6510.251321097945;5858.882822343615;6137.35557766446;6224.408681175281;6245.531585131224;6368.363163683594 09:43:09 INFO - PID 7795 | |5;yui.html;777.1373775109628;843.6625349860051;866.8179682266727;869.3653632848021;878.0341624213366;16321.265543050562;16330;16922.49232523026;16975.405860794875;16983;15558.922205388986;15583.688326233469;15771.92114039431;15781;15798.605034874134;928.5542939389097;949.2406075139895;951.6907005223295;954.1174413667364;977.5552123783662;991.9553620087113;1000.7248006798116;1026.6714651311584;1029.0995379043336;1029.5933106422958;1069.470612047034;1073.6778966310114;1074.6829685242833;1079.9784004319908;1082.2045796339723;1064.7178497698117;1070.0423121306465;1075.9515821788;1076.2842709598108;1078.8273876179812;801.767487428645;804.6499772598938;806.5120602035802;808.2846680687634;809.8987626546682;16806.411775587796;16890.239939202766;16949.322027118902;17309.134543272787;17598.648027039388;14800.259987000607;17390.695697822586;17486.650266994588;17579.64840703179;17805.287788488444;13824.239666818421;13986.720265594733;14090.225037622926;14212.644683882882;14245.572632821031;3467.549218601591;3485.2158264390564;3486.3027394521196;3488.6162522122545;3491.773034752758;87214;119967;124775;134058.3297083518;137836;10457.372557646566;11242.775144497227;11461.598844040418;11472.254303470248;11572.94213528927;19998.400047998584;25110;25241.24276271715;25483.745162548137;25650.102246421287;7979.3616510679;8000.959995199987;8035.437519373588;8046.436749427484;8047.114817370085;3758.981205094012;3812.8093595320124;3870.9806450967567;3872.845086196577;3962.32640451124;3562.87529936451;4254.957450425518;4270.295401258758;4273.487181538173;4281.12236991416;919.0396036142247;925.8102089071724;940.4357385568741;941.7457286532598;941.7928055827707;646.7057488842565;669.2170160911745;675.9290274521203;679.1035832700886;683.3166833166833;10673.412962286993;11052.226344155994;11425.371604561662;11699.707507312385;11825.763484730258;606.7845914700306;615.9045347971072;649.4901502320656;675.1864003875319;676.8713944350558;5048.7630530520255;5224.111900976843;5449.291592093082;5470.753816078286;5477.589180811455;87552.56223718841;94572.16283511368;99942;101447.4927625372;103569.96430035753;90855;91133;91258.54370728105;92384;92400.15199695968;82073;82085.76871346934;83428.58285708654;84552.57723711464;85470.57264713761;10760.246782725135;11245.269057511236;11275.548978040786;11312.03847672957;11495.48270327854;29886.517022446806;36360.45459318059;37968.620313796506;39834.800825995684;40037;38236.42645360266;51500.48499515107;52018.959620806614;52680.47319526756;53174.20238696345;13889.166650001032;14189.787153192505;14640.560783176521;14647.19440430744;14671.26643667791;15457;15463.072215667096;15727.292271848024;15877.841221588098;16053.03681779097;14329.9283503586;14498.782518262446;14538.273086345853;14561.563153105424;14697.70604587881;14325.713485730019;14524.419023238952;14687.118772873662;14878.256087195814;14909.701805964038;14095;14418.639534011734;14480.855191448372;14485.493007744679;14519.201443920685;9592.95203523978;10487.213458990758;10502.054015388947;10841.51213195424;11107.278026928223;11769.117316201147;11769.941150294193;11781.469833857325;11846.763064738829;11986.580469683518 09:43:09 INFO - PID 7795 | __end_tp_report 09:43:09 INFO - PID 7795 | __start_cc_report 09:43:09 INFO - PID 7795 | _x_x_mozilla_cycle_collect,1766 09:43:09 INFO - PID 7795 | __end_cc_report 09:43:09 INFO - PID 7795 | __startTimestamp1494002589392__endTimestamp 09:43:09 INFO - PID 7795 | 09:43:09 INFO - PID 7795 | ------- Summary: start ------- 09:43:09 INFO - PID 7795 | Number of tests: 6 09:43:09 INFO - PID 7795 | 09:43:09 INFO - PID 7795 | [#0] dojo.html Cycles:165 Average:6145.90 Median:6383.49 stddev:742.94 (11.6%) stddev-sans-first:706.77 09:43:09 INFO - PID 7795 | Values: 3138.8 3508.0 3512.7 3516.7 3528.0 6027.4 6130.5 6222.9 6230.1 6262.9 5887.3 6168.8 6274.3 6282.4 6312.3 4871.9 5173.5 5300.9 5361.1 5471.9 5303.5 5409.8 5433.9 5481.7 5485.6 5361.8 5391.5 5392.0 5443.5 5457.4 5408.1 5415.7 5424.7 5490.0 5496.6 5371.8 5394.9 5398.4 5414.2 5438.9 6137.9 6189.3 6196.3 6281.4 6302.8 6603.2 6670.3 6682.6 6684.1 6701.5 6754.8 6760.2 6764.1 6767.5 6775.0 6199.3 6264.9 6369.5 6375.3 6390.7 6626.0 6688.2 6811.3 6901.4 6913.3 6370.4 6383.5 6487.7 6581.3 6599.9 6637.5 6723.6 6735.6 6741.8 6751.6 6357.6 6627.0 6632.4 6634.9 6646.2 6402.4 6514.3 6594.4 6635.8 6637.6 5241.1 5281.5 5294.8 5303.4 5330.1 4634.3 4686.9 4718.2 4719.3 4746.5 6116.4 6164.2 6240.1 6285.0 6308.7 6719.3 6725.1 6750.3 6759.7 6779.1 6323.9 6324.6 6327.0 6328.7 6337.0 5728.7 5753.8 5812.6 5836.0 5876.6 6720.3 6853.3 6945.0 6955.6 6986.0 6715.2 6748.7 6767.7 6769.3 6772.8 6278.9 6909.1 6939.9 6973.5 6975.6 6123.5 6488.9 6524.3 6579.1 6608.8 6490.4 6742.3 6777.7 6780.1 6793.2 6322.1 6354.3 6468.0 6565.7 6575.2 6399.4 6551.6 6552.3 6565.2 6569.3 6242.3 6317.7 6409.0 6412.6 6429.7 6454.6 6505.4 6523.4 6536.3 6543.5 6383.8 6384.5 6394.0 6416.4 6421.7 09:43:09 INFO - PID 7795 | 09:43:09 INFO - PID 7795 | [#1] ext.html Cycles:180 Average:42958.07 Median:16876.70 stddev:75084.85 (444.9%) stddev-sans-first:75228.74 09:43:09 INFO - PID 7795 | Values: 793.6 802.1 1073.7 1126.4 1129.3 33976.5 37051.6 37093.8 37142.3 37250.8 38833.4 39236.0 39241.2 39260.8 39356.0 5902.2 6916.4 8383.6 8428.7 8431.1 5931.6 8202.9 8347.3 8351.5 8373.6 8390.0 8435.8 8437.1 8440.0 8487.7 5878.8 7231.4 8275.3 8410.8 8414.0 5979.6 8116.8 8312.0 8314.4 8354.1 36940.8 37280.4 37302.8 37311.1 37416.8 3521.9 3550.6 3551.7 3558.3 3569.5 30116.0 30201.8 30214.2 30273.8 30345.7 3027.0 3090.2 3093.8 3107.3 3126.7 293037.0 301006.0 302743.0 303367.0 303407.5 38498.0 38713.6 48797.8 49085.8 49092.5 39581.8 46121.5 47131.8 47243.5 47293.0 13496.8 13601.4 13602.8 13616.9 13628.3 10999.3 11009.7 11021.7 11032.2 11034.9 12273.6 12299.7 12314.9 12323.8 12417.3 5160.8 5222.8 5232.7 5233.9 5245.8 1003.5 1009.6 1010.4 1043.5 1054.6 22473.4 23480.1 23547.6 23564.9 23954.8 1087.8 1092.5 1130.2 1132.9 1155.8 10604.5 11203.4 11377.7 11965.8 11999.2 297361.0 298190.0 298629.0 298742.0 300137.0 51281.0 51364.7 51432.5 51447.2 51492.5 1501.2 1510.7 1562.3 1571.1 1572.4 21309.9 21447.0 22942.7 23052.9 23077.7 37674.8 37737.6 37750.2 37793.0 37793.4 256876.0 256880.0 257582.7 258222.0 258828.7 29034.6 29144.6 29182.4 33342.3 33432.5 35955.8 36003.7 36018.5 39651.2 42813.1 27872.4 28549.9 28712.1 29469.0 29857.1 30014.0 30051.5 30225.8 30312.4 30663.2 35996.5 36891.8 36918.0 36938.8 37131.8 24933.5 29477.1 29957.6 30476.4 30951.4 19957.5 22816.8 23673.6 23719.1 24047.9 09:43:09 INFO - PID 7795 | 09:43:09 INFO - PID 7795 | [#2] jquery.html Cycles:180 Average:35024.82 Median:12281.29 stddev:93277.04 (759.5%) stddev-sans-first:93502.42 09:43:09 INFO - PID 7795 | Values: 374.3 419.3 431.7 433.3 456.6 20363.4 20766.7 21116.3 21777.6 22067.6 20868.6 22164.8 22906.3 23082.4 23122.9 5733.5 6013.2 6017.0 6022.2 6026.2 4145.6 5992.2 6017.4 6019.9 6025.6 5426.5 5957.4 5975.4 5982.1 5986.9 5117.3 5713.6 5780.2 5849.9 5857.6 5003.0 5180.5 5233.5 5239.6 5239.9 25539.4 25679.2 25737.0 25994.5 26061.1 2190.8 2224.1 2232.4 2245.8 2256.2 17242.6 17275.9 17503.4 17748.6 17780.9 2092.6 2115.3 2143.5 2148.9 2163.2 140161.0 140341.3 141686.9 142883.3 169897.2 10339.9 11807.4 12429.2 12442.9 12858.7 16676.7 16680.7 16706.5 16720.0 16722.8 7783.7 8514.2 8889.7 8896.0 8967.0 7153.7 7551.8 8243.2 8480.4 8680.9 7527.1 7615.8 7658.8 7681.1 7762.1 1975.3 2044.8 2080.9 2083.1 2089.7 906.5 939.8 980.3 989.2 1016.6 20426.7 20955.8 20992.9 21061.5 21455.6 1003.6 1005.8 1015.5 1038.6 1044.1 10442.6 10797.7 10845.2 10845.3 10961.6 542044.0 545278.0 552094.2 560250.0 566497.0 91894.0 104964.0 109852.0 133393.0 139579.0 1074.8 1166.3 1192.9 1194.8 1197.1 22286.0 22330.2 22356.0 22740.5 22766.0 55652.7 57259.4 57403.7 57505.0 58234.0 76008.0 77153.6 77717.0 78997.6 79188.6 7401.5 7564.0 8205.7 8786.8 8898.6 13491.9 13594.4 13641.2 13981.2 14043.0 11621.1 11647.6 11747.3 11930.3 12013.6 10987.7 11023.0 11117.2 11309.3 11329.4 11517.1 11695.9 12000.5 12068.2 12105.7 8422.1 8473.8 8516.0 8974.5 8986.0 11455.9 11783.9 11868.6 11961.6 11991.7 09:43:09 INFO - PID 7795 | 09:43:09 INFO - PID 7795 | [#3] mootools.html Cycles:180 Average:7067.06 Median:4120.23 stddev:4499.67 (109.2%) stddev-sans-first:4491.21 09:43:09 INFO - PID 7795 | Values: 1269.8 1409.1 1425.7 1431.8 1432.0 9871.6 11207.7 11718.8 11739.0 11761.4 9771.3 11029.7 11409.9 11519.7 11617.4 2436.4 2523.2 2528.7 2531.2 2534.1 2091.8 2371.4 2508.6 2516.9 2517.9 1789.3 2159.0 2195.9 2514.4 2525.1 2277.3 2309.8 2465.5 2471.7 2482.7 2354.3 2389.8 2390.4 2393.9 2399.4 11154.4 11409.4 11427.1 11432.8 11498.9 6436.4 6711.0 6722.3 6728.2 6728.8 3785.8 4101.5 4138.9 4251.1 4251.8 1247.3 1255.9 1294.8 1299.7 1308.3 16074.6 16461.9 16484.3 16487.9 16513.1 5695.5 5749.4 5891.3 6000.1 6030.7 13756.7 13792.9 13804.0 13808.7 13826.0 6737.7 6742.2 6743.0 6752.9 6755.9 5266.8 5986.4 5997.0 6156.2 6180.3 4499.0 4581.5 4618.4 4651.1 4665.6 1377.4 1426.0 1429.5 1443.9 1448.9 669.9 691.4 699.9 709.5 809.2 6634.7 6688.2 6756.4 6832.8 6903.3 532.8 590.0 594.3 595.7 710.5 3957.5 4146.3 4308.2 4447.3 4552.1 14604.5 14983.1 15028.9 15055.8 15061.5 14277.9 14676.9 14973.8 14986.6 15041.9 8277.4 8516.1 8533.7 8535.1 8537.9 6839.1 6913.2 6932.5 7009.9 7032.9 11617.0 13105.2 13140.0 13218.7 13524.3 12851.5 13387.5 13391.0 13671.9 13803.3 7868.4 9007.8 9094.6 9158.5 9207.6 10199.6 10427.7 10434.5 10439.4 10439.9 8637.3 8816.5 8917.0 8974.0 8986.7 8658.3 8719.7 8785.2 8827.3 8898.6 7916.3 7982.1 8080.4 8100.3 8126.7 5873.9 5949.4 5972.3 6066.6 6129.7 4911.0 5550.8 5886.9 6147.1 6206.2 09:43:09 INFO - PID 7795 | 09:43:09 INFO - PID 7795 | [#4] prototype.html Cycles:180 Average:5043.35 Median:5725.98 stddev:1615.80 (28.2%) stddev-sans-first:1582.08 09:43:09 INFO - PID 7795 | Values: 386.7 389.4 396.1 398.5 401.6 4925.6 5956.4 5984.8 6006.2 6010.8 4705.9 5623.0 5814.8 5833.5 5886.4 3710.6 4393.2 4438.4 4463.1 4505.8 3796.7 3942.4 4318.2 4404.2 4455.9 3241.0 4062.5 4142.2 4463.8 4481.9 3594.7 4157.0 4239.5 4248.0 4255.0 3664.3 3669.7 3679.6 3686.2 3699.6 5016.5 5560.2 5722.2 5729.7 5769.4 5020.4 5028.6 5113.7 5123.8 5149.9 4972.7 5198.8 6253.8 6258.7 6333.3 4049.3 4146.2 4154.1 4163.6 4212.3 5456.6 6182.0 6509.3 6570.0 6614.8 4052.8 4065.6 4073.5 4075.0 4096.3 4242.0 4269.7 4281.0 4288.8 4307.4 4582.5 4738.9 5048.3 5052.8 5064.9 6115.9 6368.4 6370.9 6381.0 6383.3 1232.8 1436.3 1445.3 1453.5 1456.4 920.2 942.4 949.0 949.6 968.5 4879.4 4992.3 5922.8 5923.8 5936.9 5144.0 6280.3 6546.5 6557.9 6610.9 5265.9 5860.3 5879.8 5949.7 5961.2 2747.9 3169.9 3209.5 3417.8 3439.8 5586.3 6803.6 6803.7 6837.5 6841.0 5770.0 6769.6 6780.3 6813.8 6836.4 5287.4 5988.5 6306.0 6851.3 6853.6 5521.8 6594.3 6612.5 6616.0 6646.2 5496.9 6119.8 6458.4 6468.8 6477.1 6213.0 6383.3 6413.7 6747.4 6824.9 4252.5 4266.7 4281.2 4284.8 4286.1 5581.4 6444.8 6652.0 6661.7 6760.3 5350.9 5385.3 6068.8 6406.3 6420.4 5660.6 6145.8 6170.1 6329.8 6366.3 5805.0 6308.9 6360.0 6366.3 6390.2 5907.6 5913.2 6358.1 6497.6 6510.3 5858.9 6137.4 6224.4 6245.5 6368.4 09:43:09 INFO - PID 7795 | 09:43:09 INFO - PID 7795 | [#5] yui.html Cycles:180 Average:20756.67 Median:17533.15 stddev:29855.69 (170.3%) stddev-sans-first:29901.75 09:43:09 INFO - PID 7795 | Values: 777.1 843.7 866.8 869.4 878.0 16321.3 16330.0 16922.5 16975.4 16983.0 15558.9 15583.7 15771.9 15781.0 15798.6 928.6 949.2 951.7 954.1 977.6 992.0 1000.7 1026.7 1029.1 1029.6 1069.5 1073.7 1074.7 1080.0 1082.2 1064.7 1070.0 1076.0 1076.3 1078.8 801.8 804.6 806.5 808.3 809.9 16806.4 16890.2 16949.3 17309.1 17598.6 14800.3 17390.7 17486.7 17579.6 17805.3 13824.2 13986.7 14090.2 14212.6 14245.6 3467.5 3485.2 3486.3 3488.6 3491.8 87214.0 119967.0 124775.0 134058.3 137836.0 10457.4 11242.8 11461.6 11472.3 11572.9 19998.4 25110.0 25241.2 25483.7 25650.1 7979.4 8001.0 8035.4 8046.4 8047.1 3759.0 3812.8 3871.0 3872.8 3962.3 3562.9 4255.0 4270.3 4273.5 4281.1 919.0 925.8 940.4 941.7 941.8 646.7 669.2 675.9 679.1 683.3 10673.4 11052.2 11425.4 11699.7 11825.8 606.8 615.9 649.5 675.2 676.9 5048.8 5224.1 5449.3 5470.8 5477.6 87552.6 94572.2 99942.0 101447.5 103570.0 90855.0 91133.0 91258.5 92384.0 92400.2 82073.0 82085.8 83428.6 84552.6 85470.6 10760.2 11245.3 11275.5 11312.0 11495.5 29886.5 36360.5 37968.6 39834.8 40037.0 38236.4 51500.5 52019.0 52680.5 53174.2 13889.2 14189.8 14640.6 14647.2 14671.3 15457.0 15463.1 15727.3 15877.8 16053.0 14329.9 14498.8 14538.3 14561.6 14697.7 14325.7 14524.4 14687.1 14878.3 14909.7 14095.0 14418.6 14480.9 14485.5 14519.2 9593.0 10487.2 10502.1 10841.5 11107.3 11769.1 11769.9 11781.5 11846.8 11986.6 09:43:09 INFO - PID 7795 | -------- Summary: end -------- 09:43:09 INFO - PID 7795 | 09:43:10 INFO - TEST-INFO | 7795: exit 0 09:43:10 INFO - TEST-OK | dromaeo_css | took 1118852ms 09:43:10 INFO - TEST-START | kraken 09:43:10 INFO - operating with platform_type : mac_ 09:43:10 INFO - Initialising browser for kraken test... 09:43:10 INFO - TEST-INFO | started process 7799 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/tmpT23Dfm/profile http://localhost:63925/getInfo.html) 09:43:12 INFO - PID 7799 | __metrics Screen width/height:1600/1200 09:43:12 INFO - PID 7799 | colorDepth:24 09:43:12 INFO - PID 7799 | Browser inner width/height: 1024/691 09:43:12 INFO - PID 7799 | __metrics 09:43:12 INFO - PID 7799 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:43:12 INFO - PID 7799 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:43:13 INFO - TEST-INFO | 7799: exit 0 09:43:13 INFO - Browser initialized. 09:43:13 INFO - Running cycle 1/1 for kraken test... 09:43:13 INFO - TEST-INFO | started process 7800 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/tmpT23Dfm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:43:25 INFO - PID 7800 | RSS: Main: 239398912 09:43:25 INFO - PID 7800 | 09:43:28 INFO - PID 7800 | Cycle 1(1): loaded http://localhost:63925/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:63925/tests/kraken/driver.html?testName=audio-beat-detection) 09:43:29 INFO - PID 7800 | RSS: Main: 308477952 09:43:29 INFO - PID 7800 | 09:43:32 INFO - PID 7800 | Cycle 1(1): loaded http://localhost:63925/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:63925/tests/kraken/driver.html?testName=audio-dft) 09:43:32 INFO - PID 7800 | RSS: Main: 289497088 09:43:32 INFO - PID 7800 | 09:43:35 INFO - PID 7800 | Cycle 1(1): loaded http://localhost:63925/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:63925/tests/kraken/driver.html?testName=audio-fft) 09:43:36 INFO - PID 7800 | RSS: Main: 382181376 09:43:36 INFO - PID 7800 | 09:43:38 INFO - PID 7800 | Cycle 1(1): loaded http://localhost:63925/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:63925/tests/kraken/driver.html?testName=audio-oscillator) 09:43:39 INFO - PID 7800 | RSS: Main: 285949952 09:43:39 INFO - PID 7800 | 09:43:41 INFO - PID 7800 | Cycle 1(1): loaded http://localhost:63925/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:63925/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:43:41 INFO - PID 7800 | RSS: Main: 288133120 09:43:41 INFO - PID 7800 | 09:43:44 INFO - PID 7800 | Cycle 1(1): loaded http://localhost:63925/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:63925/tests/kraken/driver.html?testName=imaging-darkroom) 09:43:45 INFO - PID 7800 | RSS: Main: 351350784 09:43:45 INFO - PID 7800 | 09:43:48 INFO - PID 7800 | Cycle 1(1): loaded http://localhost:63925/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:63925/tests/kraken/driver.html?testName=imaging-desaturate) 09:43:48 INFO - PID 7800 | RSS: Main: 377270272 09:43:48 INFO - PID 7800 | 09:43:51 INFO - PID 7800 | Cycle 1(1): loaded http://localhost:63925/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:63925/tests/kraken/driver.html?testName=json-parse-financial) 09:43:52 INFO - PID 7800 | RSS: Main: 391585792 09:43:52 INFO - PID 7800 | 09:43:53 INFO - PID 7800 | Cycle 1(1): loaded http://localhost:63925/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:63925/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:43:54 INFO - PID 7800 | RSS: Main: 329732096 09:43:54 INFO - PID 7800 | 09:43:56 INFO - PID 7800 | Cycle 1(1): loaded http://localhost:63925/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:63925/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:43:56 INFO - PID 7800 | RSS: Main: 332554240 09:43:56 INFO - PID 7800 | 09:43:58 INFO - PID 7800 | Cycle 1(1): loaded http://localhost:63925/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:63925/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:43:59 INFO - PID 7800 | RSS: Main: 335646720 09:43:59 INFO - PID 7800 | 09:44:02 INFO - PID 7800 | Cycle 1(1): loaded http://localhost:63925/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:63925/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:44:03 INFO - PID 7800 | RSS: Main: 350912512 09:44:03 INFO - PID 7800 | 09:44:06 INFO - PID 7800 | Cycle 1(1): loaded http://localhost:63925/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:63925/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:44:06 INFO - PID 7800 | RSS: Main: 343670784 09:44:06 INFO - PID 7800 | 09:44:08 INFO - PID 7800 | Cycle 1(1): loaded http://localhost:63925/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:63925/tests/kraken/driver.html?testName=ai-astar) 09:44:08 INFO - PID 7800 | RSS: Main: 386695168 09:44:08 INFO - PID 7800 | 09:44:08 INFO - PID 7800 | __start_tp_report 09:44:08 INFO - PID 7800 | _x_x_mozilla_page_load 09:44:08 INFO - PID 7800 | _x_x_mozilla_page_load_details 09:44:08 INFO - PID 7800 | |i|pagename|runs| 09:44:08 INFO - PID 7800 | |0;ai-astar;110;111;112;112;111;110;108;110;110;111 09:44:08 INFO - PID 7800 | |1;audio-beat-detection;143;137;109;151;105;108;106;105;134;107 09:44:08 INFO - PID 7800 | |2;audio-dft;185;185;194;265;187;185;184;183;186;181 09:44:08 INFO - PID 7800 | |3;audio-fft;80;57;58;89;57;62;60;57;81;60 09:44:08 INFO - PID 7800 | |4;audio-oscillator;92;70;85;68;67;68;88;74;94;112 09:44:08 INFO - PID 7800 | |5;imaging-gaussian-blur;86;87;86;87;88;86;87;86;86;87 09:44:08 INFO - PID 7800 | |6;imaging-darkroom;94;94;94;95;94;94;92;94;94;93 09:44:08 INFO - PID 7800 | |7;imaging-desaturate;85;83;84;83;85;87;87;84;86;86 09:44:08 INFO - PID 7800 | |8;json-parse-financial;51;48;48;47;48;50;49;49;50;49 09:44:08 INFO - PID 7800 | |9;json-stringify-tinderbox;54;60;57;60;67;60;57;58;57;58 09:44:08 INFO - PID 7800 | |10;stanford-crypto-aes;84;81;82;82;83;83;83;82;83;82 09:44:08 INFO - PID 7800 | |11;stanford-crypto-ccm;136;134;150;119;144;151;144;134;182;138 09:44:08 INFO - PID 7800 | |12;stanford-crypto-pbkdf2;188;225;173;216;168;221;223;185;178;179 09:44:08 INFO - PID 7800 | |13;stanford-crypto-sha256-iterative;67;66;67;69;67;67;66;66;67;67 09:44:08 INFO - PID 7800 | __end_tp_report 09:44:08 INFO - PID 7800 | __start_cc_report 09:44:08 INFO - PID 7800 | _x_x_mozilla_cycle_collect,2196 09:44:08 INFO - PID 7800 | __end_cc_report 09:44:08 INFO - PID 7800 | __startTimestamp1494002648823__endTimestamp 09:44:08 INFO - PID 7800 | 09:44:08 INFO - PID 7800 | ------- Summary: start ------- 09:44:08 INFO - PID 7800 | Number of tests: 14 09:44:08 INFO - PID 7800 | 09:44:08 INFO - PID 7800 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:1.18 (1.1%) stddev-sans-first:1.24 09:44:08 INFO - PID 7800 | Values: 110.0 111.0 112.0 112.0 111.0 110.0 108.0 110.0 110.0 111.0 09:44:08 INFO - PID 7800 | 09:44:08 INFO - PID 7800 | [#1] audio-beat-detection Cycles:10 Average:120.50 Median:121.50 stddev:18.42 (15.2%) stddev-sans-first:17.64 09:44:08 INFO - PID 7800 | Values: 143.0 137.0 109.0 151.0 105.0 108.0 106.0 105.0 134.0 107.0 09:44:08 INFO - PID 7800 | 09:44:08 INFO - PID 7800 | [#2] audio-dft Cycles:10 Average:193.50 Median:185.50 stddev:25.35 (13.7%) stddev-sans-first:26.70 09:44:08 INFO - PID 7800 | Values: 185.0 185.0 194.0 265.0 187.0 185.0 184.0 183.0 186.0 181.0 09:44:08 INFO - PID 7800 | 09:44:08 INFO - PID 7800 | [#3] audio-fft Cycles:10 Average:66.10 Median:61.00 stddev:12.22 (20.0%) stddev-sans-first:11.89 09:44:08 INFO - PID 7800 | Values: 80.0 57.0 58.0 89.0 57.0 62.0 60.0 57.0 81.0 60.0 09:44:08 INFO - PID 7800 | 09:44:08 INFO - PID 7800 | [#4] audio-oscillator Cycles:10 Average:81.80 Median:79.50 stddev:14.96 (18.8%) stddev-sans-first:15.40 09:44:08 INFO - PID 7800 | Values: 92.0 70.0 85.0 68.0 67.0 68.0 88.0 74.0 94.0 112.0 09:44:08 INFO - PID 7800 | 09:44:08 INFO - PID 7800 | [#5] imaging-gaussian-blur Cycles:10 Average:86.60 Median:87.00 stddev:0.70 (0.8%) stddev-sans-first:0.71 09:44:08 INFO - PID 7800 | Values: 86.0 87.0 86.0 87.0 88.0 86.0 87.0 86.0 86.0 87.0 09:44:08 INFO - PID 7800 | 09:44:08 INFO - PID 7800 | [#6] imaging-darkroom Cycles:10 Average:93.80 Median:94.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 09:44:08 INFO - PID 7800 | Values: 94.0 94.0 94.0 95.0 94.0 94.0 92.0 94.0 94.0 93.0 09:44:08 INFO - PID 7800 | 09:44:08 INFO - PID 7800 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.50 stddev:1.49 (1.7%) stddev-sans-first:1.58 09:44:08 INFO - PID 7800 | Values: 85.0 83.0 84.0 83.0 85.0 87.0 87.0 84.0 86.0 86.0 09:44:08 INFO - PID 7800 | 09:44:08 INFO - PID 7800 | [#8] json-parse-financial Cycles:10 Average:48.90 Median:49.00 stddev:1.20 (2.4%) stddev-sans-first:1.00 09:44:08 INFO - PID 7800 | Values: 51.0 48.0 48.0 47.0 48.0 50.0 49.0 49.0 50.0 49.0 09:44:08 INFO - PID 7800 | 09:44:08 INFO - PID 7800 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.00 stddev:3.43 (5.8%) stddev-sans-first:3.16 09:44:08 INFO - PID 7800 | Values: 54.0 60.0 57.0 60.0 67.0 60.0 57.0 58.0 57.0 58.0 09:44:08 INFO - PID 7800 | 09:44:08 INFO - PID 7800 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:83.00 stddev:0.85 (1.0%) stddev-sans-first:0.71 09:44:08 INFO - PID 7800 | Values: 84.0 81.0 82.0 82.0 83.0 83.0 83.0 82.0 83.0 82.0 09:44:08 INFO - PID 7800 | 09:44:08 INFO - PID 7800 | [#11] stanford-crypto-ccm Cycles:10 Average:143.20 Median:144.00 stddev:16.49 (11.5%) stddev-sans-first:17.28 09:44:08 INFO - PID 7800 | Values: 136.0 134.0 150.0 119.0 144.0 151.0 144.0 134.0 182.0 138.0 09:44:08 INFO - PID 7800 | 09:44:08 INFO - PID 7800 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.60 Median:202.00 stddev:22.86 (11.3%) stddev-sans-first:24.08 09:44:08 INFO - PID 7800 | Values: 188.0 225.0 173.0 216.0 168.0 221.0 223.0 185.0 178.0 179.0 09:44:08 INFO - PID 7800 | 09:44:08 INFO - PID 7800 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 09:44:08 INFO - PID 7800 | Values: 67.0 66.0 67.0 69.0 67.0 67.0 66.0 66.0 67.0 67.0 09:44:08 INFO - PID 7800 | -------- Summary: end -------- 09:44:08 INFO - PID 7800 | 09:44:09 INFO - TEST-INFO | 7800: exit 0 09:44:09 INFO - TEST-OK | kraken | took 59831ms 09:44:09 INFO - SUITE-END | took 1178s 09:44:09 INFO - Completed test suite (00:19:38) 09:44:09 INFO - javascript benchmark 09:44:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7661.050509854902, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3138.7802853800213, 3508.0, 3512.6662967018133, 3516.665916737909, 3528.0474271946573, 6027.3972602739705, 6130.4592857107245, 6222.937770622298, 6230.06549017647, 6262.937370626292, 5887.264091988502, 6168.753249870011, 6274.341194174614, 6282.434580887719, 6312.305646378894, 4871.878203044935, 5173.482651734834, 5300.946990530084, 5361.142217245241, 5471.890562188753, 5303.522682958533, 5409.837704868841, 5433.918491222635, 5481.725913704299, 5485.61600687952, 5361.785528578852, 5391.541718953894, 5391.973040134774, 5443.537299329561, 5457.372402173761, 5408.0535906216255, 5415.729213539307, 5424.674519528841, 5490.011797876381, 5496.642718223303, 5371.758270877781, 5394.91907621386, 5398.379186393576, 5414.214938833887, 5438.945610543883, 6137.8673257933415, 6189.319174890758, 6196.287426945869, 6281.434670879597, 6302.842428939313, 6603.240627327871, 6670.3329667033395, 6682.599044057372, 6684.097646817666, 6701.497387695942, 6754.8311292217595, 6760.1549806274215, 6764.0530325754435, 6767.458603311772, 6775.017622444718, 6199.256089269316, 6264.9373506265265, 6369.458596019297, 6375.2987171411105, 6390.680465976682, 6626.039224312448, 6688.230853451818, 6811.318868113149, 6901.378875901193, 6913.343232392915, 6370.394812492806, 6383.489320854321, 6487.7080531376205, 6581.308962558863, 6599.934000660028, 6637.502187335969, 6723.596584204964, 6735.629540375228, 6741.831454213586, 6751.628660423626, 6357.554971151975, 6627.03907933347, 6632.403083722488, 6634.933650663432, 6646.20245570525, 6402.423781859562, 6514.348565143448, 6594.406503414716, 6635.834104147435, 6637.568558043712, 5241.109011468059, 5281.471852814688, 5294.7617357219015, 5303.390110137307, 5330.120530112566, 4634.304854271886, 4686.906261874743, 4718.150732868048, 4719.315699223594, 4746.5490778376, 6116.366205733216, 6164.229471316085, 6240.095186197976, 6284.994400895835, 6308.747650093945, 6719.328067193339, 6725.092112564839, 6750.291219421988, 6759.729610815611, 6779.0509328694025, 6323.873522529524, 6324.557280990379, 6327.0, 6328.651924144124, 6337.04944258365, 5728.656280623176, 5753.769849206069, 5812.59311848175, 5836.0, 5876.6180198286975, 6720.32796720324, 6853.280405557544, 6944.965275173592, 6955.617441040589, 6986.0219569259325, 6715.1941766988275, 6748.69630866622, 6767.729290828312, 6769.323067693192, 6772.796816095525, 6278.937210627835, 6909.1018167639895, 6939.861202775815, 6973.476989225727, 6975.616341101085, 6123.510119190543, 6488.902666459912, 6524.282328943717, 6579.078928949855, 6608.768693095719, 6490.383413575702, 6742.325767423218, 6777.661116944231, 6780.050792888901, 6793.184817821893, 6322.083297921868, 6354.269259035085, 6468.029795530708, 6565.704543295658, 6575.178102737158, 6399.424051835357, 6551.574147680385, 6552.3447655234095, 6565.179352580927, 6569.277379488157, 6242.313345531897, 6317.715702793477, 6408.967955160381, 6412.583182093149, 6429.710663020269, 6454.612723236621, 6505.447037001908, 6523.412892839668, 6536.346365363425, 6543.509236807164, 6383.776567820104, 6384.457321127757, 6394.0408938659575, 6416.422521973045, 6421.7110230038825], "value": 6093.054625705843, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [793.559574436188, 802.1377019703818, 1073.747669297715, 1126.3579759537056, 1129.2659771148753, 33976.4903526447, 37051.62948370519, 37093.81453092731, 37142.25715485689, 37250.8137459313, 38833.417498737545, 39236.0, 39241.21517569647, 39260.80369598148, 39356.0, 5902.173695682608, 6916.377526022657, 8383.622736976851, 8428.747137585882, 8431.072582016004, 5931.555133364994, 8202.876956845652, 8347.29048030918, 8351.496730588491, 8373.62318695657, 8390.0, 8435.83128337433, 8437.071922088566, 8439.987201535794, 8487.702930397438, 5878.823635290905, 7231.421486281111, 8275.337972962148, 8410.78973025673, 8413.95793021037, 5979.611325263844, 8116.797080072986, 8312.002559692875, 8314.41799074065, 8354.122817104238, 36940.81529592335, 37280.44079338812, 37302.81348593267, 37311.06722331936, 37416.812915935516, 3521.8591256349714, 3550.6449355064547, 3551.662592053751, 3558.2527669189503, 3569.5359603251413, 30116.0, 30201.79192832284, 30214.24464388386, 30273.848630756704, 30345.69654303473, 3027.04648035868, 3090.165655273086, 3093.7834351595397, 3107.3008573071106, 3126.656067832537, 293037.0, 301006.0, 302743.0, 303367.0, 303407.482962586, 38498.03754906094, 38713.612863871, 48797.75601121972, 49085.754571227626, 49092.50907490951, 39581.80209098936, 46121.53878461239, 47131.76434117876, 47243.5275647246, 47293.0, 13496.797548036591, 13601.387937542835, 13602.795958060637, 13616.93191534036, 13628.318584070757, 10999.34003959765, 11009.669709908556, 11021.669349919515, 11032.227744058, 11034.944825275983, 12273.631791046282, 12299.692507687201, 12314.876851231373, 12323.815142772866, 12417.254964701966, 5160.767765450564, 5222.764975576109, 5232.659877107976, 5233.947660523422, 5245.816396426107, 1003.508280942333, 1009.5860697114148, 1010.3937637417491, 1043.4574021508772, 1054.615065501102, 22473.43816404603, 23480.060797568247, 23547.646785298235, 23564.882175589355, 23954.760452395603, 1087.842262871895, 1092.4537731134433, 1130.2088538023415, 1132.9376884271444, 1155.8324043013715, 10604.469776511143, 11203.383813890314, 11377.658670239905, 11965.76068478643, 11999.220050696676, 297361.0, 298190.0, 298629.0, 298742.0, 300137.0, 51281.0, 51364.743176284624, 51432.485675143515, 51447.22829157566, 51492.48507514952, 1501.1593507635541, 1510.6978604279188, 1562.3125824637123, 1571.0966194438245, 1572.4496426250948, 21309.893450532647, 21447.0, 22942.655860162446, 23052.884735576885, 23077.653835192148, 37674.81162594169, 37737.62262377451, 37750.2449950994, 37793.0, 37793.433098502996, 256876.0, 256880.0, 257582.71208643838, 258222.0, 258828.70585646952, 29034.564481532372, 29144.562831557967, 29182.416351673273, 33342.333153337284, 33432.49851252282, 35955.820220899775, 36003.73986910446, 36018.4597231047, 39651.20697585974, 42813.14373712446, 27872.44255114927, 28549.857250713612, 28712.138635840958, 29469.0, 29857.10428687143, 30014.0, 30051.549226762054, 30225.848870755504, 30312.393752124393, 30663.240308372355, 35996.4600530987, 36891.81554092212, 36918.0, 36938.8153059233, 37131.8143409292, 24933.50132997366, 29477.11568652944, 29957.55063674003, 30476.390472190877, 30951.380972379975, 19957.501062473555, 22816.771832281465, 23673.64489532624, 23719.051237950287, 24047.879760601085], "value": 16778.72923918494, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.3411595591759, 419.2704693832732, 431.71938240143925, 433.31536172846893, 456.58222726205526, 20363.389098327036, 20766.6884996725, 21116.260930867422, 21777.564448711055, 22067.558648827053, 20868.582628347423, 22164.778352216472, 22906.312810615666, 23082.422939426524, 23122.88438557809, 5733.48398644123, 6013.1581578579035, 6017.007193813038, 6022.247219097613, 6026.246719160105, 4145.626893579577, 5992.161097446361, 6017.428344307284, 6019.939800601982, 6025.6083354581815, 5426.457354264562, 5957.434043765836, 5975.432333928292, 5982.0727787193055, 5986.910196347037, 5117.283580298761, 5713.628614140068, 5780.1907732917425, 5849.853753656172, 5857.619254748449, 5003.049420610108, 5180.507851754077, 5233.476652334774, 5239.607029472805, 5239.869003274911, 25539.36151596225, 25679.229623111336, 25736.97052117932, 25994.480110397875, 26061.08786192493, 2190.7622193460643, 2224.0992398078806, 2232.352617740853, 2245.7641947595594, 2256.165218869029, 17242.56893577658, 17275.913620431817, 17503.38738144159, 17748.645027099385, 17780.933144011273, 2092.591944570809, 2115.2913773885766, 2143.4781305273273, 2148.946276343104, 2163.2104281937136, 140161.0, 140341.2982935089, 141686.87469687962, 142883.2855835714, 169897.15051424789, 10339.948300258451, 11807.350595717146, 12429.192102513489, 12442.937785311016, 12858.67853303675, 16676.6664666706, 16680.66638667244, 16706.49880503587, 16719.996800191784, 16722.82603261568, 7783.727569535039, 8514.191151840565, 8889.733308000641, 8895.955520222487, 8967.0, 7153.713851445884, 7551.811204719926, 8243.175682431829, 8480.406371554056, 8680.8697869532, 7527.096748390119, 7615.771526854203, 7658.846823063507, 7681.116671582728, 7762.107357653829, 1975.2888959974398, 2044.8159665630164, 2080.864743791649, 2083.1354987680247, 2089.7387826521685, 906.5467266366817, 939.7744541310036, 980.3382716666222, 989.1592146675413, 1016.5679586175846, 20426.69359959602, 20955.790442095386, 20992.895035524725, 21061.473463163544, 21455.570888582453, 1003.5835128421623, 1005.8139244239693, 1015.4719545836124, 1038.6260946059413, 1044.1281529922448, 10442.582296708199, 10797.676069717922, 10845.186611004048, 10845.295055821347, 10961.616343427942, 542044.0, 545278.0, 552094.2395287998, 560250.0, 566497.0, 91894.0, 104963.95036049542, 109852.0, 133393.0, 139579.0, 1074.7635520185547, 1166.2827361172817, 1192.8807119288, 1194.7729931313022, 1197.060307658484, 22286.0, 22330.21844235444, 22355.993980270603, 22740.545189095796, 22766.0, 55652.721736392676, 57259.42740572541, 57403.712981436496, 57504.987325443406, 58234.0, 76008.0, 77153.61423192848, 77717.0, 78997.60501197458, 79188.60405697934, 7401.5189012714, 7564.0, 8205.71280005197, 8786.813780139599, 8898.55507224649, 13491.86508134906, 13594.388252528463, 13641.181529108286, 13981.23103229332, 14043.016988810685, 11621.12841536905, 11647.59233426826, 11747.29516229029, 11930.284182949052, 12013.63959081229, 10987.725306867393, 11023.007929286403, 11117.16621253393, 11309.321440713584, 11329.376884271114, 11517.07863370945, 11695.88304116948, 12000.519979201083, 12068.155229133876, 12105.69735756613, 8422.073571906963, 8473.824091110684, 8515.957420212859, 8974.461532308082, 8986.0, 11455.942720286344, 11783.941080294544, 11868.643940681794, 11961.581344652895, 11991.700207494883], "value": 10247.807796837691, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1269.8031805070214, 1409.133382969474, 1425.7362387958221, 1431.8067060946776, 1431.9785203221954, 9871.605135794569, 11207.6637700869, 11718.824217636742, 11739.00218481428, 11761.411929403528, 9771.316007879434, 11029.669109926715, 11409.942950285236, 11519.65441036768, 11617.361045142514, 2436.3543660929868, 2523.2304147235086, 2528.7091984421845, 2531.1520640585427, 2534.1383929463977, 2091.7594476635154, 2371.3952941999764, 2508.5610018246825, 2516.9119080832174, 2517.924462266135, 1789.3021721528614, 2159.028437203257, 2195.9451013724706, 2514.421683012908, 2525.0657256815, 2277.2826559633663, 2309.764276112289, 2465.48224872776, 2471.653968444419, 2482.6524286599893, 2354.270176245352, 2389.808815294772, 2390.3904504351453, 2393.856368617871, 2399.448126930798, 11154.442277886073, 11409.42952852354, 11427.08583313333, 11432.771344573144, 11498.885011149949, 6436.388543088399, 6711.0269010993625, 6722.327767223239, 6728.226253980806, 6728.83177920551, 3785.791781452019, 4101.52832424272, 4138.937915931264, 4251.06476575153, 4251.80866860992, 1247.3139773124744, 1255.880691334331, 1294.8316718826493, 1299.6880748620358, 1308.2608326295613, 16074.5981350466, 16461.917690411592, 16484.258208380652, 16487.917560412123, 16513.091779952098, 5695.487406133468, 5749.3963133871175, 5891.293044834561, 6000.129981152709, 6030.728617212236, 13756.65608359779, 13792.862071379157, 13804.0, 13808.654783630489, 13826.0, 6737.730490780412, 6742.157230346207, 6742.9662851685425, 6752.898706519406, 6755.898661520081, 5266.7629956652045, 5986.3714309997695, 5997.0, 6156.168917196122, 6180.289266734293, 4498.977505112453, 4581.518940511199, 4618.35343051973, 4651.069786042805, 4665.626749860003, 1377.3870627570834, 1425.9500917468047, 1429.535400994681, 1443.877270432025, 1448.8696017358488, 669.8698139915019, 691.4192078653955, 699.8915168148945, 709.482078082992, 809.1665584448028, 6634.734610615521, 6688.197416310074, 6756.425703815133, 6832.829179270459, 6903.309669033157, 532.7815595605783, 589.9705014749245, 594.2631137389606, 595.7170344086611, 710.5417006031081, 3957.5250969883223, 4146.253674338588, 4308.202982448257, 4447.288433850568, 4552.11233809404, 14604.488842890449, 14983.101013939198, 15028.94797364174, 15055.849441505663, 15061.472848450252, 14277.928610356881, 14676.926615366854, 14973.775393368891, 14986.625334366729, 15041.924790375979, 8277.420580559303, 8516.06323304436, 8533.701320453754, 8535.061143274235, 8537.871931921027, 6839.1451068616425, 6913.171321892434, 6932.549384290207, 7009.894851577333, 7032.859342813217, 11617.012553933011, 13105.2136871788, 13140.0, 13218.735625287633, 13524.323783810572, 12851.485940562272, 13387.464501419834, 13390.995675324195, 13671.863281367458, 13803.274590676165, 7868.370530357673, 9007.819843603222, 9094.59074341643, 9158.496282704515, 9207.58565864551, 10199.643012494527, 10427.68716938493, 10434.478276086014, 10439.425831579336, 10439.895601043892, 8637.265832404317, 8816.471011739317, 8916.955415222883, 8974.0, 8986.68546600866, 8658.264047556027, 8719.694810681596, 8785.165409286108, 8827.337949653931, 8898.555072246232, 7916.287534121957, 7982.082060562877, 8080.353571714131, 8100.270975612223, 8126.715564955198, 5873.949831673383, 5949.434803693643, 5972.313183983723, 6066.575339726177, 6129.724162412791, 4910.975445122752, 5550.75021624036, 5886.94113058864, 6147.108669242845, 6206.193194884636], "value": 5282.438227515396, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.6636026656808, 389.43531878775764, 396.10480314489257, 398.5456579499369, 401.63250625677506, 4925.5813255873245, 5956.404359564041, 5984.832957573275, 6006.249218847644, 6010.8196754097335, 4705.905881882369, 5622.971885140569, 5814.796482123116, 5833.45413465432, 5886.381929897363, 3710.647488488603, 4393.187260356828, 4438.423005009345, 4463.107378524292, 4505.752183629907, 3796.7152463565344, 3942.369220924653, 4318.157959197958, 4404.229259879508, 4455.883455358711, 3240.9790915861545, 4062.4921884764403, 4142.233686767942, 4463.772462572802, 4481.887952801189, 3594.7353167504566, 4156.958430415702, 4239.512456067561, 4248.0, 4254.978725106354, 3664.340418724655, 3669.6513831185994, 3679.5952445231005, 3686.1706116123923, 3699.648533389324, 5016.49835016499, 5560.193771903051, 5722.227499287585, 5729.739457319383, 5769.394213607595, 5020.4226513951, 5028.647994640377, 5113.693178409308, 5123.822375490402, 5149.922751158736, 4972.651914365996, 5198.766055527472, 6253.781117660906, 6258.71835767387, 6333.334999824998, 4049.2711311963835, 4146.212219678282, 4154.148399578109, 4163.646090082347, 4212.262854000568, 5456.645318054314, 6181.979973304399, 6509.316521765241, 6569.967150164266, 6614.801555953329, 4052.804422695312, 4065.634092931591, 4073.5315438724333, 4074.9796251019147, 4096.344584866407, 4242.024334403104, 4269.7224680395675, 4281.0, 4288.7855607220135, 4307.375430562551, 4582.495925448198, 4738.914877453909, 5048.268001139814, 5052.7726252318735, 5064.873378165502, 6115.877682446326, 6368.363163683594, 6370.936290637127, 6381.0, 6383.2978372379, 1232.8041799454516, 1436.3392839294042, 1445.284584130841, 1453.5058080252766, 1456.4028748213182, 920.2499962530517, 942.4298299528823, 948.9620415183454, 949.5993409720606, 968.4528241543505, 4879.39007624047, 4992.301077849104, 5922.763089476372, 5923.763049478059, 5936.910946335808, 5144.0, 6280.309165991737, 6546.476281897437, 6557.868842623121, 6610.909199982046, 5265.947340526545, 5860.267466566679, 5879.794207202727, 5949.672767997802, 5961.165436838846, 2747.931301717433, 3169.920751981219, 3209.51857221414, 3417.837935102077, 3439.7764145330475, 5586.329640443173, 6803.625800580917, 6803.693833777492, 6837.521373503807, 6841.0, 5769.9711501442225, 6769.627670478072, 6780.338617146785, 6813.7955861324235, 6836.38472537474, 5287.444818294024, 5988.461038506555, 6305.96847015762, 6851.314868513109, 6853.623050732158, 5521.806736764194, 6594.307597702364, 6612.5040621952585, 6615.966920165369, 6646.169228846395, 5496.917546236889, 6119.84700382494, 6458.38645328693, 6468.838279043061, 6477.125588045554, 6212.968935155476, 6383.265924418752, 6413.743450261937, 6747.359000894907, 6824.93175068243, 4252.468441444819, 4266.679999000025, 4281.207976524353, 4284.807183676679, 4286.099919016917, 5581.418581418581, 6444.7744328948265, 6652.0, 6661.666916654245, 6760.256371799196, 5350.866228344167, 5385.272988146707, 6068.786242751379, 6406.295307516262, 6420.43182726913, 5660.632058916157, 6145.770845830941, 6170.136180934763, 6329.841753956188, 6366.331535188739, 5805.039429890701, 6308.873822523616, 6360.045993101072, 6366.29970703213, 6390.207344491631, 5907.616004959664, 5913.231279933581, 6358.078078678658, 6497.577657452251, 6510.251321097945, 5858.882822343615, 6137.35557766446, 6224.408681175281, 6245.531585131224, 6368.363163683594], "value": 4543.003889544182, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [777.1373775109628, 843.6625349860051, 866.8179682266727, 869.3653632848021, 878.0341624213366, 16321.265543050562, 16330.0, 16922.49232523026, 16975.405860794875, 16983.0, 15558.922205388986, 15583.688326233469, 15771.92114039431, 15781.0, 15798.605034874134, 928.5542939389097, 949.2406075139895, 951.6907005223295, 954.1174413667364, 977.5552123783662, 991.9553620087113, 1000.7248006798116, 1026.6714651311584, 1029.0995379043336, 1029.5933106422958, 1069.470612047034, 1073.6778966310114, 1074.6829685242833, 1079.9784004319908, 1082.2045796339723, 1064.7178497698117, 1070.0423121306465, 1075.9515821788, 1076.2842709598108, 1078.8273876179812, 801.767487428645, 804.6499772598938, 806.5120602035802, 808.2846680687634, 809.8987626546682, 16806.411775587796, 16890.239939202766, 16949.322027118902, 17309.134543272787, 17598.648027039388, 14800.259987000607, 17390.695697822586, 17486.650266994588, 17579.64840703179, 17805.287788488444, 13824.239666818421, 13986.720265594733, 14090.225037622926, 14212.644683882882, 14245.572632821031, 3467.549218601591, 3485.2158264390564, 3486.3027394521196, 3488.6162522122545, 3491.773034752758, 87214.0, 119967.0, 124775.0, 134058.3297083518, 137836.0, 10457.372557646566, 11242.775144497227, 11461.598844040418, 11472.254303470248, 11572.94213528927, 19998.400047998584, 25110.0, 25241.24276271715, 25483.745162548137, 25650.102246421287, 7979.3616510679, 8000.959995199987, 8035.437519373588, 8046.436749427484, 8047.114817370085, 3758.981205094012, 3812.8093595320124, 3870.9806450967567, 3872.845086196577, 3962.32640451124, 3562.87529936451, 4254.957450425518, 4270.295401258758, 4273.487181538173, 4281.12236991416, 919.0396036142247, 925.8102089071724, 940.4357385568741, 941.7457286532598, 941.7928055827707, 646.7057488842565, 669.2170160911745, 675.9290274521203, 679.1035832700886, 683.3166833166833, 10673.412962286993, 11052.226344155994, 11425.371604561662, 11699.707507312385, 11825.763484730258, 606.7845914700306, 615.9045347971072, 649.4901502320656, 675.1864003875319, 676.8713944350558, 5048.7630530520255, 5224.111900976843, 5449.291592093082, 5470.753816078286, 5477.589180811455, 87552.56223718841, 94572.16283511368, 99942.0, 101447.4927625372, 103569.96430035753, 90855.0, 91133.0, 91258.54370728105, 92384.0, 92400.15199695968, 82073.0, 82085.76871346934, 83428.58285708654, 84552.57723711464, 85470.57264713761, 10760.246782725135, 11245.269057511236, 11275.548978040786, 11312.03847672957, 11495.48270327854, 29886.517022446806, 36360.45459318059, 37968.620313796506, 39834.800825995684, 40037.0, 38236.42645360266, 51500.48499515107, 52018.959620806614, 52680.47319526756, 53174.20238696345, 13889.166650001032, 14189.787153192505, 14640.560783176521, 14647.19440430744, 14671.26643667791, 15457.0, 15463.072215667096, 15727.292271848024, 15877.841221588098, 16053.03681779097, 14329.9283503586, 14498.782518262446, 14538.273086345853, 14561.563153105424, 14697.70604587881, 14325.713485730019, 14524.419023238952, 14687.118772873662, 14878.256087195814, 14909.701805964038, 14095.0, 14418.639534011734, 14480.855191448372, 14485.493007744679, 14519.201443920685, 9592.95203523978, 10487.213458990758, 10502.054015388947, 10841.51213195424, 11107.278026928223, 11769.117316201147, 11769.941150294193, 11781.469833857325, 11846.763064738829, 11986.580469683518], "value": 8040.741247024104, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1433.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 112.0, 112.0, 111.0, 110.0, 108.0, 110.0, 110.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 137.0, 109.0, 151.0, 105.0, 108.0, 106.0, 105.0, 134.0, 107.0], "value": 120.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 194.0, 265.0, 187.0, 185.0, 184.0, 183.0, 186.0, 181.0], "value": 193.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 58.0, 89.0, 57.0, 62.0, 60.0, 57.0, 81.0, 60.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 70.0, 85.0, 68.0, 67.0, 68.0, 88.0, 74.0, 94.0, 112.0], "value": 81.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 86.0, 87.0, 88.0, 86.0, 87.0, 86.0, 86.0, 87.0], "value": 86.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 92.0, 94.0, 94.0, 93.0], "value": 93.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 84.0, 83.0, 85.0, 87.0, 87.0, 84.0, 86.0, 86.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 48.0, 48.0, 47.0, 48.0, 50.0, 49.0, 49.0, 50.0, 49.0], "value": 48.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 60.0, 57.0, 60.0, 67.0, 60.0, 57.0, 58.0, 57.0, 58.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 82.0, 82.0, 83.0, 83.0, 83.0, 82.0, 83.0, 82.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 134.0, 150.0, 119.0, 144.0, 151.0, 144.0, 134.0, 182.0, 138.0], "value": 143.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 225.0, 173.0, 216.0, 168.0, 221.0, 223.0, 185.0, 178.0, 179.0], "value": 195.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 69.0, 67.0, 67.0, 66.0, 66.0, 67.0, 67.0], "value": 66.9, "unit": "score"}]}]} 09:44:10 INFO - Return code: 0 09:44:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:44:10 INFO - # TBPL SUCCESS # 09:44:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:44:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:44:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:44:10 INFO - 2017-05-05 09:44:10.149 screenresolution[7805:202122] starting screenresolution argv=screenresolution get 09:44:10 INFO - 2017-05-05 09:44:10.151 screenresolution[7805:202122] Display 0: 1600x1200x32@60 09:44:10 INFO - 2017-05-05 09:44:10.158 screenresolution[7806:202125] starting screenresolution argv=screenresolution list 09:44:10 INFO - Available Modes on Display 0 09:44:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:44:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:44:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:44:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:44:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:44:10 INFO - Intel Iris: 09:44:10 INFO - Chipset Model: Intel Iris 09:44:10 INFO - Type: GPU 09:44:10 INFO - Bus: Built-In 09:44:10 INFO - VRAM (Dynamic, Max): 1536 MB 09:44:10 INFO - Vendor: Intel (0x8086) 09:44:10 INFO - Device ID: 0x0a2e 09:44:10 INFO - Revision ID: 0x0009 09:44:10 INFO - Displays: 09:44:10 INFO - Display: 09:44:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:44:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:44:10 INFO - Display Serial Number: 1600x1200 60 09:44:10 INFO - Main Display: Yes 09:44:10 INFO - Mirror: Off 09:44:10 INFO - Online: Yes 09:44:10 INFO - Rotation: Supported 09:44:10 INFO - Return code: 0 09:44:10 INFO - Running post-action listener: _resource_record_post_action 09:44:10 INFO - [mozharness: 2017-05-05 16:44:10.408222Z] Finished run-tests step (success) 09:44:10 INFO - Running post-run listener: _resource_record_post_run 09:44:10 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 88064; Write bytes: 511613440; Read time: 8; Write time: 1585 09:44:10 INFO - TinderboxPrint: CPU usage
53.5% 09:44:10 INFO - TinderboxPrint: I/O read bytes / time
88,064 / 8 09:44:10 INFO - TinderboxPrint: I/O write bytes / time
511,613,440 / 1,585 09:44:10 INFO - TinderboxPrint: CPU idle
2,230.8 (46.5%) 09:44:10 INFO - TinderboxPrint: CPU system
964.4 (20.1%) 09:44:10 INFO - TinderboxPrint: CPU user
1,602.4 (33.4%) 09:44:10 INFO - TinderboxPrint: Swap in / out
207,667,200 / 0 09:44:10 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 209298432; Write bytes: 213293056; Read time: 16063; Write time: 450 09:44:10 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 30208; Write bytes: 296731136; Read time: 4; Write time: 1125 09:44:10 INFO - Running post-run listener: _upload_blobber_files 09:44:10 INFO - Blob upload gear active. 09:44:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:44:10 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 09:44:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:44:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:44:11 INFO - (blobuploader) - INFO - Open directory for files ... 09:44:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:44:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:44:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:12 INFO - (blobuploader) - INFO - Done attempting. 09:44:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:44:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:44:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:12 INFO - (blobuploader) - INFO - Done attempting. 09:44:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:44:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:44:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:13 INFO - (blobuploader) - INFO - Done attempting. 09:44:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:44:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:44:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:15 INFO - (blobuploader) - INFO - Done attempting. 09:44:15 INFO - (blobuploader) - INFO - Iteration through files over. 09:44:15 INFO - Return code: 0 09:44:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:44:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:44:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f38e9dbe94e37fc0489f6e9d57115ef8509dd2f7a15d01a6a731cff34cbb411e209f11accfee6d39deabadae93a2d26f9736a092e89282277f0e683dd3dc2921", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f35e631125fda250b3a930c5066eeb1348cafe9051e871392edee355aa38ec8540abed21ceb64f202e1ac55371b75d574787a906f7d0af70178fbea693cb9a5b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c086afa2f93defc151ddb0106083f10445aa99f1ca50f32a97568140884d5825522123fb17155b5004175ab206cc09309a2aa3dc820ba9ef1c23085fd5c32934", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc193171e6d63ae3ebcd8f320f60c21f995b894e8a3a7d2e9f9f780ef6bb73176f27a05740d6f5e3d3f5d6b66fb93f698dc1a003a953a9558e9b962f9f6840a7"} 09:44:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:44:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:44:15 INFO - Contents: 09:44:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f38e9dbe94e37fc0489f6e9d57115ef8509dd2f7a15d01a6a731cff34cbb411e209f11accfee6d39deabadae93a2d26f9736a092e89282277f0e683dd3dc2921", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f35e631125fda250b3a930c5066eeb1348cafe9051e871392edee355aa38ec8540abed21ceb64f202e1ac55371b75d574787a906f7d0af70178fbea693cb9a5b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c086afa2f93defc151ddb0106083f10445aa99f1ca50f32a97568140884d5825522123fb17155b5004175ab206cc09309a2aa3dc820ba9ef1c23085fd5c32934", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc193171e6d63ae3ebcd8f320f60c21f995b894e8a3a7d2e9f9f780ef6bb73176f27a05740d6f5e3d3f5d6b66fb93f698dc1a003a953a9558e9b962f9f6840a7"} 09:44:15 INFO - Running post-run listener: copy_logs_to_upload_dir 09:44:15 INFO - Copying logs to upload dir... 09:44:15 INFO - mkdir: /builds/slave/test/build/upload/logs 09:44:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.034429 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-05-05 09:44:15.965201) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 09:44:15.968812) ========= 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.CCev7hD5Iw/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.V0HXqfNQlf/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f38e9dbe94e37fc0489f6e9d57115ef8509dd2f7a15d01a6a731cff34cbb411e209f11accfee6d39deabadae93a2d26f9736a092e89282277f0e683dd3dc2921", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f35e631125fda250b3a930c5066eeb1348cafe9051e871392edee355aa38ec8540abed21ceb64f202e1ac55371b75d574787a906f7d0af70178fbea693cb9a5b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c086afa2f93defc151ddb0106083f10445aa99f1ca50f32a97568140884d5825522123fb17155b5004175ab206cc09309a2aa3dc820ba9ef1c23085fd5c32934", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc193171e6d63ae3ebcd8f320f60c21f995b894e8a3a7d2e9f9f780ef6bb73176f27a05740d6f5e3d3f5d6b66fb93f698dc1a003a953a9558e9b962f9f6840a7"} build_url:https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011866 build_url: 'https://queue.taskcluster.net/v1/task/aywT8JLbRWO5BNQd0MbERQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f38e9dbe94e37fc0489f6e9d57115ef8509dd2f7a15d01a6a731cff34cbb411e209f11accfee6d39deabadae93a2d26f9736a092e89282277f0e683dd3dc2921", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f35e631125fda250b3a930c5066eeb1348cafe9051e871392edee355aa38ec8540abed21ceb64f202e1ac55371b75d574787a906f7d0af70178fbea693cb9a5b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c086afa2f93defc151ddb0106083f10445aa99f1ca50f32a97568140884d5825522123fb17155b5004175ab206cc09309a2aa3dc820ba9ef1c23085fd5c32934", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc193171e6d63ae3ebcd8f320f60c21f995b894e8a3a7d2e9f9f780ef6bb73176f27a05740d6f5e3d3f5d6b66fb93f698dc1a003a953a9558e9b962f9f6840a7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 09:44:16.004626) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 09:44:16.004943) ========= 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.CCev7hD5Iw/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.V0HXqfNQlf/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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.005530 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 09:44:16.053345) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 09:44:16.053722) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 09:44:16.054030) ========= ========= Total master_lag: 0.18 =========