builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0367 starttime: 1484996062.24 results: success (0) buildid: 20170121004004 builduid: b1e21b1400f94c1cb3f53e3f32612070 revision: a891cb2fa60257c3a8cb84bb0356fba508e42f3e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-21 02:54:22.237486) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-21 02:54:22.237921) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-21 02:54:22.238206) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-21 02:54:22.375512) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 02:54:22.375837) ========= 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.V1qt3aPRIe/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.k0GsS8XzNV/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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-01-21 02:54:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.17M=0.001s 2017-01-21 02:54:23 (8.17 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.168350 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 02:54:22.580421) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 02:54:22.580796) ========= 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.V1qt3aPRIe/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.k0GsS8XzNV/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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.020439 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 02:54:22.640626) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 02:54:22.640979) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a891cb2fa60257c3a8cb84bb0356fba508e42f3e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a891cb2fa60257c3a8cb84bb0356fba508e42f3e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.V1qt3aPRIe/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.k0GsS8XzNV/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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-01-21 02:54:23,199 truncating revision to first 12 chars 2017-01-21 02:54:23,200 Setting DEBUG logging. 2017-01-21 02:54:23,200 attempt 1/10 2017-01-21 02:54:23,200 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a891cb2fa602?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-21 02:54:23,872 unpacking tar archive at: mozilla-aurora-a891cb2fa602/testing/mozharness/ program finished with exit code 0 elapsedTime=0.932276 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 02:54:23.618444) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-21 02:54:23.618785) ========= script_repo_revision: a891cb2fa60257c3a8cb84bb0356fba508e42f3e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-21 02:54:23.619173) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-21 02:54:23.619455) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-21 02:54:23.640066) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2017-01-21 02:54:23.640343) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.V1qt3aPRIe/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.k0GsS8XzNV/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 02:54:24 INFO - MultiFileLogger online at 20170121 02:54:24 in /builds/slave/test 02:54:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:54:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:54:24 INFO - {'append_to_log': False, 02:54:24 INFO - 'base_work_dir': '/builds/slave/test', 02:54:24 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:54:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:54:24 INFO - 'branch': 'Mozilla-Aurora', 02:54:24 INFO - 'buildbot_json_path': 'buildprops.json', 02:54:24 INFO - 'config_files': ('talos/mac_config.py',), 02:54:24 INFO - 'default_actions': ('clobber', 02:54:24 INFO - 'read-buildbot-config', 02:54:24 INFO - 'download-and-extract', 02:54:24 INFO - 'populate-webroot', 02:54:24 INFO - 'create-virtualenv', 02:54:24 INFO - 'install', 02:54:24 INFO - 'run-tests'), 02:54:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:54:24 INFO - 'download_minidump_stackwalk': True, 02:54:24 INFO - 'download_symbols': 'ondemand', 02:54:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:54:24 INFO - 'tooltool.py': '/tools/tooltool.py', 02:54:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:54:24 INFO - '/tools/misc-python/virtualenv.py')}, 02:54:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:54:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:54:24 INFO - 'installer_path': 'installer.exe', 02:54:24 INFO - 'log_level': 'info', 02:54:24 INFO - 'log_name': 'talos', 02:54:24 INFO - 'log_to_console': True, 02:54:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:54:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:54:24 INFO - 'opt_config_files': (), 02:54:24 INFO - 'pip_index': False, 02:54:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:54:24 INFO - 'cmd': ('bash', 02:54:24 INFO - '-c', 02:54:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:54:24 INFO - 'enabled': True, 02:54:24 INFO - 'halt_on_failure': False, 02:54:24 INFO - 'name': 'check_screen_resolution'},), 02:54:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:54:24 INFO - 'cmd': ('bash', 02:54:24 INFO - '-c', 02:54:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:54:24 INFO - 'enabled': True, 02:54:24 INFO - 'halt_on_failure': False, 02:54:24 INFO - 'name': 'check_screen_resolution'},), 02:54:24 INFO - 'run_cmd_checks_enabled': True, 02:54:24 INFO - 'sps_profile': False, 02:54:24 INFO - 'sps_profile_interval': 0, 02:54:24 INFO - 'suite': 'dromaeojs', 02:54:24 INFO - 'system_bits': '32', 02:54:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:54:24 INFO - 'title': 't-yosemite-r7-0367', 02:54:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:54:24 INFO - 'use_talos_json': True, 02:54:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:54:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:54:24 INFO - 'work_dir': 'build'} 02:54:24 INFO - [mozharness: 2017-01-21 10:54:24.295665Z] Running clobber step. 02:54:24 INFO - Running pre-action listener: _resource_record_pre_action 02:54:24 INFO - Running main action method: clobber 02:54:24 INFO - rmtree: /builds/slave/test/build 02:54:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:54:26 INFO - Running post-action listener: _resource_record_post_action 02:54:26 INFO - [mozharness: 2017-01-21 10:54:26.307473Z] Finished clobber step (success) 02:54:26 INFO - [mozharness: 2017-01-21 10:54:26.307600Z] Running read-buildbot-config step. 02:54:26 INFO - Running pre-action listener: _resource_record_pre_action 02:54:26 INFO - Running main action method: read_buildbot_config 02:54:26 INFO - Using buildbot properties: 02:54:26 INFO - { 02:54:26 INFO - "project": "", 02:54:26 INFO - "product": "firefox", 02:54:26 INFO - "script_repo_revision": "production", 02:54:26 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:54:26 INFO - "repository": "", 02:54:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:54:26 INFO - "buildid": "20170121004004", 02:54:26 INFO - "stage_platform": "macosx64", 02:54:26 INFO - "basedir": "/builds/slave/test", 02:54:26 INFO - "nightly_build": "True", 02:54:26 INFO - "buildnumber": 35, 02:54:26 INFO - "slavename": "t-yosemite-r7-0367", 02:54:26 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 02:54:26 INFO - "platform": "yosemite_r7", 02:54:26 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:54:26 INFO - "branch": "mozilla-aurora", 02:54:26 INFO - "repo_path": "releases/mozilla-aurora", 02:54:26 INFO - "revision": "a891cb2fa60257c3a8cb84bb0356fba508e42f3e", 02:54:26 INFO - "pgo_build": "False", 02:54:26 INFO - "builduid": "b1e21b1400f94c1cb3f53e3f32612070", 02:54:26 INFO - "slavebuilddir": "test" 02:54:26 INFO - } 02:54:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/eSC9gBcqQ9G-gwL_gezPww/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 02:54:26 INFO - Running post-action listener: _resource_record_post_action 02:54:26 INFO - [mozharness: 2017-01-21 10:54:26.310996Z] Finished read-buildbot-config step (success) 02:54:26 INFO - [mozharness: 2017-01-21 10:54:26.311120Z] Running download-and-extract step. 02:54:26 INFO - Running pre-action listener: _resource_record_pre_action 02:54:26 INFO - Running main action method: download_and_extract 02:54:26 INFO - mkdir: /builds/slave/test/build/tests 02:54:26 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')]} 02:54:26 INFO - trying https://queue.taskcluster.net/v1/task/eSC9gBcqQ9G-gwL_gezPww/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 02:54:26 INFO - Downloading https://queue.taskcluster.net/v1/task/eSC9gBcqQ9G-gwL_gezPww/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 02:54:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eSC9gBcqQ9G-gwL_gezPww/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 02:54:27 INFO - Downloaded 1199 bytes. 02:54:27 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 02:54:27 INFO - Using the following test package requirements: 02:54:27 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 02:54:27 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:54:27 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 02:54:27 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:54:27 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 02:54:27 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:54:27 INFO - u'jsshell-mac.zip'], 02:54:27 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:54:27 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 02:54:27 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 02:54:27 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:54:27 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 02:54:27 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:54:27 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 02:54:27 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:54:27 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 02:54:27 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:54:27 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 02:54:27 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:54:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eSC9gBcqQ9G-gwL_gezPww/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 02:54:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eSC9gBcqQ9G-gwL_gezPww/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:54:27 INFO - Fetch https://queue.taskcluster.net/v1/task/eSC9gBcqQ9G-gwL_gezPww/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 02:54:27 INFO - Http code: 200 02:54:27 INFO - via: 1.1 aa89533ad2ec5e0edba466c9920bd000.cloudfront.net (CloudFront) 02:54:27 INFO - x-amz-cf-id: mjBAA4PQx8AdVTNH5e-kr4tX5m550w4zoQ4Kp1ovgwCwwtbxwSpwug== 02:54:27 INFO - x-amz-version-id: 7nc01xrKXjjnsUkhhHFdbnxa_WrhpGuQ 02:54:28 INFO - Expected file size: 16277617 02:54:28 INFO - Obtained file size: 16277617 02:54:34 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:54:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eSC9gBcqQ9G-gwL_gezPww/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 02:54:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eSC9gBcqQ9G-gwL_gezPww/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:54:34 INFO - Fetch https://queue.taskcluster.net/v1/task/eSC9gBcqQ9G-gwL_gezPww/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 02:54:35 INFO - Http code: 200 02:54:35 INFO - via: 1.1 f0ef92e52918ab5129ebd66f2f633cbb.cloudfront.net (CloudFront) 02:54:35 INFO - x-amz-cf-id: GWObOqTzYPaVAkLafWeiDjLM7gIy0Up9rZmPEBXBia1LB6Iugt7eAQ== 02:54:35 INFO - x-amz-version-id: 7nc01xrKXjjnsUkhhHFdbnxa_WrhpGuQ 02:54:35 INFO - Expected file size: 16277617 02:54:35 INFO - Obtained file size: 16277617 02:54:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eSC9gBcqQ9G-gwL_gezPww/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 02:54:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eSC9gBcqQ9G-gwL_gezPww/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:54:41 INFO - Fetch https://queue.taskcluster.net/v1/task/eSC9gBcqQ9G-gwL_gezPww/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 02:54:42 INFO - Http code: 200 02:54:42 INFO - via: 1.1 2239f0bfe6d7427183a4e375c4638619.cloudfront.net (CloudFront) 02:54:42 INFO - x-amz-cf-id: 9bnthDYiIYnz4NG4wN-7XjlH3E3fyFPoehYwU_17RnrtnKv-bXPExg== 02:54:42 INFO - x-amz-version-id: pcx.roIIE.Y4lH6uyBsCu4xOvzDPpywD 02:54:42 INFO - Expected file size: 14402992 02:54:42 INFO - Obtained file size: 14402992 02:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:54:43 INFO - trying https://queue.taskcluster.net/v1/task/eSC9gBcqQ9G-gwL_gezPww/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:54:43 INFO - Downloading https://queue.taskcluster.net/v1/task/eSC9gBcqQ9G-gwL_gezPww/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 02:54:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eSC9gBcqQ9G-gwL_gezPww/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 02:54:46 INFO - Downloaded 110780176 bytes. 02:54:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eSC9gBcqQ9G-gwL_gezPww/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:54:46 INFO - mkdir: /builds/slave/test/properties 02:54:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:54:46 INFO - Writing to file /builds/slave/test/properties/build_url 02:54:46 INFO - Contents: 02:54:46 INFO - build_url:https://queue.taskcluster.net/v1/task/eSC9gBcqQ9G-gwL_gezPww/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:54:46 INFO - Running post-action listener: _resource_record_post_action 02:54:46 INFO - Running post-action listener: set_extra_try_arguments 02:54:46 INFO - [mozharness: 2017-01-21 10:54:46.678802Z] Finished download-and-extract step (success) 02:54:46 INFO - [mozharness: 2017-01-21 10:54:46.678925Z] Running populate-webroot step. 02:54:46 INFO - Running pre-action listener: _resource_record_pre_action 02:54:46 INFO - Running main action method: populate_webroot 02:54:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:54:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:54:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:54:46 INFO - '--tppagecycles', 02:54:46 INFO - '7'], 02:54:46 INFO - 'tests': ['tsvgm']}}, 02:54:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:54:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:54:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:54:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:54:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:54:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:54:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:54:46 INFO - 'talos_options': ['--disable-e10s'], 02:54:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:54:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:54:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:54:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:54:46 INFO - 'talos_options': ['--disable-e10s'], 02:54:46 INFO - 'tests': ['damp', 'tps']}, 02:54:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:54:46 INFO - 'tests': ['damp', 'tps']}, 02:54:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:54:46 INFO - 'tests': ['dromaeo_dom']}, 02:54:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:54:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:54:46 INFO - 'tests': ['basic_compositor_video']}, 02:54:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:54:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:54:46 INFO - 'tests': ['a11yr', 02:54:46 INFO - 'ts_paint', 02:54:46 INFO - 'tpaint', 02:54:46 INFO - 'sessionrestore', 02:54:46 INFO - 'sessionrestore_no_auto_restore', 02:54:46 INFO - 'tabpaint']}, 02:54:46 INFO - 'other-e10s': {'tests': ['a11yr', 02:54:46 INFO - 'ts_paint', 02:54:46 INFO - 'tpaint', 02:54:46 INFO - 'sessionrestore', 02:54:46 INFO - 'sessionrestore_no_auto_restore', 02:54:46 INFO - 'tabpaint']}, 02:54:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:54:46 INFO - 'ts_paint', 02:54:46 INFO - 'tpaint', 02:54:46 INFO - 'sessionrestore', 02:54:46 INFO - 'sessionrestore_no_auto_restore', 02:54:46 INFO - 'tabpaint']}, 02:54:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:54:46 INFO - 'ts_paint', 02:54:46 INFO - 'tpaint', 02:54:46 INFO - 'sessionrestore', 02:54:46 INFO - 'sessionrestore_no_auto_restore', 02:54:46 INFO - 'tabpaint']}, 02:54:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:54:46 INFO - 'tests': ['a11yr', 02:54:46 INFO - 'ts_paint', 02:54:46 INFO - 'tpaint', 02:54:46 INFO - 'sessionrestore', 02:54:46 INFO - 'sessionrestore_no_auto_restore', 02:54:46 INFO - 'tabpaint']}, 02:54:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:54:46 INFO - 'tests': ['a11yr', 02:54:46 INFO - 'ts_paint', 02:54:46 INFO - 'tpaint', 02:54:46 INFO - 'sessionrestore', 02:54:46 INFO - 'sessionrestore_no_auto_restore', 02:54:46 INFO - 'tabpaint']}, 02:54:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:54:46 INFO - 'tests': ['tsvgx', 02:54:46 INFO - 'tsvgr_opacity', 02:54:46 INFO - 'tart', 02:54:46 INFO - 'tscrollx', 02:54:46 INFO - 'cart']}, 02:54:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:54:46 INFO - 'tsvgr_opacity', 02:54:46 INFO - 'tart', 02:54:46 INFO - 'tscrollx', 02:54:46 INFO - 'cart']}, 02:54:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:54:46 INFO - 'talos_options': ['--disable-e10s'], 02:54:46 INFO - 'tests': ['tp5o']}, 02:54:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:54:46 INFO - 'tests': ['tp5o']}, 02:54:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:54:46 INFO - 'talos_options': ['--disable-e10s', 02:54:46 INFO - '--xperf_path', 02:54:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:54:46 INFO - 'tests': ['tp5n']}, 02:54:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:54:46 INFO - 'talos_options': ['--xperf_path', 02:54:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:54:46 INFO - 'tests': ['tp5n']}}, 02:54:46 INFO - 'talos.zip': {'path': '', 02:54:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:54:46 INFO - Running post-action listener: _resource_record_post_action 02:54:46 INFO - [mozharness: 2017-01-21 10:54:46.697582Z] Finished populate-webroot step (success) 02:54:46 INFO - [mozharness: 2017-01-21 10:54:46.697679Z] Running create-virtualenv step. 02:54:46 INFO - Running pre-action listener: _resource_record_pre_action 02:54:46 INFO - Running main action method: create_virtualenv 02:54:46 INFO - Creating virtualenv /builds/slave/test/build/venv 02:54:46 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 02:54:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:54:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:54:46 INFO - Using real prefix '/tools/python27' 02:54:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:54:47 INFO - Installing distribute.............................................................................................................................................................................................done. 02:54:50 INFO - Installing pip.................done. 02:54:50 INFO - Return code: 0 02:54:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:54:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:54:50 INFO - Reading from file tmpfile_stdout 02:54:50 INFO - Output received: 02:54:50 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) 02:54:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:54:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10279e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102714570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdae04610f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025b2d30>, '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 0x102418db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025aab20>, '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.V1qt3aPRIe/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.k0GsS8XzNV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 02:54:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:54:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:54:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1qt3aPRIe/Render', 02:54:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:54:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:54:50 INFO - 'HOME': '/Users/cltbld', 02:54:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:54:50 INFO - 'LOGNAME': 'cltbld', 02:54:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:50 INFO - 'MOZ_NO_REMOTE': '1', 02:54:50 INFO - 'NO_EM_RESTART': '1', 02:54:50 INFO - 'PAGER': '/bin/cat', 02:54:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:54:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:50 INFO - 'PWD': '/builds/slave/test', 02:54:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:54:50 INFO - 'SHELL': '/bin/bash', 02:54:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0GsS8XzNV/Listeners', 02:54:50 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 02:54:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:54:50 INFO - 'USER': 'cltbld', 02:54:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:54:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:54:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:50 INFO - 'XPC_FLAGS': '0x0', 02:54:50 INFO - 'XPC_SERVICE_NAME': '0', 02:54:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:54:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:50 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 02:54:50 INFO - Cleaning up... 02:54:50 INFO - Return code: 0 02:54:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:54:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10279e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102714570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdae04610f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025b2d30>, '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 0x102418db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025aab20>, '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.V1qt3aPRIe/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.k0GsS8XzNV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 02:54:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:54:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:54:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1qt3aPRIe/Render', 02:54:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:54:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:54:50 INFO - 'HOME': '/Users/cltbld', 02:54:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:54:50 INFO - 'LOGNAME': 'cltbld', 02:54:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:50 INFO - 'MOZ_NO_REMOTE': '1', 02:54:50 INFO - 'NO_EM_RESTART': '1', 02:54:50 INFO - 'PAGER': '/bin/cat', 02:54:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:54:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:50 INFO - 'PWD': '/builds/slave/test', 02:54:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:54:50 INFO - 'SHELL': '/bin/bash', 02:54:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0GsS8XzNV/Listeners', 02:54:50 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 02:54:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:54:50 INFO - 'USER': 'cltbld', 02:54:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:54:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:54:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:50 INFO - 'XPC_FLAGS': '0x0', 02:54:50 INFO - 'XPC_SERVICE_NAME': '0', 02:54:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:51 INFO - Downloading/unpacking psutil>=3.1.1 02:54:51 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 02:54:51 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 02:54:51 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 02:54:51 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 02:54:51 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 02:54:51 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 02:54:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:54:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:54:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:54:55 INFO - Installing collected packages: psutil 02:54:55 INFO - Running setup.py install for psutil 02:54:55 INFO - building 'psutil._psutil_osx' extension 02:54:55 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 02:54:55 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 02:54:55 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 02:54:55 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 02:54:55 INFO - building 'psutil._psutil_posix' extension 02:54:55 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 02:54:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:54:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:54:55 INFO - ^ 02:54:55 INFO - 1 warning generated. 02:54:55 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 02:54:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:54:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:54:55 INFO - Successfully installed psutil 02:54:55 INFO - Cleaning up... 02:54:55 INFO - Return code: 0 02:54:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:54:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10279e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102714570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdae04610f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025b2d30>, '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 0x102418db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025aab20>, '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.V1qt3aPRIe/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.k0GsS8XzNV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 02:54:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:54:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:54:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1qt3aPRIe/Render', 02:54:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:54:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:54:55 INFO - 'HOME': '/Users/cltbld', 02:54:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:54:55 INFO - 'LOGNAME': 'cltbld', 02:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:55 INFO - 'MOZ_NO_REMOTE': '1', 02:54:55 INFO - 'NO_EM_RESTART': '1', 02:54:55 INFO - 'PAGER': '/bin/cat', 02:54:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:55 INFO - 'PWD': '/builds/slave/test', 02:54:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:54:55 INFO - 'SHELL': '/bin/bash', 02:54:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0GsS8XzNV/Listeners', 02:54:55 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 02:54:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:54:55 INFO - 'USER': 'cltbld', 02:54:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:54:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:55 INFO - 'XPC_FLAGS': '0x0', 02:54:55 INFO - 'XPC_SERVICE_NAME': '0', 02:54:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:54:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:54:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:54:58 INFO - Installing collected packages: mozsystemmonitor 02:54:58 INFO - Running setup.py install for mozsystemmonitor 02:54:59 INFO - Successfully installed mozsystemmonitor 02:54:59 INFO - Cleaning up... 02:54:59 INFO - Return code: 0 02:54:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:54:59 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')]} 02:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:59 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')]} 02:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:59 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 0x10279e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102714570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdae04610f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025b2d30>, '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 0x102418db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025aab20>, '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.V1qt3aPRIe/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.k0GsS8XzNV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 02:54:59 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 02:54:59 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 02:54:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1qt3aPRIe/Render', 02:54:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:54:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:54:59 INFO - 'HOME': '/Users/cltbld', 02:54:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:54:59 INFO - 'LOGNAME': 'cltbld', 02:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:59 INFO - 'MOZ_NO_REMOTE': '1', 02:54:59 INFO - 'NO_EM_RESTART': '1', 02:54:59 INFO - 'PAGER': '/bin/cat', 02:54:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:59 INFO - 'PWD': '/builds/slave/test', 02:54:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:54:59 INFO - 'SHELL': '/bin/bash', 02:54:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0GsS8XzNV/Listeners', 02:54:59 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 02:54:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:54:59 INFO - 'USER': 'cltbld', 02:54:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:54:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:59 INFO - 'XPC_FLAGS': '0x0', 02:54:59 INFO - 'XPC_SERVICE_NAME': '0', 02:54:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:59 INFO - Downloading/unpacking jsonschema==2.5.1 02:54: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 02:54: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 02:54: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 02:54: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 02:54: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 02:54: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 02:55:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:55:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:55: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 02:55: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 02:55: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 02:55: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 02:55: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 02:55: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 02:55:02 INFO - Downloading functools32-3.2.3-2.tar.gz 02:55:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:55:02 INFO - warning: no files found matching '*.txt' 02:55:02 INFO - no previously-included directories found matching 'build' 02:55:02 INFO - no previously-included directories found matching 'dist' 02:55:02 INFO - no previously-included directories found matching '.git*' 02:55:02 INFO - Installing collected packages: jsonschema, functools32 02:55:02 INFO - Running setup.py install for functools32 02:55:02 INFO - warning: no files found matching '*.txt' 02:55:02 INFO - no previously-included directories found matching 'build' 02:55:02 INFO - no previously-included directories found matching 'dist' 02:55:02 INFO - no previously-included directories found matching '.git*' 02:55:02 INFO - Successfully installed jsonschema functools32 02:55:02 INFO - Cleaning up... 02:55:02 INFO - Return code: 0 02:55:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:55:02 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')]} 02:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:02 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')]} 02:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:02 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 0x10279e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102714570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdae04610f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025b2d30>, '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 0x102418db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025aab20>, '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.V1qt3aPRIe/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.k0GsS8XzNV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 02:55:02 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 02:55:02 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 02:55:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1qt3aPRIe/Render', 02:55:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:02 INFO - 'HOME': '/Users/cltbld', 02:55:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:02 INFO - 'LOGNAME': 'cltbld', 02:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:02 INFO - 'MOZ_NO_REMOTE': '1', 02:55:02 INFO - 'NO_EM_RESTART': '1', 02:55:02 INFO - 'PAGER': '/bin/cat', 02:55:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:02 INFO - 'PWD': '/builds/slave/test', 02:55:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:02 INFO - 'SHELL': '/bin/bash', 02:55:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0GsS8XzNV/Listeners', 02:55:02 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 02:55:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:02 INFO - 'USER': 'cltbld', 02:55:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:02 INFO - 'XPC_FLAGS': '0x0', 02:55:02 INFO - 'XPC_SERVICE_NAME': '0', 02:55:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:55:02 INFO - Cleaning up... 02:55:03 INFO - Return code: 0 02:55:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:03 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 0x10279e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102714570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdae04610f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025b2d30>, '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 0x102418db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025aab20>, '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.V1qt3aPRIe/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.k0GsS8XzNV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 02:55:03 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 02:55:03 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 02:55:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1qt3aPRIe/Render', 02:55:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:03 INFO - 'HOME': '/Users/cltbld', 02:55:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:03 INFO - 'LOGNAME': 'cltbld', 02:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:03 INFO - 'MOZ_NO_REMOTE': '1', 02:55:03 INFO - 'NO_EM_RESTART': '1', 02:55:03 INFO - 'PAGER': '/bin/cat', 02:55:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:03 INFO - 'PWD': '/builds/slave/test', 02:55:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:03 INFO - 'SHELL': '/bin/bash', 02:55:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0GsS8XzNV/Listeners', 02:55:03 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 02:55:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:03 INFO - 'USER': 'cltbld', 02:55:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:03 INFO - 'XPC_FLAGS': '0x0', 02:55:03 INFO - 'XPC_SERVICE_NAME': '0', 02:55:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:03 INFO - Downloading/unpacking blobuploader==1.2.4 02:55:03 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 02:55:03 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 02:55:03 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 02:55:03 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 02:55:03 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 02:55:03 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 02:55:05 INFO - Downloading blobuploader-1.2.4.tar.gz 02:55:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:55:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:55:05 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 02:55:05 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 02:55:05 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 02:55:05 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 02:55:05 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 02:55:05 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 02:55:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:55:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:55:06 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 02:55:06 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 02:55:06 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 02:55:06 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 02:55:06 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 02:55:06 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 02:55:07 INFO - Downloading docopt-0.6.1.tar.gz 02:55:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:55:07 INFO - Installing collected packages: blobuploader, requests, docopt 02:55:07 INFO - Running setup.py install for blobuploader 02:55:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:55:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:55:07 INFO - Running setup.py install for requests 02:55:07 INFO - Running setup.py install for docopt 02:55:07 INFO - Successfully installed blobuploader requests docopt 02:55:07 INFO - Cleaning up... 02:55:08 INFO - Return code: 0 02:55:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:55:08 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')]} 02:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:08 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')]} 02:55:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:08 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 0x10279e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102714570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdae04610f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025b2d30>, '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 0x102418db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025aab20>, '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.V1qt3aPRIe/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.k0GsS8XzNV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 02:55:08 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 02:55:08 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 02:55:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1qt3aPRIe/Render', 02:55:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:08 INFO - 'HOME': '/Users/cltbld', 02:55:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:08 INFO - 'LOGNAME': 'cltbld', 02:55:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:08 INFO - 'MOZ_NO_REMOTE': '1', 02:55:08 INFO - 'NO_EM_RESTART': '1', 02:55:08 INFO - 'PAGER': '/bin/cat', 02:55:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:08 INFO - 'PWD': '/builds/slave/test', 02:55:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:08 INFO - 'SHELL': '/bin/bash', 02:55:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0GsS8XzNV/Listeners', 02:55:08 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 02:55:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:08 INFO - 'USER': 'cltbld', 02:55:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:08 INFO - 'XPC_FLAGS': '0x0', 02:55:08 INFO - 'XPC_SERVICE_NAME': '0', 02:55:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:55:08 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-cIPaHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:55:08 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-KD07yE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:55:08 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-g34QFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:55:08 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-7lhLX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:55:08 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-VQjPPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:55:08 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-wUbbqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:55:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:55:08 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-vIEUQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:55:09 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-5ndAom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:55:09 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-hhrw1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:55:09 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-H48tjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:55:09 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-x1052k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:55:09 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-GgZzVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:55:09 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-Kqh4Er-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:55:09 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-7LzjcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:55:09 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-GdvhDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:55:09 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-kUdNkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:55:10 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-kuU5Gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:55:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:55:10 INFO - Running setup.py install for manifestparser 02:55:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:55:10 INFO - Running setup.py install for mozcrash 02:55:10 INFO - Running setup.py install for mozdebug 02:55:10 INFO - Running setup.py install for mozdevice 02:55:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:55:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:55:10 INFO - Running setup.py install for mozfile 02:55:10 INFO - Running setup.py install for mozhttpd 02:55:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:55:11 INFO - Running setup.py install for mozinfo 02:55:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:55:11 INFO - Running setup.py install for mozInstall 02:55:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:55:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:55:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:55:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:55:11 INFO - Running setup.py install for mozleak 02:55:11 INFO - Running setup.py install for mozlog 02:55:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:55:11 INFO - Running setup.py install for moznetwork 02:55:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:55:11 INFO - Running setup.py install for mozprocess 02:55:11 INFO - Running setup.py install for mozprofile 02:55:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:55:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:55:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:55:12 INFO - Running setup.py install for mozrunner 02:55:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:55:12 INFO - Running setup.py install for mozscreenshot 02:55:12 INFO - Running setup.py install for moztest 02:55:12 INFO - Running setup.py install for mozversion 02:55:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:55:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:55:12 INFO - Cleaning up... 02:55:12 INFO - Return code: 0 02:55:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:12 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 0x10279e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102714570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdae04610f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025b2d30>, '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 0x102418db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025aab20>, '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.V1qt3aPRIe/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.k0GsS8XzNV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 02:55:12 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 02:55:12 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 02:55:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1qt3aPRIe/Render', 02:55:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:12 INFO - 'HOME': '/Users/cltbld', 02:55:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:12 INFO - 'LOGNAME': 'cltbld', 02:55:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:12 INFO - 'MOZ_NO_REMOTE': '1', 02:55:12 INFO - 'NO_EM_RESTART': '1', 02:55:12 INFO - 'PAGER': '/bin/cat', 02:55:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:12 INFO - 'PWD': '/builds/slave/test', 02:55:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:12 INFO - 'SHELL': '/bin/bash', 02:55:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0GsS8XzNV/Listeners', 02:55:12 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 02:55:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:12 INFO - 'USER': 'cltbld', 02:55:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:12 INFO - 'XPC_FLAGS': '0x0', 02:55:12 INFO - 'XPC_SERVICE_NAME': '0', 02:55:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:55:12 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-nt1PdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:55:13 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)) 02:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:55:13 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-KJavvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:55:13 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)) 02:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:55:13 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-AFG_te-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:55:13 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)) 02:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:55:13 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-8t9ess-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:55:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:55:13 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-iYJ9IT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:55:13 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)) 02:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:55:13 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-QMNKUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:55:13 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)) 02:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:55:13 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-8kPMI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:55:13 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)) 02:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:55:13 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-D1WgWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:55:13 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)) 02:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:55:13 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-yMeYsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:55:13 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)) 02:55:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:55:13 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-u25vAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:55:14 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)) 02:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:55:14 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-Vd3Nnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:55:14 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)) 02:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:55:14 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-8hymdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:55:14 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-4ZlTqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:55:14 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)) 02:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:55:14 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-6d8y4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:55:14 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)) 02:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:55:14 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-GlTMNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:55:14 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)) 02:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:55:14 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-nENhOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:55:14 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)) 02:55:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:55:14 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-zC1nm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:55:14 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)) 02:55:14 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)) 02:55:14 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)) 02:55:14 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)) 02:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:55:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:55:14 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 02:55:14 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 02:55:14 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 02:55:14 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 02:55:14 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 02:55:14 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 02:55:17 INFO - Downloading blessings-1.6.tar.gz 02:55:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:55:17 INFO - Installing collected packages: blessings 02:55:17 INFO - Running setup.py install for blessings 02:55:17 INFO - Successfully installed blessings 02:55:17 INFO - Cleaning up... 02:55:17 INFO - Return code: 0 02:55:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:55:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:55:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:55:18 INFO - Reading from file tmpfile_stdout 02:55:18 INFO - Current package versions: 02:55:18 INFO - blessings == 1.6 02:55:18 INFO - blobuploader == 1.2.4 02:55:18 INFO - docopt == 0.6.1 02:55:18 INFO - functools32 == 3.2.3-2 02:55:18 INFO - jsonschema == 2.5.1 02:55:18 INFO - manifestparser == 1.1 02:55:18 INFO - mozInstall == 1.12 02:55:18 INFO - mozcrash == 1.0 02:55:18 INFO - mozdebug == 0.1 02:55:18 INFO - mozdevice == 0.48 02:55:18 INFO - mozfile == 1.2 02:55:18 INFO - mozhttpd == 0.7 02:55:18 INFO - mozinfo == 0.9 02:55:18 INFO - mozleak == 0.1 02:55:18 INFO - mozlog == 3.4 02:55:18 INFO - moznetwork == 0.27 02:55:18 INFO - mozprocess == 0.23 02:55:18 INFO - mozprofile == 0.28 02:55:18 INFO - mozrunner == 6.13 02:55:18 INFO - mozscreenshot == 0.1 02:55:18 INFO - mozsystemmonitor == 0.3 02:55:18 INFO - moztest == 0.8 02:55:18 INFO - mozversion == 1.4 02:55:18 INFO - psutil == 3.1.1 02:55:18 INFO - requests == 1.2.3 02:55:18 INFO - wsgiref == 0.1.2 02:55:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:55:18 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')]} 02:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:18 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')]} 02:55:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:18 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 0x10279e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102714570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdae04610f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025b2d30>, '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 0x102418db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025aab20>, '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.V1qt3aPRIe/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.k0GsS8XzNV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 02:55:18 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 02:55:18 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 02:55:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1qt3aPRIe/Render', 02:55:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:18 INFO - 'HOME': '/Users/cltbld', 02:55:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:18 INFO - 'LOGNAME': 'cltbld', 02:55:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:18 INFO - 'MOZ_NO_REMOTE': '1', 02:55:18 INFO - 'NO_EM_RESTART': '1', 02:55:18 INFO - 'PAGER': '/bin/cat', 02:55:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:18 INFO - 'PWD': '/builds/slave/test', 02:55:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:18 INFO - 'SHELL': '/bin/bash', 02:55:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0GsS8XzNV/Listeners', 02:55:18 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 02:55:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:18 INFO - 'USER': 'cltbld', 02:55:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:18 INFO - 'XPC_FLAGS': '0x0', 02:55:18 INFO - 'XPC_SERVICE_NAME': '0', 02:55:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:18 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)) 02:55:18 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)) 02:55:18 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)) 02:55:18 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)) 02:55:18 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)) 02:55:18 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)) 02:55:18 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)) 02:55:18 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)) 02:55:18 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)) 02:55:18 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)) 02:55:18 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)) 02:55:18 INFO - Cleaning up... 02:55:18 INFO - Return code: 0 02:55:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:55:18 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')]} 02:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:18 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')]} 02:55:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:18 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 0x10279e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102714570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdae04610f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025b2d30>, '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 0x102418db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025aab20>, '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.V1qt3aPRIe/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.k0GsS8XzNV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 02:55:18 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 02:55:18 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 02:55:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1qt3aPRIe/Render', 02:55:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:18 INFO - 'HOME': '/Users/cltbld', 02:55:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:18 INFO - 'LOGNAME': 'cltbld', 02:55:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:18 INFO - 'MOZ_NO_REMOTE': '1', 02:55:18 INFO - 'NO_EM_RESTART': '1', 02:55:18 INFO - 'PAGER': '/bin/cat', 02:55:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:18 INFO - 'PWD': '/builds/slave/test', 02:55:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:18 INFO - 'SHELL': '/bin/bash', 02:55:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0GsS8XzNV/Listeners', 02:55:18 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 02:55:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:18 INFO - 'USER': 'cltbld', 02:55:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:18 INFO - 'XPC_FLAGS': '0x0', 02:55:18 INFO - 'XPC_SERVICE_NAME': '0', 02:55:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:55:18 INFO - Cleaning up... 02:55:18 INFO - Return code: 0 02:55:18 INFO - Running post-action listener: _resource_record_post_action 02:55:18 INFO - Running post-action listener: _start_resource_monitoring 02:55:18 INFO - Starting resource monitoring. 02:55:18 INFO - [mozharness: 2017-01-21 10:55:18.621599Z] Finished create-virtualenv step (success) 02:55:18 INFO - [mozharness: 2017-01-21 10:55:18.622610Z] Running install step. 02:55:18 INFO - Running pre-action listener: _resource_record_pre_action 02:55:18 INFO - Running main action method: install 02:55:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:55:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:55:18 INFO - Reading from file tmpfile_stdout 02:55:18 INFO - Detecting whether we're running mozinstall >=1.0... 02:55:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:55:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:55:18 INFO - Reading from file tmpfile_stdout 02:55:18 INFO - Output received: 02:55:18 INFO - Usage: mozinstall [options] installer 02:55:18 INFO - Options: 02:55:18 INFO - -h, --help show this help message and exit 02:55:18 INFO - -d DEST, --destination=DEST 02:55:18 INFO - Directory to install application into. [default: 02:55:18 INFO - "/builds/slave/test"] 02:55:18 INFO - --app=APP Application being installed. [default: firefox] 02:55:18 INFO - mkdir: /builds/slave/test/build/application 02:55:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:55:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:55:50 INFO - Reading from file tmpfile_stdout 02:55:50 INFO - Output received: 02:55:50 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:55:50 INFO - Running post-action listener: _resource_record_post_action 02:55:50 INFO - [mozharness: 2017-01-21 10:55:50.418448Z] Finished install step (success) 02:55:50 INFO - [mozharness: 2017-01-21 10:55:50.418592Z] Running run-tests step. 02:55:50 INFO - Running pre-action listener: _resource_record_pre_action 02:55:50 INFO - Running main action method: run_tests 02:55:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:55:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:55:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:55:50 INFO - 2017-01-21 02:55:50.433 screenresolution[2040:17785] starting screenresolution argv=screenresolution get 02:55:50 INFO - 2017-01-21 02:55:50.435 screenresolution[2040:17785] Display 0: 1600x1200x32@60 02:55:50 INFO - 2017-01-21 02:55:50.441 screenresolution[2041:17787] starting screenresolution argv=screenresolution list 02:55:50 INFO - Available Modes on Display 0 02:55:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:55:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:55:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:55:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:55:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:55:50 INFO - Intel Iris: 02:55:50 INFO - Chipset Model: Intel Iris 02:55:50 INFO - Type: GPU 02:55:50 INFO - Bus: Built-In 02:55:50 INFO - VRAM (Dynamic, Max): 1536 MB 02:55:50 INFO - Vendor: Intel (0x8086) 02:55:50 INFO - Device ID: 0x0a2e 02:55:50 INFO - Revision ID: 0x0009 02:55:50 INFO - Displays: 02:55:50 INFO - Display: 02:55:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:55:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:55:50 INFO - Display Serial Number: 1600x1200 60 02:55:50 INFO - Main Display: Yes 02:55:50 INFO - Mirror: Off 02:55:50 INFO - Online: Yes 02:55:50 INFO - Rotation: Supported 02:55:50 INFO - Return code: 0 02:55:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:55:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:55:50 INFO - Python 2.7.3 02:55:50 INFO - Return code: 0 02:55:50 INFO - grabbing minidump binary from tooltool 02:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:50 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 0x1025b2d30>, '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 0x102418db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025aab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:55:50 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 02:55:50 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 02:55:50 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 02:55:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:55:50 INFO - Return code: 0 02:55:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:55:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:55:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:55:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:55:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:55:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eSC9gBcqQ9G-gwL_gezPww/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0367', '--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 02:55:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eSC9gBcqQ9G-gwL_gezPww/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0367 --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 02:55:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V1qt3aPRIe/Render', 02:55:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:50 INFO - 'HOME': '/Users/cltbld', 02:55:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:50 INFO - 'LOGNAME': 'cltbld', 02:55:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:55:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:55:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:50 INFO - 'MOZ_NO_REMOTE': '1', 02:55:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:55:50 INFO - 'NO_EM_RESTART': '1', 02:55:50 INFO - 'PAGER': '/bin/cat', 02:55:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:50 INFO - 'PWD': '/builds/slave/test', 02:55:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:55:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:50 INFO - 'SHELL': '/bin/bash', 02:55:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0GsS8XzNV/Listeners', 02:55:50 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 02:55:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:50 INFO - 'USER': 'cltbld', 02:55:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:50 INFO - 'XPC_FLAGS': '0x0', 02:55:50 INFO - 'XPC_SERVICE_NAME': '0', 02:55:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eSC9gBcqQ9G-gwL_gezPww/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0367', '--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 02:55:51 INFO - mozversion application_buildid: 20170121004004 02:55:51 INFO - mozversion application_changeset: a891cb2fa60257c3a8cb84bb0356fba508e42f3e 02:55:51 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:55:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:55:51 INFO - mozversion application_name: Firefox 02:55:51 INFO - mozversion application_remotingname: firefox-dev 02:55:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:55:51 INFO - mozversion application_vendor: Mozilla 02:55:51 INFO - mozversion application_version: 52.0a2 02:55:51 INFO - mozversion platform_buildid: 20170121004004 02:55:51 INFO - mozversion platform_changeset: a891cb2fa60257c3a8cb84bb0356fba508e42f3e 02:55:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:55:51 INFO - mozversion platform_version: 52.0a2 02:55:51 INFO - using testdate: 1484996151 02:55:51 INFO - actual date: 1484996151 02:55:51 INFO - starting webserver on 'localhost:49338' 02:55:51 INFO - SUITE-START | Running 2 tests 02:55:51 INFO - TEST-START | dromaeo_css 02:55:51 INFO - operating with platform_type : mac_ 02:55:51 INFO - Initialising browser for dromaeo_css test... 02:55:51 INFO - TEST-INFO | started process 2051 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/tmp8zydIg/profile http://localhost:49338/getInfo.html) 02:55:53 INFO - PROCESS | 2051 | __metrics Screen width/height:1600/1200 02:55:53 INFO - PROCESS | 2051 | colorDepth:24 02:55:53 INFO - PROCESS | 2051 | Browser inner width/height: 1024/689 02:55:53 INFO - PROCESS | 2051 | __metrics 02:55:53 INFO - PROCESS | 2051 | 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" 02:55:53 INFO - PROCESS | 2051 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:55:54 INFO - TEST-INFO | 2051: exit 0 02:55:54 INFO - Browser initialized. 02:55:54 INFO - Running cycle 1/1 for dromaeo_css test... 02:55:54 INFO - TEST-INFO | started process 2054 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/tmp8zydIg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:56:07 INFO - PROCESS | 2054 | RSS: Main: 221728768 02:56:07 INFO - PROCESS | 2054 | 02:59:10 INFO - PROCESS | 2054 | Cycle 1(1): loaded http://localhost:49338/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49338/tests/dromaeo/cssquery-ext.html) 02:59:12 INFO - PROCESS | 2054 | RSS: Main: 360226816 02:59:12 INFO - PROCESS | 2054 | 03:02:15 INFO - PROCESS | 2054 | Cycle 1(1): loaded http://localhost:49338/tests/dromaeo/cssquery-ext.html (next: http://localhost:49338/tests/dromaeo/cssquery-jquery.html) 03:02:15 INFO - PROCESS | 2054 | RSS: Main: 347885568 03:02:15 INFO - PROCESS | 2054 | 03:05:18 INFO - PROCESS | 2054 | Cycle 1(1): loaded http://localhost:49338/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49338/tests/dromaeo/cssquery-mootools.html) 03:05:18 INFO - PROCESS | 2054 | RSS: Main: 321318912 03:05:18 INFO - PROCESS | 2054 | 03:08:21 INFO - PROCESS | 2054 | Cycle 1(1): loaded http://localhost:49338/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49338/tests/dromaeo/cssquery-prototype.html) 03:08:21 INFO - PROCESS | 2054 | RSS: Main: 315076608 03:08:21 INFO - PROCESS | 2054 | 03:11:24 INFO - PROCESS | 2054 | Cycle 1(1): loaded http://localhost:49338/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49338/tests/dromaeo/cssquery-yui.html) 03:11:25 INFO - PROCESS | 2054 | RSS: Main: 303726592 03:11:25 INFO - PROCESS | 2054 | 03:14:28 INFO - PROCESS | 2054 | Cycle 1(1): loaded http://localhost:49338/tests/dromaeo/cssquery-yui.html (next: http://localhost:49338/tests/dromaeo/cssquery-dojo.html) 03:14:28 INFO - PROCESS | 2054 | RSS: Main: 486522880 03:14:28 INFO - PROCESS | 2054 | 03:14:28 INFO - PROCESS | 2054 | __start_tp_report 03:14:28 INFO - PROCESS | 2054 | _x_x_mozilla_page_load 03:14:28 INFO - PROCESS | 2054 | _x_x_mozilla_page_load_details 03:14:28 INFO - PROCESS | 2054 | |i|pagename|runs| 03:14:28 INFO - PROCESS | 2054 | |0;dojo.html;3294.2917272786344;3294.7364210863125;3318.8672453101894;3320.6513316101796;3351.6145643251034;5653.4911857932775;5678.205051292817;5704.201411802341;5723.42765723428;5795.739191736367;5672.858178545528;5701.429857014296;5746.396628354026;5756.338021127572;5769.913451298234;4690.976545117278;4899.755012249391;5236.7119808410525;5273.288106105684;5281.128613778722;5148.021875843578;5167.741612919358;5173.793048278064;5182.896342073156;5332.626716129873;4334.371516130175;5206.114960456732;5269.947300526984;5273.129933560977;5297;5233.502817232356;5271.314729085233;5286.61502611014;5296.867578310554;5308.9469105308835;4338.739675619473;5033.572146367563;5122.667026643294;5227.18978558324;5255.527002569787;5606.55147588192;5640.464155905182;5647.322321321427;5709.600327977043;5732.656040637575;6103.671041328357;6121.693915304217;6168.321484636686;6213.130161777355;6238.438540531374;6289.937100628981;6300.842478938017;6303;6305.621662700207;6334.5249106317215;5574.386817450078;5712.600117991784;5744.4829965303325;5760.74076666551;5788;6264.749410023639;6284.497240220771;6289.842753931189;6289.993601023814;6306.400891915261;6101.267847858286;6105.572609917263;6107.694615269308;6108.3280839107665;6140.6929653517145;6106.297775755756;6133.407859146218;6139.798803208702;6185.257769067741;6239.344868788712;6143.249173985482;6213.937860621426;6214.844628884223;6224.408681175281;6227.595206311576;6121.173641558333;6232.906506402408;6233.096201050913;6233.532485063638;6250.343713910065;4807.230843065093;4858.80564777412;4918;4935.703857768545;4962.057209130326;4357.411749413852;4386.990992071841;4399.1641588098155;4426.070525189746;4444.911101777946;5151.562117220078;5698.17376480408;5732.656040637575;5750.6262092963825;5777.6822274775295;6212.689365531795;6245.0320200369015;6245.5628106032145;6251.093591429309;6258.843528911813;5600.131979543177;5646.2377579027125;5723.685197314105;5724.79963201286;5738.454846789548;5317.388500322435;5336.519713225828;5365.678059316453;5387.461253874581;5389.487998640123;6272.529560282997;6307.96846015767;6309.936900630935;6314.842128946813;6328.398802113792;6122.387761223842;6247.406496382836;6277.3408792078;6281.497480201481;6292.339304372975;5103.285540024325;6208.596441231305;6233.937660623517;6277.466415354746;6304.369563043659;5144.356955380577;6077.4834139098675;6167.352427995175;6172.259328880384;6198.659073750807;6086.147939288415;6262.780802671885;6269.404406581368;6278.529110316836;6281.874362512815;5914.763409463573;5964.135200395832;6008.128821320972;6042.154098426312;6117;6037.879242415039;6042.667653278936;6100.267967843887;6111.602745821508;6143.56995010345;5921.851953701192;5930.406959304035;5930.673812940157;5938.257717785277;5944.286685597583;5850.23946886902;6080.69596520181;6093.2078829751845;6104.816855494342;6110.175126358063;5814.709264536841;5833.562482813891;5865;5873.911891321719;5918.201042859331 03:14:28 INFO - PROCESS | 2054 | |1;ext.html;483.66868694943963;484.9321095046692;500.07486150621355;505.7825135191866;520.4717212029789;24661.63007554886;30738;37767.43348849769;38986.610133898655;38988.610113898925;32703.345933081324;40480.19039619206;40612.59387406125;40648.79675601625;40752.796236018854;9108.863367049516;9302.674406395778;9304.488253146073;9306.953465232664;9312.20846228068;8377.41358104933;8525.147485251488;9178.816423671522;11080.722981925435;11279.774404511905;11235.325880447159;11277.984981351678;11299.887001129966;11301.547938082467;11304.830427543593;11204.103671706243;11279.49242284095;11285.943570282177;11287.774244515145;11319.151063670257;8226.300764434971;8449.112843151443;10873.510692018877;11134.38760868152;11152.498137583747;38613.455461781494;38703.03242418934;38711.22577548433;38772;39157.804210978764;3210.598675165604;3211.1169428407143;3301.5212794144954;3308.3052558962645;3324.2188085799817;23462.41913389526;27899.581506277424;28245.71754282472;28474.86100555996;28919;2944.720251576097;3030.2727345437156;3051.6948305169303;3061.3418115105137;3125.7655675824403;432029;434641.8267908672;436910;437050;438636;46674;57269.42730572641;57575;57835.843283134105;57889.421105789246;61030;61156.694216529526;61295.38704612986;61350;61548.38451615516;14203.650653187931;15811.762823557656;16098.873078884366;16146.35414583427;16174.676506469805;11487.885121148849;11888.702782430335;12384.938075309747;12408;12421.875781242252;15068.472603459046;15167.24163791806;15297.388104475918;15903.284352203947;16010.199490025452;7390;7475.551466912003;7532.887006694904;7603.809904752315;7675.654595543214;824.406427372291;899.1772528136681;906.582971832951;991.3407583956732;1015.5480811039164;27643;28589.857050714614;28705.712942870305;29034.41931161365;29046.7095329044;993.7962717642865;1025.6512785652915;1045.1586472889396;1047.3611097230682;1060.183658582887;14896.404143834343;15009;15085.170315632526;15338.616534586725;15448.613784655248;664963;668824;671566;673866;722388;45870.08259834851;54809.45190548123;55965.88068238612;56109.71945140248;58491.415085848595;1318.9010824188033;1342.9865701342862;1351.2838195756265;1366.5763613279914;1367.6239034265457;28826;29319.85340073286;29737;30426.84786576053;30475.39049218959;48220.517794823005;48700.78248043686;48709.02581948412;48830.267545987546;48958.51041489682;581813.1818681759;584049;584363;585578;586646;24666.383340416633;25860.224193274233;25860.965561378085;25892.22323330303;25921;44218.557814421445;44348;44465.88835279144;44786.77606611946;45366.86582835455;36228.55085796538;36401.453978190875;37239.6276037247;37725.05687357838;38593.42109868298;36973.48360288187;36996;37020.074498137765;37032.814835925645;37257;36186.27627447489;36209.55161793499;37031.814840925625;37039.25921481609;37195.6981505646;30571;31000.224994374417;31110.37779244357;32985;33695.3260934775;18790.530236743645;24760.752392475846;24981;25110.748892511572;25255.62116568216 03:14:28 INFO - PROCESS | 2054 | |2;jquery.html;348.73496142931396;370.46097927515467;374.79011753418087;382.7569493371709;400.903783092058;14724.705505889875;15207.239638018096;15831.28759205837;19996.700214486085;20466.38600841977;19911;20401.693974590395;20499.590008199826;20507.97460126995;20722.171113155495;5420.349558053039;5631.18347839564;5869.325027621835;5871.735771890254;5874.588778785486;5372.409035006146;5776.133579963018;5803.071508558632;5815.5638327125425;5826.92201942642;5662.6036177467595;5691.51622112121;5784.623999440023;5785.074388097905;5793.681347525884;5944.851378715523;6059.848503787396;6072.180255665473;6073.848153796168;6082.604630699035;5726.513246374063;5762;5838.795642152547;5860.886431578029;5907.172995780594;12938.417771200224;13029.869701303056;13087.803682944763;13245.07284490086;13247.536336228186;2204.6582779669175;2213.922512712047;2259.954800903989;2263.287064574654;2310.353101131686;9332.813343733087;9337.393069450532;9531.809363812754;10316.742081447948;14506.70986580273;1767.9469615911544;1843.6220574782137;1850.7316439116253;1872.6535590915723;1911.4361263427322;104215.99999999924;112272;119465.40267298695;123040;125694;9477.763055923519;9522.428654280628;9994.600215991424;10037.79924401508;10084.294099412971;12373.257604543576;12465;12481.31352775588;12494.375281235902;12496.125271231109;7811.336036436853;8093.94778678768;8096.068952070587;8143.959280203561;8149.592520373958;7493.288137626917;8052.033755949206;8187.959060204661;8206.58967051657;8376.036755773042;3858.6527212550445;3869.5743468218475;3872.2255548890334;3929.2337994090876;3951.38753493209;1624.5045261195448;1867.215769376865;1928.4889504281377;1930.3726288955866;1932.9033548322527;765.2615226306641;847.5719761520393;932.2914584915377;940.8917974432891;994.3884511025667;19525.414237572895;21161.470963225736;21212.151513939578;21336.15782857047;21388.786112138678;925.2043242811177;929;931.8322701913585;932.128459890005;939.7838497145558;10354.482275886327;11005.853858497676;11023.338599683884;11043.889561104446;11142.164337674707;583841;585899;592606;597622;598886;117251;123000.38499807444;123550.14674779706;128645.71354286338;129213;922.7785331520387;926.5645146781002;945.6501094595044;947.0766003147014;948.9952550237205;17999.10004499796;18210.180541875383;18576.535586610444;18608.627827443644;18613.906930465262;50472.195697493786;51366.74316628393;51585;52076.47923520716;53323;70379;72145;73286.90069648853;73446.63276683583;74688;7850.025198720577;7912.4856884302335;8102.918970810217;8142.674293028213;8266.586670666564;11045.889541104487;12039.939800300943;12463.252204867737;12549.93725031369;12554.246745195318;10302.948485257526;10661.307015043998;10768;10785.191110666889;11107.222494425636;10569.63006294776;10615.787684246117;10694.946525267324;10707.411092389993;10887.673369798918;10863.293885897392;10889.945550272198;10951.780964380827;11171.888281117084;11428.771424571629;7726.961365193138;7807.219278072147;8068.83862322762;8069;8081.674160776223;8745.387822852339;10639.042486175971;10898.400587967737;10966.506507207354;11123.221374503708 03:14:28 INFO - PROCESS | 2054 | |3;mootools.html;1241.5654520917685;1467.2956980649285;1495.4167874528935;1658.6599747051855;1847.7782666080072;7480.850382992337;7803.843923121542;8130.349572034238;8415.242628163463;8425;8176.305014073796;8258.2154695304;8262.256396924276;8265.338772898169;8274.544900030496;2287.8627282363027;2318.4435735423463;2320.037184568402;2321.1759825262043;2331.3705299569106;2293.0827668932393;2335.871527066011;2345.366750977235;2350.74141844397;2357.1749887539395;2282.429392651837;2291.4958709083976;2314.1090680088205;2315.81473482121;2322.0479603362623;2264.116994372196;2277.419258089193;2304.5966955782837;2305.538892221554;2312.6415405612156;2299.1378233162563;2319.118734880751;2320.93037208884;2322.4890524084676;2323.7095363079616;7964.482308649977;8188.713395031145;8272.793180170484;8275.54484503352;8287.50274983503;5039.672421292605;5223.320968274138;5229.450907654679;5231.503007214308;5242.449542798027;3291.1936575538907;3404.3318773800906;3460.532828068229;3495.7627118643836;3507.1056880495566;1030.798994196132;1051.2693677893867;1640.4176517336293;1664.2261348472898;1751.7985431675265;8728.694495692684;10374.170066394745;10385.584576616926;10388.168946484187;10412.79174416515;4309.655227581786;4349.673774466928;4448.733076015449;4522.231220692424;4522.547745225517;8627.007894092134;8629.180227878342;8632.093630168867;8638.308935285288;8643.17889800468;5053.31780209667;5135.152699804565;5146.1766117421785;5146.1766117421785;5147.022065807485;4030.629585940794;4280.828766849353;4432.357308190294;4763.071201115749;4831.565159135695;3594.7303952203165;3624.4019736743144;3689.8893033209047;3721.925561488755;3724.348239058154;1133.9376334301692;1146.1232157399595;1148.6955956671488;1151.8732939376662;1160.1263958706627;806.0850934189737;857.7469646454311;886.1138861138861;896.4800415758845;899.2805755395788;5419.214213939035;5516.310461192351;5517.806876759294;5527.861803454945;5688.033034384164;867.8784970104191;904.073324842029;919.3242966419676;919.4437365393841;929.7768535551419;3518.7536872419196;3550.680438760524;3583.2654305867236;3642.927141457156;3871.070942973722;9569.808603827885;9770.316077874622;9772.364796288219;9787.021297870298;9797.314188006914;9846.015398460097;9858.704238872846;9860;9873.062059104373;9886.406815591088;7612.7922902358805;7699.576523291161;7998.720044798521;8002.599545079588;8026.077001144827;5555.611107222456;5595.804146855004;5624.775008999594;5635.802746903839;5752;9303.255739540686;9321.906780932104;9379.812403752023;9529.952350238205;9536.094071063239;8657.696980605648;9050.366474346733;9082.545872706207;9449.527523623654;9481.52592370365;6786.151731033621;7046.964765176142;7207.5675459472595;7279.781606551812;7281.417486601165;7865.803354915944;7969.123396426505;8062.072861620754;8064.395170362129;8075.353971682369;6111.480524155319;7001.719931202695;7079.964600176966;7170.713171473083;7235.565866048054;7024.789256322319;7106.111736032996;7125.643717813985;7137.643117844191;7165;6593.044008618627;6623.072769812134;6729.317670582354;6732.057511948233;6740.561863478858;4714.764261786965;4722.834700785456;4797.51924424417;4800.591949684316;4890.021995600823;4782.760861956958;4787.593054590259;4791.377120974251;4882.731449770296;4927.728974906415 03:14:28 INFO - PROCESS | 2054 | |4;prototype.html;299.4699382093694;307.1645125259294;307.1966806800218;313.1997745759583;316.9508726147448;5028.421731500874;5050.318207042048;5061.949380506203;5064.620153488485;5070.619703522237;4725.535084123915;4981.750912454381;4987;4987.675801072928;5035.647504674675;3149.7322727568126;3533.823308834548;3708.6105958874336;3712.273792686414;3732.033033738171;3795.3358162321483;3848.018270590648;3863.4784304118866;3880.1075752576926;3891.2801131790566;3147.7796554241213;3149.8423579847877;3625.184333524949;3798.373268410709;3840.8271627776817;3020.328365950483;3630.6385105585405;3646.8176591170336;3821.6624181536517;3834.175652234783;3338.2322065924973;3342.5320455136302;3343.2979074394407;3362.3443428531446;3377.240120972786;4768.998510312838;4779;4780.713157210544;4785.68893021956;4788.754923719823;3640.4539319102346;4222.1766755482695;4329.437173167499;4338.490117550693;4339.305711086211;5169.819056333048;5204.271402003685;5217.3217481727515;5221.136359094281;5221.973890130525;3101.5347697845277;3724.888253352404;3726.273376691546;3729.72027097966;3743.737938344317;4822.397200349957;5539.529140023103;5543.918935807519;5578.693171875586;5579.525740312079;3592.9820350898076;3726.832292546842;3777.9244415112094;3783.432485127253;3791.431285307171;3846.1730727893637;3852.1910398816003;3862.9227415451533;3872.554656214515;3879.4956655634587;4380.255356589388;4397.934030989538;4404.867853964322;4405.229084910128;4428.335749637516;4753.453352864465;5146.022255771391;5207.29701490294;5259.8422047338645;5287.656302340336;1109.7114750165015;1126.9492872820742;1184.8980448183272;1225.393430252013;1253.3044160491015;729.4565548666171;807.7036356647496;829.6805729794073;868.6091258933379;871.3487940352995;4197.685173611992;4381.846635367747;4461.706105229512;4542.547024606742;4856.3201151838775;4477.977610111929;5443.8094666686475;5453.972730136324;5469.56243500519;5481.643693159932;4388.733519776281;4552.499225085238;4762.428508578923;4922.391132699675;4946.925796113062;2546.61800729892;2667.919962401131;2672.893084276607;2702.378452955831;2705.6482657254824;4754.643401744883;5351.451266423586;5351.892962140813;5360.103885725748;5410.646368829572;4384.671149663788;4585.638396225946;5219.295395121686;5234.900670859162;5241.97781432617;4556.863294101182;4578.153041687298;4838.693750185163;4925.6305777066145;5098.719570423662;4614.515475874985;5112.821051263188;5127.231295100753;5141;5166.892320605203;5056.64603477753;5070.290159377764;5095.363079615048;5096.898062038813;5099.92350114756;4814.831480898151;4938.506149385033;4987.877727511426;5211.905499845075;5305.363356397257;3082.7533797295714;3368.4105281576117;3386.4073787087655;3435.639257877887;3586.1214002569536;5120.206368012964;5128.615353848401;5142.742862856917;5151.866589350337;5175.292153589231;4459.44256967879;4668.253079507263;4777.8260891293685;4960.635825147969;5039.370078740158;4371.338891221316;4762.380890484354;4798.23228283473;4978.465289644393;5002.899942001067;4086.9169670036868;4090.529589097292;4519.728816271035;4878.487489007909;4901.950980490149;4875.536824001714;4894.161386395953;4983.601311894967;5128.666636668605;5296.788128474818;4282.80727367263;5077.2637967493765;5107.182850743863;5124.256982737556;5154.7938082477785 03:14:28 INFO - PROCESS | 2054 | |5;yui.html;710.7299226294009;753.8793792993122;767.6353731977312;784.0747917457405;816.9387295952805;13188.736225275501;13594.932025339871;14276.428942842287;14865.331060102295;15099.169545674984;12524.248545087301;13383.59849204523;13523.391447384867;13525.93237033816;13536.72926541471;662.2582707367754;669.5647828911223;688.4561196654637;815.9428839981204;826.6114925984807;685.0854109763471;812.7277362083709;833.6915341323688;836.9788857593726;838.4172999765166;897.4391005621486;897.4570384917129;898.27239935652;898.5282726568538;900.6757567275776;698.9580625162506;718.3606590134784;891.2736120062161;892.7634176943116;895.4403497813898;608.0726891490468;631.8009826904511;649.217692680319;650.7266947881853;651.0072139986511;14158;14187.14877107377;14199.36102875373;14200.928995354958;14211;12826.102172847905;12842.87157128426;13013.21920684762;13040.543580974716;13087.869121308855;11570.53717851285;11764.176507644383;11852.881471185265;11968.88031119695;12048.216865903689;4231.153769246163;4364.192624364503;4375.540568240321;4412.691111622188;4447.399601053881;65139.022914656794;76512.08719781994;82894;85582.5720871398;88712.55643721805;9716.31985761004;9934.105930466292;10260.127889129508;10437.895621043692;10481.895181048092;18720.344787932358;18914.243430262635;19124;19159.712604310946;19190.904045479685;7307.451941104332;7432.554046757212;7434.368078713262;7477.242847930732;7511.549307041595;4066.7763273019677;4140.8136633851545;4199.727017743837;4233.851815186454;4300.956990430056;3277;3395.1342407685884;3402.6937575618313;3405.1146701857697;3407.4548072308808;637.8150336402484;639.5491178718992;642.3480167629859;653.1117679955257;655.7278729327371;504.6694415158004;567.3758865248194;568.1704711121808;580.7880123754884;591.3052163707712;8135.085177598993;8177.427580069338;8440.282575981111;8603.827923441497;8742.519161446055;516.5557620446413;517.5859312549945;592.8547505861005;623.6227082615044;625.7090452939404;3362.680545348188;3425.520427140202;3558.928821423557;3591.789065283659;3712.9443058354145;74769;99630.5018474903;116724;117675;119581;62302.68848655728;74806.99999999891;83746;84520;94564;69315.61368772697;82865;84471.5776421114;85656;90670.99999999868;7857.685692572461;8817.25053370445;9270.072992700676;9429.999851058406;9455.621775129193;52994;54276.72861635667;54604.726976364866;56495;56759.432405677064;75059.62470187833;77556.44887102339;78291.82562261456;81880.18119818963;82192.17807821845;11734.823977640513;11796.646100616996;11970.940145299217;12125.69685757863;12170.330631815335;12816.743665126458;13253.469861205444;13300.201987880759;13480;14441.06133101387;11509.769804604028;12268.087437135957;12587.496500139892;12609.49562017509;12758.872411275768;12383.442745076312;12681.492740290285;12836.16564923277;13173.077884548373;13345.933270333586;12237.571684990982;12499.437525311565;12875.35623218854;13114.803277950648;13230.536931207362;10511.474426278503;10652.89347106519;10906.454677266263;11001.559937602406;11180.552777888794;9640.807183856425;10814.567417303535;10849.891501084889;10870.673879783619;10981.231313807957 03:14:28 INFO - PROCESS | 2054 | __end_tp_report 03:14:28 INFO - PROCESS | 2054 | __start_cc_report 03:14:28 INFO - PROCESS | 2054 | _x_x_mozilla_cycle_collect,1587 03:14:28 INFO - PROCESS | 2054 | __end_cc_report 03:14:28 INFO - PROCESS | 2054 | __startTimestamp1484997268951__endTimestamp 03:14:28 INFO - PROCESS | 2054 | 03:14:28 INFO - PROCESS | 2054 | ------- Summary: start ------- 03:14:28 INFO - PROCESS | 2054 | Number of tests: 6 03:14:28 INFO - PROCESS | 2054 | 03:14:28 INFO - PROCESS | 2054 | [#0] dojo.html Cycles:165 Average:5701.10 Median:5914.76 stddev:661.18 (11.2%) stddev-sans-first:635.68 03:14:28 INFO - PROCESS | 2054 | Values: 3294.3 3294.7 3318.9 3320.7 3351.6 5653.5 5678.2 5704.2 5723.4 5795.7 5672.9 5701.4 5746.4 5756.3 5769.9 4691.0 4899.8 5236.7 5273.3 5281.1 5148.0 5167.7 5173.8 5182.9 5332.6 4334.4 5206.1 5269.9 5273.1 5297.0 5233.5 5271.3 5286.6 5296.9 5308.9 4338.7 5033.6 5122.7 5227.2 5255.5 5606.6 5640.5 5647.3 5709.6 5732.7 6103.7 6121.7 6168.3 6213.1 6238.4 6289.9 6300.8 6303.0 6305.6 6334.5 5574.4 5712.6 5744.5 5760.7 5788.0 6264.7 6284.5 6289.8 6290.0 6306.4 6101.3 6105.6 6107.7 6108.3 6140.7 6106.3 6133.4 6139.8 6185.3 6239.3 6143.2 6213.9 6214.8 6224.4 6227.6 6121.2 6232.9 6233.1 6233.5 6250.3 4807.2 4858.8 4918.0 4935.7 4962.1 4357.4 4387.0 4399.2 4426.1 4444.9 5151.6 5698.2 5732.7 5750.6 5777.7 6212.7 6245.0 6245.6 6251.1 6258.8 5600.1 5646.2 5723.7 5724.8 5738.5 5317.4 5336.5 5365.7 5387.5 5389.5 6272.5 6308.0 6309.9 6314.8 6328.4 6122.4 6247.4 6277.3 6281.5 6292.3 5103.3 6208.6 6233.9 6277.5 6304.4 5144.4 6077.5 6167.4 6172.3 6198.7 6086.1 6262.8 6269.4 6278.5 6281.9 5914.8 5964.1 6008.1 6042.2 6117.0 6037.9 6042.7 6100.3 6111.6 6143.6 5921.9 5930.4 5930.7 5938.3 5944.3 5850.2 6080.7 6093.2 6104.8 6110.2 5814.7 5833.6 5865.0 5873.9 5918.2 03:14:28 INFO - PROCESS | 2054 | 03:14:28 INFO - PROCESS | 2054 | [#1] ext.html Cycles:180 Average:68963.63 Median:36315.00 stddev:154304.24 (424.9%) stddev-sans-first:154651.44 03:14:28 INFO - PROCESS | 2054 | Values: 483.7 484.9 500.1 505.8 520.5 24661.6 30738.0 37767.4 38986.6 38988.6 32703.3 40480.2 40612.6 40648.8 40752.8 9108.9 9302.7 9304.5 9307.0 9312.2 8377.4 8525.1 9178.8 11080.7 11279.8 11235.3 11278.0 11299.9 11301.5 11304.8 11204.1 11279.5 11285.9 11287.8 11319.2 8226.3 8449.1 10873.5 11134.4 11152.5 38613.5 38703.0 38711.2 38772.0 39157.8 3210.6 3211.1 3301.5 3308.3 3324.2 23462.4 27899.6 28245.7 28474.9 28919.0 2944.7 3030.3 3051.7 3061.3 3125.8 432029.0 434641.8 436910.0 437050.0 438636.0 46674.0 57269.4 57575.0 57835.8 57889.4 61030.0 61156.7 61295.4 61350.0 61548.4 14203.7 15811.8 16098.9 16146.4 16174.7 11487.9 11888.7 12384.9 12408.0 12421.9 15068.5 15167.2 15297.4 15903.3 16010.2 7390.0 7475.6 7532.9 7603.8 7675.7 824.4 899.2 906.6 991.3 1015.5 27643.0 28589.9 28705.7 29034.4 29046.7 993.8 1025.7 1045.2 1047.4 1060.2 14896.4 15009.0 15085.2 15338.6 15448.6 664963.0 668824.0 671566.0 673866.0 722388.0 45870.1 54809.5 55965.9 56109.7 58491.4 1318.9 1343.0 1351.3 1366.6 1367.6 28826.0 29319.9 29737.0 30426.8 30475.4 48220.5 48700.8 48709.0 48830.3 48958.5 581813.2 584049.0 584363.0 585578.0 586646.0 24666.4 25860.2 25861.0 25892.2 25921.0 44218.6 44348.0 44465.9 44786.8 45366.9 36228.6 36401.5 37239.6 37725.1 38593.4 36973.5 36996.0 37020.1 37032.8 37257.0 36186.3 36209.6 37031.8 37039.3 37195.7 30571.0 31000.2 31110.4 32985.0 33695.3 18790.5 24760.8 24981.0 25110.7 25255.6 03:14:28 INFO - PROCESS | 2054 | 03:14:28 INFO - PROCESS | 2054 | [#2] jquery.html Cycles:180 Average:33909.95 Median:378.77 stddev:98770.41 (26076.4%) stddev-sans-first:99015.34 03:14:28 INFO - PROCESS | 2054 | Values: 348.7 370.5 374.8 382.8 400.9 14724.7 15207.2 15831.3 19996.7 20466.4 19911.0 20401.7 20499.6 20508.0 20722.2 5420.3 5631.2 5869.3 5871.7 5874.6 5372.4 5776.1 5803.1 5815.6 5826.9 5662.6 5691.5 5784.6 5785.1 5793.7 5944.9 6059.8 6072.2 6073.8 6082.6 5726.5 5762.0 5838.8 5860.9 5907.2 12938.4 13029.9 13087.8 13245.1 13247.5 2204.7 2213.9 2260.0 2263.3 2310.4 9332.8 9337.4 9531.8 10316.7 14506.7 1767.9 1843.6 1850.7 1872.7 1911.4 104216.0 112272.0 119465.4 123040.0 125694.0 9477.8 9522.4 9994.6 10037.8 10084.3 12373.3 12465.0 12481.3 12494.4 12496.1 7811.3 8093.9 8096.1 8144.0 8149.6 7493.3 8052.0 8188.0 8206.6 8376.0 3858.7 3869.6 3872.2 3929.2 3951.4 1624.5 1867.2 1928.5 1930.4 1932.9 765.3 847.6 932.3 940.9 994.4 19525.4 21161.5 21212.2 21336.2 21388.8 925.2 929.0 931.8 932.1 939.8 10354.5 11005.9 11023.3 11043.9 11142.2 583841.0 585899.0 592606.0 597622.0 598886.0 117251.0 123000.4 123550.1 128645.7 129213.0 922.8 926.6 945.7 947.1 949.0 17999.1 18210.2 18576.5 18608.6 18613.9 50472.2 51366.7 51585.0 52076.5 53323.0 70379.0 72145.0 73286.9 73446.6 74688.0 7850.0 7912.5 8102.9 8142.7 8266.6 11045.9 12039.9 12463.3 12549.9 12554.2 10302.9 10661.3 10768.0 10785.2 11107.2 10569.6 10615.8 10694.9 10707.4 10887.7 10863.3 10889.9 10951.8 11171.9 11428.8 7727.0 7807.2 8068.8 8069.0 8081.7 8745.4 10639.0 10898.4 10966.5 11123.2 03:14:28 INFO - PROCESS | 2054 | 03:14:28 INFO - PROCESS | 2054 | [#3] mootools.html Cycles:180 Average:5368.44 Median:5517.06 stddev:2883.79 (52.3%) stddev-sans-first:2875.19 03:14:28 INFO - PROCESS | 2054 | Values: 1241.6 1467.3 1495.4 1658.7 1847.8 7480.9 7803.8 8130.3 8415.2 8425.0 8176.3 8258.2 8262.3 8265.3 8274.5 2287.9 2318.4 2320.0 2321.2 2331.4 2293.1 2335.9 2345.4 2350.7 2357.2 2282.4 2291.5 2314.1 2315.8 2322.0 2264.1 2277.4 2304.6 2305.5 2312.6 2299.1 2319.1 2320.9 2322.5 2323.7 7964.5 8188.7 8272.8 8275.5 8287.5 5039.7 5223.3 5229.5 5231.5 5242.4 3291.2 3404.3 3460.5 3495.8 3507.1 1030.8 1051.3 1640.4 1664.2 1751.8 8728.7 10374.2 10385.6 10388.2 10412.8 4309.7 4349.7 4448.7 4522.2 4522.5 8627.0 8629.2 8632.1 8638.3 8643.2 5053.3 5135.2 5146.2 5146.2 5147.0 4030.6 4280.8 4432.4 4763.1 4831.6 3594.7 3624.4 3689.9 3721.9 3724.3 1133.9 1146.1 1148.7 1151.9 1160.1 806.1 857.7 886.1 896.5 899.3 5419.2 5516.3 5517.8 5527.9 5688.0 867.9 904.1 919.3 919.4 929.8 3518.8 3550.7 3583.3 3642.9 3871.1 9569.8 9770.3 9772.4 9787.0 9797.3 9846.0 9858.7 9860.0 9873.1 9886.4 7612.8 7699.6 7998.7 8002.6 8026.1 5555.6 5595.8 5624.8 5635.8 5752.0 9303.3 9321.9 9379.8 9530.0 9536.1 8657.7 9050.4 9082.5 9449.5 9481.5 6786.2 7047.0 7207.6 7279.8 7281.4 7865.8 7969.1 8062.1 8064.4 8075.4 6111.5 7001.7 7080.0 7170.7 7235.6 7024.8 7106.1 7125.6 7137.6 7165.0 6593.0 6623.1 6729.3 6732.1 6740.6 4714.8 4722.8 4797.5 4800.6 4890.0 4782.8 4787.6 4791.4 4882.7 4927.7 03:14:28 INFO - PROCESS | 2054 | 03:14:28 INFO - PROCESS | 2054 | [#4] prototype.html Cycles:180 Average:4175.90 Median:4754.05 stddev:1256.93 (26.4%) stddev-sans-first:1226.32 03:14:28 INFO - PROCESS | 2054 | Values: 299.5 307.2 307.2 313.2 317.0 5028.4 5050.3 5061.9 5064.6 5070.6 4725.5 4981.8 4987.0 4987.7 5035.6 3149.7 3533.8 3708.6 3712.3 3732.0 3795.3 3848.0 3863.5 3880.1 3891.3 3147.8 3149.8 3625.2 3798.4 3840.8 3020.3 3630.6 3646.8 3821.7 3834.2 3338.2 3342.5 3343.3 3362.3 3377.2 4769.0 4779.0 4780.7 4785.7 4788.8 3640.5 4222.2 4329.4 4338.5 4339.3 5169.8 5204.3 5217.3 5221.1 5222.0 3101.5 3724.9 3726.3 3729.7 3743.7 4822.4 5539.5 5543.9 5578.7 5579.5 3593.0 3726.8 3777.9 3783.4 3791.4 3846.2 3852.2 3862.9 3872.6 3879.5 4380.3 4397.9 4404.9 4405.2 4428.3 4753.5 5146.0 5207.3 5259.8 5287.7 1109.7 1126.9 1184.9 1225.4 1253.3 729.5 807.7 829.7 868.6 871.3 4197.7 4381.8 4461.7 4542.5 4856.3 4478.0 5443.8 5454.0 5469.6 5481.6 4388.7 4552.5 4762.4 4922.4 4946.9 2546.6 2667.9 2672.9 2702.4 2705.6 4754.6 5351.5 5351.9 5360.1 5410.6 4384.7 4585.6 5219.3 5234.9 5242.0 4556.9 4578.2 4838.7 4925.6 5098.7 4614.5 5112.8 5127.2 5141.0 5166.9 5056.6 5070.3 5095.4 5096.9 5099.9 4814.8 4938.5 4987.9 5211.9 5305.4 3082.8 3368.4 3386.4 3435.6 3586.1 5120.2 5128.6 5142.7 5151.9 5175.3 4459.4 4668.3 4777.8 4960.6 5039.4 4371.3 4762.4 4798.2 4978.5 5002.9 4086.9 4090.5 4519.7 4878.5 4902.0 4875.5 4894.2 4983.6 5128.7 5296.8 4282.8 5077.3 5107.2 5124.3 5154.8 03:14:28 INFO - PROCESS | 2054 | 03:14:28 INFO - PROCESS | 2054 | [#5] yui.html Cycles:180 Average:19704.98 Median:510.61 stddev:28580.19 (5597.2%) stddev-sans-first:28624.78 03:14:28 INFO - PROCESS | 2054 | Values: 710.7 753.9 767.6 784.1 816.9 13188.7 13594.9 14276.4 14865.3 15099.2 12524.2 13383.6 13523.4 13525.9 13536.7 662.3 669.6 688.5 815.9 826.6 685.1 812.7 833.7 837.0 838.4 897.4 897.5 898.3 898.5 900.7 699.0 718.4 891.3 892.8 895.4 608.1 631.8 649.2 650.7 651.0 14158.0 14187.1 14199.4 14200.9 14211.0 12826.1 12842.9 13013.2 13040.5 13087.9 11570.5 11764.2 11852.9 11968.9 12048.2 4231.2 4364.2 4375.5 4412.7 4447.4 65139.0 76512.1 82894.0 85582.6 88712.6 9716.3 9934.1 10260.1 10437.9 10481.9 18720.3 18914.2 19124.0 19159.7 19190.9 7307.5 7432.6 7434.4 7477.2 7511.5 4066.8 4140.8 4199.7 4233.9 4301.0 3277.0 3395.1 3402.7 3405.1 3407.5 637.8 639.5 642.3 653.1 655.7 504.7 567.4 568.2 580.8 591.3 8135.1 8177.4 8440.3 8603.8 8742.5 516.6 517.6 592.9 623.6 625.7 3362.7 3425.5 3558.9 3591.8 3712.9 74769.0 99630.5 116724.0 117675.0 119581.0 62302.7 74807.0 83746.0 84520.0 94564.0 69315.6 82865.0 84471.6 85656.0 90671.0 7857.7 8817.3 9270.1 9430.0 9455.6 52994.0 54276.7 54604.7 56495.0 56759.4 75059.6 77556.4 78291.8 81880.2 82192.2 11734.8 11796.6 11970.9 12125.7 12170.3 12816.7 13253.5 13300.2 13480.0 14441.1 11509.8 12268.1 12587.5 12609.5 12758.9 12383.4 12681.5 12836.2 13173.1 13345.9 12237.6 12499.4 12875.4 13114.8 13230.5 10511.5 10652.9 10906.5 11001.6 11180.6 9640.8 10814.6 10849.9 10870.7 10981.2 03:14:28 INFO - PROCESS | 2054 | -------- Summary: end -------- 03:14:28 INFO - PROCESS | 2054 | 03:14:29 INFO - TEST-INFO | 2054: exit 0 03:14:29 INFO - TEST-OK | dromaeo_css | took 1118645ms 03:14:29 INFO - TEST-START | kraken 03:14:29 INFO - operating with platform_type : mac_ 03:14:29 INFO - Initialising browser for kraken test... 03:14:29 INFO - TEST-INFO | started process 2057 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/tmpX12aAk/profile http://localhost:49338/getInfo.html) 03:14:32 INFO - PROCESS | 2057 | __metrics Screen width/height:1600/1200 03:14:32 INFO - PROCESS | 2057 | colorDepth:24 03:14:32 INFO - PROCESS | 2057 | Browser inner width/height: 1024/689 03:14:32 INFO - PROCESS | 2057 | __metrics 03:14:32 INFO - PROCESS | 2057 | 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" 03:14:32 INFO - PROCESS | 2057 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:14:33 INFO - TEST-INFO | 2057: exit 0 03:14:33 INFO - Browser initialized. 03:14:33 INFO - Running cycle 1/1 for kraken test... 03:14:33 INFO - TEST-INFO | started process 2059 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/tmpX12aAk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:14:45 INFO - PROCESS | 2059 | RSS: Main: 222027776 03:14:45 INFO - PROCESS | 2059 | 03:14:48 INFO - PROCESS | 2059 | Cycle 1(1): loaded http://localhost:49338/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49338/tests/kraken/driver.html?testName=audio-beat-detection) 03:14:49 INFO - PROCESS | 2059 | RSS: Main: 271986688 03:14:49 INFO - PROCESS | 2059 | 03:14:51 INFO - PROCESS | 2059 | Cycle 1(1): loaded http://localhost:49338/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49338/tests/kraken/driver.html?testName=audio-dft) 03:14:52 INFO - PROCESS | 2059 | RSS: Main: 284827648 03:14:52 INFO - PROCESS | 2059 | 03:14:55 INFO - PROCESS | 2059 | Cycle 1(1): loaded http://localhost:49338/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49338/tests/kraken/driver.html?testName=audio-fft) 03:14:56 INFO - PROCESS | 2059 | RSS: Main: 379764736 03:14:56 INFO - PROCESS | 2059 | 03:14:58 INFO - PROCESS | 2059 | Cycle 1(1): loaded http://localhost:49338/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49338/tests/kraken/driver.html?testName=audio-oscillator) 03:14:58 INFO - PROCESS | 2059 | RSS: Main: 283168768 03:14:58 INFO - PROCESS | 2059 | 03:15:00 INFO - PROCESS | 2059 | Cycle 1(1): loaded http://localhost:49338/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49338/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:15:01 INFO - PROCESS | 2059 | RSS: Main: 284356608 03:15:01 INFO - PROCESS | 2059 | 03:15:04 INFO - PROCESS | 2059 | Cycle 1(1): loaded http://localhost:49338/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49338/tests/kraken/driver.html?testName=imaging-darkroom) 03:15:04 INFO - PROCESS | 2059 | RSS: Main: 325083136 03:15:04 INFO - PROCESS | 2059 | 03:15:07 INFO - PROCESS | 2059 | Cycle 1(1): loaded http://localhost:49338/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49338/tests/kraken/driver.html?testName=imaging-desaturate) 03:15:08 INFO - PROCESS | 2059 | RSS: Main: 324259840 03:15:08 INFO - PROCESS | 2059 | 03:15:10 INFO - PROCESS | 2059 | Cycle 1(1): loaded http://localhost:49338/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49338/tests/kraken/driver.html?testName=json-parse-financial) 03:15:11 INFO - PROCESS | 2059 | RSS: Main: 324644864 03:15:11 INFO - PROCESS | 2059 | 03:15:13 INFO - PROCESS | 2059 | Cycle 1(1): loaded http://localhost:49338/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49338/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:15:13 INFO - PROCESS | 2059 | RSS: Main: 298582016 03:15:13 INFO - PROCESS | 2059 | 03:15:15 INFO - PROCESS | 2059 | Cycle 1(1): loaded http://localhost:49338/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49338/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:15:16 INFO - PROCESS | 2059 | RSS: Main: 300883968 03:15:16 INFO - PROCESS | 2059 | 03:15:18 INFO - PROCESS | 2059 | Cycle 1(1): loaded http://localhost:49338/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49338/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:15:19 INFO - PROCESS | 2059 | RSS: Main: 303235072 03:15:19 INFO - PROCESS | 2059 | 03:15:21 INFO - PROCESS | 2059 | Cycle 1(1): loaded http://localhost:49338/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49338/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:15:22 INFO - PROCESS | 2059 | RSS: Main: 321675264 03:15:22 INFO - PROCESS | 2059 | 03:15:25 INFO - PROCESS | 2059 | Cycle 1(1): loaded http://localhost:49338/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49338/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:15:26 INFO - PROCESS | 2059 | RSS: Main: 314060800 03:15:26 INFO - PROCESS | 2059 | 03:15:27 INFO - PROCESS | 2059 | Cycle 1(1): loaded http://localhost:49338/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49338/tests/kraken/driver.html?testName=ai-astar) 03:15:28 INFO - PROCESS | 2059 | RSS: Main: 358432768 03:15:28 INFO - PROCESS | 2059 | 03:15:28 INFO - PROCESS | 2059 | __start_tp_report 03:15:28 INFO - PROCESS | 2059 | _x_x_mozilla_page_load 03:15:28 INFO - PROCESS | 2059 | _x_x_mozilla_page_load_details 03:15:28 INFO - PROCESS | 2059 | |i|pagename|runs| 03:15:28 INFO - PROCESS | 2059 | |0;ai-astar;114;113;115;113;112;114;113;112;114;113 03:15:28 INFO - PROCESS | 2059 | |1;audio-beat-detection;142;109;109;143;110;111;110;116;173;137 03:15:28 INFO - PROCESS | 2059 | |2;audio-dft;184;186;183;189;183;184;186;184;188;184 03:15:28 INFO - PROCESS | 2059 | |3;audio-fft;81;59;58;91;61;58;57;59;82;58 03:15:28 INFO - PROCESS | 2059 | |4;audio-oscillator;86;66;94;70;69;68;90;68;68;91 03:15:28 INFO - PROCESS | 2059 | |5;imaging-gaussian-blur;117;130;92;85;87;84;87;84;88;85 03:15:28 INFO - PROCESS | 2059 | |6;imaging-darkroom;96;104;97;97;96;97;97;97;95;95 03:15:28 INFO - PROCESS | 2059 | |7;imaging-desaturate;82;84;79;80;81;83;82;85;83;84 03:15:28 INFO - PROCESS | 2059 | |8;json-parse-financial;54;53;52;54;56;59;60;59;58;59 03:15:28 INFO - PROCESS | 2059 | |9;json-stringify-tinderbox;64;66;75;78;74;70;73;70;73;73 03:15:28 INFO - PROCESS | 2059 | |10;stanford-crypto-aes;84;84;82;83;82;83;83;86;85;84 03:15:28 INFO - PROCESS | 2059 | |11;stanford-crypto-ccm;141;144;150;149;141;144;153;159;187;148 03:15:28 INFO - PROCESS | 2059 | |12;stanford-crypto-pbkdf2;165;167;165;164;160;167;161;162;163;164 03:15:28 INFO - PROCESS | 2059 | |13;stanford-crypto-sha256-iterative;68;67;68;67;67;68;66;65;65;66 03:15:28 INFO - PROCESS | 2059 | __end_tp_report 03:15:28 INFO - PROCESS | 2059 | __start_cc_report 03:15:28 INFO - PROCESS | 2059 | _x_x_mozilla_cycle_collect,2034 03:15:28 INFO - PROCESS | 2059 | __end_cc_report 03:15:28 INFO - PROCESS | 2059 | __startTimestamp1484997328182__endTimestamp 03:15:28 INFO - PROCESS | 2059 | 03:15:28 INFO - PROCESS | 2059 | ------- Summary: start ------- 03:15:28 INFO - PROCESS | 2059 | Number of tests: 14 03:15:28 INFO - PROCESS | 2059 | 03:15:28 INFO - PROCESS | 2059 | [#0] ai-astar Cycles:10 Average:113.30 Median:113.50 stddev:0.95 (0.8%) stddev-sans-first:0.97 03:15:28 INFO - PROCESS | 2059 | Values: 114.0 113.0 115.0 113.0 112.0 114.0 113.0 112.0 114.0 113.0 03:15:28 INFO - PROCESS | 2059 | 03:15:28 INFO - PROCESS | 2059 | [#1] audio-beat-detection Cycles:10 Average:126.00 Median:126.50 stddev:21.83 (17.3%) stddev-sans-first:22.38 03:15:28 INFO - PROCESS | 2059 | Values: 142.0 109.0 109.0 143.0 110.0 111.0 110.0 116.0 173.0 137.0 03:15:28 INFO - PROCESS | 2059 | 03:15:28 INFO - PROCESS | 2059 | [#2] audio-dft Cycles:10 Average:185.10 Median:185.00 stddev:2.08 (1.1%) stddev-sans-first:2.17 03:15:28 INFO - PROCESS | 2059 | Values: 184.0 186.0 183.0 189.0 183.0 184.0 186.0 184.0 188.0 184.0 03:15:28 INFO - PROCESS | 2059 | 03:15:28 INFO - PROCESS | 2059 | [#3] audio-fft Cycles:10 Average:66.40 Median:60.00 stddev:12.91 (21.5%) stddev-sans-first:12.57 03:15:28 INFO - PROCESS | 2059 | Values: 81.0 59.0 58.0 91.0 61.0 58.0 57.0 59.0 82.0 58.0 03:15:28 INFO - PROCESS | 2059 | 03:15:28 INFO - PROCESS | 2059 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:78.00 stddev:11.60 (14.9%) stddev-sans-first:11.84 03:15:28 INFO - PROCESS | 2059 | Values: 86.0 66.0 94.0 70.0 69.0 68.0 90.0 68.0 68.0 91.0 03:15:28 INFO - PROCESS | 2059 | 03:15:28 INFO - PROCESS | 2059 | [#5] imaging-gaussian-blur Cycles:10 Average:93.90 Median:86.00 stddev:16.07 (18.7%) stddev-sans-first:14.71 03:15:28 INFO - PROCESS | 2059 | Values: 117.0 130.0 92.0 85.0 87.0 84.0 87.0 84.0 88.0 85.0 03:15:28 INFO - PROCESS | 2059 | 03:15:28 INFO - PROCESS | 2059 | [#6] imaging-darkroom Cycles:10 Average:97.10 Median:97.00 stddev:2.56 (2.6%) stddev-sans-first:2.68 03:15:28 INFO - PROCESS | 2059 | Values: 96.0 104.0 97.0 97.0 96.0 97.0 97.0 97.0 95.0 95.0 03:15:28 INFO - PROCESS | 2059 | 03:15:28 INFO - PROCESS | 2059 | [#7] imaging-desaturate Cycles:10 Average:82.30 Median:83.00 stddev:1.89 (2.3%) stddev-sans-first:2.00 03:15:28 INFO - PROCESS | 2059 | Values: 82.0 84.0 79.0 80.0 81.0 83.0 82.0 85.0 83.0 84.0 03:15:28 INFO - PROCESS | 2059 | 03:15:28 INFO - PROCESS | 2059 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:58.50 stddev:2.95 (5.0%) stddev-sans-first:3.00 03:15:28 INFO - PROCESS | 2059 | Values: 54.0 53.0 52.0 54.0 56.0 59.0 60.0 59.0 58.0 59.0 03:15:28 INFO - PROCESS | 2059 | 03:15:28 INFO - PROCESS | 2059 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:73.00 stddev:4.20 (5.7%) stddev-sans-first:3.43 03:15:28 INFO - PROCESS | 2059 | Values: 64.0 66.0 75.0 78.0 74.0 70.0 73.0 70.0 73.0 73.0 03:15:28 INFO - PROCESS | 2059 | 03:15:28 INFO - PROCESS | 2059 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:84.00 stddev:1.26 (1.5%) stddev-sans-first:1.33 03:15:28 INFO - PROCESS | 2059 | Values: 84.0 84.0 82.0 83.0 82.0 83.0 83.0 86.0 85.0 84.0 03:15:28 INFO - PROCESS | 2059 | 03:15:28 INFO - PROCESS | 2059 | [#11] stanford-crypto-ccm Cycles:10 Average:151.60 Median:149.50 stddev:13.63 (9.1%) stddev-sans-first:13.91 03:15:28 INFO - PROCESS | 2059 | Values: 141.0 144.0 150.0 149.0 141.0 144.0 153.0 159.0 187.0 148.0 03:15:28 INFO - PROCESS | 2059 | 03:15:28 INFO - PROCESS | 2059 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.80 Median:164.50 stddev:2.35 (1.4%) stddev-sans-first:2.45 03:15:28 INFO - PROCESS | 2059 | Values: 165.0 167.0 165.0 164.0 160.0 167.0 161.0 162.0 163.0 164.0 03:15:28 INFO - PROCESS | 2059 | 03:15:28 INFO - PROCESS | 2059 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.16 (1.7%) stddev-sans-first:1.13 03:15:28 INFO - PROCESS | 2059 | Values: 68.0 67.0 68.0 67.0 67.0 68.0 66.0 65.0 65.0 66.0 03:15:28 INFO - PROCESS | 2059 | -------- Summary: end -------- 03:15:28 INFO - PROCESS | 2059 | 03:15:29 INFO - TEST-INFO | 2059: exit 0 03:15:29 INFO - TEST-OK | kraken | took 59607ms 03:15:29 INFO - SUITE-END | took 1178s 03:15:29 INFO - Completed test suite (00:19:38) 03:15:29 INFO - javascript benchmark 03:15:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3294.2917272786344, 3294.7364210863125, 3318.8672453101894, 3320.6513316101796, 3351.6145643251034, 5653.4911857932775, 5678.205051292817, 5704.201411802341, 5723.42765723428, 5795.739191736367, 5672.858178545528, 5701.429857014296, 5746.396628354026, 5756.338021127572, 5769.913451298234, 4690.976545117278, 4899.755012249391, 5236.7119808410525, 5273.288106105684, 5281.128613778722, 5148.021875843578, 5167.741612919358, 5173.793048278064, 5182.896342073156, 5332.626716129873, 4334.371516130175, 5206.114960456732, 5269.947300526984, 5273.129933560977, 5297.0, 5233.502817232356, 5271.314729085233, 5286.61502611014, 5296.867578310554, 5308.9469105308835, 4338.739675619473, 5033.572146367563, 5122.667026643294, 5227.18978558324, 5255.527002569787, 5606.55147588192, 5640.464155905182, 5647.322321321427, 5709.600327977043, 5732.656040637575, 6103.671041328357, 6121.693915304217, 6168.321484636686, 6213.130161777355, 6238.438540531374, 6289.937100628981, 6300.842478938017, 6303.0, 6305.621662700207, 6334.5249106317215, 5574.386817450078, 5712.600117991784, 5744.4829965303325, 5760.74076666551, 5788.0, 6264.749410023639, 6284.497240220771, 6289.842753931189, 6289.993601023814, 6306.400891915261, 6101.267847858286, 6105.572609917263, 6107.694615269308, 6108.3280839107665, 6140.6929653517145, 6106.297775755756, 6133.407859146218, 6139.798803208702, 6185.257769067741, 6239.344868788712, 6143.249173985482, 6213.937860621426, 6214.844628884223, 6224.408681175281, 6227.595206311576, 6121.173641558333, 6232.906506402408, 6233.096201050913, 6233.532485063638, 6250.343713910065, 4807.230843065093, 4858.80564777412, 4918.0, 4935.703857768545, 4962.057209130326, 4357.411749413852, 4386.990992071841, 4399.1641588098155, 4426.070525189746, 4444.911101777946, 5151.562117220078, 5698.17376480408, 5732.656040637575, 5750.6262092963825, 5777.6822274775295, 6212.689365531795, 6245.0320200369015, 6245.5628106032145, 6251.093591429309, 6258.843528911813, 5600.131979543177, 5646.2377579027125, 5723.685197314105, 5724.79963201286, 5738.454846789548, 5317.388500322435, 5336.519713225828, 5365.678059316453, 5387.461253874581, 5389.487998640123, 6272.529560282997, 6307.96846015767, 6309.936900630935, 6314.842128946813, 6328.398802113792, 6122.387761223842, 6247.406496382836, 6277.3408792078, 6281.497480201481, 6292.339304372975, 5103.285540024325, 6208.596441231305, 6233.937660623517, 6277.466415354746, 6304.369563043659, 5144.356955380577, 6077.4834139098675, 6167.352427995175, 6172.259328880384, 6198.659073750807, 6086.147939288415, 6262.780802671885, 6269.404406581368, 6278.529110316836, 6281.874362512815, 5914.763409463573, 5964.135200395832, 6008.128821320972, 6042.154098426312, 6117.0, 6037.879242415039, 6042.667653278936, 6100.267967843887, 6111.602745821508, 6143.56995010345, 5921.851953701192, 5930.406959304035, 5930.673812940157, 5938.257717785277, 5944.286685597583, 5850.23946886902, 6080.69596520181, 6093.2078829751845, 6104.816855494342, 6110.175126358063, 5814.709264536841, 5833.562482813891, 5865.0, 5873.911891321719, 5918.201042859331], "value": 5658.252764176221, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.66868694943963, 484.9321095046692, 500.07486150621355, 505.7825135191866, 520.4717212029789, 24661.63007554886, 30738.0, 37767.43348849769, 38986.610133898655, 38988.610113898925, 32703.345933081324, 40480.19039619206, 40612.59387406125, 40648.79675601625, 40752.796236018854, 9108.863367049516, 9302.674406395778, 9304.488253146073, 9306.953465232664, 9312.20846228068, 8377.41358104933, 8525.147485251488, 9178.816423671522, 11080.722981925435, 11279.774404511905, 11235.325880447159, 11277.984981351678, 11299.887001129966, 11301.547938082467, 11304.830427543593, 11204.103671706243, 11279.49242284095, 11285.943570282177, 11287.774244515145, 11319.151063670257, 8226.300764434971, 8449.112843151443, 10873.510692018877, 11134.38760868152, 11152.498137583747, 38613.455461781494, 38703.03242418934, 38711.22577548433, 38772.0, 39157.804210978764, 3210.598675165604, 3211.1169428407143, 3301.5212794144954, 3308.3052558962645, 3324.2188085799817, 23462.41913389526, 27899.581506277424, 28245.71754282472, 28474.86100555996, 28919.0, 2944.720251576097, 3030.2727345437156, 3051.6948305169303, 3061.3418115105137, 3125.7655675824403, 432029.0, 434641.8267908672, 436910.0, 437050.0, 438636.0, 46674.0, 57269.42730572641, 57575.0, 57835.843283134105, 57889.421105789246, 61030.0, 61156.694216529526, 61295.38704612986, 61350.0, 61548.38451615516, 14203.650653187931, 15811.762823557656, 16098.873078884366, 16146.35414583427, 16174.676506469805, 11487.885121148849, 11888.702782430335, 12384.938075309747, 12408.0, 12421.875781242252, 15068.472603459046, 15167.24163791806, 15297.388104475918, 15903.284352203947, 16010.199490025452, 7390.0, 7475.551466912003, 7532.887006694904, 7603.809904752315, 7675.654595543214, 824.406427372291, 899.1772528136681, 906.582971832951, 991.3407583956732, 1015.5480811039164, 27643.0, 28589.857050714614, 28705.712942870305, 29034.41931161365, 29046.7095329044, 993.7962717642865, 1025.6512785652915, 1045.1586472889396, 1047.3611097230682, 1060.183658582887, 14896.404143834343, 15009.0, 15085.170315632526, 15338.616534586725, 15448.613784655248, 664963.0, 668824.0, 671566.0, 673866.0, 722388.0, 45870.08259834851, 54809.45190548123, 55965.88068238612, 56109.71945140248, 58491.415085848595, 1318.9010824188033, 1342.9865701342862, 1351.2838195756265, 1366.5763613279914, 1367.6239034265457, 28826.0, 29319.85340073286, 29737.0, 30426.84786576053, 30475.39049218959, 48220.517794823005, 48700.78248043686, 48709.02581948412, 48830.267545987546, 48958.51041489682, 581813.1818681759, 584049.0, 584363.0, 585578.0, 586646.0, 24666.383340416633, 25860.224193274233, 25860.965561378085, 25892.22323330303, 25921.0, 44218.557814421445, 44348.0, 44465.88835279144, 44786.77606611946, 45366.86582835455, 36228.55085796538, 36401.453978190875, 37239.6276037247, 37725.05687357838, 38593.42109868298, 36973.48360288187, 36996.0, 37020.074498137765, 37032.814835925645, 37257.0, 36186.27627447489, 36209.55161793499, 37031.814840925625, 37039.25921481609, 37195.6981505646, 30571.0, 31000.224994374417, 31110.37779244357, 32985.0, 33695.3260934775, 18790.530236743645, 24760.752392475846, 24981.0, 25110.748892511572, 25255.62116568216], "value": 19337.875927892637, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.73496142931396, 370.46097927515467, 374.79011753418087, 382.7569493371709, 400.903783092058, 14724.705505889875, 15207.239638018096, 15831.28759205837, 19996.700214486085, 20466.38600841977, 19911.0, 20401.693974590395, 20499.590008199826, 20507.97460126995, 20722.171113155495, 5420.349558053039, 5631.18347839564, 5869.325027621835, 5871.735771890254, 5874.588778785486, 5372.409035006146, 5776.133579963018, 5803.071508558632, 5815.5638327125425, 5826.92201942642, 5662.6036177467595, 5691.51622112121, 5784.623999440023, 5785.074388097905, 5793.681347525884, 5944.851378715523, 6059.848503787396, 6072.180255665473, 6073.848153796168, 6082.604630699035, 5726.513246374063, 5762.0, 5838.795642152547, 5860.886431578029, 5907.172995780594, 12938.417771200224, 13029.869701303056, 13087.803682944763, 13245.07284490086, 13247.536336228186, 2204.6582779669175, 2213.922512712047, 2259.954800903989, 2263.287064574654, 2310.353101131686, 9332.813343733087, 9337.393069450532, 9531.809363812754, 10316.742081447948, 14506.70986580273, 1767.9469615911544, 1843.6220574782137, 1850.7316439116253, 1872.6535590915723, 1911.4361263427322, 104215.99999999924, 112272.0, 119465.40267298695, 123040.0, 125694.0, 9477.763055923519, 9522.428654280628, 9994.600215991424, 10037.79924401508, 10084.294099412971, 12373.257604543576, 12465.0, 12481.31352775588, 12494.375281235902, 12496.125271231109, 7811.336036436853, 8093.94778678768, 8096.068952070587, 8143.959280203561, 8149.592520373958, 7493.288137626917, 8052.033755949206, 8187.959060204661, 8206.58967051657, 8376.036755773042, 3858.6527212550445, 3869.5743468218475, 3872.2255548890334, 3929.2337994090876, 3951.38753493209, 1624.5045261195448, 1867.215769376865, 1928.4889504281377, 1930.3726288955866, 1932.9033548322527, 765.2615226306641, 847.5719761520393, 932.2914584915377, 940.8917974432891, 994.3884511025667, 19525.414237572895, 21161.470963225736, 21212.151513939578, 21336.15782857047, 21388.786112138678, 925.2043242811177, 929.0, 931.8322701913585, 932.128459890005, 939.7838497145558, 10354.482275886327, 11005.853858497676, 11023.338599683884, 11043.889561104446, 11142.164337674707, 583841.0, 585899.0, 592606.0, 597622.0, 598886.0, 117251.0, 123000.38499807444, 123550.14674779706, 128645.71354286338, 129213.0, 922.7785331520387, 926.5645146781002, 945.6501094595044, 947.0766003147014, 948.9952550237205, 17999.10004499796, 18210.180541875383, 18576.535586610444, 18608.627827443644, 18613.906930465262, 50472.195697493786, 51366.74316628393, 51585.0, 52076.47923520716, 53323.0, 70379.0, 72145.0, 73286.90069648853, 73446.63276683583, 74688.0, 7850.025198720577, 7912.4856884302335, 8102.918970810217, 8142.674293028213, 8266.586670666564, 11045.889541104487, 12039.939800300943, 12463.252204867737, 12549.93725031369, 12554.246745195318, 10302.948485257526, 10661.307015043998, 10768.0, 10785.191110666889, 11107.222494425636, 10569.63006294776, 10615.787684246117, 10694.946525267324, 10707.411092389993, 10887.673369798918, 10863.293885897392, 10889.945550272198, 10951.780964380827, 11171.888281117084, 11428.771424571629, 7726.961365193138, 7807.219278072147, 8068.83862322762, 8069.0, 8081.674160776223, 8745.387822852339, 10639.042486175971, 10898.400587967737, 10966.506507207354, 11123.221374503708], "value": 9090.717978246086, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1241.5654520917685, 1467.2956980649285, 1495.4167874528935, 1658.6599747051855, 1847.7782666080072, 7480.850382992337, 7803.843923121542, 8130.349572034238, 8415.242628163463, 8425.0, 8176.305014073796, 8258.2154695304, 8262.256396924276, 8265.338772898169, 8274.544900030496, 2287.8627282363027, 2318.4435735423463, 2320.037184568402, 2321.1759825262043, 2331.3705299569106, 2293.0827668932393, 2335.871527066011, 2345.366750977235, 2350.74141844397, 2357.1749887539395, 2282.429392651837, 2291.4958709083976, 2314.1090680088205, 2315.81473482121, 2322.0479603362623, 2264.116994372196, 2277.419258089193, 2304.5966955782837, 2305.538892221554, 2312.6415405612156, 2299.1378233162563, 2319.118734880751, 2320.93037208884, 2322.4890524084676, 2323.7095363079616, 7964.482308649977, 8188.713395031145, 8272.793180170484, 8275.54484503352, 8287.50274983503, 5039.672421292605, 5223.320968274138, 5229.450907654679, 5231.503007214308, 5242.449542798027, 3291.1936575538907, 3404.3318773800906, 3460.532828068229, 3495.7627118643836, 3507.1056880495566, 1030.798994196132, 1051.2693677893867, 1640.4176517336293, 1664.2261348472898, 1751.7985431675265, 8728.694495692684, 10374.170066394745, 10385.584576616926, 10388.168946484187, 10412.79174416515, 4309.655227581786, 4349.673774466928, 4448.733076015449, 4522.231220692424, 4522.547745225517, 8627.007894092134, 8629.180227878342, 8632.093630168867, 8638.308935285288, 8643.17889800468, 5053.31780209667, 5135.152699804565, 5146.1766117421785, 5146.1766117421785, 5147.022065807485, 4030.629585940794, 4280.828766849353, 4432.357308190294, 4763.071201115749, 4831.565159135695, 3594.7303952203165, 3624.4019736743144, 3689.8893033209047, 3721.925561488755, 3724.348239058154, 1133.9376334301692, 1146.1232157399595, 1148.6955956671488, 1151.8732939376662, 1160.1263958706627, 806.0850934189737, 857.7469646454311, 886.1138861138861, 896.4800415758845, 899.2805755395788, 5419.214213939035, 5516.310461192351, 5517.806876759294, 5527.861803454945, 5688.033034384164, 867.8784970104191, 904.073324842029, 919.3242966419676, 919.4437365393841, 929.7768535551419, 3518.7536872419196, 3550.680438760524, 3583.2654305867236, 3642.927141457156, 3871.070942973722, 9569.808603827885, 9770.316077874622, 9772.364796288219, 9787.021297870298, 9797.314188006914, 9846.015398460097, 9858.704238872846, 9860.0, 9873.062059104373, 9886.406815591088, 7612.7922902358805, 7699.576523291161, 7998.720044798521, 8002.599545079588, 8026.077001144827, 5555.611107222456, 5595.804146855004, 5624.775008999594, 5635.802746903839, 5752.0, 9303.255739540686, 9321.906780932104, 9379.812403752023, 9529.952350238205, 9536.094071063239, 8657.696980605648, 9050.366474346733, 9082.545872706207, 9449.527523623654, 9481.52592370365, 6786.151731033621, 7046.964765176142, 7207.5675459472595, 7279.781606551812, 7281.417486601165, 7865.803354915944, 7969.123396426505, 8062.072861620754, 8064.395170362129, 8075.353971682369, 6111.480524155319, 7001.719931202695, 7079.964600176966, 7170.713171473083, 7235.565866048054, 7024.789256322319, 7106.111736032996, 7125.643717813985, 7137.643117844191, 7165.0, 6593.044008618627, 6623.072769812134, 6729.317670582354, 6732.057511948233, 6740.561863478858, 4714.764261786965, 4722.834700785456, 4797.51924424417, 4800.591949684316, 4890.021995600823, 4782.760861956958, 4787.593054590259, 4791.377120974251, 4882.731449770296, 4927.728974906415], "value": 4388.633628014347, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.4699382093694, 307.1645125259294, 307.1966806800218, 313.1997745759583, 316.9508726147448, 5028.421731500874, 5050.318207042048, 5061.949380506203, 5064.620153488485, 5070.619703522237, 4725.535084123915, 4981.750912454381, 4987.0, 4987.675801072928, 5035.647504674675, 3149.7322727568126, 3533.823308834548, 3708.6105958874336, 3712.273792686414, 3732.033033738171, 3795.3358162321483, 3848.018270590648, 3863.4784304118866, 3880.1075752576926, 3891.2801131790566, 3147.7796554241213, 3149.8423579847877, 3625.184333524949, 3798.373268410709, 3840.8271627776817, 3020.328365950483, 3630.6385105585405, 3646.8176591170336, 3821.6624181536517, 3834.175652234783, 3338.2322065924973, 3342.5320455136302, 3343.2979074394407, 3362.3443428531446, 3377.240120972786, 4768.998510312838, 4779.0, 4780.713157210544, 4785.68893021956, 4788.754923719823, 3640.4539319102346, 4222.1766755482695, 4329.437173167499, 4338.490117550693, 4339.305711086211, 5169.819056333048, 5204.271402003685, 5217.3217481727515, 5221.136359094281, 5221.973890130525, 3101.5347697845277, 3724.888253352404, 3726.273376691546, 3729.72027097966, 3743.737938344317, 4822.397200349957, 5539.529140023103, 5543.918935807519, 5578.693171875586, 5579.525740312079, 3592.9820350898076, 3726.832292546842, 3777.9244415112094, 3783.432485127253, 3791.431285307171, 3846.1730727893637, 3852.1910398816003, 3862.9227415451533, 3872.554656214515, 3879.4956655634587, 4380.255356589388, 4397.934030989538, 4404.867853964322, 4405.229084910128, 4428.335749637516, 4753.453352864465, 5146.022255771391, 5207.29701490294, 5259.8422047338645, 5287.656302340336, 1109.7114750165015, 1126.9492872820742, 1184.8980448183272, 1225.393430252013, 1253.3044160491015, 729.4565548666171, 807.7036356647496, 829.6805729794073, 868.6091258933379, 871.3487940352995, 4197.685173611992, 4381.846635367747, 4461.706105229512, 4542.547024606742, 4856.3201151838775, 4477.977610111929, 5443.8094666686475, 5453.972730136324, 5469.56243500519, 5481.643693159932, 4388.733519776281, 4552.499225085238, 4762.428508578923, 4922.391132699675, 4946.925796113062, 2546.61800729892, 2667.919962401131, 2672.893084276607, 2702.378452955831, 2705.6482657254824, 4754.643401744883, 5351.451266423586, 5351.892962140813, 5360.103885725748, 5410.646368829572, 4384.671149663788, 4585.638396225946, 5219.295395121686, 5234.900670859162, 5241.97781432617, 4556.863294101182, 4578.153041687298, 4838.693750185163, 4925.6305777066145, 5098.719570423662, 4614.515475874985, 5112.821051263188, 5127.231295100753, 5141.0, 5166.892320605203, 5056.64603477753, 5070.290159377764, 5095.363079615048, 5096.898062038813, 5099.92350114756, 4814.831480898151, 4938.506149385033, 4987.877727511426, 5211.905499845075, 5305.363356397257, 3082.7533797295714, 3368.4105281576117, 3386.4073787087655, 3435.639257877887, 3586.1214002569536, 5120.206368012964, 5128.615353848401, 5142.742862856917, 5151.866589350337, 5175.292153589231, 4459.44256967879, 4668.253079507263, 4777.8260891293685, 4960.635825147969, 5039.370078740158, 4371.338891221316, 4762.380890484354, 4798.23228283473, 4978.465289644393, 5002.899942001067, 4086.9169670036868, 4090.529589097292, 4519.728816271035, 4878.487489007909, 4901.950980490149, 4875.536824001714, 4894.161386395953, 4983.601311894967, 5128.666636668605, 5296.788128474818, 4282.80727367263, 5077.2637967493765, 5107.182850743863, 5124.256982737556, 5154.7938082477785], "value": 3778.857171862049, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.7299226294009, 753.8793792993122, 767.6353731977312, 784.0747917457405, 816.9387295952805, 13188.736225275501, 13594.932025339871, 14276.428942842287, 14865.331060102295, 15099.169545674984, 12524.248545087301, 13383.59849204523, 13523.391447384867, 13525.93237033816, 13536.72926541471, 662.2582707367754, 669.5647828911223, 688.4561196654637, 815.9428839981204, 826.6114925984807, 685.0854109763471, 812.7277362083709, 833.6915341323688, 836.9788857593726, 838.4172999765166, 897.4391005621486, 897.4570384917129, 898.27239935652, 898.5282726568538, 900.6757567275776, 698.9580625162506, 718.3606590134784, 891.2736120062161, 892.7634176943116, 895.4403497813898, 608.0726891490468, 631.8009826904511, 649.217692680319, 650.7266947881853, 651.0072139986511, 14158.0, 14187.14877107377, 14199.36102875373, 14200.928995354958, 14211.0, 12826.102172847905, 12842.87157128426, 13013.21920684762, 13040.543580974716, 13087.869121308855, 11570.53717851285, 11764.176507644383, 11852.881471185265, 11968.88031119695, 12048.216865903689, 4231.153769246163, 4364.192624364503, 4375.540568240321, 4412.691111622188, 4447.399601053881, 65139.022914656794, 76512.08719781994, 82894.0, 85582.5720871398, 88712.55643721805, 9716.31985761004, 9934.105930466292, 10260.127889129508, 10437.895621043692, 10481.895181048092, 18720.344787932358, 18914.243430262635, 19124.0, 19159.712604310946, 19190.904045479685, 7307.451941104332, 7432.554046757212, 7434.368078713262, 7477.242847930732, 7511.549307041595, 4066.7763273019677, 4140.8136633851545, 4199.727017743837, 4233.851815186454, 4300.956990430056, 3277.0, 3395.1342407685884, 3402.6937575618313, 3405.1146701857697, 3407.4548072308808, 637.8150336402484, 639.5491178718992, 642.3480167629859, 653.1117679955257, 655.7278729327371, 504.6694415158004, 567.3758865248194, 568.1704711121808, 580.7880123754884, 591.3052163707712, 8135.085177598993, 8177.427580069338, 8440.282575981111, 8603.827923441497, 8742.519161446055, 516.5557620446413, 517.5859312549945, 592.8547505861005, 623.6227082615044, 625.7090452939404, 3362.680545348188, 3425.520427140202, 3558.928821423557, 3591.789065283659, 3712.9443058354145, 74769.0, 99630.5018474903, 116724.0, 117675.0, 119581.0, 62302.68848655728, 74806.99999999891, 83746.0, 84520.0, 94564.0, 69315.61368772697, 82865.0, 84471.5776421114, 85656.0, 90670.99999999868, 7857.685692572461, 8817.25053370445, 9270.072992700676, 9429.999851058406, 9455.621775129193, 52994.0, 54276.72861635667, 54604.726976364866, 56495.0, 56759.432405677064, 75059.62470187833, 77556.44887102339, 78291.82562261456, 81880.18119818963, 82192.17807821845, 11734.823977640513, 11796.646100616996, 11970.940145299217, 12125.69685757863, 12170.330631815335, 12816.743665126458, 13253.469861205444, 13300.201987880759, 13480.0, 14441.06133101387, 11509.769804604028, 12268.087437135957, 12587.496500139892, 12609.49562017509, 12758.872411275768, 12383.442745076312, 12681.492740290285, 12836.16564923277, 13173.077884548373, 13345.933270333586, 12237.571684990982, 12499.437525311565, 12875.35623218854, 13114.803277950648, 13230.536931207362, 10511.474426278503, 10652.89347106519, 10906.454677266263, 11001.559937602406, 11180.552777888794, 9640.807183856425, 10814.567417303535, 10849.891501084889, 10870.673879783619, 10981.231313807957], "value": 7079.1444575848645, "unit": "score"}], "name": "dromaeo_css", "value": 6991.465669713611, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 115.0, 113.0, 112.0, 114.0, 113.0, 112.0, 114.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 109.0, 109.0, 143.0, 110.0, 111.0, 110.0, 116.0, 173.0, 137.0], "value": 126.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 186.0, 183.0, 189.0, 183.0, 184.0, 186.0, 184.0, 188.0, 184.0], "value": 185.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 58.0, 91.0, 61.0, 58.0, 57.0, 59.0, 82.0, 58.0], "value": 66.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 66.0, 94.0, 70.0, 69.0, 68.0, 90.0, 68.0, 68.0, 91.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 130.0, 92.0, 85.0, 87.0, 84.0, 87.0, 84.0, 88.0, 85.0], "value": 93.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 104.0, 97.0, 97.0, 96.0, 97.0, 97.0, 97.0, 95.0, 95.0], "value": 97.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 79.0, 80.0, 81.0, 83.0, 82.0, 85.0, 83.0, 84.0], "value": 82.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 52.0, 54.0, 56.0, 59.0, 60.0, 59.0, 58.0, 59.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 75.0, 78.0, 74.0, 70.0, 73.0, 70.0, 73.0, 73.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 82.0, 83.0, 82.0, 83.0, 83.0, 86.0, 85.0, 84.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 144.0, 150.0, 149.0, 141.0, 144.0, 153.0, 159.0, 187.0, 148.0], "value": 151.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 165.0, 164.0, 160.0, 167.0, 161.0, 162.0, 163.0, 164.0], "value": 163.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 67.0, 67.0, 68.0, 66.0, 65.0, 65.0, 66.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1434.7999999999997, "alertThreshold": 2.0}]} 03:15:29 INFO - Return code: 0 03:15:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:15:29 INFO - # TBPL SUCCESS # 03:15:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:15:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:15:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:15:29 INFO - 2017-01-21 03:15:29.516 screenresolution[2064:20084] starting screenresolution argv=screenresolution get 03:15:29 INFO - 2017-01-21 03:15:29.519 screenresolution[2064:20084] Display 0: 1600x1200x32@60 03:15:29 INFO - 2017-01-21 03:15:29.525 screenresolution[2065:20087] starting screenresolution argv=screenresolution list 03:15:29 INFO - Available Modes on Display 0 03:15:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:15:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:15:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:15:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:15:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:15:29 INFO - Intel Iris: 03:15:29 INFO - Chipset Model: Intel Iris 03:15:29 INFO - Type: GPU 03:15:29 INFO - Bus: Built-In 03:15:29 INFO - VRAM (Dynamic, Max): 1536 MB 03:15:29 INFO - Vendor: Intel (0x8086) 03:15:29 INFO - Device ID: 0x0a2e 03:15:29 INFO - Revision ID: 0x0009 03:15:29 INFO - Displays: 03:15:29 INFO - Display: 03:15:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:15:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:15:29 INFO - Display Serial Number: 1600x1200 60 03:15:29 INFO - Main Display: Yes 03:15:29 INFO - Mirror: Off 03:15:29 INFO - Online: Yes 03:15:29 INFO - Rotation: Supported 03:15:29 INFO - Return code: 0 03:15:29 INFO - Running post-action listener: _resource_record_post_action 03:15:29 INFO - [mozharness: 2017-01-21 11:15:29.773702Z] Finished run-tests step (success) 03:15:29 INFO - Running post-run listener: _resource_record_post_run 03:15:29 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 397312; Write bytes: 661749248; Read time: 7; Write time: 1973 03:15:29 INFO - TinderboxPrint: CPU usage
53.7% 03:15:29 INFO - TinderboxPrint: I/O read bytes / time
397,312 / 7 03:15:29 INFO - TinderboxPrint: I/O write bytes / time
661,749,248 / 1,973 03:15:29 INFO - TinderboxPrint: CPU idle
2,243.2 (46.3%) 03:15:29 INFO - TinderboxPrint: CPU system
971.7 (20.1%) 03:15:29 INFO - TinderboxPrint: CPU user
1,626.7 (33.6%) 03:15:29 INFO - TinderboxPrint: Swap in / out
351,453,184 / 0 03:15:29 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 341213696; Write bytes: 336791040; Read time: 26830; Write time: 739 03:15:29 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 372736; Write bytes: 307230720; Read time: 7; Write time: 1178 03:15:30 INFO - Running post-run listener: _upload_blobber_files 03:15:30 INFO - Blob upload gear active. 03:15:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:15:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:15:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:15:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:15:30 INFO - (blobuploader) - INFO - Open directory for files ... 03:15:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:15:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:15:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:15:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:15:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:15:33 INFO - (blobuploader) - INFO - Done attempting. 03:15:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:15:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:15:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:15:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:15:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:15:34 INFO - (blobuploader) - INFO - Done attempting. 03:15:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:15:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:15:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:15:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:15:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:15:36 INFO - (blobuploader) - INFO - Done attempting. 03:15:36 INFO - (blobuploader) - INFO - Iteration through files over. 03:15:36 INFO - Return code: 0 03:15:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:15:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:15:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/883a44ac26637ed486f8b792e061f1994bdd46db716e0c6995bb7d4b4973b20d2dc94af51f5c77daa0aa0df5a766c6965ebf1e7055dfc2218b2a2fb71474ef7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3674e1c9712cc065e38c77478d2f0f126ead0a312b882cc03fb8aecd645c8b9be13bbe117400599206b1e31d9ea49ff89ce29cdb6549f30cca7e67ab94338a16", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42a7e53f31f1b2f8cc08dcaa98d6eb22430b95101d0fb6f20df251d8971a3f6c4d4507e6c9d8abde034a034a7fc26d9ea19017e3d2ac5cb4f7dce5bc7cfee6e0"} 03:15:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:15:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:15:36 INFO - Contents: 03:15:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/883a44ac26637ed486f8b792e061f1994bdd46db716e0c6995bb7d4b4973b20d2dc94af51f5c77daa0aa0df5a766c6965ebf1e7055dfc2218b2a2fb71474ef7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3674e1c9712cc065e38c77478d2f0f126ead0a312b882cc03fb8aecd645c8b9be13bbe117400599206b1e31d9ea49ff89ce29cdb6549f30cca7e67ab94338a16", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42a7e53f31f1b2f8cc08dcaa98d6eb22430b95101d0fb6f20df251d8971a3f6c4d4507e6c9d8abde034a034a7fc26d9ea19017e3d2ac5cb4f7dce5bc7cfee6e0"} 03:15:36 INFO - Running post-run listener: copy_logs_to_upload_dir 03:15:36 INFO - Copying logs to upload dir... 03:15:36 INFO - mkdir: /builds/slave/test/build/upload/logs 03:15:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.505603 ========= master_lag: 2.21 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2017-01-21 03:15:38.356637) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-21 03:15:38.360165) ========= 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.V1qt3aPRIe/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.k0GsS8XzNV/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/883a44ac26637ed486f8b792e061f1994bdd46db716e0c6995bb7d4b4973b20d2dc94af51f5c77daa0aa0df5a766c6965ebf1e7055dfc2218b2a2fb71474ef7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3674e1c9712cc065e38c77478d2f0f126ead0a312b882cc03fb8aecd645c8b9be13bbe117400599206b1e31d9ea49ff89ce29cdb6549f30cca7e67ab94338a16", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42a7e53f31f1b2f8cc08dcaa98d6eb22430b95101d0fb6f20df251d8971a3f6c4d4507e6c9d8abde034a034a7fc26d9ea19017e3d2ac5cb4f7dce5bc7cfee6e0"} build_url:https://queue.taskcluster.net/v1/task/eSC9gBcqQ9G-gwL_gezPww/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011255 build_url: 'https://queue.taskcluster.net/v1/task/eSC9gBcqQ9G-gwL_gezPww/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/883a44ac26637ed486f8b792e061f1994bdd46db716e0c6995bb7d4b4973b20d2dc94af51f5c77daa0aa0df5a766c6965ebf1e7055dfc2218b2a2fb71474ef7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3674e1c9712cc065e38c77478d2f0f126ead0a312b882cc03fb8aecd645c8b9be13bbe117400599206b1e31d9ea49ff89ce29cdb6549f30cca7e67ab94338a16", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42a7e53f31f1b2f8cc08dcaa98d6eb22430b95101d0fb6f20df251d8971a3f6c4d4507e6c9d8abde034a034a7fc26d9ea19017e3d2ac5cb4f7dce5bc7cfee6e0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-21 03:15:38.395260) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 03:15:38.395682) ========= 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.V1qt3aPRIe/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.k0GsS8XzNV/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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.005309 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 03:15:38.444464) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-21 03:15:38.444764) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-21 03:15:38.445081) ========= ========= Total master_lag: 2.40 =========