builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0219 starttime: 1493309997.25 results: success (0) buildid: 20170427073327 builduid: 9ccf132ee1b3468c8e2f9f8b81ff4a96 revision: c0d35b1c5ab5fa9bb2f5661aa0454a1ce31b50e0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-27 09:19:57.246121) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-27 09:19:57.246575) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-27 09:19:57.246852) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-27 09:19:57.285754) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-27 09:19:57.286138) ========= 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.s15D9jFdxu/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.IdPcehrUWh/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 --2017-04-27 09:19:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 6.07M=0.002s 2017-04-27 09:19:57 (6.07 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127921 ========= master_lag: 1.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-27 09:19:58.430718) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2017-04-27 09:19:58.431048) ========= 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.s15D9jFdxu/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.IdPcehrUWh/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.022177 ========= master_lag: 1.00 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2017-04-27 09:19:59.449680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-27 09:19:59.450038) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c0d35b1c5ab5fa9bb2f5661aa0454a1ce31b50e0 --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 c0d35b1c5ab5fa9bb2f5661aa0454a1ce31b50e0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.s15D9jFdxu/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.IdPcehrUWh/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 2017-04-27 09:20:00,190 truncating revision to first 12 chars 2017-04-27 09:20:00,190 Setting DEBUG logging. 2017-04-27 09:20:00,190 attempt 1/10 2017-04-27 09:20:00,190 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c0d35b1c5ab5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-27 09:20:01,320 unpacking tar archive at: mozilla-central-c0d35b1c5ab5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.392601 ========= master_lag: 0.68 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-27 09:20:01.521726) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-27 09:20:01.522058) ========= script_repo_revision: c0d35b1c5ab5fa9bb2f5661aa0454a1ce31b50e0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-27 09:20:01.522455) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-27 09:20:01.522722) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-27 09:20:01.543273) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2017-04-27 09:20:01.543692) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.s15D9jFdxu/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.IdPcehrUWh/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 09:20:01 INFO - MultiFileLogger online at 20170427 09:20:01 in /builds/slave/test 09:20:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:20:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:20:01 INFO - {'append_to_log': False, 09:20:01 INFO - 'base_work_dir': '/builds/slave/test', 09:20:01 INFO - 'blob_upload_branch': 'Firefox', 09:20:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:20:01 INFO - 'branch': 'Firefox', 09:20:01 INFO - 'buildbot_json_path': 'buildprops.json', 09:20:01 INFO - 'config_files': ('talos/mac_config.py',), 09:20:01 INFO - 'default_actions': ('clobber', 09:20:01 INFO - 'read-buildbot-config', 09:20:01 INFO - 'download-and-extract', 09:20:01 INFO - 'populate-webroot', 09:20:01 INFO - 'create-virtualenv', 09:20:01 INFO - 'install', 09:20:01 INFO - 'run-tests'), 09:20:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:20:01 INFO - 'download_minidump_stackwalk': True, 09:20:01 INFO - 'download_symbols': 'ondemand', 09:20:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:20:01 INFO - 'tooltool.py': '/tools/tooltool.py', 09:20:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:20:01 INFO - '/tools/misc-python/virtualenv.py')}, 09:20:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:20:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:20:01 INFO - 'gecko_profile': False, 09:20:01 INFO - 'gecko_profile_interval': 0, 09:20:01 INFO - 'installer_path': 'installer.exe', 09:20:01 INFO - 'log_level': 'info', 09:20:01 INFO - 'log_name': 'talos', 09:20:01 INFO - 'log_to_console': True, 09:20:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:20:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:20:01 INFO - 'opt_config_files': (), 09:20:01 INFO - 'pip_index': False, 09:20:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:20:01 INFO - 'cmd': ('bash', 09:20:01 INFO - '-c', 09:20:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:20:01 INFO - 'enabled': True, 09:20:01 INFO - 'halt_on_failure': False, 09:20:01 INFO - 'name': 'check_screen_resolution'},), 09:20:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:20:01 INFO - 'cmd': ('bash', 09:20:01 INFO - '-c', 09:20:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:20:01 INFO - 'enabled': True, 09:20:01 INFO - 'halt_on_failure': False, 09:20:01 INFO - 'name': 'check_screen_resolution'},), 09:20:01 INFO - 'run_cmd_checks_enabled': True, 09:20:01 INFO - 'suite': 'dromaeojs-e10s', 09:20:01 INFO - 'system_bits': '32', 09:20:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:20:01 INFO - 'title': 't-yosemite-r7-0219', 09:20:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:20:01 INFO - 'use_talos_json': True, 09:20:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:20:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:20:01 INFO - 'work_dir': 'build'} 09:20:01 INFO - [mozharness: 2017-04-27 16:20:01.747225Z] Running clobber step. 09:20:01 INFO - Running pre-action listener: _resource_record_pre_action 09:20:01 INFO - Running main action method: clobber 09:20:01 INFO - rmtree: /builds/slave/test/build 09:20:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:20:04 INFO - Running post-action listener: _resource_record_post_action 09:20:04 INFO - [mozharness: 2017-04-27 16:20:04.948720Z] Finished clobber step (success) 09:20:04 INFO - [mozharness: 2017-04-27 16:20:04.948962Z] Running read-buildbot-config step. 09:20:04 INFO - Running pre-action listener: _resource_record_pre_action 09:20:04 INFO - Running main action method: read_buildbot_config 09:20:04 INFO - Using buildbot properties: 09:20:04 INFO - { 09:20:04 INFO - "project": "", 09:20:04 INFO - "product": "firefox", 09:20:04 INFO - "script_repo_revision": "production", 09:20:04 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 09:20:04 INFO - "repository": "", 09:20:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 09:20:04 INFO - "buildid": "20170427073327", 09:20:04 INFO - "pgo_build": "False", 09:20:04 INFO - "basedir": "/builds/slave/test", 09:20:04 INFO - "buildnumber": 45, 09:20:04 INFO - "slavename": "t-yosemite-r7-0219", 09:20:04 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 09:20:04 INFO - "platform": "yosemite_r7", 09:20:04 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:20:04 INFO - "branch": "mozilla-central", 09:20:04 INFO - "repo_path": "mozilla-central", 09:20:04 INFO - "revision": "c0d35b1c5ab5fa9bb2f5661aa0454a1ce31b50e0", 09:20:04 INFO - "stage_platform": "macosx64", 09:20:04 INFO - "builduid": "9ccf132ee1b3468c8e2f9f8b81ff4a96", 09:20:04 INFO - "slavebuilddir": "test" 09:20:04 INFO - } 09:20:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 09:20:04 INFO - Running post-action listener: _resource_record_post_action 09:20:04 INFO - [mozharness: 2017-04-27 16:20:04.954235Z] Finished read-buildbot-config step (success) 09:20:04 INFO - [mozharness: 2017-04-27 16:20:04.954464Z] Running download-and-extract step. 09:20:04 INFO - Running pre-action listener: _resource_record_pre_action 09:20:04 INFO - Running main action method: download_and_extract 09:20:04 INFO - mkdir: /builds/slave/test/build/tests 09:20:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:04 INFO - trying https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 09:20:04 INFO - Downloading https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:20:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 09:20:05 INFO - Downloaded 1325 bytes. 09:20:05 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:20:05 INFO - Using the following test package requirements: 09:20:05 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:20:05 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 09:20:05 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:20:05 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:20:05 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 09:20:05 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:20:05 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 09:20:05 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:20:05 INFO - u'jsshell-mac.zip'], 09:20:05 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:20:05 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 09:20:05 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:20:05 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:20:05 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 09:20:05 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:20:05 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 09:20:05 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:20:05 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 09:20:05 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:20:05 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 09:20:05 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:20:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:20:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:20:05 INFO - Fetch https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:20:07 INFO - Content-Length response header: 52529286 09:20:07 INFO - Bytes received: 52529286 09:20:23 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:20:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:20:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:20:23 INFO - Fetch https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:20:25 INFO - Content-Length response header: 52529286 09:20:25 INFO - Bytes received: 52529286 09:20:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 09:20:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:20:40 INFO - Fetch https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 09:20:41 INFO - Content-Length response header: 14408809 09:20:41 INFO - Bytes received: 14408809 09:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:41 INFO - trying https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:20:41 INFO - Downloading https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 09:20:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 09:20:44 INFO - Downloaded 71194061 bytes. 09:20:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:20:44 INFO - mkdir: /builds/slave/test/properties 09:20:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:20:44 INFO - Writing to file /builds/slave/test/properties/build_url 09:20:44 INFO - Contents: 09:20:44 INFO - build_url:https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:20:44 INFO - Running post-action listener: _resource_record_post_action 09:20:44 INFO - Running post-action listener: set_extra_try_arguments 09:20:44 INFO - [mozharness: 2017-04-27 16:20:44.811943Z] Finished download-and-extract step (success) 09:20:44 INFO - [mozharness: 2017-04-27 16:20:44.812073Z] Running populate-webroot step. 09:20:44 INFO - Running pre-action listener: _resource_record_pre_action 09:20:44 INFO - Running main action method: populate_webroot 09:20:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:20:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:20:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:20:44 INFO - '--tppagecycles', 09:20:44 INFO - '7'], 09:20:44 INFO - 'tests': ['tsvgm']}}, 09:20:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:20:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:20:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:20:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:20:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:20:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:20:44 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:20:44 INFO - 'talos_options': ['--disable-e10s'], 09:20:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:20:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:20:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:20:44 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:20:44 INFO - 'talos_options': ['--disable-e10s'], 09:20:44 INFO - 'tests': ['damp', 'tps']}, 09:20:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:20:44 INFO - 'tests': ['damp', 'tps']}, 09:20:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:20:44 INFO - 'tests': ['dromaeo_dom']}, 09:20:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:20:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:20:44 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:20:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:20:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:20:44 INFO - 'tests': ['a11yr', 09:20:44 INFO - 'ts_paint', 09:20:44 INFO - 'tpaint', 09:20:44 INFO - 'sessionrestore', 09:20:44 INFO - 'sessionrestore_no_auto_restore', 09:20:44 INFO - 'tabpaint']}, 09:20:44 INFO - 'other-e10s': {'tests': ['a11yr', 09:20:44 INFO - 'ts_paint', 09:20:44 INFO - 'tpaint', 09:20:44 INFO - 'sessionrestore', 09:20:44 INFO - 'sessionrestore_no_auto_restore', 09:20:44 INFO - 'tabpaint']}, 09:20:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:20:44 INFO - 'ts_paint', 09:20:44 INFO - 'tpaint', 09:20:44 INFO - 'sessionrestore', 09:20:44 INFO - 'sessionrestore_no_auto_restore', 09:20:44 INFO - 'tabpaint']}, 09:20:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:20:44 INFO - 'ts_paint', 09:20:44 INFO - 'tpaint', 09:20:44 INFO - 'sessionrestore', 09:20:44 INFO - 'sessionrestore_no_auto_restore', 09:20:44 INFO - 'tabpaint']}, 09:20:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:20:44 INFO - 'tests': ['a11yr', 09:20:44 INFO - 'ts_paint', 09:20:44 INFO - 'tpaint', 09:20:44 INFO - 'sessionrestore', 09:20:44 INFO - 'sessionrestore_no_auto_restore', 09:20:44 INFO - 'tabpaint']}, 09:20:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:20:44 INFO - 'tests': ['a11yr', 09:20:44 INFO - 'ts_paint', 09:20:44 INFO - 'tpaint', 09:20:44 INFO - 'sessionrestore', 09:20:44 INFO - 'sessionrestore_no_auto_restore', 09:20:44 INFO - 'tabpaint']}, 09:20:44 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:20:44 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:20:44 INFO - 'bloom_basic_ref']}, 09:20:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:20:44 INFO - 'tests': ['tsvgx', 09:20:44 INFO - 'tsvgr_opacity', 09:20:44 INFO - 'tart', 09:20:44 INFO - 'tscrollx', 09:20:44 INFO - 'cart', 09:20:44 INFO - 'tsvg_static']}, 09:20:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:20:44 INFO - 'tsvgr_opacity', 09:20:44 INFO - 'tart', 09:20:44 INFO - 'tscrollx', 09:20:44 INFO - 'cart', 09:20:44 INFO - 'tsvg_static']}, 09:20:44 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:20:44 INFO - 'talos_options': ['--disable-e10s'], 09:20:44 INFO - 'tests': ['tp5o']}, 09:20:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:20:44 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:20:44 INFO - 'talos_options': ['--disable-e10s', 09:20:44 INFO - '--xperf_path', 09:20:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:20:44 INFO - 'tests': ['tp5n']}, 09:20:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:20:44 INFO - 'talos_options': ['--xperf_path', 09:20:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:20:44 INFO - 'tests': ['tp5n']}}, 09:20:44 INFO - 'talos.zip': {'path': '', 09:20:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:20:44 INFO - Running post-action listener: _resource_record_post_action 09:20:44 INFO - [mozharness: 2017-04-27 16:20:44.831628Z] Finished populate-webroot step (success) 09:20:44 INFO - [mozharness: 2017-04-27 16:20:44.831759Z] Running create-virtualenv step. 09:20:44 INFO - Running pre-action listener: _resource_record_pre_action 09:20:44 INFO - Running main action method: create_virtualenv 09:20:44 INFO - Creating virtualenv /builds/slave/test/build/venv 09:20:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:20:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:20:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:20:44 INFO - Using real prefix '/tools/python27' 09:20:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:20:45 INFO - Installing distribute.............................................................................................................................................................................................done. 09:20:48 INFO - Installing pip.................done. 09:20:48 INFO - Return code: 0 09:20:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:20:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:20:48 INFO - Reading from file tmpfile_stdout 09:20:48 INFO - Output received: 09:20:48 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:20:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:20: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')]} 09:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20: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')]} 09:20:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d3d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabc2da8b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b2d30>, '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 0x10d0d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1a7be8>, '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.s15D9jFdxu/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.IdPcehrUWh/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 09:20:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:20:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:20:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s15D9jFdxu/Render', 09:20:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:48 INFO - 'HOME': '/Users/cltbld', 09:20:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:48 INFO - 'LOGNAME': 'cltbld', 09:20:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:48 INFO - 'MOZ_NO_REMOTE': '1', 09:20:48 INFO - 'NO_EM_RESTART': '1', 09:20:48 INFO - 'PAGER': '/bin/cat', 09:20:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:48 INFO - 'PWD': '/builds/slave/test', 09:20:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:48 INFO - 'SHELL': '/bin/bash', 09:20:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IdPcehrUWh/Listeners', 09:20:48 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 09:20:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:48 INFO - 'USER': 'cltbld', 09:20:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:48 INFO - 'XPC_FLAGS': '0x0', 09:20:48 INFO - 'XPC_SERVICE_NAME': '0', 09:20:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:49 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 09:20:49 INFO - Cleaning up... 09:20:49 INFO - Return code: 0 09:20:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:20:49 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')]} 09:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:49 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')]} 09:20:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:49 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 0x10d3d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabc2da8b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b2d30>, '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 0x10d0d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1a7be8>, '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.s15D9jFdxu/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.IdPcehrUWh/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 09:20:49 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 09:20:49 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 09:20:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s15D9jFdxu/Render', 09:20:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:49 INFO - 'HOME': '/Users/cltbld', 09:20:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:49 INFO - 'LOGNAME': 'cltbld', 09:20:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:49 INFO - 'MOZ_NO_REMOTE': '1', 09:20:49 INFO - 'NO_EM_RESTART': '1', 09:20:49 INFO - 'PAGER': '/bin/cat', 09:20:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:49 INFO - 'PWD': '/builds/slave/test', 09:20:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:49 INFO - 'SHELL': '/bin/bash', 09:20:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IdPcehrUWh/Listeners', 09:20:49 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 09:20:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:49 INFO - 'USER': 'cltbld', 09:20:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:49 INFO - 'XPC_FLAGS': '0x0', 09:20:49 INFO - 'XPC_SERVICE_NAME': '0', 09:20:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:49 INFO - Downloading/unpacking psutil>=3.1.1 09:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:20:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:20:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:20:53 INFO - Installing collected packages: psutil 09:20:53 INFO - Running setup.py install for psutil 09:20:53 INFO - building 'psutil._psutil_osx' extension 09:20:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:20:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:20:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:20:53 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:20:53 INFO - building 'psutil._psutil_posix' extension 09:20:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:20:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:20:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:20:53 INFO - ^ 09:20:53 INFO - 1 warning generated. 09:20:53 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:20:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:20:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:20:54 INFO - Successfully installed psutil 09:20:54 INFO - Cleaning up... 09:20:54 INFO - Return code: 0 09:20:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:20: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')]} 09:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20: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')]} 09:20:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d3d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabc2da8b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b2d30>, '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 0x10d0d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1a7be8>, '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.s15D9jFdxu/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.IdPcehrUWh/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 09:20: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:20: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 mozsystemmonitor==0.3 09:20:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s15D9jFdxu/Render', 09:20:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:54 INFO - 'HOME': '/Users/cltbld', 09:20:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:54 INFO - 'LOGNAME': 'cltbld', 09:20:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:54 INFO - 'MOZ_NO_REMOTE': '1', 09:20:54 INFO - 'NO_EM_RESTART': '1', 09:20:54 INFO - 'PAGER': '/bin/cat', 09:20:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:54 INFO - 'PWD': '/builds/slave/test', 09:20:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:54 INFO - 'SHELL': '/bin/bash', 09:20:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IdPcehrUWh/Listeners', 09:20:54 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 09:20:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:54 INFO - 'USER': 'cltbld', 09:20:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:54 INFO - 'XPC_FLAGS': '0x0', 09:20:54 INFO - 'XPC_SERVICE_NAME': '0', 09:20:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:20:57 INFO - Installing collected packages: mozsystemmonitor 09:20:57 INFO - Running setup.py install for mozsystemmonitor 09:20:57 INFO - Successfully installed mozsystemmonitor 09:20:57 INFO - Cleaning up... 09:20:57 INFO - Return code: 0 09:20:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d3d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabc2da8b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b2d30>, '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 0x10d0d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1a7be8>, '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.s15D9jFdxu/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.IdPcehrUWh/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 09:20:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:20:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:20:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s15D9jFdxu/Render', 09:20:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:57 INFO - 'HOME': '/Users/cltbld', 09:20:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:57 INFO - 'LOGNAME': 'cltbld', 09:20:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:57 INFO - 'MOZ_NO_REMOTE': '1', 09:20:57 INFO - 'NO_EM_RESTART': '1', 09:20:57 INFO - 'PAGER': '/bin/cat', 09:20:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:57 INFO - 'PWD': '/builds/slave/test', 09:20:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:57 INFO - 'SHELL': '/bin/bash', 09:20:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IdPcehrUWh/Listeners', 09:20:57 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 09:20:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:57 INFO - 'USER': 'cltbld', 09:20:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:57 INFO - 'XPC_FLAGS': '0x0', 09:20:57 INFO - 'XPC_SERVICE_NAME': '0', 09:20:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:57 INFO - Downloading/unpacking jsonschema==2.5.1 09:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:21:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:21:00 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 09:21:00 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 09:21:00 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 09:21:00 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 09:21:00 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 09:21:00 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 09:21:00 INFO - Downloading functools32-3.2.3-2.tar.gz 09:21:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:21:00 INFO - warning: no files found matching '*.txt' 09:21:00 INFO - no previously-included directories found matching 'build' 09:21:00 INFO - no previously-included directories found matching 'dist' 09:21:00 INFO - no previously-included directories found matching '.git*' 09:21:00 INFO - Installing collected packages: jsonschema, functools32 09:21:00 INFO - Running setup.py install for functools32 09:21:01 INFO - warning: no files found matching '*.txt' 09:21:01 INFO - no previously-included directories found matching 'build' 09:21:01 INFO - no previously-included directories found matching 'dist' 09:21:01 INFO - no previously-included directories found matching '.git*' 09:21:01 INFO - Successfully installed jsonschema functools32 09:21:01 INFO - Cleaning up... 09:21:01 INFO - Return code: 0 09:21:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:21: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')]} 09:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21: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')]} 09:21:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d3d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabc2da8b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b2d30>, '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 0x10d0d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1a7be8>, '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.s15D9jFdxu/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.IdPcehrUWh/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 09:21:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:21:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s15D9jFdxu/Render', 09:21:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:01 INFO - 'HOME': '/Users/cltbld', 09:21:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:01 INFO - 'LOGNAME': 'cltbld', 09:21:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:01 INFO - 'MOZ_NO_REMOTE': '1', 09:21:01 INFO - 'NO_EM_RESTART': '1', 09:21:01 INFO - 'PAGER': '/bin/cat', 09:21:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:01 INFO - 'PWD': '/builds/slave/test', 09:21:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:01 INFO - 'SHELL': '/bin/bash', 09:21:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IdPcehrUWh/Listeners', 09:21:01 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 09:21:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:01 INFO - 'USER': 'cltbld', 09:21:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:01 INFO - 'XPC_FLAGS': '0x0', 09:21:01 INFO - 'XPC_SERVICE_NAME': '0', 09:21:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:21:01 INFO - Cleaning up... 09:21:01 INFO - Return code: 0 09:21:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:21: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')]} 09:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21: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')]} 09:21:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d3d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabc2da8b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b2d30>, '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 0x10d0d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1a7be8>, '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.s15D9jFdxu/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.IdPcehrUWh/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 09:21:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:21:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s15D9jFdxu/Render', 09:21:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:01 INFO - 'HOME': '/Users/cltbld', 09:21:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:01 INFO - 'LOGNAME': 'cltbld', 09:21:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:01 INFO - 'MOZ_NO_REMOTE': '1', 09:21:01 INFO - 'NO_EM_RESTART': '1', 09:21:01 INFO - 'PAGER': '/bin/cat', 09:21:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:01 INFO - 'PWD': '/builds/slave/test', 09:21:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:01 INFO - 'SHELL': '/bin/bash', 09:21:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IdPcehrUWh/Listeners', 09:21:01 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 09:21:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:01 INFO - 'USER': 'cltbld', 09:21:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:01 INFO - 'XPC_FLAGS': '0x0', 09:21:01 INFO - 'XPC_SERVICE_NAME': '0', 09:21:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:01 INFO - Downloading/unpacking blobuploader==1.2.4 09:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:04 INFO - Downloading blobuploader-1.2.4.tar.gz 09:21:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:21:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:21:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:05 INFO - Downloading docopt-0.6.1.tar.gz 09:21:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:21:05 INFO - Installing collected packages: blobuploader, requests, docopt 09:21:05 INFO - Running setup.py install for blobuploader 09:21:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:21:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:21:05 INFO - Running setup.py install for requests 09:21:06 INFO - Running setup.py install for docopt 09:21:06 INFO - Successfully installed blobuploader requests docopt 09:21:06 INFO - Cleaning up... 09:21:06 INFO - Return code: 0 09:21:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d3d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabc2da8b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b2d30>, '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 0x10d0d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1a7be8>, '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.s15D9jFdxu/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.IdPcehrUWh/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 09:21:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:21:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:21:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s15D9jFdxu/Render', 09:21:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:06 INFO - 'HOME': '/Users/cltbld', 09:21:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:06 INFO - 'LOGNAME': 'cltbld', 09:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:06 INFO - 'MOZ_NO_REMOTE': '1', 09:21:06 INFO - 'NO_EM_RESTART': '1', 09:21:06 INFO - 'PAGER': '/bin/cat', 09:21:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:06 INFO - 'PWD': '/builds/slave/test', 09:21:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:06 INFO - 'SHELL': '/bin/bash', 09:21:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IdPcehrUWh/Listeners', 09:21:06 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 09:21:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:06 INFO - 'USER': 'cltbld', 09:21:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:06 INFO - 'XPC_FLAGS': '0x0', 09:21:06 INFO - 'XPC_SERVICE_NAME': '0', 09:21:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:21:07 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-9cCh4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:21:07 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-THfRin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:21:07 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-kCClFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:21:07 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-d9pLHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:21:07 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-n8LtRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:21:07 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-veebKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:21:07 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-bAYgcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:21:07 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-tTuTTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:21:07 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-jGgcxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:21:07 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-9NjO49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:21:08 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-70c53h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:21:08 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-FpjCt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:21:08 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-0ckLAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:21:08 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-KcMT_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:08 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-HbSrAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:21:08 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-j2ysRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:21:08 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-yPajEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:21:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:21:08 INFO - Running setup.py install for manifestparser 09:21:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:21:08 INFO - Running setup.py install for mozcrash 09:21:09 INFO - Running setup.py install for mozdebug 09:21:09 INFO - Running setup.py install for mozdevice 09:21:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:21:09 INFO - Running setup.py install for mozfile 09:21:09 INFO - Running setup.py install for mozhttpd 09:21:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:21:09 INFO - Running setup.py install for mozinfo 09:21:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:21:09 INFO - Running setup.py install for mozInstall 09:21:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:21:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:21:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:21:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:21:09 INFO - Running setup.py install for mozleak 09:21:10 INFO - Running setup.py install for mozlog 09:21:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:21:10 INFO - Running setup.py install for moznetwork 09:21:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:21:10 INFO - Running setup.py install for mozprocess 09:21:10 INFO - Running setup.py install for mozprofile 09:21:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:21:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:21:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:21:10 INFO - Running setup.py install for mozrunner 09:21:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:21:10 INFO - Running setup.py install for mozscreenshot 09:21:11 INFO - Running setup.py install for moztest 09:21:11 INFO - Running setup.py install for mozversion 09:21:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:21:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:21:11 INFO - Cleaning up... 09:21:11 INFO - Return code: 0 09:21:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21:11 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')]} 09:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:11 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')]} 09:21:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:11 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 0x10d3d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabc2da8b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b2d30>, '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 0x10d0d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1a7be8>, '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.s15D9jFdxu/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.IdPcehrUWh/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 09:21:11 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 09:21:11 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 09:21:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s15D9jFdxu/Render', 09:21:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:11 INFO - 'HOME': '/Users/cltbld', 09:21:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:11 INFO - 'LOGNAME': 'cltbld', 09:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:11 INFO - 'MOZ_NO_REMOTE': '1', 09:21:11 INFO - 'NO_EM_RESTART': '1', 09:21:11 INFO - 'PAGER': '/bin/cat', 09:21:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:11 INFO - 'PWD': '/builds/slave/test', 09:21:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:11 INFO - 'SHELL': '/bin/bash', 09:21:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IdPcehrUWh/Listeners', 09:21:11 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 09:21:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:11 INFO - 'USER': 'cltbld', 09:21:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:11 INFO - 'XPC_FLAGS': '0x0', 09:21:11 INFO - 'XPC_SERVICE_NAME': '0', 09:21:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:21:11 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-iJFsgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:21:11 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-fmIDs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:21:11 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-tr025p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:21:11 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-kXBcAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 09:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:21:12 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-7Scq8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:21:12 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)) 09:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:21:12 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-72mH96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:21:12 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)) 09:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:21:12 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-6p5K_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:21:12 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)) 09:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:21:12 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-c9esxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:21:12 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)) 09:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:21:12 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-_WfZQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:21:12 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)) 09:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:21:12 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-d_HzSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:21:12 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-fwQ3EI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:21:12 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-jZT6rX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 09:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:21:12 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-C3dTxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:21:13 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)) 09:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:21:13 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-mY813I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:13 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-IQTJ8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:13 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)) 09:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:21:13 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-gLGOW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:21:13 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-JGTVEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:21:13 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)) 09:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:21:13 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)) 09:21:13 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:21:13 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:21:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:21:13 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 09:21:13 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 09:21:13 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 09:21:13 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 09:21:13 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 09:21:13 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 09:21:16 INFO - Downloading blessings-1.6.tar.gz 09:21:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:21:16 INFO - Installing collected packages: blessings 09:21:16 INFO - Running setup.py install for blessings 09:21:16 INFO - Successfully installed blessings 09:21:16 INFO - Cleaning up... 09:21:16 INFO - Return code: 0 09:21:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:21:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:21:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:21:16 INFO - Reading from file tmpfile_stdout 09:21:16 INFO - Current package versions: 09:21:16 INFO - blessings == 1.6 09:21:16 INFO - blobuploader == 1.2.4 09:21:16 INFO - docopt == 0.6.1 09:21:16 INFO - functools32 == 3.2.3-2 09:21:16 INFO - jsonschema == 2.5.1 09:21:16 INFO - manifestparser == 1.1 09:21:16 INFO - mozInstall == 1.12 09:21:16 INFO - mozcrash == 1.0 09:21:16 INFO - mozdebug == 0.1 09:21:16 INFO - mozdevice == 0.50 09:21:16 INFO - mozfile == 1.2 09:21:16 INFO - mozhttpd == 0.7 09:21:16 INFO - mozinfo == 0.9 09:21:16 INFO - mozleak == 0.1 09:21:16 INFO - mozlog == 3.4 09:21:16 INFO - moznetwork == 0.27 09:21:16 INFO - mozprocess == 0.25 09:21:16 INFO - mozprofile == 0.28 09:21:16 INFO - mozrunner == 6.13 09:21:16 INFO - mozscreenshot == 0.1 09:21:16 INFO - mozsystemmonitor == 0.3 09:21:16 INFO - moztest == 0.8 09:21:16 INFO - mozversion == 1.4 09:21:16 INFO - psutil == 3.1.1 09:21:16 INFO - requests == 1.2.3 09:21:16 INFO - wsgiref == 0.1.2 09:21:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d3d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabc2da8b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b2d30>, '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 0x10d0d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1a7be8>, '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.s15D9jFdxu/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.IdPcehrUWh/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 09:21:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:21:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:21:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s15D9jFdxu/Render', 09:21:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:16 INFO - 'HOME': '/Users/cltbld', 09:21:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:16 INFO - 'LOGNAME': 'cltbld', 09:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:16 INFO - 'MOZ_NO_REMOTE': '1', 09:21:16 INFO - 'NO_EM_RESTART': '1', 09:21:16 INFO - 'PAGER': '/bin/cat', 09:21:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:16 INFO - 'PWD': '/builds/slave/test', 09:21:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:16 INFO - 'SHELL': '/bin/bash', 09:21:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IdPcehrUWh/Listeners', 09:21:16 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 09:21:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:16 INFO - 'USER': 'cltbld', 09:21:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:16 INFO - 'XPC_FLAGS': '0x0', 09:21:16 INFO - 'XPC_SERVICE_NAME': '0', 09:21:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:16 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)) 09:21:16 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)) 09:21:16 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)) 09:21:16 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)) 09:21:16 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)) 09:21:16 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)) 09:21:16 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)) 09:21:16 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)) 09:21:16 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)) 09:21:16 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)) 09:21:16 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)) 09:21:16 INFO - Cleaning up... 09:21:16 INFO - Return code: 0 09:21:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:16 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 0x10d3d4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3d7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabc2da8b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b2d30>, '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 0x10d0d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1a7be8>, '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.s15D9jFdxu/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.IdPcehrUWh/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 09:21:16 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 09:21:16 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 09:21:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s15D9jFdxu/Render', 09:21:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:16 INFO - 'HOME': '/Users/cltbld', 09:21:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:16 INFO - 'LOGNAME': 'cltbld', 09:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:16 INFO - 'MOZ_NO_REMOTE': '1', 09:21:16 INFO - 'NO_EM_RESTART': '1', 09:21:16 INFO - 'PAGER': '/bin/cat', 09:21:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:16 INFO - 'PWD': '/builds/slave/test', 09:21:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:16 INFO - 'SHELL': '/bin/bash', 09:21:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IdPcehrUWh/Listeners', 09:21:16 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 09:21:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:16 INFO - 'USER': 'cltbld', 09:21:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:16 INFO - 'XPC_FLAGS': '0x0', 09:21:16 INFO - 'XPC_SERVICE_NAME': '0', 09:21:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:21:17 INFO - Cleaning up... 09:21:17 INFO - Return code: 0 09:21:17 INFO - Running post-action listener: _resource_record_post_action 09:21:17 INFO - Running post-action listener: _start_resource_monitoring 09:21:17 INFO - Starting resource monitoring. 09:21:17 INFO - [mozharness: 2017-04-27 16:21:17.228647Z] Finished create-virtualenv step (success) 09:21:17 INFO - [mozharness: 2017-04-27 16:21:17.229606Z] Running install step. 09:21:17 INFO - Running pre-action listener: _resource_record_pre_action 09:21:17 INFO - Running main action method: install 09:21:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:21:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:21:17 INFO - Reading from file tmpfile_stdout 09:21:17 INFO - Detecting whether we're running mozinstall >=1.0... 09:21:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:21:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:21:17 INFO - Reading from file tmpfile_stdout 09:21:17 INFO - Output received: 09:21:17 INFO - Usage: mozinstall [options] installer 09:21:17 INFO - Options: 09:21:17 INFO - -h, --help show this help message and exit 09:21:17 INFO - -d DEST, --destination=DEST 09:21:17 INFO - Directory to install application into. [default: 09:21:17 INFO - "/builds/slave/test"] 09:21:17 INFO - --app=APP Application being installed. [default: firefox] 09:21:17 INFO - mkdir: /builds/slave/test/build/application 09:21:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:21:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:21:37 INFO - Reading from file tmpfile_stdout 09:21:37 INFO - Output received: 09:21:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:21:37 INFO - Running post-action listener: _resource_record_post_action 09:21:37 INFO - [mozharness: 2017-04-27 16:21:37.517323Z] Finished install step (success) 09:21:37 INFO - [mozharness: 2017-04-27 16:21:37.517451Z] Running run-tests step. 09:21:37 INFO - Running pre-action listener: _resource_record_pre_action 09:21:37 INFO - Running main action method: run_tests 09:21:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:21:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:21:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:21:37 INFO - 2017-04-27 09:21:37.532 screenresolution[1898:18082] starting screenresolution argv=screenresolution get 09:21:37 INFO - 2017-04-27 09:21:37.534 screenresolution[1898:18082] Display 0: 1600x1200x32@60 09:21:37 INFO - 2017-04-27 09:21:37.540 screenresolution[1899:18085] starting screenresolution argv=screenresolution list 09:21:37 INFO - Available Modes on Display 0 09:21:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:21:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:21:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:21:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:21:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:21:37 INFO - Intel Iris: 09:21:37 INFO - Chipset Model: Intel Iris 09:21:37 INFO - Type: GPU 09:21:37 INFO - Bus: Built-In 09:21:37 INFO - VRAM (Dynamic, Max): 1536 MB 09:21:37 INFO - Vendor: Intel (0x8086) 09:21:37 INFO - Device ID: 0x0a2e 09:21:37 INFO - Revision ID: 0x0009 09:21:37 INFO - Displays: 09:21:37 INFO - Display: 09:21:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:21:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:21:37 INFO - Display Serial Number: 1600x1200 60 09:21:37 INFO - Main Display: Yes 09:21:37 INFO - Mirror: Off 09:21:37 INFO - Online: Yes 09:21:37 INFO - Rotation: Supported 09:21:37 INFO - Return code: 0 09:21:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:21:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:21:37 INFO - Python 2.7.3 09:21:37 INFO - Return code: 0 09:21:37 INFO - grabbing minidump binary from tooltool 09:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:37 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 0x10d1b2d30>, '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 0x10d0d8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1a7be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:21:37 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 09:21:37 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 09:21:37 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 09:21:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:21:37 INFO - Return code: 0 09:21:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:21:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:21:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:21:37 INFO - ENV: RUST_BACKTRACE is now 1 09:21:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:21:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:21:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:21:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.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-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:21:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s15D9jFdxu/Render', 09:21:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:37 INFO - 'HOME': '/Users/cltbld', 09:21:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:37 INFO - 'LOGNAME': 'cltbld', 09:21:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:21:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:37 INFO - 'MOZ_NO_REMOTE': '1', 09:21:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:21:37 INFO - 'NO_EM_RESTART': '1', 09:21:37 INFO - 'PAGER': '/bin/cat', 09:21:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:37 INFO - 'PWD': '/builds/slave/test', 09:21:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:21:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:37 INFO - 'RUST_BACKTRACE': '1', 09:21:37 INFO - 'SHELL': '/bin/bash', 09:21:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IdPcehrUWh/Listeners', 09:21:37 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 09:21:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:37 INFO - 'USER': 'cltbld', 09:21:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:37 INFO - 'XPC_FLAGS': '0x0', 09:21:37 INFO - 'XPC_SERVICE_NAME': '0', 09:21:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:21:38 INFO - mozversion application_buildid: 20170427073327 09:21:38 INFO - mozversion application_changeset: c0d35b1c5ab5fa9bb2f5661aa0454a1ce31b50e0 09:21:38 INFO - mozversion application_display_name: Nightly 09:21:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:21:38 INFO - mozversion application_name: Firefox 09:21:38 INFO - mozversion application_remotingname: firefox 09:21:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:21:38 INFO - mozversion application_vendor: Mozilla 09:21:38 INFO - mozversion application_version: 55.0a1 09:21:38 INFO - mozversion platform_buildid: 20170427073327 09:21:38 INFO - mozversion platform_changeset: c0d35b1c5ab5fa9bb2f5661aa0454a1ce31b50e0 09:21:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:21:38 INFO - mozversion platform_version: 55.0a1 09:21:38 INFO - using testdate: 1493310098 09:21:38 INFO - actual date: 1493310098 09:21:38 INFO - starting webserver on 'localhost:56067' 09:21:38 INFO - SUITE-START | Running 2 tests 09:21:38 INFO - TEST-START | dromaeo_css 09:21:38 INFO - operating with platform_type : mac_ 09:21:38 INFO - Initialising browser for dromaeo_css test... 09:21:38 INFO - TEST-INFO | started process 1909 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/tmp5A5E30/profile http://localhost:56067/getInfo.html) 09:21:40 INFO - PID 1909 | 2017-04-27 09:21:40.583 plugin-container[1911:18261] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x973f, name = 'com.apple.tsm.portname' 09:21:40 INFO - PID 1909 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:21:40 INFO - PID 1909 | 2017-04-27 09:21:40.587 plugin-container[1911:18261] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9d0b, name = 'com.apple.CFPasteboardClient' 09:21:40 INFO - PID 1909 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:21:40 INFO - PID 1909 | 2017-04-27 09:21:40.587 plugin-container[1911:18261] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:21:40 INFO - PID 1909 | __metrics Screen width/height:1600/1200 09:21:40 INFO - PID 1909 | colorDepth:24 09:21:40 INFO - PID 1909 | Browser inner width/height: 1024/689 09:21:40 INFO - PID 1909 | __metrics 09:21:40 ERROR - PID 1909 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 09:21:41 INFO - TEST-INFO | 1909: exit 0 09:21:41 INFO - Browser initialized. 09:21:41 INFO - Running cycle 1/1 for dromaeo_css test... 09:21:41 INFO - TEST-INFO | started process 1912 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/tmp5A5E30/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:21:44 INFO - PID 1912 | 2017-04-27 09:21:44.213 plugin-container[1913:18391] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 09:21:44 INFO - PID 1912 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:21:44 INFO - PID 1912 | 2017-04-27 09:21:44.214 plugin-container[1913:18391] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x470b, name = 'com.apple.CFPasteboardClient' 09:21:44 INFO - PID 1912 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:21:44 INFO - PID 1912 | 2017-04-27 09:21:44.214 plugin-container[1913:18391] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:21:54 INFO - PID 1912 | RSS: Main: 237129728 09:21:54 INFO - PID 1912 | 09:24:58 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:56067/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56067/tests/dromaeo/cssquery-ext.html) 09:25:00 INFO - PID 1912 | RSS: Main: 251744256 09:25:00 INFO - PID 1912 | 09:26:42 INFO - PID 1912 | ************************* 09:26:42 INFO - PID 1912 | A coding exception was thrown and uncaught in a Task. 09:26:42 INFO - PID 1912 | 09:26:42 ERROR - PID 1912 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:26:42 INFO - PID 1912 | Full stack: 09:26:42 INFO - PID 1912 | ************************* 09:26:42 INFO - PID 1912 | ************************* 09:26:42 INFO - PID 1912 | A coding exception was thrown and uncaught in a Task. 09:26:42 INFO - PID 1912 | 09:26:42 ERROR - PID 1912 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:26:42 INFO - PID 1912 | Full stack: 09:26:42 INFO - PID 1912 | ************************* 09:26:42 INFO - PID 1912 | ************************* 09:26:42 INFO - PID 1912 | A coding exception was thrown and uncaught in a Task. 09:26:42 INFO - PID 1912 | 09:26:42 ERROR - PID 1912 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:26:42 INFO - PID 1912 | Full stack: 09:26:42 INFO - PID 1912 | ************************* 09:26:42 INFO - PID 1912 | ************************* 09:26:42 INFO - PID 1912 | A coding exception was thrown and uncaught in a Task. 09:26:42 INFO - PID 1912 | 09:26:42 ERROR - PID 1912 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:26:42 INFO - PID 1912 | Full stack: 09:26:42 INFO - PID 1912 | ************************* 09:28:02 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:56067/tests/dromaeo/cssquery-ext.html (next: http://localhost:56067/tests/dromaeo/cssquery-jquery.html) 09:28:02 INFO - PID 1912 | RSS: Main: 258285568 09:28:02 INFO - PID 1912 | 09:31:04 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:56067/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56067/tests/dromaeo/cssquery-mootools.html) 09:31:05 INFO - PID 1912 | RSS: Main: 267104256 09:31:05 INFO - PID 1912 | 09:34:06 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:56067/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56067/tests/dromaeo/cssquery-prototype.html) 09:34:07 INFO - PID 1912 | RSS: Main: 259575808 09:34:07 INFO - PID 1912 | 09:37:10 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:56067/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56067/tests/dromaeo/cssquery-yui.html) 09:37:10 INFO - PID 1912 | RSS: Main: 268660736 09:37:10 INFO - PID 1912 | 09:40:12 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:56067/tests/dromaeo/cssquery-yui.html (next: http://localhost:56067/tests/dromaeo/cssquery-dojo.html) 09:40:12 INFO - PID 1912 | RSS: Main: 263299072 09:40:12 INFO - PID 1912 | 09:40:12 INFO - PID 1912 | __start_tp_report 09:40:12 INFO - PID 1912 | _x_x_mozilla_page_load 09:40:12 INFO - PID 1912 | _x_x_mozilla_page_load_details 09:40:12 INFO - PID 1912 | |i|pagename|runs| 09:40:12 INFO - PID 1912 | |0;dojo.html;3280.6391296957336;3608.8195590220485;3634.01881491997;3642.253338065697;3652.214773823628;6065.818025459233;6182.350853160416;6185.505159587234;6211.658358790265;6232.968835155823;4516.864494065183;5607.775688972436;5817.505512031483;6167.722452489637;6202.689865506729;5409.215663728776;5418.7019713915815;5481;5533.501984821365;5620.072688006495;4533.161365147442;5571.609987300891;5578.553715702755;5584.692841893694;5589;4833.419989601252;5353.518183363496;5599.244102046212;5599.608027438081;5619.185218143367;4947.480514545993;5156.845294641167;5296.126139187029;5364.034473794715;5534.944650553483;5407.134858422633;5427.511523962862;5477.20580515827;5509.421510741355;5513.724313784335;5646.802361917313;5746.224259724925;6048.123022161762;6207.627542347428;6296.96851515744;6691.59850408977;6705.899411508832;6707.832304192385;6710.563813352116;6744.393004629558;6494.707738151795;6570.211574611029;6672.733090676367;6748.7975360738765;6764.898526522106;5310.548603368679;6299.433051025429;6305.148804911279;6322.4942004639515;6328.082428047907;6736.295037729229;6804.217514985741;6827.146606674166;6874.9656251718425;6892.793216203522;6300.086487459293;6358.205224346957;6513.316101809337;6571.474282057519;6573.80278591643;6470.320616335312;6577.079208910756;6603.867922641521;6728.899066514006;6732.091167692299;6533.346665333429;6666.133402657623;6670.899936500957;6692.163479565054;6698.56459330142;6688.632125233159;6699.196096468358;6708.329167083252;6720.1599800025;6723.058771771955;5133.794648214104;5203.089459344676;5232.764525596357;5293.3647962244;5326.36083669962;4772.0455908817685;4810.11012962603;4856.708597484162;4857.53853383928;4869.14789911764;6185.783497577563;6331.240251169797;6347.143135676717;6351.301356850743;6353.269374021954;6754.797356079325;6774.254831968479;6821.113255276782;6834.965825170842;6867.725290988305;6123.3131248723375;6225.066240064027;6257.186565746424;6266.780662676784;6356.523260755462;5919.4968427684125;5921.792737254175;5932.377100404482;5942.673152976541;5975.641461512323;6893.517453778188;6921.007216428184;6930.465462614003;6963.7562685305775;6986.895196572157;6483.546151769519;6575.901361479486;6699.162604674416;6812;6823.112995310578;6939.653017349214;6940.479464040318;6950.374466298057;6995.510314277952;7023.122109736283;6681.76613818514;6692.0965669635925;6692.196936367667;6697.3637504437;6709.630970296681;6341.8731625368155;6709.832254193684;6772.5936443813525;6834.1457317835275;6843.623600702009;5856.033754430471;5896.938551060679;6219.129321895029;6493.675316234075;6606.537542371988;6543.116679248241;6553.737850485927;6557.245916719447;6572.178477690289;6582.967085164735;6167.383261673976;6264.342244064308;6357.7139028742895;6426.518011149276;6440.8389790255615;6575.934240657723;6616.735330586723;6625.966870165618;6662.666866656551;6665;6435.903461447989;6453.870922581616;6460.967695161494;6468.353164683494;6477.514186435942 09:40:12 INFO - PID 1912 | |1;ext.html;760.8359210408074;809.0816922792629;829.3779665251063;1216.7140721930346;1258.1633213912748;36130;37552.559083659544;37574.62425375745;37574.62425375745;37624.623753762455;37380.626193738055;37514.624853751455;37612.811935940284;37645;37911;7884.960575197116;8076.192380761936;8372.120927302636;8610.440321379121;8622.439541429787;7385.889211661829;8451.197136272045;8455;8557.400981931267;8561.101084386144;8493.065762766091;8555.871661925075;8559.27246184075;8569.957150214272;8597.742067737947;8452.704155354564;8506.574671266442;8535.402521823475;8539.530325832076;8553.358498112635;8319.958400208021;8334.083250842403;8367.456115352543;8375.41372103953;8378.287845533137;36821.44767828485;36944.44583331252;37062.81468592667;37064.258714825824;37113.814430927945;3238.141892398516;3651.561812582507;3689.5795118879423;3707.5550933888107;3711.109333759905;30298;30335;30410.087697369116;30441.39117217643;30526.84736576325;3044.6498652655005;3146.606674165729;3164.4620414529586;3173.079806856009;3184.6656101109284;240637;245944;252169;273635;274675;46675.76662116668;46879.531204688195;46908.7654561725;46910.765446172554;47023;48203.758981205574;48390;48458;48511.27233091507;48940.77648058827;14033.29833508341;14040.438382464792;14107.78838317426;14159.575212743634;14212.85787142136;11428.485718142703;11490.42547872603;11608.941955290338;11655;11676.357800321064;13103.606891793072;13142.277174755289;13183.209007459584;13215.537456188988;13281;5038.269450929594;5579.632989917415;5891.852703682356;5939.2575928009;5940.61386009908;909.3907082254905;929.2380248196549;1017.2147880469876;1044.8537204791335;1068.326954018963;18554.72167917482;23860.284191474282;23862.88068559646;23882.880585596962;23923.880380598333;1082.1721383141903;1102.3441052573705;1137.641642882506;1146.18620779246;1151.240181480219;11868.584599539148;12086.87913120875;12102.455389507493;12164.817527736914;12166;284845.151548486;287313;288320;289894;295709;49321.50678493169;49527.75236123797;49542.256866147036;49623;49649;1372.2521225931691;1461.6126726417508;1500.8499150085122;1506.9698606027819;1521.8325984141736;23093.538129236986;23109.768902310763;23144;23173;23178.652320214875;36188.63811361958;36348.818255908554;36441.81779091193;36493.635063649024;36732.26535469222;225716.87141564186;270777;271215;272065;272484;27847.58228626532;31722.841385793847;31940;33859.661403386635;35756;42631;44067.77966110149;44320.77839610782;44441.33337999868;44473.332900007175;24313.869591772695;28896.133116005713;29431.411371772872;30878.382432350776;30885.536716949715;30646;30874.69125308808;30946.69053309438;30989.760409583363;31046.844765776026;36887.44668829916;37080;37100.814495928425;37108.62891371052;37165.81417092897;28941;30465.54301685521;31040.68959310378;31067.533986990664;31122.844385777928;19358.612827743647;23739.643905341087;24386.756132438448;24402.26793196207;24497.877510612332 09:40:12 INFO - PID 1912 | |2;jquery.html;436.67467736536287;442.2835007288194;444.55322400987;457.2523923385265;461.99538004619944;21401.67897481537;22209;22280.220192293273;23298.41753956152;23349.767938063636;23000.309990700265;23258;23614.5277094458;23694.76305236947;23942.760572394272;5948.553858460611;5997.7600895964215;6117.174181485487;6194.814155575317;6213.968930155343;6062.878742425149;6166.136740856284;6182.227221597301;6187.412195841388;6200.720967556471;5890.941090589104;6143.232095988002;6179.104029915659;6181.258249010102;6183.628982261056;5143.665661731976;5979.43195396441;6065.969670151665;6124.418180272867;6125.234345706786;4721.787519561628;4757.524247575249;5474.972625136888;5483.479069488392;5496.367917689477;22547.661785073236;27370.726292737018;27459.862700686568;27976.580351294746;28245.15264542067;2142.1752625239237;2190.507135894427;2193.771487966728;2198.0658220256328;2204.250554811372;14322.427102915872;16981.405650802164;17633.470995870146;18028.098595070194;18139.909300453546;1819.7088465845534;2128.648772952461;2174.597699425611;2194.441946218187;2198.9780102198933;151232.48767512295;156998.21500892536;158906.20546897306;159303;161210.3878961219;11994.760104797855;12663.556775512812;12666.493340266286;12689.809652855214;12734;16438.424655137253;16503.33986640521;16520;16554.255058522394;16587.004779713257;8778.166074222938;8890.244329231959;9019.368644194974;9081.182693557612;9113.908860911439;7217.206107328189;8486.448380855225;8501.362397820189;8521.829563408697;8711.47731136134;6715.46276297895;7772.961135194288;7861.135275119732;7922.049354077548;7947.4039447041705;2173.1090252996196;2182.672599110146;2187.3219302016428;2196.1544805249773;2336.883155842201;986.7039888033705;987.7579992901641;989.1345073061071;1015.5785349080197;1036.7770929250248;16015;18728.81271187298;19346.613067738846;19933.501662458264;20559.280425185345;997.9101880830615;1017.8829434615114;1032.318669678009;1052.3896140238644;1055.171690223171;8660.8700869487;9946.254030947708;10715.303505272132;10719.410432426135;10727.892721072689;535158.3242083765;538351;540225;547892.4636579946;551165;121819;124423;124718.75281247254;125521.37239313746;126707;1155;1157.8842115788354;1166.9941650291694;1203.5426537915712;1205.921615095016;17958.371456998942;17960;17966.820331797036;17968.820311796713;18234.908825455786;48093;53236.13673521408;54674.7266263682;55162.62093447696;56119;72903;73276;74249;74285;76094.61952690201;8476.024402796138;8665.740027799176;8766.693165739423;8816.250618697482;8946.37375383717;13934;13959.93020034934;14054.297285135906;14354.784678229626;14399.78400324017;9747.658831940847;11585.536578537101;11979.221350612183;12046.75906481883;12223.816642750187;11118.888811111785;11120.388378638929;11136.276142050741;11268;11450.541978320774;9718.465484398426;11901.583444579399;12051;12131.939340303243;12244.693882653006;8558.229759321692;8606.311495080503;8732.60703268367;8739.781505462413;8759.824803504021;9577.952110239405;11891.405429728651;11936.820947685617;11939.820902686293;12001.759964800829 09:40:12 INFO - PID 1912 | |3;mootools.html;1257.7547378261238;1406.563965170797;1462.6689712361754;1463.421948330409;1480.2450750117441;11453.37006464644;11800.527978880857;11899.643010709682;11921.523139074437;12202.877971220307;11684.065274778019;11807.350595717233;11878.703032424171;11882.881171188286;11924.642260732191;2447.1434997750735;2492.2896974362357;2526.077981536735;2543.389586499236;2552.412945022646;2187.55155193185;2477.355887469262;2524.4193835417864;2528.4184637533285;2528.683914510686;2480.987595062022;2481.8759062046915;2539.415934335095;2540.3741605372575;2546.045233037611;2467.716212635543;2471.0486462711983;2487.875606219691;2506.987465062681;2530.708968468622;2214.8449608527408;2313.2944451942153;2401.399650087478;2478.776910078084;2493.5137648158616;11643.767124657545;11678.708032299175;11832.822507662391;11847;11851;6609.438197753197;6861.622610756406;6863.794086177422;6864.897026544606;6875.656217189121;3493.8470304799357;4193.475815523059;4275.593818587229;4339;4349;1134.4384529657789;1250.4373032135575;1269.1952260170272;1277.201748906933;1300.9089363744542;16128.193590320554;16213.675726485522;16542.255598497977;16576.419825306057;16726.247318870803;6001.159837622737;6120.510359171256;6238.75044998195;6252.843678908063;6290.622562646256;13920.37358318878;14039.578812635636;14047.367868445945;14057.648558786112;14336.21150836693;5163.586913046947;6723.932760672428;6855.040294358794;6926.757563485254;6935.375816176568;6098.786542470993;6172.9074063889075;6217.782377616762;6319.526035547352;6326.841828954313;4543.091381723602;4770.236762118045;4780.737059461763;4787.664863459524;4797.424309082932;1275.5216793702361;1466.149633212734;1497.116701146329;1517.529565834595;1521.8630323270738;782.342832021105;796.5738329993426;815.6778072661266;819.1399031017407;842.8946381702287;5238.528532432099;5636.887262254732;6109.450149486567;6123.2652081750475;6366.427021567988;472.6242637103511;567.6367125039977;591.73371982608;593.8129489210885;595.2886300870418;3920.9019774505296;3978.622030907059;4184.623383895464;4445.933311000337;4479.104179164115;13642.454301827816;15138.091714497166;15225.771613425808;15333.233338333039;15353.6161595961;14643.006014410741;15216.619584510254;15266.313015914311;15276.15981121049;15278.236088195546;7371.631418429057;7628.275313845287;8306.127856575093;8553.44402613828;8627;6902.309769023058;6915.585064896122;7086.255943126103;7138.964850096603;7256.673449694882;12535.24788512692;12711.618651440102;12743.745125097632;12857.871421285667;12972.351382430652;13466.394012269275;13726;13753.587392378246;13771.655708607364;14011.509597164051;8908.55457227123;9074.863877041718;9103.180713735796;9103.726888193365;9107.952585452758;10742.355458672504;10742.462876855969;10744.83882741775;10867.673969780919;10891.891081089088;9133.40632858862;9134.543272836465;9222.584983675884;9238.95380523093;9276.25789936817;8986.415882967585;9061.184493395625;9100.180983711498;9109.22571581423;9252.398594091363;8178.591070446573;8274.669013239403;8295.58522073906;8308.418410711192;8313.043999939842;5922.378150294329;5998.880022399615;6125.1424800527075;6133.202683651097;6161;6114.144019837316;6126.479249263863;6206.348333425106;6242.875142497034;6267.96866015667 09:40:12 INFO - PID 1912 | |4;prototype.html;347.87302634538383;390.7538250901931;396.3282236608949;401.4399912122589;407.84094203260713;5632.493075623198;6103.7253323600435;6247.219097612799;6253.218347706536;6264.84337891553;5220.068574627393;5249.1338929076655;5850.853728656785;5963.612365196259;6058.545609079326;3636;3726.3851464508457;4446;4468.642508599304;4501.212287849613;4464.8214071437105;4467.977660111695;4479.686421950465;4493.719584703169;4495.820167193308;3674.761140525857;4352.216601011816;4424.889377765566;4425.4910685271125;4447.533009034053;4345.543717909637;4404.295312749977;4410.492793328776;4441.9111617767785;4446.7776611169475;3774.8476675656834;3779.357509223411;3792.6965842732516;3807.3146833569945;3811.3711237645757;4551.476580193287;5908.615939963888;5985;6022.578419510636;6065.727042283108;4370.672199585012;4963.362090510123;5216.713080780555;5231.476852314776;5336.546393556514;6485.189351331083;6490.578112422678;6532.150820393318;6551.724137931034;6577.210734711865;4167.2082304362375;4295.463067116611;4302.5052119006405;4309.935350969738;4325.740455572675;6746.987951807219;6848.520603557753;6993.79018629447;7025.683844227022;7075.629664062545;3886.70849686269;4350.868774118752;4365.541618130051;4371.715838470553;4409.911801763947;3946.7370441458456;3949.289127956938;4220.978895105566;4419.558044195619;4438.979034822009;5147.2279158126585;5241.50205730455;5256.08018596744;5272.947270527246;5292.073887069748;5198.532132108053;6654.500912431587;6660.8667826643195;6673.432758215509;6687.966560167168;1499.1904371639193;1511.9319630616649;1517.271709579408;1517.2792923361535;1528.4039224702376;901.2249465459699;909.6361455417754;976.023976023976;979.4857699707568;991.5984026469291;5311.7078560678765;5336.957933977673;6112.144299798032;6212.396809850276;6314.557980941382;6014.308354539196;6157;6203.689815509297;6447.677616119176;6981.371676549135;6216.564840461215;6220.377962203744;6222.222222222223;6241.375862413723;6254.906176407358;3543.875964341236;3554.662307080823;3568.2506673598314;3598.982005089958;3621.366260904384;7030.683619237147;7033.8944915826305;7074.575525468488;7080.2919708028785;7094.68073936674;6799.932000680029;6924.480663950224;7030.469031148782;7054.823629409203;7072.646367681596;5519.365272993577;6618.768343108064;7028.402585780266;7035.753748618774;7042.7887163385185;5705.543556515386;6033.8234044360925;6182.443580077815;6833.145856767904;6848.554843935328;4945.876353091057;6397.936020639921;6678.365555272241;6831.293793543905;6856.108705868205;5873.970630146822;7117.893231601426;7138.571685698875;7139.571625702474;7187.31720486553;3336.666333366644;4350.129974005148;4380.145871555016;4383.298672212431;4397.120575884772;6285.905711414424;6797.218319893078;6870;6954.895676564956;6959.791206263821;5534.861628459321;6623.900641490285;6658.702747552087;6658.866822663616;6664.766733164316;6443.935560644333;6549.377809108127;6644.83387915306;6671.46628269747;6744.258131605421;5454.563634909118;5938.406159384027;6473.993062150748;6523.18460192476;6578.934210658023;6387.435078405821;6538.248101468392;6579.519608088333;6645.534812563074;6687.565308254948;6186.948218802724;6413.486921046212;6507.967460162668;6524.412802847766;6541.215054193527 09:40:12 INFO - PID 1912 | |5;yui.html;732.5311800447713;826.2976470000497;834.9813227862006;862.0689655172414;870.3863776037892;8483.74548763538;12436.502539898416;16352.591185220375;16468.917655411722;16884.902481338704;13224.471021159166;14968.625784355396;17432.95402275861;17498;17524.21141048653;941.9481928493947;977.1205914676776;983.6557204978272;983.8917719050899;984.9015098490165;987.9802403951917;996.2428554298713;1002.3685078400633;1003.3829195045067;1005.7485628592851;1025.7435641089728;1028.4395004722408;1044.075992746421;1047.586203449637;1047.8899715529874;1006.3207335048813;1008.6268080810111;1018.2057994764095;1020.5968642386252;1027.7430642339416;750.8198032472222;752.8306131120509;753.2693287511105;754.8188434775669;755.4107795919192;13507.594772156852;16509.58726031847;16766.832331676647;16895.662086758195;16897.40859069939;16407.589810254718;16669.49991500257;16854.747178792328;16997.83002169975;17001;12133.575324863676;13557.25435101069;13678.905687544973;13833.170009799343;13923.58229253124;3088.3514461963014;3394.7623666343366;3427.3145370925663;3428.9314213715584;3432;122585.38707306495;123125.38437307846;123789;124763;128882.3555882224;12037.819432708517;12126.27242365461;12192.268463892195;12282.201656892274;12318.75362492745;20266.79733202649;20742.377728668165;20767.480812979797;20770.58458830815;21184.258550950643;7650.846983060308;7896.447248692536;7916.841663166704;7918.406119541058;7944.006999125109;3929.58739332366;3961.485006949078;3983.46223259862;4015.8393664253103;4035.051762835731;4269.402283680287;4320.632746216606;4354.7822608870065;4359.694821362475;4372.300431930876;923.7829110159107;957.4973139102027;961.3991255465335;963.4460185393427;967.8403063494444;647.2459584584001;665.6937808607997;674.6289540752566;675.9966200168967;698.2877464985686;11393.145514086476;11920.225185362924;12021.879781202251;12032.759344813056;12218.205816622069;646.8253571535753;649.574528683713;657.6744511466854;677.6611694152923;683.3132701634925;5370.489803468664;5544.306961629796;5681.233033540502;5970.492508136857;6048.637081775108;104119.4794026025;104162;105364;106119;108424;98944;100035.49982250188;101104.92265541342;101375.98624013813;102214;78452.60773696096;80148;82357.58821205856;82976;84004.15995840085;10967.451627418437;11134.498947547218;12343.19769214998;12998.350082496027;13026.153300035467;31532.527012095296;33946.151346216546;40452.59547404606;41049.79475102606;41604.58395416007;52635.68410789761;53562.73218633882;64863.027054595164;64883.35116648962;66423.00365494424;16077.919610401874;16150.919245403698;16421.507354779376;16584.0878751665;16600.75098873542;17841;18053.368132115313;18125.093745312945;18286.817131828513;18343.35798247055;16010.599735006717;16155;16669.49991500257;16686.916565417094;16741.832581674516;13497.460101595827;15701.842981570038;15833.52499425019;16445.09551974653;16477.752833707265;15693.843061569238;16025.51923442252;16064.759028614346;16217;16303.184840758151;9533.761655958657;11379;11922.940385298365;12371.628851134481;12377;13027.544035958696;14042.297885105909;14062.648433789238;14314.427422902967;14456.927715361357 09:40:12 INFO - PID 1912 | __end_tp_report 09:40:12 INFO - PID 1912 | __start_cc_report 09:40:12 INFO - PID 1912 | _x_x_mozilla_cycle_collect,427 09:40:12 INFO - PID 1912 | __end_cc_report 09:40:12 INFO - PID 1912 | __startTimestamp1493311212943__endTimestamp 09:40:12 INFO - PID 1912 | 09:40:12 INFO - PID 1912 | ------- Summary: start ------- 09:40:12 INFO - PID 1912 | Number of tests: 6 09:40:12 INFO - PID 1912 | 09:40:12 INFO - PID 1912 | [#0] dojo.html Cycles:165 Average:6142.11 Median:6357.71 stddev:754.39 (11.9%) stddev-sans-first:722.53 09:40:12 INFO - PID 1912 | Values: 3280.6 3608.8 3634.0 3642.3 3652.2 6065.8 6182.4 6185.5 6211.7 6233.0 4516.9 5607.8 5817.5 6167.7 6202.7 5409.2 5418.7 5481.0 5533.5 5620.1 4533.2 5571.6 5578.6 5584.7 5589.0 4833.4 5353.5 5599.2 5599.6 5619.2 4947.5 5156.8 5296.1 5364.0 5534.9 5407.1 5427.5 5477.2 5509.4 5513.7 5646.8 5746.2 6048.1 6207.6 6297.0 6691.6 6705.9 6707.8 6710.6 6744.4 6494.7 6570.2 6672.7 6748.8 6764.9 5310.5 6299.4 6305.1 6322.5 6328.1 6736.3 6804.2 6827.1 6875.0 6892.8 6300.1 6358.2 6513.3 6571.5 6573.8 6470.3 6577.1 6603.9 6728.9 6732.1 6533.3 6666.1 6670.9 6692.2 6698.6 6688.6 6699.2 6708.3 6720.2 6723.1 5133.8 5203.1 5232.8 5293.4 5326.4 4772.0 4810.1 4856.7 4857.5 4869.1 6185.8 6331.2 6347.1 6351.3 6353.3 6754.8 6774.3 6821.1 6835.0 6867.7 6123.3 6225.1 6257.2 6266.8 6356.5 5919.5 5921.8 5932.4 5942.7 5975.6 6893.5 6921.0 6930.5 6963.8 6986.9 6483.5 6575.9 6699.2 6812.0 6823.1 6939.7 6940.5 6950.4 6995.5 7023.1 6681.8 6692.1 6692.2 6697.4 6709.6 6341.9 6709.8 6772.6 6834.1 6843.6 5856.0 5896.9 6219.1 6493.7 6606.5 6543.1 6553.7 6557.2 6572.2 6583.0 6167.4 6264.3 6357.7 6426.5 6440.8 6575.9 6616.7 6626.0 6662.7 6665.0 6435.9 6453.9 6461.0 6468.4 6477.5 09:40:12 INFO - PID 1912 | 09:40:12 INFO - PID 1912 | [#1] ext.html Cycles:180 Average:42097.76 Median:3178.87 stddev:70656.41 (2222.7%) stddev-sans-first:70786.45 09:40:12 INFO - PID 1912 | Values: 760.8 809.1 829.4 1216.7 1258.2 36130.0 37552.6 37574.6 37574.6 37624.6 37380.6 37514.6 37612.8 37645.0 37911.0 7885.0 8076.2 8372.1 8610.4 8622.4 7385.9 8451.2 8455.0 8557.4 8561.1 8493.1 8555.9 8559.3 8570.0 8597.7 8452.7 8506.6 8535.4 8539.5 8553.4 8320.0 8334.1 8367.5 8375.4 8378.3 36821.4 36944.4 37062.8 37064.3 37113.8 3238.1 3651.6 3689.6 3707.6 3711.1 30298.0 30335.0 30410.1 30441.4 30526.8 3044.6 3146.6 3164.5 3173.1 3184.7 240637.0 245944.0 252169.0 273635.0 274675.0 46675.8 46879.5 46908.8 46910.8 47023.0 48203.8 48390.0 48458.0 48511.3 48940.8 14033.3 14040.4 14107.8 14159.6 14212.9 11428.5 11490.4 11608.9 11655.0 11676.4 13103.6 13142.3 13183.2 13215.5 13281.0 5038.3 5579.6 5891.9 5939.3 5940.6 909.4 929.2 1017.2 1044.9 1068.3 18554.7 23860.3 23862.9 23882.9 23923.9 1082.2 1102.3 1137.6 1146.2 1151.2 11868.6 12086.9 12102.5 12164.8 12166.0 284845.2 287313.0 288320.0 289894.0 295709.0 49321.5 49527.8 49542.3 49623.0 49649.0 1372.3 1461.6 1500.8 1507.0 1521.8 23093.5 23109.8 23144.0 23173.0 23178.7 36188.6 36348.8 36441.8 36493.6 36732.3 225716.9 270777.0 271215.0 272065.0 272484.0 27847.6 31722.8 31940.0 33859.7 35756.0 42631.0 44067.8 44320.8 44441.3 44473.3 24313.9 28896.1 29431.4 30878.4 30885.5 30646.0 30874.7 30946.7 30989.8 31046.8 36887.4 37080.0 37100.8 37108.6 37165.8 28941.0 30465.5 31040.7 31067.5 31122.8 19358.6 23739.6 24386.8 24402.3 24497.9 09:40:12 INFO - PID 1912 | 09:40:12 INFO - PID 1912 | [#2] jquery.html Cycles:180 Average:35003.91 Median:23278.21 stddev:92088.69 (395.6%) stddev-sans-first:92310.45 09:40:12 INFO - PID 1912 | Values: 436.7 442.3 444.6 457.3 462.0 21401.7 22209.0 22280.2 23298.4 23349.8 23000.3 23258.0 23614.5 23694.8 23942.8 5948.6 5997.8 6117.2 6194.8 6214.0 6062.9 6166.1 6182.2 6187.4 6200.7 5890.9 6143.2 6179.1 6181.3 6183.6 5143.7 5979.4 6066.0 6124.4 6125.2 4721.8 4757.5 5475.0 5483.5 5496.4 22547.7 27370.7 27459.9 27976.6 28245.2 2142.2 2190.5 2193.8 2198.1 2204.3 14322.4 16981.4 17633.5 18028.1 18139.9 1819.7 2128.6 2174.6 2194.4 2199.0 151232.5 156998.2 158906.2 159303.0 161210.4 11994.8 12663.6 12666.5 12689.8 12734.0 16438.4 16503.3 16520.0 16554.3 16587.0 8778.2 8890.2 9019.4 9081.2 9113.9 7217.2 8486.4 8501.4 8521.8 8711.5 6715.5 7773.0 7861.1 7922.0 7947.4 2173.1 2182.7 2187.3 2196.2 2336.9 986.7 987.8 989.1 1015.6 1036.8 16015.0 18728.8 19346.6 19933.5 20559.3 997.9 1017.9 1032.3 1052.4 1055.2 8660.9 9946.3 10715.3 10719.4 10727.9 535158.3 538351.0 540225.0 547892.5 551165.0 121819.0 124423.0 124718.8 125521.4 126707.0 1155.0 1157.9 1167.0 1203.5 1205.9 17958.4 17960.0 17966.8 17968.8 18234.9 48093.0 53236.1 54674.7 55162.6 56119.0 72903.0 73276.0 74249.0 74285.0 76094.6 8476.0 8665.7 8766.7 8816.3 8946.4 13934.0 13959.9 14054.3 14354.8 14399.8 9747.7 11585.5 11979.2 12046.8 12223.8 11118.9 11120.4 11136.3 11268.0 11450.5 9718.5 11901.6 12051.0 12131.9 12244.7 8558.2 8606.3 8732.6 8739.8 8759.8 9578.0 11891.4 11936.8 11939.8 12001.8 09:40:12 INFO - PID 1912 | 09:40:12 INFO - PID 1912 | [#3] mootools.html Cycles:180 Average:7193.52 Median:3707.37 stddev:4580.05 (123.5%) stddev-sans-first:4571.18 09:40:12 INFO - PID 1912 | Values: 1257.8 1406.6 1462.7 1463.4 1480.2 11453.4 11800.5 11899.6 11921.5 12202.9 11684.1 11807.4 11878.7 11882.9 11924.6 2447.1 2492.3 2526.1 2543.4 2552.4 2187.6 2477.4 2524.4 2528.4 2528.7 2481.0 2481.9 2539.4 2540.4 2546.0 2467.7 2471.0 2487.9 2507.0 2530.7 2214.8 2313.3 2401.4 2478.8 2493.5 11643.8 11678.7 11832.8 11847.0 11851.0 6609.4 6861.6 6863.8 6864.9 6875.7 3493.8 4193.5 4275.6 4339.0 4349.0 1134.4 1250.4 1269.2 1277.2 1300.9 16128.2 16213.7 16542.3 16576.4 16726.2 6001.2 6120.5 6238.8 6252.8 6290.6 13920.4 14039.6 14047.4 14057.6 14336.2 5163.6 6723.9 6855.0 6926.8 6935.4 6098.8 6172.9 6217.8 6319.5 6326.8 4543.1 4770.2 4780.7 4787.7 4797.4 1275.5 1466.1 1497.1 1517.5 1521.9 782.3 796.6 815.7 819.1 842.9 5238.5 5636.9 6109.5 6123.3 6366.4 472.6 567.6 591.7 593.8 595.3 3920.9 3978.6 4184.6 4445.9 4479.1 13642.5 15138.1 15225.8 15333.2 15353.6 14643.0 15216.6 15266.3 15276.2 15278.2 7371.6 7628.3 8306.1 8553.4 8627.0 6902.3 6915.6 7086.3 7139.0 7256.7 12535.2 12711.6 12743.7 12857.9 12972.4 13466.4 13726.0 13753.6 13771.7 14011.5 8908.6 9074.9 9103.2 9103.7 9108.0 10742.4 10742.5 10744.8 10867.7 10891.9 9133.4 9134.5 9222.6 9239.0 9276.3 8986.4 9061.2 9100.2 9109.2 9252.4 8178.6 8274.7 8295.6 8308.4 8313.0 5922.4 5998.9 6125.1 6133.2 6161.0 6114.1 6126.5 6206.3 6242.9 6268.0 09:40:12 INFO - PID 1912 | 09:40:12 INFO - PID 1912 | [#4] prototype.html Cycles:180 Average:5270.58 Median:6046.18 stddev:1709.06 (28.3%) stddev-sans-first:1673.44 09:40:12 INFO - PID 1912 | Values: 347.9 390.8 396.3 401.4 407.8 5632.5 6103.7 6247.2 6253.2 6264.8 5220.1 5249.1 5850.9 5963.6 6058.5 3636.0 3726.4 4446.0 4468.6 4501.2 4464.8 4468.0 4479.7 4493.7 4495.8 3674.8 4352.2 4424.9 4425.5 4447.5 4345.5 4404.3 4410.5 4441.9 4446.8 3774.8 3779.4 3792.7 3807.3 3811.4 4551.5 5908.6 5985.0 6022.6 6065.7 4370.7 4963.4 5216.7 5231.5 5336.5 6485.2 6490.6 6532.2 6551.7 6577.2 4167.2 4295.5 4302.5 4309.9 4325.7 6747.0 6848.5 6993.8 7025.7 7075.6 3886.7 4350.9 4365.5 4371.7 4409.9 3946.7 3949.3 4221.0 4419.6 4439.0 5147.2 5241.5 5256.1 5272.9 5292.1 5198.5 6654.5 6660.9 6673.4 6688.0 1499.2 1511.9 1517.3 1517.3 1528.4 901.2 909.6 976.0 979.5 991.6 5311.7 5337.0 6112.1 6212.4 6314.6 6014.3 6157.0 6203.7 6447.7 6981.4 6216.6 6220.4 6222.2 6241.4 6254.9 3543.9 3554.7 3568.3 3599.0 3621.4 7030.7 7033.9 7074.6 7080.3 7094.7 6799.9 6924.5 7030.5 7054.8 7072.6 5519.4 6618.8 7028.4 7035.8 7042.8 5705.5 6033.8 6182.4 6833.1 6848.6 4945.9 6397.9 6678.4 6831.3 6856.1 5874.0 7117.9 7138.6 7139.6 7187.3 3336.7 4350.1 4380.1 4383.3 4397.1 6285.9 6797.2 6870.0 6954.9 6959.8 5534.9 6623.9 6658.7 6658.9 6664.8 6443.9 6549.4 6644.8 6671.5 6744.3 5454.6 5938.4 6474.0 6523.2 6578.9 6387.4 6538.2 6579.5 6645.5 6687.6 6186.9 6413.5 6508.0 6524.4 6541.2 09:40:12 INFO - PID 1912 | 09:40:12 INFO - PID 1912 | [#5] yui.html Cycles:180 Average:21821.40 Median:16999.42 stddev:31451.13 (185.0%) stddev-sans-first:31499.49 09:40:12 INFO - PID 1912 | Values: 732.5 826.3 835.0 862.1 870.4 8483.7 12436.5 16352.6 16468.9 16884.9 13224.5 14968.6 17433.0 17498.0 17524.2 941.9 977.1 983.7 983.9 984.9 988.0 996.2 1002.4 1003.4 1005.7 1025.7 1028.4 1044.1 1047.6 1047.9 1006.3 1008.6 1018.2 1020.6 1027.7 750.8 752.8 753.3 754.8 755.4 13507.6 16509.6 16766.8 16895.7 16897.4 16407.6 16669.5 16854.7 16997.8 17001.0 12133.6 13557.3 13678.9 13833.2 13923.6 3088.4 3394.8 3427.3 3428.9 3432.0 122585.4 123125.4 123789.0 124763.0 128882.4 12037.8 12126.3 12192.3 12282.2 12318.8 20266.8 20742.4 20767.5 20770.6 21184.3 7650.8 7896.4 7916.8 7918.4 7944.0 3929.6 3961.5 3983.5 4015.8 4035.1 4269.4 4320.6 4354.8 4359.7 4372.3 923.8 957.5 961.4 963.4 967.8 647.2 665.7 674.6 676.0 698.3 11393.1 11920.2 12021.9 12032.8 12218.2 646.8 649.6 657.7 677.7 683.3 5370.5 5544.3 5681.2 5970.5 6048.6 104119.5 104162.0 105364.0 106119.0 108424.0 98944.0 100035.5 101104.9 101376.0 102214.0 78452.6 80148.0 82357.6 82976.0 84004.2 10967.5 11134.5 12343.2 12998.4 13026.2 31532.5 33946.2 40452.6 41049.8 41604.6 52635.7 53562.7 64863.0 64883.4 66423.0 16077.9 16150.9 16421.5 16584.1 16600.8 17841.0 18053.4 18125.1 18286.8 18343.4 16010.6 16155.0 16669.5 16686.9 16741.8 13497.5 15701.8 15833.5 16445.1 16477.8 15693.8 16025.5 16064.8 16217.0 16303.2 9533.8 11379.0 11922.9 12371.6 12377.0 13027.5 14042.3 14062.6 14314.4 14456.9 09:40:12 INFO - PID 1912 | -------- Summary: end -------- 09:40:12 INFO - PID 1912 | 09:40:13 INFO - TEST-INFO | 1912: exit 0 09:40:13 INFO - TEST-OK | dromaeo_css | took 1115448ms 09:40:13 INFO - TEST-START | kraken 09:40:13 INFO - operating with platform_type : mac_ 09:40:13 INFO - Initialising browser for kraken test... 09:40:13 INFO - TEST-INFO | started process 1917 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/tmpLO20fi/profile http://localhost:56067/getInfo.html) 09:40:16 INFO - PID 1917 | 2017-04-27 09:40:16.450 plugin-container[1918:20543] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x943f, name = 'com.apple.tsm.portname' 09:40:16 INFO - PID 1917 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:40:16 INFO - PID 1917 | 2017-04-27 09:40:16.453 plugin-container[1918:20543] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9627, name = 'com.apple.CFPasteboardClient' 09:40:16 INFO - PID 1917 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:40:16 INFO - PID 1917 | 2017-04-27 09:40:16.453 plugin-container[1918:20543] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:40:16 INFO - PID 1917 | __metrics Screen width/height:1600/1200 09:40:16 INFO - PID 1917 | colorDepth:24 09:40:16 INFO - PID 1917 | Browser inner width/height: 1024/689 09:40:16 INFO - PID 1917 | __metrics 09:40:16 ERROR - PID 1917 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 09:40:17 INFO - TEST-INFO | 1917: exit 0 09:40:17 INFO - Browser initialized. 09:40:17 INFO - Running cycle 1/1 for kraken test... 09:40:17 INFO - TEST-INFO | started process 1919 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/tmpLO20fi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:40:20 INFO - PID 1919 | 2017-04-27 09:40:20.248 plugin-container[1920:20664] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923f, name = 'com.apple.tsm.portname' 09:40:20 INFO - PID 1919 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:40:20 INFO - PID 1919 | 2017-04-27 09:40:20.249 plugin-container[1920:20664] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9717, name = 'com.apple.CFPasteboardClient' 09:40:20 INFO - PID 1919 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:40:20 INFO - PID 1919 | 2017-04-27 09:40:20.249 plugin-container[1920:20664] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:40:29 INFO - PID 1919 | RSS: Main: 237862912 09:40:29 INFO - PID 1919 | 09:40:32 INFO - PID 1919 | Cycle 1(1): loaded http://localhost:56067/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56067/tests/kraken/driver.html?testName=audio-beat-detection) 09:40:33 INFO - PID 1919 | RSS: Main: 249614336 09:40:33 INFO - PID 1919 | 09:40:36 INFO - PID 1919 | Cycle 1(1): loaded http://localhost:56067/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56067/tests/kraken/driver.html?testName=audio-dft) 09:40:36 INFO - PID 1919 | RSS: Main: 257699840 09:40:36 INFO - PID 1919 | 09:40:40 INFO - PID 1919 | Cycle 1(1): loaded http://localhost:56067/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56067/tests/kraken/driver.html?testName=audio-fft) 09:40:41 INFO - PID 1919 | RSS: Main: 260104192 09:40:41 INFO - PID 1919 | 09:40:42 INFO - PID 1919 | Cycle 1(1): loaded http://localhost:56067/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56067/tests/kraken/driver.html?testName=audio-oscillator) 09:40:43 INFO - PID 1919 | RSS: Main: 262242304 09:40:43 INFO - PID 1919 | 09:40:45 INFO - PID 1919 | Cycle 1(1): loaded http://localhost:56067/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56067/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:40:45 INFO - PID 1919 | RSS: Main: 262561792 09:40:45 INFO - PID 1919 | 09:40:48 INFO - PID 1919 | Cycle 1(1): loaded http://localhost:56067/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56067/tests/kraken/driver.html?testName=imaging-darkroom) 09:40:49 INFO - PID 1919 | RSS: Main: 268513280 09:40:49 INFO - PID 1919 | 09:40:52 INFO - PID 1919 | Cycle 1(1): loaded http://localhost:56067/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56067/tests/kraken/driver.html?testName=imaging-desaturate) 09:40:53 INFO - PID 1919 | RSS: Main: 269553664 09:40:53 INFO - PID 1919 | 09:40:56 INFO - PID 1919 | Cycle 1(1): loaded http://localhost:56067/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56067/tests/kraken/driver.html?testName=json-parse-financial) 09:40:57 INFO - PID 1919 | RSS: Main: 269434880 09:40:57 INFO - PID 1919 | 09:40:58 INFO - PID 1919 | Cycle 1(1): loaded http://localhost:56067/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56067/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:40:59 INFO - PID 1919 | RSS: Main: 268599296 09:40:59 INFO - PID 1919 | 09:41:00 INFO - PID 1919 | Cycle 1(1): loaded http://localhost:56067/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56067/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:41:01 INFO - PID 1919 | RSS: Main: 268685312 09:41:01 INFO - PID 1919 | 09:41:03 INFO - PID 1919 | Cycle 1(1): loaded http://localhost:56067/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56067/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:41:04 INFO - PID 1919 | RSS: Main: 268324864 09:41:04 INFO - PID 1919 | 09:41:07 INFO - PID 1919 | Cycle 1(1): loaded http://localhost:56067/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56067/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:41:08 INFO - PID 1919 | RSS: Main: 268410880 09:41:08 INFO - PID 1919 | 09:41:11 INFO - PID 1919 | Cycle 1(1): loaded http://localhost:56067/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56067/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:41:11 INFO - PID 1919 | RSS: Main: 268697600 09:41:11 INFO - PID 1919 | 09:41:13 INFO - PID 1919 | Cycle 1(1): loaded http://localhost:56067/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56067/tests/kraken/driver.html?testName=ai-astar) 09:41:14 INFO - PID 1919 | RSS: Main: 270143488 09:41:14 INFO - PID 1919 | 09:41:14 INFO - PID 1919 | __start_tp_report 09:41:14 INFO - PID 1919 | _x_x_mozilla_page_load 09:41:14 INFO - PID 1919 | _x_x_mozilla_page_load_details 09:41:14 INFO - PID 1919 | |i|pagename|runs| 09:41:14 INFO - PID 1919 | |0;ai-astar;82;146;170;149;114;114;123;115;118;117 09:41:14 INFO - PID 1919 | |1;audio-beat-detection;148;111;110;153;123;146;115;112;137;118 09:41:14 INFO - PID 1919 | |2;audio-dft;197;203;204;224;297;261;196;199;196;202 09:41:14 INFO - PID 1919 | |3;audio-fft;79;58;58;84;60;59;58;59;75;63 09:41:14 INFO - PID 1919 | |4;audio-oscillator;86;76;69;59;85;61;72;59;57;99 09:41:14 INFO - PID 1919 | |5;imaging-gaussian-blur;113;90;92;90;91;91;92;91;91;92 09:41:14 INFO - PID 1919 | |6;imaging-darkroom;127;101;99;102;98;97;100;98;104;98 09:41:14 INFO - PID 1919 | |7;imaging-desaturate;91;95;111;90;125;126;146;149;91;91 09:41:14 INFO - PID 1919 | |8;json-parse-financial;50;49;48;51;48;69;70;70;72;50 09:41:14 INFO - PID 1919 | |9;json-stringify-tinderbox;57;55;65;61;66;75;45;50;50;79 09:41:14 INFO - PID 1919 | |10;stanford-crypto-aes;83;81;84;82;85;93;83;85;82;98 09:41:14 INFO - PID 1919 | |11;stanford-crypto-ccm;144;137;135;137;162;150;128;163;197;156 09:41:14 INFO - PID 1919 | |12;stanford-crypto-pbkdf2;185;176;247;236;179;183;188;214;226;191 09:41:14 INFO - PID 1919 | |13;stanford-crypto-sha256-iterative;76;92;102;67;70;92;102;93;98;82 09:41:14 INFO - PID 1919 | __end_tp_report 09:41:14 INFO - PID 1919 | __start_cc_report 09:41:14 INFO - PID 1919 | _x_x_mozilla_cycle_collect,1009 09:41:14 INFO - PID 1919 | __end_cc_report 09:41:14 INFO - PID 1919 | __startTimestamp1493311274140__endTimestamp 09:41:14 INFO - PID 1919 | 09:41:14 INFO - PID 1919 | ------- Summary: start ------- 09:41:14 INFO - PID 1919 | Number of tests: 14 09:41:14 INFO - PID 1919 | 09:41:14 INFO - PID 1919 | [#0] ai-astar Cycles:10 Average:124.80 Median:134.50 stddev:24.38 (18.1%) stddev-sans-first:20.35 09:41:14 INFO - PID 1919 | Values: 82.0 146.0 170.0 149.0 114.0 114.0 123.0 115.0 118.0 117.0 09:41:14 INFO - PID 1919 | 09:41:14 INFO - PID 1919 | [#1] audio-beat-detection Cycles:10 Average:127.30 Median:130.00 stddev:16.96 (13.0%) stddev-sans-first:16.25 09:41:14 INFO - PID 1919 | Values: 148.0 111.0 110.0 153.0 123.0 146.0 115.0 112.0 137.0 118.0 09:41:14 INFO - PID 1919 | 09:41:14 INFO - PID 1919 | [#2] audio-dft Cycles:10 Average:217.90 Median:203.50 stddev:34.27 (16.8%) stddev-sans-first:35.51 09:41:14 INFO - PID 1919 | Values: 197.0 203.0 204.0 224.0 297.0 261.0 196.0 199.0 196.0 202.0 09:41:14 INFO - PID 1919 | 09:41:14 INFO - PID 1919 | [#3] audio-fft Cycles:10 Average:65.30 Median:61.50 stddev:10.02 (16.3%) stddev-sans-first:9.32 09:41:14 INFO - PID 1919 | Values: 79.0 58.0 58.0 84.0 60.0 59.0 58.0 59.0 75.0 63.0 09:41:14 INFO - PID 1919 | 09:41:14 INFO - PID 1919 | [#4] audio-oscillator Cycles:10 Average:72.30 Median:74.00 stddev:14.15 (19.1%) stddev-sans-first:14.11 09:41:14 INFO - PID 1919 | Values: 86.0 76.0 69.0 59.0 85.0 61.0 72.0 59.0 57.0 99.0 09:41:14 INFO - PID 1919 | 09:41:14 INFO - PID 1919 | [#5] imaging-gaussian-blur Cycles:10 Average:93.30 Median:91.00 stddev:6.96 (7.6%) stddev-sans-first:0.78 09:41:14 INFO - PID 1919 | Values: 113.0 90.0 92.0 90.0 91.0 91.0 92.0 91.0 91.0 92.0 09:41:14 INFO - PID 1919 | 09:41:14 INFO - PID 1919 | [#6] imaging-darkroom Cycles:10 Average:102.40 Median:97.50 stddev:8.91 (9.1%) stddev-sans-first:2.29 09:41:14 INFO - PID 1919 | Values: 127.0 101.0 99.0 102.0 98.0 97.0 100.0 98.0 104.0 98.0 09:41:14 INFO - PID 1919 | 09:41:14 INFO - PID 1919 | [#7] imaging-desaturate Cycles:10 Average:111.50 Median:90.50 stddev:23.53 (26.0%) stddev-sans-first:23.76 09:41:14 INFO - PID 1919 | Values: 91.0 95.0 111.0 90.0 125.0 126.0 146.0 149.0 91.0 91.0 09:41:14 INFO - PID 1919 | 09:41:14 INFO - PID 1919 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:60.00 stddev:10.86 (18.1%) stddev-sans-first:11.16 09:41:14 INFO - PID 1919 | Values: 50.0 49.0 48.0 51.0 48.0 69.0 70.0 70.0 72.0 50.0 09:41:14 INFO - PID 1919 | 09:41:14 INFO - PID 1919 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:63.00 stddev:11.09 (17.6%) stddev-sans-first:11.69 09:41:14 INFO - PID 1919 | Values: 57.0 55.0 65.0 61.0 66.0 75.0 45.0 50.0 50.0 79.0 09:41:14 INFO - PID 1919 | 09:41:14 INFO - PID 1919 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:84.50 stddev:5.50 (6.5%) stddev-sans-first:5.75 09:41:14 INFO - PID 1919 | Values: 83.0 81.0 84.0 82.0 85.0 93.0 83.0 85.0 82.0 98.0 09:41:14 INFO - PID 1919 | 09:41:14 INFO - PID 1919 | [#11] stanford-crypto-ccm Cycles:10 Average:150.90 Median:153.00 stddev:20.09 (13.1%) stddev-sans-first:21.15 09:41:14 INFO - PID 1919 | Values: 144.0 137.0 135.0 137.0 162.0 150.0 128.0 163.0 197.0 156.0 09:41:14 INFO - PID 1919 | 09:41:14 INFO - PID 1919 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:202.50 Median:202.50 stddev:25.97 (12.8%) stddev-sans-first:26.76 09:41:14 INFO - PID 1919 | Values: 185.0 176.0 247.0 236.0 179.0 183.0 188.0 214.0 226.0 191.0 09:41:14 INFO - PID 1919 | 09:41:14 INFO - PID 1919 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:87.40 Median:87.00 stddev:12.87 (14.8%) stddev-sans-first:12.97 09:41:14 INFO - PID 1919 | Values: 76.0 92.0 102.0 67.0 70.0 92.0 102.0 93.0 98.0 82.0 09:41:14 INFO - PID 1919 | -------- Summary: end -------- 09:41:14 INFO - PID 1919 | 09:41:15 INFO - TEST-INFO | 1919: exit 0 09:41:15 INFO - TEST-OK | kraken | took 61628ms 09:41:15 INFO - SUITE-END | took 1177s 09:41:15 INFO - Completed test suite (00:19:37) 09:41:15 INFO - javascript benchmark 09:41:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7805.067463384571, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3280.6391296957336, 3608.8195590220485, 3634.01881491997, 3642.253338065697, 3652.214773823628, 6065.818025459233, 6182.350853160416, 6185.505159587234, 6211.658358790265, 6232.968835155823, 4516.864494065183, 5607.775688972436, 5817.505512031483, 6167.722452489637, 6202.689865506729, 5409.215663728776, 5418.7019713915815, 5481.0, 5533.501984821365, 5620.072688006495, 4533.161365147442, 5571.609987300891, 5578.553715702755, 5584.692841893694, 5589.0, 4833.419989601252, 5353.518183363496, 5599.244102046212, 5599.608027438081, 5619.185218143367, 4947.480514545993, 5156.845294641167, 5296.126139187029, 5364.034473794715, 5534.944650553483, 5407.134858422633, 5427.511523962862, 5477.20580515827, 5509.421510741355, 5513.724313784335, 5646.802361917313, 5746.224259724925, 6048.123022161762, 6207.627542347428, 6296.96851515744, 6691.59850408977, 6705.899411508832, 6707.832304192385, 6710.563813352116, 6744.393004629558, 6494.707738151795, 6570.211574611029, 6672.733090676367, 6748.7975360738765, 6764.898526522106, 5310.548603368679, 6299.433051025429, 6305.148804911279, 6322.4942004639515, 6328.082428047907, 6736.295037729229, 6804.217514985741, 6827.146606674166, 6874.9656251718425, 6892.793216203522, 6300.086487459293, 6358.205224346957, 6513.316101809337, 6571.474282057519, 6573.80278591643, 6470.320616335312, 6577.079208910756, 6603.867922641521, 6728.899066514006, 6732.091167692299, 6533.346665333429, 6666.133402657623, 6670.899936500957, 6692.163479565054, 6698.56459330142, 6688.632125233159, 6699.196096468358, 6708.329167083252, 6720.1599800025, 6723.058771771955, 5133.794648214104, 5203.089459344676, 5232.764525596357, 5293.3647962244, 5326.36083669962, 4772.0455908817685, 4810.11012962603, 4856.708597484162, 4857.53853383928, 4869.14789911764, 6185.783497577563, 6331.240251169797, 6347.143135676717, 6351.301356850743, 6353.269374021954, 6754.797356079325, 6774.254831968479, 6821.113255276782, 6834.965825170842, 6867.725290988305, 6123.3131248723375, 6225.066240064027, 6257.186565746424, 6266.780662676784, 6356.523260755462, 5919.4968427684125, 5921.792737254175, 5932.377100404482, 5942.673152976541, 5975.641461512323, 6893.517453778188, 6921.007216428184, 6930.465462614003, 6963.7562685305775, 6986.895196572157, 6483.546151769519, 6575.901361479486, 6699.162604674416, 6812.0, 6823.112995310578, 6939.653017349214, 6940.479464040318, 6950.374466298057, 6995.510314277952, 7023.122109736283, 6681.76613818514, 6692.0965669635925, 6692.196936367667, 6697.3637504437, 6709.630970296681, 6341.8731625368155, 6709.832254193684, 6772.5936443813525, 6834.1457317835275, 6843.623600702009, 5856.033754430471, 5896.938551060679, 6219.129321895029, 6493.675316234075, 6606.537542371988, 6543.116679248241, 6553.737850485927, 6557.245916719447, 6572.178477690289, 6582.967085164735, 6167.383261673976, 6264.342244064308, 6357.7139028742895, 6426.518011149276, 6440.8389790255615, 6575.934240657723, 6616.735330586723, 6625.966870165618, 6662.666866656551, 6665.0, 6435.903461447989, 6453.870922581616, 6460.967695161494, 6468.353164683494, 6477.514186435942], "value": 6091.536378191302, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.8359210408074, 809.0816922792629, 829.3779665251063, 1216.7140721930346, 1258.1633213912748, 36130.0, 37552.559083659544, 37574.62425375745, 37574.62425375745, 37624.623753762455, 37380.626193738055, 37514.624853751455, 37612.811935940284, 37645.0, 37911.0, 7884.960575197116, 8076.192380761936, 8372.120927302636, 8610.440321379121, 8622.439541429787, 7385.889211661829, 8451.197136272045, 8455.0, 8557.400981931267, 8561.101084386144, 8493.065762766091, 8555.871661925075, 8559.27246184075, 8569.957150214272, 8597.742067737947, 8452.704155354564, 8506.574671266442, 8535.402521823475, 8539.530325832076, 8553.358498112635, 8319.958400208021, 8334.083250842403, 8367.456115352543, 8375.41372103953, 8378.287845533137, 36821.44767828485, 36944.44583331252, 37062.81468592667, 37064.258714825824, 37113.814430927945, 3238.141892398516, 3651.561812582507, 3689.5795118879423, 3707.5550933888107, 3711.109333759905, 30298.0, 30335.0, 30410.087697369116, 30441.39117217643, 30526.84736576325, 3044.6498652655005, 3146.606674165729, 3164.4620414529586, 3173.079806856009, 3184.6656101109284, 240637.0, 245944.0, 252169.0, 273635.0, 274675.0, 46675.76662116668, 46879.531204688195, 46908.7654561725, 46910.765446172554, 47023.0, 48203.758981205574, 48390.0, 48458.0, 48511.27233091507, 48940.77648058827, 14033.29833508341, 14040.438382464792, 14107.78838317426, 14159.575212743634, 14212.85787142136, 11428.485718142703, 11490.42547872603, 11608.941955290338, 11655.0, 11676.357800321064, 13103.606891793072, 13142.277174755289, 13183.209007459584, 13215.537456188988, 13281.0, 5038.269450929594, 5579.632989917415, 5891.852703682356, 5939.2575928009, 5940.61386009908, 909.3907082254905, 929.2380248196549, 1017.2147880469876, 1044.8537204791335, 1068.326954018963, 18554.72167917482, 23860.284191474282, 23862.88068559646, 23882.880585596962, 23923.880380598333, 1082.1721383141903, 1102.3441052573705, 1137.641642882506, 1146.18620779246, 1151.240181480219, 11868.584599539148, 12086.87913120875, 12102.455389507493, 12164.817527736914, 12166.0, 284845.151548486, 287313.0, 288320.0, 289894.0, 295709.0, 49321.50678493169, 49527.75236123797, 49542.256866147036, 49623.0, 49649.0, 1372.2521225931691, 1461.6126726417508, 1500.8499150085122, 1506.9698606027819, 1521.8325984141736, 23093.538129236986, 23109.768902310763, 23144.0, 23173.0, 23178.652320214875, 36188.63811361958, 36348.818255908554, 36441.81779091193, 36493.635063649024, 36732.26535469222, 225716.87141564186, 270777.0, 271215.0, 272065.0, 272484.0, 27847.58228626532, 31722.841385793847, 31940.0, 33859.661403386635, 35756.0, 42631.0, 44067.77966110149, 44320.77839610782, 44441.33337999868, 44473.332900007175, 24313.869591772695, 28896.133116005713, 29431.411371772872, 30878.382432350776, 30885.536716949715, 30646.0, 30874.69125308808, 30946.69053309438, 30989.760409583363, 31046.844765776026, 36887.44668829916, 37080.0, 37100.814495928425, 37108.62891371052, 37165.81417092897, 28941.0, 30465.54301685521, 31040.68959310378, 31067.533986990664, 31122.844385777928, 19358.612827743647, 23739.643905341087, 24386.756132438448, 24402.26793196207, 24497.877510612332], "value": 17112.610314530913, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [436.67467736536287, 442.2835007288194, 444.55322400987, 457.2523923385265, 461.99538004619944, 21401.67897481537, 22209.0, 22280.220192293273, 23298.41753956152, 23349.767938063636, 23000.309990700265, 23258.0, 23614.5277094458, 23694.76305236947, 23942.760572394272, 5948.553858460611, 5997.7600895964215, 6117.174181485487, 6194.814155575317, 6213.968930155343, 6062.878742425149, 6166.136740856284, 6182.227221597301, 6187.412195841388, 6200.720967556471, 5890.941090589104, 6143.232095988002, 6179.104029915659, 6181.258249010102, 6183.628982261056, 5143.665661731976, 5979.43195396441, 6065.969670151665, 6124.418180272867, 6125.234345706786, 4721.787519561628, 4757.524247575249, 5474.972625136888, 5483.479069488392, 5496.367917689477, 22547.661785073236, 27370.726292737018, 27459.862700686568, 27976.580351294746, 28245.15264542067, 2142.1752625239237, 2190.507135894427, 2193.771487966728, 2198.0658220256328, 2204.250554811372, 14322.427102915872, 16981.405650802164, 17633.470995870146, 18028.098595070194, 18139.909300453546, 1819.7088465845534, 2128.648772952461, 2174.597699425611, 2194.441946218187, 2198.9780102198933, 151232.48767512295, 156998.21500892536, 158906.20546897306, 159303.0, 161210.3878961219, 11994.760104797855, 12663.556775512812, 12666.493340266286, 12689.809652855214, 12734.0, 16438.424655137253, 16503.33986640521, 16520.0, 16554.255058522394, 16587.004779713257, 8778.166074222938, 8890.244329231959, 9019.368644194974, 9081.182693557612, 9113.908860911439, 7217.206107328189, 8486.448380855225, 8501.362397820189, 8521.829563408697, 8711.47731136134, 6715.46276297895, 7772.961135194288, 7861.135275119732, 7922.049354077548, 7947.4039447041705, 2173.1090252996196, 2182.672599110146, 2187.3219302016428, 2196.1544805249773, 2336.883155842201, 986.7039888033705, 987.7579992901641, 989.1345073061071, 1015.5785349080197, 1036.7770929250248, 16015.0, 18728.81271187298, 19346.613067738846, 19933.501662458264, 20559.280425185345, 997.9101880830615, 1017.8829434615114, 1032.318669678009, 1052.3896140238644, 1055.171690223171, 8660.8700869487, 9946.254030947708, 10715.303505272132, 10719.410432426135, 10727.892721072689, 535158.3242083765, 538351.0, 540225.0, 547892.4636579946, 551165.0, 121819.0, 124423.0, 124718.75281247254, 125521.37239313746, 126707.0, 1155.0, 1157.8842115788354, 1166.9941650291694, 1203.5426537915712, 1205.921615095016, 17958.371456998942, 17960.0, 17966.820331797036, 17968.820311796713, 18234.908825455786, 48093.0, 53236.13673521408, 54674.7266263682, 55162.62093447696, 56119.0, 72903.0, 73276.0, 74249.0, 74285.0, 76094.61952690201, 8476.024402796138, 8665.740027799176, 8766.693165739423, 8816.250618697482, 8946.37375383717, 13934.0, 13959.93020034934, 14054.297285135906, 14354.784678229626, 14399.78400324017, 9747.658831940847, 11585.536578537101, 11979.221350612183, 12046.75906481883, 12223.816642750187, 11118.888811111785, 11120.388378638929, 11136.276142050741, 11268.0, 11450.541978320774, 9718.465484398426, 11901.583444579399, 12051.0, 12131.939340303243, 12244.693882653006, 8558.229759321692, 8606.311495080503, 8732.60703268367, 8739.781505462413, 8759.824803504021, 9577.952110239405, 11891.405429728651, 11936.820947685617, 11939.820902686293, 12001.759964800829], "value": 10309.838878517123, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1257.7547378261238, 1406.563965170797, 1462.6689712361754, 1463.421948330409, 1480.2450750117441, 11453.37006464644, 11800.527978880857, 11899.643010709682, 11921.523139074437, 12202.877971220307, 11684.065274778019, 11807.350595717233, 11878.703032424171, 11882.881171188286, 11924.642260732191, 2447.1434997750735, 2492.2896974362357, 2526.077981536735, 2543.389586499236, 2552.412945022646, 2187.55155193185, 2477.355887469262, 2524.4193835417864, 2528.4184637533285, 2528.683914510686, 2480.987595062022, 2481.8759062046915, 2539.415934335095, 2540.3741605372575, 2546.045233037611, 2467.716212635543, 2471.0486462711983, 2487.875606219691, 2506.987465062681, 2530.708968468622, 2214.8449608527408, 2313.2944451942153, 2401.399650087478, 2478.776910078084, 2493.5137648158616, 11643.767124657545, 11678.708032299175, 11832.822507662391, 11847.0, 11851.0, 6609.438197753197, 6861.622610756406, 6863.794086177422, 6864.897026544606, 6875.656217189121, 3493.8470304799357, 4193.475815523059, 4275.593818587229, 4339.0, 4349.0, 1134.4384529657789, 1250.4373032135575, 1269.1952260170272, 1277.201748906933, 1300.9089363744542, 16128.193590320554, 16213.675726485522, 16542.255598497977, 16576.419825306057, 16726.247318870803, 6001.159837622737, 6120.510359171256, 6238.75044998195, 6252.843678908063, 6290.622562646256, 13920.37358318878, 14039.578812635636, 14047.367868445945, 14057.648558786112, 14336.21150836693, 5163.586913046947, 6723.932760672428, 6855.040294358794, 6926.757563485254, 6935.375816176568, 6098.786542470993, 6172.9074063889075, 6217.782377616762, 6319.526035547352, 6326.841828954313, 4543.091381723602, 4770.236762118045, 4780.737059461763, 4787.664863459524, 4797.424309082932, 1275.5216793702361, 1466.149633212734, 1497.116701146329, 1517.529565834595, 1521.8630323270738, 782.342832021105, 796.5738329993426, 815.6778072661266, 819.1399031017407, 842.8946381702287, 5238.528532432099, 5636.887262254732, 6109.450149486567, 6123.2652081750475, 6366.427021567988, 472.6242637103511, 567.6367125039977, 591.73371982608, 593.8129489210885, 595.2886300870418, 3920.9019774505296, 3978.622030907059, 4184.623383895464, 4445.933311000337, 4479.104179164115, 13642.454301827816, 15138.091714497166, 15225.771613425808, 15333.233338333039, 15353.6161595961, 14643.006014410741, 15216.619584510254, 15266.313015914311, 15276.15981121049, 15278.236088195546, 7371.631418429057, 7628.275313845287, 8306.127856575093, 8553.44402613828, 8627.0, 6902.309769023058, 6915.585064896122, 7086.255943126103, 7138.964850096603, 7256.673449694882, 12535.24788512692, 12711.618651440102, 12743.745125097632, 12857.871421285667, 12972.351382430652, 13466.394012269275, 13726.0, 13753.587392378246, 13771.655708607364, 14011.509597164051, 8908.55457227123, 9074.863877041718, 9103.180713735796, 9103.726888193365, 9107.952585452758, 10742.355458672504, 10742.462876855969, 10744.83882741775, 10867.673969780919, 10891.891081089088, 9133.40632858862, 9134.543272836465, 9222.584983675884, 9238.95380523093, 9276.25789936817, 8986.415882967585, 9061.184493395625, 9100.180983711498, 9109.22571581423, 9252.398594091363, 8178.591070446573, 8274.669013239403, 8295.58522073906, 8308.418410711192, 8313.043999939842, 5922.378150294329, 5998.880022399615, 6125.1424800527075, 6133.202683651097, 6161.0, 6114.144019837316, 6126.479249263863, 6206.348333425106, 6242.875142497034, 6267.96866015667], "value": 5376.279257464845, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.87302634538383, 390.7538250901931, 396.3282236608949, 401.4399912122589, 407.84094203260713, 5632.493075623198, 6103.7253323600435, 6247.219097612799, 6253.218347706536, 6264.84337891553, 5220.068574627393, 5249.1338929076655, 5850.853728656785, 5963.612365196259, 6058.545609079326, 3636.0, 3726.3851464508457, 4446.0, 4468.642508599304, 4501.212287849613, 4464.8214071437105, 4467.977660111695, 4479.686421950465, 4493.719584703169, 4495.820167193308, 3674.761140525857, 4352.216601011816, 4424.889377765566, 4425.4910685271125, 4447.533009034053, 4345.543717909637, 4404.295312749977, 4410.492793328776, 4441.9111617767785, 4446.7776611169475, 3774.8476675656834, 3779.357509223411, 3792.6965842732516, 3807.3146833569945, 3811.3711237645757, 4551.476580193287, 5908.615939963888, 5985.0, 6022.578419510636, 6065.727042283108, 4370.672199585012, 4963.362090510123, 5216.713080780555, 5231.476852314776, 5336.546393556514, 6485.189351331083, 6490.578112422678, 6532.150820393318, 6551.724137931034, 6577.210734711865, 4167.2082304362375, 4295.463067116611, 4302.5052119006405, 4309.935350969738, 4325.740455572675, 6746.987951807219, 6848.520603557753, 6993.79018629447, 7025.683844227022, 7075.629664062545, 3886.70849686269, 4350.868774118752, 4365.541618130051, 4371.715838470553, 4409.911801763947, 3946.7370441458456, 3949.289127956938, 4220.978895105566, 4419.558044195619, 4438.979034822009, 5147.2279158126585, 5241.50205730455, 5256.08018596744, 5272.947270527246, 5292.073887069748, 5198.532132108053, 6654.500912431587, 6660.8667826643195, 6673.432758215509, 6687.966560167168, 1499.1904371639193, 1511.9319630616649, 1517.271709579408, 1517.2792923361535, 1528.4039224702376, 901.2249465459699, 909.6361455417754, 976.023976023976, 979.4857699707568, 991.5984026469291, 5311.7078560678765, 5336.957933977673, 6112.144299798032, 6212.396809850276, 6314.557980941382, 6014.308354539196, 6157.0, 6203.689815509297, 6447.677616119176, 6981.371676549135, 6216.564840461215, 6220.377962203744, 6222.222222222223, 6241.375862413723, 6254.906176407358, 3543.875964341236, 3554.662307080823, 3568.2506673598314, 3598.982005089958, 3621.366260904384, 7030.683619237147, 7033.8944915826305, 7074.575525468488, 7080.2919708028785, 7094.68073936674, 6799.932000680029, 6924.480663950224, 7030.469031148782, 7054.823629409203, 7072.646367681596, 5519.365272993577, 6618.768343108064, 7028.402585780266, 7035.753748618774, 7042.7887163385185, 5705.543556515386, 6033.8234044360925, 6182.443580077815, 6833.145856767904, 6848.554843935328, 4945.876353091057, 6397.936020639921, 6678.365555272241, 6831.293793543905, 6856.108705868205, 5873.970630146822, 7117.893231601426, 7138.571685698875, 7139.571625702474, 7187.31720486553, 3336.666333366644, 4350.129974005148, 4380.145871555016, 4383.298672212431, 4397.120575884772, 6285.905711414424, 6797.218319893078, 6870.0, 6954.895676564956, 6959.791206263821, 5534.861628459321, 6623.900641490285, 6658.702747552087, 6658.866822663616, 6664.766733164316, 6443.935560644333, 6549.377809108127, 6644.83387915306, 6671.46628269747, 6744.258131605421, 5454.563634909118, 5938.406159384027, 6473.993062150748, 6523.18460192476, 6578.934210658023, 6387.435078405821, 6538.248101468392, 6579.519608088333, 6645.534812563074, 6687.565308254948, 6186.948218802724, 6413.486921046212, 6507.967460162668, 6524.412802847766, 6541.215054193527], "value": 4733.866937760457, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.5311800447713, 826.2976470000497, 834.9813227862006, 862.0689655172414, 870.3863776037892, 8483.74548763538, 12436.502539898416, 16352.591185220375, 16468.917655411722, 16884.902481338704, 13224.471021159166, 14968.625784355396, 17432.95402275861, 17498.0, 17524.21141048653, 941.9481928493947, 977.1205914676776, 983.6557204978272, 983.8917719050899, 984.9015098490165, 987.9802403951917, 996.2428554298713, 1002.3685078400633, 1003.3829195045067, 1005.7485628592851, 1025.7435641089728, 1028.4395004722408, 1044.075992746421, 1047.586203449637, 1047.8899715529874, 1006.3207335048813, 1008.6268080810111, 1018.2057994764095, 1020.5968642386252, 1027.7430642339416, 750.8198032472222, 752.8306131120509, 753.2693287511105, 754.8188434775669, 755.4107795919192, 13507.594772156852, 16509.58726031847, 16766.832331676647, 16895.662086758195, 16897.40859069939, 16407.589810254718, 16669.49991500257, 16854.747178792328, 16997.83002169975, 17001.0, 12133.575324863676, 13557.25435101069, 13678.905687544973, 13833.170009799343, 13923.58229253124, 3088.3514461963014, 3394.7623666343366, 3427.3145370925663, 3428.9314213715584, 3432.0, 122585.38707306495, 123125.38437307846, 123789.0, 124763.0, 128882.3555882224, 12037.819432708517, 12126.27242365461, 12192.268463892195, 12282.201656892274, 12318.75362492745, 20266.79733202649, 20742.377728668165, 20767.480812979797, 20770.58458830815, 21184.258550950643, 7650.846983060308, 7896.447248692536, 7916.841663166704, 7918.406119541058, 7944.006999125109, 3929.58739332366, 3961.485006949078, 3983.46223259862, 4015.8393664253103, 4035.051762835731, 4269.402283680287, 4320.632746216606, 4354.7822608870065, 4359.694821362475, 4372.300431930876, 923.7829110159107, 957.4973139102027, 961.3991255465335, 963.4460185393427, 967.8403063494444, 647.2459584584001, 665.6937808607997, 674.6289540752566, 675.9966200168967, 698.2877464985686, 11393.145514086476, 11920.225185362924, 12021.879781202251, 12032.759344813056, 12218.205816622069, 646.8253571535753, 649.574528683713, 657.6744511466854, 677.6611694152923, 683.3132701634925, 5370.489803468664, 5544.306961629796, 5681.233033540502, 5970.492508136857, 6048.637081775108, 104119.4794026025, 104162.0, 105364.0, 106119.0, 108424.0, 98944.0, 100035.49982250188, 101104.92265541342, 101375.98624013813, 102214.0, 78452.60773696096, 80148.0, 82357.58821205856, 82976.0, 84004.15995840085, 10967.451627418437, 11134.498947547218, 12343.19769214998, 12998.350082496027, 13026.153300035467, 31532.527012095296, 33946.151346216546, 40452.59547404606, 41049.79475102606, 41604.58395416007, 52635.68410789761, 53562.73218633882, 64863.027054595164, 64883.35116648962, 66423.00365494424, 16077.919610401874, 16150.919245403698, 16421.507354779376, 16584.0878751665, 16600.75098873542, 17841.0, 18053.368132115313, 18125.093745312945, 18286.817131828513, 18343.35798247055, 16010.599735006717, 16155.0, 16669.49991500257, 16686.916565417094, 16741.832581674516, 13497.460101595827, 15701.842981570038, 15833.52499425019, 16445.09551974653, 16477.752833707265, 15693.843061569238, 16025.51923442252, 16064.759028614346, 16217.0, 16303.184840758151, 9533.761655958657, 11379.0, 11922.940385298365, 12371.628851134481, 12377.0, 13027.544035958696, 14042.297885105909, 14062.648433789238, 14314.427422902967, 14456.927715361357], "value": 8264.890768491201, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1559.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 146.0, 170.0, 149.0, 114.0, 114.0, 123.0, 115.0, 118.0, 117.0], "value": 124.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 111.0, 110.0, 153.0, 123.0, 146.0, 115.0, 112.0, 137.0, 118.0], "value": 127.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 203.0, 204.0, 224.0, 297.0, 261.0, 196.0, 199.0, 196.0, 202.0], "value": 217.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 58.0, 84.0, 60.0, 59.0, 58.0, 59.0, 75.0, 63.0], "value": 65.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 76.0, 69.0, 59.0, 85.0, 61.0, 72.0, 59.0, 57.0, 99.0], "value": 72.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 90.0, 92.0, 90.0, 91.0, 91.0, 92.0, 91.0, 91.0, 92.0], "value": 93.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 101.0, 99.0, 102.0, 98.0, 97.0, 100.0, 98.0, 104.0, 98.0], "value": 102.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 95.0, 111.0, 90.0, 125.0, 126.0, 146.0, 149.0, 91.0, 91.0], "value": 111.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 48.0, 51.0, 48.0, 69.0, 70.0, 70.0, 72.0, 50.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 65.0, 61.0, 66.0, 75.0, 45.0, 50.0, 50.0, 79.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 84.0, 82.0, 85.0, 93.0, 83.0, 85.0, 82.0, 98.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 137.0, 135.0, 137.0, 162.0, 150.0, 128.0, 163.0, 197.0, 156.0], "value": 150.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 176.0, 247.0, 236.0, 179.0, 183.0, 188.0, 214.0, 226.0, 191.0], "value": 202.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 92.0, 102.0, 67.0, 70.0, 92.0, 102.0, 93.0, 98.0, 82.0], "value": 87.4, "unit": "score"}]}]} 09:41:15 INFO - Return code: 0 09:41:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:41:15 ERROR - # TBPL SUCCESS # 09:41:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:41:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:41:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:41:15 INFO - 2017-04-27 09:41:15.463 screenresolution[1924:21054] starting screenresolution argv=screenresolution get 09:41:15 INFO - 2017-04-27 09:41:15.466 screenresolution[1924:21054] Display 0: 1600x1200x32@60 09:41:15 INFO - 2017-04-27 09:41:15.472 screenresolution[1925:21057] starting screenresolution argv=screenresolution list 09:41:15 INFO - Available Modes on Display 0 09:41:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:41:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:41:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:41:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:41:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:41:15 INFO - Intel Iris: 09:41:15 INFO - Chipset Model: Intel Iris 09:41:15 INFO - Type: GPU 09:41:15 INFO - Bus: Built-In 09:41:15 INFO - VRAM (Dynamic, Max): 1536 MB 09:41:15 INFO - Vendor: Intel (0x8086) 09:41:15 INFO - Device ID: 0x0a2e 09:41:15 INFO - Revision ID: 0x0009 09:41:15 INFO - Displays: 09:41:15 INFO - Display: 09:41:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:41:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:41:15 INFO - Display Serial Number: 1600x1200 60 09:41:15 INFO - Main Display: Yes 09:41:15 INFO - Mirror: Off 09:41:15 INFO - Online: Yes 09:41:15 INFO - Rotation: Supported 09:41:15 INFO - Return code: 0 09:41:15 INFO - Running post-action listener: _resource_record_post_action 09:41:15 INFO - [mozharness: 2017-04-27 16:41:15.716766Z] Finished run-tests step (success) 09:41:15 INFO - Running post-run listener: _resource_record_post_run 09:41:15 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 1066496; Write bytes: 513829376; Read time: 11; Write time: 1651 09:41:15 INFO - TinderboxPrint: CPU usage
54.0% 09:41:15 INFO - TinderboxPrint: I/O read bytes / time
1,066,496 / 11 09:41:15 INFO - TinderboxPrint: I/O write bytes / time
513,829,376 / 1,651 09:41:15 INFO - TinderboxPrint: CPU idle
2,204.4 (46.0%) 09:41:15 INFO - TinderboxPrint: CPU system
963.1 (20.1%) 09:41:15 INFO - TinderboxPrint: CPU user
1,626.2 (33.9%) 09:41:15 INFO - TinderboxPrint: Swap in / out
209,219,584 / 0 09:41:15 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207901184; Write bytes: 205268480; Read time: 16155; Write time: 452 09:41:15 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 1013248; Write bytes: 301429760; Read time: 11; Write time: 1167 09:41:16 INFO - Running post-run listener: _upload_blobber_files 09:41:16 INFO - Blob upload gear active. 09:41:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:41:16 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 09:41:16 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'] 09:41:16 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 09:41:16 INFO - (blobuploader) - INFO - Open directory for files ... 09:41:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:41:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:41:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:17 INFO - (blobuploader) - INFO - Done attempting. 09:41:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:41:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:41:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:18 INFO - (blobuploader) - INFO - Done attempting. 09:41:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:41:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:41:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:19 INFO - (blobuploader) - INFO - Done attempting. 09:41:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:41:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:41:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:21 INFO - (blobuploader) - INFO - Done attempting. 09:41:21 INFO - (blobuploader) - INFO - Iteration through files over. 09:41:21 INFO - Return code: 0 09:41:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:41:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:41:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e32c3f5c7599a67574cb93fe4d784e516c8577dee8aa4fdfefc8f8773e4c0452272658e4b6274fb9aaee62e80815ff8be1ca2d7d6a02b77d7d2a3e145442fd4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70793e3d288a3ab9968e60f618b47d69c525c8ee47858294072f7183ccc5ab1d2d2a9cfa1ef1df3af58cbad4e2b07df38fb38bdc38a0cb95288f58dadd52c8cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41e529b7572935057988b094eea488e2f92eb03228df26d1784120329628e50563e3f6f0debfa9d4818488203377bb012002446bf004f57de5acb8469bb6a20a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20f7a8c9da42dc200a6298a143d904191075a0a71e3f2f0620053670778d7dcaf15fb67c38a0a9a21bb0a4b7d48c9689610e3d4127ecf6394c1063b9b64b9812"} 09:41:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:41:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:41:21 INFO - Contents: 09:41:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e32c3f5c7599a67574cb93fe4d784e516c8577dee8aa4fdfefc8f8773e4c0452272658e4b6274fb9aaee62e80815ff8be1ca2d7d6a02b77d7d2a3e145442fd4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70793e3d288a3ab9968e60f618b47d69c525c8ee47858294072f7183ccc5ab1d2d2a9cfa1ef1df3af58cbad4e2b07df38fb38bdc38a0cb95288f58dadd52c8cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41e529b7572935057988b094eea488e2f92eb03228df26d1784120329628e50563e3f6f0debfa9d4818488203377bb012002446bf004f57de5acb8469bb6a20a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20f7a8c9da42dc200a6298a143d904191075a0a71e3f2f0620053670778d7dcaf15fb67c38a0a9a21bb0a4b7d48c9689610e3d4127ecf6394c1063b9b64b9812"} 09:41:21 INFO - Running post-run listener: copy_logs_to_upload_dir 09:41:21 INFO - Copying logs to upload dir... 09:41:21 INFO - mkdir: /builds/slave/test/build/upload/logs 09:41:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.983527 ========= master_lag: 0.50 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2017-04-27 09:41:22.024598) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-27 09:41:22.027657) ========= 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.s15D9jFdxu/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.IdPcehrUWh/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e32c3f5c7599a67574cb93fe4d784e516c8577dee8aa4fdfefc8f8773e4c0452272658e4b6274fb9aaee62e80815ff8be1ca2d7d6a02b77d7d2a3e145442fd4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70793e3d288a3ab9968e60f618b47d69c525c8ee47858294072f7183ccc5ab1d2d2a9cfa1ef1df3af58cbad4e2b07df38fb38bdc38a0cb95288f58dadd52c8cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41e529b7572935057988b094eea488e2f92eb03228df26d1784120329628e50563e3f6f0debfa9d4818488203377bb012002446bf004f57de5acb8469bb6a20a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20f7a8c9da42dc200a6298a143d904191075a0a71e3f2f0620053670778d7dcaf15fb67c38a0a9a21bb0a4b7d48c9689610e3d4127ecf6394c1063b9b64b9812"} build_url:https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011268 build_url: 'https://queue.taskcluster.net/v1/task/awXcEhMjQgybIQJk36DeUg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e32c3f5c7599a67574cb93fe4d784e516c8577dee8aa4fdfefc8f8773e4c0452272658e4b6274fb9aaee62e80815ff8be1ca2d7d6a02b77d7d2a3e145442fd4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70793e3d288a3ab9968e60f618b47d69c525c8ee47858294072f7183ccc5ab1d2d2a9cfa1ef1df3af58cbad4e2b07df38fb38bdc38a0cb95288f58dadd52c8cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41e529b7572935057988b094eea488e2f92eb03228df26d1784120329628e50563e3f6f0debfa9d4818488203377bb012002446bf004f57de5acb8469bb6a20a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20f7a8c9da42dc200a6298a143d904191075a0a71e3f2f0620053670778d7dcaf15fb67c38a0a9a21bb0a4b7d48c9689610e3d4127ecf6394c1063b9b64b9812"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-27 09:41:22.064128) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 09:41:22.064471) ========= 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.s15D9jFdxu/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.IdPcehrUWh/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.005316 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 09:41:22.113581) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-27 09:41:22.113903) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-27 09:41:22.114263) ========= ========= Total master_lag: 3.26 =========