builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0219 starttime: 1476446637.99 results: success (0) buildid: 20161014025735 builduid: 66333b3435d245078e8d5b08ae53cde5 revision: 3a35f6cea288558cd0433f1b8b00c02e8bc3e4da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 05:03:57.987753) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 05:03:57.988192) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 05:03:57.988491) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 05:03:58.015208) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 05:03:58.015530) ========= 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.uVptKz2GVZ/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.5w22Nk0YOQ/Listeners TMPDIR=/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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-10-14 05:03:58-- 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% 24.2M=0s 2016-10-14 05:03:58 (24.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.105934 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 05:03:58.143330) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 05:03:58.146653) ========= 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.uVptKz2GVZ/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.5w22Nk0YOQ/Listeners TMPDIR=/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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.025818 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 05:03:58.195019) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-14 05:03:58.198385) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3a35f6cea288558cd0433f1b8b00c02e8bc3e4da --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 3a35f6cea288558cd0433f1b8b00c02e8bc3e4da --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uVptKz2GVZ/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.5w22Nk0YOQ/Listeners TMPDIR=/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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-10-14 05:03:58,484 truncating revision to first 12 chars 2016-10-14 05:03:58,484 Setting DEBUG logging. 2016-10-14 05:03:58,484 attempt 1/10 2016-10-14 05:03:58,484 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3a35f6cea288?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 05:03:59,665 unpacking tar archive at: mozilla-central-3a35f6cea288/testing/mozharness/ program finished with exit code 0 elapsedTime=1.433715 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-14 05:03:59.650658) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 05:03:59.650998) ========= script_repo_revision: 3a35f6cea288558cd0433f1b8b00c02e8bc3e4da ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 05:03:59.654383) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 05:03:59.654651) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 05:03:59.672309) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-14 05:03:59.672620) ========= /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.uVptKz2GVZ/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.5w22Nk0YOQ/Listeners TMPDIR=/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 05:04:00 INFO - MultiFileLogger online at 20161014 05:04:00 in /builds/slave/test 05:04:00 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 05:04:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:04:00 INFO - {'append_to_log': False, 05:04:00 INFO - 'base_work_dir': '/builds/slave/test', 05:04:00 INFO - 'blob_upload_branch': 'Firefox', 05:04:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:04:00 INFO - 'branch': 'Firefox', 05:04:00 INFO - 'buildbot_json_path': 'buildprops.json', 05:04:00 INFO - 'config_files': ('talos/mac_config.py',), 05:04:00 INFO - 'default_actions': ('clobber', 05:04:00 INFO - 'read-buildbot-config', 05:04:00 INFO - 'download-and-extract', 05:04:00 INFO - 'populate-webroot', 05:04:00 INFO - 'create-virtualenv', 05:04:00 INFO - 'install', 05:04:00 INFO - 'run-tests'), 05:04:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:04:00 INFO - 'download_minidump_stackwalk': True, 05:04:00 INFO - 'download_symbols': 'ondemand', 05:04:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:04:00 INFO - 'tooltool.py': '/tools/tooltool.py', 05:04:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:04:00 INFO - '/tools/misc-python/virtualenv.py')}, 05:04:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:04:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:04:00 INFO - 'installer_path': 'installer.exe', 05:04:00 INFO - 'log_level': 'info', 05:04:00 INFO - 'log_name': 'talos', 05:04:00 INFO - 'log_to_console': True, 05:04:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:04:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:04:00 INFO - 'opt_config_files': (), 05:04:00 INFO - 'pip_index': False, 05:04:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:04:00 INFO - 'cmd': ('bash', 05:04:00 INFO - '-c', 05:04:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:04:00 INFO - 'enabled': True, 05:04:00 INFO - 'halt_on_failure': False, 05:04:00 INFO - 'name': 'check_screen_resolution'},), 05:04:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:04:00 INFO - 'cmd': ('bash', 05:04:00 INFO - '-c', 05:04:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:04:00 INFO - 'enabled': True, 05:04:00 INFO - 'halt_on_failure': False, 05:04:00 INFO - 'name': 'check_screen_resolution'},), 05:04:00 INFO - 'run_cmd_checks_enabled': True, 05:04:00 INFO - 'sps_profile': False, 05:04:00 INFO - 'sps_profile_interval': 0, 05:04:00 INFO - 'suite': 'dromaeojs', 05:04:00 INFO - 'system_bits': '32', 05:04:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:04:00 INFO - 'title': 't-yosemite-r7-0219', 05:04:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:04:00 INFO - 'use_talos_json': True, 05:04:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:04:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:04:00 INFO - 'work_dir': 'build'} 05:04:00 INFO - [mozharness: 2016-10-14 12:04:00.082781Z] Running clobber step. 05:04:00 INFO - Running pre-action listener: _resource_record_pre_action 05:04:00 INFO - Running main action method: clobber 05:04:00 INFO - rmtree: /builds/slave/test/build 05:04:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:04:01 INFO - Running post-action listener: _resource_record_post_action 05:04:01 INFO - [mozharness: 2016-10-14 12:04:01.891009Z] Finished clobber step (success) 05:04:01 INFO - [mozharness: 2016-10-14 12:04:01.891126Z] Running read-buildbot-config step. 05:04:01 INFO - Running pre-action listener: _resource_record_pre_action 05:04:01 INFO - Running main action method: read_buildbot_config 05:04:01 INFO - Using buildbot properties: 05:04:01 INFO - { 05:04:01 INFO - "project": "", 05:04:01 INFO - "product": "firefox", 05:04:01 INFO - "script_repo_revision": "production", 05:04:01 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:04:01 INFO - "repository": "", 05:04:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:04:01 INFO - "buildid": "20161014025735", 05:04:01 INFO - "pgo_build": "False", 05:04:01 INFO - "basedir": "/builds/slave/test", 05:04:01 INFO - "buildnumber": 9, 05:04:01 INFO - "slavename": "t-yosemite-r7-0219", 05:04:01 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 05:04:01 INFO - "platform": "yosemite_r7", 05:04:01 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:04:01 INFO - "branch": "mozilla-central", 05:04:01 INFO - "repo_path": "mozilla-central", 05:04:01 INFO - "revision": "3a35f6cea288558cd0433f1b8b00c02e8bc3e4da", 05:04:01 INFO - "stage_platform": "macosx64", 05:04:01 INFO - "builduid": "66333b3435d245078e8d5b08ae53cde5", 05:04:01 INFO - "slavebuilddir": "test" 05:04:01 INFO - } 05:04:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/YNIUD2b3SZuXi0DG49uZnw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 05:04:01 INFO - Running post-action listener: _resource_record_post_action 05:04:01 INFO - [mozharness: 2016-10-14 12:04:01.894330Z] Finished read-buildbot-config step (success) 05:04:01 INFO - [mozharness: 2016-10-14 12:04:01.894432Z] Running download-and-extract step. 05:04:01 INFO - Running pre-action listener: _resource_record_pre_action 05:04:01 INFO - Running main action method: download_and_extract 05:04:01 INFO - mkdir: /builds/slave/test/build/tests 05:04:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:01 INFO - trying https://queue.taskcluster.net/v1/task/YNIUD2b3SZuXi0DG49uZnw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 05:04:01 INFO - Downloading https://queue.taskcluster.net/v1/task/YNIUD2b3SZuXi0DG49uZnw/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 05:04:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YNIUD2b3SZuXi0DG49uZnw/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 05:04:02 INFO - Downloaded 1199 bytes. 05:04:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:04:02 INFO - Using the following test package requirements: 05:04:02 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:04:02 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:04:02 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 05:04:02 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:04:02 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 05:04:02 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:04:02 INFO - u'jsshell-mac.zip'], 05:04:02 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:04:02 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 05:04:02 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:04:02 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:04:02 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 05:04:02 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:04:02 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 05:04:02 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:04:02 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 05:04:02 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:04:02 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 05:04:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:04:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YNIUD2b3SZuXi0DG49uZnw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:04:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YNIUD2b3SZuXi0DG49uZnw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:04:02 INFO - Fetch https://queue.taskcluster.net/v1/task/YNIUD2b3SZuXi0DG49uZnw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:04:03 INFO - Http code: 200 05:04:03 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 05:04:03 INFO - x-amz-cf-id: -eI8yiMJo_e1-_-5CzjzUIeju2ed9K-v5ONRTBz5JJegDwOn3GCHmQ== 05:04:03 INFO - x-amz-version-id: BCK5491gHiuTlEU1XrrnLc9qbGTLCPr5 05:04:03 INFO - Expected file size: 16515321 05:04:03 INFO - Obtained file size: 16515321 05:04:10 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 05:04:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YNIUD2b3SZuXi0DG49uZnw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:04:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YNIUD2b3SZuXi0DG49uZnw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:04:10 INFO - Fetch https://queue.taskcluster.net/v1/task/YNIUD2b3SZuXi0DG49uZnw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:04:11 INFO - Http code: 200 05:04:11 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 05:04:11 INFO - x-amz-cf-id: KkIEN0j5Fn5rQjqBryKvxaLa1rOymOsvHkpNDWAH9Wko9DlDGT-72w== 05:04:11 INFO - x-amz-version-id: BCK5491gHiuTlEU1XrrnLc9qbGTLCPr5 05:04:11 INFO - Expected file size: 16515321 05:04:11 INFO - Obtained file size: 16515321 05:04:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YNIUD2b3SZuXi0DG49uZnw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 05:04:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YNIUD2b3SZuXi0DG49uZnw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:04:17 INFO - Fetch https://queue.taskcluster.net/v1/task/YNIUD2b3SZuXi0DG49uZnw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 05:04:18 INFO - Http code: 200 05:04:18 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 05:04:18 INFO - x-amz-cf-id: hHBAfjGUW_M2LA-GxOZU3Igx0RIaGqVfj9_g9O08UAApPTh4_Y_66Q== 05:04:18 INFO - x-amz-version-id: ehCMyLOnH39eoS8rn6dH6jtAGg_8rDl2 05:04:18 INFO - Expected file size: 14409006 05:04:18 INFO - Obtained file size: 14409006 05:04: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')]} 05:04:18 INFO - trying https://queue.taskcluster.net/v1/task/YNIUD2b3SZuXi0DG49uZnw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:04:18 INFO - Downloading https://queue.taskcluster.net/v1/task/YNIUD2b3SZuXi0DG49uZnw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 05:04:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YNIUD2b3SZuXi0DG49uZnw/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 05:04:21 INFO - Downloaded 111478420 bytes. 05:04:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YNIUD2b3SZuXi0DG49uZnw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:04:21 INFO - mkdir: /builds/slave/test/properties 05:04:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:04:21 INFO - Writing to file /builds/slave/test/properties/build_url 05:04:21 INFO - Contents: 05:04:21 INFO - build_url:https://queue.taskcluster.net/v1/task/YNIUD2b3SZuXi0DG49uZnw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:04:22 INFO - Running post-action listener: _resource_record_post_action 05:04:22 INFO - Running post-action listener: set_extra_try_arguments 05:04:22 INFO - [mozharness: 2016-10-14 12:04:22.493987Z] Finished download-and-extract step (success) 05:04:22 INFO - [mozharness: 2016-10-14 12:04:22.494085Z] Running populate-webroot step. 05:04:22 INFO - Running pre-action listener: _resource_record_pre_action 05:04:22 INFO - Running main action method: populate_webroot 05:04:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:04:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:04:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:04:22 INFO - '--tppagecycles', 05:04:22 INFO - '7'], 05:04:22 INFO - 'tests': ['tsvgm']}}, 05:04:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:04:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:04:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:04:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:04:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:04:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:04:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:22 INFO - 'talos_options': ['--disable-e10s'], 05:04:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:04:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:04:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:22 INFO - 'talos_options': ['--disable-e10s'], 05:04:22 INFO - 'tests': ['damp', 'tps']}, 05:04:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:22 INFO - 'tests': ['damp', 'tps']}, 05:04:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:04:22 INFO - 'tests': ['dromaeo_dom']}, 05:04:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:04:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:04:22 INFO - 'tests': ['basic_compositor_video']}, 05:04:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:04:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:04:22 INFO - 'tests': ['a11yr', 05:04:22 INFO - 'ts_paint', 05:04:22 INFO - 'tpaint', 05:04:22 INFO - 'sessionrestore', 05:04:22 INFO - 'sessionrestore_no_auto_restore', 05:04:22 INFO - 'tabpaint']}, 05:04:22 INFO - 'other-e10s': {'tests': ['a11yr', 05:04:22 INFO - 'ts_paint', 05:04:22 INFO - 'tpaint', 05:04:22 INFO - 'sessionrestore', 05:04:22 INFO - 'sessionrestore_no_auto_restore', 05:04:22 INFO - 'tabpaint']}, 05:04:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:04:22 INFO - 'ts_paint', 05:04:22 INFO - 'tpaint', 05:04:22 INFO - 'sessionrestore', 05:04:22 INFO - 'sessionrestore_no_auto_restore', 05:04:22 INFO - 'tabpaint']}, 05:04:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:04:22 INFO - 'ts_paint', 05:04:22 INFO - 'tpaint', 05:04:22 INFO - 'sessionrestore', 05:04:22 INFO - 'sessionrestore_no_auto_restore', 05:04:22 INFO - 'tabpaint']}, 05:04:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:04:22 INFO - 'tests': ['a11yr', 05:04:22 INFO - 'ts_paint', 05:04:22 INFO - 'tpaint', 05:04:22 INFO - 'sessionrestore', 05:04:22 INFO - 'sessionrestore_no_auto_restore', 05:04:22 INFO - 'tabpaint']}, 05:04:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:04:22 INFO - 'tests': ['a11yr', 05:04:22 INFO - 'ts_paint', 05:04:22 INFO - 'tpaint', 05:04:22 INFO - 'sessionrestore', 05:04:22 INFO - 'sessionrestore_no_auto_restore', 05:04:22 INFO - 'tabpaint']}, 05:04:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:04:22 INFO - 'tests': ['tsvgx', 05:04:22 INFO - 'tsvgr_opacity', 05:04:22 INFO - 'tart', 05:04:22 INFO - 'tscrollx', 05:04:22 INFO - 'cart']}, 05:04:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:04:22 INFO - 'tsvgr_opacity', 05:04:22 INFO - 'tart', 05:04:22 INFO - 'tscrollx', 05:04:22 INFO - 'cart']}, 05:04:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:22 INFO - 'talos_options': ['--disable-e10s'], 05:04:22 INFO - 'tests': ['tp5o']}, 05:04:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:22 INFO - 'tests': ['tp5o']}, 05:04:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:22 INFO - 'talos_options': ['--disable-e10s', 05:04:22 INFO - '--xperf_path', 05:04:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:04:22 INFO - 'tests': ['tp5n']}, 05:04:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:04:22 INFO - 'talos_options': ['--xperf_path', 05:04:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:04:22 INFO - 'tests': ['tp5n']}}, 05:04:22 INFO - 'talos.zip': {'path': '', 05:04:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:04:22 INFO - Running post-action listener: _resource_record_post_action 05:04:22 INFO - [mozharness: 2016-10-14 12:04:22.513112Z] Finished populate-webroot step (success) 05:04:22 INFO - [mozharness: 2016-10-14 12:04:22.513240Z] Running create-virtualenv step. 05:04:22 INFO - Running pre-action listener: _resource_record_pre_action 05:04:22 INFO - Running main action method: create_virtualenv 05:04:22 INFO - Creating virtualenv /builds/slave/test/build/venv 05:04:22 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 05:04:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:04:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:04:22 INFO - Using real prefix '/tools/python27' 05:04:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:04:23 INFO - Installing distribute.............................................................................................................................................................................................done. 05:04:26 INFO - Installing pip.................done. 05:04:26 INFO - Return code: 0 05:04:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:04:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:04:26 INFO - Reading from file tmpfile_stdout 05:04:26 INFO - Output received: 05:04:26 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) 05:04:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:04:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:26 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 0x107df1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d67570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fff22565480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c05d30>, '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 0x107a2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bfdb20>, '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.uVptKz2GVZ/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.5w22Nk0YOQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 05:04:26 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 05:04:26 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 05:04:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uVptKz2GVZ/Render', 05:04:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:04:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:04:26 INFO - 'HOME': '/Users/cltbld', 05:04:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:04:26 INFO - 'LOGNAME': 'cltbld', 05:04:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:26 INFO - 'MOZ_NO_REMOTE': '1', 05:04:26 INFO - 'NO_EM_RESTART': '1', 05:04:26 INFO - 'PAGER': '/bin/cat', 05:04:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:04:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:26 INFO - 'PWD': '/builds/slave/test', 05:04:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:04:26 INFO - 'SHELL': '/bin/bash', 05:04:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5w22Nk0YOQ/Listeners', 05:04:26 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 05:04:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:04:26 INFO - 'USER': 'cltbld', 05:04:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:04:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:04:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:26 INFO - 'XPC_FLAGS': '0x0', 05:04:26 INFO - 'XPC_SERVICE_NAME': '0', 05:04:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:04:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:26 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 05:04:26 INFO - Cleaning up... 05:04:26 INFO - Return code: 0 05:04:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:04:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:26 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 0x107df1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d67570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fff22565480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c05d30>, '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 0x107a2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bfdb20>, '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.uVptKz2GVZ/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.5w22Nk0YOQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 05:04:26 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 05:04:26 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 05:04:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uVptKz2GVZ/Render', 05:04:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:04:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:04:26 INFO - 'HOME': '/Users/cltbld', 05:04:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:04:26 INFO - 'LOGNAME': 'cltbld', 05:04:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:26 INFO - 'MOZ_NO_REMOTE': '1', 05:04:26 INFO - 'NO_EM_RESTART': '1', 05:04:26 INFO - 'PAGER': '/bin/cat', 05:04:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:04:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:26 INFO - 'PWD': '/builds/slave/test', 05:04:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:04:26 INFO - 'SHELL': '/bin/bash', 05:04:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5w22Nk0YOQ/Listeners', 05:04:26 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 05:04:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:04:26 INFO - 'USER': 'cltbld', 05:04:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:04:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:04:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:26 INFO - 'XPC_FLAGS': '0x0', 05:04:26 INFO - 'XPC_SERVICE_NAME': '0', 05:04:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:04:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:26 INFO - Downloading/unpacking psutil>=3.1.1 05:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:04:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:04:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:04:30 INFO - Installing collected packages: psutil 05:04:30 INFO - Running setup.py install for psutil 05:04:30 INFO - building 'psutil._psutil_osx' extension 05:04:30 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 05:04:31 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 05:04:31 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 05:04:31 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 05:04:31 INFO - building 'psutil._psutil_posix' extension 05:04:31 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 05:04:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:04:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:04:31 INFO - ^ 05:04:31 INFO - 1 warning generated. 05:04:31 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 05:04:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:04:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:04:31 INFO - Successfully installed psutil 05:04:31 INFO - Cleaning up... 05:04:31 INFO - Return code: 0 05:04:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:04:31 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')]} 05:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:31 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')]} 05:04:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:31 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 0x107df1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d67570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fff22565480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c05d30>, '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 0x107a2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bfdb20>, '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.uVptKz2GVZ/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.5w22Nk0YOQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 05:04:31 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 05:04:31 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 05:04:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uVptKz2GVZ/Render', 05:04:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:04:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:04:31 INFO - 'HOME': '/Users/cltbld', 05:04:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:04:31 INFO - 'LOGNAME': 'cltbld', 05:04:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:31 INFO - 'MOZ_NO_REMOTE': '1', 05:04:31 INFO - 'NO_EM_RESTART': '1', 05:04:31 INFO - 'PAGER': '/bin/cat', 05:04:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:04:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:31 INFO - 'PWD': '/builds/slave/test', 05:04:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:04:31 INFO - 'SHELL': '/bin/bash', 05:04:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5w22Nk0YOQ/Listeners', 05:04:31 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 05:04:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:04:31 INFO - 'USER': 'cltbld', 05:04:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:04:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:04:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:31 INFO - 'XPC_FLAGS': '0x0', 05:04:31 INFO - 'XPC_SERVICE_NAME': '0', 05:04:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:04:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:04:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:04:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:04:34 INFO - Installing collected packages: mozsystemmonitor 05:04:34 INFO - Running setup.py install for mozsystemmonitor 05:04:34 INFO - Successfully installed mozsystemmonitor 05:04:34 INFO - Cleaning up... 05:04:34 INFO - Return code: 0 05:04:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107df1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d67570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fff22565480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c05d30>, '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 0x107a2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bfdb20>, '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.uVptKz2GVZ/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.5w22Nk0YOQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 05:04:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:04:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:04:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uVptKz2GVZ/Render', 05:04:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:04:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:04:34 INFO - 'HOME': '/Users/cltbld', 05:04:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:04:34 INFO - 'LOGNAME': 'cltbld', 05:04:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:34 INFO - 'MOZ_NO_REMOTE': '1', 05:04:34 INFO - 'NO_EM_RESTART': '1', 05:04:34 INFO - 'PAGER': '/bin/cat', 05:04:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:04:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:34 INFO - 'PWD': '/builds/slave/test', 05:04:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:04:34 INFO - 'SHELL': '/bin/bash', 05:04:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5w22Nk0YOQ/Listeners', 05:04:34 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 05:04:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:04:34 INFO - 'USER': 'cltbld', 05:04:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:04:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:04:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:34 INFO - 'XPC_FLAGS': '0x0', 05:04:34 INFO - 'XPC_SERVICE_NAME': '0', 05:04:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:04:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:34 INFO - Downloading/unpacking jsonschema==2.5.1 05:04:34 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 05:04:34 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 05:04:34 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 05:04:34 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 05:04:34 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 05:04:34 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 05:04:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:04:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:04:37 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 05:04:37 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 05:04:37 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 05:04:37 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 05:04:37 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 05:04:37 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 05:04:37 INFO - Downloading functools32-3.2.3-2.tar.gz 05:04:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:04:37 INFO - warning: no files found matching '*.txt' 05:04:37 INFO - no previously-included directories found matching 'build' 05:04:37 INFO - no previously-included directories found matching 'dist' 05:04:37 INFO - no previously-included directories found matching '.git*' 05:04:37 INFO - Installing collected packages: jsonschema, functools32 05:04:37 INFO - Running setup.py install for functools32 05:04:38 INFO - warning: no files found matching '*.txt' 05:04:38 INFO - no previously-included directories found matching 'build' 05:04:38 INFO - no previously-included directories found matching 'dist' 05:04:38 INFO - no previously-included directories found matching '.git*' 05:04:38 INFO - Successfully installed jsonschema functools32 05:04:38 INFO - Cleaning up... 05:04:38 INFO - Return code: 0 05:04:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:04:38 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')]} 05:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:38 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')]} 05:04:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:38 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 0x107df1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d67570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fff22565480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c05d30>, '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 0x107a2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bfdb20>, '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.uVptKz2GVZ/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.5w22Nk0YOQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 05:04:38 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 05:04:38 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 05:04:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uVptKz2GVZ/Render', 05:04:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:04:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:04:38 INFO - 'HOME': '/Users/cltbld', 05:04:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:04:38 INFO - 'LOGNAME': 'cltbld', 05:04:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:38 INFO - 'MOZ_NO_REMOTE': '1', 05:04:38 INFO - 'NO_EM_RESTART': '1', 05:04:38 INFO - 'PAGER': '/bin/cat', 05:04:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:04:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:38 INFO - 'PWD': '/builds/slave/test', 05:04:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:04:38 INFO - 'SHELL': '/bin/bash', 05:04:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5w22Nk0YOQ/Listeners', 05:04:38 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 05:04:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:04:38 INFO - 'USER': 'cltbld', 05:04:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:04:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:04:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:38 INFO - 'XPC_FLAGS': '0x0', 05:04:38 INFO - 'XPC_SERVICE_NAME': '0', 05:04:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:04:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:04:38 INFO - Cleaning up... 05:04:38 INFO - Return code: 0 05:04:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:04:38 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')]} 05:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:38 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')]} 05:04:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:38 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 0x107df1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d67570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fff22565480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c05d30>, '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 0x107a2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bfdb20>, '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.uVptKz2GVZ/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.5w22Nk0YOQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 05:04:38 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 05:04:38 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 05:04:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uVptKz2GVZ/Render', 05:04:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:04:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:04:38 INFO - 'HOME': '/Users/cltbld', 05:04:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:04:38 INFO - 'LOGNAME': 'cltbld', 05:04:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:38 INFO - 'MOZ_NO_REMOTE': '1', 05:04:38 INFO - 'NO_EM_RESTART': '1', 05:04:38 INFO - 'PAGER': '/bin/cat', 05:04:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:04:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:38 INFO - 'PWD': '/builds/slave/test', 05:04:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:04:38 INFO - 'SHELL': '/bin/bash', 05:04:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5w22Nk0YOQ/Listeners', 05:04:38 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 05:04:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:04:38 INFO - 'USER': 'cltbld', 05:04:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:04:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:04:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:38 INFO - 'XPC_FLAGS': '0x0', 05:04:38 INFO - 'XPC_SERVICE_NAME': '0', 05:04:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:04:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:38 INFO - Downloading/unpacking blobuploader==1.2.4 05:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:41 INFO - Downloading blobuploader-1.2.4.tar.gz 05:04:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:04:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:04:41 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 05:04:41 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 05:04:41 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 05:04:41 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 05:04:41 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 05:04:41 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 05:04:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:04:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:04:41 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 05:04:41 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 05:04:41 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 05:04:41 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 05:04:41 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 05:04:41 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 05:04:42 INFO - Downloading docopt-0.6.1.tar.gz 05:04:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:04:42 INFO - Installing collected packages: blobuploader, requests, docopt 05:04:42 INFO - Running setup.py install for blobuploader 05:04:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:04:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:04:42 INFO - Running setup.py install for requests 05:04:43 INFO - Running setup.py install for docopt 05:04:43 INFO - Successfully installed blobuploader requests docopt 05:04:43 INFO - Cleaning up... 05:04:43 INFO - Return code: 0 05:04:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:04: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')]} 05:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04: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')]} 05:04:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:43 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 0x107df1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d67570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fff22565480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c05d30>, '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 0x107a2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bfdb20>, '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.uVptKz2GVZ/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.5w22Nk0YOQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 05:04:43 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 05:04:43 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 05:04:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uVptKz2GVZ/Render', 05:04:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:04:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:04:43 INFO - 'HOME': '/Users/cltbld', 05:04:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:04:43 INFO - 'LOGNAME': 'cltbld', 05:04:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:43 INFO - 'MOZ_NO_REMOTE': '1', 05:04:43 INFO - 'NO_EM_RESTART': '1', 05:04:43 INFO - 'PAGER': '/bin/cat', 05:04:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:04:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:43 INFO - 'PWD': '/builds/slave/test', 05:04:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:04:43 INFO - 'SHELL': '/bin/bash', 05:04:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5w22Nk0YOQ/Listeners', 05:04:43 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 05:04:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:04:43 INFO - 'USER': 'cltbld', 05:04:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:04:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:04:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:43 INFO - 'XPC_FLAGS': '0x0', 05:04:43 INFO - 'XPC_SERVICE_NAME': '0', 05:04:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:04:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:04:43 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-cDkeao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:04:43 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-R_pDJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:04:43 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-NW3RyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:04:43 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-aRbbgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:04:44 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-YCZgJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:04:44 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-8kcNei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:04:44 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-jr9mrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:04:44 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-zKGspK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:04:44 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-Y4lRRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:04:44 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-4k9WQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:04:44 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-pxPOTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:04:44 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-B0I8KW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:04:44 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-JNTVo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:04:44 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-wft5nL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:04:45 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-mVC1Uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:04:45 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-4HLj_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:04:45 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-pZwm7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:04:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:04:45 INFO - Running setup.py install for manifestparser 05:04:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:04:45 INFO - Running setup.py install for mozcrash 05:04:45 INFO - Running setup.py install for mozdebug 05:04:45 INFO - Running setup.py install for mozdevice 05:04:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:04:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:04:46 INFO - Running setup.py install for mozfile 05:04:46 INFO - Running setup.py install for mozhttpd 05:04:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:04:46 INFO - Running setup.py install for mozinfo 05:04:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:04:46 INFO - Running setup.py install for mozInstall 05:04:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:04:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:04:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:04:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:04:46 INFO - Running setup.py install for mozleak 05:04:46 INFO - Running setup.py install for mozlog 05:04:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:04:46 INFO - Running setup.py install for moznetwork 05:04:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:04:47 INFO - Running setup.py install for mozprocess 05:04:47 INFO - Running setup.py install for mozprofile 05:04:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:04:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:04:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:04:47 INFO - Running setup.py install for mozrunner 05:04:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:04:47 INFO - Running setup.py install for mozscreenshot 05:04:47 INFO - Running setup.py install for moztest 05:04:47 INFO - Running setup.py install for mozversion 05:04:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:04:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:04:47 INFO - Cleaning up... 05:04:48 INFO - Return code: 0 05:04:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:04: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')]} 05:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04: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')]} 05:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:48 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 0x107df1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d67570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fff22565480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c05d30>, '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 0x107a2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bfdb20>, '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.uVptKz2GVZ/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.5w22Nk0YOQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 05:04:48 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 05:04:48 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 05:04:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uVptKz2GVZ/Render', 05:04:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:04:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:04:48 INFO - 'HOME': '/Users/cltbld', 05:04:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:04:48 INFO - 'LOGNAME': 'cltbld', 05:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:48 INFO - 'MOZ_NO_REMOTE': '1', 05:04:48 INFO - 'NO_EM_RESTART': '1', 05:04:48 INFO - 'PAGER': '/bin/cat', 05:04:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:48 INFO - 'PWD': '/builds/slave/test', 05:04:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:04:48 INFO - 'SHELL': '/bin/bash', 05:04:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5w22Nk0YOQ/Listeners', 05:04:48 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 05:04:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:04:48 INFO - 'USER': 'cltbld', 05:04:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:04:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:48 INFO - 'XPC_FLAGS': '0x0', 05:04:48 INFO - 'XPC_SERVICE_NAME': '0', 05:04:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:04:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:04:48 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-5pjQGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:04:48 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)) 05:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:04:48 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-VLWzwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:04:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 05:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:04:48 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-6vwLmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:04:48 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)) 05:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:04:48 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-dnZaCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:04:48 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)) 05:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:04:48 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-yAwYGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:04:48 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)) 05:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:04:48 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-0p3iTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:04:48 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)) 05:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:04:48 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-AtZHSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:04:49 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)) 05:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:04:49 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-Ect3XD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:04:49 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)) 05:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:04:49 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-1Rc4lB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:04:49 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)) 05:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:04:49 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-F59Swx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:04:49 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)) 05:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:04:49 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-aalD3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:04:49 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)) 05:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:04:49 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-frTcKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:04:49 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)) 05:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:04:49 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-zotENr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:04:49 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)) 05:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:04:49 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-GXQfbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:04:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 05:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:04:49 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-67Dqm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:04:49 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)) 05:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:04:49 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-04Depn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:04:49 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)) 05:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:04:49 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-FmmhaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:04:50 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)) 05:04:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:04:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:04:50 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)) 05:04:50 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)) 05:04:50 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)) 05:04:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:04:50 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 05:04:50 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 05:04:50 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 05:04:50 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 05:04:50 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 05:04:50 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 05:04:52 INFO - Downloading blessings-1.6.tar.gz 05:04:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:04:52 INFO - Installing collected packages: blessings 05:04:52 INFO - Running setup.py install for blessings 05:04:52 INFO - Successfully installed blessings 05:04:52 INFO - Cleaning up... 05:04:52 INFO - Return code: 0 05:04:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:04:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:04:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:04:53 INFO - Reading from file tmpfile_stdout 05:04:53 INFO - Current package versions: 05:04:53 INFO - blessings == 1.6 05:04:53 INFO - blobuploader == 1.2.4 05:04:53 INFO - docopt == 0.6.1 05:04:53 INFO - functools32 == 3.2.3-2 05:04:53 INFO - jsonschema == 2.5.1 05:04:53 INFO - manifestparser == 1.1 05:04:53 INFO - mozInstall == 1.12 05:04:53 INFO - mozcrash == 0.17 05:04:53 INFO - mozdebug == 0.1 05:04:53 INFO - mozdevice == 0.48 05:04:53 INFO - mozfile == 1.2 05:04:53 INFO - mozhttpd == 0.7 05:04:53 INFO - mozinfo == 0.9 05:04:53 INFO - mozleak == 0.1 05:04:53 INFO - mozlog == 3.4 05:04:53 INFO - moznetwork == 0.27 05:04:53 INFO - mozprocess == 0.23 05:04:53 INFO - mozprofile == 0.28 05:04:53 INFO - mozrunner == 6.12 05:04:53 INFO - mozscreenshot == 0.1 05:04:53 INFO - mozsystemmonitor == 0.3 05:04:53 INFO - moztest == 0.7 05:04:53 INFO - mozversion == 1.4 05:04:53 INFO - psutil == 3.1.1 05:04:53 INFO - requests == 1.2.3 05:04:53 INFO - wsgiref == 0.1.2 05:04:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:54 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 0x107df1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d67570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fff22565480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c05d30>, '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 0x107a2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bfdb20>, '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.uVptKz2GVZ/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.5w22Nk0YOQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 05:04:54 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 05:04:54 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 05:04:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uVptKz2GVZ/Render', 05:04:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:04:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:04:54 INFO - 'HOME': '/Users/cltbld', 05:04:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:04:54 INFO - 'LOGNAME': 'cltbld', 05:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:54 INFO - 'MOZ_NO_REMOTE': '1', 05:04:54 INFO - 'NO_EM_RESTART': '1', 05:04:54 INFO - 'PAGER': '/bin/cat', 05:04:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:54 INFO - 'PWD': '/builds/slave/test', 05:04:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:04:54 INFO - 'SHELL': '/bin/bash', 05:04:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5w22Nk0YOQ/Listeners', 05:04:54 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 05:04:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:04:54 INFO - 'USER': 'cltbld', 05:04:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:04:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:54 INFO - 'XPC_FLAGS': '0x0', 05:04:54 INFO - 'XPC_SERVICE_NAME': '0', 05:04:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:04:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:54 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)) 05:04:54 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)) 05:04:54 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)) 05:04:54 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)) 05:04:54 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)) 05:04:54 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)) 05:04:54 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)) 05:04:54 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)) 05:04:54 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)) 05:04:54 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)) 05:04:54 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)) 05:04:54 INFO - Cleaning up... 05:04:54 INFO - Return code: 0 05:04:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:04: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')]} 05:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04: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')]} 05:04:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107df1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d67570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fff22565480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c05d30>, '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 0x107a2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bfdb20>, '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.uVptKz2GVZ/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.5w22Nk0YOQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 05:04: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', 'jsonschema'] in /builds/slave/test/build 05:04: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 jsonschema 05:04:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uVptKz2GVZ/Render', 05:04:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:04:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:04:54 INFO - 'HOME': '/Users/cltbld', 05:04:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:04:54 INFO - 'LOGNAME': 'cltbld', 05:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:54 INFO - 'MOZ_NO_REMOTE': '1', 05:04:54 INFO - 'NO_EM_RESTART': '1', 05:04:54 INFO - 'PAGER': '/bin/cat', 05:04:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:54 INFO - 'PWD': '/builds/slave/test', 05:04:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:04:54 INFO - 'SHELL': '/bin/bash', 05:04:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5w22Nk0YOQ/Listeners', 05:04:54 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 05:04:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:04:54 INFO - 'USER': 'cltbld', 05:04:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:04:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:54 INFO - 'XPC_FLAGS': '0x0', 05:04:54 INFO - 'XPC_SERVICE_NAME': '0', 05:04:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:04:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:04:54 INFO - Cleaning up... 05:04:54 INFO - Return code: 0 05:04:54 INFO - Running post-action listener: _resource_record_post_action 05:04:54 INFO - Running post-action listener: _start_resource_monitoring 05:04:54 INFO - Starting resource monitoring. 05:04:54 INFO - [mozharness: 2016-10-14 12:04:54.941972Z] Finished create-virtualenv step (success) 05:04:54 INFO - [mozharness: 2016-10-14 12:04:54.943008Z] Running install step. 05:04:54 INFO - Running pre-action listener: _resource_record_pre_action 05:04:54 INFO - Running main action method: install 05:04:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:04:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:04:55 INFO - Reading from file tmpfile_stdout 05:04:55 INFO - Detecting whether we're running mozinstall >=1.0... 05:04:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:04:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:04:55 INFO - Reading from file tmpfile_stdout 05:04:55 INFO - Output received: 05:04:55 INFO - Usage: mozinstall [options] installer 05:04:55 INFO - Options: 05:04:55 INFO - -h, --help show this help message and exit 05:04:55 INFO - -d DEST, --destination=DEST 05:04:55 INFO - Directory to install application into. [default: 05:04:55 INFO - "/builds/slave/test"] 05:04:55 INFO - --app=APP Application being installed. [default: firefox] 05:04:55 INFO - mkdir: /builds/slave/test/build/application 05:04:55 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'] 05:04:55 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 05:05:29 INFO - Reading from file tmpfile_stdout 05:05:29 INFO - Output received: 05:05:29 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:05:29 INFO - Running post-action listener: _resource_record_post_action 05:05:29 INFO - [mozharness: 2016-10-14 12:05:29.465185Z] Finished install step (success) 05:05:29 INFO - [mozharness: 2016-10-14 12:05:29.465344Z] Running run-tests step. 05:05:29 INFO - Running pre-action listener: _resource_record_pre_action 05:05:29 INFO - Running main action method: run_tests 05:05:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:05:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:05:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:05:29 INFO - 2016-10-14 05:05:29.479 screenresolution[1643:7503] starting screenresolution argv=screenresolution get 05:05:29 INFO - 2016-10-14 05:05:29.482 screenresolution[1643:7503] Display 0: 1600x1200x32@60 05:05:29 INFO - 2016-10-14 05:05:29.488 screenresolution[1644:7505] starting screenresolution argv=screenresolution list 05:05:29 INFO - Available Modes on Display 0 05:05:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:05:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:05:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:05:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:05:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:05:29 INFO - Intel Iris: 05:05:29 INFO - Chipset Model: Intel Iris 05:05:29 INFO - Type: GPU 05:05:29 INFO - Bus: Built-In 05:05:29 INFO - VRAM (Dynamic, Max): 1536 MB 05:05:29 INFO - Vendor: Intel (0x8086) 05:05:29 INFO - Device ID: 0x0a2e 05:05:29 INFO - Revision ID: 0x0009 05:05:29 INFO - Displays: 05:05:29 INFO - Display: 05:05:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:05:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:05:29 INFO - Display Serial Number: 1600x1200 60 05:05:29 INFO - Main Display: Yes 05:05:29 INFO - Mirror: Off 05:05:29 INFO - Online: Yes 05:05:29 INFO - Rotation: Supported 05:05:29 INFO - Return code: 0 05:05:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:05:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:05:29 INFO - Python 2.7.3 05:05:29 INFO - Return code: 0 05:05:29 INFO - grabbing minidump binary from tooltool 05:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:29 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 0x107c05d30>, '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 0x107a2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bfdb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:05:29 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 05:05:29 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 05:05:29 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 05:05:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:05:29 INFO - Return code: 0 05:05:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:05:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:05:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:05:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:05:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:05:29 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/YNIUD2b3SZuXi0DG49uZnw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0219', '--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 05:05:29 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/YNIUD2b3SZuXi0DG49uZnw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0219 --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 05:05:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uVptKz2GVZ/Render', 05:05:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:29 INFO - 'HOME': '/Users/cltbld', 05:05:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:29 INFO - 'LOGNAME': 'cltbld', 05:05:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:05:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:05:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:29 INFO - 'MOZ_NO_REMOTE': '1', 05:05:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:05:29 INFO - 'NO_EM_RESTART': '1', 05:05:29 INFO - 'PAGER': '/bin/cat', 05:05:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:29 INFO - 'PWD': '/builds/slave/test', 05:05:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:05:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:29 INFO - 'SHELL': '/bin/bash', 05:05:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5w22Nk0YOQ/Listeners', 05:05:29 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 05:05:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:29 INFO - 'USER': 'cltbld', 05:05:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:29 INFO - 'XPC_FLAGS': '0x0', 05:05:29 INFO - 'XPC_SERVICE_NAME': '0', 05:05:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:29 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/YNIUD2b3SZuXi0DG49uZnw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0219', '--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 05:05:30 INFO - mozversion application_buildid: 20161014025735 05:05:30 INFO - mozversion application_changeset: 3a35f6cea288558cd0433f1b8b00c02e8bc3e4da 05:05:30 INFO - mozversion application_display_name: Nightly 05:05:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:05:30 INFO - mozversion application_name: Firefox 05:05:30 INFO - mozversion application_remotingname: firefox 05:05:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:05:30 INFO - mozversion application_vendor: Mozilla 05:05:30 INFO - mozversion application_version: 52.0a1 05:05:30 INFO - mozversion platform_buildid: 20161014025735 05:05:30 INFO - mozversion platform_changeset: 3a35f6cea288558cd0433f1b8b00c02e8bc3e4da 05:05:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:05:30 INFO - mozversion platform_version: 52.0a1 05:05:30 INFO - using testdate: 1476446730 05:05:30 INFO - actual date: 1476446730 05:05:30 INFO - starting webserver on 'localhost:49274' 05:05:30 INFO - SUITE-START | Running 2 tests 05:05:30 INFO - TEST-START | dromaeo_css 05:05:30 INFO - operating with platform_type : mac_ 05:05:30 INFO - Initialising browser for dromaeo_css test... 05:05:30 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/tmp5Z6gqO/profile http://localhost:49274/getInfo.html) 05:05:32 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 05:05:32 INFO - PROCESS | 1654 | colorDepth:24 05:05:32 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 05:05:32 INFO - PROCESS | 1654 | __metrics 05:05:32 INFO - PROCESS | 1654 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:05:32 INFO - PROCESS | 1654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:05:33 INFO - TEST-INFO | 1654: exit 0 05:05:33 INFO - Browser initialized. 05:05:33 INFO - Running cycle 1/1 for dromaeo_css test... 05:05:33 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/tmp5Z6gqO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:05:45 INFO - PROCESS | 1659 | RSS: Main: 234598400 05:05:45 INFO - PROCESS | 1659 | 05:06:36 INFO - PROCESS | 1659 | 1476446796441 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] 05:08:50 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 05:08:52 INFO - PROCESS | 1659 | RSS: Main: 392048640 05:08:52 INFO - PROCESS | 1659 | 05:11:54 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 05:11:55 INFO - PROCESS | 1659 | RSS: Main: 376807424 05:11:55 INFO - PROCESS | 1659 | 05:14:57 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 05:14:58 INFO - PROCESS | 1659 | RSS: Main: 344375296 05:14:58 INFO - PROCESS | 1659 | 05:18:01 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 05:18:01 INFO - PROCESS | 1659 | RSS: Main: 344117248 05:18:01 INFO - PROCESS | 1659 | 05:21:05 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 05:21:05 INFO - PROCESS | 1659 | RSS: Main: 329715712 05:21:05 INFO - PROCESS | 1659 | 05:24:09 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 05:24:09 INFO - PROCESS | 1659 | RSS: Main: 536068096 05:24:09 INFO - PROCESS | 1659 | 05:24:09 INFO - PROCESS | 1659 | __start_tp_report 05:24:09 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 05:24:09 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 05:24:09 INFO - PROCESS | 1659 | |i|pagename|runs| 05:24:09 INFO - PROCESS | 1659 | |0;dojo.html;3241.4813629819228;3250.3824273388063;3261.885833995809;3286.0470463565566;3311;5519.503244707976;5623.718814059296;5626.718664066791;5645.661260324378;5707.658700205454;5578;5623.662580245178;5623.662580245188;5628.240187574676;5630.971845140779;5062.822801201949;5098.184290513518;5115.744212789365;5128.794848206067;5157.896842063156;5190.688558686472;5226.1899405592;5236.031334203185;5238.188080847474;5238.8690282742855;5101.38783345999;5142.640015198937;5151.948480515184;5178.792848286064;5223.477652234784;5198.064348417283;5206.401263854667;5229.47705229474;5230;5263.578913686896;5020.196768517019;5055.342805435306;5112.769925353368;5143.588512918957;5144.511271429208;5509.090999984997;5541.667499950016;5584.944150558524;5603.775848966036;5650.5479561634975;6061.66660833654;6069.817905462844;6075.574709770318;6090.939090609081;6099.664518451484;5156.355455568054;6062.454379105901;6072.423119803611;6142.7850025249345;6165.2601687797305;5651.886962260732;5665.54675625953;5698;5725.112607545837;5735.8566035849435;6269.373062693694;6279.811605651837;6283.528735344776;6295.842603934938;6311.747530098744;5874.648830768947;5970.880582388328;5976.282846058414;5991.970040149771;6068.241469816273;6013.338532761392;6042.39576042401;6088.756449741961;6102;6105.511559075263;6035.094735789579;6063.454289114001;6094.603850749687;6131.14164017038;6132.63204207749;6060.666663333471;6090.147379366892;6096.146539484475;6100.755969761249;6133;4768.427788665383;4785.712857228577;4822.565969062801;4850.708957462563;4861.683990540674;4324.697271190987;4371.431713877176;4373.9125217495475;4379.605835474823;4409.603135717801;5643.802466913638;5648.943510564842;5658;5659.971700141473;5671.602987790815;6173.290071641729;6198.81403557894;6213.689315534205;6227.221597300338;6242;4746.620270378361;5520.641158324696;5552.611317207757;5599.916001259984;5689.203511508392;5318.760655770499;5337.492938170868;5376.354837419534;5380.1929710542945;5395.73021348931;6365.681715914278;6373.808785736435;6378.043293505825;6381.074744162163;6390.392912673288;5882.558808089325;6129.264488261437;6227.283862355887;6227.657478838707;6235.033569796688;6093.542984276109;6135.692037377249;6182.598131121463;6266.561340706106;6320.083587879823;5031.622628302819;6002.159697642421;6018.578699490994;6026.186464827192;6034.9094763577705;5158.45836187195;6114.7248373822395;6130.969345153246;6180.47465965398;6200.81397558074;4850.902981940412;5845.18167456565;5882.823515294548;5893.02765043763;5969.611975221596;5922.7334769936315;5927.288725352985;5938.168656388196;5983.521318294613;5995.250593675791;5801.1878337033695;5803.883922321615;5804.071348584206;5813.069908814569;5817.650940943557;5701.116326969326;5825.3592104867585;5895.7052147393315;5930;5931.347551769388;5787.247657804459;5797.043487824631;5832.854178645398;5880.323762767336;5894.056950887837 05:24:09 INFO - PROCESS | 1659 | |1;ext.html;504.7678068088679;509.8266589359619;511.84900454365965;521.9791208351664;560.6439910656732;30613.775448982044;38780.41829372562;39844.80077599608;40042;42485;41411;41761;41778.373324400156;41912.79043604778;41946.95132621678;9439.764005899839;9590.424574525516;9617.42295462271;9634.518274086302;9643.758906027335;9377.062293770603;9468.905310946871;9513.191378732816;9561.61753529858;9574.664886728966;9534.761630959247;9595.136437720605;9603.567839447242;9612.615495380176;9638.855417168748;8539.914600853974;9227.077292270718;9453.432794032311;9527.09492598202;9589.280803939733;9248.121428464285;9300.395474294217;9370.484623345714;9477.147056764925;9483.193928516084;39867.8006609968;39931.00172495682;40047.799761001006;40121.78112392584;40137.799311003255;3363.5122907178566;3382.4080785862375;3574.392353299945;3574.6782789549065;3822.140018495816;30002.399952000836;30368.696313037028;30826.229344266347;31008.37983240345;31037.844810776027;3190.6490286068515;3191.6489186189733;3197.8560964756407;3208.4545627243424;3303.9834800826084;443648;446177;449764;449927.7503612494;456094;57295.713521432124;57592.71203644039;57726.13410798757;57726.7113664429;57757.711211443675;33230.66769332276;33806.154846129044;60085.39914600798;60114.28914253139;60160;15720.92139539318;16236.837631623532;16242.51272461828;16271.918640406959;16274.186290685418;12191.329476878856;12403.193792403645;12485.500579976699;12547.24716517012;12568.497260109492;18399.136181402057;18498.35255766042;18621.90689046546;18651.48204992309;18674.626507469773;6479.449246814073;7709.691612335556;7766.262205090507;7767.495112817649;7901.328387087047;828.7348048624502;911.9498427586414;927.8726347487834;936.4849332866896;1037.2479952034864;28683.836909356098;29632.61809415654;29697;29823.701762982528;30163.547546786816;985.4038306824411;1016.9338992965434;1030.443560477349;1079.940603266812;1124.7694222684331;14560;15119.924400378148;15274.847251527342;15382.461613843685;15523.689526209413;661460.6926965334;667486;668162;669162;669871;56536.43463565312;56900.430995689516;56930.02234765373;56945.145822812694;57117;1338.377654390713;1370.7532644123953;1390.8052872598046;1395.2186775405805;1398.1052126638958;28181.71818281791;28856;28921.855390723755;29589.5561566581;29651.555226671186;48801.2679809796;49130.26304605505;49192.26211606757;49196;49269.50730492649;574127;578019;578044;578634;579319;25930.740692592834;26145.215643530726;26248.95004199887;26308.473830523664;26318.736812632396;45869;45951;47231;47337.52662473331;47379.763101184275;30060.54909176408;31948.68051319457;37895;38113.618863811;39107.41338879976;31741.20646983844;36944.63055369412;37871.24257514779;39028.80485597554;39070.4139437903;36867;36946;37268.81365593263;37570.8121459391;37985.290661919724;28112.71887281101;32233.838830805696;33331.000069997935;33400;33457;24710.50578988446;24827.62758558587;25041.998320066992;25296.367590810376;25338 05:24:09 INFO - PROCESS | 1659 | |2;jquery.html;324.81485553234654;350.06008866194253;371.19265597325824;374.43647310797246;403.30027402456733;14906.701865962688;15132.319045642946;17418.129093545318;18750.156242969064;19579.90210048948;19850.20599176031;19942.50143746407;20791.480212994684;20928.162873485082;21042.947852607384;5390.9191362129595;5955.255593050869;6025.3372129065765;6036.305824830135;6037.215162028952;4129.339305711087;4286.57134286572;5850.941490585083;5909.9704501477645;5969.940300596982;4322.524522302544;6505.34946505348;6569.540132190748;6579.736810527573;6584.6707664616815;6280.623162610213;6487.448566871774;6565.080888675589;6578.407943285103;6578.868422631568;5638.154276858463;5647.503411595931;5657.773689052433;5658.519025882763;5658.943410565883;24571.017159313607;25358.873205634038;25403.983840646353;25707;25986.350341241432;2220.9555808883733;2299.8850057497057;2308.2728940383895;2360.4570948681726;2778.3470884342164;14508;15354;15420.92289538545;15532.689346213012;15999.040057596465;1803.9007854567994;1863.8589812226057;1902.2391043582538;1928.1323404468046;1932.1112288347376;111958;118480;118900;119188.80811191864;119805;10059.446730429896;10141.594336226615;10186.796264074677;10348.379097254188;10845.457727113613;11830.940845295718;12607.684807879876;13291.468341266434;13304.600861974157;13312.534061307808;8054.677812887418;8088.878666820003;8366.205210504992;8424.915750842412;8495.532745698922;8391.874121888177;8456.957715211385;8627.309815214894;8638.438501497383;8832.02847686754;6305.464035557029;6447.451966582893;6447.6453795041725;6450.451711604473;6458.838529036811;1711.5721069732567;1842.2723024405284;1884.1469195495245;1887.1413506854349;1890.631326891243;849.8087930215776;858.2233079063458;949.9192568631605;955;971.8493633486821;21124.271254959986;21847.972252132673;21868.496987817274;21897.302001740645;21904.506064133635;820.4994953078617;870.3211495033884;871.4662194537659;946.9621215151454;1021.8467229915424;10931.945340273247;11411.942940285411;11526.250793698382;11536.307821530734;11544.191906566628;581929;582398;588198;600236;606773;91025;98667.02665946784;113361;113775;116176.25735613973;884.0496466298755;921.9354645174774;940.8917974432891;941.6610020392653;946.9526523673788;17947.371841985467;19149.425517234504;19155.808441915404;19396.903015484833;19553.413397598095;37478.2504349906;50576.74711626566;50854.49145508498;50860;51751.74124129506;70919.58160836858;71554.5689086205;72092.63953680197;72129.27870721226;72516;7192.244814294424;7692.192319806563;7851.371890248881;7954.323882469824;8119.75640730779;12423.565175218824;12904.16122952005;12952.546660866825;13140.934295328461;13155.53955611549;11125.666230013112;11168.106551476025;11315.943420282845;11485;11513.53945842157;9634.566444509874;10758.569657213624;11150;11287.887121129012;11461.197716159788;10274.897251027693;11590.420478976186;11632.76734465289;11678;11768.94115529417;7719.073711154473;7774.30031297186;7798.220177982384;7858.685652573833;7930.405219608668;11309.773804524028;11386.430678465878;11458.484368203284;11535.942320288344;11662.475188616363 05:24:09 INFO - PROCESS | 1659 | |3;mootools.html;1335.6443210141701;1381.4405165907808;1489.3617021276598;1643.8356164383563;1850.9259629614808;6777.898331525031;8105.473144245627;8235.711750088756;8571.100034496381;8574.742757717278;8415.410921235516;8508.574571271443;8520.360972927025;8521.488710677364;8526.01950775661;2262.988685056572;2294.575503531852;2295.5294164696197;2296.70142881426;2300.1259521381853;2251.6284813005836;2289.5878741826464;2305.4697419593504;2312.9537409251807;2314.0512389920136;2258.8644681319174;2285.9771402285933;2301.608726516496;2301.735300440454;2306.4810417655976;2255.875926824024;2274.8521346112448;2276.681264622954;2280.04238219948;2287.0623044551653;2258.672492488596;2267.4331417145713;2268.194790849241;2270.137347807839;2273.4316420894775;8399.748007559783;8418.494890306602;8634.611442485104;8642.395032347738;8677.652893884237;5115.335006449175;5262.236975638511;5270.4729527047375;5271.920921186185;5279.762410691528;3446.9655303446893;3479.356319080978;3523.8766643167623;3550.378683730363;3554.306910152521;934.8784657994486;1053.8735351757762;1063.2716589136467;1078.466159251168;1080.9246247205385;11063.391513466757;11112.777744445146;11186.832197517044;11215.831762523569;11240.718982025433;4236.745795252295;4360.978195109004;4443.33349997503;4462.799174037176;4488.102379524108;8764.079771623889;8773.736787896374;8777.253933415732;8786.12138786129;8787.560621968876;5070.2141168119;5073.644844860898;5082.186850103965;5086.160783470686;5088.0587091388215;4290.549492303326;4291.249031419489;4448.088141930896;4775.450823155312;4803.8318658847475;3137.2784259620416;3585.8565657373933;3601.1537288737127;3706.2772759311674;3760.3983362661843;1104.1442881766695;1116.1294190531398;1131.932084074958;1132.8923752243525;1140.7718456308771;833.2210730091299;839.2153336630148;882.7969566999626;885.3138817416553;925.9398139120935;5426.484483974016;5463.590230732711;5654.010548154057;5712.885742285131;5827.88344233113;972.1153750087528;989.317371013998;991.5290237137447;991.6975322526555;993.8757655293089;3683.208110256308;3709.332320182339;3732.5894151643297;3878.553966293856;3921.627445392683;10069.54687039085;10498.212634052325;10507.737306567244;10508.579656813794;10525.157987360994;10463.895361046445;10465.738356541147;10467.424291664032;10480.004399582027;10483.580656773644;7881;8011.839763204704;8032.518048917201;8040.638171282307;8047.83904321922;4947.752612369295;5548.639338442988;5555.8611034722835;5819.010768169506;5921.3782552831335;9396.624135034523;9685.903140968781;9707.417554946725;9721.805563888542;9722.708318750449;9123.863142053007;9485.146336829719;9495.335326527076;9598.66404675833;9735.318527702993;6183.3816618337805;6721.764738234138;6970.407515361048;7176.892346614701;7280.453965952469;7621.199774023869;7692.9615351922885;7693.538387696756;7706.07527096752;7717.344025757873;6545.738170473318;6643.40209381158;7244.384227340735;7328.78013659591;7363.042804435389;7020.508564400648;7124.323189297009;7142.321479459443;7163.498555101093;7200.49596528238;6838.3161683833205;6855.245922948372;6879.621620810904;6879.724811007503;6888.793336199922;4422;4567.725936443824;4600;4601.953980460153;4679.742614156254;4163.208990291835;4791.353167322506;4882.340883980759;4931.679440836334;5105.106606343801 05:24:09 INFO - PROCESS | 1659 | |4;prototype.html;296.4707996226735;297.22276247612484;303.81163678519323;305.10756038587135;310.9877349228262;4674.415698037746;4706.1764191266475;5084.644074914758;5309.203619457084;5323.840284791458;4950.678205916622;5081.441041485434;5101.642884998052;5179.326687530615;5264.736763161845;3447.413939630256;3942.9354074399894;3946.9802650986703;3951.70362222833;3954.861579844706;3475.9572128361515;3563.3051554946796;3795.4876091727538;4035.939460908074;4048.453458783071;3656.7623104498257;3800.866969656063;3913.8043097845134;3964.8612298569556;3985.581513941038;3971.225611005855;3987.2424239394422;4003.919921601581;4006.379011253231;4018.6985976051765;3481.599616044162;3483.860645574199;3492.1793378556017;3498.230389314372;3508.7017803412646;4475.910481790346;5072.54347108762;5138.691678499302;5149.6910185389;5159.380874295071;4157.875263742093;4520.163769702583;4522.68341216115;4527.343535187412;4589.449266088091;5419.674819510842;5490.835274941718;5504.284443022421;5522.834314970557;5523.834284971457;3380.7802492837886;3472.6006509251506;3596.6403359664087;3755.380362240227;3781.3004594149897;4359.847405340798;4815.80880699281;5595.832125036255;5684.54523638108;5770.365259821417;3369.6124945631077;3916.060145565044;3930.390789427643;3930.4104384342004;3932.4297976793778;3626.9093272668392;3775.0562359410146;4033.657139143147;4034.9394759078637;4036.0717035082093;3837.7505462144873;4289.935650965238;4608.9308660370125;4642.3500709900645;4647.838754978883;5306.204069389622;5471.890562188734;5563.332400112013;5584.469475399912;5592.2318452366335;1209.7660386405817;1321.6960099177243;1379.5516457151466;1380.9930950345183;1385.4621370278983;875.5490922175085;894.7696916739483;901.5041727050096;939.5959737312884;946.0019679238469;5126.923346097286;5219;5224.085784987612;5225.425203227642;5278.5513231375;4925.335079764258;5562.276904002535;5612.466815652507;5713.2576363345825;5721.342045664718;4089.5297040840087;4580.656450766206;5026.79892804291;5164.535191832753;5199.792008319625;2304.8847557622053;2870.7416332529756;2890.7398334149607;2911.417716456675;2918.8248705077763;4708.516817202571;4938.222259971125;5186.974065129651;5603.439656034446;5628.85927851807;4508.120916421332;5229.241759944863;5351.518363347317;5575.60970732053;5598.440155984369;4600.987782687804;5591.860203494945;5610.980047183011;5622.634528755618;5647.322321321386;4631.93052104212;4653.7207767534055;5382.923415316874;5433.375161856437;5462.481064298885;4716.764161791828;5582.609217354746;5656.179853921076;5664.762418844616;5672.14917762339;4659.765162232079;5874.559408044328;5875.619229481154;5877.853053673693;5910.290765108214;3003.549467579793;3749.5875453699527;3780;3790.2040571480297;3823.9044023898514;5618.85952851182;5629.88740225185;5670.801521946877;5672.75199456119;5698.715064246689;5491.75287112073;5511.511891789114;5520.475554822286;5520.895820835769;5540.22436858832;5266.210068489757;5383.461653834585;5412.350517937873;5432.809851655173;5499.807506737245;4502.906148640897;4705.952940470688;5112.932240655577;5290.28581141541;5396.1366181410785;4449.421575195204;5171.732925433293;5241.633085683966;5422.4753909958845;5570.470805273492;4952.281919121635;5412.810551630674;5432.266644003009;5440.510354068153;5472.2338872557075 05:24:09 INFO - PROCESS | 1659 | |5;yui.html;567.4439049731263;597.4808378649751;668.5119862500378;721.2030706069794;760.2169765141906;14451.988360814747;15133.394664213445;15159.924200378982;15172.772408413868;15181.848181518195;13067.673308167301;14018.789718154236;14177.574672759807;14206.71586568268;14210.644733881658;829.1708291708277;856.7472595584318;857.5540718826206;858.6737039924819;859.6862145316945;678.7285085965628;701.2636731432001;705.3581241070626;830.4062595244399;850.8255807559466;903.421810041574;905.5608030105394;905.7509184974119;906.7506435730194;908.0601577367426;897.1656359585583;898.734873212404;898.7618281155499;898.8292224477328;898.8831451911242;522.4488164985938;536.8550491367309;537.4571682600563;538.1201735162997;666.4202144134586;11532.769344613145;12449.696806090902;14448.566543003726;14480.710385792225;14774.409023639042;13998.803946974942;14359.497417590439;14468.710625787426;14482.203478808662;14628.34172462231;11638.825417618742;11703.473343699468;11723.003544698626;11745.706357341049;12137.271763694207;3728.291624591319;3735.2156047230114;3738.9252214955823;3779.565349984732;3834.65488106069;112500.43749781199;114975.42512287469;115678.84321156848;116213;117270.82729172685;10938.507767150497;10959;11052.226344155832;11127.165462590337;11518.712032199262;20535.38393848187;22378.664320035212;22502.887485562795;22573;22592.98331575083;7883.093444253869;7920.049594048751;7979.601019948979;8040.477368970998;8088.555129467935;4231.894202644959;4279.443672322578;4327.394164816865;4470.173017991682;4491.820327186876;3046.9792619472723;3509.7367697422796;3635.0367152704025;3652.214773823641;3654.3239500692457;642.3063091860779;650.6161364794793;669.2638098092157;669.7622344067786;673.7170388436869;496.89813588214327;632.1087266953573;633.7433339497511;638.5817289675177;643.1125047434604;8566.400351975302;8634.827303454022;8789.472631642122;8855.91144088551;9907.653232136841;545.3584710022781;582.3681305783188;600.4025994135776;612.574260888678;633.1073186806581;3558.893233203008;4481.462224533012;4496.9325460118125;4507.729536227836;4617.168909596237;116484;129120.35439822929;146900;148327;159240;126023;130529.69470305175;130921;130937.69062309446;131588;95627.52186239025;103884;104110.4794476038;107986.46006769915;120214;7118.5017048806085;8767.649294028168;9232.676856309998;9348.439093654402;9404.858927116236;51169;51827.96344073173;52325.215121772446;52951;54291.72854135704;62698;73932.89100663387;74136.88794668192;75790.24209757832;76315.56579954026;11928.343941083323;12213.206141600767;12305.56930507428;12833.679158021125;12861.2926289055;14074.507392241223;14168.716625667636;14227.715445691236;14398.352074156479;14877.851221487646;13272.46910123623;13332.866671333162;13392;13523.729525409633;13686.931565342109;10098.596056157672;11776;12654.620361389174;12754.42605082755;13196.14225075367;12971.481140754264;13107.178857650413;13112.803307950198;13130.474781008652;13197.934010329887;8730.301575874042;10406.725970494235;10578.259521833397;10908.181886358714;10925.836112458479;8428.789280268042;9437.339386242897;11223.923574138811;11317.264377815416;11325.377104259345 05:24:09 INFO - PROCESS | 1659 | __end_tp_report 05:24:09 INFO - PROCESS | 1659 | __start_cc_report 05:24:09 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1696 05:24:09 INFO - PROCESS | 1659 | __end_cc_report 05:24:09 INFO - PROCESS | 1659 | __startTimestamp1476447849294__endTimestamp 05:24:09 INFO - PROCESS | 1659 | 05:24:09 INFO - PROCESS | 1659 | ------- Summary: start ------- 05:24:09 INFO - PROCESS | 1659 | Number of tests: 6 05:24:09 INFO - PROCESS | 1659 | 05:24:09 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5624.51 Median:5801.19 stddev:633.85 (10.9%) stddev-sans-first:607.60 05:24:09 INFO - PROCESS | 1659 | Values: 3241.5 3250.4 3261.9 3286.0 3311.0 5519.5 5623.7 5626.7 5645.7 5707.7 5578.0 5623.7 5623.7 5628.2 5631.0 5062.8 5098.2 5115.7 5128.8 5157.9 5190.7 5226.2 5236.0 5238.2 5238.9 5101.4 5142.6 5151.9 5178.8 5223.5 5198.1 5206.4 5229.5 5230.0 5263.6 5020.2 5055.3 5112.8 5143.6 5144.5 5509.1 5541.7 5584.9 5603.8 5650.5 6061.7 6069.8 6075.6 6090.9 6099.7 5156.4 6062.5 6072.4 6142.8 6165.3 5651.9 5665.5 5698.0 5725.1 5735.9 6269.4 6279.8 6283.5 6295.8 6311.7 5874.6 5970.9 5976.3 5992.0 6068.2 6013.3 6042.4 6088.8 6102.0 6105.5 6035.1 6063.5 6094.6 6131.1 6132.6 6060.7 6090.1 6096.1 6100.8 6133.0 4768.4 4785.7 4822.6 4850.7 4861.7 4324.7 4371.4 4373.9 4379.6 4409.6 5643.8 5648.9 5658.0 5660.0 5671.6 6173.3 6198.8 6213.7 6227.2 6242.0 4746.6 5520.6 5552.6 5599.9 5689.2 5318.8 5337.5 5376.4 5380.2 5395.7 6365.7 6373.8 6378.0 6381.1 6390.4 5882.6 6129.3 6227.3 6227.7 6235.0 6093.5 6135.7 6182.6 6266.6 6320.1 5031.6 6002.2 6018.6 6026.2 6034.9 5158.5 6114.7 6131.0 6180.5 6200.8 4850.9 5845.2 5882.8 5893.0 5969.6 5922.7 5927.3 5938.2 5983.5 5995.3 5801.2 5803.9 5804.1 5813.1 5817.7 5701.1 5825.4 5895.7 5930.0 5931.3 5787.2 5797.0 5832.9 5880.3 5894.1 05:24:09 INFO - PROCESS | 1659 | 05:24:09 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:69002.85 Median:39899.40 stddev:153028.03 (383.5%) stddev-sans-first:153370.89 05:24:09 INFO - PROCESS | 1659 | Values: 504.8 509.8 511.8 522.0 560.6 30613.8 38780.4 39844.8 40042.0 42485.0 41411.0 41761.0 41778.4 41912.8 41947.0 9439.8 9590.4 9617.4 9634.5 9643.8 9377.1 9468.9 9513.2 9561.6 9574.7 9534.8 9595.1 9603.6 9612.6 9638.9 8539.9 9227.1 9453.4 9527.1 9589.3 9248.1 9300.4 9370.5 9477.1 9483.2 39867.8 39931.0 40047.8 40121.8 40137.8 3363.5 3382.4 3574.4 3574.7 3822.1 30002.4 30368.7 30826.2 31008.4 31037.8 3190.6 3191.6 3197.9 3208.5 3304.0 443648.0 446177.0 449764.0 449927.8 456094.0 57295.7 57592.7 57726.1 57726.7 57757.7 33230.7 33806.2 60085.4 60114.3 60160.0 15720.9 16236.8 16242.5 16271.9 16274.2 12191.3 12403.2 12485.5 12547.2 12568.5 18399.1 18498.4 18621.9 18651.5 18674.6 6479.4 7709.7 7766.3 7767.5 7901.3 828.7 911.9 927.9 936.5 1037.2 28683.8 29632.6 29697.0 29823.7 30163.5 985.4 1016.9 1030.4 1079.9 1124.8 14560.0 15119.9 15274.8 15382.5 15523.7 661460.7 667486.0 668162.0 669162.0 669871.0 56536.4 56900.4 56930.0 56945.1 57117.0 1338.4 1370.8 1390.8 1395.2 1398.1 28181.7 28856.0 28921.9 29589.6 29651.6 48801.3 49130.3 49192.3 49196.0 49269.5 574127.0 578019.0 578044.0 578634.0 579319.0 25930.7 26145.2 26249.0 26308.5 26318.7 45869.0 45951.0 47231.0 47337.5 47379.8 30060.5 31948.7 37895.0 38113.6 39107.4 31741.2 36944.6 37871.2 39028.8 39070.4 36867.0 36946.0 37268.8 37570.8 37985.3 28112.7 32233.8 33331.0 33400.0 33457.0 24710.5 24827.6 25042.0 25296.4 25338.0 05:24:09 INFO - PROCESS | 1659 | 05:24:09 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:34043.11 Median:25846.68 stddev:98250.12 (380.1%) stddev-sans-first:98493.12 05:24:09 INFO - PROCESS | 1659 | Values: 324.8 350.1 371.2 374.4 403.3 14906.7 15132.3 17418.1 18750.2 19579.9 19850.2 19942.5 20791.5 20928.2 21042.9 5390.9 5955.3 6025.3 6036.3 6037.2 4129.3 4286.6 5850.9 5910.0 5969.9 4322.5 6505.3 6569.5 6579.7 6584.7 6280.6 6487.4 6565.1 6578.4 6578.9 5638.2 5647.5 5657.8 5658.5 5658.9 24571.0 25358.9 25404.0 25707.0 25986.4 2221.0 2299.9 2308.3 2360.5 2778.3 14508.0 15354.0 15420.9 15532.7 15999.0 1803.9 1863.9 1902.2 1928.1 1932.1 111958.0 118480.0 118900.0 119188.8 119805.0 10059.4 10141.6 10186.8 10348.4 10845.5 11830.9 12607.7 13291.5 13304.6 13312.5 8054.7 8088.9 8366.2 8424.9 8495.5 8391.9 8457.0 8627.3 8638.4 8832.0 6305.5 6447.5 6447.6 6450.5 6458.8 1711.6 1842.3 1884.1 1887.1 1890.6 849.8 858.2 949.9 955.0 971.8 21124.3 21848.0 21868.5 21897.3 21904.5 820.5 870.3 871.5 947.0 1021.8 10931.9 11411.9 11526.3 11536.3 11544.2 581929.0 582398.0 588198.0 600236.0 606773.0 91025.0 98667.0 113361.0 113775.0 116176.3 884.0 921.9 940.9 941.7 947.0 17947.4 19149.4 19155.8 19396.9 19553.4 37478.3 50576.7 50854.5 50860.0 51751.7 70919.6 71554.6 72092.6 72129.3 72516.0 7192.2 7692.2 7851.4 7954.3 8119.8 12423.6 12904.2 12952.5 13140.9 13155.5 11125.7 11168.1 11315.9 11485.0 11513.5 9634.6 10758.6 11150.0 11287.9 11461.2 10274.9 11590.4 11632.8 11678.0 11768.9 7719.1 7774.3 7798.2 7858.7 7930.4 11309.8 11386.4 11458.5 11535.9 11662.5 05:24:09 INFO - PROCESS | 1659 | 05:24:09 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5451.70 Median:5077.92 stddev:3051.26 (60.1%) stddev-sans-first:3044.14 05:24:09 INFO - PROCESS | 1659 | Values: 1335.6 1381.4 1489.4 1643.8 1850.9 6777.9 8105.5 8235.7 8571.1 8574.7 8415.4 8508.6 8520.4 8521.5 8526.0 2263.0 2294.6 2295.5 2296.7 2300.1 2251.6 2289.6 2305.5 2313.0 2314.1 2258.9 2286.0 2301.6 2301.7 2306.5 2255.9 2274.9 2276.7 2280.0 2287.1 2258.7 2267.4 2268.2 2270.1 2273.4 8399.7 8418.5 8634.6 8642.4 8677.7 5115.3 5262.2 5270.5 5271.9 5279.8 3447.0 3479.4 3523.9 3550.4 3554.3 934.9 1053.9 1063.3 1078.5 1080.9 11063.4 11112.8 11186.8 11215.8 11240.7 4236.7 4361.0 4443.3 4462.8 4488.1 8764.1 8773.7 8777.3 8786.1 8787.6 5070.2 5073.6 5082.2 5086.2 5088.1 4290.5 4291.2 4448.1 4775.5 4803.8 3137.3 3585.9 3601.2 3706.3 3760.4 1104.1 1116.1 1131.9 1132.9 1140.8 833.2 839.2 882.8 885.3 925.9 5426.5 5463.6 5654.0 5712.9 5827.9 972.1 989.3 991.5 991.7 993.9 3683.2 3709.3 3732.6 3878.6 3921.6 10069.5 10498.2 10507.7 10508.6 10525.2 10463.9 10465.7 10467.4 10480.0 10483.6 7881.0 8011.8 8032.5 8040.6 8047.8 4947.8 5548.6 5555.9 5819.0 5921.4 9396.6 9685.9 9707.4 9721.8 9722.7 9123.9 9485.1 9495.3 9598.7 9735.3 6183.4 6721.8 6970.4 7176.9 7280.5 7621.2 7693.0 7693.5 7706.1 7717.3 6545.7 6643.4 7244.4 7328.8 7363.0 7020.5 7124.3 7142.3 7163.5 7200.5 6838.3 6855.2 6879.6 6879.7 6888.8 4422.0 4567.7 4600.0 4602.0 4679.7 4163.2 4791.4 4882.3 4931.7 5105.1 05:24:09 INFO - PROCESS | 1659 | 05:24:09 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:4422.76 Median:4989.54 stddev:1347.30 (27.0%) stddev-sans-first:1315.01 05:24:09 INFO - PROCESS | 1659 | Values: 296.5 297.2 303.8 305.1 311.0 4674.4 4706.2 5084.6 5309.2 5323.8 4950.7 5081.4 5101.6 5179.3 5264.7 3447.4 3942.9 3947.0 3951.7 3954.9 3476.0 3563.3 3795.5 4035.9 4048.5 3656.8 3800.9 3913.8 3964.9 3985.6 3971.2 3987.2 4003.9 4006.4 4018.7 3481.6 3483.9 3492.2 3498.2 3508.7 4475.9 5072.5 5138.7 5149.7 5159.4 4157.9 4520.2 4522.7 4527.3 4589.4 5419.7 5490.8 5504.3 5522.8 5523.8 3380.8 3472.6 3596.6 3755.4 3781.3 4359.8 4815.8 5595.8 5684.5 5770.4 3369.6 3916.1 3930.4 3930.4 3932.4 3626.9 3775.1 4033.7 4034.9 4036.1 3837.8 4289.9 4608.9 4642.4 4647.8 5306.2 5471.9 5563.3 5584.5 5592.2 1209.8 1321.7 1379.6 1381.0 1385.5 875.5 894.8 901.5 939.6 946.0 5126.9 5219.0 5224.1 5225.4 5278.6 4925.3 5562.3 5612.5 5713.3 5721.3 4089.5 4580.7 5026.8 5164.5 5199.8 2304.9 2870.7 2890.7 2911.4 2918.8 4708.5 4938.2 5187.0 5603.4 5628.9 4508.1 5229.2 5351.5 5575.6 5598.4 4601.0 5591.9 5611.0 5622.6 5647.3 4631.9 4653.7 5382.9 5433.4 5462.5 4716.8 5582.6 5656.2 5664.8 5672.1 4659.8 5874.6 5875.6 5877.9 5910.3 3003.5 3749.6 3780.0 3790.2 3823.9 5618.9 5629.9 5670.8 5672.8 5698.7 5491.8 5511.5 5520.5 5520.9 5540.2 5266.2 5383.5 5412.4 5432.8 5499.8 4502.9 4706.0 5112.9 5290.3 5396.1 4449.4 5171.7 5241.6 5422.5 5570.5 4952.3 5412.8 5432.3 5440.5 5472.2 05:24:09 INFO - PROCESS | 1659 | 05:24:09 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:23692.71 Median:3653.27 stddev:38183.12 (1045.2%) stddev-sans-first:38250.76 05:24:09 INFO - PROCESS | 1659 | Values: 567.4 597.5 668.5 721.2 760.2 14452.0 15133.4 15159.9 15172.8 15181.8 13067.7 14018.8 14177.6 14206.7 14210.6 829.2 856.7 857.6 858.7 859.7 678.7 701.3 705.4 830.4 850.8 903.4 905.6 905.8 906.8 908.1 897.2 898.7 898.8 898.8 898.9 522.4 536.9 537.5 538.1 666.4 11532.8 12449.7 14448.6 14480.7 14774.4 13998.8 14359.5 14468.7 14482.2 14628.3 11638.8 11703.5 11723.0 11745.7 12137.3 3728.3 3735.2 3738.9 3779.6 3834.7 112500.4 114975.4 115678.8 116213.0 117270.8 10938.5 10959.0 11052.2 11127.2 11518.7 20535.4 22378.7 22502.9 22573.0 22593.0 7883.1 7920.0 7979.6 8040.5 8088.6 4231.9 4279.4 4327.4 4470.2 4491.8 3047.0 3509.7 3635.0 3652.2 3654.3 642.3 650.6 669.3 669.8 673.7 496.9 632.1 633.7 638.6 643.1 8566.4 8634.8 8789.5 8855.9 9907.7 545.4 582.4 600.4 612.6 633.1 3558.9 4481.5 4496.9 4507.7 4617.2 116484.0 129120.4 146900.0 148327.0 159240.0 126023.0 130529.7 130921.0 130937.7 131588.0 95627.5 103884.0 104110.5 107986.5 120214.0 7118.5 8767.6 9232.7 9348.4 9404.9 51169.0 51828.0 52325.2 52951.0 54291.7 62698.0 73932.9 74136.9 75790.2 76315.6 11928.3 12213.2 12305.6 12833.7 12861.3 14074.5 14168.7 14227.7 14398.4 14877.9 13272.5 13332.9 13392.0 13523.7 13686.9 10098.6 11776.0 12654.6 12754.4 13196.1 12971.5 13107.2 13112.8 13130.5 13197.9 8730.3 10406.7 10578.3 10908.2 10925.8 8428.8 9437.3 11223.9 11317.3 11325.4 05:24:09 INFO - PROCESS | 1659 | -------- Summary: end -------- 05:24:09 INFO - PROCESS | 1659 | 05:24:09 INFO - TEST-INFO | 1659: exit 0 05:24:09 INFO - TEST-OK | dromaeo_css | took 1119840ms 05:24:09 INFO - TEST-START | kraken 05:24:09 INFO - operating with platform_type : mac_ 05:24:09 INFO - Initialising browser for kraken test... 05:24:09 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/tmpkzoLgd/profile http://localhost:49274/getInfo.html) 05:24:12 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 05:24:12 INFO - PROCESS | 1666 | colorDepth:24 05:24:12 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 05:24:12 INFO - PROCESS | 1666 | __metrics 05:24:12 INFO - PROCESS | 1666 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:24:12 INFO - PROCESS | 1666 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:24:12 INFO - TEST-INFO | 1666: exit 0 05:24:12 INFO - Browser initialized. 05:24:12 INFO - Running cycle 1/1 for kraken test... 05:24:12 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/tmpkzoLgd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:24:24 INFO - PROCESS | 1667 | RSS: Main: 234651648 05:24:24 INFO - PROCESS | 1667 | 05:24:27 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 05:24:28 INFO - PROCESS | 1667 | RSS: Main: 293490688 05:24:28 INFO - PROCESS | 1667 | 05:24:31 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 05:24:31 INFO - PROCESS | 1667 | RSS: Main: 293961728 05:24:31 INFO - PROCESS | 1667 | 05:24:35 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 05:24:35 INFO - PROCESS | 1667 | RSS: Main: 384323584 05:24:35 INFO - PROCESS | 1667 | 05:24:37 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 05:24:38 INFO - PROCESS | 1667 | RSS: Main: 285302784 05:24:38 INFO - PROCESS | 1667 | 05:24:40 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:24:41 INFO - PROCESS | 1667 | RSS: Main: 289398784 05:24:41 INFO - PROCESS | 1667 | 05:24:44 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 05:24:44 INFO - PROCESS | 1667 | RSS: Main: 325656576 05:24:44 INFO - PROCESS | 1667 | 05:24:47 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 05:24:48 INFO - PROCESS | 1667 | RSS: Main: 328560640 05:24:48 INFO - PROCESS | 1667 | 05:24:50 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 05:24:51 INFO - PROCESS | 1667 | RSS: Main: 325758976 05:24:51 INFO - PROCESS | 1667 | 05:24:53 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:24:53 INFO - PROCESS | 1667 | RSS: Main: 301760512 05:24:53 INFO - PROCESS | 1667 | 05:24:55 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:24:56 INFO - PROCESS | 1667 | RSS: Main: 305397760 05:24:56 INFO - PROCESS | 1667 | 05:24:58 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:24:59 INFO - PROCESS | 1667 | RSS: Main: 309751808 05:24:59 INFO - PROCESS | 1667 | 05:25:02 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:25:03 INFO - PROCESS | 1667 | RSS: Main: 322920448 05:25:03 INFO - PROCESS | 1667 | 05:25:06 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:25:06 INFO - PROCESS | 1667 | RSS: Main: 322297856 05:25:06 INFO - PROCESS | 1667 | 05:25:08 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 05:25:08 INFO - PROCESS | 1667 | RSS: Main: 366399488 05:25:08 INFO - PROCESS | 1667 | 05:25:08 INFO - PROCESS | 1667 | __start_tp_report 05:25:08 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 05:25:08 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 05:25:08 INFO - PROCESS | 1667 | |i|pagename|runs| 05:25:08 INFO - PROCESS | 1667 | |0;ai-astar;114;112;113;113;113;113;112;110;111;112 05:25:08 INFO - PROCESS | 1667 | |1;audio-beat-detection;148;112;145;149;114;114;113;113;170;139 05:25:08 INFO - PROCESS | 1667 | |2;audio-dft;183;184;184;182;184;185;180;179;182;184 05:25:08 INFO - PROCESS | 1667 | |3;audio-fft;78;59;58;88;62;59;58;61;82;58 05:25:08 INFO - PROCESS | 1667 | |4;audio-oscillator;95;103;126;102;67;70;105;97;100;97 05:25:08 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;89;87;90;86;88;85;90;87;89;86 05:25:08 INFO - PROCESS | 1667 | |6;imaging-darkroom;94;94;97;95;94;94;94;95;93;95 05:25:08 INFO - PROCESS | 1667 | |7;imaging-desaturate;84;84;83;87;86;84;84;86;85;84 05:25:08 INFO - PROCESS | 1667 | |8;json-parse-financial;55;54;53;54;55;55;54;54;54;55 05:25:08 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;71;65;65;75;72;71;68;66;70;72 05:25:08 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;85;86;88;89;89;91;91;87;85;92 05:25:08 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;146;156;124;133;153;152;155;157;208;164 05:25:08 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;173;172;180;157;239;233;175;172;172;174 05:25:08 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;68;70;67;69;68;68;67;68;68;69 05:25:08 INFO - PROCESS | 1667 | __end_tp_report 05:25:08 INFO - PROCESS | 1667 | __start_cc_report 05:25:08 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,2078 05:25:08 INFO - PROCESS | 1667 | __end_cc_report 05:25:08 INFO - PROCESS | 1667 | __startTimestamp1476447908656__endTimestamp 05:25:08 INFO - PROCESS | 1667 | 05:25:08 INFO - PROCESS | 1667 | ------- Summary: start ------- 05:25:08 INFO - PROCESS | 1667 | Number of tests: 14 05:25:08 INFO - PROCESS | 1667 | 05:25:08 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:1.16 (1.0%) stddev-sans-first:1.05 05:25:08 INFO - PROCESS | 1667 | Values: 114.0 112.0 113.0 113.0 113.0 113.0 112.0 110.0 111.0 112.0 05:25:08 INFO - PROCESS | 1667 | 05:25:08 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:131.70 Median:142.00 stddev:21.02 (14.8%) stddev-sans-first:21.45 05:25:08 INFO - PROCESS | 1667 | Values: 148.0 112.0 145.0 149.0 114.0 114.0 113.0 113.0 170.0 139.0 05:25:08 INFO - PROCESS | 1667 | 05:25:08 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:182.70 Median:184.00 stddev:1.95 (1.1%) stddev-sans-first:2.06 05:25:08 INFO - PROCESS | 1667 | Values: 183.0 184.0 184.0 182.0 184.0 185.0 180.0 179.0 182.0 184.0 05:25:08 INFO - PROCESS | 1667 | 05:25:08 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:66.30 Median:61.50 stddev:11.61 (18.9%) stddev-sans-first:11.52 05:25:08 INFO - PROCESS | 1667 | Values: 78.0 59.0 58.0 88.0 62.0 59.0 58.0 61.0 82.0 58.0 05:25:08 INFO - PROCESS | 1667 | 05:25:08 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:68.50 stddev:17.00 (24.8%) stddev-sans-first:18.03 05:25:08 INFO - PROCESS | 1667 | Values: 95.0 103.0 126.0 102.0 67.0 70.0 105.0 97.0 100.0 97.0 05:25:08 INFO - PROCESS | 1667 | 05:25:08 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:87.70 Median:88.50 stddev:1.77 (2.0%) stddev-sans-first:1.81 05:25:08 INFO - PROCESS | 1667 | Values: 89.0 87.0 90.0 86.0 88.0 85.0 90.0 87.0 89.0 86.0 05:25:08 INFO - PROCESS | 1667 | 05:25:08 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:94.50 Median:94.50 stddev:1.08 (1.1%) stddev-sans-first:1.13 05:25:08 INFO - PROCESS | 1667 | Values: 94.0 94.0 97.0 95.0 94.0 94.0 94.0 95.0 93.0 95.0 05:25:08 INFO - PROCESS | 1667 | 05:25:08 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:84.50 stddev:1.25 (1.5%) stddev-sans-first:1.30 05:25:08 INFO - PROCESS | 1667 | Values: 84.0 84.0 83.0 87.0 86.0 84.0 84.0 86.0 85.0 84.0 05:25:08 INFO - PROCESS | 1667 | 05:25:08 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.50 stddev:0.67 (1.2%) stddev-sans-first:0.67 05:25:08 INFO - PROCESS | 1667 | Values: 55.0 54.0 53.0 54.0 55.0 55.0 54.0 54.0 54.0 55.0 05:25:08 INFO - PROCESS | 1667 | 05:25:08 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:71.00 stddev:3.37 (4.8%) stddev-sans-first:3.54 05:25:08 INFO - PROCESS | 1667 | Values: 71.0 65.0 65.0 75.0 72.0 71.0 68.0 66.0 70.0 72.0 05:25:08 INFO - PROCESS | 1667 | 05:25:08 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:89.00 stddev:2.54 (2.9%) stddev-sans-first:2.40 05:25:08 INFO - PROCESS | 1667 | Values: 85.0 86.0 88.0 89.0 89.0 91.0 91.0 87.0 85.0 92.0 05:25:08 INFO - PROCESS | 1667 | 05:25:08 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:154.80 Median:155.50 stddev:22.20 (14.3%) stddev-sans-first:23.31 05:25:08 INFO - PROCESS | 1667 | Values: 146.0 156.0 124.0 133.0 153.0 152.0 155.0 157.0 208.0 164.0 05:25:08 INFO - PROCESS | 1667 | 05:25:08 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.70 Median:174.50 stddev:27.69 (15.9%) stddev-sans-first:29.04 05:25:08 INFO - PROCESS | 1667 | Values: 173.0 172.0 180.0 157.0 239.0 233.0 175.0 172.0 172.0 174.0 05:25:08 INFO - PROCESS | 1667 | 05:25:08 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 05:25:08 INFO - PROCESS | 1667 | Values: 68.0 70.0 67.0 69.0 68.0 68.0 67.0 68.0 68.0 69.0 05:25:08 INFO - PROCESS | 1667 | -------- Summary: end -------- 05:25:08 INFO - PROCESS | 1667 | 05:25:09 INFO - TEST-INFO | 1667: exit 0 05:25:09 INFO - TEST-OK | kraken | took 59622ms 05:25:09 INFO - SUITE-END | took 1179s 05:25:09 INFO - Completed test suite (00:19:39) 05:25:09 INFO - javascript benchmark 05:25:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3241.4813629819228, 3250.3824273388063, 3261.885833995809, 3286.0470463565566, 3311.0, 5519.503244707976, 5623.718814059296, 5626.718664066791, 5645.661260324378, 5707.658700205454, 5578.0, 5623.662580245178, 5623.662580245188, 5628.240187574676, 5630.971845140779, 5062.822801201949, 5098.184290513518, 5115.744212789365, 5128.794848206067, 5157.896842063156, 5190.688558686472, 5226.1899405592, 5236.031334203185, 5238.188080847474, 5238.8690282742855, 5101.38783345999, 5142.640015198937, 5151.948480515184, 5178.792848286064, 5223.477652234784, 5198.064348417283, 5206.401263854667, 5229.47705229474, 5230.0, 5263.578913686896, 5020.196768517019, 5055.342805435306, 5112.769925353368, 5143.588512918957, 5144.511271429208, 5509.090999984997, 5541.667499950016, 5584.944150558524, 5603.775848966036, 5650.5479561634975, 6061.66660833654, 6069.817905462844, 6075.574709770318, 6090.939090609081, 6099.664518451484, 5156.355455568054, 6062.454379105901, 6072.423119803611, 6142.7850025249345, 6165.2601687797305, 5651.886962260732, 5665.54675625953, 5698.0, 5725.112607545837, 5735.8566035849435, 6269.373062693694, 6279.811605651837, 6283.528735344776, 6295.842603934938, 6311.747530098744, 5874.648830768947, 5970.880582388328, 5976.282846058414, 5991.970040149771, 6068.241469816273, 6013.338532761392, 6042.39576042401, 6088.756449741961, 6102.0, 6105.511559075263, 6035.094735789579, 6063.454289114001, 6094.603850749687, 6131.14164017038, 6132.63204207749, 6060.666663333471, 6090.147379366892, 6096.146539484475, 6100.755969761249, 6133.0, 4768.427788665383, 4785.712857228577, 4822.565969062801, 4850.708957462563, 4861.683990540674, 4324.697271190987, 4371.431713877176, 4373.9125217495475, 4379.605835474823, 4409.603135717801, 5643.802466913638, 5648.943510564842, 5658.0, 5659.971700141473, 5671.602987790815, 6173.290071641729, 6198.81403557894, 6213.689315534205, 6227.221597300338, 6242.0, 4746.620270378361, 5520.641158324696, 5552.611317207757, 5599.916001259984, 5689.203511508392, 5318.760655770499, 5337.492938170868, 5376.354837419534, 5380.1929710542945, 5395.73021348931, 6365.681715914278, 6373.808785736435, 6378.043293505825, 6381.074744162163, 6390.392912673288, 5882.558808089325, 6129.264488261437, 6227.283862355887, 6227.657478838707, 6235.033569796688, 6093.542984276109, 6135.692037377249, 6182.598131121463, 6266.561340706106, 6320.083587879823, 5031.622628302819, 6002.159697642421, 6018.578699490994, 6026.186464827192, 6034.9094763577705, 5158.45836187195, 6114.7248373822395, 6130.969345153246, 6180.47465965398, 6200.81397558074, 4850.902981940412, 5845.18167456565, 5882.823515294548, 5893.02765043763, 5969.611975221596, 5922.7334769936315, 5927.288725352985, 5938.168656388196, 5983.521318294613, 5995.250593675791, 5801.1878337033695, 5803.883922321615, 5804.071348584206, 5813.069908814569, 5817.650940943557, 5701.116326969326, 5825.3592104867585, 5895.7052147393315, 5930.0, 5931.347551769388, 5787.247657804459, 5797.043487824631, 5832.854178645398, 5880.323762767336, 5894.056950887837], "value": 5584.629594241653, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [504.7678068088679, 509.8266589359619, 511.84900454365965, 521.9791208351664, 560.6439910656732, 30613.775448982044, 38780.41829372562, 39844.80077599608, 40042.0, 42485.0, 41411.0, 41761.0, 41778.373324400156, 41912.79043604778, 41946.95132621678, 9439.764005899839, 9590.424574525516, 9617.42295462271, 9634.518274086302, 9643.758906027335, 9377.062293770603, 9468.905310946871, 9513.191378732816, 9561.61753529858, 9574.664886728966, 9534.761630959247, 9595.136437720605, 9603.567839447242, 9612.615495380176, 9638.855417168748, 8539.914600853974, 9227.077292270718, 9453.432794032311, 9527.09492598202, 9589.280803939733, 9248.121428464285, 9300.395474294217, 9370.484623345714, 9477.147056764925, 9483.193928516084, 39867.8006609968, 39931.00172495682, 40047.799761001006, 40121.78112392584, 40137.799311003255, 3363.5122907178566, 3382.4080785862375, 3574.392353299945, 3574.6782789549065, 3822.140018495816, 30002.399952000836, 30368.696313037028, 30826.229344266347, 31008.37983240345, 31037.844810776027, 3190.6490286068515, 3191.6489186189733, 3197.8560964756407, 3208.4545627243424, 3303.9834800826084, 443648.0, 446177.0, 449764.0, 449927.7503612494, 456094.0, 57295.713521432124, 57592.71203644039, 57726.13410798757, 57726.7113664429, 57757.711211443675, 33230.66769332276, 33806.154846129044, 60085.39914600798, 60114.28914253139, 60160.0, 15720.92139539318, 16236.837631623532, 16242.51272461828, 16271.918640406959, 16274.186290685418, 12191.329476878856, 12403.193792403645, 12485.500579976699, 12547.24716517012, 12568.497260109492, 18399.136181402057, 18498.35255766042, 18621.90689046546, 18651.48204992309, 18674.626507469773, 6479.449246814073, 7709.691612335556, 7766.262205090507, 7767.495112817649, 7901.328387087047, 828.7348048624502, 911.9498427586414, 927.8726347487834, 936.4849332866896, 1037.2479952034864, 28683.836909356098, 29632.61809415654, 29697.0, 29823.701762982528, 30163.547546786816, 985.4038306824411, 1016.9338992965434, 1030.443560477349, 1079.940603266812, 1124.7694222684331, 14560.0, 15119.924400378148, 15274.847251527342, 15382.461613843685, 15523.689526209413, 661460.6926965334, 667486.0, 668162.0, 669162.0, 669871.0, 56536.43463565312, 56900.430995689516, 56930.02234765373, 56945.145822812694, 57117.0, 1338.377654390713, 1370.7532644123953, 1390.8052872598046, 1395.2186775405805, 1398.1052126638958, 28181.71818281791, 28856.0, 28921.855390723755, 29589.5561566581, 29651.555226671186, 48801.2679809796, 49130.26304605505, 49192.26211606757, 49196.0, 49269.50730492649, 574127.0, 578019.0, 578044.0, 578634.0, 579319.0, 25930.740692592834, 26145.215643530726, 26248.95004199887, 26308.473830523664, 26318.736812632396, 45869.0, 45951.0, 47231.0, 47337.52662473331, 47379.763101184275, 30060.54909176408, 31948.68051319457, 37895.0, 38113.618863811, 39107.41338879976, 31741.20646983844, 36944.63055369412, 37871.24257514779, 39028.80485597554, 39070.4139437903, 36867.0, 36946.0, 37268.81365593263, 37570.8121459391, 37985.290661919724, 28112.71887281101, 32233.838830805696, 33331.000069997935, 33400.0, 33457.0, 24710.50578988446, 24827.62758558587, 25041.998320066992, 25296.367590810376, 25338.0], "value": 19526.90155812459, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.81485553234654, 350.06008866194253, 371.19265597325824, 374.43647310797246, 403.30027402456733, 14906.701865962688, 15132.319045642946, 17418.129093545318, 18750.156242969064, 19579.90210048948, 19850.20599176031, 19942.50143746407, 20791.480212994684, 20928.162873485082, 21042.947852607384, 5390.9191362129595, 5955.255593050869, 6025.3372129065765, 6036.305824830135, 6037.215162028952, 4129.339305711087, 4286.57134286572, 5850.941490585083, 5909.9704501477645, 5969.940300596982, 4322.524522302544, 6505.34946505348, 6569.540132190748, 6579.736810527573, 6584.6707664616815, 6280.623162610213, 6487.448566871774, 6565.080888675589, 6578.407943285103, 6578.868422631568, 5638.154276858463, 5647.503411595931, 5657.773689052433, 5658.519025882763, 5658.943410565883, 24571.017159313607, 25358.873205634038, 25403.983840646353, 25707.0, 25986.350341241432, 2220.9555808883733, 2299.8850057497057, 2308.2728940383895, 2360.4570948681726, 2778.3470884342164, 14508.0, 15354.0, 15420.92289538545, 15532.689346213012, 15999.040057596465, 1803.9007854567994, 1863.8589812226057, 1902.2391043582538, 1928.1323404468046, 1932.1112288347376, 111958.0, 118480.0, 118900.0, 119188.80811191864, 119805.0, 10059.446730429896, 10141.594336226615, 10186.796264074677, 10348.379097254188, 10845.457727113613, 11830.940845295718, 12607.684807879876, 13291.468341266434, 13304.600861974157, 13312.534061307808, 8054.677812887418, 8088.878666820003, 8366.205210504992, 8424.915750842412, 8495.532745698922, 8391.874121888177, 8456.957715211385, 8627.309815214894, 8638.438501497383, 8832.02847686754, 6305.464035557029, 6447.451966582893, 6447.6453795041725, 6450.451711604473, 6458.838529036811, 1711.5721069732567, 1842.2723024405284, 1884.1469195495245, 1887.1413506854349, 1890.631326891243, 849.8087930215776, 858.2233079063458, 949.9192568631605, 955.0, 971.8493633486821, 21124.271254959986, 21847.972252132673, 21868.496987817274, 21897.302001740645, 21904.506064133635, 820.4994953078617, 870.3211495033884, 871.4662194537659, 946.9621215151454, 1021.8467229915424, 10931.945340273247, 11411.942940285411, 11526.250793698382, 11536.307821530734, 11544.191906566628, 581929.0, 582398.0, 588198.0, 600236.0, 606773.0, 91025.0, 98667.02665946784, 113361.0, 113775.0, 116176.25735613973, 884.0496466298755, 921.9354645174774, 940.8917974432891, 941.6610020392653, 946.9526523673788, 17947.371841985467, 19149.425517234504, 19155.808441915404, 19396.903015484833, 19553.413397598095, 37478.2504349906, 50576.74711626566, 50854.49145508498, 50860.0, 51751.74124129506, 70919.58160836858, 71554.5689086205, 72092.63953680197, 72129.27870721226, 72516.0, 7192.244814294424, 7692.192319806563, 7851.371890248881, 7954.323882469824, 8119.75640730779, 12423.565175218824, 12904.16122952005, 12952.546660866825, 13140.934295328461, 13155.53955611549, 11125.666230013112, 11168.106551476025, 11315.943420282845, 11485.0, 11513.53945842157, 9634.566444509874, 10758.569657213624, 11150.0, 11287.887121129012, 11461.197716159788, 10274.897251027693, 11590.420478976186, 11632.76734465289, 11678.0, 11768.94115529417, 7719.073711154473, 7774.30031297186, 7798.220177982384, 7858.685652573833, 7930.405219608668, 11309.773804524028, 11386.430678465878, 11458.484368203284, 11535.942320288344, 11662.475188616363], "value": 9572.131338392423, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.6443210141701, 1381.4405165907808, 1489.3617021276598, 1643.8356164383563, 1850.9259629614808, 6777.898331525031, 8105.473144245627, 8235.711750088756, 8571.100034496381, 8574.742757717278, 8415.410921235516, 8508.574571271443, 8520.360972927025, 8521.488710677364, 8526.01950775661, 2262.988685056572, 2294.575503531852, 2295.5294164696197, 2296.70142881426, 2300.1259521381853, 2251.6284813005836, 2289.5878741826464, 2305.4697419593504, 2312.9537409251807, 2314.0512389920136, 2258.8644681319174, 2285.9771402285933, 2301.608726516496, 2301.735300440454, 2306.4810417655976, 2255.875926824024, 2274.8521346112448, 2276.681264622954, 2280.04238219948, 2287.0623044551653, 2258.672492488596, 2267.4331417145713, 2268.194790849241, 2270.137347807839, 2273.4316420894775, 8399.748007559783, 8418.494890306602, 8634.611442485104, 8642.395032347738, 8677.652893884237, 5115.335006449175, 5262.236975638511, 5270.4729527047375, 5271.920921186185, 5279.762410691528, 3446.9655303446893, 3479.356319080978, 3523.8766643167623, 3550.378683730363, 3554.306910152521, 934.8784657994486, 1053.8735351757762, 1063.2716589136467, 1078.466159251168, 1080.9246247205385, 11063.391513466757, 11112.777744445146, 11186.832197517044, 11215.831762523569, 11240.718982025433, 4236.745795252295, 4360.978195109004, 4443.33349997503, 4462.799174037176, 4488.102379524108, 8764.079771623889, 8773.736787896374, 8777.253933415732, 8786.12138786129, 8787.560621968876, 5070.2141168119, 5073.644844860898, 5082.186850103965, 5086.160783470686, 5088.0587091388215, 4290.549492303326, 4291.249031419489, 4448.088141930896, 4775.450823155312, 4803.8318658847475, 3137.2784259620416, 3585.8565657373933, 3601.1537288737127, 3706.2772759311674, 3760.3983362661843, 1104.1442881766695, 1116.1294190531398, 1131.932084074958, 1132.8923752243525, 1140.7718456308771, 833.2210730091299, 839.2153336630148, 882.7969566999626, 885.3138817416553, 925.9398139120935, 5426.484483974016, 5463.590230732711, 5654.010548154057, 5712.885742285131, 5827.88344233113, 972.1153750087528, 989.317371013998, 991.5290237137447, 991.6975322526555, 993.8757655293089, 3683.208110256308, 3709.332320182339, 3732.5894151643297, 3878.553966293856, 3921.627445392683, 10069.54687039085, 10498.212634052325, 10507.737306567244, 10508.579656813794, 10525.157987360994, 10463.895361046445, 10465.738356541147, 10467.424291664032, 10480.004399582027, 10483.580656773644, 7881.0, 8011.839763204704, 8032.518048917201, 8040.638171282307, 8047.83904321922, 4947.752612369295, 5548.639338442988, 5555.8611034722835, 5819.010768169506, 5921.3782552831335, 9396.624135034523, 9685.903140968781, 9707.417554946725, 9721.805563888542, 9722.708318750449, 9123.863142053007, 9485.146336829719, 9495.335326527076, 9598.66404675833, 9735.318527702993, 6183.3816618337805, 6721.764738234138, 6970.407515361048, 7176.892346614701, 7280.453965952469, 7621.199774023869, 7692.9615351922885, 7693.538387696756, 7706.07527096752, 7717.344025757873, 6545.738170473318, 6643.40209381158, 7244.384227340735, 7328.78013659591, 7363.042804435389, 7020.508564400648, 7124.323189297009, 7142.321479459443, 7163.498555101093, 7200.49596528238, 6838.3161683833205, 6855.245922948372, 6879.621620810904, 6879.724811007503, 6888.793336199922, 4422.0, 4567.725936443824, 4600.0, 4601.953980460153, 4679.742614156254, 4163.208990291835, 4791.353167322506, 4882.340883980759, 4931.679440836334, 5105.106606343801], "value": 4393.091306198297, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.4707996226735, 297.22276247612484, 303.81163678519323, 305.10756038587135, 310.9877349228262, 4674.415698037746, 4706.1764191266475, 5084.644074914758, 5309.203619457084, 5323.840284791458, 4950.678205916622, 5081.441041485434, 5101.642884998052, 5179.326687530615, 5264.736763161845, 3447.413939630256, 3942.9354074399894, 3946.9802650986703, 3951.70362222833, 3954.861579844706, 3475.9572128361515, 3563.3051554946796, 3795.4876091727538, 4035.939460908074, 4048.453458783071, 3656.7623104498257, 3800.866969656063, 3913.8043097845134, 3964.8612298569556, 3985.581513941038, 3971.225611005855, 3987.2424239394422, 4003.919921601581, 4006.379011253231, 4018.6985976051765, 3481.599616044162, 3483.860645574199, 3492.1793378556017, 3498.230389314372, 3508.7017803412646, 4475.910481790346, 5072.54347108762, 5138.691678499302, 5149.6910185389, 5159.380874295071, 4157.875263742093, 4520.163769702583, 4522.68341216115, 4527.343535187412, 4589.449266088091, 5419.674819510842, 5490.835274941718, 5504.284443022421, 5522.834314970557, 5523.834284971457, 3380.7802492837886, 3472.6006509251506, 3596.6403359664087, 3755.380362240227, 3781.3004594149897, 4359.847405340798, 4815.80880699281, 5595.832125036255, 5684.54523638108, 5770.365259821417, 3369.6124945631077, 3916.060145565044, 3930.390789427643, 3930.4104384342004, 3932.4297976793778, 3626.9093272668392, 3775.0562359410146, 4033.657139143147, 4034.9394759078637, 4036.0717035082093, 3837.7505462144873, 4289.935650965238, 4608.9308660370125, 4642.3500709900645, 4647.838754978883, 5306.204069389622, 5471.890562188734, 5563.332400112013, 5584.469475399912, 5592.2318452366335, 1209.7660386405817, 1321.6960099177243, 1379.5516457151466, 1380.9930950345183, 1385.4621370278983, 875.5490922175085, 894.7696916739483, 901.5041727050096, 939.5959737312884, 946.0019679238469, 5126.923346097286, 5219.0, 5224.085784987612, 5225.425203227642, 5278.5513231375, 4925.335079764258, 5562.276904002535, 5612.466815652507, 5713.2576363345825, 5721.342045664718, 4089.5297040840087, 4580.656450766206, 5026.79892804291, 5164.535191832753, 5199.792008319625, 2304.8847557622053, 2870.7416332529756, 2890.7398334149607, 2911.417716456675, 2918.8248705077763, 4708.516817202571, 4938.222259971125, 5186.974065129651, 5603.439656034446, 5628.85927851807, 4508.120916421332, 5229.241759944863, 5351.518363347317, 5575.60970732053, 5598.440155984369, 4600.987782687804, 5591.860203494945, 5610.980047183011, 5622.634528755618, 5647.322321321386, 4631.93052104212, 4653.7207767534055, 5382.923415316874, 5433.375161856437, 5462.481064298885, 4716.764161791828, 5582.609217354746, 5656.179853921076, 5664.762418844616, 5672.14917762339, 4659.765162232079, 5874.559408044328, 5875.619229481154, 5877.853053673693, 5910.290765108214, 3003.549467579793, 3749.5875453699527, 3780.0, 3790.2040571480297, 3823.9044023898514, 5618.85952851182, 5629.88740225185, 5670.801521946877, 5672.75199456119, 5698.715064246689, 5491.75287112073, 5511.511891789114, 5520.475554822286, 5520.895820835769, 5540.22436858832, 5266.210068489757, 5383.461653834585, 5412.350517937873, 5432.809851655173, 5499.807506737245, 4502.906148640897, 4705.952940470688, 5112.932240655577, 5290.28581141541, 5396.1366181410785, 4449.421575195204, 5171.732925433293, 5241.633085683966, 5422.4753909958845, 5570.470805273492, 4952.281919121635, 5412.810551630674, 5432.266644003009, 5440.510354068153, 5472.2338872557075], "value": 3999.8761501610425, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.4439049731263, 597.4808378649751, 668.5119862500378, 721.2030706069794, 760.2169765141906, 14451.988360814747, 15133.394664213445, 15159.924200378982, 15172.772408413868, 15181.848181518195, 13067.673308167301, 14018.789718154236, 14177.574672759807, 14206.71586568268, 14210.644733881658, 829.1708291708277, 856.7472595584318, 857.5540718826206, 858.6737039924819, 859.6862145316945, 678.7285085965628, 701.2636731432001, 705.3581241070626, 830.4062595244399, 850.8255807559466, 903.421810041574, 905.5608030105394, 905.7509184974119, 906.7506435730194, 908.0601577367426, 897.1656359585583, 898.734873212404, 898.7618281155499, 898.8292224477328, 898.8831451911242, 522.4488164985938, 536.8550491367309, 537.4571682600563, 538.1201735162997, 666.4202144134586, 11532.769344613145, 12449.696806090902, 14448.566543003726, 14480.710385792225, 14774.409023639042, 13998.803946974942, 14359.497417590439, 14468.710625787426, 14482.203478808662, 14628.34172462231, 11638.825417618742, 11703.473343699468, 11723.003544698626, 11745.706357341049, 12137.271763694207, 3728.291624591319, 3735.2156047230114, 3738.9252214955823, 3779.565349984732, 3834.65488106069, 112500.43749781199, 114975.42512287469, 115678.84321156848, 116213.0, 117270.82729172685, 10938.507767150497, 10959.0, 11052.226344155832, 11127.165462590337, 11518.712032199262, 20535.38393848187, 22378.664320035212, 22502.887485562795, 22573.0, 22592.98331575083, 7883.093444253869, 7920.049594048751, 7979.601019948979, 8040.477368970998, 8088.555129467935, 4231.894202644959, 4279.443672322578, 4327.394164816865, 4470.173017991682, 4491.820327186876, 3046.9792619472723, 3509.7367697422796, 3635.0367152704025, 3652.214773823641, 3654.3239500692457, 642.3063091860779, 650.6161364794793, 669.2638098092157, 669.7622344067786, 673.7170388436869, 496.89813588214327, 632.1087266953573, 633.7433339497511, 638.5817289675177, 643.1125047434604, 8566.400351975302, 8634.827303454022, 8789.472631642122, 8855.91144088551, 9907.653232136841, 545.3584710022781, 582.3681305783188, 600.4025994135776, 612.574260888678, 633.1073186806581, 3558.893233203008, 4481.462224533012, 4496.9325460118125, 4507.729536227836, 4617.168909596237, 116484.0, 129120.35439822929, 146900.0, 148327.0, 159240.0, 126023.0, 130529.69470305175, 130921.0, 130937.69062309446, 131588.0, 95627.52186239025, 103884.0, 104110.4794476038, 107986.46006769915, 120214.0, 7118.5017048806085, 8767.649294028168, 9232.676856309998, 9348.439093654402, 9404.858927116236, 51169.0, 51827.96344073173, 52325.215121772446, 52951.0, 54291.72854135704, 62698.0, 73932.89100663387, 74136.88794668192, 75790.24209757832, 76315.56579954026, 11928.343941083323, 12213.206141600767, 12305.56930507428, 12833.679158021125, 12861.2926289055, 14074.507392241223, 14168.716625667636, 14227.715445691236, 14398.352074156479, 14877.851221487646, 13272.46910123623, 13332.866671333162, 13392.0, 13523.729525409633, 13686.931565342109, 10098.596056157672, 11776.0, 12654.620361389174, 12754.42605082755, 13196.14225075367, 12971.481140754264, 13107.178857650413, 13112.803307950198, 13130.474781008652, 13197.934010329887, 8730.301575874042, 10406.725970494235, 10578.259521833397, 10908.181886358714, 10925.836112458479, 8428.789280268042, 9437.339386242897, 11223.923574138811, 11317.264377815416, 11325.377104259345], "value": 7487.048005992966, "unit": "score"}], "name": "dromaeo_css", "value": 7182.935458751905, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 112.0, 113.0, 113.0, 113.0, 113.0, 112.0, 110.0, 111.0, 112.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 112.0, 145.0, 149.0, 114.0, 114.0, 113.0, 113.0, 170.0, 139.0], "value": 131.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 184.0, 182.0, 184.0, 185.0, 180.0, 179.0, 182.0, 184.0], "value": 182.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 59.0, 58.0, 88.0, 62.0, 59.0, 58.0, 61.0, 82.0, 58.0], "value": 66.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 103.0, 126.0, 102.0, 67.0, 70.0, 105.0, 97.0, 100.0, 97.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 90.0, 86.0, 88.0, 85.0, 90.0, 87.0, 89.0, 86.0], "value": 87.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 97.0, 95.0, 94.0, 94.0, 94.0, 95.0, 93.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 87.0, 86.0, 84.0, 84.0, 86.0, 85.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 54.0, 55.0, 55.0, 54.0, 54.0, 54.0, 55.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 65.0, 65.0, 75.0, 72.0, 71.0, 68.0, 66.0, 70.0, 72.0], "value": 69.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 88.0, 89.0, 89.0, 91.0, 91.0, 87.0, 85.0, 92.0], "value": 88.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 156.0, 124.0, 133.0, 153.0, 152.0, 155.0, 157.0, 208.0, 164.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 180.0, 157.0, 239.0, 233.0, 175.0, 172.0, 172.0, 174.0], "value": 184.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 67.0, 69.0, 68.0, 68.0, 67.0, 68.0, 68.0, 69.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1475.9, "alertThreshold": 2.0}]} 05:25:09 INFO - Return code: 0 05:25:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:25:09 INFO - # TBPL SUCCESS # 05:25:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:25:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:25:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:25:09 INFO - 2016-10-14 05:25:09.988 screenresolution[1671:9831] starting screenresolution argv=screenresolution get 05:25:09 INFO - 2016-10-14 05:25:09.990 screenresolution[1671:9831] Display 0: 1600x1200x32@60 05:25:09 INFO - 2016-10-14 05:25:09.997 screenresolution[1672:9834] starting screenresolution argv=screenresolution list 05:25:10 INFO - Available Modes on Display 0 05:25:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:25:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:25:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:25:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:25:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:25:10 INFO - Intel Iris: 05:25:10 INFO - Chipset Model: Intel Iris 05:25:10 INFO - Type: GPU 05:25:10 INFO - Bus: Built-In 05:25:10 INFO - VRAM (Dynamic, Max): 1536 MB 05:25:10 INFO - Vendor: Intel (0x8086) 05:25:10 INFO - Device ID: 0x0a2e 05:25:10 INFO - Revision ID: 0x0009 05:25:10 INFO - Displays: 05:25:10 INFO - Display: 05:25:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:25:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:25:10 INFO - Display Serial Number: 1600x1200 60 05:25:10 INFO - Main Display: Yes 05:25:10 INFO - Mirror: Off 05:25:10 INFO - Online: Yes 05:25:10 INFO - Rotation: Supported 05:25:10 INFO - Return code: 0 05:25:10 INFO - Running post-action listener: _resource_record_post_action 05:25:10 INFO - [mozharness: 2016-10-14 12:25:10.231095Z] Finished run-tests step (success) 05:25:10 INFO - Running post-run listener: _resource_record_post_run 05:25:10 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 37307392; Write bytes: 706665984; Read time: 237; Write time: 1992 05:25:10 INFO - TinderboxPrint: CPU usage
53.6% 05:25:10 INFO - TinderboxPrint: I/O read bytes / time
37,307,392 / 237 05:25:10 INFO - TinderboxPrint: I/O write bytes / time
706,665,984 / 1,992 05:25:10 INFO - TinderboxPrint: CPU idle
2,254.7 (46.4%) 05:25:10 INFO - TinderboxPrint: CPU system
972.6 (20.0%) 05:25:10 INFO - TinderboxPrint: CPU user
1,630.3 (33.6%) 05:25:10 INFO - TinderboxPrint: Swap in / out
443,678,720 / 0 05:25:10 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 400927232; Write bytes: 394667520; Read time: 29745; Write time: 859 05:25:10 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 35312640; Write bytes: 297236480; Read time: 218; Write time: 1094 05:25:10 INFO - Running post-run listener: _upload_blobber_files 05:25:10 INFO - Blob upload gear active. 05:25:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:25:10 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:25:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:25:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:25:11 INFO - (blobuploader) - INFO - Open directory for files ... 05:25:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:25:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:25:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:11 INFO - (blobuploader) - INFO - Done attempting. 05:25:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:25:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:25:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:12 INFO - (blobuploader) - INFO - Done attempting. 05:25:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:25:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:25:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:14 INFO - (blobuploader) - INFO - Done attempting. 05:25:14 INFO - (blobuploader) - INFO - Iteration through files over. 05:25:14 INFO - Return code: 0 05:25:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:25:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:25:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/571f9638e7043dd6d509f5bc3e5a1a28e05b47b16a1bfe0b02498549002fbd2bb1f3ac70def50e0fe166184b42bb170d232dceaa651313c7c88c211fcbfb21f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c5d7f3f5821ecc1bd62f82a06902be2cd7b50d7e09a3c2ebb9fbab307eb6f5ea98d0a2aebf0cef80c46308a49b7e709ec02099e4805d5e7680aed4486bd7adb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/097dd8b693c3cec84c4c9a78de8b7aa8993efc45de3854134ee4ea0b11aae48d6069384dc6e5e099b34a064c2adaf932e83cb608664fb71bc94531bd56dda9fe"} 05:25:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:25:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:25:14 INFO - Contents: 05:25:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/571f9638e7043dd6d509f5bc3e5a1a28e05b47b16a1bfe0b02498549002fbd2bb1f3ac70def50e0fe166184b42bb170d232dceaa651313c7c88c211fcbfb21f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c5d7f3f5821ecc1bd62f82a06902be2cd7b50d7e09a3c2ebb9fbab307eb6f5ea98d0a2aebf0cef80c46308a49b7e709ec02099e4805d5e7680aed4486bd7adb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/097dd8b693c3cec84c4c9a78de8b7aa8993efc45de3854134ee4ea0b11aae48d6069384dc6e5e099b34a064c2adaf932e83cb608664fb71bc94531bd56dda9fe"} 05:25:14 INFO - Running post-run listener: copy_logs_to_upload_dir 05:25:14 INFO - Copying logs to upload dir... 05:25:14 INFO - mkdir: /builds/slave/test/build/upload/logs 05:25:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.045650 ========= master_lag: 0.93 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-14 05:25:15.648053) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 05:25:15.655947) ========= 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.uVptKz2GVZ/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.5w22Nk0YOQ/Listeners TMPDIR=/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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/571f9638e7043dd6d509f5bc3e5a1a28e05b47b16a1bfe0b02498549002fbd2bb1f3ac70def50e0fe166184b42bb170d232dceaa651313c7c88c211fcbfb21f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c5d7f3f5821ecc1bd62f82a06902be2cd7b50d7e09a3c2ebb9fbab307eb6f5ea98d0a2aebf0cef80c46308a49b7e709ec02099e4805d5e7680aed4486bd7adb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/097dd8b693c3cec84c4c9a78de8b7aa8993efc45de3854134ee4ea0b11aae48d6069384dc6e5e099b34a064c2adaf932e83cb608664fb71bc94531bd56dda9fe"} build_url:https://queue.taskcluster.net/v1/task/YNIUD2b3SZuXi0DG49uZnw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011054 build_url: 'https://queue.taskcluster.net/v1/task/YNIUD2b3SZuXi0DG49uZnw/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/571f9638e7043dd6d509f5bc3e5a1a28e05b47b16a1bfe0b02498549002fbd2bb1f3ac70def50e0fe166184b42bb170d232dceaa651313c7c88c211fcbfb21f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c5d7f3f5821ecc1bd62f82a06902be2cd7b50d7e09a3c2ebb9fbab307eb6f5ea98d0a2aebf0cef80c46308a49b7e709ec02099e4805d5e7680aed4486bd7adb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/097dd8b693c3cec84c4c9a78de8b7aa8993efc45de3854134ee4ea0b11aae48d6069384dc6e5e099b34a064c2adaf932e83cb608664fb71bc94531bd56dda9fe"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 05:25:15.693614) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 05:25:15.694013) ========= 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.uVptKz2GVZ/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.5w22Nk0YOQ/Listeners TMPDIR=/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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.005126 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 05:25:15.742237) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 05:25:15.744564) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 05:25:15.744876) ========= ========= Total master_lag: 1.06 =========