builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0274 starttime: 1491280520.61 results: success (0) buildid: 20170403201427 builduid: a7901a05b0584ec59e4784f8c4895bc7 revision: 8b38e90b2ec58005e0e2ee08ec46c61a5bd3f166 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-03 21:35:20.608575) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-03 21:35:20.609049) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-03 21:35:20.609344) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-03 21:35:20.635807) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 21:35:20.636182) ========= 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.V7LUAIbDkw/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.qFuSKi4fvN/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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-03 21:35:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.8M=0.001s 2017-04-03 21:35:20 (16.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.144923 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 21:35:20.804769) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 21:35:20.805105) ========= 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.V7LUAIbDkw/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.qFuSKi4fvN/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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.026160 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 21:35:20.853267) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 21:35:20.853624) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8b38e90b2ec58005e0e2ee08ec46c61a5bd3f166 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8b38e90b2ec58005e0e2ee08ec46c61a5bd3f166 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.V7LUAIbDkw/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.qFuSKi4fvN/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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-03 21:35:20,968 truncating revision to first 12 chars 2017-04-03 21:35:20,968 Setting DEBUG logging. 2017-04-03 21:35:20,968 attempt 1/10 2017-04-03 21:35:20,968 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/8b38e90b2ec5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-03 21:35:21,659 unpacking tar archive at: mozilla-beta-8b38e90b2ec5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.968318 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 21:35:21.845364) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-03 21:35:21.845718) ========= script_repo_revision: 8b38e90b2ec58005e0e2ee08ec46c61a5bd3f166 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-03 21:35:21.846134) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-03 21:35:21.846443) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-03 21:35:21.866203) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-04-03 21:35:21.866752) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.V7LUAIbDkw/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.qFuSKi4fvN/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 21:35:22 INFO - MultiFileLogger online at 20170403 21:35:22 in /builds/slave/test 21:35:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 21:35:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:35:22 INFO - {'append_to_log': False, 21:35:22 INFO - 'base_work_dir': '/builds/slave/test', 21:35:22 INFO - 'blob_upload_branch': 'Mozilla-Beta', 21:35:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:35:22 INFO - 'branch': 'Mozilla-Beta', 21:35:22 INFO - 'buildbot_json_path': 'buildprops.json', 21:35:22 INFO - 'config_files': ('talos/mac_config.py',), 21:35:22 INFO - 'default_actions': ('clobber', 21:35:22 INFO - 'read-buildbot-config', 21:35:22 INFO - 'download-and-extract', 21:35:22 INFO - 'populate-webroot', 21:35:22 INFO - 'create-virtualenv', 21:35:22 INFO - 'install', 21:35:22 INFO - 'run-tests'), 21:35:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:35:22 INFO - 'download_minidump_stackwalk': True, 21:35:22 INFO - 'download_symbols': 'ondemand', 21:35:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:35:22 INFO - 'tooltool.py': '/tools/tooltool.py', 21:35:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:35:22 INFO - '/tools/misc-python/virtualenv.py')}, 21:35:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:35:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:35:22 INFO - 'installer_path': 'installer.exe', 21:35:22 INFO - 'log_level': 'info', 21:35:22 INFO - 'log_name': 'talos', 21:35:22 INFO - 'log_to_console': True, 21:35:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:35:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:35:22 INFO - 'opt_config_files': (), 21:35:22 INFO - 'pip_index': False, 21:35:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:35:22 INFO - 'cmd': ('bash', 21:35:22 INFO - '-c', 21:35:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:35:22 INFO - 'enabled': True, 21:35:22 INFO - 'halt_on_failure': False, 21:35:22 INFO - 'name': 'check_screen_resolution'},), 21:35:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:35:22 INFO - 'cmd': ('bash', 21:35:22 INFO - '-c', 21:35:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:35:22 INFO - 'enabled': True, 21:35:22 INFO - 'halt_on_failure': False, 21:35:22 INFO - 'name': 'check_screen_resolution'},), 21:35:22 INFO - 'run_cmd_checks_enabled': True, 21:35:22 INFO - 'sps_profile': False, 21:35:22 INFO - 'sps_profile_interval': 0, 21:35:22 INFO - 'suite': 'dromaeojs', 21:35:22 INFO - 'system_bits': '32', 21:35:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:35:22 INFO - 'title': 't-yosemite-r7-0274', 21:35:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:35:22 INFO - 'use_talos_json': True, 21:35:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:35:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:35:22 INFO - 'work_dir': 'build'} 21:35:22 INFO - [mozharness: 2017-04-04 04:35:22.086471Z] Running clobber step. 21:35:22 INFO - Running pre-action listener: _resource_record_pre_action 21:35:22 INFO - Running main action method: clobber 21:35:22 INFO - rmtree: /builds/slave/test/build 21:35:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:35:24 INFO - Running post-action listener: _resource_record_post_action 21:35:24 INFO - [mozharness: 2017-04-04 04:35:24.555842Z] Finished clobber step (success) 21:35:24 INFO - [mozharness: 2017-04-04 04:35:24.555968Z] Running read-buildbot-config step. 21:35:24 INFO - Running pre-action listener: _resource_record_pre_action 21:35:24 INFO - Running main action method: read_buildbot_config 21:35:24 INFO - Using buildbot properties: 21:35:24 INFO - { 21:35:24 INFO - "project": "", 21:35:24 INFO - "product": "firefox", 21:35:24 INFO - "script_repo_revision": "production", 21:35:24 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 21:35:24 INFO - "repository": "", 21:35:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 21:35:24 INFO - "buildid": "20170403201427", 21:35:24 INFO - "pgo_build": "False", 21:35:24 INFO - "basedir": "/builds/slave/test", 21:35:24 INFO - "buildnumber": 11, 21:35:24 INFO - "slavename": "t-yosemite-r7-0274", 21:35:24 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 21:35:24 INFO - "platform": "yosemite_r7", 21:35:24 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 21:35:24 INFO - "branch": "mozilla-beta", 21:35:24 INFO - "repo_path": "releases/mozilla-beta", 21:35:24 INFO - "revision": "8b38e90b2ec58005e0e2ee08ec46c61a5bd3f166", 21:35:24 INFO - "stage_platform": "macosx64", 21:35:24 INFO - "builduid": "a7901a05b0584ec59e4784f8c4895bc7", 21:35:24 INFO - "slavebuilddir": "test" 21:35:24 INFO - } 21:35:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/fY_qVQOBRyKsiozn9Kt5Fw/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 21:35:24 INFO - Running post-action listener: _resource_record_post_action 21:35:24 INFO - [mozharness: 2017-04-04 04:35:24.559196Z] Finished read-buildbot-config step (success) 21:35:24 INFO - [mozharness: 2017-04-04 04:35:24.559324Z] Running download-and-extract step. 21:35:24 INFO - Running pre-action listener: _resource_record_pre_action 21:35:24 INFO - Running main action method: download_and_extract 21:35:24 INFO - mkdir: /builds/slave/test/build/tests 21:35:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:24 INFO - trying https://queue.taskcluster.net/v1/task/fY_qVQOBRyKsiozn9Kt5Fw/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 21:35:24 INFO - Downloading https://queue.taskcluster.net/v1/task/fY_qVQOBRyKsiozn9Kt5Fw/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 21:35:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fY_qVQOBRyKsiozn9Kt5Fw/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 21:35:25 INFO - Downloaded 1165 bytes. 21:35:25 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 21:35:25 INFO - Using the following test package requirements: 21:35:25 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 21:35:25 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 21:35:25 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 21:35:25 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 21:35:25 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 21:35:25 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 21:35:25 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 21:35:25 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 21:35:25 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 21:35:25 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 21:35:25 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 21:35:25 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 21:35:25 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 21:35:25 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 21:35:25 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 21:35:25 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 21:35:25 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 21:35:25 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 21:35:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fY_qVQOBRyKsiozn9Kt5Fw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 21:35:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fY_qVQOBRyKsiozn9Kt5Fw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 21:35:25 INFO - Fetch https://queue.taskcluster.net/v1/task/fY_qVQOBRyKsiozn9Kt5Fw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 21:35:26 INFO - Expected file size: 16115108 21:35:26 INFO - Obtained file size: 16115108 21:35:33 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 21:35:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fY_qVQOBRyKsiozn9Kt5Fw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 21:35:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fY_qVQOBRyKsiozn9Kt5Fw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 21:35:33 INFO - Fetch https://queue.taskcluster.net/v1/task/fY_qVQOBRyKsiozn9Kt5Fw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 21:35:34 INFO - Expected file size: 16115108 21:35:34 INFO - Obtained file size: 16115108 21:35:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fY_qVQOBRyKsiozn9Kt5Fw/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 21:35:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fY_qVQOBRyKsiozn9Kt5Fw/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 21:35:40 INFO - Fetch https://queue.taskcluster.net/v1/task/fY_qVQOBRyKsiozn9Kt5Fw/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 21:35:41 INFO - Expected file size: 14403663 21:35:41 INFO - Obtained file size: 14403663 21:35:42 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')]} 21:35:42 INFO - trying https://queue.taskcluster.net/v1/task/fY_qVQOBRyKsiozn9Kt5Fw/artifacts/public/build/firefox-53.0.en-US.mac.dmg 21:35:42 INFO - Downloading https://queue.taskcluster.net/v1/task/fY_qVQOBRyKsiozn9Kt5Fw/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 21:35:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fY_qVQOBRyKsiozn9Kt5Fw/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 21:35:43 INFO - Downloaded 58724939 bytes. 21:35:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fY_qVQOBRyKsiozn9Kt5Fw/artifacts/public/build/firefox-53.0.en-US.mac.dmg 21:35:43 INFO - mkdir: /builds/slave/test/properties 21:35:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:35:43 INFO - Writing to file /builds/slave/test/properties/build_url 21:35:43 INFO - Contents: 21:35:43 INFO - build_url:https://queue.taskcluster.net/v1/task/fY_qVQOBRyKsiozn9Kt5Fw/artifacts/public/build/firefox-53.0.en-US.mac.dmg 21:35:44 INFO - Running post-action listener: _resource_record_post_action 21:35:44 INFO - Running post-action listener: set_extra_try_arguments 21:35:44 INFO - [mozharness: 2017-04-04 04:35:44.453944Z] Finished download-and-extract step (success) 21:35:44 INFO - [mozharness: 2017-04-04 04:35:44.454077Z] Running populate-webroot step. 21:35:44 INFO - Running pre-action listener: _resource_record_pre_action 21:35:44 INFO - Running main action method: populate_webroot 21:35:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:35:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:35:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:35:44 INFO - '--tppagecycles', 21:35:44 INFO - '7'], 21:35:44 INFO - 'tests': ['tsvgm']}}, 21:35:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:35:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:35:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:35:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:35:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:35:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:35:44 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:35:44 INFO - 'talos_options': ['--disable-e10s'], 21:35:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:35:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:35:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:35:44 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:35:44 INFO - 'talos_options': ['--disable-e10s'], 21:35:44 INFO - 'tests': ['damp', 'tps']}, 21:35:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:35:44 INFO - 'tests': ['damp', 'tps']}, 21:35:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:35:44 INFO - 'tests': ['dromaeo_dom']}, 21:35:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:35:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:35:44 INFO - 'tests': ['basic_compositor_video']}, 21:35:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:35:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:35:44 INFO - 'tests': ['a11yr', 21:35:44 INFO - 'ts_paint', 21:35:44 INFO - 'tpaint', 21:35:44 INFO - 'sessionrestore', 21:35:44 INFO - 'sessionrestore_no_auto_restore', 21:35:44 INFO - 'tabpaint']}, 21:35:44 INFO - 'other-e10s': {'tests': ['a11yr', 21:35:44 INFO - 'ts_paint', 21:35:44 INFO - 'tpaint', 21:35:44 INFO - 'sessionrestore', 21:35:44 INFO - 'sessionrestore_no_auto_restore', 21:35:44 INFO - 'tabpaint']}, 21:35:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:35:44 INFO - 'ts_paint', 21:35:44 INFO - 'tpaint', 21:35:44 INFO - 'sessionrestore', 21:35:44 INFO - 'sessionrestore_no_auto_restore', 21:35:44 INFO - 'tabpaint']}, 21:35:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:35:44 INFO - 'ts_paint', 21:35:44 INFO - 'tpaint', 21:35:44 INFO - 'sessionrestore', 21:35:44 INFO - 'sessionrestore_no_auto_restore', 21:35:44 INFO - 'tabpaint']}, 21:35:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:35:44 INFO - 'tests': ['a11yr', 21:35:44 INFO - 'ts_paint', 21:35:44 INFO - 'tpaint', 21:35:44 INFO - 'sessionrestore', 21:35:44 INFO - 'sessionrestore_no_auto_restore', 21:35:44 INFO - 'tabpaint']}, 21:35:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:35:44 INFO - 'tests': ['a11yr', 21:35:44 INFO - 'ts_paint', 21:35:44 INFO - 'tpaint', 21:35:44 INFO - 'sessionrestore', 21:35:44 INFO - 'sessionrestore_no_auto_restore', 21:35:44 INFO - 'tabpaint']}, 21:35:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:35:44 INFO - 'tests': ['tsvgx', 21:35:44 INFO - 'tsvgr_opacity', 21:35:44 INFO - 'tart', 21:35:44 INFO - 'tscrollx', 21:35:44 INFO - 'cart', 21:35:44 INFO - 'tsvg_static']}, 21:35:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:35:44 INFO - 'tsvgr_opacity', 21:35:44 INFO - 'tart', 21:35:44 INFO - 'tscrollx', 21:35:44 INFO - 'cart', 21:35:44 INFO - 'tsvg_static']}, 21:35:44 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:35:44 INFO - 'talos_options': ['--disable-e10s'], 21:35:44 INFO - 'tests': ['tp5o']}, 21:35:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:35:44 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:35:44 INFO - 'talos_options': ['--disable-e10s', 21:35:44 INFO - '--xperf_path', 21:35:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:35:44 INFO - 'tests': ['tp5n']}, 21:35:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:35:44 INFO - 'talos_options': ['--xperf_path', 21:35:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:35:44 INFO - 'tests': ['tp5n']}}, 21:35:44 INFO - 'talos.zip': {'path': '', 21:35:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:35:44 INFO - Running post-action listener: _resource_record_post_action 21:35:44 INFO - [mozharness: 2017-04-04 04:35:44.473049Z] Finished populate-webroot step (success) 21:35:44 INFO - [mozharness: 2017-04-04 04:35:44.473180Z] Running create-virtualenv step. 21:35:44 INFO - Running pre-action listener: _resource_record_pre_action 21:35:44 INFO - Running main action method: create_virtualenv 21:35:44 INFO - Creating virtualenv /builds/slave/test/build/venv 21:35:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:35:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:35:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:35:44 INFO - Using real prefix '/tools/python27' 21:35:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:35:45 INFO - Installing distribute.............................................................................................................................................................................................done. 21:35:48 INFO - Installing pip.................done. 21:35:48 INFO - Return code: 0 21:35:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:35:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:35:48 INFO - Reading from file tmpfile_stdout 21:35:48 INFO - Output received: 21:35:48 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 21:35:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f6efb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6f2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86a1d89370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4cdd30>, '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 0x10f3f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4c2be8>, '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.V7LUAIbDkw/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.qFuSKi4fvN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 21:35:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:35:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:35:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V7LUAIbDkw/Render', 21:35:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:35:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:35:48 INFO - 'HOME': '/Users/cltbld', 21:35:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:35:48 INFO - 'LOGNAME': 'cltbld', 21:35:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:48 INFO - 'MOZ_NO_REMOTE': '1', 21:35:48 INFO - 'NO_EM_RESTART': '1', 21:35:48 INFO - 'PAGER': '/bin/cat', 21:35:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:35:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:48 INFO - 'PWD': '/builds/slave/test', 21:35:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:35:48 INFO - 'SHELL': '/bin/bash', 21:35:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qFuSKi4fvN/Listeners', 21:35:48 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 21:35:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:35:48 INFO - 'USER': 'cltbld', 21:35:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:35:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:35:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:48 INFO - 'XPC_FLAGS': '0x0', 21:35:48 INFO - 'XPC_SERVICE_NAME': '0', 21:35:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:35:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:35:48 INFO - Cleaning up... 21:35:48 INFO - Return code: 0 21:35:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f6efb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6f2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86a1d89370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4cdd30>, '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 0x10f3f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4c2be8>, '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.V7LUAIbDkw/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.qFuSKi4fvN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 21:35:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:35:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:35:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V7LUAIbDkw/Render', 21:35:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:35:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:35:48 INFO - 'HOME': '/Users/cltbld', 21:35:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:35:48 INFO - 'LOGNAME': 'cltbld', 21:35:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:48 INFO - 'MOZ_NO_REMOTE': '1', 21:35:48 INFO - 'NO_EM_RESTART': '1', 21:35:48 INFO - 'PAGER': '/bin/cat', 21:35:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:35:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:48 INFO - 'PWD': '/builds/slave/test', 21:35:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:35:48 INFO - 'SHELL': '/bin/bash', 21:35:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qFuSKi4fvN/Listeners', 21:35:48 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 21:35:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:35:48 INFO - 'USER': 'cltbld', 21:35:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:35:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:35:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:48 INFO - 'XPC_FLAGS': '0x0', 21:35:48 INFO - 'XPC_SERVICE_NAME': '0', 21:35:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:35:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:49 INFO - Downloading/unpacking psutil>=3.1.1 21:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:35:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:35:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:35:52 INFO - Installing collected packages: psutil 21:35:52 INFO - Running setup.py install for psutil 21:35:52 INFO - building 'psutil._psutil_osx' extension 21:35:52 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 21:35:53 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 21:35:53 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 21:35:53 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 21:35:53 INFO - building 'psutil._psutil_posix' extension 21:35:53 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 21:35:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:35:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:35:53 INFO - ^ 21:35:53 INFO - 1 warning generated. 21:35:53 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 21:35:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:35:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:35:53 INFO - Successfully installed psutil 21:35:53 INFO - Cleaning up... 21:35:53 INFO - Return code: 0 21:35:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:35:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f6efb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6f2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86a1d89370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4cdd30>, '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 0x10f3f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4c2be8>, '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.V7LUAIbDkw/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.qFuSKi4fvN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 21:35:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:35:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:35:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V7LUAIbDkw/Render', 21:35:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:35:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:35:53 INFO - 'HOME': '/Users/cltbld', 21:35:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:35:53 INFO - 'LOGNAME': 'cltbld', 21:35:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:53 INFO - 'MOZ_NO_REMOTE': '1', 21:35:53 INFO - 'NO_EM_RESTART': '1', 21:35:53 INFO - 'PAGER': '/bin/cat', 21:35:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:35:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:53 INFO - 'PWD': '/builds/slave/test', 21:35:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:35:53 INFO - 'SHELL': '/bin/bash', 21:35:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qFuSKi4fvN/Listeners', 21:35:53 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 21:35:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:35:53 INFO - 'USER': 'cltbld', 21:35:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:35:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:35:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:53 INFO - 'XPC_FLAGS': '0x0', 21:35:53 INFO - 'XPC_SERVICE_NAME': '0', 21:35:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:35:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:35:54 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 21:35:54 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 21:35:54 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 21:35:54 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 21:35:54 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 21:35:54 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 21:35:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:35:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:35:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:35:56 INFO - Installing collected packages: mozsystemmonitor 21:35:56 INFO - Running setup.py install for mozsystemmonitor 21:35:57 INFO - Successfully installed mozsystemmonitor 21:35:57 INFO - Cleaning up... 21:35:57 INFO - Return code: 0 21:35:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:35:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f6efb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6f2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86a1d89370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4cdd30>, '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 0x10f3f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4c2be8>, '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.V7LUAIbDkw/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.qFuSKi4fvN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 21:35:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:35:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:35:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V7LUAIbDkw/Render', 21:35:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:35:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:35:57 INFO - 'HOME': '/Users/cltbld', 21:35:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:35:57 INFO - 'LOGNAME': 'cltbld', 21:35:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:57 INFO - 'MOZ_NO_REMOTE': '1', 21:35:57 INFO - 'NO_EM_RESTART': '1', 21:35:57 INFO - 'PAGER': '/bin/cat', 21:35:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:35:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:57 INFO - 'PWD': '/builds/slave/test', 21:35:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:35:57 INFO - 'SHELL': '/bin/bash', 21:35:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qFuSKi4fvN/Listeners', 21:35:57 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 21:35:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:35:57 INFO - 'USER': 'cltbld', 21:35:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:35:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:35:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:57 INFO - 'XPC_FLAGS': '0x0', 21:35:57 INFO - 'XPC_SERVICE_NAME': '0', 21:35:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:35:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:57 INFO - Downloading/unpacking jsonschema==2.5.1 21:35:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:35:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:36:00 INFO - Downloading functools32-3.2.3-2.tar.gz 21:36:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:36:00 INFO - warning: no files found matching '*.txt' 21:36:00 INFO - no previously-included directories found matching 'build' 21:36:00 INFO - no previously-included directories found matching 'dist' 21:36:00 INFO - no previously-included directories found matching '.git*' 21:36:00 INFO - Installing collected packages: jsonschema, functools32 21:36:00 INFO - Running setup.py install for functools32 21:36:00 INFO - warning: no files found matching '*.txt' 21:36:00 INFO - no previously-included directories found matching 'build' 21:36:00 INFO - no previously-included directories found matching 'dist' 21:36:00 INFO - no previously-included directories found matching '.git*' 21:36:00 INFO - Successfully installed jsonschema functools32 21:36:00 INFO - Cleaning up... 21:36:00 INFO - Return code: 0 21:36:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:36:00 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')]} 21:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:36:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:00 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')]} 21:36:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:36:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:00 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 0x10f6efb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6f2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86a1d89370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4cdd30>, '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 0x10f3f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4c2be8>, '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.V7LUAIbDkw/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.qFuSKi4fvN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 21:36:00 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 21:36:00 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 21:36:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V7LUAIbDkw/Render', 21:36:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:36:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:36:00 INFO - 'HOME': '/Users/cltbld', 21:36:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:36:00 INFO - 'LOGNAME': 'cltbld', 21:36:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:36:00 INFO - 'MOZ_NO_REMOTE': '1', 21:36:00 INFO - 'NO_EM_RESTART': '1', 21:36:00 INFO - 'PAGER': '/bin/cat', 21:36:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:36:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:36:00 INFO - 'PWD': '/builds/slave/test', 21:36:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:36:00 INFO - 'SHELL': '/bin/bash', 21:36:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qFuSKi4fvN/Listeners', 21:36:00 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 21:36:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:36:00 INFO - 'USER': 'cltbld', 21:36:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:36:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:36:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:36:00 INFO - 'XPC_FLAGS': '0x0', 21:36:00 INFO - 'XPC_SERVICE_NAME': '0', 21:36:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:36:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:36:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:36:01 INFO - Cleaning up... 21:36:01 INFO - Return code: 0 21:36:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:36:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:36:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:36:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:01 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 0x10f6efb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6f2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86a1d89370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4cdd30>, '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 0x10f3f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4c2be8>, '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.V7LUAIbDkw/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.qFuSKi4fvN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 21:36:01 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 21:36:01 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 21:36:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V7LUAIbDkw/Render', 21:36:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:36:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:36:01 INFO - 'HOME': '/Users/cltbld', 21:36:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:36:01 INFO - 'LOGNAME': 'cltbld', 21:36:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:36:01 INFO - 'MOZ_NO_REMOTE': '1', 21:36:01 INFO - 'NO_EM_RESTART': '1', 21:36:01 INFO - 'PAGER': '/bin/cat', 21:36:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:36:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:36:01 INFO - 'PWD': '/builds/slave/test', 21:36:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:36:01 INFO - 'SHELL': '/bin/bash', 21:36:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qFuSKi4fvN/Listeners', 21:36:01 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 21:36:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:36:01 INFO - 'USER': 'cltbld', 21:36:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:36:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:36:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:36:01 INFO - 'XPC_FLAGS': '0x0', 21:36:01 INFO - 'XPC_SERVICE_NAME': '0', 21:36:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:36:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:36:01 INFO - Downloading/unpacking blobuploader==1.2.4 21:36:01 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 21:36:01 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 21:36:01 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 21:36:01 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 21:36:01 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 21:36:01 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 21:36:03 INFO - Downloading blobuploader-1.2.4.tar.gz 21:36:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:36:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:36:04 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 21:36:04 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 21:36:04 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 21:36:04 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 21:36:04 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 21:36:04 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 21:36:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:36:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:36:04 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 21:36:04 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 21:36:04 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 21:36:04 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 21:36:04 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 21:36:04 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 21:36:05 INFO - Downloading docopt-0.6.1.tar.gz 21:36:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:36:05 INFO - Installing collected packages: blobuploader, requests, docopt 21:36:05 INFO - Running setup.py install for blobuploader 21:36:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:36:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:36:05 INFO - Running setup.py install for requests 21:36:05 INFO - Running setup.py install for docopt 21:36:06 INFO - Successfully installed blobuploader requests docopt 21:36:06 INFO - Cleaning up... 21:36:06 INFO - Return code: 0 21:36:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:36:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:36:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:06 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 0x10f6efb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6f2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86a1d89370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4cdd30>, '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 0x10f3f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4c2be8>, '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.V7LUAIbDkw/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.qFuSKi4fvN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 21:36:06 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 21:36:06 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 21:36:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V7LUAIbDkw/Render', 21:36:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:36:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:36:06 INFO - 'HOME': '/Users/cltbld', 21:36:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:36:06 INFO - 'LOGNAME': 'cltbld', 21:36:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:36:06 INFO - 'MOZ_NO_REMOTE': '1', 21:36:06 INFO - 'NO_EM_RESTART': '1', 21:36:06 INFO - 'PAGER': '/bin/cat', 21:36:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:36:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:36:06 INFO - 'PWD': '/builds/slave/test', 21:36:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:36:06 INFO - 'SHELL': '/bin/bash', 21:36:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qFuSKi4fvN/Listeners', 21:36:06 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 21:36:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:36:06 INFO - 'USER': 'cltbld', 21:36:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:36:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:36:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:36:06 INFO - 'XPC_FLAGS': '0x0', 21:36:06 INFO - 'XPC_SERVICE_NAME': '0', 21:36:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:36:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:36:06 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-zdHNZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:36:06 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-Mok9c8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:36:06 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-F_lpNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:36:06 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-lTK8AG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:36:06 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-bZ16jM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:36:06 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-y1JPck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:36:07 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-3sRKyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:36:07 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-p6lC92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:36:07 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-qawmLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:36:07 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-V3Lmw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:36:07 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-jTzttn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:36:07 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-e1QuVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:36:07 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-pWtKPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:36:07 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-BRc2i_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:36:07 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-AxEUcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:36:07 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-s_gg9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:36:08 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-F3G_Zc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:36:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:36:08 INFO - Running setup.py install for manifestparser 21:36:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:36:08 INFO - Running setup.py install for mozcrash 21:36:08 INFO - Running setup.py install for mozdebug 21:36:08 INFO - Running setup.py install for mozdevice 21:36:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:36:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:36:08 INFO - Running setup.py install for mozfile 21:36:08 INFO - Running setup.py install for mozhttpd 21:36:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:36:09 INFO - Running setup.py install for mozinfo 21:36:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:36:09 INFO - Running setup.py install for mozInstall 21:36:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:36:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:36:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:36:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:36:09 INFO - Running setup.py install for mozleak 21:36:09 INFO - Running setup.py install for mozlog 21:36:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:36:09 INFO - Running setup.py install for moznetwork 21:36:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:36:09 INFO - Running setup.py install for mozprocess 21:36:09 INFO - Running setup.py install for mozprofile 21:36:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:36:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:36:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:36:10 INFO - Running setup.py install for mozrunner 21:36:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:36:10 INFO - Running setup.py install for mozscreenshot 21:36:10 INFO - Running setup.py install for moztest 21:36:10 INFO - Running setup.py install for mozversion 21:36:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:36:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:36:10 INFO - Cleaning up... 21:36:10 INFO - Return code: 0 21:36:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:36:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:36:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:36:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:10 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 0x10f6efb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6f2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86a1d89370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4cdd30>, '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 0x10f3f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4c2be8>, '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.V7LUAIbDkw/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.qFuSKi4fvN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 21:36:10 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 21:36:10 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 21:36:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V7LUAIbDkw/Render', 21:36:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:36:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:36:10 INFO - 'HOME': '/Users/cltbld', 21:36:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:36:10 INFO - 'LOGNAME': 'cltbld', 21:36:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:36:10 INFO - 'MOZ_NO_REMOTE': '1', 21:36:10 INFO - 'NO_EM_RESTART': '1', 21:36:10 INFO - 'PAGER': '/bin/cat', 21:36:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:36:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:36:10 INFO - 'PWD': '/builds/slave/test', 21:36:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:36:10 INFO - 'SHELL': '/bin/bash', 21:36:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qFuSKi4fvN/Listeners', 21:36:10 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 21:36:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:36:10 INFO - 'USER': 'cltbld', 21:36:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:36:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:36:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:36:10 INFO - 'XPC_FLAGS': '0x0', 21:36:10 INFO - 'XPC_SERVICE_NAME': '0', 21:36:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:36:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:36:11 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-9A9rBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:36:11 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)) 21:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:36:11 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-_Jixrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:36:11 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)) 21:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:36:11 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-oho7PF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:36:11 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)) 21:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:36:11 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-DTKjq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:36:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:36:11 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-y407CW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:36:11 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)) 21:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:36:11 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-Pag8gZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:36:11 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)) 21:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:36:11 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-6sAgco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:36:11 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)) 21:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:36:11 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-90f9BY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:36:11 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)) 21:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:36:11 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-GmKodi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:36:11 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)) 21:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:36:11 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-gt2cCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:36:12 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)) 21:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:36:12 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-ActokI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:36:12 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)) 21:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:36:12 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-NG5iV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:36:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:36:12 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-ETZOpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:36:12 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)) 21:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:36:12 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-FaZR2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:36:12 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)) 21:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:36:12 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-EA9jAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:36:12 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)) 21:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:36:12 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-7LNXon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:36:12 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)) 21:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:36:12 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-K7AHrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:36:12 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)) 21:36:12 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)) 21:36:12 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)) 21:36:12 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)) 21:36:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:36:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:36:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:36:12 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 21:36:12 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 21:36:12 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 21:36:12 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 21:36:12 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 21:36:12 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 21:36:15 INFO - Downloading blessings-1.6.tar.gz 21:36:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:36:15 INFO - Installing collected packages: blessings 21:36:15 INFO - Running setup.py install for blessings 21:36:15 INFO - Successfully installed blessings 21:36:15 INFO - Cleaning up... 21:36:15 INFO - Return code: 0 21:36:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:36:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:36:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:36:16 INFO - Reading from file tmpfile_stdout 21:36:16 INFO - Current package versions: 21:36:16 INFO - blessings == 1.6 21:36:16 INFO - blobuploader == 1.2.4 21:36:16 INFO - docopt == 0.6.1 21:36:16 INFO - functools32 == 3.2.3-2 21:36:16 INFO - jsonschema == 2.5.1 21:36:16 INFO - manifestparser == 1.1 21:36:16 INFO - mozInstall == 1.12 21:36:16 INFO - mozcrash == 1.0 21:36:16 INFO - mozdebug == 0.1 21:36:16 INFO - mozdevice == 0.49 21:36:16 INFO - mozfile == 1.2 21:36:16 INFO - mozhttpd == 0.7 21:36:16 INFO - mozinfo == 0.9 21:36:16 INFO - mozleak == 0.1 21:36:16 INFO - mozlog == 3.4 21:36:16 INFO - moznetwork == 0.27 21:36:16 INFO - mozprocess == 0.24 21:36:16 INFO - mozprofile == 0.28 21:36:16 INFO - mozrunner == 6.13 21:36:16 INFO - mozscreenshot == 0.1 21:36:16 INFO - mozsystemmonitor == 0.3 21:36:16 INFO - moztest == 0.8 21:36:16 INFO - mozversion == 1.4 21:36:16 INFO - psutil == 3.1.1 21:36:16 INFO - requests == 1.2.3 21:36:16 INFO - wsgiref == 0.1.2 21:36:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:36:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:36:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:36:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:36:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:16 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 0x10f6efb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6f2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86a1d89370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4cdd30>, '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 0x10f3f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4c2be8>, '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.V7LUAIbDkw/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.qFuSKi4fvN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 21:36:16 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 21:36:16 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 21:36:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V7LUAIbDkw/Render', 21:36:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:36:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:36:16 INFO - 'HOME': '/Users/cltbld', 21:36:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:36:16 INFO - 'LOGNAME': 'cltbld', 21:36:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:36:16 INFO - 'MOZ_NO_REMOTE': '1', 21:36:16 INFO - 'NO_EM_RESTART': '1', 21:36:16 INFO - 'PAGER': '/bin/cat', 21:36:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:36:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:36:16 INFO - 'PWD': '/builds/slave/test', 21:36:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:36:16 INFO - 'SHELL': '/bin/bash', 21:36:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qFuSKi4fvN/Listeners', 21:36:16 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 21:36:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:36:16 INFO - 'USER': 'cltbld', 21:36:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:36:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:36:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:36:16 INFO - 'XPC_FLAGS': '0x0', 21:36:16 INFO - 'XPC_SERVICE_NAME': '0', 21:36:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:36:17 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)) 21:36:17 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)) 21:36:17 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)) 21:36:17 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)) 21:36:17 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)) 21:36:17 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)) 21:36:17 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)) 21:36:17 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)) 21:36:17 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)) 21:36:17 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)) 21:36:17 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)) 21:36:17 INFO - Cleaning up... 21:36:17 INFO - Return code: 0 21:36:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:36:17 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')]} 21:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:17 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')]} 21:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:36:17 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 0x10f6efb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6f2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86a1d89370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4cdd30>, '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 0x10f3f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4c2be8>, '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.V7LUAIbDkw/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.qFuSKi4fvN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 21:36:17 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 21:36:17 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 21:36:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V7LUAIbDkw/Render', 21:36:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:36:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:36:17 INFO - 'HOME': '/Users/cltbld', 21:36:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:36:17 INFO - 'LOGNAME': 'cltbld', 21:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:36:17 INFO - 'MOZ_NO_REMOTE': '1', 21:36:17 INFO - 'NO_EM_RESTART': '1', 21:36:17 INFO - 'PAGER': '/bin/cat', 21:36:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:36:17 INFO - 'PWD': '/builds/slave/test', 21:36:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:36:17 INFO - 'SHELL': '/bin/bash', 21:36:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qFuSKi4fvN/Listeners', 21:36:17 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 21:36:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:36:17 INFO - 'USER': 'cltbld', 21:36:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:36:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:36:17 INFO - 'XPC_FLAGS': '0x0', 21:36:17 INFO - 'XPC_SERVICE_NAME': '0', 21:36:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:36:17 INFO - Cleaning up... 21:36:17 INFO - Return code: 0 21:36:17 INFO - Running post-action listener: _resource_record_post_action 21:36:17 INFO - Running post-action listener: _start_resource_monitoring 21:36:17 INFO - Starting resource monitoring. 21:36:17 INFO - [mozharness: 2017-04-04 04:36:17.894485Z] Finished create-virtualenv step (success) 21:36:17 INFO - [mozharness: 2017-04-04 04:36:17.895387Z] Running install step. 21:36:17 INFO - Running pre-action listener: _resource_record_pre_action 21:36:17 INFO - Running main action method: install 21:36:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:36:18 INFO - Reading from file tmpfile_stdout 21:36:18 INFO - Detecting whether we're running mozinstall >=1.0... 21:36:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:36:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:36:18 INFO - Reading from file tmpfile_stdout 21:36:18 INFO - Output received: 21:36:18 INFO - Usage: mozinstall [options] installer 21:36:18 INFO - Options: 21:36:18 INFO - -h, --help show this help message and exit 21:36:18 INFO - -d DEST, --destination=DEST 21:36:18 INFO - Directory to install application into. [default: 21:36:18 INFO - "/builds/slave/test"] 21:36:18 INFO - --app=APP Application being installed. [default: firefox] 21:36:18 INFO - mkdir: /builds/slave/test/build/application 21:36:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:36:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 21:36:32 INFO - Reading from file tmpfile_stdout 21:36:32 INFO - Output received: 21:36:32 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 21:36:32 INFO - Running post-action listener: _resource_record_post_action 21:36:32 INFO - [mozharness: 2017-04-04 04:36:32.854635Z] Finished install step (success) 21:36:32 INFO - [mozharness: 2017-04-04 04:36:32.854765Z] Running run-tests step. 21:36:32 INFO - Running pre-action listener: _resource_record_pre_action 21:36:32 INFO - Running main action method: run_tests 21:36:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:36:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:36:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:36:32 INFO - 2017-04-03 21:36:32.869 screenresolution[1629:7232] starting screenresolution argv=screenresolution get 21:36:32 INFO - 2017-04-03 21:36:32.871 screenresolution[1629:7232] Display 0: 1600x1200x32@60 21:36:32 INFO - 2017-04-03 21:36:32.877 screenresolution[1630:7234] starting screenresolution argv=screenresolution list 21:36:32 INFO - Available Modes on Display 0 21:36:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:36:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:36:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:36:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:36:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:36:33 INFO - Intel Iris: 21:36:33 INFO - Chipset Model: Intel Iris 21:36:33 INFO - Type: GPU 21:36:33 INFO - Bus: Built-In 21:36:33 INFO - VRAM (Dynamic, Max): 1536 MB 21:36:33 INFO - Vendor: Intel (0x8086) 21:36:33 INFO - Device ID: 0x0a2e 21:36:33 INFO - Revision ID: 0x0009 21:36:33 INFO - Displays: 21:36:33 INFO - Display: 21:36:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:36:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:36:33 INFO - Display Serial Number: 1600x1200 60 21:36:33 INFO - Main Display: Yes 21:36:33 INFO - Mirror: Off 21:36:33 INFO - Online: Yes 21:36:33 INFO - Rotation: Supported 21:36:33 INFO - Return code: 0 21:36:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:36:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:36:33 INFO - Python 2.7.3 21:36:33 INFO - Return code: 0 21:36:33 INFO - grabbing minidump binary from tooltool 21:36: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')]} 21:36:33 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 0x10f4cdd30>, '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 0x10f3f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4c2be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:36:33 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 21:36:33 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 21:36:33 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 21:36:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:36:33 INFO - Return code: 0 21:36:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:36:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:36:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:36:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:36:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:36:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fY_qVQOBRyKsiozn9Kt5Fw/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0274', '--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 21:36:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fY_qVQOBRyKsiozn9Kt5Fw/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0274 --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 21:36:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V7LUAIbDkw/Render', 21:36:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:36:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:36:33 INFO - 'HOME': '/Users/cltbld', 21:36:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:36:33 INFO - 'LOGNAME': 'cltbld', 21:36:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:36:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:36:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:36:33 INFO - 'MOZ_NO_REMOTE': '1', 21:36:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:36:33 INFO - 'NO_EM_RESTART': '1', 21:36:33 INFO - 'PAGER': '/bin/cat', 21:36:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:36:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:36:33 INFO - 'PWD': '/builds/slave/test', 21:36:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:36:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:36:33 INFO - 'SHELL': '/bin/bash', 21:36:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qFuSKi4fvN/Listeners', 21:36:33 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 21:36:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:36:33 INFO - 'USER': 'cltbld', 21:36:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:36:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:36:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:36:33 INFO - 'XPC_FLAGS': '0x0', 21:36:33 INFO - 'XPC_SERVICE_NAME': '0', 21:36:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:36:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fY_qVQOBRyKsiozn9Kt5Fw/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0274', '--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 21:36:33 INFO - mozversion application_buildid: 20170403201427 21:36:33 INFO - mozversion application_changeset: 8b38e90b2ec58005e0e2ee08ec46c61a5bd3f166 21:36:33 INFO - mozversion application_display_name: Firefox 21:36:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:36:33 INFO - mozversion application_name: Firefox 21:36:33 INFO - mozversion application_remotingname: firefox 21:36:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 21:36:33 INFO - mozversion application_vendor: Mozilla 21:36:33 INFO - mozversion application_version: 53.0 21:36:33 INFO - mozversion platform_buildid: 20170403201427 21:36:33 INFO - mozversion platform_changeset: 8b38e90b2ec58005e0e2ee08ec46c61a5bd3f166 21:36:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 21:36:33 INFO - mozversion platform_version: 53.0 21:36:33 INFO - using testdate: 1491280593 21:36:33 INFO - actual date: 1491280593 21:36:33 INFO - starting webserver on 'localhost:49242' 21:36:33 INFO - SUITE-START | Running 2 tests 21:36:33 INFO - TEST-START | dromaeo_css 21:36:33 INFO - operating with platform_type : mac_ 21:36:33 INFO - Initialising browser for dromaeo_css test... 21:36:33 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpUkgfA3/profile http://localhost:49242/getInfo.html) 21:36:35 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 21:36:35 INFO - PROCESS | 1640 | colorDepth:24 21:36:35 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 21:36:35 INFO - PROCESS | 1640 | __metrics 21:36:36 INFO - PROCESS | 1640 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:36:36 INFO - PROCESS | 1640 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:36:36 INFO - TEST-INFO | 1640: exit 0 21:36:36 INFO - Browser initialized. 21:36:36 INFO - Running cycle 1/1 for dromaeo_css test... 21:36:36 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpUkgfA3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:36:48 INFO - PROCESS | 1643 | RSS: Main: 163889152 21:36:48 INFO - PROCESS | 1643 | 21:39:52 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 21:39:53 INFO - PROCESS | 1643 | RSS: Main: 312291328 21:39:53 INFO - PROCESS | 1643 | 21:42:56 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 21:42:57 INFO - PROCESS | 1643 | RSS: Main: 309882880 21:42:57 INFO - PROCESS | 1643 | 21:45:59 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 21:46:00 INFO - PROCESS | 1643 | RSS: Main: 302952448 21:46:00 INFO - PROCESS | 1643 | 21:49:02 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 21:49:03 INFO - PROCESS | 1643 | RSS: Main: 289234944 21:49:03 INFO - PROCESS | 1643 | 21:52:06 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 21:52:07 INFO - PROCESS | 1643 | RSS: Main: 268169216 21:52:07 INFO - PROCESS | 1643 | 21:55:10 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 21:55:10 INFO - PROCESS | 1643 | RSS: Main: 313311232 21:55:10 INFO - PROCESS | 1643 | 21:55:10 INFO - PROCESS | 1643 | __start_tp_report 21:55:10 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 21:55:10 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 21:55:10 INFO - PROCESS | 1643 | |i|pagename|runs| 21:55:10 INFO - PROCESS | 1643 | |0;dojo.html;3466.133466633342;3487.9651203487956;3493.7205023598117;3499.52756377889;3542.0967653248417;5911.674857882815;5971.82084537464;5988.401159884021;5992.430719081685;6004.699765011754;5975.88048239036;6066.1810655561485;6067.211262535864;6076.544259180568;6084.5132389408855;5207.817726379578;5378.435264297242;5388.757505912224;5412.4587541245755;5436.864078398032;4504.864854054384;5363.410024897258;5372.865678358034;5378.542823859977;5508.807191748289;5403.648762830423;5408.594355423339;5410.404855465896;5449.291592093023;5479.479449452296;5451.400345961941;5458.754356053947;5460.672359658433;5471.699056551908;5480.177973303997;5353;5373.785048598052;5379.058664733656;5387.946120538783;5391.838244852661;4750.762461876892;5828.0966450200285;5839.386864379221;5881.3530511643685;5904.380040095771;6266.436020758154;6269.122322874801;6272.529560282951;6279.560430769848;6304.968475157641;5878.970605146947;6366;6372.7132279047555;6377.23473183221;6393.200849893763;5965.4929331006915;6065.059915713072;6070.0591408331775;6118.1128736332985;6175.475084617813;6368.522360822864;6375;6400.23197216337;6400.743970241138;6460.515461340418;6226.972549529368;6237.96881015592;6238.937610623836;6242.75028998844;6250.874982500324;6344.746210151635;6374.075759014917;6377.96811015942;6379;6399.872002560016;6176.135341052256;6221.502279817694;6255.343188965184;6276.152719382916;6277.654728989858;6197.1324014637985;6248.687565621701;6271.43557079865;6276.937230627726;6287.339829317947;5136.152534831711;5173.301604283449;5177.094008548489;5182;5207.0887594670785;4568;4623.12160689468;4624.098300831306;4637.095766325534;4672.719636821802;5978.940210597925;6037.879242415127;6050.6369617823075;6126.846828829315;6135.386461353829;6371.139896114058;6397.7440902364315;6433.163688720437;6438.613683178931;6457.903131453032;6028.608140470856;6089.330173680892;6093.994490909039;6108.511319094462;6118.235220597426;5542.91685624716;5653.519450846642;5702.45826646468;5706.657600543981;5715.799947001835;6395.93604063972;6407.935920640827;6419.903701444388;6467.191601049869;6488.708008139645;6314.431701146918;6320.051992201023;6325.96837015812;6327.905081423874;6330.3669633036325;6496.415322620986;6546.803595892131;6556.573822701509;6561.376669216417;6574.605523668595;6145.095020543467;6208.534359923115;6240.344763799736;6248.375162483715;6282.057691346335;6243.875122497616;6376.298607153302;6377.744890204525;6394.616323020634;6397.712102955285;6221.751129954751;6230.096635987666;6232.345603711545;6239.937600624117;6245.156903817927;6164.4143806338325;6174.38256174379;6203.96898015507;6216.875662486635;6253.8749225014335;6208.844778880564;6215.12988181664;6257.906131407942;6259.6870156492905;6263.091851681572;5595.235128467019;5925.614835035709;6242.090263176194;6247.12540244357;6250.218722659668;6121.3572574879;6171;6207.937920620736;6232.719527621177;6254.9687251563455 21:55:10 INFO - PROCESS | 1643 | |1;ext.html;504.183223178451;525.9684418934864;530.3105962249073;541.5856869494837;550.1774846604327;32506.512402313983;42697.786511067476;44120.779396103055;44142.77928610361;44218.33672494915;45328.77335613317;45684.77157614207;45736.54263457364;45809.54190458095;45829.31256031162;9140.085991400872;9356.953215233914;9726.17327527161;9909.554070066828;9930.45382503962;11884.643460696192;12111.757764844699;12129.454174562166;12267.693307667336;12281.508739650404;12072.456739446701;12087.637370878887;12158.817617735742;12174.756504869898;12185.695357616041;12092.637220883344;12166.209196402295;12167.209131406431;12171.93914030433;12196.329201893892;11967.94016029923;12058.397080145958;12070.034397248286;12079.698007549794;12090.032797376276;42486.362704559455;42785.35821962673;42804.785976070234;42829.785851070854;42851.928701782395;4101.815418306153;4125.711200215986;4160.251154792136;4160.820022888995;4179.498460184797;30803.69196308053;31278.905238316776;32480.512792307898;32775.836120819484;32794.016179514656;3386.779859309137;3416.9658303416895;3420.7605467617277;3556.8577256909693;3559.5906470755936;496272;504386;505450.9454905441;505973;506250;55599.61000975008;65743.67128164328;65978.67010664917;66013;66025.66987165129;69376;69951;70026.29973700299;70076;70207.64896175487;17369.13154342278;18002.639947200983;18046.2781488739;18053.7291940621;18057.819421805878;12605.873941260654;12858.742825143632;12883.35583220854;13567;13885.791713124312;15601.921990389976;15694.9215253923;15707;17528.474145775646;17668.823311766973;6621.205455345389;6728.697208625624;6729.25978142404;6753.189617245864;6772.2211945625895;878.4246318661287;879.9560021998874;894.2309613732185;923.9122283383068;927.457437399129;30210.84894575513;31049.68950310513;31158.22104447407;31491.212719682193;32024;929.7489677786959;1052.2423854824515;1061.7345663584103;1081.0756802933536;1115.9119858138413;16029.839701603069;16444.506664800076;16450.095244761415;16455.25951332193;16828.579285517717;639016;642898;642969;643935;644112;64210;64502;64611;64724.35275647278;64754;1324.5165514587106;1397.1337770582506;1455.483303427268;1496.2294418374545;1521.239380309845;30626.234344141576;32795;32910.01269961905;33027.348632567795;33645.49531757075;45301.546984529734;53414.73292633512;53931;54240.91518169535;54311.45688543064;512791;513868;514918;515218;515248;36910.44634330541;37732.62267377291;42581.36127958145;42868.14263714771;43756.78121609372;49271;49515.25727114024;49869.75065124796;51396.74301628468;51396.74301628618;31445.842770786;33607.66392336143;33828.83085584556;34577.78977735868;35140.64859351374;30561.694383056772;33678.83160584181;34690;34724;35373;38573.42139867848;39129.80435097806;40364.99087522835;40453.59546404616;40525.79737101296;33430.49854252237;33856.66143338535;34540.65459345475;35099.82450087733;35277.82361088178;25089.24732258035;26075;26429.678516073734;26496.602550961365;26947.461050779268 21:55:10 INFO - PROCESS | 1643 | |2;jquery.html;372.1923426165222;399.6363309388455;404.33285079618605;412.87200967700016;433.6237418944186;20182.293619723314;21293.57412851742;21776.693398396088;22605;22641.433964150903;23327.300180994596;23680.76319236807;23779.643305350433;23911.64132538009;24017.639735403984;6029.849253768647;6323.77866774663;6347.270063942637;6355.2373715154245;6360.650164240965;5919.260092488439;6234.563580549363;6295;6301.432871041606;6304.085907543404;6021.367756385582;6255.530835187356;6257.18656574647;6269.2476902771505;6274.058891166339;6136.96931515344;6164.198654174951;6180.6291622502795;6219.720112594944;6222.377762223764;5322.0952438085615;5430.0768869292315;5515.586331025189;5516.862078448031;5520.585956053312;21653.566928661498;28015;28101.73542190606;28108.891833112597;28388.574171387445;3170.6353769316593;3206.118317462693;3274.0341599228286;3279.468387173511;3356.9090045735234;12559.56041538551;17019;17035.48893533196;17079.573010674707;17660.735088973677;1866.7386565880788;1900.9524761880925;1928.9780807017385;1942.3493129801534;1955.0127185771094;123092;123165;123175;127408.72591274061;128283.07575386284;11704.414779261004;11774.764504709858;11800.76398472043;11891;12056.698582535331;15595;15599.220038998004;15615.921920390325;15628.765568516481;15636.687266254612;8699.391042627081;9026.413283136575;9037.77405564866;9116.088391160964;9145.085491450935;7388.778336649909;7614.771556853303;8878.73363799087;8923.464592124494;9015.549222538846;6240.065579670317;6364.872702545923;7696.884546731803;7744.0707115145415;7748.031496062992;1701.7277235642239;1960.3432849995127;1983.890886001284;1990.532224927141;1993.6511110555596;1061.4851796878509;1081.302559848893;1085.0993675249524;1089.5750657243682;1138.7494751154732;22923.73919434447;23450.723587193086;24412.87793561021;24493.755062449505;25228.873855630605;887.6050157679899;889.8709687095335;952.1288021460286;961.1974001708512;1001.5743309093606;11143.944280278709;11714.23857449263;11744.354060526754;11744.882551174378;11751.706207344885;769271;811121;818578;841088;844309;96448.51775741216;109247.36128958072;121818.3909080449;142797;158028.20985894997;1090.4275255490932;1151.0963893343517;1169.7251145980688;1170.0288760328906;1172.7771723372532;20654.586908262052;22125.889370553043;22158.77841221567;22185.556288874453;22338.553228935005;47457.762711186224;58553.12170317364;59510.40489595049;62553.37446625657;63719;97012.54481182928;97344.51327743316;97354.0264597345;97395.51302243443;99819;7444.73943411978;8279.758036294605;8631.731080710722;8964.955175224082;9137.40606860552;11582;13581.45674173022;13714.588562343146;14191.929040354733;14212.21832799206;11683;11751.76496470083;11879.58421455245;11883.702907427383;11913.795947749693;11215.214934954474;11271.49278282463;11311.377874216998;11450.255733377304;11535.480903359537;10136.847947280648;11976.880231197576;11992.400379980792;12049.409376983991;12072.275663460221;8074.232947869943;8628.266597339045;8755.824883502168;8865.778355541162;8900.154485323885;9294.535273236175;11551.422428878355;11670.416479176178;11826.881731182579;12099 21:55:10 INFO - PROCESS | 1643 | |3;mootools.html;1462.1519518679168;1483.8441963593823;1515.1515151515152;1515.7953676253703;1519.992400038;7529.623518824064;8247.134050924657;8487.533185674785;8600.698975535857;8637.963444386674;7328.816779580513;7575.090989081318;7575.962120189405;8229.91770082299;8456.450330728498;2382.452036031709;2422.2975337152207;2423.418379588895;2426.3934016495878;2427.4174198192395;2391.5097405031925;2412.2522018174336;2422.067504010951;2430.003698483622;2431.671724317212;2032.3801240621603;2375.6555299481565;2386.95226095478;2402.95194096118;2415.4444477770126;2343.7070366204225;2364.645303204516;2387.7612238776155;2388.665586817847;2389.23544465771;2397.077125306752;2418.322869596516;2418.806495480357;2418.9395265118337;2419.8427102238297;8422.24199822019;8599.355048371397;8601.268892144175;8614.52620105894;8614.698485552975;5185.092608793446;5350.384705758848;5357.866053348697;5359.249705041298;5360.839174824761;3369.747268954838;3494.3710132176197;3628.5827129880136;3661.121330880596;3668.761530500509;1068.3322923173016;1227.5458080510268;1298.0653929170983;1321.266696983174;1814.954626134344;10891.727706807393;11073.446327683583;11112.944435277772;11120.666380008613;11137.387443690513;4346.434963454793;4573.039661671086;4641.930371044437;4649.558291962258;4651.093036857848;8897.288216942628;8904.421212621159;8912.643494260157;8919.955400222958;8939.106089391009;4844.854654360375;4979.779953911315;5269.868253293698;5274.182501712241;5276.3932147802725;4139.97930010348;4366.476022877211;4946.4064312282035;4947.307376967227;4967.155583550805;3754.1740817020213;3780.0360907968293;3839.9424008639894;3863.632954869283;3868.2456920900154;1164.5225457562358;1171.5138217639585;1174.442139983518;1179.929204247748;1184.3426898071652;905.6060613633091;917.2295271971576;926.7914719188128;927.675313640234;975.6195083917278;5126.410462796752;5481.342238931274;5623.803166889139;5682.602217844794;5880.647161170344;545.7435005547386;575.4906907386993;577.587025276929;581.2771233725977;602.0277252237693;3508.7193024558483;3790.2419516096893;3848.9807550962064;3879.8254078566533;3882.3400021996326;9882.209423246122;10155.339902906288;10248.282620216512;10258.025487578669;10270;9717.805643887083;10132.088112069949;10149.086582207638;10149.898501014895;10193.74515637115;6936.895946560806;7885.44801863864;8074.071481779671;8080.515169089756;8086.514809111354;5248.816291429782;5455.318085239345;5695.914561281667;5701.458361455655;6148.047052706837;8594.269487093417;9124.087591240823;9204.355695101278;9213.309001824757;9358.812823743623;7000;9252.074792520694;9257.074292570689;9368.859467108136;9380.530973451163;6770.45836333102;6945.479089068441;6946.5137440378685;7249.637518124178;7415.147258065392;7451.478396512192;7910.9604451977375;8002.639881205243;8091.595420228848;8104.392170587112;6781.864362712817;6895.322763475211;7062;7138.643067846483;7198.748043818441;6905.723771049102;6913.412359949461;6933.791986240421;6978.511504194657;6988.6505674715045;6399.904001439889;6404.199475065617;6491.545591808528;6507.219133703797;6512.348765123639;4935.259711043373;4992.550670439678;5002.349694539686;5060.342155519759;5066.06277838601;4949.341970439799;5062.645614806928;5103.948960510347;5176.50823171798;5263.894722105613 21:55:10 INFO - PROCESS | 1643 | |4;prototype.html;315.8704930978299;376.75510917903364;384.2430412088186;395.16619931943575;395.73683500472185;4786.736729479877;4863.854084377465;5091.745412729368;5166.889118839449;5578.24693666355;3832.501774769283;4660.510646382132;5212.973935130329;5236.664650514123;5381.816000479898;4229.217594744982;4284.271673815443;4290.1949816205815;4294.377315289296;4339.1972485090355;3558.8220588970576;4111.951452379639;4139.482564679415;4290.712786164154;4291.180849044353;3621.1852333224947;3866.6326698963553;4050;4261.998430368861;4262.829486820523;3419.469592501556;4280.019581788935;4287.742735435852;4309.224339618867;4313.590208930163;3804.714646401503;3818.236352729465;3821.9044523886846;3823.388257878754;3828.3874580067336;4480.551944805526;5074.908894587645;5233.874716935877;5363.9463605363835;5365.839024829262;4918.631102667278;4952.133376659071;4980.505848245548;4983.875403114915;4988.501149884983;4909.361782968192;5788.594798364116;5811.0411782056335;5823.417658234185;5864.501517370986;3129.6840338149605;4205.453291072172;4221.219074471202;4259.659227261812;4261.31818908973;5386.649867758544;5756.712164391805;5932.40675932412;6050.576459647827;6086.421789929949;4021.597840215955;4034.9596504034585;4045.7370270932297;4068.3897415387337;4083.4283200351974;3664.908377290589;4138.586141385837;4145.662741493127;4164.479440069991;4175.498940127204;3924.2151569685607;4118.567550407224;4967.2549117631925;5016.799328026838;5025.195968644999;5134.435212126663;5912.46787789101;5918.556108291896;5935.614185077956;5939.673317967553;1284.4348486665838;1302.1926405628572;1326.8341457317836;1363.4682473835212;1441.3153751967732;927.9884925431178;980.4215512847454;1017.9032991865761;1020.4438580973388;1042.47876061969;4275.40144379787;4307.095509942885;4581.702189357681;4877.634177436636;5151.562117220078;5307.336582927134;5661.858453538612;5704.3154821421695;5731.598788084794;5812.360640329561;4463.531329210451;4695.43654761424;4859.611231101503;5185.455527169668;5221.503957124067;2352.600202879284;2574.1633968960164;2693.3739603886056;2725.74105459981;3014.7588192944513;4870.537298956664;5064.594832413398;5232.3459567554055;5886.085118925659;5936.851578710481;4827.758612069382;5219.504147106095;5408.891822163535;5697.974364614409;5832.445917637818;5067.4932506749765;5104.3109180260935;5242.165242165212;5720.914186287209;5961.523078153824;5262.710550919736;5404.567944424946;5643.181738647955;5654.236678048575;5654.773809047592;4520.683552151318;4990.226514890198;5024.6231532634465;5380.923815237046;5559.137044422207;5071.949280507295;5259.737013149251;5639.210510528611;5912.379200183918;5929.911051334319;3490.7730997485082;3900.2004589059743;4028.5367182774357;4128.731632443882;4145.79271036441;4850.854474365775;4889.804407823647;5159.974200128975;5649.305208437535;5801.3908539602735;4684.601808846286;5379.229696706121;5572.777088916398;5801;5841.2406387171095;5122.974385128199;5739.167820666064;5786.42135786418;5819.592628515963;5819.912701309569;4751.429828420612;4906.607471402351;5439.292891924183;5556.749301658575;5588.832335029955;4746.81963084741;4840.878978025577;5334.306540149911;5794.2177805997335;5833.708314584339;4938.777755001105;5031.874203144951;5654.547636189177;5695.686737229492;5723.656580605177 21:55:10 INFO - PROCESS | 1643 | |5;yui.html;742.9554226746399;766.76613632842;791.394583143895;870.2428886868423;882.0694167653128;15309.923450382761;15351.769723454143;15825.84174158258;16179;16292.592685182877;14573.6356591085;14777.187254701013;14860.405583776635;15001.249937503137;15018.098914065136;898.4474548152872;908.1780988205652;911.7355966769629;912.8539433690611;912.9041450647686;707.6214225389417;733.4462480826995;737.0418456007196;738.1879932074728;902.9909700903005;775.244136966456;929.2333824594702;963.59047404853;963.8120566489538;970.5826494607317;960.8414611589079;961.3126614470652;961.6009356117273;962.1340793286029;963.5086106085877;711.3668834737089;712.6223101756077;712.8503014366989;712.9073220481356;713.1727196452142;15385.538313869727;15543.222838858124;15567.766483502757;15627.29677164519;15739.606509837231;11762.66962060369;12943.935280323632;13287;14198.57404277863;14200.431982720678;10313;12626.322909206645;12858.164219325807;12918.935405323007;13231.669208269774;4354.86288026373;4405.691601587891;4510.571495707903;4530.79611417487;4668.50980647034;98209;103523;103864;104712;104868.47565762198;11088.390138542458;11118.444077796077;11203.047740941949;11238.606648767418;11799.646010619696;21663.458413539473;21822.454438638844;21896.343109706733;22287.554248915254;22302.776972230393;7940.761777146695;7963.8407231855035;8012.959935200287;8045.195480452025;8091.878621820678;4403.559644035635;4429.335599660077;4447.911041779146;4503.986603014361;4504.932426013613;3183.5065564837487;3547.9067350263467;3608.9458658120147;3612.187257866959;3615.493830863681;655.3021032600266;657.3853447027045;661.3386613386614;673.8012286375531;677.5257319876107;602.6052935327367;604.4922265297172;623.800383877164;628.0328294426532;639.0733436516977;8625.870611940825;9560.904390956;10137.898621013843;10184.6435374763;10642.893571064345;572.5076434266527;643.1831573901119;671.8723442545901;672.6300534705892;675.6891829758268;4664.953350466452;4822;4833.226683730657;4851.611871050308;4851.975740121276;94192.52903735437;94446;95063.52468237752;96468.51765741127;99738;86977;88066.11933880707;88155;89121.9999999987;90158.54920725485;78434;80458.39083218302;80955;81553.59223204083;82737.75893361605;7945.562994035384;9221.492817894812;9430.335623942057;9441.622335106518;9449.055094490495;53104.20343694925;53133.20300195423;53368;53597.73201133969;54510.18234726403;53100.67248318668;68988.6550567244;70267;70592.6470367645;73688.89466657897;10594.31136976094;11129.387883666475;11686.357250351311;11708.824367634663;11782.705432364259;11987.902117129643;12003.459844307201;12019.507737539496;12122.969547588555;12292.201006934522;11136.443177841238;11893.821592675944;11993.76012479728;12012.459439325077;12164.817527736914;11033.613823516138;11846;11846.78359078542;11879.346635935106;11912.40437978115;11198.38408887519;11375.146863985068;11788.410579470821;11810.468528916048;11912.642620721392;8577.614007369559;8926.201518021093;8953.641854325753;9016.504092274989;9030.32272579546;9524.374332819347;9647.807043859224;9655.565499552396;9667.419954802734;9677.612895484102 21:55:10 INFO - PROCESS | 1643 | __end_tp_report 21:55:10 INFO - PROCESS | 1643 | __start_cc_report 21:55:10 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,1385 21:55:10 INFO - PROCESS | 1643 | __end_cc_report 21:55:10 INFO - PROCESS | 1643 | __startTimestamp1491281710495__endTimestamp 21:55:10 INFO - PROCESS | 1643 | 21:55:10 INFO - PROCESS | 1643 | ------- Summary: start ------- 21:55:10 INFO - PROCESS | 1643 | Number of tests: 6 21:55:10 INFO - PROCESS | 1643 | 21:55:10 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:5910.06 Median:6175.48 stddev:631.83 (10.2%) stddev-sans-first:603.98 21:55:10 INFO - PROCESS | 1643 | Values: 3466.1 3488.0 3493.7 3499.5 3542.1 5911.7 5971.8 5988.4 5992.4 6004.7 5975.9 6066.2 6067.2 6076.5 6084.5 5207.8 5378.4 5388.8 5412.5 5436.9 4504.9 5363.4 5372.9 5378.5 5508.8 5403.6 5408.6 5410.4 5449.3 5479.5 5451.4 5458.8 5460.7 5471.7 5480.2 5353.0 5373.8 5379.1 5387.9 5391.8 4750.8 5828.1 5839.4 5881.4 5904.4 6266.4 6269.1 6272.5 6279.6 6305.0 5879.0 6366.0 6372.7 6377.2 6393.2 5965.5 6065.1 6070.1 6118.1 6175.5 6368.5 6375.0 6400.2 6400.7 6460.5 6227.0 6238.0 6238.9 6242.8 6250.9 6344.7 6374.1 6378.0 6379.0 6399.9 6176.1 6221.5 6255.3 6276.2 6277.7 6197.1 6248.7 6271.4 6276.9 6287.3 5136.2 5173.3 5177.1 5182.0 5207.1 4568.0 4623.1 4624.1 4637.1 4672.7 5978.9 6037.9 6050.6 6126.8 6135.4 6371.1 6397.7 6433.2 6438.6 6457.9 6028.6 6089.3 6094.0 6108.5 6118.2 5542.9 5653.5 5702.5 5706.7 5715.8 6395.9 6407.9 6419.9 6467.2 6488.7 6314.4 6320.1 6326.0 6327.9 6330.4 6496.4 6546.8 6556.6 6561.4 6574.6 6145.1 6208.5 6240.3 6248.4 6282.1 6243.9 6376.3 6377.7 6394.6 6397.7 6221.8 6230.1 6232.3 6239.9 6245.2 6164.4 6174.4 6204.0 6216.9 6253.9 6208.8 6215.1 6257.9 6259.7 6263.1 5595.2 5925.6 6242.1 6247.1 6250.2 6121.4 6171.0 6207.9 6232.7 6255.0 21:55:10 INFO - PROCESS | 1643 | 21:55:10 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:70455.05 Median:37321.53 stddev:148445.22 (397.7%) stddev-sans-first:148768.74 21:55:10 INFO - PROCESS | 1643 | Values: 504.2 526.0 530.3 541.6 550.2 32506.5 42697.8 44120.8 44142.8 44218.3 45328.8 45684.8 45736.5 45809.5 45829.3 9140.1 9357.0 9726.2 9909.6 9930.5 11884.6 12111.8 12129.5 12267.7 12281.5 12072.5 12087.6 12158.8 12174.8 12185.7 12092.6 12166.2 12167.2 12171.9 12196.3 11967.9 12058.4 12070.0 12079.7 12090.0 42486.4 42785.4 42804.8 42829.8 42851.9 4101.8 4125.7 4160.3 4160.8 4179.5 30803.7 31278.9 32480.5 32775.8 32794.0 3386.8 3417.0 3420.8 3556.9 3559.6 496272.0 504386.0 505450.9 505973.0 506250.0 55599.6 65743.7 65978.7 66013.0 66025.7 69376.0 69951.0 70026.3 70076.0 70207.6 17369.1 18002.6 18046.3 18053.7 18057.8 12605.9 12858.7 12883.4 13567.0 13885.8 15601.9 15694.9 15707.0 17528.5 17668.8 6621.2 6728.7 6729.3 6753.2 6772.2 878.4 880.0 894.2 923.9 927.5 30210.8 31049.7 31158.2 31491.2 32024.0 929.7 1052.2 1061.7 1081.1 1115.9 16029.8 16444.5 16450.1 16455.3 16828.6 639016.0 642898.0 642969.0 643935.0 644112.0 64210.0 64502.0 64611.0 64724.4 64754.0 1324.5 1397.1 1455.5 1496.2 1521.2 30626.2 32795.0 32910.0 33027.3 33645.5 45301.5 53414.7 53931.0 54240.9 54311.5 512791.0 513868.0 514918.0 515218.0 515248.0 36910.4 37732.6 42581.4 42868.1 43756.8 49271.0 49515.3 49869.8 51396.7 51396.7 31445.8 33607.7 33828.8 34577.8 35140.6 30561.7 33678.8 34690.0 34724.0 35373.0 38573.4 39129.8 40365.0 40453.6 40525.8 33430.5 33856.7 34540.7 35099.8 35277.8 25089.2 26075.0 26429.7 26496.6 26947.5 21:55:10 INFO - PROCESS | 1643 | 21:55:10 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:42767.49 Median:23964.64 stddev:134950.40 (563.1%) stddev-sans-first:135291.42 21:55:10 INFO - PROCESS | 1643 | Values: 372.2 399.6 404.3 412.9 433.6 20182.3 21293.6 21776.7 22605.0 22641.4 23327.3 23680.8 23779.6 23911.6 24017.6 6029.8 6323.8 6347.3 6355.2 6360.7 5919.3 6234.6 6295.0 6301.4 6304.1 6021.4 6255.5 6257.2 6269.2 6274.1 6137.0 6164.2 6180.6 6219.7 6222.4 5322.1 5430.1 5515.6 5516.9 5520.6 21653.6 28015.0 28101.7 28108.9 28388.6 3170.6 3206.1 3274.0 3279.5 3356.9 12559.6 17019.0 17035.5 17079.6 17660.7 1866.7 1901.0 1929.0 1942.3 1955.0 123092.0 123165.0 123175.0 127408.7 128283.1 11704.4 11774.8 11800.8 11891.0 12056.7 15595.0 15599.2 15615.9 15628.8 15636.7 8699.4 9026.4 9037.8 9116.1 9145.1 7388.8 7614.8 8878.7 8923.5 9015.5 6240.1 6364.9 7696.9 7744.1 7748.0 1701.7 1960.3 1983.9 1990.5 1993.7 1061.5 1081.3 1085.1 1089.6 1138.7 22923.7 23450.7 24412.9 24493.8 25228.9 887.6 889.9 952.1 961.2 1001.6 11143.9 11714.2 11744.4 11744.9 11751.7 769271.0 811121.0 818578.0 841088.0 844309.0 96448.5 109247.4 121818.4 142797.0 158028.2 1090.4 1151.1 1169.7 1170.0 1172.8 20654.6 22125.9 22158.8 22185.6 22338.6 47457.8 58553.1 59510.4 62553.4 63719.0 97012.5 97344.5 97354.0 97395.5 99819.0 7444.7 8279.8 8631.7 8965.0 9137.4 11582.0 13581.5 13714.6 14191.9 14212.2 11683.0 11751.8 11879.6 11883.7 11913.8 11215.2 11271.5 11311.4 11450.3 11535.5 10136.8 11976.9 11992.4 12049.4 12072.3 8074.2 8628.3 8755.8 8865.8 8900.2 9294.5 11551.4 11670.4 11826.9 12099.0 21:55:10 INFO - PROCESS | 1643 | 21:55:10 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:5437.53 Median:5216.95 stddev:2943.74 (56.4%) stddev-sans-first:2936.84 21:55:10 INFO - PROCESS | 1643 | Values: 1462.2 1483.8 1515.2 1515.8 1520.0 7529.6 8247.1 8487.5 8600.7 8638.0 7328.8 7575.1 7576.0 8229.9 8456.5 2382.5 2422.3 2423.4 2426.4 2427.4 2391.5 2412.3 2422.1 2430.0 2431.7 2032.4 2375.7 2387.0 2403.0 2415.4 2343.7 2364.6 2387.8 2388.7 2389.2 2397.1 2418.3 2418.8 2418.9 2419.8 8422.2 8599.4 8601.3 8614.5 8614.7 5185.1 5350.4 5357.9 5359.2 5360.8 3369.7 3494.4 3628.6 3661.1 3668.8 1068.3 1227.5 1298.1 1321.3 1815.0 10891.7 11073.4 11112.9 11120.7 11137.4 4346.4 4573.0 4641.9 4649.6 4651.1 8897.3 8904.4 8912.6 8920.0 8939.1 4844.9 4979.8 5269.9 5274.2 5276.4 4140.0 4366.5 4946.4 4947.3 4967.2 3754.2 3780.0 3839.9 3863.6 3868.2 1164.5 1171.5 1174.4 1179.9 1184.3 905.6 917.2 926.8 927.7 975.6 5126.4 5481.3 5623.8 5682.6 5880.6 545.7 575.5 577.6 581.3 602.0 3508.7 3790.2 3849.0 3879.8 3882.3 9882.2 10155.3 10248.3 10258.0 10270.0 9717.8 10132.1 10149.1 10149.9 10193.7 6936.9 7885.4 8074.1 8080.5 8086.5 5248.8 5455.3 5695.9 5701.5 6148.0 8594.3 9124.1 9204.4 9213.3 9358.8 7000.0 9252.1 9257.1 9368.9 9380.5 6770.5 6945.5 6946.5 7249.6 7415.1 7451.5 7911.0 8002.6 8091.6 8104.4 6781.9 6895.3 7062.0 7138.6 7198.7 6905.7 6913.4 6933.8 6978.5 6988.7 6399.9 6404.2 6491.5 6507.2 6512.3 4935.3 4992.6 5002.3 5060.3 5066.1 4949.3 5062.6 5103.9 5176.5 5263.9 21:55:10 INFO - PROCESS | 1643 | 21:55:10 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4543.78 Median:4959.69 stddev:1348.87 (27.2%) stddev-sans-first:1314.80 21:55:10 INFO - PROCESS | 1643 | Values: 315.9 376.8 384.2 395.2 395.7 4786.7 4863.9 5091.7 5166.9 5578.2 3832.5 4660.5 5213.0 5236.7 5381.8 4229.2 4284.3 4290.2 4294.4 4339.2 3558.8 4112.0 4139.5 4290.7 4291.2 3621.2 3866.6 4050.0 4262.0 4262.8 3419.5 4280.0 4287.7 4309.2 4313.6 3804.7 3818.2 3821.9 3823.4 3828.4 4480.6 5074.9 5233.9 5363.9 5365.8 4918.6 4952.1 4980.5 4983.9 4988.5 4909.4 5788.6 5811.0 5823.4 5864.5 3129.7 4205.5 4221.2 4259.7 4261.3 5386.6 5756.7 5932.4 6050.6 6086.4 4021.6 4035.0 4045.7 4068.4 4083.4 3664.9 4138.6 4145.7 4164.5 4175.5 3924.2 4118.6 4967.3 5016.8 5025.2 5134.4 5912.5 5918.6 5935.6 5939.7 1284.4 1302.2 1326.8 1363.5 1441.3 928.0 980.4 1017.9 1020.4 1042.5 4275.4 4307.1 4581.7 4877.6 5151.6 5307.3 5661.9 5704.3 5731.6 5812.4 4463.5 4695.4 4859.6 5185.5 5221.5 2352.6 2574.2 2693.4 2725.7 3014.8 4870.5 5064.6 5232.3 5886.1 5936.9 4827.8 5219.5 5408.9 5698.0 5832.4 5067.5 5104.3 5242.2 5720.9 5961.5 5262.7 5404.6 5643.2 5654.2 5654.8 4520.7 4990.2 5024.6 5380.9 5559.1 5071.9 5259.7 5639.2 5912.4 5929.9 3490.8 3900.2 4028.5 4128.7 4145.8 4850.9 4889.8 5160.0 5649.3 5801.4 4684.6 5379.2 5572.8 5801.0 5841.2 5123.0 5739.2 5786.4 5819.6 5819.9 4751.4 4906.6 5439.3 5556.7 5588.8 4746.8 4840.9 5334.3 5794.2 5833.7 4938.8 5031.9 5654.5 5695.7 5723.7 21:55:10 INFO - PROCESS | 1643 | 21:55:10 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:20076.53 Median:53482.87 stddev:28943.65 (54.1%) stddev-sans-first:28988.44 21:55:10 INFO - PROCESS | 1643 | Values: 743.0 766.8 791.4 870.2 882.1 15309.9 15351.8 15825.8 16179.0 16292.6 14573.6 14777.2 14860.4 15001.2 15018.1 898.4 908.2 911.7 912.9 912.9 707.6 733.4 737.0 738.2 903.0 775.2 929.2 963.6 963.8 970.6 960.8 961.3 961.6 962.1 963.5 711.4 712.6 712.9 712.9 713.2 15385.5 15543.2 15567.8 15627.3 15739.6 11762.7 12943.9 13287.0 14198.6 14200.4 10313.0 12626.3 12858.2 12918.9 13231.7 4354.9 4405.7 4510.6 4530.8 4668.5 98209.0 103523.0 103864.0 104712.0 104868.5 11088.4 11118.4 11203.0 11238.6 11799.6 21663.5 21822.5 21896.3 22287.6 22302.8 7940.8 7963.8 8013.0 8045.2 8091.9 4403.6 4429.3 4447.9 4504.0 4504.9 3183.5 3547.9 3608.9 3612.2 3615.5 655.3 657.4 661.3 673.8 677.5 602.6 604.5 623.8 628.0 639.1 8625.9 9560.9 10137.9 10184.6 10642.9 572.5 643.2 671.9 672.6 675.7 4665.0 4822.0 4833.2 4851.6 4852.0 94192.5 94446.0 95063.5 96468.5 99738.0 86977.0 88066.1 88155.0 89122.0 90158.5 78434.0 80458.4 80955.0 81553.6 82737.8 7945.6 9221.5 9430.3 9441.6 9449.1 53104.2 53133.2 53368.0 53597.7 54510.2 53100.7 68988.7 70267.0 70592.6 73688.9 10594.3 11129.4 11686.4 11708.8 11782.7 11987.9 12003.5 12019.5 12123.0 12292.2 11136.4 11893.8 11993.8 12012.5 12164.8 11033.6 11846.0 11846.8 11879.3 11912.4 11198.4 11375.1 11788.4 11810.5 11912.6 8577.6 8926.2 8953.6 9016.5 9030.3 9524.4 9647.8 9655.6 9667.4 9677.6 21:55:10 INFO - PROCESS | 1643 | -------- Summary: end -------- 21:55:10 INFO - PROCESS | 1643 | 21:55:11 INFO - TEST-INFO | 1643: exit 0 21:55:11 INFO - TEST-OK | dromaeo_css | took 1117601ms 21:55:11 INFO - TEST-START | kraken 21:55:11 INFO - operating with platform_type : mac_ 21:55:11 INFO - Initialising browser for kraken test... 21:55:11 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmp4zyoDk/profile http://localhost:49242/getInfo.html) 21:55:13 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 21:55:13 INFO - PROCESS | 1652 | colorDepth:24 21:55:13 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 21:55:13 INFO - PROCESS | 1652 | __metrics 21:55:13 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:55:13 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:55:14 INFO - TEST-INFO | 1652: exit 0 21:55:14 INFO - Browser initialized. 21:55:14 INFO - Running cycle 1/1 for kraken test... 21:55:14 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmp4zyoDk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:55:26 INFO - PROCESS | 1653 | RSS: Main: 167899136 21:55:26 INFO - PROCESS | 1653 | 21:55:28 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 21:55:29 INFO - PROCESS | 1653 | RSS: Main: 215437312 21:55:29 INFO - PROCESS | 1653 | 21:55:32 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 21:55:32 INFO - PROCESS | 1653 | RSS: Main: 228945920 21:55:32 INFO - PROCESS | 1653 | 21:55:35 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 21:55:36 INFO - PROCESS | 1653 | RSS: Main: 325189632 21:55:36 INFO - PROCESS | 1653 | 21:55:38 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 21:55:39 INFO - PROCESS | 1653 | RSS: Main: 227860480 21:55:39 INFO - PROCESS | 1653 | 21:55:41 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:55:41 INFO - PROCESS | 1653 | RSS: Main: 228130816 21:55:41 INFO - PROCESS | 1653 | 21:55:44 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 21:55:45 INFO - PROCESS | 1653 | RSS: Main: 267890688 21:55:45 INFO - PROCESS | 1653 | 21:55:47 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 21:55:48 INFO - PROCESS | 1653 | RSS: Main: 271405056 21:55:48 INFO - PROCESS | 1653 | 21:55:51 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 21:55:51 INFO - PROCESS | 1653 | RSS: Main: 267071488 21:55:51 INFO - PROCESS | 1653 | 21:55:53 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:55:54 INFO - PROCESS | 1653 | RSS: Main: 245596160 21:55:54 INFO - PROCESS | 1653 | 21:55:56 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:55:56 INFO - PROCESS | 1653 | RSS: Main: 247877632 21:55:56 INFO - PROCESS | 1653 | 21:55:58 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:55:59 INFO - PROCESS | 1653 | RSS: Main: 253095936 21:55:59 INFO - PROCESS | 1653 | 21:56:02 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:56:02 INFO - PROCESS | 1653 | RSS: Main: 256282624 21:56:02 INFO - PROCESS | 1653 | 21:56:05 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:56:06 INFO - PROCESS | 1653 | RSS: Main: 257892352 21:56:06 INFO - PROCESS | 1653 | 21:56:08 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 21:56:08 INFO - PROCESS | 1653 | RSS: Main: 302448640 21:56:08 INFO - PROCESS | 1653 | 21:56:08 INFO - PROCESS | 1653 | __start_tp_report 21:56:08 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 21:56:08 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 21:56:08 INFO - PROCESS | 1653 | |i|pagename|runs| 21:56:08 INFO - PROCESS | 1653 | |0;ai-astar;110;112;114;112;112;116;113;113;113;114 21:56:08 INFO - PROCESS | 1653 | |1;audio-beat-detection;135;105;103;139;108;105;106;97;125;104 21:56:08 INFO - PROCESS | 1653 | |2;audio-dft;186;187;184;184;183;184;182;184;182;200 21:56:08 INFO - PROCESS | 1653 | |3;audio-fft;79;57;58;88;58;60;57;58;73;58 21:56:08 INFO - PROCESS | 1653 | |4;audio-oscillator;83;69;85;68;68;68;81;69;70;80 21:56:08 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;87;84;87;84;88;83;88;85;87;84 21:56:08 INFO - PROCESS | 1653 | |6;imaging-darkroom;94;94;94;96;93;94;94;94;93;93 21:56:08 INFO - PROCESS | 1653 | |7;imaging-desaturate;86;86;85;88;87;86;87;86;87;87 21:56:08 INFO - PROCESS | 1653 | |8;json-parse-financial;54;51;52;53;56;52;54;76;79;80 21:56:08 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;65;70;75;73;71;66;67;68;68;67 21:56:08 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;81;86;84;83;83;81;83;80;88;106 21:56:08 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;133;147;132;130;132;133;129;134;145;133 21:56:08 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;173;161;161;162;163;160;168;214;183;160 21:56:08 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;64;65;65;63;65;63;62;65;62;64 21:56:08 INFO - PROCESS | 1653 | __end_tp_report 21:56:08 INFO - PROCESS | 1653 | __start_cc_report 21:56:08 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1971 21:56:08 INFO - PROCESS | 1653 | __end_cc_report 21:56:08 INFO - PROCESS | 1653 | __startTimestamp1491281768327__endTimestamp 21:56:08 INFO - PROCESS | 1653 | 21:56:08 INFO - PROCESS | 1653 | ------- Summary: start ------- 21:56:08 INFO - PROCESS | 1653 | Number of tests: 14 21:56:08 INFO - PROCESS | 1653 | 21:56:08 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:1.60 (1.4%) stddev-sans-first:1.30 21:56:08 INFO - PROCESS | 1653 | Values: 110.0 112.0 114.0 112.0 112.0 116.0 113.0 113.0 113.0 114.0 21:56:08 INFO - PROCESS | 1653 | 21:56:08 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:112.70 Median:116.50 stddev:14.69 (12.6%) stddev-sans-first:13.18 21:56:08 INFO - PROCESS | 1653 | Values: 135.0 105.0 103.0 139.0 108.0 105.0 106.0 97.0 125.0 104.0 21:56:08 INFO - PROCESS | 1653 | 21:56:08 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:185.60 Median:184.00 stddev:5.30 (2.9%) stddev-sans-first:5.61 21:56:08 INFO - PROCESS | 1653 | Values: 186.0 187.0 184.0 184.0 183.0 184.0 182.0 184.0 182.0 200.0 21:56:08 INFO - PROCESS | 1653 | 21:56:08 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:64.60 Median:59.00 stddev:11.24 (19.0%) stddev-sans-first:10.64 21:56:08 INFO - PROCESS | 1653 | Values: 79.0 57.0 58.0 88.0 58.0 60.0 57.0 58.0 73.0 58.0 21:56:08 INFO - PROCESS | 1653 | 21:56:08 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:74.10 Median:75.00 stddev:7.16 (9.5%) stddev-sans-first:6.83 21:56:08 INFO - PROCESS | 1653 | Values: 83.0 69.0 85.0 68.0 68.0 68.0 81.0 69.0 70.0 80.0 21:56:08 INFO - PROCESS | 1653 | 21:56:08 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:85.70 Median:87.00 stddev:1.89 (2.2%) stddev-sans-first:1.94 21:56:08 INFO - PROCESS | 1653 | Values: 87.0 84.0 87.0 84.0 88.0 83.0 88.0 85.0 87.0 84.0 21:56:08 INFO - PROCESS | 1653 | 21:56:08 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:93.90 Median:94.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 21:56:08 INFO - PROCESS | 1653 | Values: 94.0 94.0 94.0 96.0 93.0 94.0 94.0 94.0 93.0 93.0 21:56:08 INFO - PROCESS | 1653 | 21:56:08 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:86.50 Median:87.00 stddev:0.85 (1.0%) stddev-sans-first:0.88 21:56:08 INFO - PROCESS | 1653 | Values: 86.0 86.0 85.0 88.0 87.0 86.0 87.0 86.0 87.0 87.0 21:56:08 INFO - PROCESS | 1653 | 21:56:08 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:60.70 Median:55.00 stddev:12.28 (22.3%) stddev-sans-first:12.79 21:56:08 INFO - PROCESS | 1653 | Values: 54.0 51.0 52.0 53.0 56.0 52.0 54.0 76.0 79.0 80.0 21:56:08 INFO - PROCESS | 1653 | 21:56:08 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:3.20 (4.6%) stddev-sans-first:3.05 21:56:08 INFO - PROCESS | 1653 | Values: 65.0 70.0 75.0 73.0 71.0 66.0 67.0 68.0 68.0 67.0 21:56:08 INFO - PROCESS | 1653 | 21:56:08 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:83.00 stddev:7.59 (9.1%) stddev-sans-first:7.87 21:56:08 INFO - PROCESS | 1653 | Values: 81.0 86.0 84.0 83.0 83.0 81.0 83.0 80.0 88.0 106.0 21:56:08 INFO - PROCESS | 1653 | 21:56:08 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:134.80 Median:133.00 stddev:6.11 (4.6%) stddev-sans-first:6.44 21:56:08 INFO - PROCESS | 1653 | Values: 133.0 147.0 132.0 130.0 132.0 133.0 129.0 134.0 145.0 133.0 21:56:08 INFO - PROCESS | 1653 | 21:56:08 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.50 Median:165.50 stddev:16.97 (10.3%) stddev-sans-first:17.97 21:56:08 INFO - PROCESS | 1653 | Values: 173.0 161.0 161.0 162.0 163.0 160.0 168.0 214.0 183.0 160.0 21:56:08 INFO - PROCESS | 1653 | 21:56:08 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.50 stddev:1.23 (1.9%) stddev-sans-first:1.30 21:56:08 INFO - PROCESS | 1653 | Values: 64.0 65.0 65.0 63.0 65.0 63.0 62.0 65.0 62.0 64.0 21:56:08 INFO - PROCESS | 1653 | -------- Summary: end -------- 21:56:08 INFO - PROCESS | 1653 | 21:56:09 INFO - TEST-INFO | 1653: exit 0 21:56:09 INFO - TEST-OK | kraken | took 58091ms 21:56:09 INFO - SUITE-END | took 1175s 21:56:09 INFO - Completed test suite (00:19:36) 21:56:09 INFO - javascript benchmark 21:56:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3466.133466633342, 3487.9651203487956, 3493.7205023598117, 3499.52756377889, 3542.0967653248417, 5911.674857882815, 5971.82084537464, 5988.401159884021, 5992.430719081685, 6004.699765011754, 5975.88048239036, 6066.1810655561485, 6067.211262535864, 6076.544259180568, 6084.5132389408855, 5207.817726379578, 5378.435264297242, 5388.757505912224, 5412.4587541245755, 5436.864078398032, 4504.864854054384, 5363.410024897258, 5372.865678358034, 5378.542823859977, 5508.807191748289, 5403.648762830423, 5408.594355423339, 5410.404855465896, 5449.291592093023, 5479.479449452296, 5451.400345961941, 5458.754356053947, 5460.672359658433, 5471.699056551908, 5480.177973303997, 5353.0, 5373.785048598052, 5379.058664733656, 5387.946120538783, 5391.838244852661, 4750.762461876892, 5828.0966450200285, 5839.386864379221, 5881.3530511643685, 5904.380040095771, 6266.436020758154, 6269.122322874801, 6272.529560282951, 6279.560430769848, 6304.968475157641, 5878.970605146947, 6366.0, 6372.7132279047555, 6377.23473183221, 6393.200849893763, 5965.4929331006915, 6065.059915713072, 6070.0591408331775, 6118.1128736332985, 6175.475084617813, 6368.522360822864, 6375.0, 6400.23197216337, 6400.743970241138, 6460.515461340418, 6226.972549529368, 6237.96881015592, 6238.937610623836, 6242.75028998844, 6250.874982500324, 6344.746210151635, 6374.075759014917, 6377.96811015942, 6379.0, 6399.872002560016, 6176.135341052256, 6221.502279817694, 6255.343188965184, 6276.152719382916, 6277.654728989858, 6197.1324014637985, 6248.687565621701, 6271.43557079865, 6276.937230627726, 6287.339829317947, 5136.152534831711, 5173.301604283449, 5177.094008548489, 5182.0, 5207.0887594670785, 4568.0, 4623.12160689468, 4624.098300831306, 4637.095766325534, 4672.719636821802, 5978.940210597925, 6037.879242415127, 6050.6369617823075, 6126.846828829315, 6135.386461353829, 6371.139896114058, 6397.7440902364315, 6433.163688720437, 6438.613683178931, 6457.903131453032, 6028.608140470856, 6089.330173680892, 6093.994490909039, 6108.511319094462, 6118.235220597426, 5542.91685624716, 5653.519450846642, 5702.45826646468, 5706.657600543981, 5715.799947001835, 6395.93604063972, 6407.935920640827, 6419.903701444388, 6467.191601049869, 6488.708008139645, 6314.431701146918, 6320.051992201023, 6325.96837015812, 6327.905081423874, 6330.3669633036325, 6496.415322620986, 6546.803595892131, 6556.573822701509, 6561.376669216417, 6574.605523668595, 6145.095020543467, 6208.534359923115, 6240.344763799736, 6248.375162483715, 6282.057691346335, 6243.875122497616, 6376.298607153302, 6377.744890204525, 6394.616323020634, 6397.712102955285, 6221.751129954751, 6230.096635987666, 6232.345603711545, 6239.937600624117, 6245.156903817927, 6164.4143806338325, 6174.38256174379, 6203.96898015507, 6216.875662486635, 6253.8749225014335, 6208.844778880564, 6215.12988181664, 6257.906131407942, 6259.6870156492905, 6263.091851681572, 5595.235128467019, 5925.614835035709, 6242.090263176194, 6247.12540244357, 6250.218722659668, 6121.3572574879, 6171.0, 6207.937920620736, 6232.719527621177, 6254.9687251563455], "value": 5871.166822081799, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [504.183223178451, 525.9684418934864, 530.3105962249073, 541.5856869494837, 550.1774846604327, 32506.512402313983, 42697.786511067476, 44120.779396103055, 44142.77928610361, 44218.33672494915, 45328.77335613317, 45684.77157614207, 45736.54263457364, 45809.54190458095, 45829.31256031162, 9140.085991400872, 9356.953215233914, 9726.17327527161, 9909.554070066828, 9930.45382503962, 11884.643460696192, 12111.757764844699, 12129.454174562166, 12267.693307667336, 12281.508739650404, 12072.456739446701, 12087.637370878887, 12158.817617735742, 12174.756504869898, 12185.695357616041, 12092.637220883344, 12166.209196402295, 12167.209131406431, 12171.93914030433, 12196.329201893892, 11967.94016029923, 12058.397080145958, 12070.034397248286, 12079.698007549794, 12090.032797376276, 42486.362704559455, 42785.35821962673, 42804.785976070234, 42829.785851070854, 42851.928701782395, 4101.815418306153, 4125.711200215986, 4160.251154792136, 4160.820022888995, 4179.498460184797, 30803.69196308053, 31278.905238316776, 32480.512792307898, 32775.836120819484, 32794.016179514656, 3386.779859309137, 3416.9658303416895, 3420.7605467617277, 3556.8577256909693, 3559.5906470755936, 496272.0, 504386.0, 505450.9454905441, 505973.0, 506250.0, 55599.61000975008, 65743.67128164328, 65978.67010664917, 66013.0, 66025.66987165129, 69376.0, 69951.0, 70026.29973700299, 70076.0, 70207.64896175487, 17369.13154342278, 18002.639947200983, 18046.2781488739, 18053.7291940621, 18057.819421805878, 12605.873941260654, 12858.742825143632, 12883.35583220854, 13567.0, 13885.791713124312, 15601.921990389976, 15694.9215253923, 15707.0, 17528.474145775646, 17668.823311766973, 6621.205455345389, 6728.697208625624, 6729.25978142404, 6753.189617245864, 6772.2211945625895, 878.4246318661287, 879.9560021998874, 894.2309613732185, 923.9122283383068, 927.457437399129, 30210.84894575513, 31049.68950310513, 31158.22104447407, 31491.212719682193, 32024.0, 929.7489677786959, 1052.2423854824515, 1061.7345663584103, 1081.0756802933536, 1115.9119858138413, 16029.839701603069, 16444.506664800076, 16450.095244761415, 16455.25951332193, 16828.579285517717, 639016.0, 642898.0, 642969.0, 643935.0, 644112.0, 64210.0, 64502.0, 64611.0, 64724.35275647278, 64754.0, 1324.5165514587106, 1397.1337770582506, 1455.483303427268, 1496.2294418374545, 1521.239380309845, 30626.234344141576, 32795.0, 32910.01269961905, 33027.348632567795, 33645.49531757075, 45301.546984529734, 53414.73292633512, 53931.0, 54240.91518169535, 54311.45688543064, 512791.0, 513868.0, 514918.0, 515218.0, 515248.0, 36910.44634330541, 37732.62267377291, 42581.36127958145, 42868.14263714771, 43756.78121609372, 49271.0, 49515.25727114024, 49869.75065124796, 51396.74301628468, 51396.74301628618, 31445.842770786, 33607.66392336143, 33828.83085584556, 34577.78977735868, 35140.64859351374, 30561.694383056772, 33678.83160584181, 34690.0, 34724.0, 35373.0, 38573.42139867848, 39129.80435097806, 40364.99087522835, 40453.59546404616, 40525.79737101296, 33430.49854252237, 33856.66143338535, 34540.65459345475, 35099.82450087733, 35277.82361088178, 25089.24732258035, 26075.0, 26429.678516073734, 26496.602550961365, 26947.461050779268], "value": 21150.123935264968, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.1923426165222, 399.6363309388455, 404.33285079618605, 412.87200967700016, 433.6237418944186, 20182.293619723314, 21293.57412851742, 21776.693398396088, 22605.0, 22641.433964150903, 23327.300180994596, 23680.76319236807, 23779.643305350433, 23911.64132538009, 24017.639735403984, 6029.849253768647, 6323.77866774663, 6347.270063942637, 6355.2373715154245, 6360.650164240965, 5919.260092488439, 6234.563580549363, 6295.0, 6301.432871041606, 6304.085907543404, 6021.367756385582, 6255.530835187356, 6257.18656574647, 6269.2476902771505, 6274.058891166339, 6136.96931515344, 6164.198654174951, 6180.6291622502795, 6219.720112594944, 6222.377762223764, 5322.0952438085615, 5430.0768869292315, 5515.586331025189, 5516.862078448031, 5520.585956053312, 21653.566928661498, 28015.0, 28101.73542190606, 28108.891833112597, 28388.574171387445, 3170.6353769316593, 3206.118317462693, 3274.0341599228286, 3279.468387173511, 3356.9090045735234, 12559.56041538551, 17019.0, 17035.48893533196, 17079.573010674707, 17660.735088973677, 1866.7386565880788, 1900.9524761880925, 1928.9780807017385, 1942.3493129801534, 1955.0127185771094, 123092.0, 123165.0, 123175.0, 127408.72591274061, 128283.07575386284, 11704.414779261004, 11774.764504709858, 11800.76398472043, 11891.0, 12056.698582535331, 15595.0, 15599.220038998004, 15615.921920390325, 15628.765568516481, 15636.687266254612, 8699.391042627081, 9026.413283136575, 9037.77405564866, 9116.088391160964, 9145.085491450935, 7388.778336649909, 7614.771556853303, 8878.73363799087, 8923.464592124494, 9015.549222538846, 6240.065579670317, 6364.872702545923, 7696.884546731803, 7744.0707115145415, 7748.031496062992, 1701.7277235642239, 1960.3432849995127, 1983.890886001284, 1990.532224927141, 1993.6511110555596, 1061.4851796878509, 1081.302559848893, 1085.0993675249524, 1089.5750657243682, 1138.7494751154732, 22923.73919434447, 23450.723587193086, 24412.87793561021, 24493.755062449505, 25228.873855630605, 887.6050157679899, 889.8709687095335, 952.1288021460286, 961.1974001708512, 1001.5743309093606, 11143.944280278709, 11714.23857449263, 11744.354060526754, 11744.882551174378, 11751.706207344885, 769271.0, 811121.0, 818578.0, 841088.0, 844309.0, 96448.51775741216, 109247.36128958072, 121818.3909080449, 142797.0, 158028.20985894997, 1090.4275255490932, 1151.0963893343517, 1169.7251145980688, 1170.0288760328906, 1172.7771723372532, 20654.586908262052, 22125.889370553043, 22158.77841221567, 22185.556288874453, 22338.553228935005, 47457.762711186224, 58553.12170317364, 59510.40489595049, 62553.37446625657, 63719.0, 97012.54481182928, 97344.51327743316, 97354.0264597345, 97395.51302243443, 99819.0, 7444.73943411978, 8279.758036294605, 8631.731080710722, 8964.955175224082, 9137.40606860552, 11582.0, 13581.45674173022, 13714.588562343146, 14191.929040354733, 14212.21832799206, 11683.0, 11751.76496470083, 11879.58421455245, 11883.702907427383, 11913.795947749693, 11215.214934954474, 11271.49278282463, 11311.377874216998, 11450.255733377304, 11535.480903359537, 10136.847947280648, 11976.880231197576, 11992.400379980792, 12049.409376983991, 12072.275663460221, 8074.232947869943, 8628.266597339045, 8755.824883502168, 8865.778355541162, 8900.154485323885, 9294.535273236175, 11551.422428878355, 11670.416479176178, 11826.881731182579, 12099.0], "value": 10605.92931043343, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1462.1519518679168, 1483.8441963593823, 1515.1515151515152, 1515.7953676253703, 1519.992400038, 7529.623518824064, 8247.134050924657, 8487.533185674785, 8600.698975535857, 8637.963444386674, 7328.816779580513, 7575.090989081318, 7575.962120189405, 8229.91770082299, 8456.450330728498, 2382.452036031709, 2422.2975337152207, 2423.418379588895, 2426.3934016495878, 2427.4174198192395, 2391.5097405031925, 2412.2522018174336, 2422.067504010951, 2430.003698483622, 2431.671724317212, 2032.3801240621603, 2375.6555299481565, 2386.95226095478, 2402.95194096118, 2415.4444477770126, 2343.7070366204225, 2364.645303204516, 2387.7612238776155, 2388.665586817847, 2389.23544465771, 2397.077125306752, 2418.322869596516, 2418.806495480357, 2418.9395265118337, 2419.8427102238297, 8422.24199822019, 8599.355048371397, 8601.268892144175, 8614.52620105894, 8614.698485552975, 5185.092608793446, 5350.384705758848, 5357.866053348697, 5359.249705041298, 5360.839174824761, 3369.747268954838, 3494.3710132176197, 3628.5827129880136, 3661.121330880596, 3668.761530500509, 1068.3322923173016, 1227.5458080510268, 1298.0653929170983, 1321.266696983174, 1814.954626134344, 10891.727706807393, 11073.446327683583, 11112.944435277772, 11120.666380008613, 11137.387443690513, 4346.434963454793, 4573.039661671086, 4641.930371044437, 4649.558291962258, 4651.093036857848, 8897.288216942628, 8904.421212621159, 8912.643494260157, 8919.955400222958, 8939.106089391009, 4844.854654360375, 4979.779953911315, 5269.868253293698, 5274.182501712241, 5276.3932147802725, 4139.97930010348, 4366.476022877211, 4946.4064312282035, 4947.307376967227, 4967.155583550805, 3754.1740817020213, 3780.0360907968293, 3839.9424008639894, 3863.632954869283, 3868.2456920900154, 1164.5225457562358, 1171.5138217639585, 1174.442139983518, 1179.929204247748, 1184.3426898071652, 905.6060613633091, 917.2295271971576, 926.7914719188128, 927.675313640234, 975.6195083917278, 5126.410462796752, 5481.342238931274, 5623.803166889139, 5682.602217844794, 5880.647161170344, 545.7435005547386, 575.4906907386993, 577.587025276929, 581.2771233725977, 602.0277252237693, 3508.7193024558483, 3790.2419516096893, 3848.9807550962064, 3879.8254078566533, 3882.3400021996326, 9882.209423246122, 10155.339902906288, 10248.282620216512, 10258.025487578669, 10270.0, 9717.805643887083, 10132.088112069949, 10149.086582207638, 10149.898501014895, 10193.74515637115, 6936.895946560806, 7885.44801863864, 8074.071481779671, 8080.515169089756, 8086.514809111354, 5248.816291429782, 5455.318085239345, 5695.914561281667, 5701.458361455655, 6148.047052706837, 8594.269487093417, 9124.087591240823, 9204.355695101278, 9213.309001824757, 9358.812823743623, 7000.0, 9252.074792520694, 9257.074292570689, 9368.859467108136, 9380.530973451163, 6770.45836333102, 6945.479089068441, 6946.5137440378685, 7249.637518124178, 7415.147258065392, 7451.478396512192, 7910.9604451977375, 8002.639881205243, 8091.595420228848, 8104.392170587112, 6781.864362712817, 6895.322763475211, 7062.0, 7138.643067846483, 7198.748043818441, 6905.723771049102, 6913.412359949461, 6933.791986240421, 6978.511504194657, 6988.6505674715045, 6399.904001439889, 6404.199475065617, 6491.545591808528, 6507.219133703797, 6512.348765123639, 4935.259711043373, 4992.550670439678, 5002.349694539686, 5060.342155519759, 5066.06277838601, 4949.341970439799, 5062.645614806928, 5103.948960510347, 5176.50823171798, 5263.894722105613], "value": 4402.952579177969, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.8704930978299, 376.75510917903364, 384.2430412088186, 395.16619931943575, 395.73683500472185, 4786.736729479877, 4863.854084377465, 5091.745412729368, 5166.889118839449, 5578.24693666355, 3832.501774769283, 4660.510646382132, 5212.973935130329, 5236.664650514123, 5381.816000479898, 4229.217594744982, 4284.271673815443, 4290.1949816205815, 4294.377315289296, 4339.1972485090355, 3558.8220588970576, 4111.951452379639, 4139.482564679415, 4290.712786164154, 4291.180849044353, 3621.1852333224947, 3866.6326698963553, 4050.0, 4261.998430368861, 4262.829486820523, 3419.469592501556, 4280.019581788935, 4287.742735435852, 4309.224339618867, 4313.590208930163, 3804.714646401503, 3818.236352729465, 3821.9044523886846, 3823.388257878754, 3828.3874580067336, 4480.551944805526, 5074.908894587645, 5233.874716935877, 5363.9463605363835, 5365.839024829262, 4918.631102667278, 4952.133376659071, 4980.505848245548, 4983.875403114915, 4988.501149884983, 4909.361782968192, 5788.594798364116, 5811.0411782056335, 5823.417658234185, 5864.501517370986, 3129.6840338149605, 4205.453291072172, 4221.219074471202, 4259.659227261812, 4261.31818908973, 5386.649867758544, 5756.712164391805, 5932.40675932412, 6050.576459647827, 6086.421789929949, 4021.597840215955, 4034.9596504034585, 4045.7370270932297, 4068.3897415387337, 4083.4283200351974, 3664.908377290589, 4138.586141385837, 4145.662741493127, 4164.479440069991, 4175.498940127204, 3924.2151569685607, 4118.567550407224, 4967.2549117631925, 5016.799328026838, 5025.195968644999, 5134.435212126663, 5912.46787789101, 5918.556108291896, 5935.614185077956, 5939.673317967553, 1284.4348486665838, 1302.1926405628572, 1326.8341457317836, 1363.4682473835212, 1441.3153751967732, 927.9884925431178, 980.4215512847454, 1017.9032991865761, 1020.4438580973388, 1042.47876061969, 4275.40144379787, 4307.095509942885, 4581.702189357681, 4877.634177436636, 5151.562117220078, 5307.336582927134, 5661.858453538612, 5704.3154821421695, 5731.598788084794, 5812.360640329561, 4463.531329210451, 4695.43654761424, 4859.611231101503, 5185.455527169668, 5221.503957124067, 2352.600202879284, 2574.1633968960164, 2693.3739603886056, 2725.74105459981, 3014.7588192944513, 4870.537298956664, 5064.594832413398, 5232.3459567554055, 5886.085118925659, 5936.851578710481, 4827.758612069382, 5219.504147106095, 5408.891822163535, 5697.974364614409, 5832.445917637818, 5067.4932506749765, 5104.3109180260935, 5242.165242165212, 5720.914186287209, 5961.523078153824, 5262.710550919736, 5404.567944424946, 5643.181738647955, 5654.236678048575, 5654.773809047592, 4520.683552151318, 4990.226514890198, 5024.6231532634465, 5380.923815237046, 5559.137044422207, 5071.949280507295, 5259.737013149251, 5639.210510528611, 5912.379200183918, 5929.911051334319, 3490.7730997485082, 3900.2004589059743, 4028.5367182774357, 4128.731632443882, 4145.79271036441, 4850.854474365775, 4889.804407823647, 5159.974200128975, 5649.305208437535, 5801.3908539602735, 4684.601808846286, 5379.229696706121, 5572.777088916398, 5801.0, 5841.2406387171095, 5122.974385128199, 5739.167820666064, 5786.42135786418, 5819.592628515963, 5819.912701309569, 4751.429828420612, 4906.607471402351, 5439.292891924183, 5556.749301658575, 5588.832335029955, 4746.81963084741, 4840.878978025577, 5334.306540149911, 5794.2177805997335, 5833.708314584339, 4938.777755001105, 5031.874203144951, 5654.547636189177, 5695.686737229492, 5723.656580605177], "value": 4141.089660223317, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.9554226746399, 766.76613632842, 791.394583143895, 870.2428886868423, 882.0694167653128, 15309.923450382761, 15351.769723454143, 15825.84174158258, 16179.0, 16292.592685182877, 14573.6356591085, 14777.187254701013, 14860.405583776635, 15001.249937503137, 15018.098914065136, 898.4474548152872, 908.1780988205652, 911.7355966769629, 912.8539433690611, 912.9041450647686, 707.6214225389417, 733.4462480826995, 737.0418456007196, 738.1879932074728, 902.9909700903005, 775.244136966456, 929.2333824594702, 963.59047404853, 963.8120566489538, 970.5826494607317, 960.8414611589079, 961.3126614470652, 961.6009356117273, 962.1340793286029, 963.5086106085877, 711.3668834737089, 712.6223101756077, 712.8503014366989, 712.9073220481356, 713.1727196452142, 15385.538313869727, 15543.222838858124, 15567.766483502757, 15627.29677164519, 15739.606509837231, 11762.66962060369, 12943.935280323632, 13287.0, 14198.57404277863, 14200.431982720678, 10313.0, 12626.322909206645, 12858.164219325807, 12918.935405323007, 13231.669208269774, 4354.86288026373, 4405.691601587891, 4510.571495707903, 4530.79611417487, 4668.50980647034, 98209.0, 103523.0, 103864.0, 104712.0, 104868.47565762198, 11088.390138542458, 11118.444077796077, 11203.047740941949, 11238.606648767418, 11799.646010619696, 21663.458413539473, 21822.454438638844, 21896.343109706733, 22287.554248915254, 22302.776972230393, 7940.761777146695, 7963.8407231855035, 8012.959935200287, 8045.195480452025, 8091.878621820678, 4403.559644035635, 4429.335599660077, 4447.911041779146, 4503.986603014361, 4504.932426013613, 3183.5065564837487, 3547.9067350263467, 3608.9458658120147, 3612.187257866959, 3615.493830863681, 655.3021032600266, 657.3853447027045, 661.3386613386614, 673.8012286375531, 677.5257319876107, 602.6052935327367, 604.4922265297172, 623.800383877164, 628.0328294426532, 639.0733436516977, 8625.870611940825, 9560.904390956, 10137.898621013843, 10184.6435374763, 10642.893571064345, 572.5076434266527, 643.1831573901119, 671.8723442545901, 672.6300534705892, 675.6891829758268, 4664.953350466452, 4822.0, 4833.226683730657, 4851.611871050308, 4851.975740121276, 94192.52903735437, 94446.0, 95063.52468237752, 96468.51765741127, 99738.0, 86977.0, 88066.11933880707, 88155.0, 89121.9999999987, 90158.54920725485, 78434.0, 80458.39083218302, 80955.0, 81553.59223204083, 82737.75893361605, 7945.562994035384, 9221.492817894812, 9430.335623942057, 9441.622335106518, 9449.055094490495, 53104.20343694925, 53133.20300195423, 53368.0, 53597.73201133969, 54510.18234726403, 53100.67248318668, 68988.6550567244, 70267.0, 70592.6470367645, 73688.89466657897, 10594.31136976094, 11129.387883666475, 11686.357250351311, 11708.824367634663, 11782.705432364259, 11987.902117129643, 12003.459844307201, 12019.507737539496, 12122.969547588555, 12292.201006934522, 11136.443177841238, 11893.821592675944, 11993.76012479728, 12012.459439325077, 12164.817527736914, 11033.613823516138, 11846.0, 11846.78359078542, 11879.346635935106, 11912.40437978115, 11198.38408887519, 11375.146863985068, 11788.410579470821, 11810.468528916048, 11912.642620721392, 8577.614007369559, 8926.201518021093, 8953.641854325753, 9016.504092274989, 9030.32272579546, 9524.374332819347, 9647.807043859224, 9655.565499552396, 9667.419954802734, 9677.612895484102], "value": 7367.4451597438865, "unit": "score"}], "name": "dromaeo_css", "value": 7492.64730984281, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 114.0, 112.0, 112.0, 116.0, 113.0, 113.0, 113.0, 114.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 105.0, 103.0, 139.0, 108.0, 105.0, 106.0, 97.0, 125.0, 104.0], "value": 112.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 187.0, 184.0, 184.0, 183.0, 184.0, 182.0, 184.0, 182.0, 200.0], "value": 185.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 57.0, 58.0, 88.0, 58.0, 60.0, 57.0, 58.0, 73.0, 58.0], "value": 64.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 69.0, 85.0, 68.0, 68.0, 68.0, 81.0, 69.0, 70.0, 80.0], "value": 74.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 84.0, 88.0, 83.0, 88.0, 85.0, 87.0, 84.0], "value": 85.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 96.0, 93.0, 94.0, 94.0, 94.0, 93.0, 93.0], "value": 93.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 85.0, 88.0, 87.0, 86.0, 87.0, 86.0, 87.0, 87.0], "value": 86.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 51.0, 52.0, 53.0, 56.0, 52.0, 54.0, 76.0, 79.0, 80.0], "value": 60.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 70.0, 75.0, 73.0, 71.0, 66.0, 67.0, 68.0, 68.0, 67.0], "value": 69.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 86.0, 84.0, 83.0, 83.0, 81.0, 83.0, 80.0, 88.0, 106.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 147.0, 132.0, 130.0, 132.0, 133.0, 129.0, 134.0, 145.0, 133.0], "value": 134.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 161.0, 161.0, 162.0, 163.0, 160.0, 168.0, 214.0, 183.0, 160.0], "value": 170.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 63.0, 65.0, 63.0, 62.0, 65.0, 62.0, 64.0], "value": 63.8, "unit": "score"}], "name": "kraken", "value": 1400.3000000000002, "alertThreshold": 2.0}]} 21:56:09 INFO - Return code: 0 21:56:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:56:09 INFO - # TBPL SUCCESS # 21:56:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:56:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:56:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:56:09 INFO - 2017-04-03 21:56:09.661 screenresolution[1657:9595] starting screenresolution argv=screenresolution get 21:56:09 INFO - 2017-04-03 21:56:09.663 screenresolution[1657:9595] Display 0: 1600x1200x32@60 21:56:09 INFO - 2017-04-03 21:56:09.669 screenresolution[1658:9598] starting screenresolution argv=screenresolution list 21:56:09 INFO - Available Modes on Display 0 21:56:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:56:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:56:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:56:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:56:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:56:09 INFO - Intel Iris: 21:56:09 INFO - Chipset Model: Intel Iris 21:56:09 INFO - Type: GPU 21:56:09 INFO - Bus: Built-In 21:56:09 INFO - VRAM (Dynamic, Max): 1536 MB 21:56:09 INFO - Vendor: Intel (0x8086) 21:56:09 INFO - Device ID: 0x0a2e 21:56:09 INFO - Revision ID: 0x0009 21:56:09 INFO - Displays: 21:56:09 INFO - Display: 21:56:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:56:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:56:09 INFO - Display Serial Number: 1600x1200 60 21:56:09 INFO - Main Display: Yes 21:56:09 INFO - Mirror: Off 21:56:09 INFO - Online: Yes 21:56:09 INFO - Rotation: Supported 21:56:09 INFO - Return code: 0 21:56:09 INFO - Running post-action listener: _resource_record_post_action 21:56:09 INFO - [mozharness: 2017-04-04 04:56:09.904622Z] Finished run-tests step (success) 21:56:09 INFO - Running post-run listener: _resource_record_post_run 21:56:09 INFO - Total resource usage - Wall time: 1191s; CPU: 54.0%; Read bytes: 37954560; Write bytes: 420193280; Read time: 240; Write time: 1379 21:56:09 INFO - TinderboxPrint: CPU usage
53.6% 21:56:09 INFO - TinderboxPrint: I/O read bytes / time
37,954,560 / 240 21:56:09 INFO - TinderboxPrint: I/O write bytes / time
420,193,280 / 1,379 21:56:09 INFO - TinderboxPrint: CPU idle
2,211.9 (46.4%) 21:56:09 INFO - TinderboxPrint: CPU system
949.1 (19.9%) 21:56:09 INFO - TinderboxPrint: CPU user
1,604.7 (33.7%) 21:56:09 INFO - TinderboxPrint: Swap in / out
160,079,872 / 0 21:56:09 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 109783552; Write bytes: 102170624; Read time: 9984; Write time: 229 21:56:09 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 37053440; Write bytes: 297493504; Read time: 228; Write time: 1090 21:56:10 INFO - Running post-run listener: _upload_blobber_files 21:56:10 INFO - Blob upload gear active. 21:56:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:56:10 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 21:56:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:56:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:56:10 INFO - (blobuploader) - INFO - Open directory for files ... 21:56:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:56:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:56:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:56:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:56:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:56:11 INFO - (blobuploader) - INFO - Done attempting. 21:56:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:56:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:56:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:56:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:56:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:56:12 INFO - (blobuploader) - INFO - Done attempting. 21:56:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:56:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:56:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:56:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:56:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:56:13 INFO - (blobuploader) - INFO - Done attempting. 21:56:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:56:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:56:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:56:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:56:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:56:15 INFO - (blobuploader) - INFO - Done attempting. 21:56:15 INFO - (blobuploader) - INFO - Iteration through files over. 21:56:15 INFO - Return code: 0 21:56:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:56:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:56:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/58a601b090442a1971f863e9d4376142658c78c5aafb6f05462fbd60552699bb6b7c25ad812ea4f2a3d8b109912443e3f3f0ebac2652f1fd74b305baf60356c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c17a7cc2036b2ababab649b158ef214fd09b00479e00130c44bfa3c1a008ee6c08508bc49581e5eba3e4630cc7fe1762c58863ad8ec94496b9199abe2f06797", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5c947f4053a185aa1858bdd74c8abd541acae3600d1b0aab10c25d291154a92ec462d751e5580f00e887683ef45a78320f8f333f4dd7b8e743888686570f59bf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/32267129b2558be8bb57e7236cc2dc78d98592c8207450412522ccac4ac0d60a43c0683474e26393ef2dfd30160319d74161adc3a5e21cffac8c2320419077dd"} 21:56:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:56:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:56:15 INFO - Contents: 21:56:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/58a601b090442a1971f863e9d4376142658c78c5aafb6f05462fbd60552699bb6b7c25ad812ea4f2a3d8b109912443e3f3f0ebac2652f1fd74b305baf60356c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c17a7cc2036b2ababab649b158ef214fd09b00479e00130c44bfa3c1a008ee6c08508bc49581e5eba3e4630cc7fe1762c58863ad8ec94496b9199abe2f06797", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5c947f4053a185aa1858bdd74c8abd541acae3600d1b0aab10c25d291154a92ec462d751e5580f00e887683ef45a78320f8f333f4dd7b8e743888686570f59bf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/32267129b2558be8bb57e7236cc2dc78d98592c8207450412522ccac4ac0d60a43c0683474e26393ef2dfd30160319d74161adc3a5e21cffac8c2320419077dd"} 21:56:15 INFO - Running post-run listener: copy_logs_to_upload_dir 21:56:15 INFO - Copying logs to upload dir... 21:56:15 INFO - mkdir: /builds/slave/test/build/upload/logs 21:56:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.830254 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-04-03 21:56:15.742190) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-03 21:56:15.745889) ========= 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.V7LUAIbDkw/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.qFuSKi4fvN/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/58a601b090442a1971f863e9d4376142658c78c5aafb6f05462fbd60552699bb6b7c25ad812ea4f2a3d8b109912443e3f3f0ebac2652f1fd74b305baf60356c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c17a7cc2036b2ababab649b158ef214fd09b00479e00130c44bfa3c1a008ee6c08508bc49581e5eba3e4630cc7fe1762c58863ad8ec94496b9199abe2f06797", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5c947f4053a185aa1858bdd74c8abd541acae3600d1b0aab10c25d291154a92ec462d751e5580f00e887683ef45a78320f8f333f4dd7b8e743888686570f59bf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/32267129b2558be8bb57e7236cc2dc78d98592c8207450412522ccac4ac0d60a43c0683474e26393ef2dfd30160319d74161adc3a5e21cffac8c2320419077dd"} build_url:https://queue.taskcluster.net/v1/task/fY_qVQOBRyKsiozn9Kt5Fw/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010917 build_url: 'https://queue.taskcluster.net/v1/task/fY_qVQOBRyKsiozn9Kt5Fw/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/58a601b090442a1971f863e9d4376142658c78c5aafb6f05462fbd60552699bb6b7c25ad812ea4f2a3d8b109912443e3f3f0ebac2652f1fd74b305baf60356c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c17a7cc2036b2ababab649b158ef214fd09b00479e00130c44bfa3c1a008ee6c08508bc49581e5eba3e4630cc7fe1762c58863ad8ec94496b9199abe2f06797", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5c947f4053a185aa1858bdd74c8abd541acae3600d1b0aab10c25d291154a92ec462d751e5580f00e887683ef45a78320f8f333f4dd7b8e743888686570f59bf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/32267129b2558be8bb57e7236cc2dc78d98592c8207450412522ccac4ac0d60a43c0683474e26393ef2dfd30160319d74161adc3a5e21cffac8c2320419077dd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-03 21:56:15.780860) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 21:56:15.781254) ========= 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.V7LUAIbDkw/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.qFuSKi4fvN/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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.004890 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 21:56:15.830777) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-03 21:56:15.831138) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-03 21:56:15.831537) ========= ========= Total master_lag: 0.18 =========