builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0102 starttime: 1492768825.44 results: success (0) buildid: 20170421014628 builduid: 3654f57986464cbfb0090181e00c5d82 revision: 7b43acb948540e6687bab6d508dcf6add5823e03 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-21 03:00:25.441169) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-21 03:00:25.441601) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-21 03:00:25.441889) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-21 03:00:25.468526) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 03:00:25.468845) ========= 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.zK7hiI3d42/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.eHuK1B7Kh4/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-21 03:00:25-- 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% 164M=0s 2017-04-21 03:00:25 (164 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.152877 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 03:00:25.646197) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 03:00:25.646509) ========= 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.zK7hiI3d42/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.eHuK1B7Kh4/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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.038622 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 03:00:25.706876) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-21 03:00:25.707219) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7b43acb948540e6687bab6d508dcf6add5823e03 --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 7b43acb948540e6687bab6d508dcf6add5823e03 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zK7hiI3d42/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.eHuK1B7Kh4/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-21 03:00:25,976 truncating revision to first 12 chars 2017-04-21 03:00:25,977 Setting DEBUG logging. 2017-04-21 03:00:25,977 attempt 1/10 2017-04-21 03:00:25,977 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7b43acb94854?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-21 03:00:27,314 unpacking tar archive at: mozilla-central-7b43acb94854/testing/mozharness/ program finished with exit code 0 elapsedTime=1.617040 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-21 03:00:27.345909) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-21 03:00:27.346215) ========= script_repo_revision: 7b43acb948540e6687bab6d508dcf6add5823e03 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-21 03:00:27.346708) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-21 03:00:27.346994) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-21 03:00:27.367422) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-21 03:00:27.367726) ========= /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.zK7hiI3d42/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.eHuK1B7Kh4/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 03:00:27 INFO - MultiFileLogger online at 20170421 03:00:27 in /builds/slave/test 03:00:27 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 03:00:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:00:27 INFO - {'append_to_log': False, 03:00:27 INFO - 'base_work_dir': '/builds/slave/test', 03:00:27 INFO - 'blob_upload_branch': 'Firefox', 03:00:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:00:27 INFO - 'branch': 'Firefox', 03:00:27 INFO - 'buildbot_json_path': 'buildprops.json', 03:00:27 INFO - 'config_files': ('talos/mac_config.py',), 03:00:27 INFO - 'default_actions': ('clobber', 03:00:27 INFO - 'read-buildbot-config', 03:00:27 INFO - 'download-and-extract', 03:00:27 INFO - 'populate-webroot', 03:00:27 INFO - 'create-virtualenv', 03:00:27 INFO - 'install', 03:00:27 INFO - 'run-tests'), 03:00:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:00:27 INFO - 'download_minidump_stackwalk': True, 03:00:27 INFO - 'download_symbols': 'ondemand', 03:00:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:00:27 INFO - 'tooltool.py': '/tools/tooltool.py', 03:00:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:00:27 INFO - '/tools/misc-python/virtualenv.py')}, 03:00:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:00:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:00:27 INFO - 'gecko_profile': False, 03:00:27 INFO - 'gecko_profile_interval': 0, 03:00:27 INFO - 'installer_path': 'installer.exe', 03:00:27 INFO - 'log_level': 'info', 03:00:27 INFO - 'log_name': 'talos', 03:00:27 INFO - 'log_to_console': True, 03:00:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:00:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:00:27 INFO - 'opt_config_files': (), 03:00:27 INFO - 'pip_index': False, 03:00:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:00:27 INFO - 'cmd': ('bash', 03:00:27 INFO - '-c', 03:00:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:00:27 INFO - 'enabled': True, 03:00:27 INFO - 'halt_on_failure': False, 03:00:27 INFO - 'name': 'check_screen_resolution'},), 03:00:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:00:27 INFO - 'cmd': ('bash', 03:00:27 INFO - '-c', 03:00:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:00:27 INFO - 'enabled': True, 03:00:27 INFO - 'halt_on_failure': False, 03:00:27 INFO - 'name': 'check_screen_resolution'},), 03:00:27 INFO - 'run_cmd_checks_enabled': True, 03:00:27 INFO - 'suite': 'dromaeojs', 03:00:27 INFO - 'system_bits': '32', 03:00:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:00:27 INFO - 'title': 't-yosemite-r7-0102', 03:00:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:00:27 INFO - 'use_talos_json': True, 03:00:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:00:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:00:27 INFO - 'work_dir': 'build'} 03:00:27 INFO - [mozharness: 2017-04-21 10:00:27.750387Z] Running clobber step. 03:00:27 INFO - Running pre-action listener: _resource_record_pre_action 03:00:27 INFO - Running main action method: clobber 03:00:27 INFO - rmtree: /builds/slave/test/build 03:00:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:00:30 INFO - Running post-action listener: _resource_record_post_action 03:00:30 INFO - [mozharness: 2017-04-21 10:00:30.231482Z] Finished clobber step (success) 03:00:30 INFO - [mozharness: 2017-04-21 10:00:30.231630Z] Running read-buildbot-config step. 03:00:30 INFO - Running pre-action listener: _resource_record_pre_action 03:00:30 INFO - Running main action method: read_buildbot_config 03:00:30 INFO - Using buildbot properties: 03:00:30 INFO - { 03:00:30 INFO - "project": "", 03:00:30 INFO - "product": "firefox", 03:00:30 INFO - "script_repo_revision": "production", 03:00:30 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 03:00:30 INFO - "repository": "", 03:00:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 03:00:30 INFO - "buildid": "20170421014628", 03:00:30 INFO - "pgo_build": "False", 03:00:30 INFO - "basedir": "/builds/slave/test", 03:00:30 INFO - "buildnumber": 19, 03:00:30 INFO - "slavename": "t-yosemite-r7-0102", 03:00:30 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 03:00:30 INFO - "platform": "yosemite_r7", 03:00:30 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:00:30 INFO - "branch": "mozilla-central", 03:00:30 INFO - "repo_path": "mozilla-central", 03:00:30 INFO - "revision": "7b43acb948540e6687bab6d508dcf6add5823e03", 03:00:30 INFO - "stage_platform": "macosx64", 03:00:30 INFO - "builduid": "3654f57986464cbfb0090181e00c5d82", 03:00:30 INFO - "slavebuilddir": "test" 03:00:30 INFO - } 03:00:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 03:00:30 INFO - Running post-action listener: _resource_record_post_action 03:00:30 INFO - [mozharness: 2017-04-21 10:00:30.234884Z] Finished read-buildbot-config step (success) 03:00:30 INFO - [mozharness: 2017-04-21 10:00:30.235031Z] Running download-and-extract step. 03:00:30 INFO - Running pre-action listener: _resource_record_pre_action 03:00:30 INFO - Running main action method: download_and_extract 03:00:30 INFO - mkdir: /builds/slave/test/build/tests 03:00: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')]} 03:00:30 INFO - trying https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 03:00:30 INFO - Downloading https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/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 03:00:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/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 03:00:31 INFO - Downloaded 1325 bytes. 03:00:31 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 03:00:31 INFO - Using the following test package requirements: 03:00:31 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:00:31 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 03:00:31 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:00:31 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:00:31 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 03:00:31 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:00:31 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 03:00:31 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:00:31 INFO - u'jsshell-mac.zip'], 03:00:31 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:00:31 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 03:00:31 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:00:31 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:00:31 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 03:00:31 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:00:31 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 03:00:31 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:00:31 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 03:00:31 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:00:31 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 03:00:31 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:00:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:00:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:00:31 INFO - Fetch https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:00:33 INFO - Content-Length response header: 52523527 03:00:33 INFO - Bytes received: 52523527 03:00:49 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 03:00:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:00:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:00:49 INFO - Fetch https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:00:50 INFO - Content-Length response header: 52523527 03:00:50 INFO - Bytes received: 52523527 03:01:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 03:01:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:01:06 INFO - Fetch https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 03:01:07 INFO - Content-Length response header: 14408811 03:01:07 INFO - Bytes received: 14408811 03:01:07 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')]} 03:01:07 INFO - trying https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:01:07 INFO - Downloading https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 03:01:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/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 03:01:09 INFO - Downloaded 71026675 bytes. 03:01:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:01:09 INFO - mkdir: /builds/slave/test/properties 03:01:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:01:09 INFO - Writing to file /builds/slave/test/properties/build_url 03:01:09 INFO - Contents: 03:01:09 INFO - build_url:https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:01:10 INFO - Running post-action listener: _resource_record_post_action 03:01:10 INFO - Running post-action listener: set_extra_try_arguments 03:01:10 INFO - [mozharness: 2017-04-21 10:01:10.568074Z] Finished download-and-extract step (success) 03:01:10 INFO - [mozharness: 2017-04-21 10:01:10.568205Z] Running populate-webroot step. 03:01:10 INFO - Running pre-action listener: _resource_record_pre_action 03:01:10 INFO - Running main action method: populate_webroot 03:01:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:01:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:01:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:01:10 INFO - '--tppagecycles', 03:01:10 INFO - '7'], 03:01:10 INFO - 'tests': ['tsvgm']}}, 03:01:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:01:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:01:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:01:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:01:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:01:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:01:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:01:10 INFO - 'talos_options': ['--disable-e10s'], 03:01:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:01:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:01:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:01:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:01:10 INFO - 'talos_options': ['--disable-e10s'], 03:01:10 INFO - 'tests': ['damp', 'tps']}, 03:01:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:01:10 INFO - 'tests': ['damp', 'tps']}, 03:01:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:01:10 INFO - 'tests': ['dromaeo_dom']}, 03:01:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:01:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:01:10 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:01:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:01:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:01:10 INFO - 'tests': ['a11yr', 03:01:10 INFO - 'ts_paint', 03:01:10 INFO - 'tpaint', 03:01:10 INFO - 'sessionrestore', 03:01:10 INFO - 'sessionrestore_no_auto_restore', 03:01:10 INFO - 'tabpaint']}, 03:01:10 INFO - 'other-e10s': {'tests': ['a11yr', 03:01:10 INFO - 'ts_paint', 03:01:10 INFO - 'tpaint', 03:01:10 INFO - 'sessionrestore', 03:01:10 INFO - 'sessionrestore_no_auto_restore', 03:01:10 INFO - 'tabpaint']}, 03:01:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:01:10 INFO - 'ts_paint', 03:01:10 INFO - 'tpaint', 03:01:10 INFO - 'sessionrestore', 03:01:10 INFO - 'sessionrestore_no_auto_restore', 03:01:10 INFO - 'tabpaint']}, 03:01:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:01:10 INFO - 'ts_paint', 03:01:10 INFO - 'tpaint', 03:01:10 INFO - 'sessionrestore', 03:01:10 INFO - 'sessionrestore_no_auto_restore', 03:01:10 INFO - 'tabpaint']}, 03:01:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:01:10 INFO - 'tests': ['a11yr', 03:01:10 INFO - 'ts_paint', 03:01:10 INFO - 'tpaint', 03:01:10 INFO - 'sessionrestore', 03:01:10 INFO - 'sessionrestore_no_auto_restore', 03:01:10 INFO - 'tabpaint']}, 03:01:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:01:10 INFO - 'tests': ['a11yr', 03:01:10 INFO - 'ts_paint', 03:01:10 INFO - 'tpaint', 03:01:10 INFO - 'sessionrestore', 03:01:10 INFO - 'sessionrestore_no_auto_restore', 03:01:10 INFO - 'tabpaint']}, 03:01:10 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:01:10 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:01:10 INFO - 'bloom_basic_ref']}, 03:01:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:01:10 INFO - 'tests': ['tsvgx', 03:01:10 INFO - 'tsvgr_opacity', 03:01:10 INFO - 'tart', 03:01:10 INFO - 'tscrollx', 03:01:10 INFO - 'cart', 03:01:10 INFO - 'tsvg_static']}, 03:01:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:01:10 INFO - 'tsvgr_opacity', 03:01:10 INFO - 'tart', 03:01:10 INFO - 'tscrollx', 03:01:10 INFO - 'cart', 03:01:10 INFO - 'tsvg_static']}, 03:01:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:01:10 INFO - 'talos_options': ['--disable-e10s'], 03:01:10 INFO - 'tests': ['tp5o']}, 03:01:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:01:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:01:10 INFO - 'talos_options': ['--disable-e10s', 03:01:10 INFO - '--xperf_path', 03:01:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:01:10 INFO - 'tests': ['tp5n']}, 03:01:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:01:10 INFO - 'talos_options': ['--xperf_path', 03:01:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:01:10 INFO - 'tests': ['tp5n']}}, 03:01:10 INFO - 'talos.zip': {'path': '', 03:01:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:01:10 INFO - Running post-action listener: _resource_record_post_action 03:01:10 INFO - [mozharness: 2017-04-21 10:01:10.586870Z] Finished populate-webroot step (success) 03:01:10 INFO - [mozharness: 2017-04-21 10:01:10.587005Z] Running create-virtualenv step. 03:01:10 INFO - Running pre-action listener: _resource_record_pre_action 03:01:10 INFO - Running main action method: create_virtualenv 03:01:10 INFO - Creating virtualenv /builds/slave/test/build/venv 03:01:10 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 03:01:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:01:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:01:10 INFO - Using real prefix '/tools/python27' 03:01:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:01:11 INFO - Installing distribute.............................................................................................................................................................................................done. 03:01:14 INFO - Installing pip.................done. 03:01:14 INFO - Return code: 0 03:01:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:01:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:01:14 INFO - Reading from file tmpfile_stdout 03:01:14 INFO - Output received: 03:01:14 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) 03:01:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:01:14 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')]} 03:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:14 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')]} 03:01:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:14 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 0x102746b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102749768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc412cb7980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102524d30>, '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 0x10244adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102519be8>, '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.zK7hiI3d42/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.eHuK1B7Kh4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 03:01:14 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 03:01:14 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 03:01:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zK7hiI3d42/Render', 03:01:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:14 INFO - 'HOME': '/Users/cltbld', 03:01:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:14 INFO - 'LOGNAME': 'cltbld', 03:01:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:14 INFO - 'MOZ_NO_REMOTE': '1', 03:01:14 INFO - 'NO_EM_RESTART': '1', 03:01:14 INFO - 'PAGER': '/bin/cat', 03:01:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:14 INFO - 'PWD': '/builds/slave/test', 03:01:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:14 INFO - 'SHELL': '/bin/bash', 03:01:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eHuK1B7Kh4/Listeners', 03:01:14 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 03:01:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:14 INFO - 'USER': 'cltbld', 03:01:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:14 INFO - 'XPC_FLAGS': '0x0', 03:01:14 INFO - 'XPC_SERVICE_NAME': '0', 03:01:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:14 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 03:01:14 INFO - Cleaning up... 03:01:14 INFO - Return code: 0 03:01:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:01:14 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')]} 03:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:14 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')]} 03:01:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:14 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 0x102746b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102749768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc412cb7980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102524d30>, '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 0x10244adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102519be8>, '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.zK7hiI3d42/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.eHuK1B7Kh4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 03:01:14 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 03:01:14 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 03:01:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zK7hiI3d42/Render', 03:01:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:14 INFO - 'HOME': '/Users/cltbld', 03:01:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:14 INFO - 'LOGNAME': 'cltbld', 03:01:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:14 INFO - 'MOZ_NO_REMOTE': '1', 03:01:14 INFO - 'NO_EM_RESTART': '1', 03:01:14 INFO - 'PAGER': '/bin/cat', 03:01:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:14 INFO - 'PWD': '/builds/slave/test', 03:01:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:14 INFO - 'SHELL': '/bin/bash', 03:01:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eHuK1B7Kh4/Listeners', 03:01:14 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 03:01:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:14 INFO - 'USER': 'cltbld', 03:01:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:14 INFO - 'XPC_FLAGS': '0x0', 03:01:14 INFO - 'XPC_SERVICE_NAME': '0', 03:01:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:15 INFO - Downloading/unpacking psutil>=3.1.1 03:01:15 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 03:01:15 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 03:01:15 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 03:01:15 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 03:01:15 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 03:01:15 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 03:01:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:01:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:01:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:01:18 INFO - Installing collected packages: psutil 03:01:18 INFO - Running setup.py install for psutil 03:01:18 INFO - building 'psutil._psutil_osx' extension 03:01:18 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 03:01:19 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 03:01:19 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 03:01:19 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 03:01:19 INFO - building 'psutil._psutil_posix' extension 03:01:19 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 03:01:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:01:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:01:19 INFO - ^ 03:01:19 INFO - 1 warning generated. 03:01:19 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 03:01:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:01:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:01:19 INFO - Successfully installed psutil 03:01:19 INFO - Cleaning up... 03:01:19 INFO - Return code: 0 03:01:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:01:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:19 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 0x102746b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102749768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc412cb7980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102524d30>, '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 0x10244adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102519be8>, '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.zK7hiI3d42/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.eHuK1B7Kh4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 03:01:19 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 03:01:19 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 03:01:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zK7hiI3d42/Render', 03:01:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:19 INFO - 'HOME': '/Users/cltbld', 03:01:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:19 INFO - 'LOGNAME': 'cltbld', 03:01:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:19 INFO - 'MOZ_NO_REMOTE': '1', 03:01:19 INFO - 'NO_EM_RESTART': '1', 03:01:19 INFO - 'PAGER': '/bin/cat', 03:01:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:19 INFO - 'PWD': '/builds/slave/test', 03:01:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:19 INFO - 'SHELL': '/bin/bash', 03:01:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eHuK1B7Kh4/Listeners', 03:01:19 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 03:01:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:19 INFO - 'USER': 'cltbld', 03:01:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:19 INFO - 'XPC_FLAGS': '0x0', 03:01:19 INFO - 'XPC_SERVICE_NAME': '0', 03:01:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:01:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:01:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:01:22 INFO - Installing collected packages: mozsystemmonitor 03:01:22 INFO - Running setup.py install for mozsystemmonitor 03:01:22 INFO - Successfully installed mozsystemmonitor 03:01:22 INFO - Cleaning up... 03:01:23 INFO - Return code: 0 03:01:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:01:23 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')]} 03:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:23 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')]} 03:01:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:23 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 0x102746b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102749768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc412cb7980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102524d30>, '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 0x10244adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102519be8>, '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.zK7hiI3d42/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.eHuK1B7Kh4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 03:01:23 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 03:01:23 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 03:01:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zK7hiI3d42/Render', 03:01:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:23 INFO - 'HOME': '/Users/cltbld', 03:01:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:23 INFO - 'LOGNAME': 'cltbld', 03:01:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:23 INFO - 'MOZ_NO_REMOTE': '1', 03:01:23 INFO - 'NO_EM_RESTART': '1', 03:01:23 INFO - 'PAGER': '/bin/cat', 03:01:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:23 INFO - 'PWD': '/builds/slave/test', 03:01:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:23 INFO - 'SHELL': '/bin/bash', 03:01:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eHuK1B7Kh4/Listeners', 03:01:23 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 03:01:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:23 INFO - 'USER': 'cltbld', 03:01:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:23 INFO - 'XPC_FLAGS': '0x0', 03:01:23 INFO - 'XPC_SERVICE_NAME': '0', 03:01:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:24 INFO - Downloading/unpacking jsonschema==2.5.1 03:01:24 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 03:01:24 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 03:01:24 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 03:01:24 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 03:01:24 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 03:01:24 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 03:01:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:01:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:01:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:27 INFO - Downloading functools32-3.2.3-2.tar.gz 03:01:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:01:27 INFO - warning: no files found matching '*.txt' 03:01:27 INFO - no previously-included directories found matching 'build' 03:01:27 INFO - no previously-included directories found matching 'dist' 03:01:27 INFO - no previously-included directories found matching '.git*' 03:01:27 INFO - Installing collected packages: jsonschema, functools32 03:01:27 INFO - Running setup.py install for functools32 03:01:27 INFO - warning: no files found matching '*.txt' 03:01:27 INFO - no previously-included directories found matching 'build' 03:01:27 INFO - no previously-included directories found matching 'dist' 03:01:27 INFO - no previously-included directories found matching '.git*' 03:01:27 INFO - Successfully installed jsonschema functools32 03:01:27 INFO - Cleaning up... 03:01:27 INFO - Return code: 0 03:01:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:01:27 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')]} 03:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:27 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')]} 03:01:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:27 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 0x102746b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102749768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc412cb7980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102524d30>, '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 0x10244adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102519be8>, '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.zK7hiI3d42/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.eHuK1B7Kh4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 03:01:27 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 03:01:27 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 03:01:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zK7hiI3d42/Render', 03:01:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:27 INFO - 'HOME': '/Users/cltbld', 03:01:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:27 INFO - 'LOGNAME': 'cltbld', 03:01:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:27 INFO - 'MOZ_NO_REMOTE': '1', 03:01:27 INFO - 'NO_EM_RESTART': '1', 03:01:27 INFO - 'PAGER': '/bin/cat', 03:01:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:27 INFO - 'PWD': '/builds/slave/test', 03:01:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:27 INFO - 'SHELL': '/bin/bash', 03:01:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eHuK1B7Kh4/Listeners', 03:01:27 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 03:01:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:27 INFO - 'USER': 'cltbld', 03:01:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:27 INFO - 'XPC_FLAGS': '0x0', 03:01:27 INFO - 'XPC_SERVICE_NAME': '0', 03:01:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:01:28 INFO - Cleaning up... 03:01:28 INFO - Return code: 0 03:01:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:01:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102746b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102749768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc412cb7980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102524d30>, '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 0x10244adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102519be8>, '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.zK7hiI3d42/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.eHuK1B7Kh4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 03:01:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:01:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:01:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zK7hiI3d42/Render', 03:01:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:28 INFO - 'HOME': '/Users/cltbld', 03:01:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:28 INFO - 'LOGNAME': 'cltbld', 03:01:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:28 INFO - 'MOZ_NO_REMOTE': '1', 03:01:28 INFO - 'NO_EM_RESTART': '1', 03:01:28 INFO - 'PAGER': '/bin/cat', 03:01:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:28 INFO - 'PWD': '/builds/slave/test', 03:01:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:28 INFO - 'SHELL': '/bin/bash', 03:01:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eHuK1B7Kh4/Listeners', 03:01:28 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 03:01:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:28 INFO - 'USER': 'cltbld', 03:01:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:28 INFO - 'XPC_FLAGS': '0x0', 03:01:28 INFO - 'XPC_SERVICE_NAME': '0', 03:01:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:28 INFO - Downloading/unpacking blobuploader==1.2.4 03:01:28 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 03:01:28 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 03:01:28 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 03:01:28 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 03:01:28 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 03:01:28 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 03:01:30 INFO - Downloading blobuploader-1.2.4.tar.gz 03:01:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:01:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:01:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:32 INFO - Downloading docopt-0.6.1.tar.gz 03:01:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:01:32 INFO - Installing collected packages: blobuploader, requests, docopt 03:01:32 INFO - Running setup.py install for blobuploader 03:01:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:01:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:01:32 INFO - Running setup.py install for requests 03:01:32 INFO - Running setup.py install for docopt 03:01:33 INFO - Successfully installed blobuploader requests docopt 03:01:33 INFO - Cleaning up... 03:01:33 INFO - Return code: 0 03:01:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:01:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:33 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 0x102746b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102749768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc412cb7980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102524d30>, '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 0x10244adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102519be8>, '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.zK7hiI3d42/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.eHuK1B7Kh4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 03:01:33 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 03:01:33 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 03:01:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zK7hiI3d42/Render', 03:01:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:33 INFO - 'HOME': '/Users/cltbld', 03:01:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:33 INFO - 'LOGNAME': 'cltbld', 03:01:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:33 INFO - 'MOZ_NO_REMOTE': '1', 03:01:33 INFO - 'NO_EM_RESTART': '1', 03:01:33 INFO - 'PAGER': '/bin/cat', 03:01:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:33 INFO - 'PWD': '/builds/slave/test', 03:01:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:33 INFO - 'SHELL': '/bin/bash', 03:01:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eHuK1B7Kh4/Listeners', 03:01:33 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 03:01:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:33 INFO - 'USER': 'cltbld', 03:01:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:33 INFO - 'XPC_FLAGS': '0x0', 03:01:33 INFO - 'XPC_SERVICE_NAME': '0', 03:01:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:01:33 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-H0hz_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:01:33 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-nThs4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:01:33 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-KzldyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:01:33 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Hl1rFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:01:33 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-AMG20P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:01:33 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-zZ_RIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:01:34 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-dO2_zB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:01:34 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-M5HxS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:01:34 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-VmJ098-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:01:34 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-4bk0aW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:01:34 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-PQVy0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:01:34 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-pcX34g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:01:34 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-uECX44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:01:34 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-KITK75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:01:34 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-gEgeY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:01:35 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-EhiikT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:01:35 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-g5pN9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:01:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:01:35 INFO - Running setup.py install for manifestparser 03:01:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:01:35 INFO - Running setup.py install for mozcrash 03:01:35 INFO - Running setup.py install for mozdebug 03:01:35 INFO - Running setup.py install for mozdevice 03:01:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:01:35 INFO - Running setup.py install for mozfile 03:01:35 INFO - Running setup.py install for mozhttpd 03:01:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:01:36 INFO - Running setup.py install for mozinfo 03:01:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:01:36 INFO - Running setup.py install for mozInstall 03:01:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:01:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:01:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:01:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:01:36 INFO - Running setup.py install for mozleak 03:01:36 INFO - Running setup.py install for mozlog 03:01:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:01:36 INFO - Running setup.py install for moznetwork 03:01:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:01:36 INFO - Running setup.py install for mozprocess 03:01:37 INFO - Running setup.py install for mozprofile 03:01:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:01:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:01:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:01:37 INFO - Running setup.py install for mozrunner 03:01:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:01:37 INFO - Running setup.py install for mozscreenshot 03:01:37 INFO - Running setup.py install for moztest 03:01:37 INFO - Running setup.py install for mozversion 03:01:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:01:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:01:37 INFO - Cleaning up... 03:01:37 INFO - Return code: 0 03:01:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:01:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:37 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 0x102746b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102749768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc412cb7980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102524d30>, '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 0x10244adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102519be8>, '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.zK7hiI3d42/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.eHuK1B7Kh4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 03:01:37 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 03:01:37 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 03:01:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zK7hiI3d42/Render', 03:01:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:37 INFO - 'HOME': '/Users/cltbld', 03:01:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:37 INFO - 'LOGNAME': 'cltbld', 03:01:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:37 INFO - 'MOZ_NO_REMOTE': '1', 03:01:37 INFO - 'NO_EM_RESTART': '1', 03:01:37 INFO - 'PAGER': '/bin/cat', 03:01:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:37 INFO - 'PWD': '/builds/slave/test', 03:01:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:37 INFO - 'SHELL': '/bin/bash', 03:01:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eHuK1B7Kh4/Listeners', 03:01:37 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 03:01:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:37 INFO - 'USER': 'cltbld', 03:01:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:37 INFO - 'XPC_FLAGS': '0x0', 03:01:37 INFO - 'XPC_SERVICE_NAME': '0', 03:01:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:01:38 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-fu27xc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:01:38 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)) 03:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:01:38 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-nyIbrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:01:38 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)) 03:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:01:38 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-baTJtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:01:38 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)) 03:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:01:38 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-WV56UY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:01:38 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)) 03:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:01:38 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-AXXXlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:01:38 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)) 03:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:01:38 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-J0a8yh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:01:38 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)) 03:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:01:38 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-FfV1m5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:01:38 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)) 03:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:01:38 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-W_fPw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:01:38 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)) 03:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:01:38 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-UZnB2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:01:39 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)) 03:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:01:39 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-lZgCM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:01:39 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)) 03:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:01:39 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-6ye7hB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:01:39 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)) 03:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:01:39 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-t5rlrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:01:39 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)) 03:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:01:39 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-odusO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:01:39 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)) 03:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:01:39 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-zERulm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:01:39 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)) 03:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:01:39 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-N1MnIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:01:39 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)) 03:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:01:39 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-AuftsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:01:39 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)) 03:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:01:39 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-ez1PZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:01:39 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)) 03:01:39 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)) 03:01:39 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)) 03:01:39 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)) 03:01:39 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)) 03:01:39 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)) 03:01:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:01:39 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 03:01:39 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 03:01:39 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 03:01:39 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 03:01:39 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 03:01:39 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 03:01:42 INFO - Downloading blessings-1.6.tar.gz 03:01:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:01:42 INFO - Installing collected packages: blessings 03:01:42 INFO - Running setup.py install for blessings 03:01:42 INFO - Successfully installed blessings 03:01:42 INFO - Cleaning up... 03:01:42 INFO - Return code: 0 03:01:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:01:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:01:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:01:43 INFO - Reading from file tmpfile_stdout 03:01:43 INFO - Current package versions: 03:01:43 INFO - blessings == 1.6 03:01:43 INFO - blobuploader == 1.2.4 03:01:43 INFO - docopt == 0.6.1 03:01:43 INFO - functools32 == 3.2.3-2 03:01:43 INFO - jsonschema == 2.5.1 03:01:43 INFO - manifestparser == 1.1 03:01:43 INFO - mozInstall == 1.12 03:01:43 INFO - mozcrash == 1.0 03:01:43 INFO - mozdebug == 0.1 03:01:43 INFO - mozdevice == 0.50 03:01:43 INFO - mozfile == 1.2 03:01:43 INFO - mozhttpd == 0.7 03:01:43 INFO - mozinfo == 0.9 03:01:43 INFO - mozleak == 0.1 03:01:43 INFO - mozlog == 3.4 03:01:43 INFO - moznetwork == 0.27 03:01:43 INFO - mozprocess == 0.25 03:01:43 INFO - mozprofile == 0.28 03:01:43 INFO - mozrunner == 6.13 03:01:43 INFO - mozscreenshot == 0.1 03:01:43 INFO - mozsystemmonitor == 0.3 03:01:43 INFO - moztest == 0.8 03:01:43 INFO - mozversion == 1.4 03:01:43 INFO - psutil == 3.1.1 03:01:43 INFO - requests == 1.2.3 03:01:43 INFO - wsgiref == 0.1.2 03:01:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:43 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 0x102746b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102749768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc412cb7980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102524d30>, '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 0x10244adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102519be8>, '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.zK7hiI3d42/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.eHuK1B7Kh4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 03:01:43 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 03:01:43 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 03:01:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zK7hiI3d42/Render', 03:01:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:43 INFO - 'HOME': '/Users/cltbld', 03:01:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:43 INFO - 'LOGNAME': 'cltbld', 03:01:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:43 INFO - 'MOZ_NO_REMOTE': '1', 03:01:43 INFO - 'NO_EM_RESTART': '1', 03:01:43 INFO - 'PAGER': '/bin/cat', 03:01:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:43 INFO - 'PWD': '/builds/slave/test', 03:01:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:43 INFO - 'SHELL': '/bin/bash', 03:01:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eHuK1B7Kh4/Listeners', 03:01:43 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 03:01:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:43 INFO - 'USER': 'cltbld', 03:01:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:43 INFO - 'XPC_FLAGS': '0x0', 03:01:43 INFO - 'XPC_SERVICE_NAME': '0', 03:01:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:43 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)) 03:01:43 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)) 03:01:43 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)) 03:01:43 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)) 03:01:43 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)) 03:01:43 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)) 03:01:43 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)) 03:01:43 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)) 03:01:43 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)) 03:01:43 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)) 03:01:43 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)) 03:01:43 INFO - Cleaning up... 03:01:43 INFO - Return code: 0 03:01:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102746b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102749768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc412cb7980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102524d30>, '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 0x10244adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102519be8>, '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.zK7hiI3d42/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.eHuK1B7Kh4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 03:01:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:01:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:01:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zK7hiI3d42/Render', 03:01:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:43 INFO - 'HOME': '/Users/cltbld', 03:01:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:43 INFO - 'LOGNAME': 'cltbld', 03:01:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:43 INFO - 'MOZ_NO_REMOTE': '1', 03:01:43 INFO - 'NO_EM_RESTART': '1', 03:01:43 INFO - 'PAGER': '/bin/cat', 03:01:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:43 INFO - 'PWD': '/builds/slave/test', 03:01:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:43 INFO - 'SHELL': '/bin/bash', 03:01:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eHuK1B7Kh4/Listeners', 03:01:43 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 03:01:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:43 INFO - 'USER': 'cltbld', 03:01:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:43 INFO - 'XPC_FLAGS': '0x0', 03:01:43 INFO - 'XPC_SERVICE_NAME': '0', 03:01:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:01:43 INFO - Cleaning up... 03:01:43 INFO - Return code: 0 03:01:43 INFO - Running post-action listener: _resource_record_post_action 03:01:43 INFO - Running post-action listener: _start_resource_monitoring 03:01:43 INFO - Starting resource monitoring. 03:01:43 INFO - [mozharness: 2017-04-21 10:01:43.753727Z] Finished create-virtualenv step (success) 03:01:43 INFO - [mozharness: 2017-04-21 10:01:43.754716Z] Running install step. 03:01:43 INFO - Running pre-action listener: _resource_record_pre_action 03:01:43 INFO - Running main action method: install 03:01:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:01:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:01:44 INFO - Reading from file tmpfile_stdout 03:01:44 INFO - Detecting whether we're running mozinstall >=1.0... 03:01:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:01:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:01:44 INFO - Reading from file tmpfile_stdout 03:01:44 INFO - Output received: 03:01:44 INFO - Usage: mozinstall [options] installer 03:01:44 INFO - Options: 03:01:44 INFO - -h, --help show this help message and exit 03:01:44 INFO - -d DEST, --destination=DEST 03:01:44 INFO - Directory to install application into. [default: 03:01:44 INFO - "/builds/slave/test"] 03:01:44 INFO - --app=APP Application being installed. [default: firefox] 03:01:44 INFO - mkdir: /builds/slave/test/build/application 03:01:44 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'] 03:01:44 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 03:02:03 INFO - Reading from file tmpfile_stdout 03:02:03 INFO - Output received: 03:02:03 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:02:03 INFO - Running post-action listener: _resource_record_post_action 03:02:03 INFO - [mozharness: 2017-04-21 10:02:03.781005Z] Finished install step (success) 03:02:03 INFO - [mozharness: 2017-04-21 10:02:03.781144Z] Running run-tests step. 03:02:03 INFO - Running pre-action listener: _resource_record_pre_action 03:02:03 INFO - Running main action method: run_tests 03:02:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:02:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:02:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:02:03 INFO - 2017-04-21 03:02:03.795 screenresolution[1629:7393] starting screenresolution argv=screenresolution get 03:02:03 INFO - 2017-04-21 03:02:03.798 screenresolution[1629:7393] Display 0: 1600x1200x32@60 03:02:03 INFO - 2017-04-21 03:02:03.804 screenresolution[1630:7396] starting screenresolution argv=screenresolution list 03:02:03 INFO - Available Modes on Display 0 03:02:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:02:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:02:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:02:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:02:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:02:04 INFO - Intel Iris: 03:02:04 INFO - Chipset Model: Intel Iris 03:02:04 INFO - Type: GPU 03:02:04 INFO - Bus: Built-In 03:02:04 INFO - VRAM (Dynamic, Max): 1536 MB 03:02:04 INFO - Vendor: Intel (0x8086) 03:02:04 INFO - Device ID: 0x0a2e 03:02:04 INFO - Revision ID: 0x0009 03:02:04 INFO - Displays: 03:02:04 INFO - Display: 03:02:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:02:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:02:04 INFO - Display Serial Number: 1600x1200 60 03:02:04 INFO - Main Display: Yes 03:02:04 INFO - Mirror: Off 03:02:04 INFO - Online: Yes 03:02:04 INFO - Rotation: Supported 03:02:04 INFO - Return code: 0 03:02:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:02:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:02:04 INFO - Python 2.7.3 03:02:04 INFO - Return code: 0 03:02:04 INFO - grabbing minidump binary from tooltool 03:02:04 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')]} 03:02:04 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 0x102524d30>, '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 0x10244adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102519be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:02:04 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 03:02:04 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 03:02:04 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 03:02:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:02:04 INFO - Return code: 0 03:02:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:02:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:02:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:02:04 INFO - ENV: RUST_BACKTRACE is now 1 03:02:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:02:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:02:04 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/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0102', '--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 03:02:04 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/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0102 --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 03:02:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zK7hiI3d42/Render', 03:02:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:02:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:02:04 INFO - 'HOME': '/Users/cltbld', 03:02:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:02:04 INFO - 'LOGNAME': 'cltbld', 03:02:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:02:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:02:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:04 INFO - 'MOZ_NO_REMOTE': '1', 03:02:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:02:04 INFO - 'NO_EM_RESTART': '1', 03:02:04 INFO - 'PAGER': '/bin/cat', 03:02:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:02:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:04 INFO - 'PWD': '/builds/slave/test', 03:02:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:02:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:02:04 INFO - 'RUST_BACKTRACE': '1', 03:02:04 INFO - 'SHELL': '/bin/bash', 03:02:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eHuK1B7Kh4/Listeners', 03:02:04 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 03:02:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:02:04 INFO - 'USER': 'cltbld', 03:02:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:02:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:02:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:04 INFO - 'XPC_FLAGS': '0x0', 03:02:04 INFO - 'XPC_SERVICE_NAME': '0', 03:02:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:02:04 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/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0102', '--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 03:02:04 INFO - mozversion application_buildid: 20170421014628 03:02:04 INFO - mozversion application_changeset: 7b43acb948540e6687bab6d508dcf6add5823e03 03:02:04 INFO - mozversion application_display_name: Nightly 03:02:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:02:04 INFO - mozversion application_name: Firefox 03:02:04 INFO - mozversion application_remotingname: firefox 03:02:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:02:04 INFO - mozversion application_vendor: Mozilla 03:02:04 INFO - mozversion application_version: 55.0a1 03:02:04 INFO - mozversion platform_buildid: 20170421014628 03:02:04 INFO - mozversion platform_changeset: 7b43acb948540e6687bab6d508dcf6add5823e03 03:02:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:02:04 INFO - mozversion platform_version: 55.0a1 03:02:04 INFO - using testdate: 1492768924 03:02:04 INFO - actual date: 1492768924 03:02:04 INFO - starting webserver on 'localhost:49245' 03:02:04 INFO - SUITE-START | Running 2 tests 03:02:04 INFO - TEST-START | dromaeo_css 03:02:04 INFO - operating with platform_type : mac_ 03:02:04 INFO - Initialising browser for dromaeo_css test... 03:02:04 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmp3WZLFH/profile http://localhost:49245/getInfo.html) 03:02:06 INFO - PID 1640 | __metrics Screen width/height:1600/1200 03:02:06 INFO - PID 1640 | colorDepth:24 03:02:06 INFO - PID 1640 | Browser inner width/height: 1024/689 03:02:06 INFO - PID 1640 | __metrics 03:02:07 INFO - PID 1640 | 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" 03:02:07 INFO - PID 1640 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:02:08 INFO - TEST-INFO | 1640: exit 0 03:02:08 INFO - Browser initialized. 03:02:08 INFO - Running cycle 1/1 for dromaeo_css test... 03:02:08 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmp3WZLFH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:02:20 INFO - PID 1642 | RSS: Main: 241192960 03:02:20 INFO - PID 1642 | 03:05:25 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49245/tests/dromaeo/cssquery-ext.html) 03:05:27 INFO - PID 1642 | RSS: Main: 434454528 03:05:27 INFO - PID 1642 | 03:07:09 INFO - PID 1642 | ************************* 03:07:09 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 03:07:09 INFO - PID 1642 | 03:07:09 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:07:09 INFO - PID 1642 | Full stack: 03:07:09 INFO - PID 1642 | ************************* 03:07:09 INFO - PID 1642 | ************************* 03:07:09 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 03:07:09 INFO - PID 1642 | 03:07:09 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:07:09 INFO - PID 1642 | Full stack: 03:07:09 INFO - PID 1642 | ************************* 03:07:09 INFO - PID 1642 | ************************* 03:07:09 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 03:07:09 INFO - PID 1642 | 03:07:09 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:07:09 INFO - PID 1642 | Full stack: 03:07:09 INFO - PID 1642 | ************************* 03:07:09 INFO - PID 1642 | ************************* 03:07:09 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 03:07:09 INFO - PID 1642 | 03:07:09 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:07:09 INFO - PID 1642 | Full stack: 03:07:09 INFO - PID 1642 | ************************* 03:08:29 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-ext.html (next: http://localhost:49245/tests/dromaeo/cssquery-jquery.html) 03:08:30 INFO - PID 1642 | RSS: Main: 369762304 03:08:30 INFO - PID 1642 | 03:11:32 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49245/tests/dromaeo/cssquery-mootools.html) 03:11:33 INFO - PID 1642 | RSS: Main: 333750272 03:11:33 INFO - PID 1642 | 03:14:35 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49245/tests/dromaeo/cssquery-prototype.html) 03:14:36 INFO - PID 1642 | RSS: Main: 363642880 03:14:36 INFO - PID 1642 | 03:17:39 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49245/tests/dromaeo/cssquery-yui.html) 03:17:40 INFO - PID 1642 | RSS: Main: 327933952 03:17:40 INFO - PID 1642 | 03:20:42 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-yui.html (next: http://localhost:49245/tests/dromaeo/cssquery-dojo.html) 03:20:42 INFO - PID 1642 | RSS: Main: 377737216 03:20:42 INFO - PID 1642 | 03:20:42 INFO - PID 1642 | __start_tp_report 03:20:42 INFO - PID 1642 | _x_x_mozilla_page_load 03:20:42 INFO - PID 1642 | _x_x_mozilla_page_load_details 03:20:42 INFO - PID 1642 | |i|pagename|runs| 03:20:42 INFO - PID 1642 | |0;dojo.html;3447.775894566853;3461.2039230976857;3496.0036389628963;3502.352064867998;3519.683228509435;5917.112433135032;6045.848853778658;6074.605150665204;6079.817605471837;6102.206713127298;5146.0222557714105;5967.970160149193;6011.308699499559;6024.2168518092585;6060.363661815512;5182.792688292464;5209.453007434222;5216.374035115772;5259.710715910624;5265.4997775211295;5323.467653234684;5326.866828329284;5338.91991620126;5340.225667278242;5435.320584926884;4334.479862416499;5313.707746073965;5314.654547454423;5315.229291752694;5326;5307.708076055816;5314.335708036496;5321.201819727034;5322.92015619766;5328.6269961102735;5131.153359695646;5263.710495922723;5269.262303277545;5282;5304.973475132639;6127.724252408608;6192.845178870519;6202.875942481171;6205.844853878644;6211.68941552925;5436.836894893159;6455.5158363122955;6483.610983340967;6500.544961852672;6503.8699226015215;5394.460553944614;6451.322611125858;6451.870962580722;6512.185976752906;6590.868182636368;6217.56477046607;6220.253569571681;6220.564560480723;6224.875502490016;6229.1590635264565;6754.257031726506;6758.594484330857;6769.864602708017;6779.118714567075;6782.830429239309;6227.159333490012;6299.905501417483;6304.936950630527;6433.131527243856;6443.29123796382;6459.61242325462;6460.353964603502;6542.084108224853;6546.541742078104;6547.508936829757;6377.64922929234;6425.036244563259;6433.067205255305;6441;6442.516811239176;6249.531285153632;6346.4605508532295;6404.327545607737;6452.35476452351;6453.096566480696;5006.74966251686;5114.820981265712;5189.299444574934;5246.97376513115;5248.7900483980975;4029.274730548471;4572.291294849304;4584.289435137493;4656.998745269783;4657.67396282257;6181.8454538636;6202.782902598387;6203.410675985864;6206.596571222856;6222.408871157233;6514.511411644051;6582.572132811352;6601.00984852276;6602.1747281589805;6622.205335359788;6058.575899687068;6102.004547214544;6103.36797469674;6168.629882207082;6211.440970312694;5727.2268243787385;5746.080627099644;5746.683932383676;5768.826935191951;5786.132080188006;6728.495362847806;6749.595024298558;6770.356816102462;6783.3555812197765;6800.149981252343;6317.368263173829;6397.680115994275;6535.117759102651;6549.083128361938;6604.8348791280605;6664.400203981665;6727.360900714424;6738.46092312604;6747.325267473213;6756.763513277012;6442.549021568445;6449;6453.741850326122;6457.031445283245;6466.32103629131;6317.5893566918;6320.304766475776;6540.50946179029;6545.181852268466;6560.9343906560325;6285.748570057147;6295.181626388723;6341.936580634135;6381.553291269566;6392.616443013248;6361.268454127649;6361.777337793155;6362.904556431565;6365.936340636719;6383.202099737533;6216.658083805434;6221.720022598904;6271.153394291712;6271.310155882758;6288.371162883675;5561.915426491795;6149.292831324455;6255.40573645503;6266.905996409966;6390.712417941297;6173.32093469709;6199.659018754011;6200.906986395117;6210.844728881633;6245.812625621239 03:20:42 INFO - PID 1642 | |1;ext.html;730.9269073092692;786.7561056072618;796.3072127249294;1131.123379380979;1132.9376884271367;27336.86331568342;27620.895164193433;27636.75634596443;36621;37255.254894902086;39531.80234098825;39798.80100599493;39900.80049599755;39934;39958;8437.987441507012;8597.011343695462;8601.913980860174;8611.224989750921;8618.439801412887;6071.848203794896;6178.258608966908;8378.664853405857;8520.062793092755;8568.143185681445;8592.269657079156;8656.61045252962;8659.913400865973;8667.869981950276;8689.739307820775;8576.614052367628;8618.870716939251;8619.051904290493;8629.568521573896;8631.482111073356;8424.368172387034;8473.957630211871;8477.448965817202;8482.194191551793;8482.575871206414;32832.6716732832;36558.63441365606;37351.066223344365;37590.06024849373;37729.81135094307;3546.414841551141;3583.996480985328;3584.6773790358734;3586.8923932282073;3591.2099338145567;30604.38791224163;30710.692893071006;30722.23194420135;30737.846310768527;30745;3162.3517178978254;3208;3214.341060082701;3223.903282901517;3235.773495855291;291692;299580;299711;300305;305883;44811.77594112074;44863.55136448659;45028;45131;45183;46737.76631116823;46787;46802.53197467982;46847.531524685;46867.76566117216;14054.508092216724;14147.43410263578;14169.858301416854;14170.929145354206;14182.574522764333;9856.901430985741;11369.658910232707;11431.828522572168;11459.197856150156;11476.368799716096;10658.89341106579;10728.517216725266;10787.56849726018;12366.319852408204;12415.944644705301;5157.885267040496;5214.374275086938;5219.347581552306;5221.190715439113;5236.29310043147;941.2517048946104;1002.6113832342259;1013.3869009249298;1024.99487502562;1059.5179193466954;21608.675869861963;23241;24269.878650606635;24363.634545481833;24382.75617243805;1086.9293495922739;1095.2333366643381;1112.67732357617;1117.8155604325357;1159.913006524514;10427.791444171075;12590.118691691494;12596.496140154291;12613.432395542222;12644.936775316248;305304;305871;308501;310098;310711;52146.73926630418;52267.477325227024;52283.47716522862;52351.47648523542;52615;1402.2918426194706;1435.1790540374702;1481.1187343530582;1483.0730793254215;1527.7631967045127;23383;23427;23437;23440.945157468297;23445.648315275626;36967.70613028531;36985.26029479449;37003.62996370002;37005.444918326786;37121.6287837129;275139;275327;278331;278716;278734;33202;33276.83361583274;33293.83353083219;33431.1642208937;34740.826295868355;44569.331460027475;44701.88245293894;44833.55166448294;44896;45123.548764511936;28409.715902840708;28729.138125856258;29523.261918452212;30221.395572088873;30439.54340684936;30055.098347049625;30680.079597612108;31097.37805243928;31137.065888023397;31375;36979.07552311214;37057.81471092627;37107.443388348656;37181.62818371782;37205;24745;27968.44063118767;28479.00323488668;29278.853605731834;29962;23911.28266152018;24008.39979000539;24252.393690157885;24284.27147185587;24366.147184848443 03:20:42 INFO - PID 1642 | |2;jquery.html;400.60140160540266;415.99376009359867;425.29825787450704;440.7047278323524;445.9643228541717;15562.610934726637;18829.340973065944;20621.38135855923;21987.450313742163;22184;21949.67075493869;22176.445588860246;22828.31515054547;23057.654135187942;23302.88348558259;4226.492820861501;5998.40015998401;6157.1995640566665;6244.594101383418;6251.374862513735;6085;6184.752609895599;6186.876262474748;6189.90715139271;6203.875922481548;6017.037274036155;6082.300535438437;6132.41742034506;6161.199044124258;6169.629822210659;6011.519078473755;6078.422549857756;6121.357257487989;6125.866714657803;6134.815955521319;5407.972960135174;5433.320834895638;5467.835964921059;5469.917951230735;5470.316210473691;27268.454630907272;27279.590806137923;27320.316992075157;27369.589456158174;27473;2243.6410174372186;2275.5562665280277;2281.2471884278148;2287.3824067501846;2295.747467778543;17556;17771.644567108713;18191.727124093148;18252.817471825245;18372.26510939561;1942.5046613113707;2143.110609097223;2211.8119959803435;2214.1475531920164;2216.26863135165;144898.27550862284;146285.26857365645;146884.2655786725;147472.26263868719;149700.2514987429;11613.419329033515;12089.214201076902;12607.495700172074;12629.684257893443;12731.61805145847;15378.384864605514;15400.46098386551;16594.83405165957;16896.239669214916;16979.23593438298;8837.55812209387;8874.156955089256;9005.279577633773;9100.22648074921;9159.633614655339;8484.10345887316;8485.32117430604;8519.275861551838;8706.738797836075;8720.694775682821;6632.469402447792;7730.188330225358;7853.450258481851;7892.28969392746;7910.2089791020435;2160.5894879972757;2160.719106516174;2161.216995978324;2163.1671806354666;2289.027163455558;927.3879239701764;953.4565297780338;967.5887747707196;1003.3428104591504;1004.703612434319;20321.91358638378;21476;21506.24728134539;21556.784432155477;21703.02336394866;941.1388579449864;979.9020097990144;1012.8430093335397;1018.1040684197859;1018.2057994764095;10651.893481065244;10942.781144377228;11019.724506887393;11046;11048.944755276172;565303;566992;567470;581321;584820;128069;129191;129926;130108;130264;1142.7200335917587;1157.6237722740143;1186.6084192216547;1192.9940350298193;1193.1588230297618;18177.545561361072;18262.634747305245;18342.266309347477;18372.897626142476;18580.44258672242;54900.72549637226;55226.171607426724;55237.72381138069;55314.89370212654;55402.72298638481;59717;74067.88898166423;74249.143771404;74974.25025749672;75149.62425188058;8677.132286771272;8914.65700362364;8920.687775927812;8990.82018359616;8998.460092394478;11372.86271372856;13669.658258543615;13890.305484725925;14279.857201427852;14386.208758518382;11411.8092354278;11818.409079545816;11875.762484750085;12131.393430328624;12177.208481448677;10376.575730008928;10381.429021403896;11361.4887330072;11495.425228738362;11798.705032374259;10417.47912604382;11305.321680699184;11611.883881161419;12266.815997759863;12278.877211227773;8704.695335663222;8890.4665720057;8940.642374304955;8951.597178126869;9218.861717074384;11830.881691182978;11845.5854045108;12046.277223366626;12062.698432539257;12118.454669539715 03:20:42 INFO - PID 1642 | |3;mootools.html;1399.587121799069;1449.84051754307;1469.1699189957674;1477.2023107521943;1477.3056663368227;11305.321680699164;11874.228175168608;11880.990115840164;11894.82157767634;11929.463174157163;11277.718057048578;11731.17881748278;11731.882681173207;11734.471948762304;11742.236754610944;2546.681664791901;2580.8193426460157;2582.535143674138;2592.7666510014096;2593.8703064846777;2152.494163871489;2237.0604346174646;2443.780059794618;2512.798976081909;2574.2663340947834;2178.2485042660255;2213.1258153029544;2214.7010153629294;2215.080741492287;2495.6381324707904;2551.8086143539217;2556.578164602838;2561.3596600849787;2565.743425657438;2567.6276939843806;2505.6116301973225;2516.5218608464334;2530.633058206568;2547.8726063696927;2565.422779874532;11704.47329870158;11831.408429578572;11850.940745296219;11851.585194518151;11865;6594.604323740591;6836.897446538306;6850.93149068508;6851;6856.41720453762;4123.690723195772;4354.346847972798;4359.760213188273;4429.756363400012;4432.512423633398;1255.4350542256022;1281.6667666406709;1325.3969443903002;1331.8202042724206;1336.305121336909;13703;16569.171541423002;16583.83416165835;16609.6678066438;16623.168841557872;5406.405295417501;5606.271184745957;5867.911981320283;5884.411558844081;5902.793402230987;12321.93839030817;12348.259104453762;12351.6912077197;12377.195482293622;12392.504299828086;6711.63086030273;6717.261101278856;6718.731250750013;6729.360710732472;6733.797986060426;6006.939930600638;6121.959266924633;6238.438540531374;6271.184745983084;6277.089821975788;3746.2320224353944;4266.743995360288;4390.297552391602;4443.488998765119;4444.64438346301;1280.8847203751707;1283.159530507519;1284.653143651209;1300.8048792680984;1305.3799445263614;695.2352412346379;697.8674051930117;778.7858338956833;792.1444839573247;814.3688641303038;6205.131281620576;6315.242170939517;6375.139356186948;6409.935900640934;6470.417662410406;595.1459655394523;598.3298705449924;624.2228425610144;625.3152797686525;628.5066223014911;3896.6687831534637;4077.327241005201;4498.523968651213;4628.236341003764;4693.380783629642;13111.60665180046;15329.386824526893;15367.615809604626;15374.38502459889;15382.538523844303;12875.613731588068;15181;15406.768898466533;15433.614159646098;15445.150516721464;8431.283340915968;8740;8785.033646298902;8844.55777211124;8882.822343553222;6536.542442029012;6995.79012629622;7087.468439866928;7105.6447177639875;7136;10550.419726914786;13431.19412835233;13597.52408665692;13642.181469111489;13959.302034898417;13939.581812545639;14087.225202613954;14251.073680210753;14304.284785760878;14381;9542.952285238807;9615.644167179085;9687.41875487473;9801;9859.852102218616;10747.785044298915;10965.287256328633;10973.23187376876;10974;10982.341059536453;8988.640454382014;9179.632814687338;9252.722418327461;9301.348905576815;9431.528423578931;9039.186473217442;9073.818523629623;9223.49270790113;9244.352895297265;9314.627414903329;7935;8224.38317126206;8280.213379728915;8313.459625124347;8324.875126872981;5957.731902064331;6024.668643224665;6076.544259180668;6193.194884664965;6211;5990.311114221746;5994.310654274815;6141.570090093829;6193.907091393543;6320.6839658016 03:20:42 INFO - PID 1642 | |4;prototype.html;383.57806412945763;397.245234055295;406.5629448343032;407.43570155334874;410.0405052177904;5686.488216060554;5826.708664566776;5970.492508136808;5993.910091348634;6040.30536488304;4907.75461226939;5665.943340566593;5794.565407594437;5802.564807639423;5885.941140588593;4037.6164264394833;4231.534531201581;4509.909801803962;4551.180787458256;4564.109998550284;4259.297215959363;4346.5436129206455;4358.757754040099;4537.70504917181;4552.90402526282;4027.8388864445387;4253.723507971972;4283.764392958386;4354.02034542227;4360.018995725968;4149.543550209474;4481.77591120446;4506.166359223522;4506.188886000518;4512.593866551993;3342.498625206214;3377.9493307600405;4009.498812648419;4016.2168377166463;4036.636702696742;4572.95427045732;5528.9723551381985;5644.971775141139;5765.830561299411;5783.71081445926;5372.597055220874;5395;5398.46015398457;5399.6490228135435;5429.945700542983;6092.147099406043;6310.432061114476;6337.6197428154455;6337.968310158466;6354.364563543655;3646.7994260315672;3853.3064048471265;4525.864224073283;4581.358609794632;4610.3315019322345;5560.805371811967;6552.820492311382;6577.276499585042;6602.9669851650915;6604.60372377654;4529.184746745617;4664.416947881515;4674.205385084544;4696.81212751493;4720.409948756405;4685.180093483695;4735.739534325577;4745.240761478216;4776.546228108324;4791.736454495036;5376.327959005124;5380.192971054373;5417.214503896992;5418.295621569171;5430.782768689208;6040.758369665252;6266.216722909637;6305.527085468608;6329.2721337045905;6363.395477429637;1380.4823191303262;1628.731259342219;1637.3614290426742;1638.803343598752;1640.9917950410172;996.242855429864;1059.2416588463113;1084.311462221495;1133.3086817041599;1137.9658610241706;5204.9739751301;5388.7305634718105;5957.344692083867;6087.512998960073;6122.7550897964475;5808.912866307009;6129.877402451926;6368.808935731936;6522.641254731036;6591.967040164865;5839.956015394578;5859.472647461749;5956.7319470623925;5981.940180598225;5986.161937328778;2934.8385838779072;3108.6580476147606;3338.2488939988793;3365.478350855621;3396.9469464466097;5419.891602168013;6097.048944337858;6720;6726.798196054028;6728.293529179464;6399.200099987502;6592.241892182365;6676.699548520328;6678.332166783282;6706;5880.617759845596;6145.324014358328;6383.0531687835655;6644.734210631617;6773.932260677528;5461.1808228766;6366.936330636634;6571.605703657796;6581.934180658132;6589.341065893564;6196.628202307876;6440.581362211441;6479.023897711243;6484.902726459012;6492.220933488012;6754.425873800782;6760.763373281911;6776.864462710817;6794.398968546679;6799.762008329685;3685.834137463767;3983.7849455916225;4237.915241695087;4321.438213032411;4325.356364581439;5347.786088556414;6175.783847565313;6496.902546461902;6526.051738698019;6526.510511711545;6165.938340616536;6318.842028949313;6320.5259605528845;6331.240251169889;6339.778107766206;6075.392460753889;6244.65654389013;6294.8111556653375;6306.873862522632;6313.936860631335;5155.304033955368;5308.787648494017;6020.1270815730595;6198.163247961467;6211.782587609412;6045.425684559959;6233.407826256498;6293.527985401021;6329.240491141092;6341;5260;5873.888278205359;6015.428534289235;6020.939790602038;6150.538709596887 03:20:42 INFO - PID 1642 | |5;yui.html;706.4983861458364;843.670968322354;844.8014716541612;847.0682249525522;856.4732689396019;13002.674933126676;15541.611459713513;17854.28582856686;18065.45803625892;18192.27230910762;16655.417060402888;16881.83118168818;16887.746683799753;16905.40831070913;17255.396061137864;950.719537736366;961.7162936933604;962.8555716642489;968.9806203875918;992.6426486464867;946.9678050924491;948.2935213266092;950.4059962523423;950.4487397309543;1003.4079892863209;1013.8023085498331;1015.4262841494569;1015.735908663749;1016.2175125153627;1035.4874337203057;1011.1203253169716;1012.9240306976933;1012.9696109116665;1013.8225810483136;1033.2095946600818;747.1072068877693;748.6032402826511;750.4446709435033;755.5466719967975;768.0514564512822;16367.836321636869;16496.34014639413;16663.416780412626;16959.067251301174;17117.828821711748;14618.195999220039;16727.247273872585;16754.162291885357;16927.49217523476;17190.570235744082;13887.375068121857;13999.370028348749;14012.089214201147;14030.017898747092;14196.929015354857;3536.6286539913194;3558.8220588970707;3562.4834399012257;3563.4476656118345;3565.554305711786;123840.38079809633;123991;126175;126320;129009;12932.159409638532;12961.351932403531;12979.156354836905;13103.541376051793;13111.2133272004;25029.749702503104;25215.243542693748;25507.744922550908;25876.741232587432;25940;7639.69441222356;7702.691892324357;7724.343430808444;7751;7855.84288314242;3841.078141246081;3877.6703980162;3912.9021774455296;3913.8630147944687;3915.9216815663526;4201.894952626148;4228.492580890313;4287.785610719514;4329.76186309756;4346.434963454731;856.9400141990126;908.6960212095664;950.2065775077749;956.8134213828237;957.7988622389237;635.3805040085879;656.8587753632896;659.1760299625469;660.4848218389664;687.9552829066095;10857.565697372174;11373.431328433546;11619.244749091282;11936.940315298369;12118.81821772674;606.2391698418456;653.1541653558653;653.5784419049781;665.04565947864;673.2056173714965;4540.591346778806;5432.674039557639;5434.3207099112615;5563.805266815642;5666.858328541737;92028.53985730163;96723.51638241904;98238;98587.50706246422;99804.00195997948;90753;91722;91997;92365;94412.63968400845;54734.49684366856;71068.93396598952;82533.58733206296;84702.72945905816;86279.56860215659;11460.426978651201;12298.508059677513;12388.380580971096;12425.13024088305;12571.18287311322;37144.628553714116;37268.06829829276;37668.81165594154;37891.62108378881;38125.80937095297;45717.771411142734;45990.540094598626;46116.53883461122;46226.306605401616;46955.76522117504;13800;15755.212239388215;15761.605959851095;16011.439599613957;16098.436554720529;17720.822791771916;17729.822701772817;17860.732089018416;18244.81755182431;18268.26926922908;13057.673558161123;16355.836441635907;16387;16481.917590411973;16674.83325166733;16304.021758694516;16446.67106657884;16492.587685307964;16497.752533712242;16635.334586616398;15784.92107539455;15980.280887359864;16186.514404567883;16277.918610406872;16283.430079947146;11341.4896329667;11368.31790092564;11696.94151529271;12002.339871306813;12083.033357331216;12183.390830458618;12238.694032649255;12804.167729097579;12817.743645127232;13036.47854085826 03:20:42 INFO - PID 1642 | __end_tp_report 03:20:42 INFO - PID 1642 | __start_cc_report 03:20:42 INFO - PID 1642 | _x_x_mozilla_cycle_collect,1960 03:20:42 INFO - PID 1642 | __end_cc_report 03:20:42 INFO - PID 1642 | __startTimestamp1492770042905__endTimestamp 03:20:42 INFO - PID 1642 | 03:20:42 INFO - PID 1642 | ------- Summary: start ------- 03:20:42 INFO - PID 1642 | Number of tests: 6 03:20:42 INFO - PID 1642 | 03:20:42 INFO - PID 1642 | [#0] dojo.html Cycles:165 Average:5986.18 Median:6222.41 stddev:722.11 (11.6%) stddev-sans-first:696.33 03:20:42 INFO - PID 1642 | Values: 3447.8 3461.2 3496.0 3502.4 3519.7 5917.1 6045.8 6074.6 6079.8 6102.2 5146.0 5968.0 6011.3 6024.2 6060.4 5182.8 5209.5 5216.4 5259.7 5265.5 5323.5 5326.9 5338.9 5340.2 5435.3 4334.5 5313.7 5314.7 5315.2 5326.0 5307.7 5314.3 5321.2 5322.9 5328.6 5131.2 5263.7 5269.3 5282.0 5305.0 6127.7 6192.8 6202.9 6205.8 6211.7 5436.8 6455.5 6483.6 6500.5 6503.9 5394.5 6451.3 6451.9 6512.2 6590.9 6217.6 6220.3 6220.6 6224.9 6229.2 6754.3 6758.6 6769.9 6779.1 6782.8 6227.2 6299.9 6304.9 6433.1 6443.3 6459.6 6460.4 6542.1 6546.5 6547.5 6377.6 6425.0 6433.1 6441.0 6442.5 6249.5 6346.5 6404.3 6452.4 6453.1 5006.7 5114.8 5189.3 5247.0 5248.8 4029.3 4572.3 4584.3 4657.0 4657.7 6181.8 6202.8 6203.4 6206.6 6222.4 6514.5 6582.6 6601.0 6602.2 6622.2 6058.6 6102.0 6103.4 6168.6 6211.4 5727.2 5746.1 5746.7 5768.8 5786.1 6728.5 6749.6 6770.4 6783.4 6800.1 6317.4 6397.7 6535.1 6549.1 6604.8 6664.4 6727.4 6738.5 6747.3 6756.8 6442.5 6449.0 6453.7 6457.0 6466.3 6317.6 6320.3 6540.5 6545.2 6560.9 6285.7 6295.2 6341.9 6381.6 6392.6 6361.3 6361.8 6362.9 6365.9 6383.2 6216.7 6221.7 6271.2 6271.3 6288.4 5561.9 6149.3 6255.4 6266.9 6390.7 6173.3 6199.7 6200.9 6210.8 6245.8 03:20:42 INFO - PID 1642 | 03:20:42 INFO - PID 1642 | [#1] ext.html Cycles:180 Average:44068.52 Median:3219.12 stddev:77420.08 (2405.0%) stddev-sans-first:77568.89 03:20:42 INFO - PID 1642 | Values: 730.9 786.8 796.3 1131.1 1132.9 27336.9 27620.9 27636.8 36621.0 37255.3 39531.8 39798.8 39900.8 39934.0 39958.0 8438.0 8597.0 8601.9 8611.2 8618.4 6071.8 6178.3 8378.7 8520.1 8568.1 8592.3 8656.6 8659.9 8667.9 8689.7 8576.6 8618.9 8619.1 8629.6 8631.5 8424.4 8474.0 8477.4 8482.2 8482.6 32832.7 36558.6 37351.1 37590.1 37729.8 3546.4 3584.0 3584.7 3586.9 3591.2 30604.4 30710.7 30722.2 30737.8 30745.0 3162.4 3208.0 3214.3 3223.9 3235.8 291692.0 299580.0 299711.0 300305.0 305883.0 44811.8 44863.6 45028.0 45131.0 45183.0 46737.8 46787.0 46802.5 46847.5 46867.8 14054.5 14147.4 14169.9 14170.9 14182.6 9856.9 11369.7 11431.8 11459.2 11476.4 10658.9 10728.5 10787.6 12366.3 12415.9 5157.9 5214.4 5219.3 5221.2 5236.3 941.3 1002.6 1013.4 1025.0 1059.5 21608.7 23241.0 24269.9 24363.6 24382.8 1086.9 1095.2 1112.7 1117.8 1159.9 10427.8 12590.1 12596.5 12613.4 12644.9 305304.0 305871.0 308501.0 310098.0 310711.0 52146.7 52267.5 52283.5 52351.5 52615.0 1402.3 1435.2 1481.1 1483.1 1527.8 23383.0 23427.0 23437.0 23440.9 23445.6 36967.7 36985.3 37003.6 37005.4 37121.6 275139.0 275327.0 278331.0 278716.0 278734.0 33202.0 33276.8 33293.8 33431.2 34740.8 44569.3 44701.9 44833.6 44896.0 45123.5 28409.7 28729.1 29523.3 30221.4 30439.5 30055.1 30680.1 31097.4 31137.1 31375.0 36979.1 37057.8 37107.4 37181.6 37205.0 24745.0 27968.4 28479.0 29278.9 29962.0 23911.3 24008.4 24252.4 24284.3 24366.1 03:20:42 INFO - PID 1642 | 03:20:42 INFO - PID 1642 | [#2] jquery.html Cycles:180 Average:35735.82 Median:12213.82 stddev:96568.44 (790.6%) stddev-sans-first:96802.90 03:20:42 INFO - PID 1642 | Values: 400.6 416.0 425.3 440.7 446.0 15562.6 18829.3 20621.4 21987.5 22184.0 21949.7 22176.4 22828.3 23057.7 23302.9 4226.5 5998.4 6157.2 6244.6 6251.4 6085.0 6184.8 6186.9 6189.9 6203.9 6017.0 6082.3 6132.4 6161.2 6169.6 6011.5 6078.4 6121.4 6125.9 6134.8 5408.0 5433.3 5467.8 5469.9 5470.3 27268.5 27279.6 27320.3 27369.6 27473.0 2243.6 2275.6 2281.2 2287.4 2295.7 17556.0 17771.6 18191.7 18252.8 18372.3 1942.5 2143.1 2211.8 2214.1 2216.3 144898.3 146285.3 146884.3 147472.3 149700.3 11613.4 12089.2 12607.5 12629.7 12731.6 15378.4 15400.5 16594.8 16896.2 16979.2 8837.6 8874.2 9005.3 9100.2 9159.6 8484.1 8485.3 8519.3 8706.7 8720.7 6632.5 7730.2 7853.5 7892.3 7910.2 2160.6 2160.7 2161.2 2163.2 2289.0 927.4 953.5 967.6 1003.3 1004.7 20321.9 21476.0 21506.2 21556.8 21703.0 941.1 979.9 1012.8 1018.1 1018.2 10651.9 10942.8 11019.7 11046.0 11048.9 565303.0 566992.0 567470.0 581321.0 584820.0 128069.0 129191.0 129926.0 130108.0 130264.0 1142.7 1157.6 1186.6 1193.0 1193.2 18177.5 18262.6 18342.3 18372.9 18580.4 54900.7 55226.2 55237.7 55314.9 55402.7 59717.0 74067.9 74249.1 74974.3 75149.6 8677.1 8914.7 8920.7 8990.8 8998.5 11372.9 13669.7 13890.3 14279.9 14386.2 11411.8 11818.4 11875.8 12131.4 12177.2 10376.6 10381.4 11361.5 11495.4 11798.7 10417.5 11305.3 11611.9 12266.8 12278.9 8704.7 8890.5 8940.6 8951.6 9218.9 11830.9 11845.6 12046.3 12062.7 12118.5 03:20:42 INFO - PID 1642 | 03:20:42 INFO - PID 1642 | [#3] mootools.html Cycles:180 Average:7175.11 Median:3821.45 stddev:4534.01 (118.6%) stddev-sans-first:4525.96 03:20:42 INFO - PID 1642 | Values: 1399.6 1449.8 1469.2 1477.2 1477.3 11305.3 11874.2 11881.0 11894.8 11929.5 11277.7 11731.2 11731.9 11734.5 11742.2 2546.7 2580.8 2582.5 2592.8 2593.9 2152.5 2237.1 2443.8 2512.8 2574.3 2178.2 2213.1 2214.7 2215.1 2495.6 2551.8 2556.6 2561.4 2565.7 2567.6 2505.6 2516.5 2530.6 2547.9 2565.4 11704.5 11831.4 11850.9 11851.6 11865.0 6594.6 6836.9 6850.9 6851.0 6856.4 4123.7 4354.3 4359.8 4429.8 4432.5 1255.4 1281.7 1325.4 1331.8 1336.3 13703.0 16569.2 16583.8 16609.7 16623.2 5406.4 5606.3 5867.9 5884.4 5902.8 12321.9 12348.3 12351.7 12377.2 12392.5 6711.6 6717.3 6718.7 6729.4 6733.8 6006.9 6122.0 6238.4 6271.2 6277.1 3746.2 4266.7 4390.3 4443.5 4444.6 1280.9 1283.2 1284.7 1300.8 1305.4 695.2 697.9 778.8 792.1 814.4 6205.1 6315.2 6375.1 6409.9 6470.4 595.1 598.3 624.2 625.3 628.5 3896.7 4077.3 4498.5 4628.2 4693.4 13111.6 15329.4 15367.6 15374.4 15382.5 12875.6 15181.0 15406.8 15433.6 15445.2 8431.3 8740.0 8785.0 8844.6 8882.8 6536.5 6995.8 7087.5 7105.6 7136.0 10550.4 13431.2 13597.5 13642.2 13959.3 13939.6 14087.2 14251.1 14304.3 14381.0 9543.0 9615.6 9687.4 9801.0 9859.9 10747.8 10965.3 10973.2 10974.0 10982.3 8988.6 9179.6 9252.7 9301.3 9431.5 9039.2 9073.8 9223.5 9244.4 9314.6 7935.0 8224.4 8280.2 8313.5 8324.9 5957.7 6024.7 6076.5 6193.2 6211.0 5990.3 5994.3 6141.6 6193.9 6320.7 03:20:42 INFO - PID 1642 | 03:20:42 INFO - PID 1642 | [#4] prototype.html Cycles:180 Average:5150.80 Median:5789.14 stddev:1570.19 (27.1%) stddev-sans-first:1533.28 03:20:42 INFO - PID 1642 | Values: 383.6 397.2 406.6 407.4 410.0 5686.5 5826.7 5970.5 5993.9 6040.3 4907.8 5665.9 5794.6 5802.6 5885.9 4037.6 4231.5 4509.9 4551.2 4564.1 4259.3 4346.5 4358.8 4537.7 4552.9 4027.8 4253.7 4283.8 4354.0 4360.0 4149.5 4481.8 4506.2 4506.2 4512.6 3342.5 3377.9 4009.5 4016.2 4036.6 4573.0 5529.0 5645.0 5765.8 5783.7 5372.6 5395.0 5398.5 5399.6 5429.9 6092.1 6310.4 6337.6 6338.0 6354.4 3646.8 3853.3 4525.9 4581.4 4610.3 5560.8 6552.8 6577.3 6603.0 6604.6 4529.2 4664.4 4674.2 4696.8 4720.4 4685.2 4735.7 4745.2 4776.5 4791.7 5376.3 5380.2 5417.2 5418.3 5430.8 6040.8 6266.2 6305.5 6329.3 6363.4 1380.5 1628.7 1637.4 1638.8 1641.0 996.2 1059.2 1084.3 1133.3 1138.0 5205.0 5388.7 5957.3 6087.5 6122.8 5808.9 6129.9 6368.8 6522.6 6592.0 5840.0 5859.5 5956.7 5981.9 5986.2 2934.8 3108.7 3338.2 3365.5 3396.9 5419.9 6097.0 6720.0 6726.8 6728.3 6399.2 6592.2 6676.7 6678.3 6706.0 5880.6 6145.3 6383.1 6644.7 6773.9 5461.2 6366.9 6571.6 6581.9 6589.3 6196.6 6440.6 6479.0 6484.9 6492.2 6754.4 6760.8 6776.9 6794.4 6799.8 3685.8 3983.8 4237.9 4321.4 4325.4 5347.8 6175.8 6496.9 6526.1 6526.5 6165.9 6318.8 6320.5 6331.2 6339.8 6075.4 6244.7 6294.8 6306.9 6313.9 5155.3 5308.8 6020.1 6198.2 6211.8 6045.4 6233.4 6293.5 6329.2 6341.0 5260.0 5873.9 6015.4 6020.9 6150.5 03:20:42 INFO - PID 1642 | 03:20:42 INFO - PID 1642 | [#5] yui.html Cycles:180 Average:21015.45 Median:21649.01 stddev:29678.75 (137.1%) stddev-sans-first:29722.83 03:20:42 INFO - PID 1642 | Values: 706.5 843.7 844.8 847.1 856.5 13002.7 15541.6 17854.3 18065.5 18192.3 16655.4 16881.8 16887.7 16905.4 17255.4 950.7 961.7 962.9 969.0 992.6 947.0 948.3 950.4 950.4 1003.4 1013.8 1015.4 1015.7 1016.2 1035.5 1011.1 1012.9 1013.0 1013.8 1033.2 747.1 748.6 750.4 755.5 768.1 16367.8 16496.3 16663.4 16959.1 17117.8 14618.2 16727.2 16754.2 16927.5 17190.6 13887.4 13999.4 14012.1 14030.0 14196.9 3536.6 3558.8 3562.5 3563.4 3565.6 123840.4 123991.0 126175.0 126320.0 129009.0 12932.2 12961.4 12979.2 13103.5 13111.2 25029.7 25215.2 25507.7 25876.7 25940.0 7639.7 7702.7 7724.3 7751.0 7855.8 3841.1 3877.7 3912.9 3913.9 3915.9 4201.9 4228.5 4287.8 4329.8 4346.4 856.9 908.7 950.2 956.8 957.8 635.4 656.9 659.2 660.5 688.0 10857.6 11373.4 11619.2 11936.9 12118.8 606.2 653.2 653.6 665.0 673.2 4540.6 5432.7 5434.3 5563.8 5666.9 92028.5 96723.5 98238.0 98587.5 99804.0 90753.0 91722.0 91997.0 92365.0 94412.6 54734.5 71068.9 82533.6 84702.7 86279.6 11460.4 12298.5 12388.4 12425.1 12571.2 37144.6 37268.1 37668.8 37891.6 38125.8 45717.8 45990.5 46116.5 46226.3 46955.8 13800.0 15755.2 15761.6 16011.4 16098.4 17720.8 17729.8 17860.7 18244.8 18268.3 13057.7 16355.8 16387.0 16481.9 16674.8 16304.0 16446.7 16492.6 16497.8 16635.3 15784.9 15980.3 16186.5 16277.9 16283.4 11341.5 11368.3 11696.9 12002.3 12083.0 12183.4 12238.7 12804.2 12817.7 13036.5 03:20:42 INFO - PID 1642 | -------- Summary: end -------- 03:20:42 INFO - PID 1642 | 03:20:43 INFO - TEST-INFO | 1642: exit 0 03:20:43 INFO - TEST-OK | dromaeo_css | took 1119215ms 03:20:43 INFO - TEST-START | kraken 03:20:43 INFO - operating with platform_type : mac_ 03:20:43 INFO - Initialising browser for kraken test... 03:20:43 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmptVP8Qk/profile http://localhost:49245/getInfo.html) 03:20:46 INFO - PID 1651 | __metrics Screen width/height:1600/1200 03:20:46 INFO - PID 1651 | colorDepth:24 03:20:46 INFO - PID 1651 | Browser inner width/height: 1024/689 03:20:46 INFO - PID 1651 | __metrics 03:20:46 INFO - PID 1651 | 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" 03:20:46 INFO - PID 1651 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:20:47 INFO - TEST-INFO | 1651: exit 0 03:20:47 INFO - Browser initialized. 03:20:47 INFO - Running cycle 1/1 for kraken test... 03:20:47 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmptVP8Qk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:20:59 INFO - PID 1652 | RSS: Main: 241782784 03:20:59 INFO - PID 1652 | 03:21:02 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection) 03:21:02 INFO - PID 1652 | RSS: Main: 312549376 03:21:02 INFO - PID 1652 | 03:21:05 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-dft) 03:21:06 INFO - PID 1652 | RSS: Main: 295190528 03:21:06 INFO - PID 1652 | 03:21:09 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-fft) 03:21:10 INFO - PID 1652 | RSS: Main: 387567616 03:21:10 INFO - PID 1652 | 03:21:12 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator) 03:21:12 INFO - PID 1652 | RSS: Main: 290107392 03:21:12 INFO - PID 1652 | 03:21:14 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:21:15 INFO - PID 1652 | RSS: Main: 292397056 03:21:15 INFO - PID 1652 | 03:21:18 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom) 03:21:18 INFO - PID 1652 | RSS: Main: 356413440 03:21:18 INFO - PID 1652 | 03:21:21 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate) 03:21:22 INFO - PID 1652 | RSS: Main: 371609600 03:21:22 INFO - PID 1652 | 03:21:25 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial) 03:21:26 INFO - PID 1652 | RSS: Main: 377393152 03:21:26 INFO - PID 1652 | 03:21:27 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:21:28 INFO - PID 1652 | RSS: Main: 332451840 03:21:28 INFO - PID 1652 | 03:21:29 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:21:30 INFO - PID 1652 | RSS: Main: 332480512 03:21:30 INFO - PID 1652 | 03:21:32 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:21:33 INFO - PID 1652 | RSS: Main: 334675968 03:21:33 INFO - PID 1652 | 03:21:36 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:21:36 INFO - PID 1652 | RSS: Main: 348733440 03:21:36 INFO - PID 1652 | 03:21:39 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:21:40 INFO - PID 1652 | RSS: Main: 341680128 03:21:40 INFO - PID 1652 | 03:21:42 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49245/tests/kraken/driver.html?testName=ai-astar) 03:21:42 INFO - PID 1652 | RSS: Main: 384929792 03:21:42 INFO - PID 1652 | 03:21:42 INFO - PID 1652 | __start_tp_report 03:21:42 INFO - PID 1652 | _x_x_mozilla_page_load 03:21:42 INFO - PID 1652 | _x_x_mozilla_page_load_details 03:21:42 INFO - PID 1652 | |i|pagename|runs| 03:21:42 INFO - PID 1652 | |0;ai-astar;111;111;111;112;113;111;112;112;112;112 03:21:42 INFO - PID 1652 | |1;audio-beat-detection;139;108;104;148;96;104;129;134;153;110 03:21:42 INFO - PID 1652 | |2;audio-dft;184;184;186;187;186;186;185;184;182;184 03:21:42 INFO - PID 1652 | |3;audio-fft;79;57;60;88;60;57;57;57;80;58 03:21:42 INFO - PID 1652 | |4;audio-oscillator;85;94;113;99;96;69;88;69;70;91 03:21:42 INFO - PID 1652 | |5;imaging-gaussian-blur;90;93;89;94;87;95;92;93;94;88 03:21:42 INFO - PID 1652 | |6;imaging-darkroom;96;96;96;95;95;99;97;96;95;95 03:21:42 INFO - PID 1652 | |7;imaging-desaturate;84;110;134;116;85;84;88;86;84;83 03:21:42 INFO - PID 1652 | |8;json-parse-financial;49;49;47;48;49;49;49;49;50;48 03:21:42 INFO - PID 1652 | |9;json-stringify-tinderbox;54;54;64;60;65;59;58;57;57;58 03:21:42 INFO - PID 1652 | |10;stanford-crypto-aes;83;83;81;84;83;83;83;80;81;80 03:21:42 INFO - PID 1652 | |11;stanford-crypto-ccm;137;136;135;138;132;137;142;149;177;150 03:21:42 INFO - PID 1652 | |12;stanford-crypto-pbkdf2;177;188;183;186;178;172;184;185;182;184 03:21:42 INFO - PID 1652 | |13;stanford-crypto-sha256-iterative;71;68;67;67;69;68;67;68;65;69 03:21:42 INFO - PID 1652 | __end_tp_report 03:21:42 INFO - PID 1652 | __start_cc_report 03:21:42 INFO - PID 1652 | _x_x_mozilla_cycle_collect,2174 03:21:42 INFO - PID 1652 | __end_cc_report 03:21:42 INFO - PID 1652 | __startTimestamp1492770102479__endTimestamp 03:21:42 INFO - PID 1652 | 03:21:42 INFO - PID 1652 | ------- Summary: start ------- 03:21:42 INFO - PID 1652 | Number of tests: 14 03:21:42 INFO - PID 1652 | 03:21:42 INFO - PID 1652 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 03:21:42 INFO - PID 1652 | Values: 111.0 111.0 111.0 112.0 113.0 111.0 112.0 112.0 112.0 112.0 03:21:42 INFO - PID 1652 | 03:21:42 INFO - PID 1652 | [#1] audio-beat-detection Cycles:10 Average:122.50 Median:136.50 stddev:20.50 (15.0%) stddev-sans-first:20.85 03:21:42 INFO - PID 1652 | Values: 139.0 108.0 104.0 148.0 96.0 104.0 129.0 134.0 153.0 110.0 03:21:42 INFO - PID 1652 | 03:21:42 INFO - PID 1652 | [#2] audio-dft Cycles:10 Average:184.80 Median:185.50 stddev:1.48 (0.8%) stddev-sans-first:1.54 03:21:42 INFO - PID 1652 | Values: 184.0 184.0 186.0 187.0 186.0 186.0 185.0 184.0 182.0 184.0 03:21:42 INFO - PID 1652 | 03:21:42 INFO - PID 1652 | [#3] audio-fft Cycles:10 Average:65.30 Median:60.00 stddev:12.04 (20.1%) stddev-sans-first:11.70 03:21:42 INFO - PID 1652 | Values: 79.0 57.0 60.0 88.0 60.0 57.0 57.0 57.0 80.0 58.0 03:21:42 INFO - PID 1652 | 03:21:42 INFO - PID 1652 | [#4] audio-oscillator Cycles:10 Average:87.40 Median:89.50 stddev:14.55 (16.3%) stddev-sans-first:15.41 03:21:42 INFO - PID 1652 | Values: 85.0 94.0 113.0 99.0 96.0 69.0 88.0 69.0 70.0 91.0 03:21:42 INFO - PID 1652 | 03:21:42 INFO - PID 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:91.50 Median:93.00 stddev:2.80 (3.0%) stddev-sans-first:2.92 03:21:42 INFO - PID 1652 | Values: 90.0 93.0 89.0 94.0 87.0 95.0 92.0 93.0 94.0 88.0 03:21:42 INFO - PID 1652 | 03:21:42 INFO - PID 1652 | [#6] imaging-darkroom Cycles:10 Average:96.00 Median:96.00 stddev:1.25 (1.3%) stddev-sans-first:1.32 03:21:42 INFO - PID 1652 | Values: 96.0 96.0 96.0 95.0 95.0 99.0 97.0 96.0 95.0 95.0 03:21:42 INFO - PID 1652 | 03:21:42 INFO - PID 1652 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:84.00 stddev:18.02 (21.5%) stddev-sans-first:18.63 03:21:42 INFO - PID 1652 | Values: 84.0 110.0 134.0 116.0 85.0 84.0 88.0 86.0 84.0 83.0 03:21:42 INFO - PID 1652 | 03:21:42 INFO - PID 1652 | [#8] json-parse-financial Cycles:10 Average:48.70 Median:49.00 stddev:0.82 (1.7%) stddev-sans-first:0.87 03:21:42 INFO - PID 1652 | Values: 49.0 49.0 47.0 48.0 49.0 49.0 49.0 49.0 50.0 48.0 03:21:42 INFO - PID 1652 | 03:21:42 INFO - PID 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:58.50 stddev:3.66 (6.3%) stddev-sans-first:3.48 03:21:42 INFO - PID 1652 | Values: 54.0 54.0 64.0 60.0 65.0 59.0 58.0 57.0 57.0 58.0 03:21:42 INFO - PID 1652 | 03:21:42 INFO - PID 1652 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:83.00 stddev:1.45 (1.7%) stddev-sans-first:1.50 03:21:42 INFO - PID 1652 | Values: 83.0 83.0 81.0 84.0 83.0 83.0 83.0 80.0 81.0 80.0 03:21:42 INFO - PID 1652 | 03:21:42 INFO - PID 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:143.30 Median:140.00 stddev:13.22 (9.4%) stddev-sans-first:13.82 03:21:42 INFO - PID 1652 | Values: 137.0 136.0 135.0 138.0 132.0 137.0 142.0 149.0 177.0 150.0 03:21:42 INFO - PID 1652 | 03:21:42 INFO - PID 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.90 Median:184.00 stddev:4.84 (2.6%) stddev-sans-first:4.80 03:21:42 INFO - PID 1652 | Values: 177.0 188.0 183.0 186.0 178.0 172.0 184.0 185.0 182.0 184.0 03:21:42 INFO - PID 1652 | 03:21:42 INFO - PID 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.60 (2.3%) stddev-sans-first:1.24 03:21:42 INFO - PID 1652 | Values: 71.0 68.0 67.0 67.0 69.0 68.0 67.0 68.0 65.0 69.0 03:21:42 INFO - PID 1652 | -------- Summary: end -------- 03:21:42 INFO - PID 1652 | 03:21:43 INFO - TEST-INFO | 1652: exit 0 03:21:43 INFO - TEST-OK | kraken | took 59954ms 03:21:43 INFO - SUITE-END | took 1179s 03:21:43 INFO - Completed test suite (00:19:39) 03:21:43 INFO - javascript benchmark 03:21:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7743.197337256349, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3447.775894566853, 3461.2039230976857, 3496.0036389628963, 3502.352064867998, 3519.683228509435, 5917.112433135032, 6045.848853778658, 6074.605150665204, 6079.817605471837, 6102.206713127298, 5146.0222557714105, 5967.970160149193, 6011.308699499559, 6024.2168518092585, 6060.363661815512, 5182.792688292464, 5209.453007434222, 5216.374035115772, 5259.710715910624, 5265.4997775211295, 5323.467653234684, 5326.866828329284, 5338.91991620126, 5340.225667278242, 5435.320584926884, 4334.479862416499, 5313.707746073965, 5314.654547454423, 5315.229291752694, 5326.0, 5307.708076055816, 5314.335708036496, 5321.201819727034, 5322.92015619766, 5328.6269961102735, 5131.153359695646, 5263.710495922723, 5269.262303277545, 5282.0, 5304.973475132639, 6127.724252408608, 6192.845178870519, 6202.875942481171, 6205.844853878644, 6211.68941552925, 5436.836894893159, 6455.5158363122955, 6483.610983340967, 6500.544961852672, 6503.8699226015215, 5394.460553944614, 6451.322611125858, 6451.870962580722, 6512.185976752906, 6590.868182636368, 6217.56477046607, 6220.253569571681, 6220.564560480723, 6224.875502490016, 6229.1590635264565, 6754.257031726506, 6758.594484330857, 6769.864602708017, 6779.118714567075, 6782.830429239309, 6227.159333490012, 6299.905501417483, 6304.936950630527, 6433.131527243856, 6443.29123796382, 6459.61242325462, 6460.353964603502, 6542.084108224853, 6546.541742078104, 6547.508936829757, 6377.64922929234, 6425.036244563259, 6433.067205255305, 6441.0, 6442.516811239176, 6249.531285153632, 6346.4605508532295, 6404.327545607737, 6452.35476452351, 6453.096566480696, 5006.74966251686, 5114.820981265712, 5189.299444574934, 5246.97376513115, 5248.7900483980975, 4029.274730548471, 4572.291294849304, 4584.289435137493, 4656.998745269783, 4657.67396282257, 6181.8454538636, 6202.782902598387, 6203.410675985864, 6206.596571222856, 6222.408871157233, 6514.511411644051, 6582.572132811352, 6601.00984852276, 6602.1747281589805, 6622.205335359788, 6058.575899687068, 6102.004547214544, 6103.36797469674, 6168.629882207082, 6211.440970312694, 5727.2268243787385, 5746.080627099644, 5746.683932383676, 5768.826935191951, 5786.132080188006, 6728.495362847806, 6749.595024298558, 6770.356816102462, 6783.3555812197765, 6800.149981252343, 6317.368263173829, 6397.680115994275, 6535.117759102651, 6549.083128361938, 6604.8348791280605, 6664.400203981665, 6727.360900714424, 6738.46092312604, 6747.325267473213, 6756.763513277012, 6442.549021568445, 6449.0, 6453.741850326122, 6457.031445283245, 6466.32103629131, 6317.5893566918, 6320.304766475776, 6540.50946179029, 6545.181852268466, 6560.9343906560325, 6285.748570057147, 6295.181626388723, 6341.936580634135, 6381.553291269566, 6392.616443013248, 6361.268454127649, 6361.777337793155, 6362.904556431565, 6365.936340636719, 6383.202099737533, 6216.658083805434, 6221.720022598904, 6271.153394291712, 6271.310155882758, 6288.371162883675, 5561.915426491795, 6149.292831324455, 6255.40573645503, 6266.905996409966, 6390.712417941297, 6173.32093469709, 6199.659018754011, 6200.906986395117, 6210.844728881633, 6245.812625621239], "value": 5937.46337399255, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.9269073092692, 786.7561056072618, 796.3072127249294, 1131.123379380979, 1132.9376884271367, 27336.86331568342, 27620.895164193433, 27636.75634596443, 36621.0, 37255.254894902086, 39531.80234098825, 39798.80100599493, 39900.80049599755, 39934.0, 39958.0, 8437.987441507012, 8597.011343695462, 8601.913980860174, 8611.224989750921, 8618.439801412887, 6071.848203794896, 6178.258608966908, 8378.664853405857, 8520.062793092755, 8568.143185681445, 8592.269657079156, 8656.61045252962, 8659.913400865973, 8667.869981950276, 8689.739307820775, 8576.614052367628, 8618.870716939251, 8619.051904290493, 8629.568521573896, 8631.482111073356, 8424.368172387034, 8473.957630211871, 8477.448965817202, 8482.194191551793, 8482.575871206414, 32832.6716732832, 36558.63441365606, 37351.066223344365, 37590.06024849373, 37729.81135094307, 3546.414841551141, 3583.996480985328, 3584.6773790358734, 3586.8923932282073, 3591.2099338145567, 30604.38791224163, 30710.692893071006, 30722.23194420135, 30737.846310768527, 30745.0, 3162.3517178978254, 3208.0, 3214.341060082701, 3223.903282901517, 3235.773495855291, 291692.0, 299580.0, 299711.0, 300305.0, 305883.0, 44811.77594112074, 44863.55136448659, 45028.0, 45131.0, 45183.0, 46737.76631116823, 46787.0, 46802.53197467982, 46847.531524685, 46867.76566117216, 14054.508092216724, 14147.43410263578, 14169.858301416854, 14170.929145354206, 14182.574522764333, 9856.901430985741, 11369.658910232707, 11431.828522572168, 11459.197856150156, 11476.368799716096, 10658.89341106579, 10728.517216725266, 10787.56849726018, 12366.319852408204, 12415.944644705301, 5157.885267040496, 5214.374275086938, 5219.347581552306, 5221.190715439113, 5236.29310043147, 941.2517048946104, 1002.6113832342259, 1013.3869009249298, 1024.99487502562, 1059.5179193466954, 21608.675869861963, 23241.0, 24269.878650606635, 24363.634545481833, 24382.75617243805, 1086.9293495922739, 1095.2333366643381, 1112.67732357617, 1117.8155604325357, 1159.913006524514, 10427.791444171075, 12590.118691691494, 12596.496140154291, 12613.432395542222, 12644.936775316248, 305304.0, 305871.0, 308501.0, 310098.0, 310711.0, 52146.73926630418, 52267.477325227024, 52283.47716522862, 52351.47648523542, 52615.0, 1402.2918426194706, 1435.1790540374702, 1481.1187343530582, 1483.0730793254215, 1527.7631967045127, 23383.0, 23427.0, 23437.0, 23440.945157468297, 23445.648315275626, 36967.70613028531, 36985.26029479449, 37003.62996370002, 37005.444918326786, 37121.6287837129, 275139.0, 275327.0, 278331.0, 278716.0, 278734.0, 33202.0, 33276.83361583274, 33293.83353083219, 33431.1642208937, 34740.826295868355, 44569.331460027475, 44701.88245293894, 44833.55166448294, 44896.0, 45123.548764511936, 28409.715902840708, 28729.138125856258, 29523.261918452212, 30221.395572088873, 30439.54340684936, 30055.098347049625, 30680.079597612108, 31097.37805243928, 31137.065888023397, 31375.0, 36979.07552311214, 37057.81471092627, 37107.443388348656, 37181.62818371782, 37205.0, 24745.0, 27968.44063118767, 28479.00323488668, 29278.853605731834, 29962.0, 23911.28266152018, 24008.39979000539, 24252.393690157885, 24284.27147185587, 24366.147184848443], "value": 17057.70333800892, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.60140160540266, 415.99376009359867, 425.29825787450704, 440.7047278323524, 445.9643228541717, 15562.610934726637, 18829.340973065944, 20621.38135855923, 21987.450313742163, 22184.0, 21949.67075493869, 22176.445588860246, 22828.31515054547, 23057.654135187942, 23302.88348558259, 4226.492820861501, 5998.40015998401, 6157.1995640566665, 6244.594101383418, 6251.374862513735, 6085.0, 6184.752609895599, 6186.876262474748, 6189.90715139271, 6203.875922481548, 6017.037274036155, 6082.300535438437, 6132.41742034506, 6161.199044124258, 6169.629822210659, 6011.519078473755, 6078.422549857756, 6121.357257487989, 6125.866714657803, 6134.815955521319, 5407.972960135174, 5433.320834895638, 5467.835964921059, 5469.917951230735, 5470.316210473691, 27268.454630907272, 27279.590806137923, 27320.316992075157, 27369.589456158174, 27473.0, 2243.6410174372186, 2275.5562665280277, 2281.2471884278148, 2287.3824067501846, 2295.747467778543, 17556.0, 17771.644567108713, 18191.727124093148, 18252.817471825245, 18372.26510939561, 1942.5046613113707, 2143.110609097223, 2211.8119959803435, 2214.1475531920164, 2216.26863135165, 144898.27550862284, 146285.26857365645, 146884.2655786725, 147472.26263868719, 149700.2514987429, 11613.419329033515, 12089.214201076902, 12607.495700172074, 12629.684257893443, 12731.61805145847, 15378.384864605514, 15400.46098386551, 16594.83405165957, 16896.239669214916, 16979.23593438298, 8837.55812209387, 8874.156955089256, 9005.279577633773, 9100.22648074921, 9159.633614655339, 8484.10345887316, 8485.32117430604, 8519.275861551838, 8706.738797836075, 8720.694775682821, 6632.469402447792, 7730.188330225358, 7853.450258481851, 7892.28969392746, 7910.2089791020435, 2160.5894879972757, 2160.719106516174, 2161.216995978324, 2163.1671806354666, 2289.027163455558, 927.3879239701764, 953.4565297780338, 967.5887747707196, 1003.3428104591504, 1004.703612434319, 20321.91358638378, 21476.0, 21506.24728134539, 21556.784432155477, 21703.02336394866, 941.1388579449864, 979.9020097990144, 1012.8430093335397, 1018.1040684197859, 1018.2057994764095, 10651.893481065244, 10942.781144377228, 11019.724506887393, 11046.0, 11048.944755276172, 565303.0, 566992.0, 567470.0, 581321.0, 584820.0, 128069.0, 129191.0, 129926.0, 130108.0, 130264.0, 1142.7200335917587, 1157.6237722740143, 1186.6084192216547, 1192.9940350298193, 1193.1588230297618, 18177.545561361072, 18262.634747305245, 18342.266309347477, 18372.897626142476, 18580.44258672242, 54900.72549637226, 55226.171607426724, 55237.72381138069, 55314.89370212654, 55402.72298638481, 59717.0, 74067.88898166423, 74249.143771404, 74974.25025749672, 75149.62425188058, 8677.132286771272, 8914.65700362364, 8920.687775927812, 8990.82018359616, 8998.460092394478, 11372.86271372856, 13669.658258543615, 13890.305484725925, 14279.857201427852, 14386.208758518382, 11411.8092354278, 11818.409079545816, 11875.762484750085, 12131.393430328624, 12177.208481448677, 10376.575730008928, 10381.429021403896, 11361.4887330072, 11495.425228738362, 11798.705032374259, 10417.47912604382, 11305.321680699184, 11611.883881161419, 12266.815997759863, 12278.877211227773, 8704.695335663222, 8890.4665720057, 8940.642374304955, 8951.597178126869, 9218.861717074384, 11830.881691182978, 11845.5854045108, 12046.277223366626, 12062.698432539257, 12118.454669539715], "value": 10358.35376911747, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1399.587121799069, 1449.84051754307, 1469.1699189957674, 1477.2023107521943, 1477.3056663368227, 11305.321680699164, 11874.228175168608, 11880.990115840164, 11894.82157767634, 11929.463174157163, 11277.718057048578, 11731.17881748278, 11731.882681173207, 11734.471948762304, 11742.236754610944, 2546.681664791901, 2580.8193426460157, 2582.535143674138, 2592.7666510014096, 2593.8703064846777, 2152.494163871489, 2237.0604346174646, 2443.780059794618, 2512.798976081909, 2574.2663340947834, 2178.2485042660255, 2213.1258153029544, 2214.7010153629294, 2215.080741492287, 2495.6381324707904, 2551.8086143539217, 2556.578164602838, 2561.3596600849787, 2565.743425657438, 2567.6276939843806, 2505.6116301973225, 2516.5218608464334, 2530.633058206568, 2547.8726063696927, 2565.422779874532, 11704.47329870158, 11831.408429578572, 11850.940745296219, 11851.585194518151, 11865.0, 6594.604323740591, 6836.897446538306, 6850.93149068508, 6851.0, 6856.41720453762, 4123.690723195772, 4354.346847972798, 4359.760213188273, 4429.756363400012, 4432.512423633398, 1255.4350542256022, 1281.6667666406709, 1325.3969443903002, 1331.8202042724206, 1336.305121336909, 13703.0, 16569.171541423002, 16583.83416165835, 16609.6678066438, 16623.168841557872, 5406.405295417501, 5606.271184745957, 5867.911981320283, 5884.411558844081, 5902.793402230987, 12321.93839030817, 12348.259104453762, 12351.6912077197, 12377.195482293622, 12392.504299828086, 6711.63086030273, 6717.261101278856, 6718.731250750013, 6729.360710732472, 6733.797986060426, 6006.939930600638, 6121.959266924633, 6238.438540531374, 6271.184745983084, 6277.089821975788, 3746.2320224353944, 4266.743995360288, 4390.297552391602, 4443.488998765119, 4444.64438346301, 1280.8847203751707, 1283.159530507519, 1284.653143651209, 1300.8048792680984, 1305.3799445263614, 695.2352412346379, 697.8674051930117, 778.7858338956833, 792.1444839573247, 814.3688641303038, 6205.131281620576, 6315.242170939517, 6375.139356186948, 6409.935900640934, 6470.417662410406, 595.1459655394523, 598.3298705449924, 624.2228425610144, 625.3152797686525, 628.5066223014911, 3896.6687831534637, 4077.327241005201, 4498.523968651213, 4628.236341003764, 4693.380783629642, 13111.60665180046, 15329.386824526893, 15367.615809604626, 15374.38502459889, 15382.538523844303, 12875.613731588068, 15181.0, 15406.768898466533, 15433.614159646098, 15445.150516721464, 8431.283340915968, 8740.0, 8785.033646298902, 8844.55777211124, 8882.822343553222, 6536.542442029012, 6995.79012629622, 7087.468439866928, 7105.6447177639875, 7136.0, 10550.419726914786, 13431.19412835233, 13597.52408665692, 13642.181469111489, 13959.302034898417, 13939.581812545639, 14087.225202613954, 14251.073680210753, 14304.284785760878, 14381.0, 9542.952285238807, 9615.644167179085, 9687.41875487473, 9801.0, 9859.852102218616, 10747.785044298915, 10965.287256328633, 10973.23187376876, 10974.0, 10982.341059536453, 8988.640454382014, 9179.632814687338, 9252.722418327461, 9301.348905576815, 9431.528423578931, 9039.186473217442, 9073.818523629623, 9223.49270790113, 9244.352895297265, 9314.627414903329, 7935.0, 8224.38317126206, 8280.213379728915, 8313.459625124347, 8324.875126872981, 5957.731902064331, 6024.668643224665, 6076.544259180668, 6193.194884664965, 6211.0, 5990.311114221746, 5994.310654274815, 6141.570090093829, 6193.907091393543, 6320.6839658016], "value": 5369.169995247338, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.57806412945763, 397.245234055295, 406.5629448343032, 407.43570155334874, 410.0405052177904, 5686.488216060554, 5826.708664566776, 5970.492508136808, 5993.910091348634, 6040.30536488304, 4907.75461226939, 5665.943340566593, 5794.565407594437, 5802.564807639423, 5885.941140588593, 4037.6164264394833, 4231.534531201581, 4509.909801803962, 4551.180787458256, 4564.109998550284, 4259.297215959363, 4346.5436129206455, 4358.757754040099, 4537.70504917181, 4552.90402526282, 4027.8388864445387, 4253.723507971972, 4283.764392958386, 4354.02034542227, 4360.018995725968, 4149.543550209474, 4481.77591120446, 4506.166359223522, 4506.188886000518, 4512.593866551993, 3342.498625206214, 3377.9493307600405, 4009.498812648419, 4016.2168377166463, 4036.636702696742, 4572.95427045732, 5528.9723551381985, 5644.971775141139, 5765.830561299411, 5783.71081445926, 5372.597055220874, 5395.0, 5398.46015398457, 5399.6490228135435, 5429.945700542983, 6092.147099406043, 6310.432061114476, 6337.6197428154455, 6337.968310158466, 6354.364563543655, 3646.7994260315672, 3853.3064048471265, 4525.864224073283, 4581.358609794632, 4610.3315019322345, 5560.805371811967, 6552.820492311382, 6577.276499585042, 6602.9669851650915, 6604.60372377654, 4529.184746745617, 4664.416947881515, 4674.205385084544, 4696.81212751493, 4720.409948756405, 4685.180093483695, 4735.739534325577, 4745.240761478216, 4776.546228108324, 4791.736454495036, 5376.327959005124, 5380.192971054373, 5417.214503896992, 5418.295621569171, 5430.782768689208, 6040.758369665252, 6266.216722909637, 6305.527085468608, 6329.2721337045905, 6363.395477429637, 1380.4823191303262, 1628.731259342219, 1637.3614290426742, 1638.803343598752, 1640.9917950410172, 996.242855429864, 1059.2416588463113, 1084.311462221495, 1133.3086817041599, 1137.9658610241706, 5204.9739751301, 5388.7305634718105, 5957.344692083867, 6087.512998960073, 6122.7550897964475, 5808.912866307009, 6129.877402451926, 6368.808935731936, 6522.641254731036, 6591.967040164865, 5839.956015394578, 5859.472647461749, 5956.7319470623925, 5981.940180598225, 5986.161937328778, 2934.8385838779072, 3108.6580476147606, 3338.2488939988793, 3365.478350855621, 3396.9469464466097, 5419.891602168013, 6097.048944337858, 6720.0, 6726.798196054028, 6728.293529179464, 6399.200099987502, 6592.241892182365, 6676.699548520328, 6678.332166783282, 6706.0, 5880.617759845596, 6145.324014358328, 6383.0531687835655, 6644.734210631617, 6773.932260677528, 5461.1808228766, 6366.936330636634, 6571.605703657796, 6581.934180658132, 6589.341065893564, 6196.628202307876, 6440.581362211441, 6479.023897711243, 6484.902726459012, 6492.220933488012, 6754.425873800782, 6760.763373281911, 6776.864462710817, 6794.398968546679, 6799.762008329685, 3685.834137463767, 3983.7849455916225, 4237.915241695087, 4321.438213032411, 4325.356364581439, 5347.786088556414, 6175.783847565313, 6496.902546461902, 6526.051738698019, 6526.510511711545, 6165.938340616536, 6318.842028949313, 6320.5259605528845, 6331.240251169889, 6339.778107766206, 6075.392460753889, 6244.65654389013, 6294.8111556653375, 6306.873862522632, 6313.936860631335, 5155.304033955368, 5308.787648494017, 6020.1270815730595, 6198.163247961467, 6211.782587609412, 6045.425684559959, 6233.407826256498, 6293.527985401021, 6329.240491141092, 6341.0, 5260.0, 5873.888278205359, 6015.428534289235, 6020.939790602038, 6150.538709596887], "value": 4671.939256308949, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.4983861458364, 843.670968322354, 844.8014716541612, 847.0682249525522, 856.4732689396019, 13002.674933126676, 15541.611459713513, 17854.28582856686, 18065.45803625892, 18192.27230910762, 16655.417060402888, 16881.83118168818, 16887.746683799753, 16905.40831070913, 17255.396061137864, 950.719537736366, 961.7162936933604, 962.8555716642489, 968.9806203875918, 992.6426486464867, 946.9678050924491, 948.2935213266092, 950.4059962523423, 950.4487397309543, 1003.4079892863209, 1013.8023085498331, 1015.4262841494569, 1015.735908663749, 1016.2175125153627, 1035.4874337203057, 1011.1203253169716, 1012.9240306976933, 1012.9696109116665, 1013.8225810483136, 1033.2095946600818, 747.1072068877693, 748.6032402826511, 750.4446709435033, 755.5466719967975, 768.0514564512822, 16367.836321636869, 16496.34014639413, 16663.416780412626, 16959.067251301174, 17117.828821711748, 14618.195999220039, 16727.247273872585, 16754.162291885357, 16927.49217523476, 17190.570235744082, 13887.375068121857, 13999.370028348749, 14012.089214201147, 14030.017898747092, 14196.929015354857, 3536.6286539913194, 3558.8220588970707, 3562.4834399012257, 3563.4476656118345, 3565.554305711786, 123840.38079809633, 123991.0, 126175.0, 126320.0, 129009.0, 12932.159409638532, 12961.351932403531, 12979.156354836905, 13103.541376051793, 13111.2133272004, 25029.749702503104, 25215.243542693748, 25507.744922550908, 25876.741232587432, 25940.0, 7639.69441222356, 7702.691892324357, 7724.343430808444, 7751.0, 7855.84288314242, 3841.078141246081, 3877.6703980162, 3912.9021774455296, 3913.8630147944687, 3915.9216815663526, 4201.894952626148, 4228.492580890313, 4287.785610719514, 4329.76186309756, 4346.434963454731, 856.9400141990126, 908.6960212095664, 950.2065775077749, 956.8134213828237, 957.7988622389237, 635.3805040085879, 656.8587753632896, 659.1760299625469, 660.4848218389664, 687.9552829066095, 10857.565697372174, 11373.431328433546, 11619.244749091282, 11936.940315298369, 12118.81821772674, 606.2391698418456, 653.1541653558653, 653.5784419049781, 665.04565947864, 673.2056173714965, 4540.591346778806, 5432.674039557639, 5434.3207099112615, 5563.805266815642, 5666.858328541737, 92028.53985730163, 96723.51638241904, 98238.0, 98587.50706246422, 99804.00195997948, 90753.0, 91722.0, 91997.0, 92365.0, 94412.63968400845, 54734.49684366856, 71068.93396598952, 82533.58733206296, 84702.72945905816, 86279.56860215659, 11460.426978651201, 12298.508059677513, 12388.380580971096, 12425.13024088305, 12571.18287311322, 37144.628553714116, 37268.06829829276, 37668.81165594154, 37891.62108378881, 38125.80937095297, 45717.771411142734, 45990.540094598626, 46116.53883461122, 46226.306605401616, 46955.76522117504, 13800.0, 15755.212239388215, 15761.605959851095, 16011.439599613957, 16098.436554720529, 17720.822791771916, 17729.822701772817, 17860.732089018416, 18244.81755182431, 18268.26926922908, 13057.673558161123, 16355.836441635907, 16387.0, 16481.917590411973, 16674.83325166733, 16304.021758694516, 16446.67106657884, 16492.587685307964, 16497.752533712242, 16635.334586616398, 15784.92107539455, 15980.280887359864, 16186.514404567883, 16277.918610406872, 16283.430079947146, 11341.4896329667, 11368.31790092564, 11696.94151529271, 12002.339871306813, 12083.033357331216, 12183.390830458618, 12238.694032649255, 12804.167729097579, 12817.743645127232, 13036.47854085826], "value": 8189.822867118979, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1437.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 111.0, 112.0, 113.0, 111.0, 112.0, 112.0, 112.0, 112.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 108.0, 104.0, 148.0, 96.0, 104.0, 129.0, 134.0, 153.0, 110.0], "value": 122.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 186.0, 187.0, 186.0, 186.0, 185.0, 184.0, 182.0, 184.0], "value": 184.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 57.0, 60.0, 88.0, 60.0, 57.0, 57.0, 57.0, 80.0, 58.0], "value": 65.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 94.0, 113.0, 99.0, 96.0, 69.0, 88.0, 69.0, 70.0, 91.0], "value": 87.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 93.0, 89.0, 94.0, 87.0, 95.0, 92.0, 93.0, 94.0, 88.0], "value": 91.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 99.0, 97.0, 96.0, 95.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 110.0, 134.0, 116.0, 85.0, 84.0, 88.0, 86.0, 84.0, 83.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 49.0, 47.0, 48.0, 49.0, 49.0, 49.0, 49.0, 50.0, 48.0], "value": 48.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 64.0, 60.0, 65.0, 59.0, 58.0, 57.0, 57.0, 58.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 81.0, 84.0, 83.0, 83.0, 83.0, 80.0, 81.0, 80.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 136.0, 135.0, 138.0, 132.0, 137.0, 142.0, 149.0, 177.0, 150.0], "value": 143.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 188.0, 183.0, 186.0, 178.0, 172.0, 184.0, 185.0, 182.0, 184.0], "value": 181.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 67.0, 67.0, 69.0, 68.0, 67.0, 68.0, 65.0, 69.0], "value": 67.9, "unit": "score"}]}]} 03:21:43 INFO - Return code: 0 03:21:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:21:43 ERROR - # TBPL SUCCESS # 03:21:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:21:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:21:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:21:43 INFO - 2017-04-21 03:21:43.831 screenresolution[1656:9795] starting screenresolution argv=screenresolution get 03:21:43 INFO - 2017-04-21 03:21:43.833 screenresolution[1656:9795] Display 0: 1600x1200x32@60 03:21:43 INFO - 2017-04-21 03:21:43.840 screenresolution[1657:9798] starting screenresolution argv=screenresolution list 03:21:43 INFO - Available Modes on Display 0 03:21:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:21:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:21:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:21:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:21:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:21:44 INFO - Intel Iris: 03:21:44 INFO - Chipset Model: Intel Iris 03:21:44 INFO - Type: GPU 03:21:44 INFO - Bus: Built-In 03:21:44 INFO - VRAM (Dynamic, Max): 1536 MB 03:21:44 INFO - Vendor: Intel (0x8086) 03:21:44 INFO - Device ID: 0x0a2e 03:21:44 INFO - Revision ID: 0x0009 03:21:44 INFO - Displays: 03:21:44 INFO - Display: 03:21:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:21:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:21:44 INFO - Display Serial Number: 1600x1200 60 03:21:44 INFO - Main Display: Yes 03:21:44 INFO - Mirror: Off 03:21:44 INFO - Online: Yes 03:21:44 INFO - Rotation: Supported 03:21:44 INFO - Return code: 0 03:21:44 INFO - Running post-action listener: _resource_record_post_action 03:21:44 INFO - [mozharness: 2017-04-21 10:21:44.087997Z] Finished run-tests step (success) 03:21:44 INFO - Running post-run listener: _resource_record_post_run 03:21:44 INFO - Total resource usage - Wall time: 1199s; CPU: 53.0%; Read bytes: 39785472; Write bytes: 511124480; Read time: 389; Write time: 1950 03:21:44 INFO - TinderboxPrint: CPU usage
53.4% 03:21:44 INFO - TinderboxPrint: I/O read bytes / time
39,785,472 / 389 03:21:44 INFO - TinderboxPrint: I/O write bytes / time
511,124,480 / 1,950 03:21:44 INFO - TinderboxPrint: CPU idle
2,237.2 (46.6%) 03:21:44 INFO - TinderboxPrint: CPU system
957.2 (20.0%) 03:21:44 INFO - TinderboxPrint: CPU user
1,603.3 (33.4%) 03:21:44 INFO - TinderboxPrint: Swap in / out
246,722,560 / 0 03:21:44 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 209218048; Write bytes: 211367936; Read time: 15907; Write time: 635 03:21:44 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 34878464; Write bytes: 298167296; Read time: 355; Write time: 1310 03:21:44 INFO - Running post-run listener: _upload_blobber_files 03:21:44 INFO - Blob upload gear active. 03:21:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:21:44 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 03:21:44 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'] 03:21:44 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 03:21:44 INFO - (blobuploader) - INFO - Open directory for files ... 03:21:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:21:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:21:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:45 INFO - (blobuploader) - INFO - Done attempting. 03:21:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:21:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:21:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:46 INFO - (blobuploader) - INFO - Done attempting. 03:21:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:21:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:21:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:47 INFO - (blobuploader) - INFO - Done attempting. 03:21:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:21:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:21:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:50 INFO - (blobuploader) - INFO - Done attempting. 03:21:50 INFO - (blobuploader) - INFO - Iteration through files over. 03:21:50 INFO - Return code: 0 03:21:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:21:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:21:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/015fce9790bbde956cfdd4ebc416d69277638bbc1735cd4723c259a3a668bdfca0a7b4a70fb15557084d06b42c2d947f88ddd81a4bcf6e0fc0076931aced4b37", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30150d45a68a991f604a0c6e05b0f6db212d12697577439fc6cffc9c1e6fe023206b4442d853c7a3b79571e7ff040cebb3f3d423b11b9f17a23633185c42a7be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5bdb8b1487f5dbc1eeb3710daee1353105853623c196f7affa09fa11ff7b8564b831be507b99d3dbda470c9193b0afd609fcda4818b7e650a362bf2194ddd711", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b10319b3aff10636b4f61804b1f1f25c9d2563f3effa80e5575a99384ff1d528efda17256f8e6e6bdd3a53c95cabff6124abea8883a7f05373a4483561b43887"} 03:21:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:21:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:21:50 INFO - Contents: 03:21:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/015fce9790bbde956cfdd4ebc416d69277638bbc1735cd4723c259a3a668bdfca0a7b4a70fb15557084d06b42c2d947f88ddd81a4bcf6e0fc0076931aced4b37", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30150d45a68a991f604a0c6e05b0f6db212d12697577439fc6cffc9c1e6fe023206b4442d853c7a3b79571e7ff040cebb3f3d423b11b9f17a23633185c42a7be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5bdb8b1487f5dbc1eeb3710daee1353105853623c196f7affa09fa11ff7b8564b831be507b99d3dbda470c9193b0afd609fcda4818b7e650a362bf2194ddd711", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b10319b3aff10636b4f61804b1f1f25c9d2563f3effa80e5575a99384ff1d528efda17256f8e6e6bdd3a53c95cabff6124abea8883a7f05373a4483561b43887"} 03:21:50 INFO - Running post-run listener: copy_logs_to_upload_dir 03:21:50 INFO - Copying logs to upload dir... 03:21:50 INFO - mkdir: /builds/slave/test/build/upload/logs 03:21:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.648497 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-21 03:21:50.035236) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-21 03:21:50.039119) ========= 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.zK7hiI3d42/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.eHuK1B7Kh4/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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/015fce9790bbde956cfdd4ebc416d69277638bbc1735cd4723c259a3a668bdfca0a7b4a70fb15557084d06b42c2d947f88ddd81a4bcf6e0fc0076931aced4b37", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30150d45a68a991f604a0c6e05b0f6db212d12697577439fc6cffc9c1e6fe023206b4442d853c7a3b79571e7ff040cebb3f3d423b11b9f17a23633185c42a7be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5bdb8b1487f5dbc1eeb3710daee1353105853623c196f7affa09fa11ff7b8564b831be507b99d3dbda470c9193b0afd609fcda4818b7e650a362bf2194ddd711", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b10319b3aff10636b4f61804b1f1f25c9d2563f3effa80e5575a99384ff1d528efda17256f8e6e6bdd3a53c95cabff6124abea8883a7f05373a4483561b43887"} build_url:https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011254 build_url: 'https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/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/015fce9790bbde956cfdd4ebc416d69277638bbc1735cd4723c259a3a668bdfca0a7b4a70fb15557084d06b42c2d947f88ddd81a4bcf6e0fc0076931aced4b37", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30150d45a68a991f604a0c6e05b0f6db212d12697577439fc6cffc9c1e6fe023206b4442d853c7a3b79571e7ff040cebb3f3d423b11b9f17a23633185c42a7be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5bdb8b1487f5dbc1eeb3710daee1353105853623c196f7affa09fa11ff7b8564b831be507b99d3dbda470c9193b0afd609fcda4818b7e650a362bf2194ddd711", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b10319b3aff10636b4f61804b1f1f25c9d2563f3effa80e5575a99384ff1d528efda17256f8e6e6bdd3a53c95cabff6124abea8883a7f05373a4483561b43887"}' ========= master_lag: 0.74 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-21 03:21:50.785946) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 03:21:50.786265) ========= 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.zK7hiI3d42/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.eHuK1B7Kh4/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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.005736 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 03:21:50.836651) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-21 03:21:50.836969) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-21 03:21:50.837282) ========= ========= Total master_lag: 0.87 =========