builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0235 starttime: 1479953816.19 results: success (0) buildid: 20161123161136 builduid: 5e2a2eacfbf348b0bf9ab61e80e729d5 revision: 34fce7c12173bdd6dda54c2ebf6d344252f1ac48 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 18:16:56.190224) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 18:16:56.190682) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 18:16:56.190998) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 18:16:56.218307) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 18:16:56.218884) ========= 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.yGZJPrcoCG/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.LSEwLwymn1/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 --2016-11-23 18:16:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 41.9M=0s 2016-11-23 18:16:56 (41.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.140577 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 18:16:56.384383) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 18:16:56.384691) ========= 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.yGZJPrcoCG/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.LSEwLwymn1/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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.025100 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 18:16:56.433404) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-23 18:16:56.433826) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 34fce7c12173bdd6dda54c2ebf6d344252f1ac48 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 34fce7c12173bdd6dda54c2ebf6d344252f1ac48 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yGZJPrcoCG/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.LSEwLwymn1/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 2016-11-23 18:16:56,528 truncating revision to first 12 chars 2016-11-23 18:16:56,528 Setting DEBUG logging. 2016-11-23 18:16:56,528 attempt 1/10 2016-11-23 18:16:56,528 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/34fce7c12173?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-23 18:16:58,835 unpacking tar archive at: mozilla-central-34fce7c12173/testing/mozharness/ program finished with exit code 0 elapsedTime=2.584342 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-23 18:16:59.041505) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 18:16:59.041824) ========= script_repo_revision: 34fce7c12173bdd6dda54c2ebf6d344252f1ac48 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 18:16:59.042211) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 18:16:59.042474) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 18:16:59.062232) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-11-23 18:16:59.062619) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yGZJPrcoCG/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.LSEwLwymn1/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 18:16:59 INFO - MultiFileLogger online at 20161123 18:16:59 in /builds/slave/test 18:16:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:16:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:16:59 INFO - {'append_to_log': False, 18:16:59 INFO - 'base_work_dir': '/builds/slave/test', 18:16:59 INFO - 'blob_upload_branch': 'Firefox', 18:16:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:16:59 INFO - 'branch': 'Firefox', 18:16:59 INFO - 'buildbot_json_path': 'buildprops.json', 18:16:59 INFO - 'config_files': ('talos/mac_config.py',), 18:16:59 INFO - 'default_actions': ('clobber', 18:16:59 INFO - 'read-buildbot-config', 18:16:59 INFO - 'download-and-extract', 18:16:59 INFO - 'populate-webroot', 18:16:59 INFO - 'create-virtualenv', 18:16:59 INFO - 'install', 18:16:59 INFO - 'run-tests'), 18:16:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:16:59 INFO - 'download_minidump_stackwalk': True, 18:16:59 INFO - 'download_symbols': 'ondemand', 18:16:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:16:59 INFO - 'tooltool.py': '/tools/tooltool.py', 18:16:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:16:59 INFO - '/tools/misc-python/virtualenv.py')}, 18:16:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:16:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:16:59 INFO - 'installer_path': 'installer.exe', 18:16:59 INFO - 'log_level': 'info', 18:16:59 INFO - 'log_name': 'talos', 18:16:59 INFO - 'log_to_console': True, 18:16:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:16:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:16:59 INFO - 'opt_config_files': (), 18:16:59 INFO - 'pip_index': False, 18:16:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:16:59 INFO - 'cmd': ('bash', 18:16:59 INFO - '-c', 18:16:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:16:59 INFO - 'enabled': True, 18:16:59 INFO - 'halt_on_failure': False, 18:16:59 INFO - 'name': 'check_screen_resolution'},), 18:16:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:16:59 INFO - 'cmd': ('bash', 18:16:59 INFO - '-c', 18:16:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:16:59 INFO - 'enabled': True, 18:16:59 INFO - 'halt_on_failure': False, 18:16:59 INFO - 'name': 'check_screen_resolution'},), 18:16:59 INFO - 'run_cmd_checks_enabled': True, 18:16:59 INFO - 'sps_profile': False, 18:16:59 INFO - 'sps_profile_interval': 0, 18:16:59 INFO - 'suite': 'dromaeojs', 18:16:59 INFO - 'system_bits': '32', 18:16:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:16:59 INFO - 'title': 't-yosemite-r7-0235', 18:16:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:16:59 INFO - 'use_talos_json': True, 18:16:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:16:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:16:59 INFO - 'work_dir': 'build'} 18:16:59 INFO - [mozharness: 2016-11-24 02:16:59.264414Z] Running clobber step. 18:16:59 INFO - Running pre-action listener: _resource_record_pre_action 18:16:59 INFO - Running main action method: clobber 18:16:59 INFO - rmtree: /builds/slave/test/build 18:16:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:17:01 INFO - Running post-action listener: _resource_record_post_action 18:17:01 INFO - [mozharness: 2016-11-24 02:17:01.566948Z] Finished clobber step (success) 18:17:01 INFO - [mozharness: 2016-11-24 02:17:01.567205Z] Running read-buildbot-config step. 18:17:01 INFO - Running pre-action listener: _resource_record_pre_action 18:17:01 INFO - Running main action method: read_buildbot_config 18:17:01 INFO - Using buildbot properties: 18:17:01 INFO - { 18:17:01 INFO - "project": "", 18:17:01 INFO - "product": "firefox", 18:17:01 INFO - "script_repo_revision": "production", 18:17:01 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 18:17:01 INFO - "repository": "", 18:17:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 18:17:01 INFO - "buildid": "20161123161136", 18:17:01 INFO - "pgo_build": "False", 18:17:01 INFO - "basedir": "/builds/slave/test", 18:17:01 INFO - "buildnumber": 147, 18:17:01 INFO - "slavename": "t-yosemite-r7-0235", 18:17:01 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 18:17:01 INFO - "platform": "yosemite_r7", 18:17:01 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:17:01 INFO - "branch": "mozilla-central", 18:17:01 INFO - "repo_path": "mozilla-central", 18:17:01 INFO - "revision": "34fce7c12173bdd6dda54c2ebf6d344252f1ac48", 18:17:01 INFO - "stage_platform": "macosx64", 18:17:01 INFO - "builduid": "5e2a2eacfbf348b0bf9ab61e80e729d5", 18:17:01 INFO - "slavebuilddir": "test" 18:17:01 INFO - } 18:17:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/WAgGw4aTSRm02Ai6JIZioQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 18:17:01 INFO - Running post-action listener: _resource_record_post_action 18:17:01 INFO - [mozharness: 2016-11-24 02:17:01.572768Z] Finished read-buildbot-config step (success) 18:17:01 INFO - [mozharness: 2016-11-24 02:17:01.573001Z] Running download-and-extract step. 18:17:01 INFO - Running pre-action listener: _resource_record_pre_action 18:17:01 INFO - Running main action method: download_and_extract 18:17:01 INFO - mkdir: /builds/slave/test/build/tests 18:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:01 INFO - trying https://queue.taskcluster.net/v1/task/WAgGw4aTSRm02Ai6JIZioQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 18:17:01 INFO - Downloading https://queue.taskcluster.net/v1/task/WAgGw4aTSRm02Ai6JIZioQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 18:17:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WAgGw4aTSRm02Ai6JIZioQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 18:17:02 INFO - Downloaded 1199 bytes. 18:17:02 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 18:17:02 INFO - Using the following test package requirements: 18:17:02 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 18:17:02 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:17:02 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 18:17:02 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:17:02 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 18:17:02 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:17:02 INFO - u'jsshell-mac.zip'], 18:17:02 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:17:02 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 18:17:02 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 18:17:02 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:17:02 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 18:17:02 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:17:02 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 18:17:02 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:17:02 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 18:17:02 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:17:02 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 18:17:02 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:17:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WAgGw4aTSRm02Ai6JIZioQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 18:17:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WAgGw4aTSRm02Ai6JIZioQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:17:02 INFO - Fetch https://queue.taskcluster.net/v1/task/WAgGw4aTSRm02Ai6JIZioQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 18:17:03 INFO - Http code: 200 18:17:03 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 18:17:03 INFO - x-amz-cf-id: R7_IpRPycdu9YGucSVWaJbvOpwV1YntXJ5yKzMb1esv2oDgMsKTAcg== 18:17:03 INFO - x-amz-version-id: tz2kUGIK8PmQRLRR9E8M_tSdB20pmB9A 18:17:04 INFO - Expected file size: 16267861 18:17:04 INFO - Obtained file size: 16267861 18:17:11 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:17:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WAgGw4aTSRm02Ai6JIZioQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 18:17:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WAgGw4aTSRm02Ai6JIZioQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:17:11 INFO - Fetch https://queue.taskcluster.net/v1/task/WAgGw4aTSRm02Ai6JIZioQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 18:17:12 INFO - Http code: 200 18:17:12 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 18:17:12 INFO - x-amz-cf-id: 8MyFcCYuIK3NZTPD2C2QkY5gqp4DezLcjG8o4I7TzBisje4ZBPSF4w== 18:17:12 INFO - x-amz-version-id: tz2kUGIK8PmQRLRR9E8M_tSdB20pmB9A 18:17:12 INFO - Expected file size: 16267861 18:17:12 INFO - Obtained file size: 16267861 18:17:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WAgGw4aTSRm02Ai6JIZioQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 18:17:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WAgGw4aTSRm02Ai6JIZioQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:17:18 INFO - Fetch https://queue.taskcluster.net/v1/task/WAgGw4aTSRm02Ai6JIZioQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 18:17:19 INFO - Http code: 200 18:17:19 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 18:17:19 INFO - x-amz-cf-id: 9RLbZFkCri_bCb4eJ5nfPHZZaImgGsoExDpjrW_3LwSap1Sjbijx3Q== 18:17:19 INFO - x-amz-version-id: rQTDQ.jCiCdskjLKh8s0.qtlGbdaejYj 18:17:20 INFO - Expected file size: 14409749 18:17:20 INFO - Obtained file size: 14409749 18:17:20 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')]} 18:17:20 INFO - trying https://queue.taskcluster.net/v1/task/WAgGw4aTSRm02Ai6JIZioQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 18:17:20 INFO - Downloading https://queue.taskcluster.net/v1/task/WAgGw4aTSRm02Ai6JIZioQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 18:17:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WAgGw4aTSRm02Ai6JIZioQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 18:17:24 INFO - Downloaded 107543562 bytes. 18:17:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WAgGw4aTSRm02Ai6JIZioQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 18:17:24 INFO - mkdir: /builds/slave/test/properties 18:17:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:17:24 INFO - Writing to file /builds/slave/test/properties/build_url 18:17:24 INFO - Contents: 18:17:24 INFO - build_url:https://queue.taskcluster.net/v1/task/WAgGw4aTSRm02Ai6JIZioQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 18:17:25 INFO - Running post-action listener: _resource_record_post_action 18:17:25 INFO - Running post-action listener: set_extra_try_arguments 18:17:25 INFO - [mozharness: 2016-11-24 02:17:25.743676Z] Finished download-and-extract step (success) 18:17:25 INFO - [mozharness: 2016-11-24 02:17:25.743793Z] Running populate-webroot step. 18:17:25 INFO - Running pre-action listener: _resource_record_pre_action 18:17:25 INFO - Running main action method: populate_webroot 18:17:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:17:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:17:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:17:25 INFO - '--tppagecycles', 18:17:25 INFO - '7'], 18:17:25 INFO - 'tests': ['tsvgm']}}, 18:17:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:17:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:17:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:17:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:17:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:17:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:17:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:17:25 INFO - 'talos_options': ['--disable-e10s'], 18:17:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:17:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:17:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:17:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:17:25 INFO - 'talos_options': ['--disable-e10s'], 18:17:25 INFO - 'tests': ['damp', 'tps']}, 18:17:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:17:25 INFO - 'tests': ['damp', 'tps']}, 18:17:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:17:25 INFO - 'tests': ['dromaeo_dom']}, 18:17:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:17:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:17:25 INFO - 'tests': ['basic_compositor_video']}, 18:17:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:17:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:17:25 INFO - 'tests': ['a11yr', 18:17:25 INFO - 'ts_paint', 18:17:25 INFO - 'tpaint', 18:17:25 INFO - 'sessionrestore', 18:17:25 INFO - 'sessionrestore_no_auto_restore', 18:17:25 INFO - 'tabpaint']}, 18:17:25 INFO - 'other-e10s': {'tests': ['a11yr', 18:17:25 INFO - 'ts_paint', 18:17:25 INFO - 'tpaint', 18:17:25 INFO - 'sessionrestore', 18:17:25 INFO - 'sessionrestore_no_auto_restore', 18:17:25 INFO - 'tabpaint']}, 18:17:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:17:25 INFO - 'ts_paint', 18:17:25 INFO - 'tpaint', 18:17:25 INFO - 'sessionrestore', 18:17:25 INFO - 'sessionrestore_no_auto_restore', 18:17:25 INFO - 'tabpaint']}, 18:17:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:17:25 INFO - 'ts_paint', 18:17:25 INFO - 'tpaint', 18:17:25 INFO - 'sessionrestore', 18:17:25 INFO - 'sessionrestore_no_auto_restore', 18:17:25 INFO - 'tabpaint']}, 18:17:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:17:25 INFO - 'tests': ['a11yr', 18:17:25 INFO - 'ts_paint', 18:17:25 INFO - 'tpaint', 18:17:25 INFO - 'sessionrestore', 18:17:25 INFO - 'sessionrestore_no_auto_restore', 18:17:25 INFO - 'tabpaint']}, 18:17:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:17:25 INFO - 'tests': ['a11yr', 18:17:25 INFO - 'ts_paint', 18:17:25 INFO - 'tpaint', 18:17:25 INFO - 'sessionrestore', 18:17:25 INFO - 'sessionrestore_no_auto_restore', 18:17:25 INFO - 'tabpaint']}, 18:17:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:17:25 INFO - 'tests': ['tsvgx', 18:17:25 INFO - 'tsvgr_opacity', 18:17:25 INFO - 'tart', 18:17:25 INFO - 'tscrollx', 18:17:25 INFO - 'cart', 18:17:25 INFO - 'tsvg_static']}, 18:17:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:17:25 INFO - 'tsvgr_opacity', 18:17:25 INFO - 'tart', 18:17:25 INFO - 'tscrollx', 18:17:25 INFO - 'cart', 18:17:25 INFO - 'tsvg_static']}, 18:17:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:17:25 INFO - 'talos_options': ['--disable-e10s'], 18:17:25 INFO - 'tests': ['tp5o']}, 18:17:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:17:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:17:25 INFO - 'talos_options': ['--disable-e10s', 18:17:25 INFO - '--xperf_path', 18:17:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:17:25 INFO - 'tests': ['tp5n']}, 18:17:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:17:25 INFO - 'talos_options': ['--xperf_path', 18:17:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:17:25 INFO - 'tests': ['tp5n']}}, 18:17:25 INFO - 'talos.zip': {'path': '', 18:17:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:17:25 INFO - Running post-action listener: _resource_record_post_action 18:17:25 INFO - [mozharness: 2016-11-24 02:17:25.762074Z] Finished populate-webroot step (success) 18:17:25 INFO - [mozharness: 2016-11-24 02:17:25.762208Z] Running create-virtualenv step. 18:17:25 INFO - Running pre-action listener: _resource_record_pre_action 18:17:25 INFO - Running main action method: create_virtualenv 18:17:25 INFO - Creating virtualenv /builds/slave/test/build/venv 18:17:25 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 18:17:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:17:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:17:25 INFO - Using real prefix '/tools/python27' 18:17:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:17:26 INFO - Installing distribute.............................................................................................................................................................................................done. 18:17:29 INFO - Installing pip.................done. 18:17:29 INFO - Return code: 0 18:17:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:17:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:17:29 INFO - Reading from file tmpfile_stdout 18:17:29 INFO - Output received: 18:17:29 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) 18:17:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:17:29 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')]} 18:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:29 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')]} 18:17:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:29 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 0x101e073f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d7d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeb9d7eaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c1dd30>, '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 0x101a84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c15b20>, '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.yGZJPrcoCG/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.LSEwLwymn1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 18:17:29 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 18:17:29 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 18:17:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yGZJPrcoCG/Render', 18:17:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:17:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:17:29 INFO - 'HOME': '/Users/cltbld', 18:17:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:17:29 INFO - 'LOGNAME': 'cltbld', 18:17:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:29 INFO - 'MOZ_NO_REMOTE': '1', 18:17:29 INFO - 'NO_EM_RESTART': '1', 18:17:29 INFO - 'PAGER': '/bin/cat', 18:17:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:17:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:29 INFO - 'PWD': '/builds/slave/test', 18:17:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:17:29 INFO - 'SHELL': '/bin/bash', 18:17:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LSEwLwymn1/Listeners', 18:17:29 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 18:17:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:17:29 INFO - 'USER': 'cltbld', 18:17:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:17:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:17:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:29 INFO - 'XPC_FLAGS': '0x0', 18:17:29 INFO - 'XPC_SERVICE_NAME': '0', 18:17:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:30 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 18:17:30 INFO - Cleaning up... 18:17:30 INFO - Return code: 0 18:17:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:30 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 0x101e073f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d7d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeb9d7eaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c1dd30>, '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 0x101a84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c15b20>, '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.yGZJPrcoCG/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.LSEwLwymn1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 18:17:30 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 18:17:30 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 18:17:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yGZJPrcoCG/Render', 18:17:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:17:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:17:30 INFO - 'HOME': '/Users/cltbld', 18:17:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:17:30 INFO - 'LOGNAME': 'cltbld', 18:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:30 INFO - 'MOZ_NO_REMOTE': '1', 18:17:30 INFO - 'NO_EM_RESTART': '1', 18:17:30 INFO - 'PAGER': '/bin/cat', 18:17:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:30 INFO - 'PWD': '/builds/slave/test', 18:17:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:17:30 INFO - 'SHELL': '/bin/bash', 18:17:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LSEwLwymn1/Listeners', 18:17:30 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 18:17:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:17:30 INFO - 'USER': 'cltbld', 18:17:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:17:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:30 INFO - 'XPC_FLAGS': '0x0', 18:17:30 INFO - 'XPC_SERVICE_NAME': '0', 18:17:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:30 INFO - Downloading/unpacking psutil>=3.1.1 18:17:30 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 18:17:30 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 18:17:30 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 18:17:30 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 18:17:30 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 18:17:30 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 18:17:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:17:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:17:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:17:33 INFO - Installing collected packages: psutil 18:17:33 INFO - Running setup.py install for psutil 18:17:33 INFO - building 'psutil._psutil_osx' extension 18:17:33 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 18:17:34 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 18:17:34 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 18:17:34 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 18:17:34 INFO - building 'psutil._psutil_posix' extension 18:17:34 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 18:17:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:17:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:17:34 INFO - ^ 18:17:34 INFO - 1 warning generated. 18:17:34 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 18:17:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:17:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:17:34 INFO - Successfully installed psutil 18:17:34 INFO - Cleaning up... 18:17:34 INFO - Return code: 0 18:17:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:34 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 0x101e073f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d7d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeb9d7eaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c1dd30>, '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 0x101a84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c15b20>, '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.yGZJPrcoCG/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.LSEwLwymn1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 18:17:34 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 18:17:34 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 18:17:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yGZJPrcoCG/Render', 18:17:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:17:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:17:34 INFO - 'HOME': '/Users/cltbld', 18:17:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:17:34 INFO - 'LOGNAME': 'cltbld', 18:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:34 INFO - 'MOZ_NO_REMOTE': '1', 18:17:34 INFO - 'NO_EM_RESTART': '1', 18:17:34 INFO - 'PAGER': '/bin/cat', 18:17:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:34 INFO - 'PWD': '/builds/slave/test', 18:17:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:17:34 INFO - 'SHELL': '/bin/bash', 18:17:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LSEwLwymn1/Listeners', 18:17:34 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 18:17:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:17:34 INFO - 'USER': 'cltbld', 18:17:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:17:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:34 INFO - 'XPC_FLAGS': '0x0', 18:17:34 INFO - 'XPC_SERVICE_NAME': '0', 18:17:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:17:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:17:35 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 18:17:35 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 18:17:35 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 18:17:35 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 18:17:35 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 18:17:35 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 18:17:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:17:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:17:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:17:37 INFO - Installing collected packages: mozsystemmonitor 18:17:37 INFO - Running setup.py install for mozsystemmonitor 18:17:37 INFO - Successfully installed mozsystemmonitor 18:17:37 INFO - Cleaning up... 18:17:37 INFO - Return code: 0 18:17:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:37 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 0x101e073f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d7d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeb9d7eaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c1dd30>, '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 0x101a84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c15b20>, '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.yGZJPrcoCG/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.LSEwLwymn1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 18:17:37 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 18:17:37 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 18:17:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yGZJPrcoCG/Render', 18:17:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:17:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:17:37 INFO - 'HOME': '/Users/cltbld', 18:17:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:17:37 INFO - 'LOGNAME': 'cltbld', 18:17:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:37 INFO - 'MOZ_NO_REMOTE': '1', 18:17:37 INFO - 'NO_EM_RESTART': '1', 18:17:37 INFO - 'PAGER': '/bin/cat', 18:17:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:17:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:37 INFO - 'PWD': '/builds/slave/test', 18:17:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:17:37 INFO - 'SHELL': '/bin/bash', 18:17:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LSEwLwymn1/Listeners', 18:17:37 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 18:17:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:17:37 INFO - 'USER': 'cltbld', 18:17:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:17:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:17:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:37 INFO - 'XPC_FLAGS': '0x0', 18:17:37 INFO - 'XPC_SERVICE_NAME': '0', 18:17:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:17:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:38 INFO - Downloading/unpacking jsonschema==2.5.1 18:17:38 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 18:17:38 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 18:17:38 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 18:17:38 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 18:17:38 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 18:17:38 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 18:17:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:17:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:17:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:41 INFO - Downloading functools32-3.2.3-2.tar.gz 18:17:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:17:41 INFO - warning: no files found matching '*.txt' 18:17:41 INFO - no previously-included directories found matching 'build' 18:17:41 INFO - no previously-included directories found matching 'dist' 18:17:41 INFO - no previously-included directories found matching '.git*' 18:17:41 INFO - Installing collected packages: jsonschema, functools32 18:17:41 INFO - Running setup.py install for functools32 18:17:41 INFO - warning: no files found matching '*.txt' 18:17:41 INFO - no previously-included directories found matching 'build' 18:17:41 INFO - no previously-included directories found matching 'dist' 18:17:41 INFO - no previously-included directories found matching '.git*' 18:17:41 INFO - Successfully installed jsonschema functools32 18:17:41 INFO - Cleaning up... 18:17:41 INFO - Return code: 0 18:17:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:41 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 0x101e073f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d7d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeb9d7eaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c1dd30>, '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 0x101a84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c15b20>, '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.yGZJPrcoCG/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.LSEwLwymn1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 18:17:41 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 18:17:41 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 18:17:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yGZJPrcoCG/Render', 18:17:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:17:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:17:41 INFO - 'HOME': '/Users/cltbld', 18:17:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:17:41 INFO - 'LOGNAME': 'cltbld', 18:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:41 INFO - 'MOZ_NO_REMOTE': '1', 18:17:41 INFO - 'NO_EM_RESTART': '1', 18:17:41 INFO - 'PAGER': '/bin/cat', 18:17:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:41 INFO - 'PWD': '/builds/slave/test', 18:17:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:17:41 INFO - 'SHELL': '/bin/bash', 18:17:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LSEwLwymn1/Listeners', 18:17:41 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 18:17:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:17:41 INFO - 'USER': 'cltbld', 18:17:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:17:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:41 INFO - 'XPC_FLAGS': '0x0', 18:17:41 INFO - 'XPC_SERVICE_NAME': '0', 18:17:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:17:41 INFO - Cleaning up... 18:17:41 INFO - Return code: 0 18:17:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:41 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 0x101e073f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d7d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeb9d7eaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c1dd30>, '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 0x101a84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c15b20>, '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.yGZJPrcoCG/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.LSEwLwymn1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 18:17:41 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 18:17:41 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 18:17:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yGZJPrcoCG/Render', 18:17:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:17:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:17:41 INFO - 'HOME': '/Users/cltbld', 18:17:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:17:41 INFO - 'LOGNAME': 'cltbld', 18:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:41 INFO - 'MOZ_NO_REMOTE': '1', 18:17:41 INFO - 'NO_EM_RESTART': '1', 18:17:41 INFO - 'PAGER': '/bin/cat', 18:17:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:41 INFO - 'PWD': '/builds/slave/test', 18:17:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:17:41 INFO - 'SHELL': '/bin/bash', 18:17:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LSEwLwymn1/Listeners', 18:17:41 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 18:17:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:17:41 INFO - 'USER': 'cltbld', 18:17:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:17:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:41 INFO - 'XPC_FLAGS': '0x0', 18:17:41 INFO - 'XPC_SERVICE_NAME': '0', 18:17:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:17:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:42 INFO - Downloading/unpacking blobuploader==1.2.4 18:17:42 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 18:17:42 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 18:17:42 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 18:17:42 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 18:17:42 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 18:17:42 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 18:17:44 INFO - Downloading blobuploader-1.2.4.tar.gz 18:17:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:17:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:17:44 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 18:17:44 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 18:17:44 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 18:17:44 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 18:17:44 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 18:17:44 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 18:17:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:17:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:17:45 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 18:17:45 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 18:17:45 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 18:17:45 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 18:17:45 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 18:17:45 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 18:17:45 INFO - Downloading docopt-0.6.1.tar.gz 18:17:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:17:46 INFO - Installing collected packages: blobuploader, requests, docopt 18:17:46 INFO - Running setup.py install for blobuploader 18:17:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:17:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:17:46 INFO - Running setup.py install for requests 18:17:46 INFO - Running setup.py install for docopt 18:17:46 INFO - Successfully installed blobuploader requests docopt 18:17:46 INFO - Cleaning up... 18:17:46 INFO - Return code: 0 18:17:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:17:46 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')]} 18:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:46 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')]} 18:17:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:46 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 0x101e073f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d7d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeb9d7eaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c1dd30>, '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 0x101a84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c15b20>, '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.yGZJPrcoCG/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.LSEwLwymn1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 18:17:46 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 18:17:46 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 18:17:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yGZJPrcoCG/Render', 18:17:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:17:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:17:46 INFO - 'HOME': '/Users/cltbld', 18:17:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:17:46 INFO - 'LOGNAME': 'cltbld', 18:17:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:46 INFO - 'MOZ_NO_REMOTE': '1', 18:17:46 INFO - 'NO_EM_RESTART': '1', 18:17:46 INFO - 'PAGER': '/bin/cat', 18:17:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:17:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:46 INFO - 'PWD': '/builds/slave/test', 18:17:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:17:46 INFO - 'SHELL': '/bin/bash', 18:17:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LSEwLwymn1/Listeners', 18:17:46 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 18:17:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:17:46 INFO - 'USER': 'cltbld', 18:17:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:17:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:17:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:46 INFO - 'XPC_FLAGS': '0x0', 18:17:46 INFO - 'XPC_SERVICE_NAME': '0', 18:17:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:17:47 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-JSRJoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:17:47 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-looogt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:17:47 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-lVR2vJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:17:47 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-MaPEAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:17:47 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-UgV46P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:17:47 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-ZzSqI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:17:47 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-UNKOsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:17:47 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-ysvTYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:17:47 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-2WNfeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:17:48 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-T_zeH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:17:48 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-tDCdHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:17:48 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-2GWzLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:17:48 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-ixuYME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:17:48 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-B09Lz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:17:48 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-6WkZK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:17:48 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-wxp0YR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:17:48 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-QyOv9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:17:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:17:48 INFO - Running setup.py install for manifestparser 18:17:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:17:49 INFO - Running setup.py install for mozcrash 18:17:49 INFO - Running setup.py install for mozdebug 18:17:49 INFO - Running setup.py install for mozdevice 18:17:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:17:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:17:49 INFO - Running setup.py install for mozfile 18:17:49 INFO - Running setup.py install for mozhttpd 18:17:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:17:49 INFO - Running setup.py install for mozinfo 18:17:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:17:49 INFO - Running setup.py install for mozInstall 18:17:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:17:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:17:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:17:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:17:50 INFO - Running setup.py install for mozleak 18:17:50 INFO - Running setup.py install for mozlog 18:17:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:17:50 INFO - Running setup.py install for moznetwork 18:17:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:17:50 INFO - Running setup.py install for mozprocess 18:17:50 INFO - Running setup.py install for mozprofile 18:17:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:17:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:17:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:17:50 INFO - Running setup.py install for mozrunner 18:17:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:17:51 INFO - Running setup.py install for mozscreenshot 18:17:51 INFO - Running setup.py install for moztest 18:17:51 INFO - Running setup.py install for mozversion 18:17:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:17:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:17:51 INFO - Cleaning up... 18:17:51 INFO - Return code: 0 18:17:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:17:51 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')]} 18:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:51 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')]} 18:17:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:52 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 0x101e073f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d7d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeb9d7eaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c1dd30>, '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 0x101a84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c15b20>, '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.yGZJPrcoCG/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.LSEwLwymn1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 18:17:52 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 18:17:52 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 18:17:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yGZJPrcoCG/Render', 18:17:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:17:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:17:52 INFO - 'HOME': '/Users/cltbld', 18:17:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:17:52 INFO - 'LOGNAME': 'cltbld', 18:17:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:52 INFO - 'MOZ_NO_REMOTE': '1', 18:17:52 INFO - 'NO_EM_RESTART': '1', 18:17:52 INFO - 'PAGER': '/bin/cat', 18:17:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:17:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:52 INFO - 'PWD': '/builds/slave/test', 18:17:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:17:52 INFO - 'SHELL': '/bin/bash', 18:17:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LSEwLwymn1/Listeners', 18:17:52 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 18:17:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:17:52 INFO - 'USER': 'cltbld', 18:17:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:17:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:52 INFO - 'XPC_FLAGS': '0x0', 18:17:52 INFO - 'XPC_SERVICE_NAME': '0', 18:17:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:17:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:17:52 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-sdpiuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:17:52 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)) 18:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:17:52 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-u3dDIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:17:52 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)) 18:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:17:52 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-lClgXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:17:52 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)) 18:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:17:52 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-1wGiYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:17:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:17:52 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-zTzrud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:17:53 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)) 18:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:17:53 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-B_Yiwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:17:53 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)) 18:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:17:53 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-UbfiCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:17:53 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)) 18:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:17:53 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-ueA1zL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:17:53 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)) 18:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:17:53 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-k3QBXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:17:53 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)) 18:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:17:53 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-835iJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:17:53 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)) 18:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:17:53 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-rAsb5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:17:53 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)) 18:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:17:53 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-lGDOEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:17:53 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)) 18:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:17:53 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-WFt4jj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:17:53 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)) 18:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:17:53 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-Dt4K_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:17:54 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)) 18:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:17:54 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-vBGpjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:17:54 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)) 18:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:17:54 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-t_wrPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 18:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:17:54 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-ts9qyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:17:54 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)) 18:17:54 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)) 18:17:54 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)) 18:17:54 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)) 18:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:17:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:17:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:58 INFO - Downloading blessings-1.6.tar.gz 18:17:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:17:58 INFO - Installing collected packages: blessings 18:17:58 INFO - Running setup.py install for blessings 18:17:58 INFO - Successfully installed blessings 18:17:58 INFO - Cleaning up... 18:17:58 INFO - Return code: 0 18:17:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:17:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:17:58 INFO - Reading from file tmpfile_stdout 18:17:58 INFO - Current package versions: 18:17:58 INFO - blessings == 1.6 18:17:58 INFO - blobuploader == 1.2.4 18:17:58 INFO - docopt == 0.6.1 18:17:58 INFO - functools32 == 3.2.3-2 18:17:58 INFO - jsonschema == 2.5.1 18:17:58 INFO - manifestparser == 1.1 18:17:58 INFO - mozInstall == 1.12 18:17:58 INFO - mozcrash == 1.0 18:17:58 INFO - mozdebug == 0.1 18:17:58 INFO - mozdevice == 0.49 18:17:58 INFO - mozfile == 1.2 18:17:58 INFO - mozhttpd == 0.7 18:17:58 INFO - mozinfo == 0.9 18:17:58 INFO - mozleak == 0.1 18:17:58 INFO - mozlog == 3.4 18:17:58 INFO - moznetwork == 0.27 18:17:58 INFO - mozprocess == 0.23 18:17:58 INFO - mozprofile == 0.28 18:17:58 INFO - mozrunner == 6.13 18:17:58 INFO - mozscreenshot == 0.1 18:17:58 INFO - mozsystemmonitor == 0.3 18:17:58 INFO - moztest == 0.7 18:17:58 INFO - mozversion == 1.4 18:17:58 INFO - psutil == 3.1.1 18:17:58 INFO - requests == 1.2.3 18:17:58 INFO - wsgiref == 0.1.2 18:17:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:17:58 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')]} 18:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:58 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')]} 18:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:58 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 0x101e073f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d7d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeb9d7eaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c1dd30>, '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 0x101a84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c15b20>, '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.yGZJPrcoCG/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.LSEwLwymn1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 18:17:58 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 18:17:58 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 18:17:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yGZJPrcoCG/Render', 18:17:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:17:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:17:58 INFO - 'HOME': '/Users/cltbld', 18:17:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:17:58 INFO - 'LOGNAME': 'cltbld', 18:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:58 INFO - 'MOZ_NO_REMOTE': '1', 18:17:58 INFO - 'NO_EM_RESTART': '1', 18:17:58 INFO - 'PAGER': '/bin/cat', 18:17:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:58 INFO - 'PWD': '/builds/slave/test', 18:17:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:17:58 INFO - 'SHELL': '/bin/bash', 18:17:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LSEwLwymn1/Listeners', 18:17:58 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 18:17:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:17:58 INFO - 'USER': 'cltbld', 18:17:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:17:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:58 INFO - 'XPC_FLAGS': '0x0', 18:17:58 INFO - 'XPC_SERVICE_NAME': '0', 18:17:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:17:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:59 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)) 18:17:59 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)) 18:17:59 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)) 18:17:59 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)) 18:17:59 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)) 18:17:59 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)) 18:17:59 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)) 18:17:59 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)) 18:17:59 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)) 18:17:59 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)) 18:17:59 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)) 18:17:59 INFO - Cleaning up... 18:17:59 INFO - Return code: 0 18:17:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:17: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')]} 18:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17: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')]} 18:17:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101e073f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d7d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeb9d7eaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c1dd30>, '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 0x101a84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c15b20>, '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.yGZJPrcoCG/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.LSEwLwymn1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 18:17: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'] in /builds/slave/test/build 18:17: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 18:17:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yGZJPrcoCG/Render', 18:17:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:17:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:17:59 INFO - 'HOME': '/Users/cltbld', 18:17:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:17:59 INFO - 'LOGNAME': 'cltbld', 18:17:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:59 INFO - 'MOZ_NO_REMOTE': '1', 18:17:59 INFO - 'NO_EM_RESTART': '1', 18:17:59 INFO - 'PAGER': '/bin/cat', 18:17:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:17:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:59 INFO - 'PWD': '/builds/slave/test', 18:17:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:17:59 INFO - 'SHELL': '/bin/bash', 18:17:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LSEwLwymn1/Listeners', 18:17:59 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 18:17:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:17:59 INFO - 'USER': 'cltbld', 18:17:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:17:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:17:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:59 INFO - 'XPC_FLAGS': '0x0', 18:17:59 INFO - 'XPC_SERVICE_NAME': '0', 18:17:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:17:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:17:59 INFO - Cleaning up... 18:17:59 INFO - Return code: 0 18:17:59 INFO - Running post-action listener: _resource_record_post_action 18:17:59 INFO - Running post-action listener: _start_resource_monitoring 18:17:59 INFO - Starting resource monitoring. 18:17:59 INFO - [mozharness: 2016-11-24 02:17:59.331521Z] Finished create-virtualenv step (success) 18:17:59 INFO - [mozharness: 2016-11-24 02:17:59.332545Z] Running install step. 18:17:59 INFO - Running pre-action listener: _resource_record_pre_action 18:17:59 INFO - Running main action method: install 18:17:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:17:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:17:59 INFO - Reading from file tmpfile_stdout 18:17:59 INFO - Detecting whether we're running mozinstall >=1.0... 18:17:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:17:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:17:59 INFO - Reading from file tmpfile_stdout 18:17:59 INFO - Output received: 18:17:59 INFO - Usage: mozinstall [options] installer 18:17:59 INFO - Options: 18:17:59 INFO - -h, --help show this help message and exit 18:17:59 INFO - -d DEST, --destination=DEST 18:17:59 INFO - Directory to install application into. [default: 18:17:59 INFO - "/builds/slave/test"] 18:17:59 INFO - --app=APP Application being installed. [default: firefox] 18:17:59 INFO - mkdir: /builds/slave/test/build/application 18:17:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:17:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:18:32 INFO - Reading from file tmpfile_stdout 18:18:32 INFO - Output received: 18:18:32 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:18:32 INFO - Running post-action listener: _resource_record_post_action 18:18:32 INFO - [mozharness: 2016-11-24 02:18:32.348789Z] Finished install step (success) 18:18:32 INFO - [mozharness: 2016-11-24 02:18:32.348930Z] Running run-tests step. 18:18:32 INFO - Running pre-action listener: _resource_record_pre_action 18:18:32 INFO - Running main action method: run_tests 18:18:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:18:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:18:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:18:32 INFO - 2016-11-23 18:18:32.363 screenresolution[1639:7415] starting screenresolution argv=screenresolution get 18:18:32 INFO - 2016-11-23 18:18:32.366 screenresolution[1639:7415] Display 0: 1600x1200x32@60 18:18:32 INFO - 2016-11-23 18:18:32.371 screenresolution[1640:7417] starting screenresolution argv=screenresolution list 18:18:32 INFO - Available Modes on Display 0 18:18:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:18:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:18:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:18:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:18:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:18:32 INFO - Intel Iris: 18:18:32 INFO - Chipset Model: Intel Iris 18:18:32 INFO - Type: GPU 18:18:32 INFO - Bus: Built-In 18:18:32 INFO - VRAM (Dynamic, Max): 1536 MB 18:18:32 INFO - Vendor: Intel (0x8086) 18:18:32 INFO - Device ID: 0x0a2e 18:18:32 INFO - Revision ID: 0x0009 18:18:32 INFO - Displays: 18:18:32 INFO - Display: 18:18:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:18:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:18:32 INFO - Display Serial Number: 1600x1200 60 18:18:32 INFO - Main Display: Yes 18:18:32 INFO - Mirror: Off 18:18:32 INFO - Online: Yes 18:18:32 INFO - Rotation: Supported 18:18:32 INFO - Return code: 0 18:18:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:18:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:18:32 INFO - Python 2.7.3 18:18:32 INFO - Return code: 0 18:18:32 INFO - grabbing minidump binary from tooltool 18:18:32 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')]} 18:18:32 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 0x101c1dd30>, '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 0x101a84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c15b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:18:32 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 18:18:32 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 18:18:32 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 18:18:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:18:32 INFO - Return code: 0 18:18:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:18:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:18:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:18:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:18:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:18:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WAgGw4aTSRm02Ai6JIZioQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0235', '--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 18:18:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WAgGw4aTSRm02Ai6JIZioQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0235 --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 18:18:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yGZJPrcoCG/Render', 18:18:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:18:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:18:32 INFO - 'HOME': '/Users/cltbld', 18:18:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:18:32 INFO - 'LOGNAME': 'cltbld', 18:18:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:18:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:32 INFO - 'MOZ_NO_REMOTE': '1', 18:18:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:18:32 INFO - 'NO_EM_RESTART': '1', 18:18:32 INFO - 'PAGER': '/bin/cat', 18:18:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:32 INFO - 'PWD': '/builds/slave/test', 18:18:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:18:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:18:32 INFO - 'SHELL': '/bin/bash', 18:18:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LSEwLwymn1/Listeners', 18:18:32 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 18:18:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:18:32 INFO - 'USER': 'cltbld', 18:18:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:18:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:32 INFO - 'XPC_FLAGS': '0x0', 18:18:32 INFO - 'XPC_SERVICE_NAME': '0', 18:18:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:18:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WAgGw4aTSRm02Ai6JIZioQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0235', '--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 18:18:32 INFO - mozversion application_buildid: 20161123161136 18:18:32 INFO - mozversion application_changeset: 34fce7c12173bdd6dda54c2ebf6d344252f1ac48 18:18:32 INFO - mozversion application_display_name: Nightly 18:18:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:18:32 INFO - mozversion application_name: Firefox 18:18:32 INFO - mozversion application_remotingname: firefox 18:18:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:18:32 INFO - mozversion application_vendor: Mozilla 18:18:32 INFO - mozversion application_version: 53.0a1 18:18:32 INFO - mozversion platform_buildid: 20161123161136 18:18:32 INFO - mozversion platform_changeset: 34fce7c12173bdd6dda54c2ebf6d344252f1ac48 18:18:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:18:32 INFO - mozversion platform_version: 53.0a1 18:18:32 INFO - using testdate: 1479953912 18:18:32 INFO - actual date: 1479953912 18:18:32 INFO - starting webserver on 'localhost:49241' 18:18:32 INFO - SUITE-START | Running 2 tests 18:18:32 INFO - TEST-START | dromaeo_css 18:18:32 INFO - operating with platform_type : mac_ 18:18:32 INFO - Initialising browser for dromaeo_css test... 18:18:32 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmptf5cUG/profile http://localhost:49241/getInfo.html) 18:18:35 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 18:18:35 INFO - PROCESS | 1650 | colorDepth:24 18:18:35 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 18:18:35 INFO - PROCESS | 1650 | __metrics 18:18:35 INFO - PROCESS | 1650 | 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" 18:18:35 INFO - PROCESS | 1650 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:18:36 INFO - TEST-INFO | 1650: exit 0 18:18:36 INFO - Browser initialized. 18:18:36 INFO - Running cycle 1/1 for dromaeo_css test... 18:18:36 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmptf5cUG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:18:48 INFO - PROCESS | 1653 | RSS: Main: 244080640 18:18:48 INFO - PROCESS | 1653 | 18:19:40 INFO - PROCESS | 1653 | 1479953980503 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:21:51 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 18:21:54 INFO - PROCESS | 1653 | RSS: Main: 420737024 18:21:54 INFO - PROCESS | 1653 | 18:24:57 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 18:24:58 INFO - PROCESS | 1653 | RSS: Main: 373547008 18:24:58 INFO - PROCESS | 1653 | 18:28:00 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 18:28:01 INFO - PROCESS | 1653 | RSS: Main: 349429760 18:28:01 INFO - PROCESS | 1653 | 18:31:03 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 18:31:04 INFO - PROCESS | 1653 | RSS: Main: 333185024 18:31:04 INFO - PROCESS | 1653 | 18:34:07 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 18:34:08 INFO - PROCESS | 1653 | RSS: Main: 328744960 18:34:08 INFO - PROCESS | 1653 | 18:37:11 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 18:37:11 INFO - PROCESS | 1653 | RSS: Main: 460906496 18:37:11 INFO - PROCESS | 1653 | 18:37:11 INFO - PROCESS | 1653 | __start_tp_report 18:37:11 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 18:37:11 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 18:37:11 INFO - PROCESS | 1653 | |i|pagename|runs| 18:37:11 INFO - PROCESS | 1653 | |0;dojo.html;3073.431415188189;3159.69982851629;3288.4245257080006;3338.981610608764;3344.866205351786;5511.22842802008;5595.272614560102;5620.803271885485;5648.9549433354805;5664.461876121767;5561.221428999943;5615.634983726065;5704.3154821421485;5713.371529131802;5729.140628905656;5072.112380333445;5086.186210206368;5124.359455068116;5155;5181.766820493068;5180.715060671661;5249.921251181217;5252.8161514347;5265.973670131663;5310.07073762092;5189.792408303663;5198.584113270948;5200.531952124327;5234.136367499358;5289;5089.949100508985;5091.872703182413;5122.743862806845;5143.074246635604;5160.071187186305;5105.463926287761;5149.588032957355;5172.120739474299;5181.04150732112;5198.558122559587;5639.041362968305;5659.066254068074;5665.206871038058;5676;5723.685197314146;5995.250593675791;6080.30076541199;6083.513318934474;6181.103739957681;6182.319944806112;5170.819021334235;6140.232470941132;6163.01391777318;6220.720067596969;6227.87544249117;5647.350554686182;5714.285714285715;5727.856803579861;5728.312602487728;5737.598368114233;6259.812205633838;6315.36846315374;6319.33646967071;6358.427741503287;6361.522885783585;5862.12068189775;5903.789723106753;5930.822075337746;5957.255343082114;5965.761369545169;6117.370705100174;6117.736059405574;6126.059675755388;6133.4264757247465;6142.051815128763;6111.622125543816;6129.755478880898;6155.84610384744;6171.691415429211;6180.536459765535;6183.258009038854;6192.225971753531;6197.163382943335;6206.255249370014;6219.378062193835;4570.154521413549;4587.472440669366;4818.95181048185;4919.262110683426;4932.062908047459;4370.519242883281;4372.693911426233;4382.956170438319;4408.9118217636105;4465.776711164429;5653.321601407775;5688.11834165705;5694.4590263924865;5704.229928959538;5717.999350113713;6228.844278892973;6235.657038862906;6246.031865060922;6262.655553944485;6269.811905642838;5575.498205161555;5631.436856314418;5645.604807663424;5685.0619647758485;5690.231818704505;5349.277847490617;5367.087595108841;5375.569954403638;5417.052015897202;5460.235567020621;6289.433950944345;6294.3076261612105;6302.464290535356;6308.526860485574;6316.6841657916;6112.358202388685;6198.504119670506;6205;6257.624542527463;6265.279492858197;6229.96885015572;6234.1583886174785;6255.78104766331;6281.183446152154;6322.873542529215;6112.786052488142;6151.907721384094;6156.846078848064;6162.137300777805;6179.474744646755;6113.083037544404;6204.5036397089025;6241.282252540835;6255.593386429868;6259.874802504016;5870.324912635102;5987.910181347371;5987.910181347371;5994.490468310242;6044.848878778066;5979.162917191509;6004.369541198286;6008.669523176267;6011.398860113954;6067.878642427215;5459.2629994950175;5486.780528778804;5786.161006653927;5848.619839710405;5861.974154523026;4649.256119020941;5911.911321330097;6032.8793424132145;6059.272887253558;6076.8784624308155;5868.618539794899;5878.882422351615;5883.529317654663;5885.234919460443;5935.7032148391545 18:37:11 INFO - PROCESS | 1653 | |1;ext.html;450.42570722329026;464.44034937899835;496.6027178257393;519.2652396858446;526.8472143078505;30842.691573084263;31249.84375078124;32372.248358889465;32509;32545.83727081367;41714.58285417145;42181.578184218146;42467.78766106165;44336.55663443365;44364.55635443645;9222.953885230598;9371.20344770692;9385.483798391086;9389.014153513885;9401.153896149344;8375.62309696062;9278.953605231998;9389.201917836992;9397.295202859812;9397.342186046979;8504.107068757785;11069.50187241576;11346.546138154505;11387.54449822006;11512.194146409754;11233.550657973672;11313.547458101748;11315.151363647718;11324.547018119265;11331.660050198507;8350.248477637042;8586.05553389133;11060.668179954615;11199;11205.943970280177;38487.8075609623;39440.211195775926;39591.60408395937;41012.79493602543;41074.794626026975;3313.867445302185;3341.2649217172184;3348.648391918862;3361.0757041813454;3441.48377743338;29472.410551788846;30770.69229307723;30836.691633083832;30870.845645771627;30886.536701949488;3168.065420700899;3184.060702092865;3221.114193596756;3222.5649537312397;3322.401967645823;271860;336951;339276;339446;340778.2961085228;57758;58184.709076454346;58218.7089064552;58257;58362.41637583655;61052;61230.77538449206;61244;61313;61332.69333653303;15418.691626167414;15696.843031569539;15729.056256624639;15729.056256624639;15766.9211653941;12139.271643701406;12184;12199.085068619888;12215.69460763488;12218.572349967708;14389.920755943345;14817.703645927237;14856.925715371353;14868.70262594742;16362.754558681629;5925.644461332334;6120.755169793248;6138.907916381258;6165.660888651168;6198;856.8286342731478;937.044214900811;982.2240430060315;987.8320685483485;1008.2639673038723;27961.708615561743;29013.85493072521;29671.703282967326;29705.702942970292;29815;1027;1069.4118234970736;1119.339589642115;1146.7018575170516;1155.1188008292131;14649.926750366392;15016.699666006838;15146.621334466507;15287.541373758804;15333.463328783439;549807;553381.466185341;553864;556692;557980;48922;50154.49845501498;55190;56086.71956640191;56327.155092673645;1321.7819059855208;1345.643404497809;1365.7541642504445;1367.3095086981011;1371.2184055088503;29588.112356629335;29680.55479167771;29967.13713503727;30052.3989520204;30276.556123459795;49825.750871245415;50483.74758126186;50589.24116138335;50643.733906652626;50696.98606027785;474613;528056;575690.0663443655;592599;724648;24676.876615617526;25056.997720090993;25075.996960121392;25251.74748252494;25366;44310.178220978174;44494.777526112164;44540;44572;45045.09909801851;27070.72929270682;36325.09187270339;36697.899063028155;36816;37663;36769.816150919076;36918.00988073214;37016.444753328185;37632;38113.428298576095;36435;36681.08297292589;36961.81519092387;38169.80915095407;38208.80895595504;32429.51355729713;33909.830450847585;33938;34238.657613423544;34415.311693765485;23434.882825585762;24327.148549800673;24941.87529062343;25203.74796252014;25225.74774252234 18:37:11 INFO - PROCESS | 1653 | |2;jquery.html;347.35392170562733;363.49837224630005;372.10879942537605;372.83408883047036;397.7514053716427;12102.821492131412;14880.925595372022;17898.373556925526;18970.620587588273;19662.90168549159;19291.807081929175;19705.408837734856;20249.49376265594;20285.898570507165;20300;5119.590432765389;5614.045612245907;5619.353774315945;5720.914186287188;5721.599488035839;4025.1748391579804;4295.806688699;5597.776088956437;5715.0855863061915;5734.025215713318;6284.214473190851;6331.810045698637;6347.61914285142;6364.395382438661;6365.872682546346;5279.313689220415;6093.329733729264;6196.752129914798;6313.2424109107205;6331.651759153245;5395.190721391823;5401.540869026137;5427.565794736412;5457.126859702468;5465.043617366945;22512.43718907024;24647.137350192836;24758.25725228246;24763.87618061916;24943.376415589573;2297.287840769367;2384.0106355862295;2396.9640455393182;2430.0887167312258;2977.2259212604663;14598.854011459856;14931.477398291116;14989.925050374788;15608.453704120302;15612.76580851288;1778.4664600619762;1822.4168266154836;1827.4426299978502;1863.8881667100018;1901.268011815461;113912;116736;116755.99999999916;116803;117101.414492927;8158.4289099762445;8837.55812209387;10435;10832.837507437394;11019.504122314514;11908.642740717793;12413.627591172279;12624.495020199089;12637.43131559082;13215.60353189406;7057.36483716468;7114.537555058904;8189.058258300252;8369.916300837036;8552.059273479912;7264.113699170918;7450.701971921171;7571.659275332623;8349.121447674224;8497.447665901696;5225.425203227642;5523.696196709219;6459;6574.901376479356;6651.035599837996;1743.6338368942663;1784.7501349811037;1790.6597746428138;1792.7490151378818;1794.237449084134;889.4929889962659;889.8709687095464;937.2127412973135;944.7685317097217;1035.1304903880625;20084.89957550232;21785.23751668684;21800.672989905164;21882.12471501154;22341.664875026563;940.1585580905052;946.9234943568006;948.4830767231875;983.7934033852828;1012.3773879064322;11042.558297668164;11517.654470365902;11575.479103440366;11765.529378824922;11767;512949;519643;521886;523899;525876;82690.17309826946;91374;106529;109481;114612.42693786477;956.818204541135;995.6216637677636;1035.3529044347283;1064.3401091323274;1064.984025239622;18832.435026949213;19077.523061923563;19136.521586960436;19283.22867085301;19327;47368.97311282944;47476.7626161867;47914;48485;48826;55183.72408137934;68266;69828.60342793218;70528;71139.22151946243;5406.21609866575;5564.749586268708;6324.810255692337;6954.130733658293;7305.159906610807;12972.74770416905;13046.152000119962;13371;13563;13598.524051658145;11245.91950489162;11375.772484550429;11568.95879370827;11675.241109327866;11735.647930562096;11236.044936180517;11270.436478175894;11329.490172942073;11491.54033838637;11551.76896462083;11425.771484570429;11500.25248358854;11669.416529173677;11793.646190613952;11812.40937953116;7925.881111783443;7979.800504987422;8003.919960800317;8025.799355016171;8124.22819832115;11259.549618015515;11356.205065645656;11516.481758321062;11625.360605166798;11671.88328116708 18:37:11 INFO - PROCESS | 1653 | |3;mootools.html;1326.6351753267845;1466.47207005478;1503.6015455904187;1652.6033751899547;1831.5146486181172;7363.521371110881;7740.767776966693;7898.684052637895;8213.7125200618;8222.177782221775;8121.796955076126;8183.6726530938695;8197.1802819718;8197.672093116269;8210.589470526465;1984.642764302425;2272.8409011369167;2306.411864974429;2310.4570425949887;2310.792028717415;2066.865653732503;2241.60771864923;2331.277304035746;2338.96491552626;2344.979933728825;2257.8758168300737;2269.1830940861278;2280.407094155515;2281.6805647209403;2282.315305408379;2276.4877902471976;2288.347820871044;2290.541891621682;2291.5187810559637;2292.3123063081175;2021.0602070037503;2269.6822444857735;2274.3972847195505;2309.515001849614;2314.5486630107134;8028.839423211503;8214.794630134234;8236.629351679188;8237.546934918577;8250;5002.1496345621335;5031.723255220962;5178.974105129488;5182.818601348935;5182.974085129588;3267.8856240031487;3457.6715212054814;3540.2211513466996;3542.964570354289;3547.9645203547893;930.7673081729567;995.8157740817971;1050.2648146297622;1086.6902932664232;1090.738222826516;10588.311759735592;10613.310134841287;10616.309939853885;10620.15038796902;10633;3870.748401353903;4342.934855977162;4613.538646135359;4680.555347242007;4682.742449165328;8145.877811832827;8965.327600429993;9196;9216.124468175512;9259.259259259243;5055.266986286968;5153.845384638467;5163.251328557413;5168.224766285088;5176.430592634807;4257.127288905767;4416.293393057095;4444.488883778342;4612.7001744886475;4731.361266229083;3521.8239088045493;3665.083729067733;3687.2441149564274;3794.6964242860504;3800.0879788850475;1048.3343077145914;1241.1126044877956;1247.3513772838073;1252.4051075739133;1257.6792917805901;823.4277177361796;853.7822855172016;861.3195575495414;901.6663834381321;931.2363861633531;5517.972410137923;5586.385497595261;5593.636413633101;5778.133280007948;5878.441548053013;916.6562539047857;927.3693888155984;927.8051609162017;941.1717688434271;971.1502435369052;3688.5389326334207;3692.667659910621;3698.4267438547067;3796.487474191004;3849.268638958589;9520.952395237979;9922.00779922002;10010.199184065257;10027.348222365523;10029.69910902674;9321.207697345666;9788.314817962817;9920.702378928643;9960.252981026451;9960.402375857471;7487.737929172453;7703.961480192564;7707.152213256537;7714.729984450517;7726.575038372944;5406.675599463887;5417.160340147283;5443.099177055345;5724.255846739898;5752.741126649227;9015.053419391132;9107.362484626012;9159;9352.719418417459;9360.297977651568;9295.67465138717;9363.29775266844;9376.156145946898;9407.294452915921;9523.285753568649;6523.380278873499;6960.721571137098;6985.1967023790885;7023;7160.10498687664;7352.926470735438;7427.44294177928;7534.736284230025;7815.491993020435;7847.058352997677;6888.896666550106;6959.373656370951;7048.541844780073;7080.468964827555;7128.85742285141;6859.622720750406;6893.586384816927;6905.792826215222;6943.722251110101;6943.930560694531;6557.311482294291;6565.671716414065;6568.6058836469965;6568.967155164193;6647.966760166169;3995.4606128172327;4704.623630109514;4757.119932812441;4771.093492236464;4879.146149423907;4191.266528357464;4606.585407313224;4649.349091127177;4665.2535594304745;4750.477447480705 18:37:11 INFO - PROCESS | 1653 | |4;prototype.html;300.90371081253994;306.1061699836477;307.96612372639004;315.1679565945902;316.11960689479804;4133.586641335869;5207.791688332467;5299.099153143965;5348.304720386354;5362.973185134078;5003.774830132644;5130.333056702623;5156.767945442455;5200.531952124308;5224.399194092681;3823.254465379252;3961.5444223914187;3962.445257663929;3978.4032395140816;3979.5224573051273;3433.296174284278;3458.4985177149297;3758.981205093971;3952.644262016418;4017.879463616096;3734.5145131132913;3984.6214609612184;4005.5794141615147;4030.355143177092;4078.8368465261356;3517.859285628572;3709.1839795245005;3921.372580387153;3937.7834219117935;3992.08182118113;3452.8446219920165;3458.792472451661;3465.705415039725;3469.410200265961;3471.9652803471895;5089.923651145199;5103.2855400244;5103.897922041539;5106.514881086291;5111.795528178868;4193.580641935812;4491.865244042684;4501.7524036178;4518;4521.660875434355;5146.871328216787;5433.320834895638;5470.8085217017615;5471.37079235889;5503.284573005523;2992;3210.133264018725;3714.8699795507296;3731.0112820102695;3742.0644838790304;4809.326694262841;5694.829155125353;5742.28221472316;5807.651540907559;5811.970940145315;3369.4945758136478;3599.642234336514;3762.3039737648623;3807.2385522895534;3858.884233473;3842.51968503937;3856.3251431000026;3873.4189871519498;3878.5539662939123;3917.1578110706337;3562.786232826039;3843.8270277837005;4491.865244042684;4507.797149128297;4558.680892337571;4990.326305948651;5173.689578625294;5516.668999860021;5550.223928342973;5568.777248909998;1171.262104873941;1240.2620440837686;1243.5585367194697;1247.6007677543098;1248.545444557099;769.9307062364414;781.3397678961269;782.6321628834439;843.4896887383168;847.8601030829967;4934.55588996992;5105.540501354896;5136;5144.6655967362;5274.7626356814035;5660.858478537987;5666.518345940559;5671.120976248688;5696.8860622787315;5700.434804338064;4434.933475997863;4498.17823781369;4623.514530974267;4930.753462326869;5191.143461328914;2409.686700767283;2760.8619569021466;2785.8189217700783;2826.5618829081527;2845.900393486218;5105.897882042338;5427.29445172133;5533.446655334515;5584.441555844383;5610.793679358876;4911.901761964812;5001.399832020181;5198.974005130026;5459.1265397537;5532.834014979557;5508.669479831223;5534.422689533463;5538.972305138529;5546.722663866871;5556.527695145958;4615.284630882219;5023.844515761322;5332;5332.187056400842;5359.383670877899;4175.916481670411;4850.708957462422;5093.134167191661;5346.599005074557;5353.785848566014;4919.163052818807;4951.8266860659705;5486.369067557282;5563.471470210324;5628.002059269064;3199.648038715786;3442.9671098669796;3517.824108794499;3574.57105147384;3589.533360663097;4704.858854234379;4772.4228916386155;5084.339035925306;5313.787448502171;5380.919286210788;4647.442306923191;4703.3885594872445;4731.716097034189;5089.312942752681;5282.76227569768;4969.378827646544;5104.41299250591;5157.535821776059;5170.870728231825;5194.714290714047;4545.977270113628;4727.787249573847;4764.332993380999;4857.465678775403;5080;5210.056318180216;5234.9067014196735;5385.515303622536;5388.622796404214;5391.649542779707;5354.135537487426;5370.167624018283;5377.300950876517;5381.408045115112;5387.191921211849 18:37:11 INFO - PROCESS | 1653 | |5;yui.html;641.9903701444479;734.8052766017003;766.8734658781301;781.468601351081;795.4670370851529;13622.11456255344;14862.33119509622;15149.166795826226;15195.696086078271;15283.617909552268;13146;13254.668633284173;13406.530771423002;13534.729305413886;13758.793618095737;704.9823754406156;824.5135370131636;838.7944953486405;840.6511297811401;842.5997651115702;659.5317324699469;679.4971720926503;804.4610111225463;829.4940086547201;834.8121672623641;884.9513276769775;887.2857349833414;888.3159966825541;889.2174886100223;892.4020905993;880.6785523284019;881.2949640287744;881.9779505512349;883.4169448164181;883.7481317824454;505.2648396582963;521.5384384819462;630.3507387390995;656.8456412743002;657.4346062386344;13667.248301343423;14118.858811411857;14164.504242351572;14178.220197889112;14183.574492765234;12783.808242876365;12884.87115128846;13294.667633309147;13306.268155251457;13409.128406653535;10482.842757358645;12065.396730163544;12083.366557690788;12138.514459421613;12599.93700031503;3816.580176180618;4238.682098842568;4287.249731297042;4304.156391337757;4368.978155109204;91049;92126.15747685009;92744;93472;93485;10259.692209233735;10270.537825797857;10271.794564108675;10344;10681.626143084955;19562;19851.702224466644;19889.701654475193;20077.096530656156;20120.39638810838;7448.85102297951;7512.962435187789;7596.81007974805;7679.808004799813;7696.884546731803;4124.587541245852;4211.873643790691;4242.766647834399;4256.851010214627;4274.786260686953;3212.5181222816295;3247.236899328656;3281.4913688378338;3282.343531293751;3286.6220384655594;623.5043140703152;625.9311475737666;637.3339859846471;638.0524920493064;641.8619996700638;556.5519756595979;589.345826132992;611.3615510431996;613.6624856329001;628.335855970681;8288.792780180424;8311.875321870177;8532.866783304175;8552.529610871337;8611.6985905493;553.6733327336891;604.7218279591438;613.1507861611611;613.1936503497886;626.9435750782452;4035.5157381114454;4194.266003449445;4199.748015119103;4246.185106976346;4280.957190428118;72698.54602907912;73337;87611;105039.84083660801;107027.46486267519;65387;68599;75036;79344.01639959047;94772.52613737025;67476;82540.17459825324;85745.57127214324;86060.6848417879;86736.566317168;7231.457640676865;7870.606469676379;7988.680452781824;8206.466579672302;8402;54003.46932348154;54299;54806;55073.44926550683;56195;71166.28833711804;72977;74968.25031749831;75885.75542301718;76750.23249767431;10556.577736890438;10597.523111459848;10743.623973160902;10815.35107893529;10951.726206844574;9695.757606059906;11850.288982661068;11885.881141188478;11902.702432439259;12220.602041427688;10980.560777569128;11069.501872415922;11235.494402751732;11240.381779002233;11371.260868043551;8829.514376709085;11193.216474846682;12654.936725316315;12971.156874803108;13197.076204665582;12656.74686506283;12749.490020399451;12782.68043298925;12829.61511154667;12932.159409638343;10099.747506312107;10617.946910265398;10847.186461015297;11239.943800281273;11348.375839328915;6630;8820.5589720515;8907.73276801697;8927.375083744335;9071.637134514809 18:37:11 INFO - PROCESS | 1653 | __end_tp_report 18:37:11 INFO - PROCESS | 1653 | __start_cc_report 18:37:11 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,2416 18:37:11 INFO - PROCESS | 1653 | __end_cc_report 18:37:11 INFO - PROCESS | 1653 | __startTimestamp1479955031724__endTimestamp 18:37:11 INFO - PROCESS | 1653 | 18:37:11 INFO - PROCESS | 1653 | ------- Summary: start ------- 18:37:11 INFO - PROCESS | 1653 | Number of tests: 6 18:37:11 INFO - PROCESS | 1653 | 18:37:11 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5672.59 Median:5862.12 stddev:650.98 (11.1%) stddev-sans-first:620.22 18:37:11 INFO - PROCESS | 1653 | Values: 3073.4 3159.7 3288.4 3339.0 3344.9 5511.2 5595.3 5620.8 5649.0 5664.5 5561.2 5615.6 5704.3 5713.4 5729.1 5072.1 5086.2 5124.4 5155.0 5181.8 5180.7 5249.9 5252.8 5266.0 5310.1 5189.8 5198.6 5200.5 5234.1 5289.0 5089.9 5091.9 5122.7 5143.1 5160.1 5105.5 5149.6 5172.1 5181.0 5198.6 5639.0 5659.1 5665.2 5676.0 5723.7 5995.3 6080.3 6083.5 6181.1 6182.3 5170.8 6140.2 6163.0 6220.7 6227.9 5647.4 5714.3 5727.9 5728.3 5737.6 6259.8 6315.4 6319.3 6358.4 6361.5 5862.1 5903.8 5930.8 5957.3 5965.8 6117.4 6117.7 6126.1 6133.4 6142.1 6111.6 6129.8 6155.8 6171.7 6180.5 6183.3 6192.2 6197.2 6206.3 6219.4 4570.2 4587.5 4819.0 4919.3 4932.1 4370.5 4372.7 4383.0 4408.9 4465.8 5653.3 5688.1 5694.5 5704.2 5718.0 6228.8 6235.7 6246.0 6262.7 6269.8 5575.5 5631.4 5645.6 5685.1 5690.2 5349.3 5367.1 5375.6 5417.1 5460.2 6289.4 6294.3 6302.5 6308.5 6316.7 6112.4 6198.5 6205.0 6257.6 6265.3 6230.0 6234.2 6255.8 6281.2 6322.9 6112.8 6151.9 6156.8 6162.1 6179.5 6113.1 6204.5 6241.3 6255.6 6259.9 5870.3 5987.9 5987.9 5994.5 6044.8 5979.2 6004.4 6008.7 6011.4 6067.9 5459.3 5486.8 5786.2 5848.6 5862.0 4649.3 5911.9 6032.9 6059.3 6076.9 5868.6 5878.9 5883.5 5885.2 5935.7 18:37:11 INFO - PROCESS | 1653 | 18:37:11 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:62492.10 Median:187508.48 stddev:134263.55 (71.6%) stddev-sans-first:134559.39 18:37:11 INFO - PROCESS | 1653 | Values: 450.4 464.4 496.6 519.3 526.8 30842.7 31249.8 32372.2 32509.0 32545.8 41714.6 42181.6 42467.8 44336.6 44364.6 9223.0 9371.2 9385.5 9389.0 9401.2 8375.6 9279.0 9389.2 9397.3 9397.3 8504.1 11069.5 11346.5 11387.5 11512.2 11233.6 11313.5 11315.2 11324.5 11331.7 8350.2 8586.1 11060.7 11199.0 11205.9 38487.8 39440.2 39591.6 41012.8 41074.8 3313.9 3341.3 3348.6 3361.1 3441.5 29472.4 30770.7 30836.7 30870.8 30886.5 3168.1 3184.1 3221.1 3222.6 3322.4 271860.0 336951.0 339276.0 339446.0 340778.3 57758.0 58184.7 58218.7 58257.0 58362.4 61052.0 61230.8 61244.0 61313.0 61332.7 15418.7 15696.8 15729.1 15729.1 15766.9 12139.3 12184.0 12199.1 12215.7 12218.6 14389.9 14817.7 14856.9 14868.7 16362.8 5925.6 6120.8 6138.9 6165.7 6198.0 856.8 937.0 982.2 987.8 1008.3 27961.7 29013.9 29671.7 29705.7 29815.0 1027.0 1069.4 1119.3 1146.7 1155.1 14649.9 15016.7 15146.6 15287.5 15333.5 549807.0 553381.5 553864.0 556692.0 557980.0 48922.0 50154.5 55190.0 56086.7 56327.2 1321.8 1345.6 1365.8 1367.3 1371.2 29588.1 29680.6 29967.1 30052.4 30276.6 49825.8 50483.7 50589.2 50643.7 50697.0 474613.0 528056.0 575690.1 592599.0 724648.0 24676.9 25057.0 25076.0 25251.7 25366.0 44310.2 44494.8 44540.0 44572.0 45045.1 27070.7 36325.1 36697.9 36816.0 37663.0 36769.8 36918.0 37016.4 37632.0 38113.4 36435.0 36681.1 36961.8 38169.8 38208.8 32429.5 33909.8 33938.0 34238.7 34415.3 23434.9 24327.1 24941.9 25203.7 25225.7 18:37:11 INFO - PROCESS | 1653 | 18:37:11 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:31587.29 Median:13538.61 stddev:86835.48 (641.4%) stddev-sans-first:87047.39 18:37:11 INFO - PROCESS | 1653 | Values: 347.4 363.5 372.1 372.8 397.8 12102.8 14880.9 17898.4 18970.6 19662.9 19291.8 19705.4 20249.5 20285.9 20300.0 5119.6 5614.0 5619.4 5720.9 5721.6 4025.2 4295.8 5597.8 5715.1 5734.0 6284.2 6331.8 6347.6 6364.4 6365.9 5279.3 6093.3 6196.8 6313.2 6331.7 5395.2 5401.5 5427.6 5457.1 5465.0 22512.4 24647.1 24758.3 24763.9 24943.4 2297.3 2384.0 2397.0 2430.1 2977.2 14598.9 14931.5 14989.9 15608.5 15612.8 1778.5 1822.4 1827.4 1863.9 1901.3 113912.0 116736.0 116756.0 116803.0 117101.4 8158.4 8837.6 10435.0 10832.8 11019.5 11908.6 12413.6 12624.5 12637.4 13215.6 7057.4 7114.5 8189.1 8369.9 8552.1 7264.1 7450.7 7571.7 8349.1 8497.4 5225.4 5523.7 6459.0 6574.9 6651.0 1743.6 1784.8 1790.7 1792.7 1794.2 889.5 889.9 937.2 944.8 1035.1 20084.9 21785.2 21800.7 21882.1 22341.7 940.2 946.9 948.5 983.8 1012.4 11042.6 11517.7 11575.5 11765.5 11767.0 512949.0 519643.0 521886.0 523899.0 525876.0 82690.2 91374.0 106529.0 109481.0 114612.4 956.8 995.6 1035.4 1064.3 1065.0 18832.4 19077.5 19136.5 19283.2 19327.0 47369.0 47476.8 47914.0 48485.0 48826.0 55183.7 68266.0 69828.6 70528.0 71139.2 5406.2 5564.7 6324.8 6954.1 7305.2 12972.7 13046.2 13371.0 13563.0 13598.5 11245.9 11375.8 11569.0 11675.2 11735.6 11236.0 11270.4 11329.5 11491.5 11551.8 11425.8 11500.3 11669.4 11793.6 11812.4 7925.9 7979.8 8003.9 8025.8 8124.2 11259.5 11356.2 11516.5 11625.4 11671.9 18:37:11 INFO - PROCESS | 1653 | 18:37:11 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5340.21 Median:5294.82 stddev:2917.25 (55.1%) stddev-sans-first:2909.84 18:37:11 INFO - PROCESS | 1653 | Values: 1326.6 1466.5 1503.6 1652.6 1831.5 7363.5 7740.8 7898.7 8213.7 8222.2 8121.8 8183.7 8197.2 8197.7 8210.6 1984.6 2272.8 2306.4 2310.5 2310.8 2066.9 2241.6 2331.3 2339.0 2345.0 2257.9 2269.2 2280.4 2281.7 2282.3 2276.5 2288.3 2290.5 2291.5 2292.3 2021.1 2269.7 2274.4 2309.5 2314.5 8028.8 8214.8 8236.6 8237.5 8250.0 5002.1 5031.7 5179.0 5182.8 5183.0 3267.9 3457.7 3540.2 3543.0 3548.0 930.8 995.8 1050.3 1086.7 1090.7 10588.3 10613.3 10616.3 10620.2 10633.0 3870.7 4342.9 4613.5 4680.6 4682.7 8145.9 8965.3 9196.0 9216.1 9259.3 5055.3 5153.8 5163.3 5168.2 5176.4 4257.1 4416.3 4444.5 4612.7 4731.4 3521.8 3665.1 3687.2 3794.7 3800.1 1048.3 1241.1 1247.4 1252.4 1257.7 823.4 853.8 861.3 901.7 931.2 5518.0 5586.4 5593.6 5778.1 5878.4 916.7 927.4 927.8 941.2 971.2 3688.5 3692.7 3698.4 3796.5 3849.3 9521.0 9922.0 10010.2 10027.3 10029.7 9321.2 9788.3 9920.7 9960.3 9960.4 7487.7 7704.0 7707.2 7714.7 7726.6 5406.7 5417.2 5443.1 5724.3 5752.7 9015.1 9107.4 9159.0 9352.7 9360.3 9295.7 9363.3 9376.2 9407.3 9523.3 6523.4 6960.7 6985.2 7023.0 7160.1 7352.9 7427.4 7534.7 7815.5 7847.1 6888.9 6959.4 7048.5 7080.5 7128.9 6859.6 6893.6 6905.8 6943.7 6943.9 6557.3 6565.7 6568.6 6569.0 6648.0 3995.5 4704.6 4757.1 4771.1 4879.1 4191.3 4606.6 4649.3 4665.3 4750.5 18:37:11 INFO - PROCESS | 1653 | 18:37:11 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4346.51 Median:4943.19 stddev:1333.56 (27.0%) stddev-sans-first:1302.27 18:37:11 INFO - PROCESS | 1653 | Values: 300.9 306.1 308.0 315.2 316.1 4133.6 5207.8 5299.1 5348.3 5363.0 5003.8 5130.3 5156.8 5200.5 5224.4 3823.3 3961.5 3962.4 3978.4 3979.5 3433.3 3458.5 3759.0 3952.6 4017.9 3734.5 3984.6 4005.6 4030.4 4078.8 3517.9 3709.2 3921.4 3937.8 3992.1 3452.8 3458.8 3465.7 3469.4 3472.0 5089.9 5103.3 5103.9 5106.5 5111.8 4193.6 4491.9 4501.8 4518.0 4521.7 5146.9 5433.3 5470.8 5471.4 5503.3 2992.0 3210.1 3714.9 3731.0 3742.1 4809.3 5694.8 5742.3 5807.7 5812.0 3369.5 3599.6 3762.3 3807.2 3858.9 3842.5 3856.3 3873.4 3878.6 3917.2 3562.8 3843.8 4491.9 4507.8 4558.7 4990.3 5173.7 5516.7 5550.2 5568.8 1171.3 1240.3 1243.6 1247.6 1248.5 769.9 781.3 782.6 843.5 847.9 4934.6 5105.5 5136.0 5144.7 5274.8 5660.9 5666.5 5671.1 5696.9 5700.4 4434.9 4498.2 4623.5 4930.8 5191.1 2409.7 2760.9 2785.8 2826.6 2845.9 5105.9 5427.3 5533.4 5584.4 5610.8 4911.9 5001.4 5199.0 5459.1 5532.8 5508.7 5534.4 5539.0 5546.7 5556.5 4615.3 5023.8 5332.0 5332.2 5359.4 4175.9 4850.7 5093.1 5346.6 5353.8 4919.2 4951.8 5486.4 5563.5 5628.0 3199.6 3443.0 3517.8 3574.6 3589.5 4704.9 4772.4 5084.3 5313.8 5380.9 4647.4 4703.4 4731.7 5089.3 5282.8 4969.4 5104.4 5157.5 5170.9 5194.7 4546.0 4727.8 4764.3 4857.5 5080.0 5210.1 5234.9 5385.5 5388.6 5391.6 5354.1 5370.2 5377.3 5381.4 5387.2 18:37:11 INFO - PROCESS | 1653 | 18:37:11 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:19181.38 Median:27813.56 stddev:27608.33 (99.3%) stddev-sans-first:27650.68 18:37:11 INFO - PROCESS | 1653 | Values: 642.0 734.8 766.9 781.5 795.5 13622.1 14862.3 15149.2 15195.7 15283.6 13146.0 13254.7 13406.5 13534.7 13758.8 705.0 824.5 838.8 840.7 842.6 659.5 679.5 804.5 829.5 834.8 885.0 887.3 888.3 889.2 892.4 880.7 881.3 882.0 883.4 883.7 505.3 521.5 630.4 656.8 657.4 13667.2 14118.9 14164.5 14178.2 14183.6 12783.8 12884.9 13294.7 13306.3 13409.1 10482.8 12065.4 12083.4 12138.5 12599.9 3816.6 4238.7 4287.2 4304.2 4369.0 91049.0 92126.2 92744.0 93472.0 93485.0 10259.7 10270.5 10271.8 10344.0 10681.6 19562.0 19851.7 19889.7 20077.1 20120.4 7448.9 7513.0 7596.8 7679.8 7696.9 4124.6 4211.9 4242.8 4256.9 4274.8 3212.5 3247.2 3281.5 3282.3 3286.6 623.5 625.9 637.3 638.1 641.9 556.6 589.3 611.4 613.7 628.3 8288.8 8311.9 8532.9 8552.5 8611.7 553.7 604.7 613.2 613.2 626.9 4035.5 4194.3 4199.7 4246.2 4281.0 72698.5 73337.0 87611.0 105039.8 107027.5 65387.0 68599.0 75036.0 79344.0 94772.5 67476.0 82540.2 85745.6 86060.7 86736.6 7231.5 7870.6 7988.7 8206.5 8402.0 54003.5 54299.0 54806.0 55073.4 56195.0 71166.3 72977.0 74968.3 75885.8 76750.2 10556.6 10597.5 10743.6 10815.4 10951.7 9695.8 11850.3 11885.9 11902.7 12220.6 10980.6 11069.5 11235.5 11240.4 11371.3 8829.5 11193.2 12654.9 12971.2 13197.1 12656.7 12749.5 12782.7 12829.6 12932.2 10099.7 10617.9 10847.2 11239.9 11348.4 6630.0 8820.6 8907.7 8927.4 9071.6 18:37:11 INFO - PROCESS | 1653 | -------- Summary: end -------- 18:37:11 INFO - PROCESS | 1653 | 18:37:12 INFO - TEST-INFO | 1653: exit 0 18:37:12 INFO - TEST-OK | dromaeo_css | took 1119456ms 18:37:12 INFO - TEST-START | kraken 18:37:12 INFO - operating with platform_type : mac_ 18:37:12 INFO - Initialising browser for kraken test... 18:37:12 INFO - TEST-INFO | started process 1775 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmphjf3yB/profile http://localhost:49241/getInfo.html) 18:37:15 INFO - PROCESS | 1775 | __metrics Screen width/height:1600/1200 18:37:15 INFO - PROCESS | 1775 | colorDepth:24 18:37:15 INFO - PROCESS | 1775 | Browser inner width/height: 1024/689 18:37:15 INFO - PROCESS | 1775 | __metrics 18:37:15 INFO - PROCESS | 1775 | 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" 18:37:15 INFO - PROCESS | 1775 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:37:16 INFO - TEST-INFO | 1775: exit 0 18:37:16 INFO - Browser initialized. 18:37:16 INFO - Running cycle 1/1 for kraken test... 18:37:16 INFO - TEST-INFO | started process 1776 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmphjf3yB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:37:28 INFO - PROCESS | 1776 | RSS: Main: 243806208 18:37:28 INFO - PROCESS | 1776 | 18:37:30 INFO - PROCESS | 1776 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 18:37:31 INFO - PROCESS | 1776 | RSS: Main: 294019072 18:37:31 INFO - PROCESS | 1776 | 18:37:34 INFO - PROCESS | 1776 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 18:37:35 INFO - PROCESS | 1776 | RSS: Main: 294072320 18:37:35 INFO - PROCESS | 1776 | 18:37:38 INFO - PROCESS | 1776 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 18:37:39 INFO - PROCESS | 1776 | RSS: Main: 385949696 18:37:39 INFO - PROCESS | 1776 | 18:37:41 INFO - PROCESS | 1776 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 18:37:41 INFO - PROCESS | 1776 | RSS: Main: 288264192 18:37:41 INFO - PROCESS | 1776 | 18:37:43 INFO - PROCESS | 1776 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:37:44 INFO - PROCESS | 1776 | RSS: Main: 291471360 18:37:44 INFO - PROCESS | 1776 | 18:37:46 INFO - PROCESS | 1776 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 18:37:47 INFO - PROCESS | 1776 | RSS: Main: 333197312 18:37:47 INFO - PROCESS | 1776 | 18:37:50 INFO - PROCESS | 1776 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 18:37:51 INFO - PROCESS | 1776 | RSS: Main: 334966784 18:37:51 INFO - PROCESS | 1776 | 18:37:53 INFO - PROCESS | 1776 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 18:37:54 INFO - PROCESS | 1776 | RSS: Main: 331546624 18:37:54 INFO - PROCESS | 1776 | 18:37:56 INFO - PROCESS | 1776 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:37:56 INFO - PROCESS | 1776 | RSS: Main: 310476800 18:37:56 INFO - PROCESS | 1776 | 18:37:58 INFO - PROCESS | 1776 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:37:59 INFO - PROCESS | 1776 | RSS: Main: 311152640 18:37:59 INFO - PROCESS | 1776 | 18:38:01 INFO - PROCESS | 1776 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:38:02 INFO - PROCESS | 1776 | RSS: Main: 313237504 18:38:02 INFO - PROCESS | 1776 | 18:38:05 INFO - PROCESS | 1776 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:38:06 INFO - PROCESS | 1776 | RSS: Main: 332709888 18:38:06 INFO - PROCESS | 1776 | 18:38:09 INFO - PROCESS | 1776 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:38:09 INFO - PROCESS | 1776 | RSS: Main: 326033408 18:38:09 INFO - PROCESS | 1776 | 18:38:11 INFO - PROCESS | 1776 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 18:38:11 INFO - PROCESS | 1776 | RSS: Main: 369577984 18:38:11 INFO - PROCESS | 1776 | 18:38:11 INFO - PROCESS | 1776 | __start_tp_report 18:38:11 INFO - PROCESS | 1776 | _x_x_mozilla_page_load 18:38:11 INFO - PROCESS | 1776 | _x_x_mozilla_page_load_details 18:38:11 INFO - PROCESS | 1776 | |i|pagename|runs| 18:38:11 INFO - PROCESS | 1776 | |0;ai-astar;112;113;114;113;114;115;114;112;115;113 18:38:11 INFO - PROCESS | 1776 | |1;audio-beat-detection;145;112;110;149;129;142;99;128;113;123 18:38:11 INFO - PROCESS | 1776 | |2;audio-dft;181;182;187;183;185;218;181;181;181;183 18:38:11 INFO - PROCESS | 1776 | |3;audio-fft;80;58;57;89;72;60;59;58;74;57 18:38:11 INFO - PROCESS | 1776 | |4;audio-oscillator;87;70;85;71;68;70;81;67;69;82 18:38:11 INFO - PROCESS | 1776 | |5;imaging-gaussian-blur;86;83;86;83;86;83;86;83;86;83 18:38:11 INFO - PROCESS | 1776 | |6;imaging-darkroom;110;149;147;92;92;92;93;93;92;93 18:38:11 INFO - PROCESS | 1776 | |7;imaging-desaturate;86;87;85;86;85;86;84;87;88;87 18:38:11 INFO - PROCESS | 1776 | |8;json-parse-financial;57;52;54;53;55;55;54;53;55;54 18:38:11 INFO - PROCESS | 1776 | |9;json-stringify-tinderbox;71;72;69;75;74;70;71;71;72;72 18:38:11 INFO - PROCESS | 1776 | |10;stanford-crypto-aes;88;98;104;88;87;88;88;87;87;90 18:38:11 INFO - PROCESS | 1776 | |11;stanford-crypto-ccm;153;152;151;149;149;157;164;153;189;149 18:38:11 INFO - PROCESS | 1776 | |12;stanford-crypto-pbkdf2;177;175;175;174;177;179;231;206;174;179 18:38:11 INFO - PROCESS | 1776 | |13;stanford-crypto-sha256-iterative;67;69;68;70;68;67;68;66;67;67 18:38:11 INFO - PROCESS | 1776 | __end_tp_report 18:38:11 INFO - PROCESS | 1776 | __start_cc_report 18:38:11 INFO - PROCESS | 1776 | _x_x_mozilla_cycle_collect,1976 18:38:11 INFO - PROCESS | 1776 | __end_cc_report 18:38:11 INFO - PROCESS | 1776 | __startTimestamp1479955091669__endTimestamp 18:38:11 INFO - PROCESS | 1776 | 18:38:11 INFO - PROCESS | 1776 | ------- Summary: start ------- 18:38:11 INFO - PROCESS | 1776 | Number of tests: 14 18:38:11 INFO - PROCESS | 1776 | 18:38:11 INFO - PROCESS | 1776 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:1.08 (0.9%) stddev-sans-first:1.00 18:38:11 INFO - PROCESS | 1776 | Values: 112.0 113.0 114.0 113.0 114.0 115.0 114.0 112.0 115.0 113.0 18:38:11 INFO - PROCESS | 1776 | 18:38:11 INFO - PROCESS | 1776 | [#1] audio-beat-detection Cycles:10 Average:125.00 Median:135.50 stddev:16.69 (12.3%) stddev-sans-first:16.06 18:38:11 INFO - PROCESS | 1776 | Values: 145.0 112.0 110.0 149.0 129.0 142.0 99.0 128.0 113.0 123.0 18:38:11 INFO - PROCESS | 1776 | 18:38:11 INFO - PROCESS | 1776 | [#2] audio-dft Cycles:10 Average:186.20 Median:183.00 stddev:11.35 (6.2%) stddev-sans-first:11.88 18:38:11 INFO - PROCESS | 1776 | Values: 181.0 182.0 187.0 183.0 185.0 218.0 181.0 181.0 181.0 183.0 18:38:11 INFO - PROCESS | 1776 | 18:38:11 INFO - PROCESS | 1776 | [#3] audio-fft Cycles:10 Average:66.40 Median:66.00 stddev:11.54 (17.5%) stddev-sans-first:11.14 18:38:11 INFO - PROCESS | 1776 | Values: 80.0 58.0 57.0 89.0 72.0 60.0 59.0 58.0 74.0 57.0 18:38:11 INFO - PROCESS | 1776 | 18:38:11 INFO - PROCESS | 1776 | [#4] audio-oscillator Cycles:10 Average:75.00 Median:76.00 stddev:7.77 (10.2%) stddev-sans-first:6.93 18:38:11 INFO - PROCESS | 1776 | Values: 87.0 70.0 85.0 71.0 68.0 70.0 81.0 67.0 69.0 82.0 18:38:11 INFO - PROCESS | 1776 | 18:38:11 INFO - PROCESS | 1776 | [#5] imaging-gaussian-blur Cycles:10 Average:84.50 Median:86.00 stddev:1.58 (1.8%) stddev-sans-first:1.58 18:38:11 INFO - PROCESS | 1776 | Values: 86.0 83.0 86.0 83.0 86.0 83.0 86.0 83.0 86.0 83.0 18:38:11 INFO - PROCESS | 1776 | 18:38:11 INFO - PROCESS | 1776 | [#6] imaging-darkroom Cycles:10 Average:105.30 Median:92.00 stddev:23.17 (25.2%) stddev-sans-first:24.51 18:38:11 INFO - PROCESS | 1776 | Values: 110.0 149.0 147.0 92.0 92.0 92.0 93.0 93.0 92.0 93.0 18:38:11 INFO - PROCESS | 1776 | 18:38:11 INFO - PROCESS | 1776 | [#7] imaging-desaturate Cycles:10 Average:86.10 Median:86.50 stddev:1.20 (1.4%) stddev-sans-first:1.27 18:38:11 INFO - PROCESS | 1776 | Values: 86.0 87.0 85.0 86.0 85.0 86.0 84.0 87.0 88.0 87.0 18:38:11 INFO - PROCESS | 1776 | 18:38:11 INFO - PROCESS | 1776 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.50 stddev:1.40 (2.6%) stddev-sans-first:1.05 18:38:11 INFO - PROCESS | 1776 | Values: 57.0 52.0 54.0 53.0 55.0 55.0 54.0 53.0 55.0 54.0 18:38:11 INFO - PROCESS | 1776 | 18:38:11 INFO - PROCESS | 1776 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:72.00 stddev:1.77 (2.5%) stddev-sans-first:1.86 18:38:11 INFO - PROCESS | 1776 | Values: 71.0 72.0 69.0 75.0 74.0 70.0 71.0 71.0 72.0 72.0 18:38:11 INFO - PROCESS | 1776 | 18:38:11 INFO - PROCESS | 1776 | [#10] stanford-crypto-aes Cycles:10 Average:90.50 Median:88.00 stddev:5.78 (6.6%) stddev-sans-first:6.06 18:38:11 INFO - PROCESS | 1776 | Values: 88.0 98.0 104.0 88.0 87.0 88.0 88.0 87.0 87.0 90.0 18:38:11 INFO - PROCESS | 1776 | 18:38:11 INFO - PROCESS | 1776 | [#11] stanford-crypto-ccm Cycles:10 Average:156.60 Median:153.00 stddev:12.28 (8.0%) stddev-sans-first:12.95 18:38:11 INFO - PROCESS | 1776 | Values: 153.0 152.0 151.0 149.0 149.0 157.0 164.0 153.0 189.0 149.0 18:38:11 INFO - PROCESS | 1776 | 18:38:11 INFO - PROCESS | 1776 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.70 Median:178.00 stddev:18.85 (10.6%) stddev-sans-first:19.79 18:38:11 INFO - PROCESS | 1776 | Values: 177.0 175.0 175.0 174.0 177.0 179.0 231.0 206.0 174.0 179.0 18:38:11 INFO - PROCESS | 1776 | 18:38:11 INFO - PROCESS | 1776 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.16 (1.7%) stddev-sans-first:1.20 18:38:11 INFO - PROCESS | 1776 | Values: 67.0 69.0 68.0 70.0 68.0 67.0 68.0 66.0 67.0 67.0 18:38:11 INFO - PROCESS | 1776 | -------- Summary: end -------- 18:38:11 INFO - PROCESS | 1776 | 18:38:12 INFO - TEST-INFO | 1776: exit 0 18:38:12 INFO - TEST-OK | kraken | took 60504ms 18:38:12 INFO - SUITE-END | took 1179s 18:38:13 INFO - Completed test suite (00:19:40) 18:38:13 INFO - javascript benchmark 18:38:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3073.431415188189, 3159.69982851629, 3288.4245257080006, 3338.981610608764, 3344.866205351786, 5511.22842802008, 5595.272614560102, 5620.803271885485, 5648.9549433354805, 5664.461876121767, 5561.221428999943, 5615.634983726065, 5704.3154821421485, 5713.371529131802, 5729.140628905656, 5072.112380333445, 5086.186210206368, 5124.359455068116, 5155.0, 5181.766820493068, 5180.715060671661, 5249.921251181217, 5252.8161514347, 5265.973670131663, 5310.07073762092, 5189.792408303663, 5198.584113270948, 5200.531952124327, 5234.136367499358, 5289.0, 5089.949100508985, 5091.872703182413, 5122.743862806845, 5143.074246635604, 5160.071187186305, 5105.463926287761, 5149.588032957355, 5172.120739474299, 5181.04150732112, 5198.558122559587, 5639.041362968305, 5659.066254068074, 5665.206871038058, 5676.0, 5723.685197314146, 5995.250593675791, 6080.30076541199, 6083.513318934474, 6181.103739957681, 6182.319944806112, 5170.819021334235, 6140.232470941132, 6163.01391777318, 6220.720067596969, 6227.87544249117, 5647.350554686182, 5714.285714285715, 5727.856803579861, 5728.312602487728, 5737.598368114233, 6259.812205633838, 6315.36846315374, 6319.33646967071, 6358.427741503287, 6361.522885783585, 5862.12068189775, 5903.789723106753, 5930.822075337746, 5957.255343082114, 5965.761369545169, 6117.370705100174, 6117.736059405574, 6126.059675755388, 6133.4264757247465, 6142.051815128763, 6111.622125543816, 6129.755478880898, 6155.84610384744, 6171.691415429211, 6180.536459765535, 6183.258009038854, 6192.225971753531, 6197.163382943335, 6206.255249370014, 6219.378062193835, 4570.154521413549, 4587.472440669366, 4818.95181048185, 4919.262110683426, 4932.062908047459, 4370.519242883281, 4372.693911426233, 4382.956170438319, 4408.9118217636105, 4465.776711164429, 5653.321601407775, 5688.11834165705, 5694.4590263924865, 5704.229928959538, 5717.999350113713, 6228.844278892973, 6235.657038862906, 6246.031865060922, 6262.655553944485, 6269.811905642838, 5575.498205161555, 5631.436856314418, 5645.604807663424, 5685.0619647758485, 5690.231818704505, 5349.277847490617, 5367.087595108841, 5375.569954403638, 5417.052015897202, 5460.235567020621, 6289.433950944345, 6294.3076261612105, 6302.464290535356, 6308.526860485574, 6316.6841657916, 6112.358202388685, 6198.504119670506, 6205.0, 6257.624542527463, 6265.279492858197, 6229.96885015572, 6234.1583886174785, 6255.78104766331, 6281.183446152154, 6322.873542529215, 6112.786052488142, 6151.907721384094, 6156.846078848064, 6162.137300777805, 6179.474744646755, 6113.083037544404, 6204.5036397089025, 6241.282252540835, 6255.593386429868, 6259.874802504016, 5870.324912635102, 5987.910181347371, 5987.910181347371, 5994.490468310242, 6044.848878778066, 5979.162917191509, 6004.369541198286, 6008.669523176267, 6011.398860113954, 6067.878642427215, 5459.2629994950175, 5486.780528778804, 5786.161006653927, 5848.619839710405, 5861.974154523026, 4649.256119020941, 5911.911321330097, 6032.8793424132145, 6059.272887253558, 6076.8784624308155, 5868.618539794899, 5878.882422351615, 5883.529317654663, 5885.234919460443, 5935.7032148391545], "value": 5629.73818801453, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [450.42570722329026, 464.44034937899835, 496.6027178257393, 519.2652396858446, 526.8472143078505, 30842.691573084263, 31249.84375078124, 32372.248358889465, 32509.0, 32545.83727081367, 41714.58285417145, 42181.578184218146, 42467.78766106165, 44336.55663443365, 44364.55635443645, 9222.953885230598, 9371.20344770692, 9385.483798391086, 9389.014153513885, 9401.153896149344, 8375.62309696062, 9278.953605231998, 9389.201917836992, 9397.295202859812, 9397.342186046979, 8504.107068757785, 11069.50187241576, 11346.546138154505, 11387.54449822006, 11512.194146409754, 11233.550657973672, 11313.547458101748, 11315.151363647718, 11324.547018119265, 11331.660050198507, 8350.248477637042, 8586.05553389133, 11060.668179954615, 11199.0, 11205.943970280177, 38487.8075609623, 39440.211195775926, 39591.60408395937, 41012.79493602543, 41074.794626026975, 3313.867445302185, 3341.2649217172184, 3348.648391918862, 3361.0757041813454, 3441.48377743338, 29472.410551788846, 30770.69229307723, 30836.691633083832, 30870.845645771627, 30886.536701949488, 3168.065420700899, 3184.060702092865, 3221.114193596756, 3222.5649537312397, 3322.401967645823, 271860.0, 336951.0, 339276.0, 339446.0, 340778.2961085228, 57758.0, 58184.709076454346, 58218.7089064552, 58257.0, 58362.41637583655, 61052.0, 61230.77538449206, 61244.0, 61313.0, 61332.69333653303, 15418.691626167414, 15696.843031569539, 15729.056256624639, 15729.056256624639, 15766.9211653941, 12139.271643701406, 12184.0, 12199.085068619888, 12215.69460763488, 12218.572349967708, 14389.920755943345, 14817.703645927237, 14856.925715371353, 14868.70262594742, 16362.754558681629, 5925.644461332334, 6120.755169793248, 6138.907916381258, 6165.660888651168, 6198.0, 856.8286342731478, 937.044214900811, 982.2240430060315, 987.8320685483485, 1008.2639673038723, 27961.708615561743, 29013.85493072521, 29671.703282967326, 29705.702942970292, 29815.0, 1027.0, 1069.4118234970736, 1119.339589642115, 1146.7018575170516, 1155.1188008292131, 14649.926750366392, 15016.699666006838, 15146.621334466507, 15287.541373758804, 15333.463328783439, 549807.0, 553381.466185341, 553864.0, 556692.0, 557980.0, 48922.0, 50154.49845501498, 55190.0, 56086.71956640191, 56327.155092673645, 1321.7819059855208, 1345.643404497809, 1365.7541642504445, 1367.3095086981011, 1371.2184055088503, 29588.112356629335, 29680.55479167771, 29967.13713503727, 30052.3989520204, 30276.556123459795, 49825.750871245415, 50483.74758126186, 50589.24116138335, 50643.733906652626, 50696.98606027785, 474613.0, 528056.0, 575690.0663443655, 592599.0, 724648.0, 24676.876615617526, 25056.997720090993, 25075.996960121392, 25251.74748252494, 25366.0, 44310.178220978174, 44494.777526112164, 44540.0, 44572.0, 45045.09909801851, 27070.72929270682, 36325.09187270339, 36697.899063028155, 36816.0, 37663.0, 36769.816150919076, 36918.00988073214, 37016.444753328185, 37632.0, 38113.428298576095, 36435.0, 36681.08297292589, 36961.81519092387, 38169.80915095407, 38208.80895595504, 32429.51355729713, 33909.830450847585, 33938.0, 34238.657613423544, 34415.311693765485, 23434.882825585762, 24327.148549800673, 24941.87529062343, 25203.74796252014, 25225.74774252234], "value": 19139.66149958552, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.35392170562733, 363.49837224630005, 372.10879942537605, 372.83408883047036, 397.7514053716427, 12102.821492131412, 14880.925595372022, 17898.373556925526, 18970.620587588273, 19662.90168549159, 19291.807081929175, 19705.408837734856, 20249.49376265594, 20285.898570507165, 20300.0, 5119.590432765389, 5614.045612245907, 5619.353774315945, 5720.914186287188, 5721.599488035839, 4025.1748391579804, 4295.806688699, 5597.776088956437, 5715.0855863061915, 5734.025215713318, 6284.214473190851, 6331.810045698637, 6347.61914285142, 6364.395382438661, 6365.872682546346, 5279.313689220415, 6093.329733729264, 6196.752129914798, 6313.2424109107205, 6331.651759153245, 5395.190721391823, 5401.540869026137, 5427.565794736412, 5457.126859702468, 5465.043617366945, 22512.43718907024, 24647.137350192836, 24758.25725228246, 24763.87618061916, 24943.376415589573, 2297.287840769367, 2384.0106355862295, 2396.9640455393182, 2430.0887167312258, 2977.2259212604663, 14598.854011459856, 14931.477398291116, 14989.925050374788, 15608.453704120302, 15612.76580851288, 1778.4664600619762, 1822.4168266154836, 1827.4426299978502, 1863.8881667100018, 1901.268011815461, 113912.0, 116736.0, 116755.99999999916, 116803.0, 117101.414492927, 8158.4289099762445, 8837.55812209387, 10435.0, 10832.837507437394, 11019.504122314514, 11908.642740717793, 12413.627591172279, 12624.495020199089, 12637.43131559082, 13215.60353189406, 7057.36483716468, 7114.537555058904, 8189.058258300252, 8369.916300837036, 8552.059273479912, 7264.113699170918, 7450.701971921171, 7571.659275332623, 8349.121447674224, 8497.447665901696, 5225.425203227642, 5523.696196709219, 6459.0, 6574.901376479356, 6651.035599837996, 1743.6338368942663, 1784.7501349811037, 1790.6597746428138, 1792.7490151378818, 1794.237449084134, 889.4929889962659, 889.8709687095464, 937.2127412973135, 944.7685317097217, 1035.1304903880625, 20084.89957550232, 21785.23751668684, 21800.672989905164, 21882.12471501154, 22341.664875026563, 940.1585580905052, 946.9234943568006, 948.4830767231875, 983.7934033852828, 1012.3773879064322, 11042.558297668164, 11517.654470365902, 11575.479103440366, 11765.529378824922, 11767.0, 512949.0, 519643.0, 521886.0, 523899.0, 525876.0, 82690.17309826946, 91374.0, 106529.0, 109481.0, 114612.42693786477, 956.818204541135, 995.6216637677636, 1035.3529044347283, 1064.3401091323274, 1064.984025239622, 18832.435026949213, 19077.523061923563, 19136.521586960436, 19283.22867085301, 19327.0, 47368.97311282944, 47476.7626161867, 47914.0, 48485.0, 48826.0, 55183.72408137934, 68266.0, 69828.60342793218, 70528.0, 71139.22151946243, 5406.21609866575, 5564.749586268708, 6324.810255692337, 6954.130733658293, 7305.159906610807, 12972.74770416905, 13046.152000119962, 13371.0, 13563.0, 13598.524051658145, 11245.91950489162, 11375.772484550429, 11568.95879370827, 11675.241109327866, 11735.647930562096, 11236.044936180517, 11270.436478175894, 11329.490172942073, 11491.54033838637, 11551.76896462083, 11425.771484570429, 11500.25248358854, 11669.416529173677, 11793.646190613952, 11812.40937953116, 7925.881111783443, 7979.800504987422, 8003.919960800317, 8025.799355016171, 8124.22819832115, 11259.549618015515, 11356.205065645656, 11516.481758321062, 11625.360605166798, 11671.88328116708], "value": 9391.820487710189, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1326.6351753267845, 1466.47207005478, 1503.6015455904187, 1652.6033751899547, 1831.5146486181172, 7363.521371110881, 7740.767776966693, 7898.684052637895, 8213.7125200618, 8222.177782221775, 8121.796955076126, 8183.6726530938695, 8197.1802819718, 8197.672093116269, 8210.589470526465, 1984.642764302425, 2272.8409011369167, 2306.411864974429, 2310.4570425949887, 2310.792028717415, 2066.865653732503, 2241.60771864923, 2331.277304035746, 2338.96491552626, 2344.979933728825, 2257.8758168300737, 2269.1830940861278, 2280.407094155515, 2281.6805647209403, 2282.315305408379, 2276.4877902471976, 2288.347820871044, 2290.541891621682, 2291.5187810559637, 2292.3123063081175, 2021.0602070037503, 2269.6822444857735, 2274.3972847195505, 2309.515001849614, 2314.5486630107134, 8028.839423211503, 8214.794630134234, 8236.629351679188, 8237.546934918577, 8250.0, 5002.1496345621335, 5031.723255220962, 5178.974105129488, 5182.818601348935, 5182.974085129588, 3267.8856240031487, 3457.6715212054814, 3540.2211513466996, 3542.964570354289, 3547.9645203547893, 930.7673081729567, 995.8157740817971, 1050.2648146297622, 1086.6902932664232, 1090.738222826516, 10588.311759735592, 10613.310134841287, 10616.309939853885, 10620.15038796902, 10633.0, 3870.748401353903, 4342.934855977162, 4613.538646135359, 4680.555347242007, 4682.742449165328, 8145.877811832827, 8965.327600429993, 9196.0, 9216.124468175512, 9259.259259259243, 5055.266986286968, 5153.845384638467, 5163.251328557413, 5168.224766285088, 5176.430592634807, 4257.127288905767, 4416.293393057095, 4444.488883778342, 4612.7001744886475, 4731.361266229083, 3521.8239088045493, 3665.083729067733, 3687.2441149564274, 3794.6964242860504, 3800.0879788850475, 1048.3343077145914, 1241.1126044877956, 1247.3513772838073, 1252.4051075739133, 1257.6792917805901, 823.4277177361796, 853.7822855172016, 861.3195575495414, 901.6663834381321, 931.2363861633531, 5517.972410137923, 5586.385497595261, 5593.636413633101, 5778.133280007948, 5878.441548053013, 916.6562539047857, 927.3693888155984, 927.8051609162017, 941.1717688434271, 971.1502435369052, 3688.5389326334207, 3692.667659910621, 3698.4267438547067, 3796.487474191004, 3849.268638958589, 9520.952395237979, 9922.00779922002, 10010.199184065257, 10027.348222365523, 10029.69910902674, 9321.207697345666, 9788.314817962817, 9920.702378928643, 9960.252981026451, 9960.402375857471, 7487.737929172453, 7703.961480192564, 7707.152213256537, 7714.729984450517, 7726.575038372944, 5406.675599463887, 5417.160340147283, 5443.099177055345, 5724.255846739898, 5752.741126649227, 9015.053419391132, 9107.362484626012, 9159.0, 9352.719418417459, 9360.297977651568, 9295.67465138717, 9363.29775266844, 9376.156145946898, 9407.294452915921, 9523.285753568649, 6523.380278873499, 6960.721571137098, 6985.1967023790885, 7023.0, 7160.10498687664, 7352.926470735438, 7427.44294177928, 7534.736284230025, 7815.491993020435, 7847.058352997677, 6888.896666550106, 6959.373656370951, 7048.541844780073, 7080.468964827555, 7128.85742285141, 6859.622720750406, 6893.586384816927, 6905.792826215222, 6943.722251110101, 6943.930560694531, 6557.311482294291, 6565.671716414065, 6568.6058836469965, 6568.967155164193, 6647.966760166169, 3995.4606128172327, 4704.623630109514, 4757.119932812441, 4771.093492236464, 4879.146149423907, 4191.266528357464, 4606.585407313224, 4649.349091127177, 4665.2535594304745, 4750.477447480705], "value": 4335.052144676548, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.90371081253994, 306.1061699836477, 307.96612372639004, 315.1679565945902, 316.11960689479804, 4133.586641335869, 5207.791688332467, 5299.099153143965, 5348.304720386354, 5362.973185134078, 5003.774830132644, 5130.333056702623, 5156.767945442455, 5200.531952124308, 5224.399194092681, 3823.254465379252, 3961.5444223914187, 3962.445257663929, 3978.4032395140816, 3979.5224573051273, 3433.296174284278, 3458.4985177149297, 3758.981205093971, 3952.644262016418, 4017.879463616096, 3734.5145131132913, 3984.6214609612184, 4005.5794141615147, 4030.355143177092, 4078.8368465261356, 3517.859285628572, 3709.1839795245005, 3921.372580387153, 3937.7834219117935, 3992.08182118113, 3452.8446219920165, 3458.792472451661, 3465.705415039725, 3469.410200265961, 3471.9652803471895, 5089.923651145199, 5103.2855400244, 5103.897922041539, 5106.514881086291, 5111.795528178868, 4193.580641935812, 4491.865244042684, 4501.7524036178, 4518.0, 4521.660875434355, 5146.871328216787, 5433.320834895638, 5470.8085217017615, 5471.37079235889, 5503.284573005523, 2992.0, 3210.133264018725, 3714.8699795507296, 3731.0112820102695, 3742.0644838790304, 4809.326694262841, 5694.829155125353, 5742.28221472316, 5807.651540907559, 5811.970940145315, 3369.4945758136478, 3599.642234336514, 3762.3039737648623, 3807.2385522895534, 3858.884233473, 3842.51968503937, 3856.3251431000026, 3873.4189871519498, 3878.5539662939123, 3917.1578110706337, 3562.786232826039, 3843.8270277837005, 4491.865244042684, 4507.797149128297, 4558.680892337571, 4990.326305948651, 5173.689578625294, 5516.668999860021, 5550.223928342973, 5568.777248909998, 1171.262104873941, 1240.2620440837686, 1243.5585367194697, 1247.6007677543098, 1248.545444557099, 769.9307062364414, 781.3397678961269, 782.6321628834439, 843.4896887383168, 847.8601030829967, 4934.55588996992, 5105.540501354896, 5136.0, 5144.6655967362, 5274.7626356814035, 5660.858478537987, 5666.518345940559, 5671.120976248688, 5696.8860622787315, 5700.434804338064, 4434.933475997863, 4498.17823781369, 4623.514530974267, 4930.753462326869, 5191.143461328914, 2409.686700767283, 2760.8619569021466, 2785.8189217700783, 2826.5618829081527, 2845.900393486218, 5105.897882042338, 5427.29445172133, 5533.446655334515, 5584.441555844383, 5610.793679358876, 4911.901761964812, 5001.399832020181, 5198.974005130026, 5459.1265397537, 5532.834014979557, 5508.669479831223, 5534.422689533463, 5538.972305138529, 5546.722663866871, 5556.527695145958, 4615.284630882219, 5023.844515761322, 5332.0, 5332.187056400842, 5359.383670877899, 4175.916481670411, 4850.708957462422, 5093.134167191661, 5346.599005074557, 5353.785848566014, 4919.163052818807, 4951.8266860659705, 5486.369067557282, 5563.471470210324, 5628.002059269064, 3199.648038715786, 3442.9671098669796, 3517.824108794499, 3574.57105147384, 3589.533360663097, 4704.858854234379, 4772.4228916386155, 5084.339035925306, 5313.787448502171, 5380.919286210788, 4647.442306923191, 4703.3885594872445, 4731.716097034189, 5089.312942752681, 5282.76227569768, 4969.378827646544, 5104.41299250591, 5157.535821776059, 5170.870728231825, 5194.714290714047, 4545.977270113628, 4727.787249573847, 4764.332993380999, 4857.465678775403, 5080.0, 5210.056318180216, 5234.9067014196735, 5385.515303622536, 5388.622796404214, 5391.649542779707, 5354.135537487426, 5370.167624018283, 5377.300950876517, 5381.408045115112, 5387.191921211849], "value": 3918.8562613550034, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [641.9903701444479, 734.8052766017003, 766.8734658781301, 781.468601351081, 795.4670370851529, 13622.11456255344, 14862.33119509622, 15149.166795826226, 15195.696086078271, 15283.617909552268, 13146.0, 13254.668633284173, 13406.530771423002, 13534.729305413886, 13758.793618095737, 704.9823754406156, 824.5135370131636, 838.7944953486405, 840.6511297811401, 842.5997651115702, 659.5317324699469, 679.4971720926503, 804.4610111225463, 829.4940086547201, 834.8121672623641, 884.9513276769775, 887.2857349833414, 888.3159966825541, 889.2174886100223, 892.4020905993, 880.6785523284019, 881.2949640287744, 881.9779505512349, 883.4169448164181, 883.7481317824454, 505.2648396582963, 521.5384384819462, 630.3507387390995, 656.8456412743002, 657.4346062386344, 13667.248301343423, 14118.858811411857, 14164.504242351572, 14178.220197889112, 14183.574492765234, 12783.808242876365, 12884.87115128846, 13294.667633309147, 13306.268155251457, 13409.128406653535, 10482.842757358645, 12065.396730163544, 12083.366557690788, 12138.514459421613, 12599.93700031503, 3816.580176180618, 4238.682098842568, 4287.249731297042, 4304.156391337757, 4368.978155109204, 91049.0, 92126.15747685009, 92744.0, 93472.0, 93485.0, 10259.692209233735, 10270.537825797857, 10271.794564108675, 10344.0, 10681.626143084955, 19562.0, 19851.702224466644, 19889.701654475193, 20077.096530656156, 20120.39638810838, 7448.85102297951, 7512.962435187789, 7596.81007974805, 7679.808004799813, 7696.884546731803, 4124.587541245852, 4211.873643790691, 4242.766647834399, 4256.851010214627, 4274.786260686953, 3212.5181222816295, 3247.236899328656, 3281.4913688378338, 3282.343531293751, 3286.6220384655594, 623.5043140703152, 625.9311475737666, 637.3339859846471, 638.0524920493064, 641.8619996700638, 556.5519756595979, 589.345826132992, 611.3615510431996, 613.6624856329001, 628.335855970681, 8288.792780180424, 8311.875321870177, 8532.866783304175, 8552.529610871337, 8611.6985905493, 553.6733327336891, 604.7218279591438, 613.1507861611611, 613.1936503497886, 626.9435750782452, 4035.5157381114454, 4194.266003449445, 4199.748015119103, 4246.185106976346, 4280.957190428118, 72698.54602907912, 73337.0, 87611.0, 105039.84083660801, 107027.46486267519, 65387.0, 68599.0, 75036.0, 79344.01639959047, 94772.52613737025, 67476.0, 82540.17459825324, 85745.57127214324, 86060.6848417879, 86736.566317168, 7231.457640676865, 7870.606469676379, 7988.680452781824, 8206.466579672302, 8402.0, 54003.46932348154, 54299.0, 54806.0, 55073.44926550683, 56195.0, 71166.28833711804, 72977.0, 74968.25031749831, 75885.75542301718, 76750.23249767431, 10556.577736890438, 10597.523111459848, 10743.623973160902, 10815.35107893529, 10951.726206844574, 9695.757606059906, 11850.288982661068, 11885.881141188478, 11902.702432439259, 12220.602041427688, 10980.560777569128, 11069.501872415922, 11235.494402751732, 11240.381779002233, 11371.260868043551, 8829.514376709085, 11193.216474846682, 12654.936725316315, 12971.156874803108, 13197.076204665582, 12656.74686506283, 12749.490020399451, 12782.68043298925, 12829.61511154667, 12932.159409638343, 10099.747506312107, 10617.946910265398, 10847.186461015297, 11239.943800281273, 11348.375839328915, 6630.0, 8820.5589720515, 8907.73276801697, 8927.375083744335, 9071.637134514809], "value": 6964.914242842428, "unit": "score"}], "name": "dromaeo_css", "value": 7020.720045750333, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 114.0, 113.0, 114.0, 115.0, 114.0, 112.0, 115.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 112.0, 110.0, 149.0, 129.0, 142.0, 99.0, 128.0, 113.0, 123.0], "value": 125.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 182.0, 187.0, 183.0, 185.0, 218.0, 181.0, 181.0, 181.0, 183.0], "value": 186.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 57.0, 89.0, 72.0, 60.0, 59.0, 58.0, 74.0, 57.0], "value": 66.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 85.0, 71.0, 68.0, 70.0, 81.0, 67.0, 69.0, 82.0], "value": 75.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 86.0, 83.0, 86.0, 83.0, 86.0, 83.0, 86.0, 83.0], "value": 84.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 149.0, 147.0, 92.0, 92.0, 92.0, 93.0, 93.0, 92.0, 93.0], "value": 105.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 85.0, 86.0, 85.0, 86.0, 84.0, 87.0, 88.0, 87.0], "value": 86.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 52.0, 54.0, 53.0, 55.0, 55.0, 54.0, 53.0, 55.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 69.0, 75.0, 74.0, 70.0, 71.0, 71.0, 72.0, 72.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 98.0, 104.0, 88.0, 87.0, 88.0, 88.0, 87.0, 87.0, 90.0], "value": 90.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 152.0, 151.0, 149.0, 149.0, 157.0, 164.0, 153.0, 189.0, 149.0], "value": 156.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 175.0, 175.0, 174.0, 177.0, 179.0, 231.0, 206.0, 174.0, 179.0], "value": 184.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 68.0, 70.0, 68.0, 67.0, 68.0, 66.0, 67.0, 67.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1467.4, "alertThreshold": 2.0}]} 18:38:13 INFO - Return code: 0 18:38:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:38:13 INFO - # TBPL SUCCESS # 18:38:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:38:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:38:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:38:13 INFO - 2016-11-23 18:38:13.483 screenresolution[1786:9957] starting screenresolution argv=screenresolution get 18:38:13 INFO - 2016-11-23 18:38:13.486 screenresolution[1786:9957] Display 0: 1600x1200x32@60 18:38:13 INFO - 2016-11-23 18:38:13.492 screenresolution[1787:9960] starting screenresolution argv=screenresolution list 18:38:13 INFO - Available Modes on Display 0 18:38:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:38:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:38:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:38:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:38:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:38:13 INFO - Intel Iris: 18:38:13 INFO - Chipset Model: Intel Iris 18:38:13 INFO - Type: GPU 18:38:13 INFO - Bus: Built-In 18:38:13 INFO - VRAM (Dynamic, Max): 1536 MB 18:38:13 INFO - Vendor: Intel (0x8086) 18:38:13 INFO - Device ID: 0x0a2e 18:38:13 INFO - Revision ID: 0x0009 18:38:13 INFO - Displays: 18:38:13 INFO - Display: 18:38:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:38:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:38:13 INFO - Display Serial Number: 1600x1200 60 18:38:13 INFO - Main Display: Yes 18:38:13 INFO - Mirror: Off 18:38:13 INFO - Online: Yes 18:38:13 INFO - Rotation: Supported 18:38:13 INFO - Return code: 0 18:38:13 INFO - Running post-action listener: _resource_record_post_action 18:38:13 INFO - [mozharness: 2016-11-24 02:38:13.728047Z] Finished run-tests step (success) 18:38:13 INFO - Running post-run listener: _resource_record_post_run 18:38:13 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 37712896; Write bytes: 690832384; Read time: 242; Write time: 2034 18:38:13 INFO - TinderboxPrint: CPU usage
53.8% 18:38:13 INFO - TinderboxPrint: I/O read bytes / time
37,712,896 / 242 18:38:13 INFO - TinderboxPrint: I/O write bytes / time
690,832,384 / 2,034 18:38:13 INFO - TinderboxPrint: CPU idle
2,241.9 (46.2%) 18:38:13 INFO - TinderboxPrint: CPU system
974.2 (20.1%) 18:38:13 INFO - TinderboxPrint: CPU user
1,637.4 (33.7%) 18:38:13 INFO - TinderboxPrint: Swap in / out
420,478,976 / 0 18:38:13 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 348160; Write bytes: 385213952; Read time: 12; Write time: 825 18:38:13 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 34477056; Write bytes: 304057856; Read time: 212; Write time: 1204 18:38:14 INFO - Running post-run listener: _upload_blobber_files 18:38:14 INFO - Blob upload gear active. 18:38:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:38:14 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 18:38:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:38:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:38:14 INFO - (blobuploader) - INFO - Open directory for files ... 18:38:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:38:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:38:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:38:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:38:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:38:15 INFO - (blobuploader) - INFO - Done attempting. 18:38:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:38:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:38:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:38:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:38:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:38:17 INFO - (blobuploader) - INFO - Done attempting. 18:38:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:38:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:38:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:38:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:38:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:38:19 INFO - (blobuploader) - INFO - Done attempting. 18:38:19 INFO - (blobuploader) - INFO - Iteration through files over. 18:38:19 INFO - Return code: 0 18:38:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:38:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:38:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fedab95c9221893f1017811d47ccf676aa714323e28dc37e8003a57ffc5f4327eb413832d6c704a3f1c3d6f67e11db298734a2a19e0300ab2352823b9125d7b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7457ebe2c2796ebba7f3105b7a77fe4219fe0572373974a434bad0fd8078a906eab4e3c3c8e36b4b2a2c8edc2d85c55bf1282e3925ed82dfdee15308759c9e49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ad930a13ccc87d1f1631b16bc16ea569c2c067a157db7e548e06ea7c385714c069149694c66a8bd9dd07739f0ed08369be24b0fd70163ab0fde75f7c5d2c40c"} 18:38:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:38:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:38:19 INFO - Contents: 18:38:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fedab95c9221893f1017811d47ccf676aa714323e28dc37e8003a57ffc5f4327eb413832d6c704a3f1c3d6f67e11db298734a2a19e0300ab2352823b9125d7b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7457ebe2c2796ebba7f3105b7a77fe4219fe0572373974a434bad0fd8078a906eab4e3c3c8e36b4b2a2c8edc2d85c55bf1282e3925ed82dfdee15308759c9e49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ad930a13ccc87d1f1631b16bc16ea569c2c067a157db7e548e06ea7c385714c069149694c66a8bd9dd07739f0ed08369be24b0fd70163ab0fde75f7c5d2c40c"} 18:38:19 INFO - Running post-run listener: copy_logs_to_upload_dir 18:38:19 INFO - Copying logs to upload dir... 18:38:19 INFO - mkdir: /builds/slave/test/build/upload/logs 18:38:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.208685 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-11-23 18:38:19.312377) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 18:38:19.315400) ========= 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.yGZJPrcoCG/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.LSEwLwymn1/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fedab95c9221893f1017811d47ccf676aa714323e28dc37e8003a57ffc5f4327eb413832d6c704a3f1c3d6f67e11db298734a2a19e0300ab2352823b9125d7b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7457ebe2c2796ebba7f3105b7a77fe4219fe0572373974a434bad0fd8078a906eab4e3c3c8e36b4b2a2c8edc2d85c55bf1282e3925ed82dfdee15308759c9e49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ad930a13ccc87d1f1631b16bc16ea569c2c067a157db7e548e06ea7c385714c069149694c66a8bd9dd07739f0ed08369be24b0fd70163ab0fde75f7c5d2c40c"} build_url:https://queue.taskcluster.net/v1/task/WAgGw4aTSRm02Ai6JIZioQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010876 build_url: 'https://queue.taskcluster.net/v1/task/WAgGw4aTSRm02Ai6JIZioQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fedab95c9221893f1017811d47ccf676aa714323e28dc37e8003a57ffc5f4327eb413832d6c704a3f1c3d6f67e11db298734a2a19e0300ab2352823b9125d7b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7457ebe2c2796ebba7f3105b7a77fe4219fe0572373974a434bad0fd8078a906eab4e3c3c8e36b4b2a2c8edc2d85c55bf1282e3925ed82dfdee15308759c9e49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ad930a13ccc87d1f1631b16bc16ea569c2c067a157db7e548e06ea7c385714c069149694c66a8bd9dd07739f0ed08369be24b0fd70163ab0fde75f7c5d2c40c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 18:38:19.348857) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 18:38:19.349185) ========= 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.yGZJPrcoCG/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.LSEwLwymn1/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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.005164 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 18:38:19.397604) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 18:38:19.397911) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 18:38:19.398212) ========= ========= Total master_lag: 0.18 =========