builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0125 starttime: 1479122533.84 results: success (0) buildid: 20161114012220 builduid: 611333f71d4d45768789301e0ef4777f revision: add9dada238ed99b4f93c027b535423f067d3781 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 03:22:13.842751) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 03:22:13.843147) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 03:22:13.843419) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 03:22:13.867975) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 03:22:13.868279) ========= 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.BNY0KxcSvk/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.OGxQDmJI1S/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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-14 03:22:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 143M=0s 2016-11-14 03:22:14 (143 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.162718 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 03:22:14.053319) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 03:22:14.053643) ========= 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.BNY0KxcSvk/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.OGxQDmJI1S/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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.028822 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 03:22:14.102230) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 03:22:14.102600) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev add9dada238ed99b4f93c027b535423f067d3781 --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 add9dada238ed99b4f93c027b535423f067d3781 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BNY0KxcSvk/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.OGxQDmJI1S/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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-14 03:22:14,181 truncating revision to first 12 chars 2016-11-14 03:22:14,181 Setting DEBUG logging. 2016-11-14 03:22:14,182 attempt 1/10 2016-11-14 03:22:14,182 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/add9dada238e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 03:22:15,453 unpacking tar archive at: mozilla-central-add9dada238e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.744789 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 03:22:15.868828) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 03:22:15.869165) ========= script_repo_revision: add9dada238ed99b4f93c027b535423f067d3781 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 03:22:15.869574) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 03:22:15.869840) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 03:22:15.887881) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-11-14 03:22:15.888450) ========= /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.BNY0KxcSvk/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.OGxQDmJI1S/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 03:22:16 INFO - MultiFileLogger online at 20161114 03:22:16 in /builds/slave/test 03:22:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:22:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:22:16 INFO - {'append_to_log': False, 03:22:16 INFO - 'base_work_dir': '/builds/slave/test', 03:22:16 INFO - 'blob_upload_branch': 'Firefox', 03:22:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:22:16 INFO - 'branch': 'Firefox', 03:22:16 INFO - 'buildbot_json_path': 'buildprops.json', 03:22:16 INFO - 'config_files': ('talos/mac_config.py',), 03:22:16 INFO - 'default_actions': ('clobber', 03:22:16 INFO - 'read-buildbot-config', 03:22:16 INFO - 'download-and-extract', 03:22:16 INFO - 'populate-webroot', 03:22:16 INFO - 'create-virtualenv', 03:22:16 INFO - 'install', 03:22:16 INFO - 'run-tests'), 03:22:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:22:16 INFO - 'download_minidump_stackwalk': True, 03:22:16 INFO - 'download_symbols': 'ondemand', 03:22:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:22:16 INFO - 'tooltool.py': '/tools/tooltool.py', 03:22:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:22:16 INFO - '/tools/misc-python/virtualenv.py')}, 03:22:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:22:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:22:16 INFO - 'installer_path': 'installer.exe', 03:22:16 INFO - 'log_level': 'info', 03:22:16 INFO - 'log_name': 'talos', 03:22:16 INFO - 'log_to_console': True, 03:22:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:22:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:22:16 INFO - 'opt_config_files': (), 03:22:16 INFO - 'pip_index': False, 03:22:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:22:16 INFO - 'cmd': ('bash', 03:22:16 INFO - '-c', 03:22:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:22:16 INFO - 'enabled': True, 03:22:16 INFO - 'halt_on_failure': False, 03:22:16 INFO - 'name': 'check_screen_resolution'},), 03:22:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:22:16 INFO - 'cmd': ('bash', 03:22:16 INFO - '-c', 03:22:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:22:16 INFO - 'enabled': True, 03:22:16 INFO - 'halt_on_failure': False, 03:22:16 INFO - 'name': 'check_screen_resolution'},), 03:22:16 INFO - 'run_cmd_checks_enabled': True, 03:22:16 INFO - 'sps_profile': False, 03:22:16 INFO - 'sps_profile_interval': 0, 03:22:16 INFO - 'suite': 'dromaeojs', 03:22:16 INFO - 'system_bits': '32', 03:22:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:22:16 INFO - 'title': 't-yosemite-r7-0125', 03:22:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:22:16 INFO - 'use_talos_json': True, 03:22:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:22:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:22:16 INFO - 'work_dir': 'build'} 03:22:16 INFO - [mozharness: 2016-11-14 11:22:16.094915Z] Running clobber step. 03:22:16 INFO - Running pre-action listener: _resource_record_pre_action 03:22:16 INFO - Running main action method: clobber 03:22:16 INFO - rmtree: /builds/slave/test/build 03:22:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:22:18 INFO - Running post-action listener: _resource_record_post_action 03:22:18 INFO - [mozharness: 2016-11-14 11:22:18.184002Z] Finished clobber step (success) 03:22:18 INFO - [mozharness: 2016-11-14 11:22:18.184132Z] Running read-buildbot-config step. 03:22:18 INFO - Running pre-action listener: _resource_record_pre_action 03:22:18 INFO - Running main action method: read_buildbot_config 03:22:18 INFO - Using buildbot properties: 03:22:18 INFO - { 03:22:18 INFO - "project": "", 03:22:18 INFO - "product": "firefox", 03:22:18 INFO - "script_repo_revision": "production", 03:22:18 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 03:22:18 INFO - "repository": "", 03:22:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 03:22:18 INFO - "buildid": "20161114012220", 03:22:18 INFO - "pgo_build": "False", 03:22:18 INFO - "basedir": "/builds/slave/test", 03:22:18 INFO - "buildnumber": 7, 03:22:18 INFO - "slavename": "t-yosemite-r7-0125", 03:22:18 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 03:22:18 INFO - "platform": "yosemite_r7", 03:22:18 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:22:18 INFO - "branch": "mozilla-central", 03:22:18 INFO - "repo_path": "mozilla-central", 03:22:18 INFO - "revision": "add9dada238ed99b4f93c027b535423f067d3781", 03:22:18 INFO - "stage_platform": "macosx64", 03:22:18 INFO - "builduid": "611333f71d4d45768789301e0ef4777f", 03:22:18 INFO - "slavebuilddir": "test" 03:22:18 INFO - } 03:22:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/GJyOfF0mT5Scof1WhFnclQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 03:22:18 INFO - Running post-action listener: _resource_record_post_action 03:22:18 INFO - [mozharness: 2016-11-14 11:22:18.187408Z] Finished read-buildbot-config step (success) 03:22:18 INFO - [mozharness: 2016-11-14 11:22:18.187489Z] Running download-and-extract step. 03:22:18 INFO - Running pre-action listener: _resource_record_pre_action 03:22:18 INFO - Running main action method: download_and_extract 03:22:18 INFO - mkdir: /builds/slave/test/build/tests 03:22:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:18 INFO - trying https://queue.taskcluster.net/v1/task/GJyOfF0mT5Scof1WhFnclQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 03:22:18 INFO - Downloading https://queue.taskcluster.net/v1/task/GJyOfF0mT5Scof1WhFnclQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 03:22:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GJyOfF0mT5Scof1WhFnclQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 03:22:19 INFO - Downloaded 1199 bytes. 03:22:19 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 03:22:19 INFO - Using the following test package requirements: 03:22:19 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 03:22:19 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:22:19 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 03:22:19 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:22:19 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 03:22:19 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:22:19 INFO - u'jsshell-mac.zip'], 03:22:19 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:22:19 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 03:22:19 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 03:22:19 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:22:19 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 03:22:19 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:22:19 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 03:22:19 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:22:19 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 03:22:19 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:22:19 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 03:22:19 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:22:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GJyOfF0mT5Scof1WhFnclQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 03:22:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GJyOfF0mT5Scof1WhFnclQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:22:19 INFO - Fetch https://queue.taskcluster.net/v1/task/GJyOfF0mT5Scof1WhFnclQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 03:22:20 INFO - Http code: 200 03:22:20 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 03:22:20 INFO - x-amz-cf-id: 5YpZhNH-_sP6v4iY1CBs9NMdWa6QhVNfy_WPfr__Pcific6NTLzMug== 03:22:20 INFO - x-amz-version-id: wsMrm2qlstQnw8nr1FlngJqbAavmYK9t 03:22:20 INFO - Expected file size: 16319972 03:22:20 INFO - Obtained file size: 16319972 03:22:27 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 03:22:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GJyOfF0mT5Scof1WhFnclQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 03:22:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GJyOfF0mT5Scof1WhFnclQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:22:27 INFO - Fetch https://queue.taskcluster.net/v1/task/GJyOfF0mT5Scof1WhFnclQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 03:22:27 INFO - Http code: 200 03:22:27 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 03:22:27 INFO - x-amz-cf-id: gYQ2lgMzJMEqHDj2ifxq2ZMJsDAKNDE86ijGYVAgSWYQX2rmq1OPDw== 03:22:27 INFO - x-amz-version-id: wsMrm2qlstQnw8nr1FlngJqbAavmYK9t 03:22:27 INFO - Expected file size: 16319972 03:22:27 INFO - Obtained file size: 16319972 03:22:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GJyOfF0mT5Scof1WhFnclQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 03:22:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GJyOfF0mT5Scof1WhFnclQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:22:34 INFO - Fetch https://queue.taskcluster.net/v1/task/GJyOfF0mT5Scof1WhFnclQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 03:22:34 INFO - Http code: 200 03:22:34 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 03:22:34 INFO - x-amz-cf-id: ifMzQ0M2CfpbtjfNQ4icI2RIhtA4osYvuvOLHwzevXxe_urxzmrTAA== 03:22:34 INFO - x-amz-version-id: mD.k3DILLk5Q59PdQI6eOt7CMB5sQ5U4 03:22:35 INFO - Expected file size: 14409038 03:22:35 INFO - Obtained file size: 14409038 03:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:35 INFO - trying https://queue.taskcluster.net/v1/task/GJyOfF0mT5Scof1WhFnclQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 03:22:35 INFO - Downloading https://queue.taskcluster.net/v1/task/GJyOfF0mT5Scof1WhFnclQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 03:22:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GJyOfF0mT5Scof1WhFnclQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 03:22:38 INFO - Downloaded 111042419 bytes. 03:22:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GJyOfF0mT5Scof1WhFnclQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 03:22:38 INFO - mkdir: /builds/slave/test/properties 03:22:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:22:38 INFO - Writing to file /builds/slave/test/properties/build_url 03:22:38 INFO - Contents: 03:22:38 INFO - build_url:https://queue.taskcluster.net/v1/task/GJyOfF0mT5Scof1WhFnclQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 03:22:38 INFO - Running post-action listener: _resource_record_post_action 03:22:38 INFO - Running post-action listener: set_extra_try_arguments 03:22:38 INFO - [mozharness: 2016-11-14 11:22:38.898347Z] Finished download-and-extract step (success) 03:22:38 INFO - [mozharness: 2016-11-14 11:22:38.898474Z] Running populate-webroot step. 03:22:38 INFO - Running pre-action listener: _resource_record_pre_action 03:22:38 INFO - Running main action method: populate_webroot 03:22:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:22:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:22:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:22:38 INFO - '--tppagecycles', 03:22:38 INFO - '7'], 03:22:38 INFO - 'tests': ['tsvgm']}}, 03:22:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:22:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:22:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:22:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:22:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:22:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:22:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:38 INFO - 'talos_options': ['--disable-e10s'], 03:22:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:22:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:22:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:38 INFO - 'talos_options': ['--disable-e10s'], 03:22:38 INFO - 'tests': ['damp', 'tps']}, 03:22:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:38 INFO - 'tests': ['damp', 'tps']}, 03:22:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:22:38 INFO - 'tests': ['dromaeo_dom']}, 03:22:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:22:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:22:38 INFO - 'tests': ['basic_compositor_video']}, 03:22:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:22:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:22:38 INFO - 'tests': ['a11yr', 03:22:38 INFO - 'ts_paint', 03:22:38 INFO - 'tpaint', 03:22:38 INFO - 'sessionrestore', 03:22:38 INFO - 'sessionrestore_no_auto_restore', 03:22:38 INFO - 'tabpaint']}, 03:22:38 INFO - 'other-e10s': {'tests': ['a11yr', 03:22:38 INFO - 'ts_paint', 03:22:38 INFO - 'tpaint', 03:22:38 INFO - 'sessionrestore', 03:22:38 INFO - 'sessionrestore_no_auto_restore', 03:22:38 INFO - 'tabpaint']}, 03:22:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:22:38 INFO - 'ts_paint', 03:22:38 INFO - 'tpaint', 03:22:38 INFO - 'sessionrestore', 03:22:38 INFO - 'sessionrestore_no_auto_restore', 03:22:38 INFO - 'tabpaint']}, 03:22:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:22:38 INFO - 'ts_paint', 03:22:38 INFO - 'tpaint', 03:22:38 INFO - 'sessionrestore', 03:22:38 INFO - 'sessionrestore_no_auto_restore', 03:22:38 INFO - 'tabpaint']}, 03:22:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:22:38 INFO - 'tests': ['a11yr', 03:22:38 INFO - 'ts_paint', 03:22:38 INFO - 'tpaint', 03:22:38 INFO - 'sessionrestore', 03:22:38 INFO - 'sessionrestore_no_auto_restore', 03:22:38 INFO - 'tabpaint']}, 03:22:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:22:38 INFO - 'tests': ['a11yr', 03:22:38 INFO - 'ts_paint', 03:22:38 INFO - 'tpaint', 03:22:38 INFO - 'sessionrestore', 03:22:38 INFO - 'sessionrestore_no_auto_restore', 03:22:38 INFO - 'tabpaint']}, 03:22:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:22:38 INFO - 'tests': ['tsvgx', 03:22:38 INFO - 'tsvgr_opacity', 03:22:38 INFO - 'tart', 03:22:38 INFO - 'tscrollx', 03:22:38 INFO - 'cart']}, 03:22:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:22:38 INFO - 'tsvgr_opacity', 03:22:38 INFO - 'tart', 03:22:38 INFO - 'tscrollx', 03:22:38 INFO - 'cart']}, 03:22:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:38 INFO - 'talos_options': ['--disable-e10s'], 03:22:38 INFO - 'tests': ['tp5o']}, 03:22:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:38 INFO - 'tests': ['tp5o']}, 03:22:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:38 INFO - 'talos_options': ['--disable-e10s', 03:22:38 INFO - '--xperf_path', 03:22:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:22:38 INFO - 'tests': ['tp5n']}, 03:22:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:38 INFO - 'talos_options': ['--xperf_path', 03:22:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:22:38 INFO - 'tests': ['tp5n']}}, 03:22:38 INFO - 'talos.zip': {'path': '', 03:22:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:22:38 INFO - Running post-action listener: _resource_record_post_action 03:22:38 INFO - [mozharness: 2016-11-14 11:22:38.917190Z] Finished populate-webroot step (success) 03:22:38 INFO - [mozharness: 2016-11-14 11:22:38.917324Z] Running create-virtualenv step. 03:22:38 INFO - Running pre-action listener: _resource_record_pre_action 03:22:38 INFO - Running main action method: create_virtualenv 03:22:38 INFO - Creating virtualenv /builds/slave/test/build/venv 03:22:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:22:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:22:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:22:39 INFO - Using real prefix '/tools/python27' 03:22:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:22:39 INFO - Installing distribute.............................................................................................................................................................................................done. 03:22:42 INFO - Installing pip.................done. 03:22:42 INFO - Return code: 0 03:22:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:22:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:22:42 INFO - Reading from file tmpfile_stdout 03:22:42 INFO - Output received: 03:22:42 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:22:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:42 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 0x10fefe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe74570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5cbc95ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd12d30>, '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 0x10fb38db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd0ab20>, '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.BNY0KxcSvk/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.OGxQDmJI1S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:22:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:22:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:22:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BNY0KxcSvk/Render', 03:22:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:42 INFO - 'HOME': '/Users/cltbld', 03:22:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:42 INFO - 'LOGNAME': 'cltbld', 03:22:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:42 INFO - 'MOZ_NO_REMOTE': '1', 03:22:42 INFO - 'NO_EM_RESTART': '1', 03:22:42 INFO - 'PAGER': '/bin/cat', 03:22:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:42 INFO - 'PWD': '/builds/slave/test', 03:22:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:42 INFO - 'SHELL': '/bin/bash', 03:22:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OGxQDmJI1S/Listeners', 03:22:42 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 03:22:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:42 INFO - 'USER': 'cltbld', 03:22:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:42 INFO - 'XPC_FLAGS': '0x0', 03:22:42 INFO - 'XPC_SERVICE_NAME': '0', 03:22:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:22:43 INFO - Cleaning up... 03:22:43 INFO - Return code: 0 03:22:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fefe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe74570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5cbc95ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd12d30>, '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 0x10fb38db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd0ab20>, '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.BNY0KxcSvk/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.OGxQDmJI1S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:22:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:22:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:22:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BNY0KxcSvk/Render', 03:22:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:43 INFO - 'HOME': '/Users/cltbld', 03:22:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:43 INFO - 'LOGNAME': 'cltbld', 03:22:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:43 INFO - 'MOZ_NO_REMOTE': '1', 03:22:43 INFO - 'NO_EM_RESTART': '1', 03:22:43 INFO - 'PAGER': '/bin/cat', 03:22:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:43 INFO - 'PWD': '/builds/slave/test', 03:22:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:43 INFO - 'SHELL': '/bin/bash', 03:22:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OGxQDmJI1S/Listeners', 03:22:43 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 03:22:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:43 INFO - 'USER': 'cltbld', 03:22:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:43 INFO - 'XPC_FLAGS': '0x0', 03:22:43 INFO - 'XPC_SERVICE_NAME': '0', 03:22:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:43 INFO - Downloading/unpacking psutil>=3.1.1 03:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:22:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:22:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:22:46 INFO - Installing collected packages: psutil 03:22:46 INFO - Running setup.py install for psutil 03:22:46 INFO - building 'psutil._psutil_osx' extension 03:22:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:22:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:22:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:22:47 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:22:47 INFO - building 'psutil._psutil_posix' extension 03:22:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:22:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:22:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:22:47 INFO - ^ 03:22:47 INFO - 1 warning generated. 03:22:47 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:22:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:22:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:22:48 INFO - Successfully installed psutil 03:22:48 INFO - Cleaning up... 03:22:48 INFO - Return code: 0 03:22:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:22:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fefe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe74570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5cbc95ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd12d30>, '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 0x10fb38db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd0ab20>, '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.BNY0KxcSvk/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.OGxQDmJI1S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:22:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:22:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:22:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BNY0KxcSvk/Render', 03:22:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:48 INFO - 'HOME': '/Users/cltbld', 03:22:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:48 INFO - 'LOGNAME': 'cltbld', 03:22:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:48 INFO - 'MOZ_NO_REMOTE': '1', 03:22:48 INFO - 'NO_EM_RESTART': '1', 03:22:48 INFO - 'PAGER': '/bin/cat', 03:22:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:48 INFO - 'PWD': '/builds/slave/test', 03:22:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:48 INFO - 'SHELL': '/bin/bash', 03:22:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OGxQDmJI1S/Listeners', 03:22:48 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 03:22:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:48 INFO - 'USER': 'cltbld', 03:22:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:48 INFO - 'XPC_FLAGS': '0x0', 03:22:48 INFO - 'XPC_SERVICE_NAME': '0', 03:22:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:22:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:22:51 INFO - Installing collected packages: mozsystemmonitor 03:22:51 INFO - Running setup.py install for mozsystemmonitor 03:22:51 INFO - Successfully installed mozsystemmonitor 03:22:51 INFO - Cleaning up... 03:22:51 INFO - Return code: 0 03:22:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:22: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')]} 03:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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')]} 03:22:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:51 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 0x10fefe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe74570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5cbc95ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd12d30>, '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 0x10fb38db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd0ab20>, '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.BNY0KxcSvk/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.OGxQDmJI1S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:22:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:22:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BNY0KxcSvk/Render', 03:22:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:51 INFO - 'HOME': '/Users/cltbld', 03:22:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:51 INFO - 'LOGNAME': 'cltbld', 03:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:51 INFO - 'MOZ_NO_REMOTE': '1', 03:22:51 INFO - 'NO_EM_RESTART': '1', 03:22:51 INFO - 'PAGER': '/bin/cat', 03:22:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:51 INFO - 'PWD': '/builds/slave/test', 03:22:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:51 INFO - 'SHELL': '/bin/bash', 03:22:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OGxQDmJI1S/Listeners', 03:22:51 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 03:22:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:51 INFO - 'USER': 'cltbld', 03:22:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:51 INFO - 'XPC_FLAGS': '0x0', 03:22:51 INFO - 'XPC_SERVICE_NAME': '0', 03:22:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:51 INFO - Downloading/unpacking jsonschema==2.5.1 03:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:22:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:22: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 03:22: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 03:22: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 03:22: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 03:22: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 03:22: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 03:22:54 INFO - Downloading functools32-3.2.3-2.tar.gz 03:22:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:22:54 INFO - warning: no files found matching '*.txt' 03:22:54 INFO - no previously-included directories found matching 'build' 03:22:54 INFO - no previously-included directories found matching 'dist' 03:22:54 INFO - no previously-included directories found matching '.git*' 03:22:54 INFO - Installing collected packages: jsonschema, functools32 03:22:54 INFO - Running setup.py install for functools32 03:22:54 INFO - warning: no files found matching '*.txt' 03:22:54 INFO - no previously-included directories found matching 'build' 03:22:54 INFO - no previously-included directories found matching 'dist' 03:22:54 INFO - no previously-included directories found matching '.git*' 03:22:54 INFO - Successfully installed jsonschema functools32 03:22:54 INFO - Cleaning up... 03:22:54 INFO - Return code: 0 03:22:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:54 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 0x10fefe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe74570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5cbc95ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd12d30>, '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 0x10fb38db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd0ab20>, '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.BNY0KxcSvk/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.OGxQDmJI1S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:22:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:22:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:22:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BNY0KxcSvk/Render', 03:22:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:54 INFO - 'HOME': '/Users/cltbld', 03:22:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:54 INFO - 'LOGNAME': 'cltbld', 03:22:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:54 INFO - 'MOZ_NO_REMOTE': '1', 03:22:54 INFO - 'NO_EM_RESTART': '1', 03:22:54 INFO - 'PAGER': '/bin/cat', 03:22:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:54 INFO - 'PWD': '/builds/slave/test', 03:22:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:54 INFO - 'SHELL': '/bin/bash', 03:22:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OGxQDmJI1S/Listeners', 03:22:54 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 03:22:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:54 INFO - 'USER': 'cltbld', 03:22:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:54 INFO - 'XPC_FLAGS': '0x0', 03:22:54 INFO - 'XPC_SERVICE_NAME': '0', 03:22:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:22:55 INFO - Cleaning up... 03:22:55 INFO - Return code: 0 03:22:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fefe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe74570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5cbc95ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd12d30>, '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 0x10fb38db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd0ab20>, '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.BNY0KxcSvk/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.OGxQDmJI1S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:22:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:22:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:22:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BNY0KxcSvk/Render', 03:22:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:55 INFO - 'HOME': '/Users/cltbld', 03:22:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:55 INFO - 'LOGNAME': 'cltbld', 03:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:55 INFO - 'MOZ_NO_REMOTE': '1', 03:22:55 INFO - 'NO_EM_RESTART': '1', 03:22:55 INFO - 'PAGER': '/bin/cat', 03:22:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:55 INFO - 'PWD': '/builds/slave/test', 03:22:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:55 INFO - 'SHELL': '/bin/bash', 03:22:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OGxQDmJI1S/Listeners', 03:22:55 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 03:22:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:55 INFO - 'USER': 'cltbld', 03:22:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:55 INFO - 'XPC_FLAGS': '0x0', 03:22:55 INFO - 'XPC_SERVICE_NAME': '0', 03:22:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:55 INFO - Downloading/unpacking blobuploader==1.2.4 03:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:57 INFO - Downloading blobuploader-1.2.4.tar.gz 03:22:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:22:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:22:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:59 INFO - Downloading docopt-0.6.1.tar.gz 03:22:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:22:59 INFO - Installing collected packages: blobuploader, requests, docopt 03:22:59 INFO - Running setup.py install for blobuploader 03:22:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:22:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:22:59 INFO - Running setup.py install for requests 03:22:59 INFO - Running setup.py install for docopt 03:23:00 INFO - Successfully installed blobuploader requests docopt 03:23:00 INFO - Cleaning up... 03:23:00 INFO - Return code: 0 03:23:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:00 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 0x10fefe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe74570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5cbc95ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd12d30>, '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 0x10fb38db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd0ab20>, '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.BNY0KxcSvk/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.OGxQDmJI1S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:23:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:23:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:23:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BNY0KxcSvk/Render', 03:23:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:00 INFO - 'HOME': '/Users/cltbld', 03:23:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:00 INFO - 'LOGNAME': 'cltbld', 03:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:00 INFO - 'MOZ_NO_REMOTE': '1', 03:23:00 INFO - 'NO_EM_RESTART': '1', 03:23:00 INFO - 'PAGER': '/bin/cat', 03:23:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:00 INFO - 'PWD': '/builds/slave/test', 03:23:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:00 INFO - 'SHELL': '/bin/bash', 03:23:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OGxQDmJI1S/Listeners', 03:23:00 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 03:23:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:00 INFO - 'USER': 'cltbld', 03:23:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:00 INFO - 'XPC_FLAGS': '0x0', 03:23:00 INFO - 'XPC_SERVICE_NAME': '0', 03:23:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:23:00 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-Bbb5Zg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:23:00 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-a917SQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:23:00 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-9QsDNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:23:00 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-wyLU_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:23:00 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-z4vPzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:23:00 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-yezHDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:23:01 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-gAkmiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:23:01 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-hTcRHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:23:01 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-fArLU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:23:01 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-CrLmK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:23:01 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-NAkWkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:23:01 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-UoCIA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:23:01 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-DdRyHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:23:01 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-JeI8wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:01 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-QsWdCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:23:01 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-wf5WtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:23:02 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-ihPyJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:23:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:23:02 INFO - Running setup.py install for manifestparser 03:23:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:23:02 INFO - Running setup.py install for mozcrash 03:23:02 INFO - Running setup.py install for mozdebug 03:23:02 INFO - Running setup.py install for mozdevice 03:23:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:23:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:23:02 INFO - Running setup.py install for mozfile 03:23:02 INFO - Running setup.py install for mozhttpd 03:23:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:23:03 INFO - Running setup.py install for mozinfo 03:23:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:23:03 INFO - Running setup.py install for mozInstall 03:23:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:23:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:23:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:23:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:23:03 INFO - Running setup.py install for mozleak 03:23:03 INFO - Running setup.py install for mozlog 03:23:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:23:03 INFO - Running setup.py install for moznetwork 03:23:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:23:03 INFO - Running setup.py install for mozprocess 03:23:03 INFO - Running setup.py install for mozprofile 03:23:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:23:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:23:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:23:04 INFO - Running setup.py install for mozrunner 03:23:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:23:04 INFO - Running setup.py install for mozscreenshot 03:23:04 INFO - Running setup.py install for moztest 03:23:04 INFO - Running setup.py install for mozversion 03:23:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:23:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:23:04 INFO - Cleaning up... 03:23:04 INFO - Return code: 0 03:23:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:04 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 0x10fefe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe74570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5cbc95ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd12d30>, '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 0x10fb38db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd0ab20>, '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.BNY0KxcSvk/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.OGxQDmJI1S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:23:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:23:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:23:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BNY0KxcSvk/Render', 03:23:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:04 INFO - 'HOME': '/Users/cltbld', 03:23:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:04 INFO - 'LOGNAME': 'cltbld', 03:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:04 INFO - 'MOZ_NO_REMOTE': '1', 03:23:04 INFO - 'NO_EM_RESTART': '1', 03:23:04 INFO - 'PAGER': '/bin/cat', 03:23:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:04 INFO - 'PWD': '/builds/slave/test', 03:23:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:04 INFO - 'SHELL': '/bin/bash', 03:23:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OGxQDmJI1S/Listeners', 03:23:04 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 03:23:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:04 INFO - 'USER': 'cltbld', 03:23:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:04 INFO - 'XPC_FLAGS': '0x0', 03:23:04 INFO - 'XPC_SERVICE_NAME': '0', 03:23:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:23:05 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-K9aXS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:23:05 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-aH9h2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:23:05 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-jDye8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:23:05 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-LAx7Gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:23:05 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-zd4QX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:23:05 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-rkCioV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:23:05 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-QRCyRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:23:05 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-nrjZN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:23:05 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-FO_zkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:23:05 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-HyOso8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:23:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:23:06 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-2dEZAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:23:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:23:06 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-E5iDRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:23:06 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)) 03:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:23:06 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-SKV_NC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:23:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:23:06 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-P2CmKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:23:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:06 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-faP2VM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:23:06 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-_o2B6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:23:06 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)) 03:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:23:06 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-y5oQPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:23:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:23:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:23:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:23:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:23:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:23:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:23:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:09 INFO - Downloading blessings-1.6.tar.gz 03:23:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:23:09 INFO - Installing collected packages: blessings 03:23:09 INFO - Running setup.py install for blessings 03:23:09 INFO - Successfully installed blessings 03:23:09 INFO - Cleaning up... 03:23:10 INFO - Return code: 0 03:23:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:23:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:23:10 INFO - Reading from file tmpfile_stdout 03:23:10 INFO - Current package versions: 03:23:10 INFO - blessings == 1.6 03:23:10 INFO - blobuploader == 1.2.4 03:23:10 INFO - docopt == 0.6.1 03:23:10 INFO - functools32 == 3.2.3-2 03:23:10 INFO - jsonschema == 2.5.1 03:23:10 INFO - manifestparser == 1.1 03:23:10 INFO - mozInstall == 1.12 03:23:10 INFO - mozcrash == 1.0 03:23:10 INFO - mozdebug == 0.1 03:23:10 INFO - mozdevice == 0.48 03:23:10 INFO - mozfile == 1.2 03:23:10 INFO - mozhttpd == 0.7 03:23:10 INFO - mozinfo == 0.9 03:23:10 INFO - mozleak == 0.1 03:23:10 INFO - mozlog == 3.4 03:23:10 INFO - moznetwork == 0.27 03:23:10 INFO - mozprocess == 0.23 03:23:10 INFO - mozprofile == 0.28 03:23:10 INFO - mozrunner == 6.13 03:23:10 INFO - mozscreenshot == 0.1 03:23:10 INFO - mozsystemmonitor == 0.3 03:23:10 INFO - moztest == 0.7 03:23:10 INFO - mozversion == 1.4 03:23:10 INFO - psutil == 3.1.1 03:23:10 INFO - requests == 1.2.3 03:23:10 INFO - wsgiref == 0.1.2 03:23:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fefe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe74570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5cbc95ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd12d30>, '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 0x10fb38db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd0ab20>, '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.BNY0KxcSvk/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.OGxQDmJI1S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:23:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:23:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BNY0KxcSvk/Render', 03:23:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:10 INFO - 'HOME': '/Users/cltbld', 03:23:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:10 INFO - 'LOGNAME': 'cltbld', 03:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:10 INFO - 'MOZ_NO_REMOTE': '1', 03:23:10 INFO - 'NO_EM_RESTART': '1', 03:23:10 INFO - 'PAGER': '/bin/cat', 03:23:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:10 INFO - 'PWD': '/builds/slave/test', 03:23:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:10 INFO - 'SHELL': '/bin/bash', 03:23:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OGxQDmJI1S/Listeners', 03:23:10 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 03:23:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:10 INFO - 'USER': 'cltbld', 03:23:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:10 INFO - 'XPC_FLAGS': '0x0', 03:23:10 INFO - 'XPC_SERVICE_NAME': '0', 03:23:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:23:10 INFO - Cleaning up... 03:23:10 INFO - Return code: 0 03:23:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fefe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe74570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5cbc95ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd12d30>, '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 0x10fb38db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd0ab20>, '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.BNY0KxcSvk/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.OGxQDmJI1S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:23:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:23:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BNY0KxcSvk/Render', 03:23:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:10 INFO - 'HOME': '/Users/cltbld', 03:23:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:10 INFO - 'LOGNAME': 'cltbld', 03:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:10 INFO - 'MOZ_NO_REMOTE': '1', 03:23:10 INFO - 'NO_EM_RESTART': '1', 03:23:10 INFO - 'PAGER': '/bin/cat', 03:23:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:10 INFO - 'PWD': '/builds/slave/test', 03:23:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:10 INFO - 'SHELL': '/bin/bash', 03:23:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OGxQDmJI1S/Listeners', 03:23:10 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 03:23:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:10 INFO - 'USER': 'cltbld', 03:23:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:10 INFO - 'XPC_FLAGS': '0x0', 03:23:10 INFO - 'XPC_SERVICE_NAME': '0', 03:23:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:23:11 INFO - Cleaning up... 03:23:11 INFO - Return code: 0 03:23:11 INFO - Running post-action listener: _resource_record_post_action 03:23:11 INFO - Running post-action listener: _start_resource_monitoring 03:23:11 INFO - Starting resource monitoring. 03:23:11 INFO - [mozharness: 2016-11-14 11:23:11.244458Z] Finished create-virtualenv step (success) 03:23:11 INFO - [mozharness: 2016-11-14 11:23:11.245440Z] Running install step. 03:23:11 INFO - Running pre-action listener: _resource_record_pre_action 03:23:11 INFO - Running main action method: install 03:23:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:23:11 INFO - Reading from file tmpfile_stdout 03:23:11 INFO - Detecting whether we're running mozinstall >=1.0... 03:23:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:23:11 INFO - Reading from file tmpfile_stdout 03:23:11 INFO - Output received: 03:23:11 INFO - Usage: mozinstall [options] installer 03:23:11 INFO - Options: 03:23:11 INFO - -h, --help show this help message and exit 03:23:11 INFO - -d DEST, --destination=DEST 03:23:11 INFO - Directory to install application into. [default: 03:23:11 INFO - "/builds/slave/test"] 03:23:11 INFO - --app=APP Application being installed. [default: firefox] 03:23:11 INFO - mkdir: /builds/slave/test/build/application 03:23:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 03:23:45 INFO - Reading from file tmpfile_stdout 03:23:45 INFO - Output received: 03:23:45 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:23:45 INFO - Running post-action listener: _resource_record_post_action 03:23:45 INFO - [mozharness: 2016-11-14 11:23:45.746700Z] Finished install step (success) 03:23:45 INFO - [mozharness: 2016-11-14 11:23:45.746840Z] Running run-tests step. 03:23:45 INFO - Running pre-action listener: _resource_record_pre_action 03:23:45 INFO - Running main action method: run_tests 03:23:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:23:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:23:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:23:45 INFO - 2016-11-14 03:23:45.761 screenresolution[1636:7422] starting screenresolution argv=screenresolution get 03:23:45 INFO - 2016-11-14 03:23:45.764 screenresolution[1636:7422] Display 0: 1600x1200x32@60 03:23:45 INFO - 2016-11-14 03:23:45.770 screenresolution[1637:7425] starting screenresolution argv=screenresolution list 03:23:45 INFO - Available Modes on Display 0 03:23:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:23:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:23:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:23:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:23:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:23:45 INFO - Intel Iris: 03:23:45 INFO - Chipset Model: Intel Iris 03:23:45 INFO - Type: GPU 03:23:45 INFO - Bus: Built-In 03:23:45 INFO - VRAM (Dynamic, Max): 1536 MB 03:23:45 INFO - Vendor: Intel (0x8086) 03:23:45 INFO - Device ID: 0x0a2e 03:23:45 INFO - Revision ID: 0x0009 03:23:45 INFO - Displays: 03:23:45 INFO - Display: 03:23:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:23:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:23:45 INFO - Display Serial Number: 1600x1200 60 03:23:45 INFO - Main Display: Yes 03:23:45 INFO - Mirror: Off 03:23:45 INFO - Online: Yes 03:23:45 INFO - Rotation: Supported 03:23:46 INFO - Return code: 0 03:23:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:23:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:23:46 INFO - Python 2.7.3 03:23:46 INFO - Return code: 0 03:23:46 INFO - grabbing minidump binary from tooltool 03:23: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')]} 03:23:46 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 0x10fd12d30>, '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 0x10fb38db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd0ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:23:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:23:46 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:23:46 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:23:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:23:46 INFO - Return code: 0 03:23:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:23:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:23:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:23:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:23:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:23:46 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/GJyOfF0mT5Scof1WhFnclQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0125', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:23:46 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/GJyOfF0mT5Scof1WhFnclQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0125 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:23:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BNY0KxcSvk/Render', 03:23:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:46 INFO - 'HOME': '/Users/cltbld', 03:23:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:46 INFO - 'LOGNAME': 'cltbld', 03:23:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:23:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:23:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:46 INFO - 'MOZ_NO_REMOTE': '1', 03:23:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:23:46 INFO - 'NO_EM_RESTART': '1', 03:23:46 INFO - 'PAGER': '/bin/cat', 03:23:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:46 INFO - 'PWD': '/builds/slave/test', 03:23:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:23:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:46 INFO - 'SHELL': '/bin/bash', 03:23:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OGxQDmJI1S/Listeners', 03:23:46 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 03:23:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:46 INFO - 'USER': 'cltbld', 03:23:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:46 INFO - 'XPC_FLAGS': '0x0', 03:23:46 INFO - 'XPC_SERVICE_NAME': '0', 03:23:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:46 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/GJyOfF0mT5Scof1WhFnclQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0125', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:23:46 INFO - mozversion application_buildid: 20161114012220 03:23:46 INFO - mozversion application_changeset: add9dada238ed99b4f93c027b535423f067d3781 03:23:46 INFO - mozversion application_display_name: Nightly 03:23:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:23:46 INFO - mozversion application_name: Firefox 03:23:46 INFO - mozversion application_remotingname: firefox 03:23:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:23:46 INFO - mozversion application_vendor: Mozilla 03:23:46 INFO - mozversion application_version: 52.0a1 03:23:46 INFO - mozversion platform_buildid: 20161114012220 03:23:46 INFO - mozversion platform_changeset: add9dada238ed99b4f93c027b535423f067d3781 03:23:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:23:46 INFO - mozversion platform_version: 52.0a1 03:23:46 INFO - using testdate: 1479122626 03:23:46 INFO - actual date: 1479122626 03:23:46 INFO - starting webserver on 'localhost:49266' 03:23:46 INFO - SUITE-START | Running 2 tests 03:23:46 INFO - TEST-START | dromaeo_css 03:23:46 INFO - operating with platform_type : mac_ 03:23:46 INFO - Initialising browser for dromaeo_css test... 03:23:46 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/tmp_stYfs/profile http://localhost:49266/getInfo.html) 03:23:49 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 03:23:49 INFO - PROCESS | 1647 | colorDepth:24 03:23:49 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 03:23:49 INFO - PROCESS | 1647 | __metrics 03:23:49 INFO - PROCESS | 1647 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:23:49 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:23:49 INFO - TEST-INFO | 1647: exit 0 03:23:49 INFO - Browser initialized. 03:23:49 INFO - Running cycle 1/1 for dromaeo_css test... 03:23:49 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/tmp_stYfs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:24:02 INFO - PROCESS | 1652 | RSS: Main: 238223360 03:24:02 INFO - PROCESS | 1652 | 03:24:53 INFO - PROCESS | 1652 | 1479122693107 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] 03:27:06 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 03:27:07 INFO - PROCESS | 1652 | RSS: Main: 373829632 03:27:07 INFO - PROCESS | 1652 | 03:30:10 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 03:30:11 INFO - PROCESS | 1652 | RSS: Main: 373784576 03:30:11 INFO - PROCESS | 1652 | 03:33:13 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 03:33:14 INFO - PROCESS | 1652 | RSS: Main: 342089728 03:33:14 INFO - PROCESS | 1652 | 03:36:16 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 03:36:17 INFO - PROCESS | 1652 | RSS: Main: 339922944 03:36:17 INFO - PROCESS | 1652 | 03:39:20 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 03:39:21 INFO - PROCESS | 1652 | RSS: Main: 329392128 03:39:21 INFO - PROCESS | 1652 | 03:42:24 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 03:42:24 INFO - PROCESS | 1652 | RSS: Main: 479260672 03:42:24 INFO - PROCESS | 1652 | 03:42:24 INFO - PROCESS | 1652 | __start_tp_report 03:42:24 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 03:42:24 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 03:42:24 INFO - PROCESS | 1652 | |i|pagename|runs| 03:42:24 INFO - PROCESS | 1652 | |0;dojo.html;3332.850021749021;3348.882789102382;3361.193313604734;3387.4749413840864;3389.57630296213;5677.977963966485;5742.9138562921535;5749.885002299951;5799.768009279624;5830.416958304168;5803.854903627412;5804.738786754596;5895;5901.90814699281;5930.940690593093;5204.8178313758835;5220.425753167148;5241.711705856176;5307.230451584518;5321.920171197435;5358.919616205741;5408.3509978802595;5413.26920865684;5416.756245968941;5417.295751552293;5126.128558145124;5374.301340825707;5404.405515393303;5405.37838148614;5488.286522752057;5191.766370513298;5236.319278493771;5264.552513036397;5292.338457692788;5355.116405793078;4447.3773671685985;5304.9734751326;5319.946800531984;5323.787048518094;5330.92003619946;5822.563307751893;5871.14868344092;5875.529957603381;5881.176635271023;5933.584649074566;6149.077638354238;6163.660998645073;6221.191245138149;6230.190075290228;6329.905051424233;6278.246610406781;6297.464715499188;6331.461825744817;6332.1135041094285;6355.904661430082;5853.0635098384055;5860.120981852713;5866.844419682791;5869.325027621878;5878.647281163144;6229.065640154013;6301.117843501914;6304.338044505353;6306.747730090745;6312.968435157794;6106.885399019288;6151.169592105009;6180.66006369645;6253.593516421418;6257.186565746424;6243.750249989949;6312.400321969406;6334.429901308904;6334.904976425358;6348.111264422984;6103.277060575968;6190.380961903864;6243.594166379171;6267.905981410283;6284.905726414107;6173.32093469718;6199.225096862892;6246.875062498724;6269.655168965751;6274.372562743781;4947.6536642434685;4971.6271279654175;4976.2286845539;4980.9252861207115;5005.1241032819835;4495.977520112378;4498.055408364215;4503;4518.932216016762;4549.272116461417;5791.507721843691;5835.153902684172;5874.5887787854435;5876.676782776903;5909.497692696083;6278.277998030194;6299.811005669837;6319.431251187415;6343.207099112611;6345;5939.762409503572;5993.9810232260625;6008.939910600925;6017.669028203403;6046.3349031606485;4705.623550116051;5312.707801070901;5402.945970540244;5417.972910135503;5451.48210919962;6286.6856657166045;6287.811365659038;6315.084312774714;6341.587796793378;6444.677766111769;6299.181106456132;6302.936970630235;6326.177596912372;6326.2092238470195;6341.365863413622;6371;6419.871602567829;6431.196100487439;6450.48396128318;6451.0645956337;6084.087386892002;6139.185504090546;6214.347493513116;6248.68756562161;6277.309495955533;6303.275123360872;6329.1139240505445;6334.208223972004;6336.20797400325;6357;6212.782552610637;6237.750489980532;6260.874782504416;6261.24865016201;6277.403646653744;6099.84750381244;6110.2550082019825;6110.40687992437;6149.446549810538;6248.687565621792;4983.3023376728015;6113.902014424272;6123.724432400463;6128.50971922254;6133.273457575459;6086.756529738761;6143.385661433821;6217.658028808459;6240.500759939285;6256.124142620128;6004;6033.034714445667;6052.182955300978;6056.818295451144;6062.636241825505 03:42:24 INFO - PROCESS | 1652 | |1;ext.html;490.2743938970324;501.9222020586809;509.2158076562097;517.622135840836;528.801699362739;29118.417631647353;38563;39709.40435893464;39879.2024159517;41427.96430089249;40350.59649403505;40882;40891.159897804595;40961;41113.7944310278;9120.680776172818;9291.024442433549;9306.86039709405;9311.068893110703;9326.440413575207;9271.490068046254;9377;9402;9407.106324899123;9440.905590944072;9348.813023739554;9409.811803763921;9410.2471802256;9426.387284826498;9428.387154834949;9339.953300233523;9372.343935924488;9404.623815047458;9417.811643767154;9429.999999999965;9158.450492970444;9194.862077068849;9246.214071803905;9265.953670231673;9267.3976191548;38774.41838372427;38884.805575971935;38978.10218978108;39117;39179;3240.238543942172;3253.9349213015844;3304.1739565108724;3313.93372132556;3326.4843949187916;29048.854755726297;29674.25814354637;30402.84798575993;30664.926727564427;30762.077137685905;3016.442941354661;3141.371725654878;3169.984150079235;3181.284211052495;3307.090550098718;487525;489948.55025724997;490836;491005;491063;59023.704881475314;59750;59780.80438391208;59787;59845.40154598398;33419.83290083534;34076.97769066932;34153.31693366119;34676.30647387038;62640.37359626436;13657.590272291847;15171.772423413657;15441.459548915735;15553.922230388776;15741.44904928322;11627.825582616268;11628;11629.53481860716;11634.185607007597;11979.401029948642;18408.81591184098;18440.262389504536;18442.815571844378;18461.261549538136;18482.907585461988;7492.250774922464;7601.809954751176;7603.2776886195725;7675.385969122457;7693.6922523099565;862.6161358195668;967.3953778888194;972.562346943864;1041.6406589400904;1057.0380953332585;25130.497390052096;28253.57619635707;29006.41987160245;29471.85264073666;29511.704882950897;1011.6206422591529;1014.9644762433279;1041.6302212714377;1067.8291473364225;1096.0190629386655;13465.798013029813;15046.398144074114;15363.231838408035;15491.922540387226;15499.612509687347;605365;610856;610974;611324;613225;55709.72145139329;56162.719186404625;56228.15657765137;56293.87412251732;57116;1304.7651422743998;1354.7222819322014;1365.474292397434;1368.7467818453617;1370.123121202451;28422.715772842006;29141.85429072841;29181.854090729412;29897.70102299036;29966.850165749904;44868.55131448644;48294.758526207144;48314.75842620764;48528.75735621299;48638.756806217156;537421;543582;544090;544518.2774086104;546061;25692.486150277262;26099.347516312246;26116.34709132287;26139.38606139447;26179.214623561325;42611;42949.78525107355;43494.56505434905;44417;44733.32900006568;30196.698033020268;36567.08582285464;36666;36849.81575092107;37936.86189414322;36151;36230.637693622724;37223.44164837584;37485.81257093697;37822.62177378301;35464;35923.640763592026;36051;36108.458373123896;36583.81708091549;32050.679493205702;32384.28851493243;32787;32791.836040819646;32867.83566082154;22365.552688946456;23878;24085.759142409053;24897.377565561004;24929.50140997206 03:42:24 INFO - PROCESS | 1652 | |2;jquery.html;301.3280384742025;347.38686218823796;369.53807740324595;371.09823129794603;399.97400168989014;14600.926995365022;14932.104073755583;15527.534173974786;15932.84067159328;20248.898755506238;18880.073588593754;19427.611447771036;19933.800661993377;20121.39635810928;20168.697469537932;5460.863478413052;5685.744141513642;5689.146628005791;5691.7723291068305;5697.145428185785;4932.432770231433;5664.631798933056;5781.913271300934;6261.968690156543;6392.808215753535;6306;6352.7141278642575;6393.808185754435;6402.6158430494315;6413.775517856876;6073.453389194971;6304.117423560705;6342.968285158591;6370.108184854124;6374.745010199586;5243.213517972296;5469.617126801126;5489.615726899118;5492.1212605982855;5509.696966666832;20415.693764593543;25581.616275755878;25625;25950;25979.74020259792;2198.5273166269167;2211.2150186683657;2289.2331069091874;2630.500204961051;3048.60368152141;10237.590496380137;14329.78505322421;14580.125192488485;14767.26163691811;15326.770098448533;1742.1898817050005;1799.7390378395191;1816.1010299901634;1866.3654357518374;1879.5395128193543;91525;106987;107449;108123.91876081217;108479;11126.61056863006;11135.220534562503;11204.831927521094;11248.437578121062;11453.885461145283;14133.575992720234;14160.645983850487;14169.929150354183;14187.006909516234;14229.359678814479;8107.391945604103;8272.627731752085;8273.83452330962;8422.157784221528;8425.831483370299;8073.273405393543;8078.542206059629;8134.389920755967;8322.583870806557;8378.49729016261;3839.788811615332;3863.845446182121;4337.783110844445;4419.823207071681;4519.254323036728;1520.8479152084703;1607.8905555166898;1874.8500119990367;1891.4892978895896;1892.48902796247;714.9392301654418;777.8910952466659;874.3267683883502;885.8715486254457;933.1508327422014;19552;20058.699119512927;21095.472613184487;21142.78857211439;21311.573768524544;863.9784005399789;969.8205831921117;980.2158273381267;992.9255305851946;1006.0894890124449;10623.787524249472;10886.836697449544;11020.338779673246;11024.50389732464;11059.889401106047;585758;594764;598675;600124;602467;129412;133648;134978;138562.30718846343;138935;919.9448033118034;921.1157289002499;950.0499500499501;953.0612346838359;955.073578628729;16669.49991500257;18329.450116496526;18346.17442215077;18358.357457488924;18465.446036618923;52723.296386501235;54201.728991354794;54348.641283968216;54822.72588637191;54881;76713;80572;80788;80927.59536202281;81334;6220.471259942956;7765;7910.050793904768;7995.440319177602;8073.83852322962;10431.426271555138;10824.56701731922;12237.69405764863;12758.362081896053;13171.60485185446;10662.413567253876;11002.779944401227;11103.611373601885;11149.498272577915;11227.024838417989;10759.193060520649;10829.29609575375;11003.33979961173;11176.552937882394;11177.72055698614;9470.43737783258;9792.069753373418;10769.838452423062;10989;11168.72078198019;7886.369090472634;7941.960290198512;7969.8406031880195;8010.158933311918;8155.755327340189;8326.167383261625;9392.624295028123;9579.952100239454;9590.808183836145;9692.951535242279 03:42:24 INFO - PROCESS | 1652 | |3;mootools.html;1478.63773375523;1504.5862387843342;1677.211710496067;1832.9633407331846;1855.4711907106478;8011.278984891359;8425.494470331785;8435.746927592174;8443.704470343531;8449.197326254012;7324.230955749649;7639.083310002794;7665.961670191641;7916.604169791516;8141.43009989301;2273.3180045986137;2280.304507125322;2309.9422514437106;2311.2257393773107;2317.617593097137;2285.4971906180613;2320.3039088273536;2335.0776443304885;2340.216027630746;2344.120954642009;2276.169198242646;2278.1456953642382;2305.804006659436;2310.341552657493;2311.7919387255142;2266.444721043347;2268.274152271257;2288.4622113803243;2291.0263138166297;2297.3452566018773;1944.6402415553168;2291.8051965582945;2306.9307920762403;2309.7690230976937;2313.9884300578556;8210.630521626541;8244.422890397675;8294.709685160991;8301.335893128595;8312.667493300261;4952.059108769322;5102.234664800272;5113.207452844815;5116.923246151311;5122.154844450662;3200.567923330344;3370.7303415726683;3552.8934131976084;3553.822308884571;3558.074900525856;1034.7826956339177;1049.7323182588468;1056.7780766039064;1062.3201151263197;1084.0677017764715;10679.519421626046;10774.515146818412;10835.67492975212;10842.241043126984;10847.132229421628;4347.7826108694435;4494.0337827367275;4615.869112067565;4628.490866004737;4634.467036290802;9131.771705707277;9325.347225694271;9327.720168394959;9331.300152488591;9341.299402544837;5120.5135512127035;5127.794888204505;5132.384113906355;5138.97430512845;5140.640155189101;4110.815013324408;4210.45264115663;4379.386885835986;4653;4699.647526435531;3632.9091772705365;3683.1528748387486;3748.962510374916;3786.659200671953;3794.962050379516;1240.2930329712158;1244.3094082784141;1256.3718140929536;1257.5724253753585;1272.204871955028;802.7591722483231;884.575832909016;887.3458709070964;904.2268860124631;929.2055292724758;5504.724763761796;5602.663840169522;5624.746886390122;5674.716264186774;5861.648301101947;424.5945122408093;426.13069338549633;934.7195841247599;963.426761077158;985.6402413119304;3016.788824782288;3738.12154143776;3776.2825063237897;3835.980820095882;3892.649661530476;9468.337216394924;9900.960399158128;10041.347312424668;10161;10178.98210178991;9966.302358834811;10117;10120.949395252977;10121.898781012243;10148.543315550818;7468.813279667943;7797.142314345418;7844.843103137905;7862.606869656494;7877.921220787948;5487.4238204987905;5541.33503979525;5542.418046105101;5548.667079975215;5689.089745640677;9107.408018478778;9280.860787088333;9365.719028429157;9378.827646544181;9495.66765163216;9293.67472138472;9492.477913714813;9543.0456954304;9606.66376676813;9624.903750962401;6233.812985610439;6462.256840463407;6478.643674597943;6640.335966403321;6786.76246331376;6819.829504262433;7420.666070026754;7673.8848917267405;8022.398320125897;8070.677172913018;7037.1555413350725;7118;7155.642217888981;7230.674619642024;7275.8908616371855;7012.474064445289;7013.088298521159;7054.4003759681;7068.823279418056;7149.82125446868;6602.273749887412;6604.735810567716;6678.595705545902;6683.398494135551;6694.263631000684;4817;4846.636502262274;4882.487338829372;4899.289603007615;4981.42713587942;4301.397804307337;4825.710457372569;4865.172920603577;4933.421305182307;4941.777620007037 03:42:24 INFO - PROCESS | 1652 | |4;prototype.html;298.7639764585977;301.17628286636045;307.9491883839167;312.0606973011235;312.7904304116242;4643.094596553665;4778.569928706415;4966.478519755419;5089.2620570017325;5302.151655735079;4913.852584422464;5028.8239911603105;5053.722045287517;5079.771410286537;5256.7897284108685;3181.325568967846;4005.499312585927;4024.4969378827645;4024.5170579530495;4069.6337329640473;3328.6685325869726;3796.2217745362273;3858.421236814472;4017.1764788218347;4038.3336749436307;3326.6340702522825;3891.440418208328;3986.302397080514;4014.799260037001;4019.457373254617;3468.8785892493893;4012.498437695288;4032.072623296629;4040.474738284004;4053.5338436079787;3169.2869104451543;3478.3825521132794;3491.6682915123024;3495.702865256431;3506.8947931562093;5098.260752190949;5100.795968161269;5112.667676601009;5168.441621397395;5189.844304670866;3841.5774264830848;4206.705530612859;4572.451305843287;4583.427071616048;4602.884927876797;4634.86095417138;4992.600591952635;5108.208227724708;5575.720055717297;5623.116256054227;3206.4228438881223;3525.7179425645886;3800.3539398302078;3821;3828.1960788234505;5199.012187684366;5299.8410047698635;5515.145152501369;5784.2769653793275;5842.620229685057;3346.5147553604593;3831.501904752364;3858.884233473;3867.323218436762;3867.497225360685;3440.8795692151157;3717.5353080864893;3894.668953139015;3905.414187871842;3912.6478616924046;4373.781310934441;4536.841210557614;4538.523455037173;4566.438178220993;4569.565891240327;5323.467653234646;5628.352739434936;5636.830895073154;5653.378128405954;5700.686462244534;1248.3071895098308;1253.8965710174987;1264.9557265495664;1266.8923141533073;1270.4473554004037;788.341734651561;814.5682788122305;815.2458975447687;842.7471758472434;855.5935930433119;4159.480064991876;4183.686223533247;4409.735415875058;4609.953900460952;4925.876853078702;4909.533594308535;5074.670146440543;5349.973250133725;5384.273123128406;5398.892022159614;3986.661133803659;4528.547145285445;4607.654425918003;4678.6491013174145;4851.757412129379;2644.048142668638;2830.066078194191;2830.716928307194;2840.3467202543115;2840.4035152617766;4348.760603228128;5304.761285742151;5493.7802487900035;5494.642848214853;5543.639663421945;4218.535961044283;4874.491095736501;5455.8363249102595;5483.533899618577;5490.835274941758;4527.547245275512;4925.729084900293;5519.503244707835;5523.7790488380815;5532.723363831792;4973.278874563096;5087.084324821568;5305.893882122413;5350.010248104113;5389.353277606712;4904.730239836843;4975.9149327417235;5248.399238232376;5318.670332416896;5371.785128594813;5143.125668636266;5150.871228219175;5514.779408823602;5552.8056518023295;5615.550755939434;3055.4194703006356;3340.365330587181;3577.5528058992627;3597.5503062117236;3606.2787442512126;4535.569120933638;4725.9054818904115;5050.545450909436;5299.788008479618;5366.463353664602;4785.49752276006;4869.683470574401;5164.870878228075;5191.650170955503;5200.5059519345605;4329.631981281626;4760.97619511914;5196.922046169235;5216;5230.895382092413;4469.994251293563;4724.929126063043;4994.225894986283;5069.467705890976;5130.179171332569;4550.314245461187;5006.924896126634;5292.603054770984;5362.570994320523;5470.59293910678;5466.223477369791;5477.67133971963;5487.420912171273;5501.587380946365;5536.667799932017 03:42:24 INFO - PROCESS | 1652 | |5;yui.html;679.229074999875;757.4319260554585;760.5930827007548;770.1912991359071;781.4803155901328;13710.520131795389;14303.713925721493;14703.632409189775;14880.702385952274;15091.169985650784;13261.336933153352;13633.045686801903;13778.655533611665;13801.51694690686;13810.309484525758;798.3054742374128;825.6986200036973;827.764087235138;828.1304630138361;828.904675962263;645.2772894358325;668.2148475541244;671.043762638241;672.1530871102422;672.7443571442869;840.8864803251574;868.1275318305095;873.0876234335103;874.2656168818191;876.8903887014123;867.3148212911792;867.5271976772674;867.5532100968038;868.7046404222594;868.934829887761;498.6860965121838;510.38498609175855;641.7433026789275;642.4699622811153;643.7360682120308;11940.462679179458;12072.396380181044;12237.571684990982;12259.325737084457;12271.815922761076;13054;13690.247036412993;13952;13964.301784910715;13975.580732578039;10023.398596084258;10031.69904902854;10131.493425328705;10248.436336001518;10373.481325933673;3136.4511210538294;3675.7978311192874;3692.372296709566;3694.2796154749835;3816.3702989007056;86966.5651671744;88564.5571772137;88698.11301886963;89085.55457222673;89491;10562.894371056345;10719.142468602493;10769.407682577534;10900.618478353219;11126.443677816076;20983.685244721342;21090.367288981353;21093.578128437344;21113.155473781186;21126.366209013755;7089.964550177319;7346.302101300368;7466.738664146729;7744.148143704188;7822.687092516236;3338.4658454647138;3527.1534831640734;3591;4005.1989602079116;4024.4164596133396;3289.687479689426;3355.8825441109934;3376.3922493951322;3387.6442973487924;3399.847006884696;644.6261168522246;670.5625990491245;680.5984469163218;683.3781259054236;687.88993760998;567.8353277549547;576.5186069631905;577.3302968556454;622.844288927759;671.2113266911359;8266.8346633067;8942.50816205102;9060.048694887073;9072.501012444247;9105.499197544066;572.4218539275362;580.7299605683378;601.6841158391879;650.1061041068531;693.6219760230687;4054.858079967246;4083.3670781028986;4141.068259641616;4190.308599081118;4270.29540125882;73059.63470182614;110353.44823275832;115923;117889;118704;67449.6627516869;67527.66236168788;80345;81598.59200703958;110864.4456777727;93004.53497732469;93412.65278576221;94725;95372.52313738388;97578;8558.058613552628;8601.440906341068;8636.438631488933;8663.350248731496;8858.73423797287;40289.79855100706;49066;51363;55867.72066139643;58033;51333.203337882995;72656.63671681608;74653.62673186816;78554.82167767602;80111;12132.91887221528;12334.75330493367;12378.566750163702;12387.75224495523;12784.54472843443;14126;14211.28943552839;14247.430102795772;14394.784078238625;14538;12981.4158362872;13182.209067455984;13339;13389.933050334686;13580.32098395096;13012.28432436225;13191.67020824487;13270.535531256359;13376.732465350444;13802.585922422344;12924.935375323063;13012.28432436225;13193.60419187426;13324.200547967153;13553.525626603021;10699.090577301016;10728.51721672511;10743.95845815864;11041.558337666404;11375.715607109889;8389.622466988878;10579.682609521727;10787;11219.046381057375;11248 03:42:24 INFO - PROCESS | 1652 | __end_tp_report 03:42:24 INFO - PROCESS | 1652 | __start_cc_report 03:42:24 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1551 03:42:24 INFO - PROCESS | 1652 | __end_cc_report 03:42:24 INFO - PROCESS | 1652 | __startTimestamp1479123744782__endTimestamp 03:42:24 INFO - PROCESS | 1652 | 03:42:24 INFO - PROCESS | 1652 | ------- Summary: start ------- 03:42:24 INFO - PROCESS | 1652 | Number of tests: 6 03:42:24 INFO - PROCESS | 1652 | 03:42:24 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5818.22 Median:6086.76 stddev:655.60 (10.8%) stddev-sans-first:627.96 03:42:24 INFO - PROCESS | 1652 | Values: 3332.9 3348.9 3361.2 3387.5 3389.6 5678.0 5742.9 5749.9 5799.8 5830.4 5803.9 5804.7 5895.0 5901.9 5930.9 5204.8 5220.4 5241.7 5307.2 5321.9 5358.9 5408.4 5413.3 5416.8 5417.3 5126.1 5374.3 5404.4 5405.4 5488.3 5191.8 5236.3 5264.6 5292.3 5355.1 4447.4 5305.0 5319.9 5323.8 5330.9 5822.6 5871.1 5875.5 5881.2 5933.6 6149.1 6163.7 6221.2 6230.2 6329.9 6278.2 6297.5 6331.5 6332.1 6355.9 5853.1 5860.1 5866.8 5869.3 5878.6 6229.1 6301.1 6304.3 6306.7 6313.0 6106.9 6151.2 6180.7 6253.6 6257.2 6243.8 6312.4 6334.4 6334.9 6348.1 6103.3 6190.4 6243.6 6267.9 6284.9 6173.3 6199.2 6246.9 6269.7 6274.4 4947.7 4971.6 4976.2 4980.9 5005.1 4496.0 4498.1 4503.0 4518.9 4549.3 5791.5 5835.2 5874.6 5876.7 5909.5 6278.3 6299.8 6319.4 6343.2 6345.0 5939.8 5994.0 6008.9 6017.7 6046.3 4705.6 5312.7 5402.9 5418.0 5451.5 6286.7 6287.8 6315.1 6341.6 6444.7 6299.2 6302.9 6326.2 6326.2 6341.4 6371.0 6419.9 6431.2 6450.5 6451.1 6084.1 6139.2 6214.3 6248.7 6277.3 6303.3 6329.1 6334.2 6336.2 6357.0 6212.8 6237.8 6260.9 6261.2 6277.4 6099.8 6110.3 6110.4 6149.4 6248.7 4983.3 6113.9 6123.7 6128.5 6133.3 6086.8 6143.4 6217.7 6240.5 6256.1 6004.0 6033.0 6052.2 6056.8 6062.6 03:42:24 INFO - PROCESS | 1652 | 03:42:24 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:67002.85 Median:37879.74 stddev:147003.01 (388.1%) stddev-sans-first:147330.57 03:42:24 INFO - PROCESS | 1652 | Values: 490.3 501.9 509.2 517.6 528.8 29118.4 38563.0 39709.4 39879.2 41428.0 40350.6 40882.0 40891.2 40961.0 41113.8 9120.7 9291.0 9306.9 9311.1 9326.4 9271.5 9377.0 9402.0 9407.1 9440.9 9348.8 9409.8 9410.2 9426.4 9428.4 9340.0 9372.3 9404.6 9417.8 9430.0 9158.5 9194.9 9246.2 9266.0 9267.4 38774.4 38884.8 38978.1 39117.0 39179.0 3240.2 3253.9 3304.2 3313.9 3326.5 29048.9 29674.3 30402.8 30664.9 30762.1 3016.4 3141.4 3170.0 3181.3 3307.1 487525.0 489948.6 490836.0 491005.0 491063.0 59023.7 59750.0 59780.8 59787.0 59845.4 33419.8 34077.0 34153.3 34676.3 62640.4 13657.6 15171.8 15441.5 15553.9 15741.4 11627.8 11628.0 11629.5 11634.2 11979.4 18408.8 18440.3 18442.8 18461.3 18482.9 7492.3 7601.8 7603.3 7675.4 7693.7 862.6 967.4 972.6 1041.6 1057.0 25130.5 28253.6 29006.4 29471.9 29511.7 1011.6 1015.0 1041.6 1067.8 1096.0 13465.8 15046.4 15363.2 15491.9 15499.6 605365.0 610856.0 610974.0 611324.0 613225.0 55709.7 56162.7 56228.2 56293.9 57116.0 1304.8 1354.7 1365.5 1368.7 1370.1 28422.7 29141.9 29181.9 29897.7 29966.9 44868.6 48294.8 48314.8 48528.8 48638.8 537421.0 543582.0 544090.0 544518.3 546061.0 25692.5 26099.3 26116.3 26139.4 26179.2 42611.0 42949.8 43494.6 44417.0 44733.3 30196.7 36567.1 36666.0 36849.8 37936.9 36151.0 36230.6 37223.4 37485.8 37822.6 35464.0 35923.6 36051.0 36108.5 36583.8 32050.7 32384.3 32787.0 32791.8 32867.8 22365.6 23878.0 24085.8 24897.4 24929.5 03:42:24 INFO - PROCESS | 1652 | 03:42:24 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:34677.79 Median:370.32 stddev:99535.46 (26878.4%) stddev-sans-first:99781.21 03:42:24 INFO - PROCESS | 1652 | Values: 301.3 347.4 369.5 371.1 400.0 14600.9 14932.1 15527.5 15932.8 20248.9 18880.1 19427.6 19933.8 20121.4 20168.7 5460.9 5685.7 5689.1 5691.8 5697.1 4932.4 5664.6 5781.9 6262.0 6392.8 6306.0 6352.7 6393.8 6402.6 6413.8 6073.5 6304.1 6343.0 6370.1 6374.7 5243.2 5469.6 5489.6 5492.1 5509.7 20415.7 25581.6 25625.0 25950.0 25979.7 2198.5 2211.2 2289.2 2630.5 3048.6 10237.6 14329.8 14580.1 14767.3 15326.8 1742.2 1799.7 1816.1 1866.4 1879.5 91525.0 106987.0 107449.0 108123.9 108479.0 11126.6 11135.2 11204.8 11248.4 11453.9 14133.6 14160.6 14169.9 14187.0 14229.4 8107.4 8272.6 8273.8 8422.2 8425.8 8073.3 8078.5 8134.4 8322.6 8378.5 3839.8 3863.8 4337.8 4419.8 4519.3 1520.8 1607.9 1874.9 1891.5 1892.5 714.9 777.9 874.3 885.9 933.2 19552.0 20058.7 21095.5 21142.8 21311.6 864.0 969.8 980.2 992.9 1006.1 10623.8 10886.8 11020.3 11024.5 11059.9 585758.0 594764.0 598675.0 600124.0 602467.0 129412.0 133648.0 134978.0 138562.3 138935.0 919.9 921.1 950.0 953.1 955.1 16669.5 18329.5 18346.2 18358.4 18465.4 52723.3 54201.7 54348.6 54822.7 54881.0 76713.0 80572.0 80788.0 80927.6 81334.0 6220.5 7765.0 7910.1 7995.4 8073.8 10431.4 10824.6 12237.7 12758.4 13171.6 10662.4 11002.8 11103.6 11149.5 11227.0 10759.2 10829.3 11003.3 11176.6 11177.7 9470.4 9792.1 10769.8 10989.0 11168.7 7886.4 7942.0 7969.8 8010.2 8155.8 8326.2 9392.6 9580.0 9590.8 9693.0 03:42:24 INFO - PROCESS | 1652 | 03:42:24 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5389.39 Median:5107.72 stddev:2964.32 (58.0%) stddev-sans-first:2958.06 03:42:24 INFO - PROCESS | 1652 | Values: 1478.6 1504.6 1677.2 1833.0 1855.5 8011.3 8425.5 8435.7 8443.7 8449.2 7324.2 7639.1 7666.0 7916.6 8141.4 2273.3 2280.3 2309.9 2311.2 2317.6 2285.5 2320.3 2335.1 2340.2 2344.1 2276.2 2278.1 2305.8 2310.3 2311.8 2266.4 2268.3 2288.5 2291.0 2297.3 1944.6 2291.8 2306.9 2309.8 2314.0 8210.6 8244.4 8294.7 8301.3 8312.7 4952.1 5102.2 5113.2 5116.9 5122.2 3200.6 3370.7 3552.9 3553.8 3558.1 1034.8 1049.7 1056.8 1062.3 1084.1 10679.5 10774.5 10835.7 10842.2 10847.1 4347.8 4494.0 4615.9 4628.5 4634.5 9131.8 9325.3 9327.7 9331.3 9341.3 5120.5 5127.8 5132.4 5139.0 5140.6 4110.8 4210.5 4379.4 4653.0 4699.6 3632.9 3683.2 3749.0 3786.7 3795.0 1240.3 1244.3 1256.4 1257.6 1272.2 802.8 884.6 887.3 904.2 929.2 5504.7 5602.7 5624.7 5674.7 5861.6 424.6 426.1 934.7 963.4 985.6 3016.8 3738.1 3776.3 3836.0 3892.6 9468.3 9901.0 10041.3 10161.0 10179.0 9966.3 10117.0 10120.9 10121.9 10148.5 7468.8 7797.1 7844.8 7862.6 7877.9 5487.4 5541.3 5542.4 5548.7 5689.1 9107.4 9280.9 9365.7 9378.8 9495.7 9293.7 9492.5 9543.0 9606.7 9624.9 6233.8 6462.3 6478.6 6640.3 6786.8 6819.8 7420.7 7673.9 8022.4 8070.7 7037.2 7118.0 7155.6 7230.7 7275.9 7012.5 7013.1 7054.4 7068.8 7149.8 6602.3 6604.7 6678.6 6683.4 6694.3 4817.0 4846.6 4882.5 4899.3 4981.4 4301.4 4825.7 4865.2 4933.4 4941.8 03:42:24 INFO - PROCESS | 1652 | 03:42:24 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4306.29 Median:4782.03 stddev:1303.11 (27.3%) stddev-sans-first:1271.58 03:42:24 INFO - PROCESS | 1652 | Values: 298.8 301.2 307.9 312.1 312.8 4643.1 4778.6 4966.5 5089.3 5302.2 4913.9 5028.8 5053.7 5079.8 5256.8 3181.3 4005.5 4024.5 4024.5 4069.6 3328.7 3796.2 3858.4 4017.2 4038.3 3326.6 3891.4 3986.3 4014.8 4019.5 3468.9 4012.5 4032.1 4040.5 4053.5 3169.3 3478.4 3491.7 3495.7 3506.9 5098.3 5100.8 5112.7 5168.4 5189.8 3841.6 4206.7 4572.5 4583.4 4602.9 4634.9 4992.6 5108.2 5575.7 5623.1 3206.4 3525.7 3800.4 3821.0 3828.2 5199.0 5299.8 5515.1 5784.3 5842.6 3346.5 3831.5 3858.9 3867.3 3867.5 3440.9 3717.5 3894.7 3905.4 3912.6 4373.8 4536.8 4538.5 4566.4 4569.6 5323.5 5628.4 5636.8 5653.4 5700.7 1248.3 1253.9 1265.0 1266.9 1270.4 788.3 814.6 815.2 842.7 855.6 4159.5 4183.7 4409.7 4610.0 4925.9 4909.5 5074.7 5350.0 5384.3 5398.9 3986.7 4528.5 4607.7 4678.6 4851.8 2644.0 2830.1 2830.7 2840.3 2840.4 4348.8 5304.8 5493.8 5494.6 5543.6 4218.5 4874.5 5455.8 5483.5 5490.8 4527.5 4925.7 5519.5 5523.8 5532.7 4973.3 5087.1 5305.9 5350.0 5389.4 4904.7 4975.9 5248.4 5318.7 5371.8 5143.1 5150.9 5514.8 5552.8 5615.6 3055.4 3340.4 3577.6 3597.6 3606.3 4535.6 4725.9 5050.5 5299.8 5366.5 4785.5 4869.7 5164.9 5191.7 5200.5 4329.6 4761.0 5196.9 5216.0 5230.9 4470.0 4724.9 4994.2 5069.5 5130.2 4550.3 5006.9 5292.6 5362.6 5470.6 5466.2 5477.7 5487.4 5501.6 5536.7 03:42:24 INFO - PROCESS | 1652 | 03:42:24 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:20134.87 Median:4069.11 stddev:29694.31 (729.7%) stddev-sans-first:29741.68 03:42:24 INFO - PROCESS | 1652 | Values: 679.2 757.4 760.6 770.2 781.5 13710.5 14303.7 14703.6 14880.7 15091.2 13261.3 13633.0 13778.7 13801.5 13810.3 798.3 825.7 827.8 828.1 828.9 645.3 668.2 671.0 672.2 672.7 840.9 868.1 873.1 874.3 876.9 867.3 867.5 867.6 868.7 868.9 498.7 510.4 641.7 642.5 643.7 11940.5 12072.4 12237.6 12259.3 12271.8 13054.0 13690.2 13952.0 13964.3 13975.6 10023.4 10031.7 10131.5 10248.4 10373.5 3136.5 3675.8 3692.4 3694.3 3816.4 86966.6 88564.6 88698.1 89085.6 89491.0 10562.9 10719.1 10769.4 10900.6 11126.4 20983.7 21090.4 21093.6 21113.2 21126.4 7090.0 7346.3 7466.7 7744.1 7822.7 3338.5 3527.2 3591.0 4005.2 4024.4 3289.7 3355.9 3376.4 3387.6 3399.8 644.6 670.6 680.6 683.4 687.9 567.8 576.5 577.3 622.8 671.2 8266.8 8942.5 9060.0 9072.5 9105.5 572.4 580.7 601.7 650.1 693.6 4054.9 4083.4 4141.1 4190.3 4270.3 73059.6 110353.4 115923.0 117889.0 118704.0 67449.7 67527.7 80345.0 81598.6 110864.4 93004.5 93412.7 94725.0 95372.5 97578.0 8558.1 8601.4 8636.4 8663.4 8858.7 40289.8 49066.0 51363.0 55867.7 58033.0 51333.2 72656.6 74653.6 78554.8 80111.0 12132.9 12334.8 12378.6 12387.8 12784.5 14126.0 14211.3 14247.4 14394.8 14538.0 12981.4 13182.2 13339.0 13389.9 13580.3 13012.3 13191.7 13270.5 13376.7 13802.6 12924.9 13012.3 13193.6 13324.2 13553.5 10699.1 10728.5 10744.0 11041.6 11375.7 8389.6 10579.7 10787.0 11219.0 11248.0 03:42:24 INFO - PROCESS | 1652 | -------- Summary: end -------- 03:42:24 INFO - PROCESS | 1652 | 03:42:25 INFO - TEST-INFO | 1652: exit 0 03:42:25 INFO - TEST-OK | dromaeo_css | took 1119088ms 03:42:25 INFO - TEST-START | kraken 03:42:25 INFO - operating with platform_type : mac_ 03:42:25 INFO - Initialising browser for kraken test... 03:42:25 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/tmpbmRZNz/profile http://localhost:49266/getInfo.html) 03:42:27 INFO - PROCESS | 1682 | __metrics Screen width/height:1600/1200 03:42:27 INFO - PROCESS | 1682 | colorDepth:24 03:42:27 INFO - PROCESS | 1682 | Browser inner width/height: 1024/689 03:42:27 INFO - PROCESS | 1682 | __metrics 03:42:27 INFO - PROCESS | 1682 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:42:27 INFO - PROCESS | 1682 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:42:28 INFO - TEST-INFO | 1682: exit 0 03:42:28 INFO - Browser initialized. 03:42:28 INFO - Running cycle 1/1 for kraken test... 03:42:28 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/tmpbmRZNz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:42:40 INFO - PROCESS | 1683 | RSS: Main: 238088192 03:42:40 INFO - PROCESS | 1683 | 03:42:43 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 03:42:44 INFO - PROCESS | 1683 | RSS: Main: 289071104 03:42:44 INFO - PROCESS | 1683 | 03:42:46 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 03:42:47 INFO - PROCESS | 1683 | RSS: Main: 289132544 03:42:47 INFO - PROCESS | 1683 | 03:42:51 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 03:42:51 INFO - PROCESS | 1683 | RSS: Main: 380846080 03:42:51 INFO - PROCESS | 1683 | 03:42:53 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 03:42:54 INFO - PROCESS | 1683 | RSS: Main: 281559040 03:42:54 INFO - PROCESS | 1683 | 03:42:56 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:42:57 INFO - PROCESS | 1683 | RSS: Main: 287010816 03:42:57 INFO - PROCESS | 1683 | 03:42:59 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 03:43:00 INFO - PROCESS | 1683 | RSS: Main: 327794688 03:43:00 INFO - PROCESS | 1683 | 03:43:03 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 03:43:04 INFO - PROCESS | 1683 | RSS: Main: 330752000 03:43:04 INFO - PROCESS | 1683 | 03:43:06 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 03:43:07 INFO - PROCESS | 1683 | RSS: Main: 327581696 03:43:07 INFO - PROCESS | 1683 | 03:43:08 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:43:09 INFO - PROCESS | 1683 | RSS: Main: 304795648 03:43:09 INFO - PROCESS | 1683 | 03:43:11 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:43:12 INFO - PROCESS | 1683 | RSS: Main: 307392512 03:43:12 INFO - PROCESS | 1683 | 03:43:14 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:43:14 INFO - PROCESS | 1683 | RSS: Main: 310697984 03:43:14 INFO - PROCESS | 1683 | 03:43:17 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:43:18 INFO - PROCESS | 1683 | RSS: Main: 327020544 03:43:18 INFO - PROCESS | 1683 | 03:43:21 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:43:22 INFO - PROCESS | 1683 | RSS: Main: 320471040 03:43:22 INFO - PROCESS | 1683 | 03:43:24 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 03:43:24 INFO - PROCESS | 1683 | RSS: Main: 364216320 03:43:24 INFO - PROCESS | 1683 | 03:43:24 INFO - PROCESS | 1683 | __start_tp_report 03:43:24 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 03:43:24 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 03:43:24 INFO - PROCESS | 1683 | |i|pagename|runs| 03:43:24 INFO - PROCESS | 1683 | |0;ai-astar;114;113;115;113;112;113;112;112;113;112 03:43:24 INFO - PROCESS | 1683 | |1;audio-beat-detection;148;113;114;151;115;114;113;112;142;113 03:43:24 INFO - PROCESS | 1683 | |2;audio-dft;183;187;183;184;185;185;180;184;185;181 03:43:24 INFO - PROCESS | 1683 | |3;audio-fft;94;76;82;100;62;60;59;59;83;57 03:43:24 INFO - PROCESS | 1683 | |4;audio-oscillator;90;71;91;70;67;70;93;91;99;126 03:43:24 INFO - PROCESS | 1683 | |5;imaging-gaussian-blur;87;85;88;86;90;129;89;86;88;85 03:43:24 INFO - PROCESS | 1683 | |6;imaging-darkroom;93;94;95;93;95;94;94;93;94;92 03:43:24 INFO - PROCESS | 1683 | |7;imaging-desaturate;82;82;79;79;81;83;85;85;83;82 03:43:24 INFO - PROCESS | 1683 | |8;json-parse-financial;55;55;53;53;54;54;54;54;53;54 03:43:24 INFO - PROCESS | 1683 | |9;json-stringify-tinderbox;66;73;72;81;75;72;71;69;70;73 03:43:24 INFO - PROCESS | 1683 | |10;stanford-crypto-aes;86;85;90;87;87;88;86;87;90;94 03:43:24 INFO - PROCESS | 1683 | |11;stanford-crypto-ccm;150;149;149;144;149;146;147;149;206;180 03:43:24 INFO - PROCESS | 1683 | |12;stanford-crypto-pbkdf2;178;221;155;216;236;174;174;171;176;177 03:43:24 INFO - PROCESS | 1683 | |13;stanford-crypto-sha256-iterative;68;69;69;68;67;69;67;68;67;66 03:43:24 INFO - PROCESS | 1683 | __end_tp_report 03:43:24 INFO - PROCESS | 1683 | __start_cc_report 03:43:24 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,2055 03:43:24 INFO - PROCESS | 1683 | __end_cc_report 03:43:24 INFO - PROCESS | 1683 | __startTimestamp1479123804489__endTimestamp 03:43:24 INFO - PROCESS | 1683 | 03:43:24 INFO - PROCESS | 1683 | ------- Summary: start ------- 03:43:24 INFO - PROCESS | 1683 | Number of tests: 14 03:43:24 INFO - PROCESS | 1683 | 03:43:24 INFO - PROCESS | 1683 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:0.99 (0.9%) stddev-sans-first:0.97 03:43:24 INFO - PROCESS | 1683 | Values: 114.0 113.0 115.0 113.0 112.0 113.0 112.0 112.0 113.0 112.0 03:43:24 INFO - PROCESS | 1683 | 03:43:24 INFO - PROCESS | 1683 | [#1] audio-beat-detection Cycles:10 Average:123.50 Median:114.50 stddev:16.38 (14.3%) stddev-sans-first:14.78 03:43:24 INFO - PROCESS | 1683 | Values: 148.0 113.0 114.0 151.0 115.0 114.0 113.0 112.0 142.0 113.0 03:43:24 INFO - PROCESS | 1683 | 03:43:24 INFO - PROCESS | 1683 | [#2] audio-dft Cycles:10 Average:183.70 Median:184.50 stddev:2.06 (1.1%) stddev-sans-first:2.17 03:43:24 INFO - PROCESS | 1683 | Values: 183.0 187.0 183.0 184.0 185.0 185.0 180.0 184.0 185.0 181.0 03:43:24 INFO - PROCESS | 1683 | 03:43:24 INFO - PROCESS | 1683 | [#3] audio-fft Cycles:10 Average:73.20 Median:69.00 stddev:15.98 (23.2%) stddev-sans-first:15.07 03:43:24 INFO - PROCESS | 1683 | Values: 94.0 76.0 82.0 100.0 62.0 60.0 59.0 59.0 83.0 57.0 03:43:24 INFO - PROCESS | 1683 | 03:43:24 INFO - PROCESS | 1683 | [#4] audio-oscillator Cycles:10 Average:86.80 Median:90.50 stddev:18.18 (20.1%) stddev-sans-first:19.25 03:43:24 INFO - PROCESS | 1683 | Values: 90.0 71.0 91.0 70.0 67.0 70.0 93.0 91.0 99.0 126.0 03:43:24 INFO - PROCESS | 1683 | 03:43:24 INFO - PROCESS | 1683 | [#5] imaging-gaussian-blur Cycles:10 Average:91.30 Median:87.50 stddev:13.35 (15.3%) stddev-sans-first:14.07 03:43:24 INFO - PROCESS | 1683 | Values: 87.0 85.0 88.0 86.0 90.0 129.0 89.0 86.0 88.0 85.0 03:43:24 INFO - PROCESS | 1683 | 03:43:24 INFO - PROCESS | 1683 | [#6] imaging-darkroom Cycles:10 Average:93.70 Median:94.00 stddev:0.95 (1.0%) stddev-sans-first:0.97 03:43:24 INFO - PROCESS | 1683 | Values: 93.0 94.0 95.0 93.0 95.0 94.0 94.0 93.0 94.0 92.0 03:43:24 INFO - PROCESS | 1683 | 03:43:24 INFO - PROCESS | 1683 | [#7] imaging-desaturate Cycles:10 Average:82.10 Median:82.50 stddev:2.08 (2.5%) stddev-sans-first:2.20 03:43:24 INFO - PROCESS | 1683 | Values: 82.0 82.0 79.0 79.0 81.0 83.0 85.0 85.0 83.0 82.0 03:43:24 INFO - PROCESS | 1683 | 03:43:24 INFO - PROCESS | 1683 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:0.74 (1.4%) stddev-sans-first:0.67 03:43:24 INFO - PROCESS | 1683 | Values: 55.0 55.0 53.0 53.0 54.0 54.0 54.0 54.0 53.0 54.0 03:43:24 INFO - PROCESS | 1683 | 03:43:24 INFO - PROCESS | 1683 | [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:72.50 stddev:3.97 (5.5%) stddev-sans-first:3.52 03:43:24 INFO - PROCESS | 1683 | Values: 66.0 73.0 72.0 81.0 75.0 72.0 71.0 69.0 70.0 73.0 03:43:24 INFO - PROCESS | 1683 | 03:43:24 INFO - PROCESS | 1683 | [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:87.50 stddev:2.67 (3.0%) stddev-sans-first:2.73 03:43:24 INFO - PROCESS | 1683 | Values: 86.0 85.0 90.0 87.0 87.0 88.0 86.0 87.0 90.0 94.0 03:43:24 INFO - PROCESS | 1683 | 03:43:24 INFO - PROCESS | 1683 | [#11] stanford-crypto-ccm Cycles:10 Average:156.90 Median:149.00 stddev:20.07 (13.5%) stddev-sans-first:21.13 03:43:24 INFO - PROCESS | 1683 | Values: 150.0 149.0 149.0 144.0 149.0 146.0 147.0 149.0 206.0 180.0 03:43:24 INFO - PROCESS | 1683 | 03:43:24 INFO - PROCESS | 1683 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.80 Median:177.50 stddev:26.48 (14.9%) stddev-sans-first:27.85 03:43:24 INFO - PROCESS | 1683 | Values: 178.0 221.0 155.0 216.0 236.0 174.0 174.0 171.0 176.0 177.0 03:43:24 INFO - PROCESS | 1683 | 03:43:24 INFO - PROCESS | 1683 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.03 (1.5%) stddev-sans-first:1.09 03:43:24 INFO - PROCESS | 1683 | Values: 68.0 69.0 69.0 68.0 67.0 69.0 67.0 68.0 67.0 66.0 03:43:24 INFO - PROCESS | 1683 | -------- Summary: end -------- 03:43:24 INFO - PROCESS | 1683 | 03:43:25 INFO - TEST-INFO | 1683: exit 0 03:43:25 INFO - TEST-OK | kraken | took 59945ms 03:43:25 INFO - SUITE-END | took 1179s 03:43:25 INFO - Completed test suite (00:19:39) 03:43:25 INFO - javascript benchmark 03:43:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3332.850021749021, 3348.882789102382, 3361.193313604734, 3387.4749413840864, 3389.57630296213, 5677.977963966485, 5742.9138562921535, 5749.885002299951, 5799.768009279624, 5830.416958304168, 5803.854903627412, 5804.738786754596, 5895.0, 5901.90814699281, 5930.940690593093, 5204.8178313758835, 5220.425753167148, 5241.711705856176, 5307.230451584518, 5321.920171197435, 5358.919616205741, 5408.3509978802595, 5413.26920865684, 5416.756245968941, 5417.295751552293, 5126.128558145124, 5374.301340825707, 5404.405515393303, 5405.37838148614, 5488.286522752057, 5191.766370513298, 5236.319278493771, 5264.552513036397, 5292.338457692788, 5355.116405793078, 4447.3773671685985, 5304.9734751326, 5319.946800531984, 5323.787048518094, 5330.92003619946, 5822.563307751893, 5871.14868344092, 5875.529957603381, 5881.176635271023, 5933.584649074566, 6149.077638354238, 6163.660998645073, 6221.191245138149, 6230.190075290228, 6329.905051424233, 6278.246610406781, 6297.464715499188, 6331.461825744817, 6332.1135041094285, 6355.904661430082, 5853.0635098384055, 5860.120981852713, 5866.844419682791, 5869.325027621878, 5878.647281163144, 6229.065640154013, 6301.117843501914, 6304.338044505353, 6306.747730090745, 6312.968435157794, 6106.885399019288, 6151.169592105009, 6180.66006369645, 6253.593516421418, 6257.186565746424, 6243.750249989949, 6312.400321969406, 6334.429901308904, 6334.904976425358, 6348.111264422984, 6103.277060575968, 6190.380961903864, 6243.594166379171, 6267.905981410283, 6284.905726414107, 6173.32093469718, 6199.225096862892, 6246.875062498724, 6269.655168965751, 6274.372562743781, 4947.6536642434685, 4971.6271279654175, 4976.2286845539, 4980.9252861207115, 5005.1241032819835, 4495.977520112378, 4498.055408364215, 4503.0, 4518.932216016762, 4549.272116461417, 5791.507721843691, 5835.153902684172, 5874.5887787854435, 5876.676782776903, 5909.497692696083, 6278.277998030194, 6299.811005669837, 6319.431251187415, 6343.207099112611, 6345.0, 5939.762409503572, 5993.9810232260625, 6008.939910600925, 6017.669028203403, 6046.3349031606485, 4705.623550116051, 5312.707801070901, 5402.945970540244, 5417.972910135503, 5451.48210919962, 6286.6856657166045, 6287.811365659038, 6315.084312774714, 6341.587796793378, 6444.677766111769, 6299.181106456132, 6302.936970630235, 6326.177596912372, 6326.2092238470195, 6341.365863413622, 6371.0, 6419.871602567829, 6431.196100487439, 6450.48396128318, 6451.0645956337, 6084.087386892002, 6139.185504090546, 6214.347493513116, 6248.68756562161, 6277.309495955533, 6303.275123360872, 6329.1139240505445, 6334.208223972004, 6336.20797400325, 6357.0, 6212.782552610637, 6237.750489980532, 6260.874782504416, 6261.24865016201, 6277.403646653744, 6099.84750381244, 6110.2550082019825, 6110.40687992437, 6149.446549810538, 6248.687565621792, 4983.3023376728015, 6113.902014424272, 6123.724432400463, 6128.50971922254, 6133.273457575459, 6086.756529738761, 6143.385661433821, 6217.658028808459, 6240.500759939285, 6256.124142620128, 6004.0, 6033.034714445667, 6052.182955300978, 6056.818295451144, 6062.636241825505], "value": 5775.50231884428, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.2743938970324, 501.9222020586809, 509.2158076562097, 517.622135840836, 528.801699362739, 29118.417631647353, 38563.0, 39709.40435893464, 39879.2024159517, 41427.96430089249, 40350.59649403505, 40882.0, 40891.159897804595, 40961.0, 41113.7944310278, 9120.680776172818, 9291.024442433549, 9306.86039709405, 9311.068893110703, 9326.440413575207, 9271.490068046254, 9377.0, 9402.0, 9407.106324899123, 9440.905590944072, 9348.813023739554, 9409.811803763921, 9410.2471802256, 9426.387284826498, 9428.387154834949, 9339.953300233523, 9372.343935924488, 9404.623815047458, 9417.811643767154, 9429.999999999965, 9158.450492970444, 9194.862077068849, 9246.214071803905, 9265.953670231673, 9267.3976191548, 38774.41838372427, 38884.805575971935, 38978.10218978108, 39117.0, 39179.0, 3240.238543942172, 3253.9349213015844, 3304.1739565108724, 3313.93372132556, 3326.4843949187916, 29048.854755726297, 29674.25814354637, 30402.84798575993, 30664.926727564427, 30762.077137685905, 3016.442941354661, 3141.371725654878, 3169.984150079235, 3181.284211052495, 3307.090550098718, 487525.0, 489948.55025724997, 490836.0, 491005.0, 491063.0, 59023.704881475314, 59750.0, 59780.80438391208, 59787.0, 59845.40154598398, 33419.83290083534, 34076.97769066932, 34153.31693366119, 34676.30647387038, 62640.37359626436, 13657.590272291847, 15171.772423413657, 15441.459548915735, 15553.922230388776, 15741.44904928322, 11627.825582616268, 11628.0, 11629.53481860716, 11634.185607007597, 11979.401029948642, 18408.81591184098, 18440.262389504536, 18442.815571844378, 18461.261549538136, 18482.907585461988, 7492.250774922464, 7601.809954751176, 7603.2776886195725, 7675.385969122457, 7693.6922523099565, 862.6161358195668, 967.3953778888194, 972.562346943864, 1041.6406589400904, 1057.0380953332585, 25130.497390052096, 28253.57619635707, 29006.41987160245, 29471.85264073666, 29511.704882950897, 1011.6206422591529, 1014.9644762433279, 1041.6302212714377, 1067.8291473364225, 1096.0190629386655, 13465.798013029813, 15046.398144074114, 15363.231838408035, 15491.922540387226, 15499.612509687347, 605365.0, 610856.0, 610974.0, 611324.0, 613225.0, 55709.72145139329, 56162.719186404625, 56228.15657765137, 56293.87412251732, 57116.0, 1304.7651422743998, 1354.7222819322014, 1365.474292397434, 1368.7467818453617, 1370.123121202451, 28422.715772842006, 29141.85429072841, 29181.854090729412, 29897.70102299036, 29966.850165749904, 44868.55131448644, 48294.758526207144, 48314.75842620764, 48528.75735621299, 48638.756806217156, 537421.0, 543582.0, 544090.0, 544518.2774086104, 546061.0, 25692.486150277262, 26099.347516312246, 26116.34709132287, 26139.38606139447, 26179.214623561325, 42611.0, 42949.78525107355, 43494.56505434905, 44417.0, 44733.32900006568, 30196.698033020268, 36567.08582285464, 36666.0, 36849.81575092107, 37936.86189414322, 36151.0, 36230.637693622724, 37223.44164837584, 37485.81257093697, 37822.62177378301, 35464.0, 35923.640763592026, 36051.0, 36108.458373123896, 36583.81708091549, 32050.679493205702, 32384.28851493243, 32787.0, 32791.836040819646, 32867.83566082154, 22365.552688946456, 23878.0, 24085.759142409053, 24897.377565561004, 24929.50140997206], "value": 19087.373152924185, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.3280384742025, 347.38686218823796, 369.53807740324595, 371.09823129794603, 399.97400168989014, 14600.926995365022, 14932.104073755583, 15527.534173974786, 15932.84067159328, 20248.898755506238, 18880.073588593754, 19427.611447771036, 19933.800661993377, 20121.39635810928, 20168.697469537932, 5460.863478413052, 5685.744141513642, 5689.146628005791, 5691.7723291068305, 5697.145428185785, 4932.432770231433, 5664.631798933056, 5781.913271300934, 6261.968690156543, 6392.808215753535, 6306.0, 6352.7141278642575, 6393.808185754435, 6402.6158430494315, 6413.775517856876, 6073.453389194971, 6304.117423560705, 6342.968285158591, 6370.108184854124, 6374.745010199586, 5243.213517972296, 5469.617126801126, 5489.615726899118, 5492.1212605982855, 5509.696966666832, 20415.693764593543, 25581.616275755878, 25625.0, 25950.0, 25979.74020259792, 2198.5273166269167, 2211.2150186683657, 2289.2331069091874, 2630.500204961051, 3048.60368152141, 10237.590496380137, 14329.78505322421, 14580.125192488485, 14767.26163691811, 15326.770098448533, 1742.1898817050005, 1799.7390378395191, 1816.1010299901634, 1866.3654357518374, 1879.5395128193543, 91525.0, 106987.0, 107449.0, 108123.91876081217, 108479.0, 11126.61056863006, 11135.220534562503, 11204.831927521094, 11248.437578121062, 11453.885461145283, 14133.575992720234, 14160.645983850487, 14169.929150354183, 14187.006909516234, 14229.359678814479, 8107.391945604103, 8272.627731752085, 8273.83452330962, 8422.157784221528, 8425.831483370299, 8073.273405393543, 8078.542206059629, 8134.389920755967, 8322.583870806557, 8378.49729016261, 3839.788811615332, 3863.845446182121, 4337.783110844445, 4419.823207071681, 4519.254323036728, 1520.8479152084703, 1607.8905555166898, 1874.8500119990367, 1891.4892978895896, 1892.48902796247, 714.9392301654418, 777.8910952466659, 874.3267683883502, 885.8715486254457, 933.1508327422014, 19552.0, 20058.699119512927, 21095.472613184487, 21142.78857211439, 21311.573768524544, 863.9784005399789, 969.8205831921117, 980.2158273381267, 992.9255305851946, 1006.0894890124449, 10623.787524249472, 10886.836697449544, 11020.338779673246, 11024.50389732464, 11059.889401106047, 585758.0, 594764.0, 598675.0, 600124.0, 602467.0, 129412.0, 133648.0, 134978.0, 138562.30718846343, 138935.0, 919.9448033118034, 921.1157289002499, 950.0499500499501, 953.0612346838359, 955.073578628729, 16669.49991500257, 18329.450116496526, 18346.17442215077, 18358.357457488924, 18465.446036618923, 52723.296386501235, 54201.728991354794, 54348.641283968216, 54822.72588637191, 54881.0, 76713.0, 80572.0, 80788.0, 80927.59536202281, 81334.0, 6220.471259942956, 7765.0, 7910.050793904768, 7995.440319177602, 8073.83852322962, 10431.426271555138, 10824.56701731922, 12237.69405764863, 12758.362081896053, 13171.60485185446, 10662.413567253876, 11002.779944401227, 11103.611373601885, 11149.498272577915, 11227.024838417989, 10759.193060520649, 10829.29609575375, 11003.33979961173, 11176.552937882394, 11177.72055698614, 9470.43737783258, 9792.069753373418, 10769.838452423062, 10989.0, 11168.72078198019, 7886.369090472634, 7941.960290198512, 7969.8406031880195, 8010.158933311918, 8155.755327340189, 8326.167383261625, 9392.624295028123, 9579.952100239454, 9590.808183836145, 9692.951535242279], "value": 9373.13693494211, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1478.63773375523, 1504.5862387843342, 1677.211710496067, 1832.9633407331846, 1855.4711907106478, 8011.278984891359, 8425.494470331785, 8435.746927592174, 8443.704470343531, 8449.197326254012, 7324.230955749649, 7639.083310002794, 7665.961670191641, 7916.604169791516, 8141.43009989301, 2273.3180045986137, 2280.304507125322, 2309.9422514437106, 2311.2257393773107, 2317.617593097137, 2285.4971906180613, 2320.3039088273536, 2335.0776443304885, 2340.216027630746, 2344.120954642009, 2276.169198242646, 2278.1456953642382, 2305.804006659436, 2310.341552657493, 2311.7919387255142, 2266.444721043347, 2268.274152271257, 2288.4622113803243, 2291.0263138166297, 2297.3452566018773, 1944.6402415553168, 2291.8051965582945, 2306.9307920762403, 2309.7690230976937, 2313.9884300578556, 8210.630521626541, 8244.422890397675, 8294.709685160991, 8301.335893128595, 8312.667493300261, 4952.059108769322, 5102.234664800272, 5113.207452844815, 5116.923246151311, 5122.154844450662, 3200.567923330344, 3370.7303415726683, 3552.8934131976084, 3553.822308884571, 3558.074900525856, 1034.7826956339177, 1049.7323182588468, 1056.7780766039064, 1062.3201151263197, 1084.0677017764715, 10679.519421626046, 10774.515146818412, 10835.67492975212, 10842.241043126984, 10847.132229421628, 4347.7826108694435, 4494.0337827367275, 4615.869112067565, 4628.490866004737, 4634.467036290802, 9131.771705707277, 9325.347225694271, 9327.720168394959, 9331.300152488591, 9341.299402544837, 5120.5135512127035, 5127.794888204505, 5132.384113906355, 5138.97430512845, 5140.640155189101, 4110.815013324408, 4210.45264115663, 4379.386885835986, 4653.0, 4699.647526435531, 3632.9091772705365, 3683.1528748387486, 3748.962510374916, 3786.659200671953, 3794.962050379516, 1240.2930329712158, 1244.3094082784141, 1256.3718140929536, 1257.5724253753585, 1272.204871955028, 802.7591722483231, 884.575832909016, 887.3458709070964, 904.2268860124631, 929.2055292724758, 5504.724763761796, 5602.663840169522, 5624.746886390122, 5674.716264186774, 5861.648301101947, 424.5945122408093, 426.13069338549633, 934.7195841247599, 963.426761077158, 985.6402413119304, 3016.788824782288, 3738.12154143776, 3776.2825063237897, 3835.980820095882, 3892.649661530476, 9468.337216394924, 9900.960399158128, 10041.347312424668, 10161.0, 10178.98210178991, 9966.302358834811, 10117.0, 10120.949395252977, 10121.898781012243, 10148.543315550818, 7468.813279667943, 7797.142314345418, 7844.843103137905, 7862.606869656494, 7877.921220787948, 5487.4238204987905, 5541.33503979525, 5542.418046105101, 5548.667079975215, 5689.089745640677, 9107.408018478778, 9280.860787088333, 9365.719028429157, 9378.827646544181, 9495.66765163216, 9293.67472138472, 9492.477913714813, 9543.0456954304, 9606.66376676813, 9624.903750962401, 6233.812985610439, 6462.256840463407, 6478.643674597943, 6640.335966403321, 6786.76246331376, 6819.829504262433, 7420.666070026754, 7673.8848917267405, 8022.398320125897, 8070.677172913018, 7037.1555413350725, 7118.0, 7155.642217888981, 7230.674619642024, 7275.8908616371855, 7012.474064445289, 7013.088298521159, 7054.4003759681, 7068.823279418056, 7149.82125446868, 6602.273749887412, 6604.735810567716, 6678.595705545902, 6683.398494135551, 6694.263631000684, 4817.0, 4846.636502262274, 4882.487338829372, 4899.289603007615, 4981.42713587942, 4301.397804307337, 4825.710457372569, 4865.172920603577, 4933.421305182307, 4941.777620007037], "value": 4356.3444211548085, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.7639764585977, 301.17628286636045, 307.9491883839167, 312.0606973011235, 312.7904304116242, 4643.094596553665, 4778.569928706415, 4966.478519755419, 5089.2620570017325, 5302.151655735079, 4913.852584422464, 5028.8239911603105, 5053.722045287517, 5079.771410286537, 5256.7897284108685, 3181.325568967846, 4005.499312585927, 4024.4969378827645, 4024.5170579530495, 4069.6337329640473, 3328.6685325869726, 3796.2217745362273, 3858.421236814472, 4017.1764788218347, 4038.3336749436307, 3326.6340702522825, 3891.440418208328, 3986.302397080514, 4014.799260037001, 4019.457373254617, 3468.8785892493893, 4012.498437695288, 4032.072623296629, 4040.474738284004, 4053.5338436079787, 3169.2869104451543, 3478.3825521132794, 3491.6682915123024, 3495.702865256431, 3506.8947931562093, 5098.260752190949, 5100.795968161269, 5112.667676601009, 5168.441621397395, 5189.844304670866, 3841.5774264830848, 4206.705530612859, 4572.451305843287, 4583.427071616048, 4602.884927876797, 4634.86095417138, 4992.600591952635, 5108.208227724708, 5575.720055717297, 5623.116256054227, 3206.4228438881223, 3525.7179425645886, 3800.3539398302078, 3821.0, 3828.1960788234505, 5199.012187684366, 5299.8410047698635, 5515.145152501369, 5784.2769653793275, 5842.620229685057, 3346.5147553604593, 3831.501904752364, 3858.884233473, 3867.323218436762, 3867.497225360685, 3440.8795692151157, 3717.5353080864893, 3894.668953139015, 3905.414187871842, 3912.6478616924046, 4373.781310934441, 4536.841210557614, 4538.523455037173, 4566.438178220993, 4569.565891240327, 5323.467653234646, 5628.352739434936, 5636.830895073154, 5653.378128405954, 5700.686462244534, 1248.3071895098308, 1253.8965710174987, 1264.9557265495664, 1266.8923141533073, 1270.4473554004037, 788.341734651561, 814.5682788122305, 815.2458975447687, 842.7471758472434, 855.5935930433119, 4159.480064991876, 4183.686223533247, 4409.735415875058, 4609.953900460952, 4925.876853078702, 4909.533594308535, 5074.670146440543, 5349.973250133725, 5384.273123128406, 5398.892022159614, 3986.661133803659, 4528.547145285445, 4607.654425918003, 4678.6491013174145, 4851.757412129379, 2644.048142668638, 2830.066078194191, 2830.716928307194, 2840.3467202543115, 2840.4035152617766, 4348.760603228128, 5304.761285742151, 5493.7802487900035, 5494.642848214853, 5543.639663421945, 4218.535961044283, 4874.491095736501, 5455.8363249102595, 5483.533899618577, 5490.835274941758, 4527.547245275512, 4925.729084900293, 5519.503244707835, 5523.7790488380815, 5532.723363831792, 4973.278874563096, 5087.084324821568, 5305.893882122413, 5350.010248104113, 5389.353277606712, 4904.730239836843, 4975.9149327417235, 5248.399238232376, 5318.670332416896, 5371.785128594813, 5143.125668636266, 5150.871228219175, 5514.779408823602, 5552.8056518023295, 5615.550755939434, 3055.4194703006356, 3340.365330587181, 3577.5528058992627, 3597.5503062117236, 3606.2787442512126, 4535.569120933638, 4725.9054818904115, 5050.545450909436, 5299.788008479618, 5366.463353664602, 4785.49752276006, 4869.683470574401, 5164.870878228075, 5191.650170955503, 5200.5059519345605, 4329.631981281626, 4760.97619511914, 5196.922046169235, 5216.0, 5230.895382092413, 4469.994251293563, 4724.929126063043, 4994.225894986283, 5069.467705890976, 5130.179171332569, 4550.314245461187, 5006.924896126634, 5292.603054770984, 5362.570994320523, 5470.59293910678, 5466.223477369791, 5477.67133971963, 5487.420912171273, 5501.587380946365, 5536.667799932017], "value": 3893.813169172481, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.229074999875, 757.4319260554585, 760.5930827007548, 770.1912991359071, 781.4803155901328, 13710.520131795389, 14303.713925721493, 14703.632409189775, 14880.702385952274, 15091.169985650784, 13261.336933153352, 13633.045686801903, 13778.655533611665, 13801.51694690686, 13810.309484525758, 798.3054742374128, 825.6986200036973, 827.764087235138, 828.1304630138361, 828.904675962263, 645.2772894358325, 668.2148475541244, 671.043762638241, 672.1530871102422, 672.7443571442869, 840.8864803251574, 868.1275318305095, 873.0876234335103, 874.2656168818191, 876.8903887014123, 867.3148212911792, 867.5271976772674, 867.5532100968038, 868.7046404222594, 868.934829887761, 498.6860965121838, 510.38498609175855, 641.7433026789275, 642.4699622811153, 643.7360682120308, 11940.462679179458, 12072.396380181044, 12237.571684990982, 12259.325737084457, 12271.815922761076, 13054.0, 13690.247036412993, 13952.0, 13964.301784910715, 13975.580732578039, 10023.398596084258, 10031.69904902854, 10131.493425328705, 10248.436336001518, 10373.481325933673, 3136.4511210538294, 3675.7978311192874, 3692.372296709566, 3694.2796154749835, 3816.3702989007056, 86966.5651671744, 88564.5571772137, 88698.11301886963, 89085.55457222673, 89491.0, 10562.894371056345, 10719.142468602493, 10769.407682577534, 10900.618478353219, 11126.443677816076, 20983.685244721342, 21090.367288981353, 21093.578128437344, 21113.155473781186, 21126.366209013755, 7089.964550177319, 7346.302101300368, 7466.738664146729, 7744.148143704188, 7822.687092516236, 3338.4658454647138, 3527.1534831640734, 3591.0, 4005.1989602079116, 4024.4164596133396, 3289.687479689426, 3355.8825441109934, 3376.3922493951322, 3387.6442973487924, 3399.847006884696, 644.6261168522246, 670.5625990491245, 680.5984469163218, 683.3781259054236, 687.88993760998, 567.8353277549547, 576.5186069631905, 577.3302968556454, 622.844288927759, 671.2113266911359, 8266.8346633067, 8942.50816205102, 9060.048694887073, 9072.501012444247, 9105.499197544066, 572.4218539275362, 580.7299605683378, 601.6841158391879, 650.1061041068531, 693.6219760230687, 4054.858079967246, 4083.3670781028986, 4141.068259641616, 4190.308599081118, 4270.29540125882, 73059.63470182614, 110353.44823275832, 115923.0, 117889.0, 118704.0, 67449.6627516869, 67527.66236168788, 80345.0, 81598.59200703958, 110864.4456777727, 93004.53497732469, 93412.65278576221, 94725.0, 95372.52313738388, 97578.0, 8558.058613552628, 8601.440906341068, 8636.438631488933, 8663.350248731496, 8858.73423797287, 40289.79855100706, 49066.0, 51363.0, 55867.72066139643, 58033.0, 51333.203337882995, 72656.63671681608, 74653.62673186816, 78554.82167767602, 80111.0, 12132.91887221528, 12334.75330493367, 12378.566750163702, 12387.75224495523, 12784.54472843443, 14126.0, 14211.28943552839, 14247.430102795772, 14394.784078238625, 14538.0, 12981.4158362872, 13182.209067455984, 13339.0, 13389.933050334686, 13580.32098395096, 13012.28432436225, 13191.67020824487, 13270.535531256359, 13376.732465350444, 13802.585922422344, 12924.935375323063, 13012.28432436225, 13193.60419187426, 13324.200547967153, 13553.525626603021, 10699.090577301016, 10728.51721672511, 10743.95845815864, 11041.558337666404, 11375.715607109889, 8389.622466988878, 10579.682609521727, 10787.0, 11219.046381057375, 11248.0], "value": 7116.285077673099, "unit": "score"}], "name": "dromaeo_css", "value": 7068.651522774147, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 115.0, 113.0, 112.0, 113.0, 112.0, 112.0, 113.0, 112.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 113.0, 114.0, 151.0, 115.0, 114.0, 113.0, 112.0, 142.0, 113.0], "value": 123.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 187.0, 183.0, 184.0, 185.0, 185.0, 180.0, 184.0, 185.0, 181.0], "value": 183.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 76.0, 82.0, 100.0, 62.0, 60.0, 59.0, 59.0, 83.0, 57.0], "value": 73.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 91.0, 70.0, 67.0, 70.0, 93.0, 91.0, 99.0, 126.0], "value": 86.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 88.0, 86.0, 90.0, 129.0, 89.0, 86.0, 88.0, 85.0], "value": 91.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 95.0, 93.0, 95.0, 94.0, 94.0, 93.0, 94.0, 92.0], "value": 93.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 79.0, 79.0, 81.0, 83.0, 85.0, 85.0, 83.0, 82.0], "value": 82.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 53.0, 53.0, 54.0, 54.0, 54.0, 54.0, 53.0, 54.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 73.0, 72.0, 81.0, 75.0, 72.0, 71.0, 69.0, 70.0, 73.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 90.0, 87.0, 87.0, 88.0, 86.0, 87.0, 90.0, 94.0], "value": 88.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 149.0, 144.0, 149.0, 146.0, 147.0, 149.0, 206.0, 180.0], "value": 156.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 221.0, 155.0, 216.0, 236.0, 174.0, 174.0, 171.0, 176.0, 177.0], "value": 187.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 68.0, 67.0, 69.0, 67.0, 68.0, 67.0, 66.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1473.8000000000002, "alertThreshold": 2.0}]} 03:43:25 INFO - Return code: 0 03:43:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:43:25 INFO - # TBPL SUCCESS # 03:43:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:43:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:43:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:43:25 INFO - 2016-11-14 03:43:25.784 screenresolution[1687:9670] starting screenresolution argv=screenresolution get 03:43:25 INFO - 2016-11-14 03:43:25.787 screenresolution[1687:9670] Display 0: 1600x1200x32@60 03:43:25 INFO - 2016-11-14 03:43:25.793 screenresolution[1688:9673] starting screenresolution argv=screenresolution list 03:43:25 INFO - Available Modes on Display 0 03:43:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:43:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:43:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:43:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:43:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:43:26 INFO - Intel Iris: 03:43:26 INFO - Chipset Model: Intel Iris 03:43:26 INFO - Type: GPU 03:43:26 INFO - Bus: Built-In 03:43:26 INFO - VRAM (Dynamic, Max): 1536 MB 03:43:26 INFO - Vendor: Intel (0x8086) 03:43:26 INFO - Device ID: 0x0a2e 03:43:26 INFO - Revision ID: 0x0009 03:43:26 INFO - Displays: 03:43:26 INFO - Display: 03:43:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:43:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:43:26 INFO - Display Serial Number: 1600x1200 60 03:43:26 INFO - Main Display: Yes 03:43:26 INFO - Mirror: Off 03:43:26 INFO - Online: Yes 03:43:26 INFO - Rotation: Supported 03:43:26 INFO - Return code: 0 03:43:26 INFO - Running post-action listener: _resource_record_post_action 03:43:26 INFO - [mozharness: 2016-11-14 11:43:26.031222Z] Finished run-tests step (success) 03:43:26 INFO - Running post-run listener: _resource_record_post_run 03:43:26 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 38740992; Write bytes: 701097984; Read time: 413; Write time: 1901 03:43:26 INFO - TinderboxPrint: CPU usage
53.7% 03:43:26 INFO - TinderboxPrint: I/O read bytes / time
38,740,992 / 413 03:43:26 INFO - TinderboxPrint: I/O write bytes / time
701,097,984 / 1,901 03:43:26 INFO - TinderboxPrint: CPU idle
2,250.5 (46.3%) 03:43:26 INFO - TinderboxPrint: CPU system
971.5 (20.0%) 03:43:26 INFO - TinderboxPrint: CPU user
1,635.7 (33.7%) 03:43:26 INFO - TinderboxPrint: Swap in / out
437,215,232 / 0 03:43:26 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 389943808; Write bytes: 384686080; Read time: 29181; Write time: 749 03:43:26 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 36709376; Write bytes: 298135552; Read time: 368; Write time: 1108 03:43:26 INFO - Running post-run listener: _upload_blobber_files 03:43:26 INFO - Blob upload gear active. 03:43:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:43:26 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:43:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:43:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:43:26 INFO - (blobuploader) - INFO - Open directory for files ... 03:43:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:43:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:43:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:27 INFO - (blobuploader) - INFO - Done attempting. 03:43:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:43:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:43:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:29 INFO - (blobuploader) - INFO - Done attempting. 03:43:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:43:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:43:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:31 INFO - (blobuploader) - INFO - Done attempting. 03:43:31 INFO - (blobuploader) - INFO - Iteration through files over. 03:43:31 INFO - Return code: 0 03:43:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:43:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:43:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56727b977f852a3745ec1ee168f9ffcba19cce0b16294fa9b27bcb5b61c189932425b2e16af4fd0be01f451ee8093f868efcd8137f0b1f54f4a7cc8b3efe73bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1da656418bd6b00973d644ff030b38326441e12314d08c7189fad85075b13c15f91aca73ec69a073d368fe6503de10b8ba707f93a2c082aa6ad8b38ddf548dbf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1effe9c47e6843d1ab6b281f4a8f75322be9f0e994372b3f3b818ce2b42f19fd8fbf3bb0de26c7772bd644acf53b46148460f9733eef467f516d2b24c0c7f24e"} 03:43:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:43:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:43:31 INFO - Contents: 03:43:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56727b977f852a3745ec1ee168f9ffcba19cce0b16294fa9b27bcb5b61c189932425b2e16af4fd0be01f451ee8093f868efcd8137f0b1f54f4a7cc8b3efe73bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1da656418bd6b00973d644ff030b38326441e12314d08c7189fad85075b13c15f91aca73ec69a073d368fe6503de10b8ba707f93a2c082aa6ad8b38ddf548dbf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1effe9c47e6843d1ab6b281f4a8f75322be9f0e994372b3f3b818ce2b42f19fd8fbf3bb0de26c7772bd644acf53b46148460f9733eef467f516d2b24c0c7f24e"} 03:43:31 INFO - Running post-run listener: copy_logs_to_upload_dir 03:43:31 INFO - Copying logs to upload dir... 03:43:31 INFO - mkdir: /builds/slave/test/build/upload/logs 03:43:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.418085 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-11-14 03:43:31.344390) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 03:43:31.348404) ========= 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.BNY0KxcSvk/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.OGxQDmJI1S/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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/56727b977f852a3745ec1ee168f9ffcba19cce0b16294fa9b27bcb5b61c189932425b2e16af4fd0be01f451ee8093f868efcd8137f0b1f54f4a7cc8b3efe73bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1da656418bd6b00973d644ff030b38326441e12314d08c7189fad85075b13c15f91aca73ec69a073d368fe6503de10b8ba707f93a2c082aa6ad8b38ddf548dbf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1effe9c47e6843d1ab6b281f4a8f75322be9f0e994372b3f3b818ce2b42f19fd8fbf3bb0de26c7772bd644acf53b46148460f9733eef467f516d2b24c0c7f24e"} build_url:https://queue.taskcluster.net/v1/task/GJyOfF0mT5Scof1WhFnclQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011258 build_url: 'https://queue.taskcluster.net/v1/task/GJyOfF0mT5Scof1WhFnclQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56727b977f852a3745ec1ee168f9ffcba19cce0b16294fa9b27bcb5b61c189932425b2e16af4fd0be01f451ee8093f868efcd8137f0b1f54f4a7cc8b3efe73bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1da656418bd6b00973d644ff030b38326441e12314d08c7189fad85075b13c15f91aca73ec69a073d368fe6503de10b8ba707f93a2c082aa6ad8b38ddf548dbf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1effe9c47e6843d1ab6b281f4a8f75322be9f0e994372b3f3b818ce2b42f19fd8fbf3bb0de26c7772bd644acf53b46148460f9733eef467f516d2b24c0c7f24e"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 03:43:31.386116) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 03:43:31.386482) ========= 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.BNY0KxcSvk/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.OGxQDmJI1S/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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.004883 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 03:43:31.434975) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 03:43:31.435262) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 03:43:31.435540) ========= ========= Total master_lag: 0.17 =========