builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0088 starttime: 1486699252.13 results: success (0) buildid: 20170209185011 builduid: 4f89dbd8b6f2442480533108b73d9097 revision: 6b063631a7d3ffd5dc2b621852e4d8ac8758ef99 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 20:00:52.134589) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 20:00:52.135198) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 20:00:52.135515) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 20:00:52.161379) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 20:00:52.161801) ========= 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.rMAtioew4e/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.l2kopoFxMS/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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-02-09 20:00:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 10.6M=0.001s 2017-02-09 20:00:52 (10.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.152276 ========= master_lag: 0.25 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 20:00:52.563506) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 20:00:52.563871) ========= 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.rMAtioew4e/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.l2kopoFxMS/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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.020550 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 20:00:52.606789) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-09 20:00:52.607172) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6b063631a7d3ffd5dc2b621852e4d8ac8758ef99 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6b063631a7d3ffd5dc2b621852e4d8ac8758ef99 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rMAtioew4e/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.l2kopoFxMS/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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-02-09 20:00:52,692 truncating revision to first 12 chars 2017-02-09 20:00:52,692 Setting DEBUG logging. 2017-02-09 20:00:52,692 attempt 1/10 2017-02-09 20:00:52,692 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6b063631a7d3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-09 20:00:53,470 unpacking tar archive at: mozilla-aurora-6b063631a7d3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.050870 ========= master_lag: 0.84 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-09 20:00:54.498043) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 20:00:54.498565) ========= script_repo_revision: 6b063631a7d3ffd5dc2b621852e4d8ac8758ef99 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 20:00:54.499151) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 20:00:54.499455) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 20:00:54.537089) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-09 20:00:54.537418) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rMAtioew4e/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.l2kopoFxMS/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 20:00:54 INFO - MultiFileLogger online at 20170209 20:00:54 in /builds/slave/test 20:00:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 20:00:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:00:54 INFO - {'append_to_log': False, 20:00:54 INFO - 'base_work_dir': '/builds/slave/test', 20:00:54 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 20:00:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:00:54 INFO - 'branch': 'Mozilla-Aurora', 20:00:54 INFO - 'buildbot_json_path': 'buildprops.json', 20:00:54 INFO - 'config_files': ('talos/mac_config.py',), 20:00:54 INFO - 'default_actions': ('clobber', 20:00:54 INFO - 'read-buildbot-config', 20:00:54 INFO - 'download-and-extract', 20:00:54 INFO - 'populate-webroot', 20:00:54 INFO - 'create-virtualenv', 20:00:54 INFO - 'install', 20:00:54 INFO - 'run-tests'), 20:00:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:00:54 INFO - 'download_minidump_stackwalk': True, 20:00:54 INFO - 'download_symbols': 'ondemand', 20:00:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:00:54 INFO - 'tooltool.py': '/tools/tooltool.py', 20:00:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:00:54 INFO - '/tools/misc-python/virtualenv.py')}, 20:00:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:00:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:00:54 INFO - 'installer_path': 'installer.exe', 20:00:54 INFO - 'log_level': 'info', 20:00:54 INFO - 'log_name': 'talos', 20:00:54 INFO - 'log_to_console': True, 20:00:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:00:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:00:54 INFO - 'opt_config_files': (), 20:00:54 INFO - 'pip_index': False, 20:00:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:00:54 INFO - 'cmd': ('bash', 20:00:54 INFO - '-c', 20:00:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:00:54 INFO - 'enabled': True, 20:00:54 INFO - 'halt_on_failure': False, 20:00:54 INFO - 'name': 'check_screen_resolution'},), 20:00:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:00:54 INFO - 'cmd': ('bash', 20:00:54 INFO - '-c', 20:00:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:00:54 INFO - 'enabled': True, 20:00:54 INFO - 'halt_on_failure': False, 20:00:54 INFO - 'name': 'check_screen_resolution'},), 20:00:54 INFO - 'run_cmd_checks_enabled': True, 20:00:54 INFO - 'sps_profile': False, 20:00:54 INFO - 'sps_profile_interval': 0, 20:00:54 INFO - 'suite': 'dromaeojs-e10s', 20:00:54 INFO - 'system_bits': '32', 20:00:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:00:54 INFO - 'title': 't-yosemite-r7-0088', 20:00:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:00:54 INFO - 'use_talos_json': True, 20:00:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:00:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:00:54 INFO - 'work_dir': 'build'} 20:00:54 INFO - [mozharness: 2017-02-10 04:00:54.751081Z] Running clobber step. 20:00:54 INFO - Running pre-action listener: _resource_record_pre_action 20:00:54 INFO - Running main action method: clobber 20:00:54 INFO - rmtree: /builds/slave/test/build 20:00:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:00:56 INFO - Running post-action listener: _resource_record_post_action 20:00:56 INFO - [mozharness: 2017-02-10 04:00:56.854304Z] Finished clobber step (success) 20:00:56 INFO - [mozharness: 2017-02-10 04:00:56.854447Z] Running read-buildbot-config step. 20:00:56 INFO - Running pre-action listener: _resource_record_pre_action 20:00:56 INFO - Running main action method: read_buildbot_config 20:00:56 INFO - Using buildbot properties: 20:00:56 INFO - { 20:00:56 INFO - "project": "", 20:00:56 INFO - "product": "firefox", 20:00:56 INFO - "script_repo_revision": "production", 20:00:56 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 20:00:56 INFO - "repository": "", 20:00:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 20:00:56 INFO - "buildid": "20170209185011", 20:00:56 INFO - "pgo_build": "False", 20:00:56 INFO - "basedir": "/builds/slave/test", 20:00:56 INFO - "buildnumber": 81, 20:00:56 INFO - "slavename": "t-yosemite-r7-0088", 20:00:56 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 20:00:56 INFO - "platform": "yosemite_r7", 20:00:56 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 20:00:56 INFO - "branch": "mozilla-aurora", 20:00:56 INFO - "repo_path": "releases/mozilla-aurora", 20:00:56 INFO - "revision": "6b063631a7d3ffd5dc2b621852e4d8ac8758ef99", 20:00:56 INFO - "stage_platform": "macosx64", 20:00:56 INFO - "builduid": "4f89dbd8b6f2442480533108b73d9097", 20:00:56 INFO - "slavebuilddir": "test" 20:00:56 INFO - } 20:00:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 20:00:56 INFO - Running post-action listener: _resource_record_post_action 20:00:56 INFO - [mozharness: 2017-02-10 04:00:56.857863Z] Finished read-buildbot-config step (success) 20:00:56 INFO - [mozharness: 2017-02-10 04:00:56.857978Z] Running download-and-extract step. 20:00:56 INFO - Running pre-action listener: _resource_record_pre_action 20:00:56 INFO - Running main action method: download_and_extract 20:00:56 INFO - mkdir: /builds/slave/test/build/tests 20:00:56 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')]} 20:00:56 INFO - trying https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 20:00:56 INFO - Downloading https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 20:00:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 20:00:58 INFO - Downloaded 1199 bytes. 20:00:58 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 20:00:58 INFO - Using the following test package requirements: 20:00:58 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 20:00:58 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:00:58 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 20:00:58 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:00:58 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 20:00:58 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:00:58 INFO - u'jsshell-mac.zip'], 20:00:58 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:00:58 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 20:00:58 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 20:00:58 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:00:58 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 20:00:58 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:00:58 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 20:00:58 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:00:58 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 20:00:58 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:00:58 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 20:00:58 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 20:00:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 20:00:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 20:00:58 INFO - Fetch https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 20:00:59 INFO - Expected file size: 16357895 20:00:59 INFO - Obtained file size: 16357895 20:01:05 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 20:01:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 20:01:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 20:01:05 INFO - Fetch https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 20:01:06 INFO - Expected file size: 16357895 20:01:06 INFO - Obtained file size: 16357895 20:01:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 20:01:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 20:01:13 INFO - Fetch https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 20:01:13 INFO - Expected file size: 14403485 20:01:13 INFO - Obtained file size: 14403485 20:01:14 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')]} 20:01:14 INFO - trying https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 20:01:14 INFO - Downloading https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 20:01:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 20:01:16 INFO - Downloaded 73823279 bytes. 20:01:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 20:01:16 INFO - mkdir: /builds/slave/test/properties 20:01:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:01:16 INFO - Writing to file /builds/slave/test/properties/build_url 20:01:16 INFO - Contents: 20:01:16 INFO - build_url:https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 20:01:17 INFO - Running post-action listener: _resource_record_post_action 20:01:17 INFO - Running post-action listener: set_extra_try_arguments 20:01:17 INFO - [mozharness: 2017-02-10 04:01:17.009209Z] Finished download-and-extract step (success) 20:01:17 INFO - [mozharness: 2017-02-10 04:01:17.009341Z] Running populate-webroot step. 20:01:17 INFO - Running pre-action listener: _resource_record_pre_action 20:01:17 INFO - Running main action method: populate_webroot 20:01:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:01:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:01:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:01:17 INFO - '--tppagecycles', 20:01:17 INFO - '7'], 20:01:17 INFO - 'tests': ['tsvgm']}}, 20:01:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:01:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:01:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:01:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:01:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:01:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:01:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:01:17 INFO - 'talos_options': ['--disable-e10s'], 20:01:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:01:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:01:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:01:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:01:17 INFO - 'talos_options': ['--disable-e10s'], 20:01:17 INFO - 'tests': ['damp', 'tps']}, 20:01:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:01:17 INFO - 'tests': ['damp', 'tps']}, 20:01:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:01:17 INFO - 'tests': ['dromaeo_dom']}, 20:01:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:01:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:01:17 INFO - 'tests': ['basic_compositor_video']}, 20:01:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:01:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:01:17 INFO - 'tests': ['a11yr', 20:01:17 INFO - 'ts_paint', 20:01:17 INFO - 'tpaint', 20:01:17 INFO - 'sessionrestore', 20:01:17 INFO - 'sessionrestore_no_auto_restore', 20:01:17 INFO - 'tabpaint']}, 20:01:17 INFO - 'other-e10s': {'tests': ['a11yr', 20:01:17 INFO - 'ts_paint', 20:01:17 INFO - 'tpaint', 20:01:17 INFO - 'sessionrestore', 20:01:17 INFO - 'sessionrestore_no_auto_restore', 20:01:17 INFO - 'tabpaint']}, 20:01:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:01:17 INFO - 'ts_paint', 20:01:17 INFO - 'tpaint', 20:01:17 INFO - 'sessionrestore', 20:01:17 INFO - 'sessionrestore_no_auto_restore', 20:01:17 INFO - 'tabpaint']}, 20:01:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:01:17 INFO - 'ts_paint', 20:01:17 INFO - 'tpaint', 20:01:17 INFO - 'sessionrestore', 20:01:17 INFO - 'sessionrestore_no_auto_restore', 20:01:17 INFO - 'tabpaint']}, 20:01:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:01:17 INFO - 'tests': ['a11yr', 20:01:17 INFO - 'ts_paint', 20:01:17 INFO - 'tpaint', 20:01:17 INFO - 'sessionrestore', 20:01:17 INFO - 'sessionrestore_no_auto_restore', 20:01:17 INFO - 'tabpaint']}, 20:01:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:01:17 INFO - 'tests': ['a11yr', 20:01:17 INFO - 'ts_paint', 20:01:17 INFO - 'tpaint', 20:01:17 INFO - 'sessionrestore', 20:01:17 INFO - 'sessionrestore_no_auto_restore', 20:01:17 INFO - 'tabpaint']}, 20:01:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:01:17 INFO - 'tests': ['tsvgx', 20:01:17 INFO - 'tsvgr_opacity', 20:01:17 INFO - 'tart', 20:01:17 INFO - 'tscrollx', 20:01:17 INFO - 'cart', 20:01:17 INFO - 'tsvg_static']}, 20:01:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:01:17 INFO - 'tsvgr_opacity', 20:01:17 INFO - 'tart', 20:01:17 INFO - 'tscrollx', 20:01:17 INFO - 'cart', 20:01:17 INFO - 'tsvg_static']}, 20:01:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:01:17 INFO - 'talos_options': ['--disable-e10s'], 20:01:17 INFO - 'tests': ['tp5o']}, 20:01:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:01:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:01:17 INFO - 'talos_options': ['--disable-e10s', 20:01:17 INFO - '--xperf_path', 20:01:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:01:17 INFO - 'tests': ['tp5n']}, 20:01:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:01:17 INFO - 'talos_options': ['--xperf_path', 20:01:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:01:17 INFO - 'tests': ['tp5n']}}, 20:01:17 INFO - 'talos.zip': {'path': '', 20:01:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:01:17 INFO - Running post-action listener: _resource_record_post_action 20:01:17 INFO - [mozharness: 2017-02-10 04:01:17.028100Z] Finished populate-webroot step (success) 20:01:17 INFO - [mozharness: 2017-02-10 04:01:17.028211Z] Running create-virtualenv step. 20:01:17 INFO - Running pre-action listener: _resource_record_pre_action 20:01:17 INFO - Running main action method: create_virtualenv 20:01:17 INFO - Creating virtualenv /builds/slave/test/build/venv 20:01:17 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 20:01:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:01:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:01:17 INFO - Using real prefix '/tools/python27' 20:01:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:01:17 INFO - Installing distribute.............................................................................................................................................................................................done. 20:01:20 INFO - Installing pip.................done. 20:01:20 INFO - Return code: 0 20:01:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:01:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:01:20 INFO - Reading from file tmpfile_stdout 20:01:20 INFO - Output received: 20:01:20 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) 20:01:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:01:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:01:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:20 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 0x101b30b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b33768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8598ce8920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10190ed30>, '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 0x101835db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101903be8>, '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.rMAtioew4e/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.l2kopoFxMS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 20:01:20 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 20:01:20 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 20:01:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rMAtioew4e/Render', 20:01:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:01:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:01:20 INFO - 'HOME': '/Users/cltbld', 20:01:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:01:20 INFO - 'LOGNAME': 'cltbld', 20:01:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:20 INFO - 'MOZ_NO_REMOTE': '1', 20:01:20 INFO - 'NO_EM_RESTART': '1', 20:01:20 INFO - 'PAGER': '/bin/cat', 20:01:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:01:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:20 INFO - 'PWD': '/builds/slave/test', 20:01:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:01:20 INFO - 'SHELL': '/bin/bash', 20:01:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l2kopoFxMS/Listeners', 20:01:20 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 20:01:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:01:20 INFO - 'USER': 'cltbld', 20:01:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:01:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:01:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:20 INFO - 'XPC_FLAGS': '0x0', 20:01:20 INFO - 'XPC_SERVICE_NAME': '0', 20:01:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:01:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:21 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 20:01:21 INFO - Cleaning up... 20:01:21 INFO - Return code: 0 20:01:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:01:21 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')]} 20:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:21 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')]} 20:01:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:21 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 0x101b30b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b33768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8598ce8920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10190ed30>, '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 0x101835db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101903be8>, '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.rMAtioew4e/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.l2kopoFxMS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 20:01:21 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 20:01:21 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 20:01:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rMAtioew4e/Render', 20:01:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:01:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:01:21 INFO - 'HOME': '/Users/cltbld', 20:01:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:01:21 INFO - 'LOGNAME': 'cltbld', 20:01:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:21 INFO - 'MOZ_NO_REMOTE': '1', 20:01:21 INFO - 'NO_EM_RESTART': '1', 20:01:21 INFO - 'PAGER': '/bin/cat', 20:01:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:01:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:21 INFO - 'PWD': '/builds/slave/test', 20:01:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:01:21 INFO - 'SHELL': '/bin/bash', 20:01:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l2kopoFxMS/Listeners', 20:01:21 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 20:01:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:01:21 INFO - 'USER': 'cltbld', 20:01:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:01:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:01:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:21 INFO - 'XPC_FLAGS': '0x0', 20:01:21 INFO - 'XPC_SERVICE_NAME': '0', 20:01:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:01:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:21 INFO - Downloading/unpacking psutil>=3.1.1 20:01:21 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 20:01:21 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 20:01:21 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 20:01:21 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 20:01:21 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 20:01:21 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 20:01:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:01:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:01:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:01:25 INFO - Installing collected packages: psutil 20:01:25 INFO - Running setup.py install for psutil 20:01:25 INFO - building 'psutil._psutil_osx' extension 20:01:25 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 20:01:25 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 20:01:25 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 20:01:25 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 20:01:25 INFO - building 'psutil._psutil_posix' extension 20:01:25 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 20:01:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:01:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:01:25 INFO - ^ 20:01:25 INFO - 1 warning generated. 20:01:25 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 20:01:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:01:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:01:25 INFO - Successfully installed psutil 20:01:25 INFO - Cleaning up... 20:01:25 INFO - Return code: 0 20:01:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:01:25 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')]} 20:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:01:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101b30b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b33768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8598ce8920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10190ed30>, '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 0x101835db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101903be8>, '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.rMAtioew4e/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.l2kopoFxMS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 20:01:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:01:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:01:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rMAtioew4e/Render', 20:01:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:01:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:01:26 INFO - 'HOME': '/Users/cltbld', 20:01:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:01:26 INFO - 'LOGNAME': 'cltbld', 20:01:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:26 INFO - 'MOZ_NO_REMOTE': '1', 20:01:26 INFO - 'NO_EM_RESTART': '1', 20:01:26 INFO - 'PAGER': '/bin/cat', 20:01:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:01:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:26 INFO - 'PWD': '/builds/slave/test', 20:01:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:01:26 INFO - 'SHELL': '/bin/bash', 20:01:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l2kopoFxMS/Listeners', 20:01:26 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 20:01:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:01:26 INFO - 'USER': 'cltbld', 20:01:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:01:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:01:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:26 INFO - 'XPC_FLAGS': '0x0', 20:01:26 INFO - 'XPC_SERVICE_NAME': '0', 20:01:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:01:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:01:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:01:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:01:30 INFO - Installing collected packages: mozsystemmonitor 20:01:30 INFO - Running setup.py install for mozsystemmonitor 20:01:30 INFO - Successfully installed mozsystemmonitor 20:01:30 INFO - Cleaning up... 20:01:30 INFO - Return code: 0 20:01:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:01:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:01:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101b30b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b33768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8598ce8920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10190ed30>, '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 0x101835db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101903be8>, '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.rMAtioew4e/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.l2kopoFxMS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 20:01:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:01:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:01:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rMAtioew4e/Render', 20:01:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:01:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:01:30 INFO - 'HOME': '/Users/cltbld', 20:01:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:01:30 INFO - 'LOGNAME': 'cltbld', 20:01:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:30 INFO - 'MOZ_NO_REMOTE': '1', 20:01:30 INFO - 'NO_EM_RESTART': '1', 20:01:30 INFO - 'PAGER': '/bin/cat', 20:01:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:01:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:30 INFO - 'PWD': '/builds/slave/test', 20:01:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:01:30 INFO - 'SHELL': '/bin/bash', 20:01:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l2kopoFxMS/Listeners', 20:01:30 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 20:01:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:01:30 INFO - 'USER': 'cltbld', 20:01:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:01:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:01:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:30 INFO - 'XPC_FLAGS': '0x0', 20:01:30 INFO - 'XPC_SERVICE_NAME': '0', 20:01:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:01:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:30 INFO - Downloading/unpacking jsonschema==2.5.1 20:01:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:01:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:01:33 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 20:01:33 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 20:01:33 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 20:01:33 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 20:01:33 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 20:01:33 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 20:01:33 INFO - Downloading functools32-3.2.3-2.tar.gz 20:01:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:01:33 INFO - warning: no files found matching '*.txt' 20:01:33 INFO - no previously-included directories found matching 'build' 20:01:33 INFO - no previously-included directories found matching 'dist' 20:01:33 INFO - no previously-included directories found matching '.git*' 20:01:33 INFO - Installing collected packages: jsonschema, functools32 20:01:33 INFO - Running setup.py install for functools32 20:01:33 INFO - warning: no files found matching '*.txt' 20:01:33 INFO - no previously-included directories found matching 'build' 20:01:33 INFO - no previously-included directories found matching 'dist' 20:01:33 INFO - no previously-included directories found matching '.git*' 20:01:33 INFO - Successfully installed jsonschema functools32 20:01:33 INFO - Cleaning up... 20:01:34 INFO - Return code: 0 20:01:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:01:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:01:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:01:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101b30b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b33768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8598ce8920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10190ed30>, '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 0x101835db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101903be8>, '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.rMAtioew4e/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.l2kopoFxMS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 20:01:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:01:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:01:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rMAtioew4e/Render', 20:01:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:01:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:01:34 INFO - 'HOME': '/Users/cltbld', 20:01:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:01:34 INFO - 'LOGNAME': 'cltbld', 20:01:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:34 INFO - 'MOZ_NO_REMOTE': '1', 20:01:34 INFO - 'NO_EM_RESTART': '1', 20:01:34 INFO - 'PAGER': '/bin/cat', 20:01:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:01:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:34 INFO - 'PWD': '/builds/slave/test', 20:01:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:01:34 INFO - 'SHELL': '/bin/bash', 20:01:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l2kopoFxMS/Listeners', 20:01:34 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 20:01:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:01:34 INFO - 'USER': 'cltbld', 20:01:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:01:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:01:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:34 INFO - 'XPC_FLAGS': '0x0', 20:01:34 INFO - 'XPC_SERVICE_NAME': '0', 20:01:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:01:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:01:34 INFO - Cleaning up... 20:01:34 INFO - Return code: 0 20:01:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:01:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:01:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:01:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101b30b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b33768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8598ce8920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10190ed30>, '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 0x101835db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101903be8>, '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.rMAtioew4e/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.l2kopoFxMS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 20:01:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:01:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:01:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rMAtioew4e/Render', 20:01:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:01:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:01:34 INFO - 'HOME': '/Users/cltbld', 20:01:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:01:34 INFO - 'LOGNAME': 'cltbld', 20:01:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:34 INFO - 'MOZ_NO_REMOTE': '1', 20:01:34 INFO - 'NO_EM_RESTART': '1', 20:01:34 INFO - 'PAGER': '/bin/cat', 20:01:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:01:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:34 INFO - 'PWD': '/builds/slave/test', 20:01:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:01:34 INFO - 'SHELL': '/bin/bash', 20:01:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l2kopoFxMS/Listeners', 20:01:34 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 20:01:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:01:34 INFO - 'USER': 'cltbld', 20:01:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:01:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:01:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:34 INFO - 'XPC_FLAGS': '0x0', 20:01:34 INFO - 'XPC_SERVICE_NAME': '0', 20:01:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:01:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:34 INFO - Downloading/unpacking blobuploader==1.2.4 20:01:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:37 INFO - Downloading blobuploader-1.2.4.tar.gz 20:01:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:01:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:01:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:01:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:01:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:38 INFO - Downloading docopt-0.6.1.tar.gz 20:01:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:01:38 INFO - Installing collected packages: blobuploader, requests, docopt 20:01:38 INFO - Running setup.py install for blobuploader 20:01:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:01:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:01:38 INFO - Running setup.py install for requests 20:01:39 INFO - Running setup.py install for docopt 20:01:39 INFO - Successfully installed blobuploader requests docopt 20:01:39 INFO - Cleaning up... 20:01:39 INFO - Return code: 0 20:01:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:01:39 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')]} 20:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:39 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')]} 20:01:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:39 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 0x101b30b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b33768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8598ce8920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10190ed30>, '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 0x101835db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101903be8>, '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.rMAtioew4e/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.l2kopoFxMS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 20:01:39 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 20:01:39 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 20:01:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rMAtioew4e/Render', 20:01:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:01:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:01:39 INFO - 'HOME': '/Users/cltbld', 20:01:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:01:39 INFO - 'LOGNAME': 'cltbld', 20:01:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:39 INFO - 'MOZ_NO_REMOTE': '1', 20:01:39 INFO - 'NO_EM_RESTART': '1', 20:01:39 INFO - 'PAGER': '/bin/cat', 20:01:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:01:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:39 INFO - 'PWD': '/builds/slave/test', 20:01:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:01:39 INFO - 'SHELL': '/bin/bash', 20:01:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l2kopoFxMS/Listeners', 20:01:39 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 20:01:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:01:39 INFO - 'USER': 'cltbld', 20:01:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:01:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:01:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:39 INFO - 'XPC_FLAGS': '0x0', 20:01:39 INFO - 'XPC_SERVICE_NAME': '0', 20:01:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:01:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:01:39 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-1VhN5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:01:39 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-n50N_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:01:39 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-v4xRNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:01:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:01:39 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-MoKgBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:01:40 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-G8kO5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:01:40 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-Gin7pZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:01:40 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-_ADwU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:01:40 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-XT3KVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:01:40 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-bmp544-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:01:40 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-5xQ6Sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:01:40 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-p8dRhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:01:40 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-YHeo18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:01:40 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-x5MnPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:01:40 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-5EhbZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:01:41 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-MqdONk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:01:41 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-etJQdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:01:41 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-Awz8fA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:01:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:01:41 INFO - Running setup.py install for manifestparser 20:01:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:01:41 INFO - Running setup.py install for mozcrash 20:01:41 INFO - Running setup.py install for mozdebug 20:01:41 INFO - Running setup.py install for mozdevice 20:01:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:01:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:01:41 INFO - Running setup.py install for mozfile 20:01:42 INFO - Running setup.py install for mozhttpd 20:01:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:01:42 INFO - Running setup.py install for mozinfo 20:01:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:01:42 INFO - Running setup.py install for mozInstall 20:01:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:01:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:01:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:01:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:01:42 INFO - Running setup.py install for mozleak 20:01:42 INFO - Running setup.py install for mozlog 20:01:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:01:42 INFO - Running setup.py install for moznetwork 20:01:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:01:43 INFO - Running setup.py install for mozprocess 20:01:43 INFO - Running setup.py install for mozprofile 20:01:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:01:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:01:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:01:43 INFO - Running setup.py install for mozrunner 20:01:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:01:43 INFO - Running setup.py install for mozscreenshot 20:01:43 INFO - Running setup.py install for moztest 20:01:43 INFO - Running setup.py install for mozversion 20:01:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:01:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:01:43 INFO - Cleaning up... 20:01:43 INFO - Return code: 0 20:01:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:01:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:43 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 0x101b30b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b33768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8598ce8920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10190ed30>, '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 0x101835db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101903be8>, '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.rMAtioew4e/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.l2kopoFxMS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 20:01:43 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 20:01:43 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 20:01:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rMAtioew4e/Render', 20:01:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:01:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:01:43 INFO - 'HOME': '/Users/cltbld', 20:01:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:01:43 INFO - 'LOGNAME': 'cltbld', 20:01:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:43 INFO - 'MOZ_NO_REMOTE': '1', 20:01:43 INFO - 'NO_EM_RESTART': '1', 20:01:43 INFO - 'PAGER': '/bin/cat', 20:01:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:01:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:43 INFO - 'PWD': '/builds/slave/test', 20:01:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:01:43 INFO - 'SHELL': '/bin/bash', 20:01:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l2kopoFxMS/Listeners', 20:01:43 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 20:01:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:01:43 INFO - 'USER': 'cltbld', 20:01:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:01:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:01:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:43 INFO - 'XPC_FLAGS': '0x0', 20:01:43 INFO - 'XPC_SERVICE_NAME': '0', 20:01:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:01:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:01:44 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-FiB1oG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:01:44 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)) 20:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:01:44 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-KbJ_iD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:01:44 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)) 20:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:01:44 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-6iD5s9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:01:44 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)) 20:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:01:44 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-dljvrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:01:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:01:44 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-JcQEv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:01:44 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)) 20:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:01:44 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-pyCjvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:01:44 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)) 20:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:01:44 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-ecivvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:01:44 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)) 20:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:01:44 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-vRtTEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:01:45 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)) 20:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:01:45 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-ojast1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:01:45 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)) 20:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:01:45 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-WQMwlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:01:45 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)) 20:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:01:45 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-hTDqpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:01:45 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)) 20:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:01:45 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-cWrs95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:01:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 20:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:01:45 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-ofmLgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:01:45 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)) 20:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:01:45 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-AK29dz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:01:45 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)) 20:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:01:45 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-og_aJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:01:45 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)) 20:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:01:45 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-cEywr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:01:45 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)) 20:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:01:45 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-fm6Hr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:01:46 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)) 20:01:46 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)) 20:01:46 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)) 20:01:46 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)) 20:01:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:01:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:01:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:01:46 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 20:01:46 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 20:01:46 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 20:01:46 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 20:01:46 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 20:01:46 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 20:01:48 INFO - Downloading blessings-1.6.tar.gz 20:01:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:01:48 INFO - Installing collected packages: blessings 20:01:48 INFO - Running setup.py install for blessings 20:01:48 INFO - Successfully installed blessings 20:01:48 INFO - Cleaning up... 20:01:49 INFO - Return code: 0 20:01:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:01:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:01:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:01:49 INFO - Reading from file tmpfile_stdout 20:01:49 INFO - Current package versions: 20:01:49 INFO - blessings == 1.6 20:01:49 INFO - blobuploader == 1.2.4 20:01:49 INFO - docopt == 0.6.1 20:01:49 INFO - functools32 == 3.2.3-2 20:01:49 INFO - jsonschema == 2.5.1 20:01:49 INFO - manifestparser == 1.1 20:01:49 INFO - mozInstall == 1.12 20:01:49 INFO - mozcrash == 1.0 20:01:49 INFO - mozdebug == 0.1 20:01:49 INFO - mozdevice == 0.49 20:01:49 INFO - mozfile == 1.2 20:01:49 INFO - mozhttpd == 0.7 20:01:49 INFO - mozinfo == 0.9 20:01:49 INFO - mozleak == 0.1 20:01:49 INFO - mozlog == 3.4 20:01:49 INFO - moznetwork == 0.27 20:01:49 INFO - mozprocess == 0.24 20:01:49 INFO - mozprofile == 0.28 20:01:49 INFO - mozrunner == 6.13 20:01:49 INFO - mozscreenshot == 0.1 20:01:49 INFO - mozsystemmonitor == 0.3 20:01:49 INFO - moztest == 0.8 20:01:49 INFO - mozversion == 1.4 20:01:49 INFO - psutil == 3.1.1 20:01:49 INFO - requests == 1.2.3 20:01:49 INFO - wsgiref == 0.1.2 20:01:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:01: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')]} 20:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01: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')]} 20:01:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:49 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 0x101b30b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b33768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8598ce8920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10190ed30>, '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 0x101835db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101903be8>, '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.rMAtioew4e/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.l2kopoFxMS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 20:01:49 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 20:01:49 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 20:01:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rMAtioew4e/Render', 20:01:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:01:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:01:49 INFO - 'HOME': '/Users/cltbld', 20:01:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:01:49 INFO - 'LOGNAME': 'cltbld', 20:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:49 INFO - 'MOZ_NO_REMOTE': '1', 20:01:49 INFO - 'NO_EM_RESTART': '1', 20:01:49 INFO - 'PAGER': '/bin/cat', 20:01:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:49 INFO - 'PWD': '/builds/slave/test', 20:01:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:01:49 INFO - 'SHELL': '/bin/bash', 20:01:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l2kopoFxMS/Listeners', 20:01:49 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 20:01:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:01:49 INFO - 'USER': 'cltbld', 20:01:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:01:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:49 INFO - 'XPC_FLAGS': '0x0', 20:01:49 INFO - 'XPC_SERVICE_NAME': '0', 20:01:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:01:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:49 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)) 20:01:49 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)) 20:01:49 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)) 20:01:49 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)) 20:01:49 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)) 20:01:49 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)) 20:01:49 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)) 20:01:49 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)) 20:01:49 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)) 20:01:49 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)) 20:01:49 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)) 20:01:49 INFO - Cleaning up... 20:01:49 INFO - Return code: 0 20:01:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:01: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')]} 20:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01: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')]} 20:01:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101b30b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b33768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8598ce8920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10190ed30>, '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 0x101835db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101903be8>, '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.rMAtioew4e/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.l2kopoFxMS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 20:01: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', 'jsonschema'] in /builds/slave/test/build 20:01: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 jsonschema 20:01:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rMAtioew4e/Render', 20:01:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:01:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:01:49 INFO - 'HOME': '/Users/cltbld', 20:01:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:01:49 INFO - 'LOGNAME': 'cltbld', 20:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:49 INFO - 'MOZ_NO_REMOTE': '1', 20:01:49 INFO - 'NO_EM_RESTART': '1', 20:01:49 INFO - 'PAGER': '/bin/cat', 20:01:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:01:49 INFO - 'PWD': '/builds/slave/test', 20:01:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:01:49 INFO - 'SHELL': '/bin/bash', 20:01:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l2kopoFxMS/Listeners', 20:01:49 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 20:01:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:01:49 INFO - 'USER': 'cltbld', 20:01:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:01:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:49 INFO - 'XPC_FLAGS': '0x0', 20:01:49 INFO - 'XPC_SERVICE_NAME': '0', 20:01:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:01:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:01:49 INFO - Cleaning up... 20:01:49 INFO - Return code: 0 20:01:49 INFO - Running post-action listener: _resource_record_post_action 20:01:49 INFO - Running post-action listener: _start_resource_monitoring 20:01:49 INFO - Starting resource monitoring. 20:01:49 INFO - [mozharness: 2017-02-10 04:01:49.951001Z] Finished create-virtualenv step (success) 20:01:49 INFO - [mozharness: 2017-02-10 04:01:49.951976Z] Running install step. 20:01:49 INFO - Running pre-action listener: _resource_record_pre_action 20:01:49 INFO - Running main action method: install 20:01:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:01:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:01:50 INFO - Reading from file tmpfile_stdout 20:01:50 INFO - Detecting whether we're running mozinstall >=1.0... 20:01:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:01:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:01:50 INFO - Reading from file tmpfile_stdout 20:01:50 INFO - Output received: 20:01:50 INFO - Usage: mozinstall [options] installer 20:01:50 INFO - Options: 20:01:50 INFO - -h, --help show this help message and exit 20:01:50 INFO - -d DEST, --destination=DEST 20:01:50 INFO - Directory to install application into. [default: 20:01:50 INFO - "/builds/slave/test"] 20:01:50 INFO - --app=APP Application being installed. [default: firefox] 20:01:50 INFO - mkdir: /builds/slave/test/build/application 20:01:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 20:01:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 20:02:10 INFO - Reading from file tmpfile_stdout 20:02:10 INFO - Output received: 20:02:10 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 20:02:10 INFO - Running post-action listener: _resource_record_post_action 20:02:10 INFO - [mozharness: 2017-02-10 04:02:10.172832Z] Finished install step (success) 20:02:10 INFO - [mozharness: 2017-02-10 04:02:10.173000Z] Running run-tests step. 20:02:10 INFO - Running pre-action listener: _resource_record_pre_action 20:02:10 INFO - Running main action method: run_tests 20:02:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:02:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:02:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:02:10 INFO - 2017-02-09 20:02:10.187 screenresolution[2153:22203] starting screenresolution argv=screenresolution get 20:02:10 INFO - 2017-02-09 20:02:10.190 screenresolution[2153:22203] Display 0: 1600x1200x32@60 20:02:10 INFO - 2017-02-09 20:02:10.196 screenresolution[2154:22206] starting screenresolution argv=screenresolution list 20:02:10 INFO - Available Modes on Display 0 20:02:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:02:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:02:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:02:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:02:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:02:10 INFO - Intel Iris: 20:02:10 INFO - Chipset Model: Intel Iris 20:02:10 INFO - Type: GPU 20:02:10 INFO - Bus: Built-In 20:02:10 INFO - VRAM (Dynamic, Max): 1536 MB 20:02:10 INFO - Vendor: Intel (0x8086) 20:02:10 INFO - Device ID: 0x0a2e 20:02:10 INFO - Revision ID: 0x0009 20:02:10 INFO - Displays: 20:02:10 INFO - Display: 20:02:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:02:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:02:10 INFO - Display Serial Number: 1600x1200 60 20:02:10 INFO - Main Display: Yes 20:02:10 INFO - Mirror: Off 20:02:10 INFO - Online: Yes 20:02:10 INFO - Rotation: Supported 20:02:10 INFO - Return code: 0 20:02:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:02:10 INFO - Python 2.7.3 20:02:10 INFO - Return code: 0 20:02:10 INFO - grabbing minidump binary from tooltool 20:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:02:10 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 0x10190ed30>, '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 0x101835db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101903be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:02:10 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 20:02:10 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 20:02:10 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 20:02:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:02:10 INFO - Return code: 0 20:02:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:02:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:02:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:02:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:02:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:02:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0088', '--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 20:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0088 --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 20:02:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rMAtioew4e/Render', 20:02:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:02:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:02:10 INFO - 'HOME': '/Users/cltbld', 20:02:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:02:10 INFO - 'LOGNAME': 'cltbld', 20:02:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:02:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:02:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:10 INFO - 'MOZ_NO_REMOTE': '1', 20:02:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:02:10 INFO - 'NO_EM_RESTART': '1', 20:02:10 INFO - 'PAGER': '/bin/cat', 20:02:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:02:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:10 INFO - 'PWD': '/builds/slave/test', 20:02:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:02:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:02:10 INFO - 'SHELL': '/bin/bash', 20:02:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l2kopoFxMS/Listeners', 20:02:10 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 20:02:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:02:10 INFO - 'USER': 'cltbld', 20:02:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:02:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:02:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:10 INFO - 'XPC_FLAGS': '0x0', 20:02:10 INFO - 'XPC_SERVICE_NAME': '0', 20:02:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:02:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0088', '--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 20:02:10 INFO - mozversion application_buildid: 20170209185011 20:02:10 INFO - mozversion application_changeset: 6b063631a7d3ffd5dc2b621852e4d8ac8758ef99 20:02:10 INFO - mozversion application_display_name: FirefoxDeveloperEdition 20:02:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:02:10 INFO - mozversion application_name: Firefox 20:02:10 INFO - mozversion application_remotingname: firefox-dev 20:02:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:02:10 INFO - mozversion application_vendor: Mozilla 20:02:10 INFO - mozversion application_version: 53.0a2 20:02:10 INFO - mozversion platform_buildid: 20170209185011 20:02:10 INFO - mozversion platform_changeset: 6b063631a7d3ffd5dc2b621852e4d8ac8758ef99 20:02:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:02:10 INFO - mozversion platform_version: 53.0a2 20:02:10 INFO - using testdate: 1486699330 20:02:10 INFO - actual date: 1486699330 20:02:10 INFO - starting webserver on 'localhost:57071' 20:02:10 INFO - SUITE-START | Running 2 tests 20:02:10 INFO - TEST-START | dromaeo_css 20:02:10 INFO - operating with platform_type : mac_ 20:02:10 INFO - Initialising browser for dromaeo_css test... 20:02:10 INFO - TEST-INFO | started process 2164 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmp0GaE2u/profile http://localhost:57071/getInfo.html) 20:02:13 INFO - PROCESS | 2164 | 2017-02-09 20:02:13.536 plugin-container[2166:22379] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3f, name = 'com.apple.tsm.portname' 20:02:13 INFO - PROCESS | 2164 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:02:13 INFO - PROCESS | 2164 | 2017-02-09 20:02:13.539 plugin-container[2166:22379] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910f, name = 'com.apple.CFPasteboardClient' 20:02:13 INFO - PROCESS | 2164 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:02:13 INFO - PROCESS | 2164 | 2017-02-09 20:02:13.539 plugin-container[2166:22379] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:02:13 INFO - PROCESS | 2164 | __metrics Screen width/height:1600/1200 20:02:13 INFO - PROCESS | 2164 | colorDepth:24 20:02:13 INFO - PROCESS | 2164 | Browser inner width/height: 1024/689 20:02:13 INFO - PROCESS | 2164 | __metrics 20:02:13 ERROR - PROCESS | 2164 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 20:02:14 INFO - TEST-INFO | 2164: exit 0 20:02:14 INFO - Browser initialized. 20:02:14 INFO - Running cycle 1/1 for dromaeo_css test... 20:02:14 INFO - TEST-INFO | started process 2167 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmp0GaE2u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:02:16 INFO - PROCESS | 2167 | 2017-02-09 20:02:16.777 plugin-container[2168:22620] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 20:02:16 INFO - PROCESS | 2167 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:02:16 INFO - PROCESS | 2167 | 2017-02-09 20:02:16.778 plugin-container[2168:22620] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4717, name = 'com.apple.CFPasteboardClient' 20:02:16 INFO - PROCESS | 2167 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:02:16 INFO - PROCESS | 2167 | 2017-02-09 20:02:16.778 plugin-container[2168:22620] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:02:26 INFO - PROCESS | 2167 | RSS: Main: 218968064 20:02:26 INFO - PROCESS | 2167 | 20:05:29 INFO - PROCESS | 2167 | Cycle 1(1): loaded http://localhost:57071/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57071/tests/dromaeo/cssquery-ext.html) 20:05:31 INFO - PROCESS | 2167 | RSS: Main: 238747648 20:05:31 INFO - PROCESS | 2167 | 20:07:14 INFO - PROCESS | 2167 | ************************* 20:07:14 INFO - PROCESS | 2167 | A coding exception was thrown and uncaught in a Task. 20:07:14 INFO - PROCESS | 2167 | 20:07:14 ERROR - PROCESS | 2167 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:07:14 INFO - PROCESS | 2167 | Full stack: 20:07:14 INFO - PROCESS | 2167 | ************************* 20:08:33 INFO - PROCESS | 2167 | Cycle 1(1): loaded http://localhost:57071/tests/dromaeo/cssquery-ext.html (next: http://localhost:57071/tests/dromaeo/cssquery-jquery.html) 20:08:34 INFO - PROCESS | 2167 | RSS: Main: 248160256 20:08:34 INFO - PROCESS | 2167 | 20:11:36 INFO - PROCESS | 2167 | Cycle 1(1): loaded http://localhost:57071/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57071/tests/dromaeo/cssquery-mootools.html) 20:11:37 INFO - PROCESS | 2167 | RSS: Main: 254164992 20:11:37 INFO - PROCESS | 2167 | 20:14:38 INFO - PROCESS | 2167 | Cycle 1(1): loaded http://localhost:57071/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57071/tests/dromaeo/cssquery-prototype.html) 20:14:39 INFO - PROCESS | 2167 | RSS: Main: 250490880 20:14:39 INFO - PROCESS | 2167 | 20:17:42 INFO - PROCESS | 2167 | Cycle 1(1): loaded http://localhost:57071/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57071/tests/dromaeo/cssquery-yui.html) 20:17:43 INFO - PROCESS | 2167 | RSS: Main: 254648320 20:17:43 INFO - PROCESS | 2167 | 20:20:45 INFO - PROCESS | 2167 | Cycle 1(1): loaded http://localhost:57071/tests/dromaeo/cssquery-yui.html (next: http://localhost:57071/tests/dromaeo/cssquery-dojo.html) 20:20:45 INFO - PROCESS | 2167 | RSS: Main: 255942656 20:20:45 INFO - PROCESS | 2167 | 20:20:45 INFO - PROCESS | 2167 | __start_tp_report 20:20:45 INFO - PROCESS | 2167 | _x_x_mozilla_page_load 20:20:45 INFO - PROCESS | 2167 | _x_x_mozilla_page_load_details 20:20:45 INFO - PROCESS | 2167 | |i|pagename|runs| 20:20:45 INFO - PROCESS | 2167 | |0;dojo.html;3412.0957946144276;3431.9999999999995;3438.1748380388713;3446.707029902458;3452.2577645806145;5781.248437703098;5806.651600903949;5827.912581311273;5853.268341457318;5856.853578660535;5785.363610002896;5844.532437405008;5857.209276747638;5878.706064696769;5890.087036509337;5276.762545685444;5304;5326.733663316838;5350.5184533391985;5355.518003379695;5377.462253774611;5385.78456861725;5393.2719082923695;5393.2719082923695;5464.6994415307145;4391.560843915615;5228.2680424740565;5231.73841307935;5356.062689029423;5364.007658583155;3760.3231418344685;5328.813491527778;5356.678599284055;5377.973110134463;5425.159100339453;5250.264962905197;5305.602079843989;5320.547753440962;5327.706976116312;5354.357477102733;5643.266375371217;5889.970550147222;5915.053591425394;5943.970280148615;6000.309964354112;6178.41305076017;6210.565260431772;6227.09707092469;6252.2809876864285;6332.873342533124;6282.87434251317;6303.243610766692;6308.621482711052;6315.400036996524;6359.682015899187;5889.5877288590245;5974.790882319141;5977.701114944235;5994.520438364921;6002;6215.502759779207;6232.532560058014;6365.649889256043;6372.522060845455;6401.8719625608155;6183.81448556544;6201.81394558164;6234.2830574483605;6263.029230469285;6281.371862813773;6332.9234030214975;6337.714802833883;6338.58799178052;6343.333949935282;6361.840953976188;5395.732002979296;6000.909986350208;6195.535334849814;6203.689815509207;6216.813495595139;6269.937300627026;6290.496760259169;6302.590331628429;6313.179286692701;6319.873602527924;5076.517730815566;5098.2352647103235;5098.643094983389;5110.718910459886;5139.897202056013;4403.14138742942;4418.359337895987;4450.087732014929;4498.595126438636;4513.052259025576;6016.759329626853;6113.266408031065;6116.174316467309;6116.8227554565365;6142.324344322121;6259.71831267594;6304.3695630437505;6319.115323854664;6326.082718005863;6330.715117819617;5785.652860828363;5849.268841394825;6035.064564992434;6048.637081775108;6083.7870674526175;5564.610477266633;5585.99452098618;5586.608937374426;5601.691906945076;5610.663360198319;6527.445167160749;6541.443977261986;6558;6569.178852643419;6573.934260657428;6149.877002460015;6159.661218632839;6225.439710425902;6251.843703907257;6325.082862984934;6490.967545162244;6503.934960650522;6523.151990241238;6541.672916354259;6542.149520562487;4867.318575399518;5079.619028572798;6144.262688477233;6293.496520278458;6297.685115744286;5987.820365389045;6193.876122477435;6235.688215589294;6296.181496405438;6320.799048180831;6129.141920131096;6142.560166306883;6164.229471316085;6215.627062376272;6250.124982502544;6102.084687296763;6131.754729810757;6134.570580059353;6155.2921414037955;6158.938410616016;5526.563093595613;5553.611247212656;6009.098635204754;6037.667928263988;6128.325884152829;5208.114620514598;5742.28221472316;6121.971262793606;6223.657698826608;6228.0969259456215;5013.623978201723;6092.573519853568;6108.5723999319625;6109.258861224707;6110.480609148094 20:20:45 INFO - PROCESS | 2167 | |1;ext.html;488.6359662051771;490.3429404597838;502.5301343244065;511.7159976213201;525.1413938211024;37157.25685486292;37595.248095038085;40296.589619363294;40331;40478.595214047884;42254;42531.36202956958;42552.57447425525;42687.35968960468;42708.786456067755;8447.915520844774;8692.304615630766;9067.773305667362;9311.022342654025;9330.486823224719;10989.450527473635;11349.886501134966;11360.829587556193;11382.544698212103;11516.251443656178;11432.37121958292;11456.31262124271;11473.655790326304;11480;11497.252678575907;10825.67522974312;11460.025897798698;11461.312321260668;11489.597864074718;11499.425028748528;11312;11402.372869492174;11422.485988130555;11427.257228280136;11427.885721142766;39828.60171398278;40152.79923600363;40284;40304.79847600743;40310.79844600787;3939.763614183158;3943.3493473577114;4055.959440405588;4056.5334986476637;4068.755874647501;29369.559456608167;29390.706092939225;29418.705812942026;29743.70256297431;30369.696303036908;2827.2366461055603;3307.570015897918;3330.150811543041;3332.3835090508333;3337.349216902705;466351;467376;469644;469904;471925.921111187;60852.69573652103;61031.38968610257;61084.69457652772;61095;61185.38814611886;51699;54029.02840343819;62650;62972.68513657494;63435;13418.597442076752;16570.917145414194;16644.750328745078;16649.750253746202;16674.166291685367;11794.29234245948;12013.339266340261;12617.684557885943;12865.742685146432;12932.030097742707;12227.633171004707;16164.353425862833;16167.625751811227;16297.348106075624;16302.836971630131;6602.735890564323;6636.236832764197;6665.533412661164;6676.933230667728;6682.665866706645;868.3053557154251;869.9734313509992;877.7849426890325;897.6633762339122;905.8686490458847;29807.85096074549;29833.552496712568;30126.69873301283;30225.395492090476;30491.847540762155;1029.34122161815;1070.2454769387564;1086.9945650271857;1099.8405231241425;1187.4715751490503;15517.689646207238;15532.92233538825;15540.45608403723;15567.922160389126;15669.921650391676;627951.860240705;630936;630998;631608;632087;59695.70152149211;59909.70045149746;60052.69973650191;60106;60425;1436.6839295355005;1442.0410427065883;1455.4251070826965;1456.8470310617656;1459.1391079263285;28555.143345699664;28619.570706439004;29107;29745.10764677063;30099.849500753233;50644;51255;51271.48728512667;51367;51376.48623513866;373306;465088;466554;466723;467014;24372.756272437047;24437.144699935416;24864.005439782206;24963.87518062398;46248.537514624426;42542;44221.55778442303;48368.5163148364;50975;52012.47987520076;40698.38952415657;41149.588504114574;42048.57951420569;42072;43341;41717.37423938704;41843.953901152716;41851.372229415974;42893.78553107214;43233.7838310819;40426.9893252671;40959.59040409558;41249.79375103105;41378.586214137475;41399.7930010348;33473.66526334705;36296.81851590725;36449.63550364569;37022.259554809294;37184.07039824026;24837.751622484266;25608.463492190527;26824.865875671276;27058.05296814602;27173.320666983484 20:20:45 INFO - PROCESS | 2167 | |2;jquery.html;364.3096332450007;392.50348309388613;392.7309792791938;402.71608515996223;422.97885105744723;14543.636409089779;16152;19895.204191832327;21121.260755873547;21184;20560.89719551404;20958.790412095874;21308.89345553274;22048;22354.776452235474;5804.216430781833;5886.735096920627;6090.66501342426;6144.938550614482;6203.069539569055;5126.7436628168625;6006.189164462807;6061.9393806062035;6084.482818960394;6094.146819445281;5195.870103247411;5942.97028514859;6062.878742425149;6124;6124.693765311739;5907.497862681677;5911.438413350725;5954.434328738763;6100;6120.540959428061;5810.983077961382;5841.123831425278;5853.385394533555;5861.677607731573;5869.1196320551835;13473.663158421117;19938.900305498526;25683.7158142094;25715.22854314355;25969.74030259692;2600.973990260111;2631.789456843448;2638.775704065157;2641.1152263991585;2868.827870327787;9855.211583073336;10328.225383096298;10391.636292729718;10542.525586348633;10589.205809564313;1625.6098536351308;1824.9087545622665;1834.9534314820073;1849.861260405475;1891.7067854482577;133322;133724;140228;142102;143774;11563.88436115645;11789.76420471603;12094.455749491293;12128.818067728991;12132.211406258564;15583.14292713889;15723.921380393254;15748;15750.527484175493;15765.527034188992;8614.741557753277;8742.21320081183;8843.585026395875;8845.159709827556;8845.611684845057;7025;8505;8569.228769410784;8651.567421628893;8714;3958.990457433336;4601.976990115028;4748.430188377417;4809.470958194595;4824.589909857701;1769.796473405549;2001.2695366191526;2049.3442098528626;2074.388055523624;2080.147139672727;844.4004756622744;1007.969760907174;1024.6106479537727;1036.6682661548232;1044.383813550009;20476.38570842877;21859.672104918438;21978;22223.77769222676;23098.53802923932;1044.681372181492;1057.9418132002659;1063.8829728729834;1089.1395797320188;1106.2035334559105;11170.720731981766;11304.15218858589;11448.54205831774;11519.76960460803;11528.308301501937;741550;773464;794466;809083.1821457956;810403;92943.07056929344;117618;137280;164625;166028.3397166013;1068.1561566362486;1074.4466599701161;1100.0539535999035;1106.9225154239125;1108.2519299472663;19729.90135049373;20350.389488315373;20799.064042118443;20832.47918802042;20848.37454876356;50233.49766502434;60133.39866601278;62770.68614656897;62946.685266573375;65311.67344163249;57626.7118664404;69289.96065058927;73493.89759153724;91739.08260917572;92729.53635231781;7992.760217193261;8167.101618821806;8340.541270230196;8384.706535271236;8646.265067469083;7214.494985350975;9517.952410237904;12088.637340879788;12963.870361296265;13375.398107085399;10369.585216591553;10777.46112694378;10937.898288141947;11121.555137794721;11214.271072380596;9770.923790986619;10964.342139471657;10972.957569030928;11045.668629941114;11094.057005154653;10973.945130274298;11244.212905096565;11247.943760281474;11271.774564508827;11526.308421494738;7083.964580177066;7323.265005425738;7505.061867266591;7725.5364678119495;8435.83128337442;9421.905780942378;11038.061764750086;11208.66374008781;11234.3259404436;11241.100711942861 20:20:45 INFO - PROCESS | 2167 | |3;mootools.html;1411.054593422407;1417.4613646814216;1420.2756594137;1423.6440889777555;1432;7557.69769209231;7819.061712594496;8098.757037288883;8576.485410875344;8590.52752098635;8055.879161812578;8328.791780205484;8345.791355216123;8450.87323690145;8464.449810762297;2303.4586872085006;2345.95308093838;2355.49356888269;2356.2460012795827;2363;1826.3333883132693;2069.2411450267305;2323.372689373868;2359.740428552858;2362.433016076138;2251.684764133023;2331.522037982218;2335.789778919897;2354.387859156623;2355.3758254062686;2324.0122947747222;2324.407276144589;2330.755270696578;2336.0422226887063;2340.6137987232087;2302.2057390200353;2310.6187479065934;2357.941051473727;2382.118616112032;2382.2614989353356;8424.747257582283;8450.915490845075;8488.618012189467;8504.659813607448;8532.061473237938;5112.079825631385;5259.658122222043;5266.973665131688;5281.894362112736;5285.312909321764;3273.5908011498564;3340.866365345383;3477.4436090225695;3523.6652518010746;3541.4687796830426;1191.5114802930757;1206.4751832952693;1250.1374051904156;1251.361805479212;1270.104576273725;10808.351498910011;10826.917308269189;10882.23824332297;10886.836697449466;10929.945350273198;4675.345451636774;4722.8583142505095;4737.28940658897;4818.578519336804;4828.975855120772;9545.952270238744;9613;9642.662506812228;9654.372465789702;9670.56482458291;5228.9477105229225;5281.419043905167;5287.68273903567;5320.866978325495;5340.519353258225;4741.739204343725;4771.856844294677;4786.8085276589245;4837.395325584302;4852.102361063215;3866.240860408507;3935.4293627424436;3966.801659916993;3994.4807175067053;4045.5145382554283;1179.9233049851732;1230.2741382584318;1263.2673049631192;1300.3173333999725;1303.648015035935;790.0992868130336;851.0978362935184;909.8271328447573;911.9316051296179;913.8263729891299;5501.092319767194;5597.888042239132;5604.159376093618;5625.986557992191;5806.622569532967;981.0924894472585;984.4733067808688;996.14829320931;1004.0160642570322;1009.0968583118068;3701.722370822199;3775.1317197044286;3785.432185172191;3795.791231482295;3816.637419445148;8357.958210209032;9817.607295708092;10143.594256229815;10163.644272450429;10165.695029149138;8142.226488483585;10077.949610251902;10093.646722364829;10108.898911010943;10138.898611013796;7573.659185336563;7879.842403151905;7890.723824666109;7983.84032319362;8036;4907.3620429343955;5612.915806262828;5635.605507614591;5769.653820770767;5830.125481177857;8966.730998070068;9123.406978546373;9310.767230819283;9364.578593963424;9397.248220142235;9148.725538233864;9265.629374824932;9332.673356432764;9482.241420686467;9505.524723763923;7210.315020073084;7416.443766717625;7446.7021319146625;7451.627418628938;7455.627218639155;7737.535747855147;7941.086775020946;7973.282404583615;7977.122516523294;8015.47899386538;7258.129024517092;7302.5253358533655;7332.78001659951;7349.448791340564;7365.410767138723;7075.716971321295;7161.248068952685;7176.461765367514;7183.964080179566;7252.854942901218;6410.4871610272;6417.1657684500715;6495.9025614614875;6499.447546958372;6510.414062734377;4892;4922.852314430573;5045.268436076822;5068.873278168076;5171.456997015259;4964.726940018334;5017.079845782012;5059.46875578059;5227.0591293566;5231.398389185292 20:20:45 INFO - PROCESS | 2167 | |4;prototype.html;296.866410115448;357.76208821133946;363.7617360628788;369.1012384842908;371.75092687899104;4267.786610669462;4845.825983980494;5131.563817075548;5327.987682340362;5349.679019258847;4223.472065991751;4380.364847097177;5333.120035194198;5363.007843548946;5428.321459817523;3715.7213209009296;3966.9801650991703;4072.2669919414493;4230.217409779193;4263.5736426357425;3555.324488347219;3776.4524143999242;3903.8093381518624;4043.8584649537274;4101.9179616407655;4099.467069281004;4103.548609652936;4111.856085037024;4118.546959834416;4120.299549076664;3948.802559871995;4096.651784598283;4103.446034785311;4121;4123.876283711494;3070.3705740323403;3228.6287076985977;3502.5446691929887;3511.9639706286707;3513;5211.635185537014;5212.478752124795;5227.947720522784;5232.738363081869;5258;3506;4133.966508372907;4435.556444355539;4612.262038073925;4685.812567497296;4666.160091183586;5000.499950005007;5345.1447768356875;5635.886542546545;5756.740946657411;3266.5100234964707;3904.39481880309;3905.8242379092726;3913.5303763548554;3929.2730844793805;5062.962222666408;5964.254468191476;6018.846995573041;6041.395860413967;6048.939510604881;3774.96188548146;3896.648881961511;3950.7827069511454;3997.8411657704514;4005.8998525036523;3379.867744305636;3682.963170368262;3967.940480892789;4022.1955608877756;4023.7384570002855;4528.728276303433;4652.55800698933;4689.546240665405;4715.292706094114;4730.810767569327;4689.882752931136;5775.797847075416;5780.94219057804;5802;5814.563907706939;1273.802625531997;1295.7732396830706;1315.283170671986;1321.4317843327462;1323.5837653710437;787.5786454246951;865.3726048614704;884.39860894591;896.6908313861704;900.3832374823266;4363.509192645871;4649.465311489222;4718.811247550059;5083.186690129562;5128.358955130609;5273.965416456414;5532.97639936613;5725.312962444534;5758.596898217168;5772.5670574707065;4711.599514041276;4831.806727730851;4849.80600775965;5047.596192304607;5140.946106048251;2651.7480839320233;2680;2786.5927706508082;2878.7265209805037;2991.578999975038;5301.761420736076;5833.562482813721;5945.435183657545;5949.8580511016;5990.371011043778;5539.889202215933;5789.134378482678;5796.710164491843;5839.839259474022;5906.025505791582;5200.843974680765;5493.533049690741;5897.174395584621;5938.228030356113;5967.791127310524;4466.731996080245;4759.428868535798;4931.852044438672;5085.338905942203;5378.542823860016;5177.8187763428095;5540.22436858832;5618.089849451207;5624.943750562442;5667.376588575171;5125.7693403796175;5248.711320877388;5819.214406055128;5921.5558833086825;5922.466977971831;3160.5891234139413;3381.3575420669995;3617.155250822047;3811.5616704078275;3821.273957948092;4843.418789745112;5381.704006279536;5525.508112809599;5686.947914635805;5724.763674880642;4536.659750518658;5007.768435671997;5368.597355198298;5506.072874493895;5647.745851436777;5006.3992320921725;5224.03355379256;5708.971455142698;5725.599208055396;5760.020796464695;5302.840914772563;5536.667799932017;5553.583481239004;5575.358833734173;5654.378018418053;4952.876178095432;5414.972925135349;5682.420075352501;5698.914516282342;5756.740946657326;4657.767111644472;5221.869453263547;5385.549574943469;5395.730213489232;5620.213170156099 20:20:45 INFO - PROCESS | 2167 | |5;yui.html;698.4028655499548;703.4969996452536;755.5693254844738;817;846.6909578004029;14458.27708614569;15171.92414037931;15189.088654680727;15205.619859503518;15370.385184592616;13929.721405571883;14131.858681413183;14147.080439771407;14151;15512.069275843458;846.3990566697637;854.6111519258723;868.5961028121922;871.0636066228798;872.2890843962182;853.9274161696263;864.2394692670473;864.5936409887343;864.8140649760301;866.9133086691344;912.5756523216703;916.8853893263342;917.9632814687404;918.3387960668341;919.7470695558708;910.713125365511;912.5938957164065;912.6030176873081;912.9452232866049;915.7985243246509;677.1197443323659;677.1265068062194;677.200902934542;677.4444955136789;680.7651360280695;15572.92213538925;15582.454614088565;15589.922050389676;15610;15631.140287284195;13725.45098196071;13796.931015344959;13901.023278080258;14057.016008879382;14102.083364581269;11425.657230283105;11681;11727.472263748152;11751.823722644167;11763.294202347886;3608.260306637133;3623.9637603624155;3625.6555627215635;3631.564212294515;3660.084978755311;87519;106523.93476065295;112911.43544282226;113831.43084284608;114494;8574.699885503978;10453;10775.568977240979;10814.89185108139;11070.169737269736;20431.182752689725;21521.89239053795;21943.451413714785;22074.66887996681;22481.775182248297;7604.201558836243;7649.617519124022;7685.077790665156;7950.4832185907735;8103.716369927024;4267.509236437787;4276.31578947367;4317.093410383792;4397.07661391105;4422.20400327944;3580.3197392495345;3654.524911761507;3679.7424180307657;3703.7222208334483;3705.2404257127223;588.4644973074481;655.4134050025201;673.0207548017622;673.9730410783612;675.3584095109666;675.5913919477944;688.4905170174035;695;697.8262711653265;739.3530660671912;8444.746657600283;9802.36284641496;10133.460249469448;10239.897601024044;10648.201384896163;612.6660969771485;660.531022973694;678.8438659108433;691.8339598496325;696.1646024770296;4499.797509112098;5036.899262014739;5039.170862655463;5040.79836806531;5057.216131499624;77009;86198.56900715457;108213.37679934807;110114;111060;77573.61213194011;77842;84389;85343.14656853351;97849;47212.7639361801;72028.2797172032;73825;75995.72012839623;80979.5951020253;10481.895181048092;10700.89299106999;10908.781824363627;10949.726256843642;10968.725781855517;47889.80275493141;48242.27636585384;49055;50295;54138.45861541334;66290.33709662841;67561.66219168872;71610;73688.26311736814;74502;12772.936135319263;12886.608230337595;13002.869971300544;13037;13735.812220788892;14027.649308766955;14493.420263189777;14535.41858325655;14643.9749217558;15068.397264109313;13156.473741050633;13194.868051319363;13420.328983550979;13857.930710346383;13937.926040600183;13468.730625387634;13834.37745301484;13868.653283667989;13884.375203116086;14670.926645366704;10265.897341026493;13277.800832987707;13521;13694.041417100707;13826.37781299864;11103.833442498531;11103.888961110286;11187.552497899993;11701.122415818678;11896.22674526153;10327.225458090523;10887.618933337295;11029.779404412027;11033.779324413626;11042.889571104508 20:20:45 INFO - PROCESS | 2167 | __end_tp_report 20:20:45 INFO - PROCESS | 2167 | __start_cc_report 20:20:45 INFO - PROCESS | 2167 | _x_x_mozilla_cycle_collect,375 20:20:45 INFO - PROCESS | 2167 | __end_cc_report 20:20:45 INFO - PROCESS | 2167 | __startTimestamp1486700445883__endTimestamp 20:20:45 INFO - PROCESS | 2167 | 20:20:45 INFO - PROCESS | 2167 | ------- Summary: start ------- 20:20:45 INFO - PROCESS | 2167 | Number of tests: 6 20:20:45 INFO - PROCESS | 2167 | 20:20:45 INFO - PROCESS | 2167 | [#0] dojo.html Cycles:165 Average:5806.98 Median:6083.79 stddev:670.09 (11.0%) stddev-sans-first:645.27 20:20:45 INFO - PROCESS | 2167 | Values: 3412.1 3432.0 3438.2 3446.7 3452.3 5781.2 5806.7 5827.9 5853.3 5856.9 5785.4 5844.5 5857.2 5878.7 5890.1 5276.8 5304.0 5326.7 5350.5 5355.5 5377.5 5385.8 5393.3 5393.3 5464.7 4391.6 5228.3 5231.7 5356.1 5364.0 3760.3 5328.8 5356.7 5378.0 5425.2 5250.3 5305.6 5320.5 5327.7 5354.4 5643.3 5890.0 5915.1 5944.0 6000.3 6178.4 6210.6 6227.1 6252.3 6332.9 6282.9 6303.2 6308.6 6315.4 6359.7 5889.6 5974.8 5977.7 5994.5 6002.0 6215.5 6232.5 6365.6 6372.5 6401.9 6183.8 6201.8 6234.3 6263.0 6281.4 6332.9 6337.7 6338.6 6343.3 6361.8 5395.7 6000.9 6195.5 6203.7 6216.8 6269.9 6290.5 6302.6 6313.2 6319.9 5076.5 5098.2 5098.6 5110.7 5139.9 4403.1 4418.4 4450.1 4498.6 4513.1 6016.8 6113.3 6116.2 6116.8 6142.3 6259.7 6304.4 6319.1 6326.1 6330.7 5785.7 5849.3 6035.1 6048.6 6083.8 5564.6 5586.0 5586.6 5601.7 5610.7 6527.4 6541.4 6558.0 6569.2 6573.9 6149.9 6159.7 6225.4 6251.8 6325.1 6491.0 6503.9 6523.2 6541.7 6542.1 4867.3 5079.6 6144.3 6293.5 6297.7 5987.8 6193.9 6235.7 6296.2 6320.8 6129.1 6142.6 6164.2 6215.6 6250.1 6102.1 6131.8 6134.6 6155.3 6158.9 5526.6 5553.6 6009.1 6037.7 6128.3 5208.1 5742.3 6122.0 6223.7 6228.1 5013.6 6092.6 6108.6 6109.3 6110.5 20:20:45 INFO - PROCESS | 2167 | 20:20:45 INFO - PROCESS | 2167 | [#1] ext.html Cycles:180 Average:66266.63 Median:40218.40 stddev:139294.26 (346.3%) stddev-sans-first:139597.47 20:20:45 INFO - PROCESS | 2167 | Values: 488.6 490.3 502.5 511.7 525.1 37157.3 37595.2 40296.6 40331.0 40478.6 42254.0 42531.4 42552.6 42687.4 42708.8 8447.9 8692.3 9067.8 9311.0 9330.5 10989.5 11349.9 11360.8 11382.5 11516.3 11432.4 11456.3 11473.7 11480.0 11497.3 10825.7 11460.0 11461.3 11489.6 11499.4 11312.0 11402.4 11422.5 11427.3 11427.9 39828.6 40152.8 40284.0 40304.8 40310.8 3939.8 3943.3 4056.0 4056.5 4068.8 29369.6 29390.7 29418.7 29743.7 30369.7 2827.2 3307.6 3330.2 3332.4 3337.3 466351.0 467376.0 469644.0 469904.0 471925.9 60852.7 61031.4 61084.7 61095.0 61185.4 51699.0 54029.0 62650.0 62972.7 63435.0 13418.6 16570.9 16644.8 16649.8 16674.2 11794.3 12013.3 12617.7 12865.7 12932.0 12227.6 16164.4 16167.6 16297.3 16302.8 6602.7 6636.2 6665.5 6676.9 6682.7 868.3 870.0 877.8 897.7 905.9 29807.9 29833.6 30126.7 30225.4 30491.8 1029.3 1070.2 1087.0 1099.8 1187.5 15517.7 15532.9 15540.5 15567.9 15669.9 627951.9 630936.0 630998.0 631608.0 632087.0 59695.7 59909.7 60052.7 60106.0 60425.0 1436.7 1442.0 1455.4 1456.8 1459.1 28555.1 28619.6 29107.0 29745.1 30099.8 50644.0 51255.0 51271.5 51367.0 51376.5 373306.0 465088.0 466554.0 466723.0 467014.0 24372.8 24437.1 24864.0 24963.9 46248.5 42542.0 44221.6 48368.5 50975.0 52012.5 40698.4 41149.6 42048.6 42072.0 43341.0 41717.4 41844.0 41851.4 42893.8 43233.8 40427.0 40959.6 41249.8 41378.6 41399.8 33473.7 36296.8 36449.6 37022.3 37184.1 24837.8 25608.5 26824.9 27058.1 27173.3 20:20:45 INFO - PROCESS | 2167 | 20:20:45 INFO - PROCESS | 2167 | [#2] jquery.html Cycles:180 Average:41205.62 Median:22013.00 stddev:130444.86 (592.6%) stddev-sans-first:130774.74 20:20:45 INFO - PROCESS | 2167 | Values: 364.3 392.5 392.7 402.7 423.0 14543.6 16152.0 19895.2 21121.3 21184.0 20560.9 20958.8 21308.9 22048.0 22354.8 5804.2 5886.7 6090.7 6144.9 6203.1 5126.7 6006.2 6061.9 6084.5 6094.1 5195.9 5943.0 6062.9 6124.0 6124.7 5907.5 5911.4 5954.4 6100.0 6120.5 5811.0 5841.1 5853.4 5861.7 5869.1 13473.7 19938.9 25683.7 25715.2 25969.7 2601.0 2631.8 2638.8 2641.1 2868.8 9855.2 10328.2 10391.6 10542.5 10589.2 1625.6 1824.9 1835.0 1849.9 1891.7 133322.0 133724.0 140228.0 142102.0 143774.0 11563.9 11789.8 12094.5 12128.8 12132.2 15583.1 15723.9 15748.0 15750.5 15765.5 8614.7 8742.2 8843.6 8845.2 8845.6 7025.0 8505.0 8569.2 8651.6 8714.0 3959.0 4602.0 4748.4 4809.5 4824.6 1769.8 2001.3 2049.3 2074.4 2080.1 844.4 1008.0 1024.6 1036.7 1044.4 20476.4 21859.7 21978.0 22223.8 23098.5 1044.7 1057.9 1063.9 1089.1 1106.2 11170.7 11304.2 11448.5 11519.8 11528.3 741550.0 773464.0 794466.0 809083.2 810403.0 92943.1 117618.0 137280.0 164625.0 166028.3 1068.2 1074.4 1100.1 1106.9 1108.3 19729.9 20350.4 20799.1 20832.5 20848.4 50233.5 60133.4 62770.7 62946.7 65311.7 57626.7 69290.0 73493.9 91739.1 92729.5 7992.8 8167.1 8340.5 8384.7 8646.3 7214.5 9518.0 12088.6 12963.9 13375.4 10369.6 10777.5 10937.9 11121.6 11214.3 9770.9 10964.3 10973.0 11045.7 11094.1 10973.9 11244.2 11247.9 11271.8 11526.3 7084.0 7323.3 7505.1 7725.5 8435.8 9421.9 11038.1 11208.7 11234.3 11241.1 20:20:45 INFO - PROCESS | 2167 | 20:20:45 INFO - PROCESS | 2167 | [#3] mootools.html Cycles:180 Average:5485.54 Median:5230.17 stddev:2963.76 (56.7%) stddev-sans-first:2956.25 20:20:45 INFO - PROCESS | 2167 | Values: 1411.1 1417.5 1420.3 1423.6 1432.0 7557.7 7819.1 8098.8 8576.5 8590.5 8055.9 8328.8 8345.8 8450.9 8464.4 2303.5 2346.0 2355.5 2356.2 2363.0 1826.3 2069.2 2323.4 2359.7 2362.4 2251.7 2331.5 2335.8 2354.4 2355.4 2324.0 2324.4 2330.8 2336.0 2340.6 2302.2 2310.6 2357.9 2382.1 2382.3 8424.7 8450.9 8488.6 8504.7 8532.1 5112.1 5259.7 5267.0 5281.9 5285.3 3273.6 3340.9 3477.4 3523.7 3541.5 1191.5 1206.5 1250.1 1251.4 1270.1 10808.4 10826.9 10882.2 10886.8 10929.9 4675.3 4722.9 4737.3 4818.6 4829.0 9546.0 9613.0 9642.7 9654.4 9670.6 5228.9 5281.4 5287.7 5320.9 5340.5 4741.7 4771.9 4786.8 4837.4 4852.1 3866.2 3935.4 3966.8 3994.5 4045.5 1179.9 1230.3 1263.3 1300.3 1303.6 790.1 851.1 909.8 911.9 913.8 5501.1 5597.9 5604.2 5626.0 5806.6 981.1 984.5 996.1 1004.0 1009.1 3701.7 3775.1 3785.4 3795.8 3816.6 8358.0 9817.6 10143.6 10163.6 10165.7 8142.2 10077.9 10093.6 10108.9 10138.9 7573.7 7879.8 7890.7 7983.8 8036.0 4907.4 5612.9 5635.6 5769.7 5830.1 8966.7 9123.4 9310.8 9364.6 9397.2 9148.7 9265.6 9332.7 9482.2 9505.5 7210.3 7416.4 7446.7 7451.6 7455.6 7737.5 7941.1 7973.3 7977.1 8015.5 7258.1 7302.5 7332.8 7349.4 7365.4 7075.7 7161.2 7176.5 7184.0 7252.9 6410.5 6417.2 6495.9 6499.4 6510.4 4892.0 4922.9 5045.3 5068.9 5171.5 4964.7 5017.1 5059.5 5227.1 5231.4 20:20:45 INFO - PROCESS | 2167 | 20:20:45 INFO - PROCESS | 2167 | [#4] prototype.html Cycles:180 Average:4492.50 Median:5007.08 stddev:1385.93 (27.7%) stddev-sans-first:1353.56 20:20:45 INFO - PROCESS | 2167 | Values: 296.9 357.8 363.8 369.1 371.8 4267.8 4845.8 5131.6 5328.0 5349.7 4223.5 4380.4 5333.1 5363.0 5428.3 3715.7 3967.0 4072.3 4230.2 4263.6 3555.3 3776.5 3903.8 4043.9 4101.9 4099.5 4103.5 4111.9 4118.5 4120.3 3948.8 4096.7 4103.4 4121.0 4123.9 3070.4 3228.6 3502.5 3512.0 3513.0 5211.6 5212.5 5227.9 5232.7 5258.0 3506.0 4134.0 4435.6 4612.3 4685.8 4666.2 5000.5 5345.1 5635.9 5756.7 3266.5 3904.4 3905.8 3913.5 3929.3 5063.0 5964.3 6018.8 6041.4 6048.9 3775.0 3896.6 3950.8 3997.8 4005.9 3379.9 3683.0 3967.9 4022.2 4023.7 4528.7 4652.6 4689.5 4715.3 4730.8 4689.9 5775.8 5780.9 5802.0 5814.6 1273.8 1295.8 1315.3 1321.4 1323.6 787.6 865.4 884.4 896.7 900.4 4363.5 4649.5 4718.8 5083.2 5128.4 5274.0 5533.0 5725.3 5758.6 5772.6 4711.6 4831.8 4849.8 5047.6 5140.9 2651.7 2680.0 2786.6 2878.7 2991.6 5301.8 5833.6 5945.4 5949.9 5990.4 5539.9 5789.1 5796.7 5839.8 5906.0 5200.8 5493.5 5897.2 5938.2 5967.8 4466.7 4759.4 4931.9 5085.3 5378.5 5177.8 5540.2 5618.1 5624.9 5667.4 5125.8 5248.7 5819.2 5921.6 5922.5 3160.6 3381.4 3617.2 3811.6 3821.3 4843.4 5381.7 5525.5 5686.9 5724.8 4536.7 5007.8 5368.6 5506.1 5647.7 5006.4 5224.0 5709.0 5725.6 5760.0 5302.8 5536.7 5553.6 5575.4 5654.4 4952.9 5415.0 5682.4 5698.9 5756.7 4657.8 5221.9 5385.5 5395.7 5620.2 20:20:45 INFO - PROCESS | 2167 | 20:20:45 INFO - PROCESS | 2167 | [#5] yui.html Cycles:180 Average:20161.67 Median:3669.91 stddev:28809.46 (785.0%) stddev-sans-first:28853.22 20:20:45 INFO - PROCESS | 2167 | Values: 698.4 703.5 755.6 817.0 846.7 14458.3 15171.9 15189.1 15205.6 15370.4 13929.7 14131.9 14147.1 14151.0 15512.1 846.4 854.6 868.6 871.1 872.3 853.9 864.2 864.6 864.8 866.9 912.6 916.9 918.0 918.3 919.7 910.7 912.6 912.6 912.9 915.8 677.1 677.1 677.2 677.4 680.8 15572.9 15582.5 15589.9 15610.0 15631.1 13725.5 13796.9 13901.0 14057.0 14102.1 11425.7 11681.0 11727.5 11751.8 11763.3 3608.3 3624.0 3625.7 3631.6 3660.1 87519.0 106523.9 112911.4 113831.4 114494.0 8574.7 10453.0 10775.6 10814.9 11070.2 20431.2 21521.9 21943.5 22074.7 22481.8 7604.2 7649.6 7685.1 7950.5 8103.7 4267.5 4276.3 4317.1 4397.1 4422.2 3580.3 3654.5 3679.7 3703.7 3705.2 588.5 655.4 673.0 674.0 675.4 675.6 688.5 695.0 697.8 739.4 8444.7 9802.4 10133.5 10239.9 10648.2 612.7 660.5 678.8 691.8 696.2 4499.8 5036.9 5039.2 5040.8 5057.2 77009.0 86198.6 108213.4 110114.0 111060.0 77573.6 77842.0 84389.0 85343.1 97849.0 47212.8 72028.3 73825.0 75995.7 80979.6 10481.9 10700.9 10908.8 10949.7 10968.7 47889.8 48242.3 49055.0 50295.0 54138.5 66290.3 67561.7 71610.0 73688.3 74502.0 12772.9 12886.6 13002.9 13037.0 13735.8 14027.6 14493.4 14535.4 14644.0 15068.4 13156.5 13194.9 13420.3 13857.9 13937.9 13468.7 13834.4 13868.7 13884.4 14670.9 10265.9 13277.8 13521.0 13694.0 13826.4 11103.8 11103.9 11187.6 11701.1 11896.2 10327.2 10887.6 11029.8 11033.8 11042.9 20:20:45 INFO - PROCESS | 2167 | -------- Summary: end -------- 20:20:45 INFO - PROCESS | 2167 | 20:20:46 INFO - TEST-INFO | 2167: exit 0 20:20:46 INFO - TEST-OK | dromaeo_css | took 1115777ms 20:20:46 INFO - TEST-START | kraken 20:20:46 INFO - operating with platform_type : mac_ 20:20:46 INFO - Initialising browser for kraken test... 20:20:46 INFO - TEST-INFO | started process 2171 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpffch_u/profile http://localhost:57071/getInfo.html) 20:20:49 INFO - PROCESS | 2171 | 2017-02-09 20:20:49.366 plugin-container[2172:24637] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c47, name = 'com.apple.tsm.portname' 20:20:49 INFO - PROCESS | 2171 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:20:49 INFO - PROCESS | 2171 | 2017-02-09 20:20:49.370 plugin-container[2172:24637] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x440f, name = 'com.apple.CFPasteboardClient' 20:20:49 INFO - PROCESS | 2171 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:20:49 INFO - PROCESS | 2171 | 2017-02-09 20:20:49.370 plugin-container[2172:24637] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:20:49 INFO - PROCESS | 2171 | __metrics Screen width/height:1600/1200 20:20:49 INFO - PROCESS | 2171 | colorDepth:24 20:20:49 INFO - PROCESS | 2171 | Browser inner width/height: 1024/689 20:20:49 INFO - PROCESS | 2171 | __metrics 20:20:49 ERROR - PROCESS | 2171 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 20:20:50 INFO - TEST-INFO | 2171: exit 0 20:20:50 INFO - Browser initialized. 20:20:50 INFO - Running cycle 1/1 for kraken test... 20:20:50 INFO - TEST-INFO | started process 2173 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpffch_u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:20:52 INFO - PROCESS | 2173 | 2017-02-09 20:20:52.702 plugin-container[2174:24760] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8733, name = 'com.apple.tsm.portname' 20:20:52 INFO - PROCESS | 2173 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:20:52 INFO - PROCESS | 2173 | 2017-02-09 20:20:52.704 plugin-container[2174:24760] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0f, name = 'com.apple.CFPasteboardClient' 20:20:52 INFO - PROCESS | 2173 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:20:52 INFO - PROCESS | 2173 | 2017-02-09 20:20:52.704 plugin-container[2174:24760] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:21:02 INFO - PROCESS | 2173 | RSS: Main: 219033600 20:21:02 INFO - PROCESS | 2173 | 20:21:05 INFO - PROCESS | 2173 | Cycle 1(1): loaded http://localhost:57071/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57071/tests/kraken/driver.html?testName=audio-beat-detection) 20:21:06 INFO - PROCESS | 2173 | RSS: Main: 233402368 20:21:06 INFO - PROCESS | 2173 | 20:21:08 INFO - PROCESS | 2173 | Cycle 1(1): loaded http://localhost:57071/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57071/tests/kraken/driver.html?testName=audio-dft) 20:21:09 INFO - PROCESS | 2173 | RSS: Main: 241442816 20:21:09 INFO - PROCESS | 2173 | 20:21:12 INFO - PROCESS | 2173 | Cycle 1(1): loaded http://localhost:57071/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57071/tests/kraken/driver.html?testName=audio-fft) 20:21:13 INFO - PROCESS | 2173 | RSS: Main: 245313536 20:21:13 INFO - PROCESS | 2173 | 20:21:15 INFO - PROCESS | 2173 | Cycle 1(1): loaded http://localhost:57071/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57071/tests/kraken/driver.html?testName=audio-oscillator) 20:21:16 INFO - PROCESS | 2173 | RSS: Main: 246165504 20:21:16 INFO - PROCESS | 2173 | 20:21:18 INFO - PROCESS | 2173 | Cycle 1(1): loaded http://localhost:57071/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57071/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:21:18 INFO - PROCESS | 2173 | RSS: Main: 246865920 20:21:18 INFO - PROCESS | 2173 | 20:21:21 INFO - PROCESS | 2173 | Cycle 1(1): loaded http://localhost:57071/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57071/tests/kraken/driver.html?testName=imaging-darkroom) 20:21:22 INFO - PROCESS | 2173 | RSS: Main: 250482688 20:21:22 INFO - PROCESS | 2173 | 20:21:25 INFO - PROCESS | 2173 | Cycle 1(1): loaded http://localhost:57071/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57071/tests/kraken/driver.html?testName=imaging-desaturate) 20:21:26 INFO - PROCESS | 2173 | RSS: Main: 249966592 20:21:26 INFO - PROCESS | 2173 | 20:21:29 INFO - PROCESS | 2173 | Cycle 1(1): loaded http://localhost:57071/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57071/tests/kraken/driver.html?testName=json-parse-financial) 20:21:30 INFO - PROCESS | 2173 | RSS: Main: 250011648 20:21:30 INFO - PROCESS | 2173 | 20:21:31 INFO - PROCESS | 2173 | Cycle 1(1): loaded http://localhost:57071/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57071/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:21:32 INFO - PROCESS | 2173 | RSS: Main: 249556992 20:21:32 INFO - PROCESS | 2173 | 20:21:34 INFO - PROCESS | 2173 | Cycle 1(1): loaded http://localhost:57071/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57071/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:21:34 INFO - PROCESS | 2173 | RSS: Main: 249610240 20:21:34 INFO - PROCESS | 2173 | 20:21:37 INFO - PROCESS | 2173 | Cycle 1(1): loaded http://localhost:57071/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57071/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:21:37 INFO - PROCESS | 2173 | RSS: Main: 249724928 20:21:37 INFO - PROCESS | 2173 | 20:21:40 INFO - PROCESS | 2173 | Cycle 1(1): loaded http://localhost:57071/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57071/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:21:41 INFO - PROCESS | 2173 | RSS: Main: 250089472 20:21:41 INFO - PROCESS | 2173 | 20:21:44 INFO - PROCESS | 2173 | Cycle 1(1): loaded http://localhost:57071/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57071/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:21:45 INFO - PROCESS | 2173 | RSS: Main: 249831424 20:21:45 INFO - PROCESS | 2173 | 20:21:46 INFO - PROCESS | 2173 | Cycle 1(1): loaded http://localhost:57071/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57071/tests/kraken/driver.html?testName=ai-astar) 20:21:47 INFO - PROCESS | 2173 | RSS: Main: 251781120 20:21:47 INFO - PROCESS | 2173 | 20:21:47 INFO - PROCESS | 2173 | __start_tp_report 20:21:47 INFO - PROCESS | 2173 | _x_x_mozilla_page_load 20:21:47 INFO - PROCESS | 2173 | _x_x_mozilla_page_load_details 20:21:47 INFO - PROCESS | 2173 | |i|pagename|runs| 20:21:47 INFO - PROCESS | 2173 | |0;ai-astar;104;119;119;117;118;118;121;118;119;120 20:21:47 INFO - PROCESS | 2173 | |1;audio-beat-detection;150;115;114;146;109;150;135;134;129;144 20:21:47 INFO - PROCESS | 2173 | |2;audio-dft;203;204;232;267;198;204;189;200;199;230 20:21:47 INFO - PROCESS | 2173 | |3;audio-fft;86;62;63;89;59;61;83;80;74;60 20:21:47 INFO - PROCESS | 2173 | |4;audio-oscillator;91;71;85;72;73;93;116;104;80;82 20:21:47 INFO - PROCESS | 2173 | |5;imaging-gaussian-blur;137;111;89;104;105;87;79;132;136;85 20:21:47 INFO - PROCESS | 2173 | |6;imaging-darkroom;155;96;96;124;154;95;96;97;102;150 20:21:47 INFO - PROCESS | 2173 | |7;imaging-desaturate;83;146;145;94;92;91;94;94;92;103 20:21:47 INFO - PROCESS | 2173 | |8;json-parse-financial;56;56;55;59;59;60;60;59;59;61 20:21:47 INFO - PROCESS | 2173 | |9;json-stringify-tinderbox;67;76;71;88;109;104;74;74;73;73 20:21:47 INFO - PROCESS | 2173 | |10;stanford-crypto-aes;88;86;86;83;86;88;86;83;91;106 20:21:47 INFO - PROCESS | 2173 | |11;stanford-crypto-ccm;156;165;150;151;160;148;142;139;186;160 20:21:47 INFO - PROCESS | 2173 | |12;stanford-crypto-pbkdf2;174;173;168;202;190;170;151;171;157;152 20:21:47 INFO - PROCESS | 2173 | |13;stanford-crypto-sha256-iterative;71;65;75;68;68;65;66;67;67;64 20:21:47 INFO - PROCESS | 2173 | __end_tp_report 20:21:47 INFO - PROCESS | 2173 | __start_cc_report 20:21:47 INFO - PROCESS | 2173 | _x_x_mozilla_cycle_collect,943 20:21:47 INFO - PROCESS | 2173 | __end_cc_report 20:21:47 INFO - PROCESS | 2173 | __startTimestamp1486700507037__endTimestamp 20:21:47 INFO - PROCESS | 2173 | 20:21:47 INFO - PROCESS | 2173 | ------- Summary: start ------- 20:21:47 INFO - PROCESS | 2173 | Number of tests: 14 20:21:47 INFO - PROCESS | 2173 | 20:21:47 INFO - PROCESS | 2173 | [#0] ai-astar Cycles:10 Average:117.30 Median:119.00 stddev:4.81 (4.0%) stddev-sans-first:1.20 20:21:47 INFO - PROCESS | 2173 | Values: 104.0 119.0 119.0 117.0 118.0 118.0 121.0 118.0 119.0 120.0 20:21:47 INFO - PROCESS | 2173 | 20:21:47 INFO - PROCESS | 2173 | [#1] audio-beat-detection Cycles:10 Average:132.60 Median:139.50 stddev:15.45 (11.1%) stddev-sans-first:15.05 20:21:47 INFO - PROCESS | 2173 | Values: 150.0 115.0 114.0 146.0 109.0 150.0 135.0 134.0 129.0 144.0 20:21:47 INFO - PROCESS | 2173 | 20:21:47 INFO - PROCESS | 2173 | [#2] audio-dft Cycles:10 Average:212.60 Median:204.00 stddev:23.55 (11.5%) stddev-sans-first:24.72 20:21:47 INFO - PROCESS | 2173 | Values: 203.0 204.0 232.0 267.0 198.0 204.0 189.0 200.0 199.0 230.0 20:21:47 INFO - PROCESS | 2173 | 20:21:47 INFO - PROCESS | 2173 | [#3] audio-fft Cycles:10 Average:71.70 Median:77.00 stddev:11.96 (15.5%) stddev-sans-first:11.52 20:21:47 INFO - PROCESS | 2173 | Values: 86.0 62.0 63.0 89.0 59.0 61.0 83.0 80.0 74.0 60.0 20:21:47 INFO - PROCESS | 2173 | 20:21:47 INFO - PROCESS | 2173 | [#4] audio-oscillator Cycles:10 Average:86.70 Median:81.00 stddev:14.67 (18.1%) stddev-sans-first:15.47 20:21:47 INFO - PROCESS | 2173 | Values: 91.0 71.0 85.0 72.0 73.0 93.0 116.0 104.0 80.0 82.0 20:21:47 INFO - PROCESS | 2173 | 20:21:47 INFO - PROCESS | 2173 | [#5] imaging-gaussian-blur Cycles:10 Average:106.50 Median:108.00 stddev:22.07 (20.4%) stddev-sans-first:20.47 20:21:47 INFO - PROCESS | 2173 | Values: 137.0 111.0 89.0 104.0 105.0 87.0 79.0 132.0 136.0 85.0 20:21:47 INFO - PROCESS | 2173 | 20:21:47 INFO - PROCESS | 2173 | [#6] imaging-darkroom Cycles:10 Average:116.50 Median:95.50 stddev:26.63 (27.9%) stddev-sans-first:24.32 20:21:47 INFO - PROCESS | 2173 | Values: 155.0 96.0 96.0 124.0 154.0 95.0 96.0 97.0 102.0 150.0 20:21:47 INFO - PROCESS | 2173 | 20:21:47 INFO - PROCESS | 2173 | [#7] imaging-desaturate Cycles:10 Average:103.40 Median:92.00 stddev:22.71 (24.7%) stddev-sans-first:22.85 20:21:47 INFO - PROCESS | 2173 | Values: 83.0 146.0 145.0 94.0 92.0 91.0 94.0 94.0 92.0 103.0 20:21:47 INFO - PROCESS | 2173 | 20:21:47 INFO - PROCESS | 2173 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:59.00 stddev:2.01 (3.4%) stddev-sans-first:1.94 20:21:47 INFO - PROCESS | 2173 | Values: 56.0 56.0 55.0 59.0 59.0 60.0 60.0 59.0 59.0 61.0 20:21:47 INFO - PROCESS | 2173 | 20:21:47 INFO - PROCESS | 2173 | [#9] json-stringify-tinderbox Cycles:10 Average:80.90 Median:73.50 stddev:14.56 (19.8%) stddev-sans-first:14.55 20:21:47 INFO - PROCESS | 2173 | Values: 67.0 76.0 71.0 88.0 109.0 104.0 74.0 74.0 73.0 73.0 20:21:47 INFO - PROCESS | 2173 | 20:21:47 INFO - PROCESS | 2173 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:86.00 stddev:6.65 (7.7%) stddev-sans-first:7.05 20:21:47 INFO - PROCESS | 2173 | Values: 88.0 86.0 86.0 83.0 86.0 88.0 86.0 83.0 91.0 106.0 20:21:47 INFO - PROCESS | 2173 | 20:21:47 INFO - PROCESS | 2173 | [#11] stanford-crypto-ccm Cycles:10 Average:155.70 Median:158.00 stddev:13.43 (8.5%) stddev-sans-first:14.24 20:21:47 INFO - PROCESS | 2173 | Values: 156.0 165.0 150.0 151.0 160.0 148.0 142.0 139.0 186.0 160.0 20:21:47 INFO - PROCESS | 2173 | 20:21:47 INFO - PROCESS | 2173 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.80 Median:172.00 stddev:15.99 (9.3%) stddev-sans-first:16.92 20:21:47 INFO - PROCESS | 2173 | Values: 174.0 173.0 168.0 202.0 190.0 170.0 151.0 171.0 157.0 152.0 20:21:47 INFO - PROCESS | 2173 | 20:21:47 INFO - PROCESS | 2173 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:3.27 (4.8%) stddev-sans-first:3.23 20:21:47 INFO - PROCESS | 2173 | Values: 71.0 65.0 75.0 68.0 68.0 65.0 66.0 67.0 67.0 64.0 20:21:47 INFO - PROCESS | 2173 | -------- Summary: end -------- 20:21:47 INFO - PROCESS | 2173 | 20:21:47 INFO - TEST-INFO | 2173: exit 0 20:21:47 INFO - TEST-OK | kraken | took 61357ms 20:21:47 INFO - SUITE-END | took 1177s 20:21:48 INFO - Completed test suite (00:19:37) 20:21:48 INFO - javascript benchmark 20:21:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7350.588915637076, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3412.0957946144276, 3431.9999999999995, 3438.1748380388713, 3446.707029902458, 3452.2577645806145, 5781.248437703098, 5806.651600903949, 5827.912581311273, 5853.268341457318, 5856.853578660535, 5785.363610002896, 5844.532437405008, 5857.209276747638, 5878.706064696769, 5890.087036509337, 5276.762545685444, 5304.0, 5326.733663316838, 5350.5184533391985, 5355.518003379695, 5377.462253774611, 5385.78456861725, 5393.2719082923695, 5393.2719082923695, 5464.6994415307145, 4391.560843915615, 5228.2680424740565, 5231.73841307935, 5356.062689029423, 5364.007658583155, 3760.3231418344685, 5328.813491527778, 5356.678599284055, 5377.973110134463, 5425.159100339453, 5250.264962905197, 5305.602079843989, 5320.547753440962, 5327.706976116312, 5354.357477102733, 5643.266375371217, 5889.970550147222, 5915.053591425394, 5943.970280148615, 6000.309964354112, 6178.41305076017, 6210.565260431772, 6227.09707092469, 6252.2809876864285, 6332.873342533124, 6282.87434251317, 6303.243610766692, 6308.621482711052, 6315.400036996524, 6359.682015899187, 5889.5877288590245, 5974.790882319141, 5977.701114944235, 5994.520438364921, 6002.0, 6215.502759779207, 6232.532560058014, 6365.649889256043, 6372.522060845455, 6401.8719625608155, 6183.81448556544, 6201.81394558164, 6234.2830574483605, 6263.029230469285, 6281.371862813773, 6332.9234030214975, 6337.714802833883, 6338.58799178052, 6343.333949935282, 6361.840953976188, 5395.732002979296, 6000.909986350208, 6195.535334849814, 6203.689815509207, 6216.813495595139, 6269.937300627026, 6290.496760259169, 6302.590331628429, 6313.179286692701, 6319.873602527924, 5076.517730815566, 5098.2352647103235, 5098.643094983389, 5110.718910459886, 5139.897202056013, 4403.14138742942, 4418.359337895987, 4450.087732014929, 4498.595126438636, 4513.052259025576, 6016.759329626853, 6113.266408031065, 6116.174316467309, 6116.8227554565365, 6142.324344322121, 6259.71831267594, 6304.3695630437505, 6319.115323854664, 6326.082718005863, 6330.715117819617, 5785.652860828363, 5849.268841394825, 6035.064564992434, 6048.637081775108, 6083.7870674526175, 5564.610477266633, 5585.99452098618, 5586.608937374426, 5601.691906945076, 5610.663360198319, 6527.445167160749, 6541.443977261986, 6558.0, 6569.178852643419, 6573.934260657428, 6149.877002460015, 6159.661218632839, 6225.439710425902, 6251.843703907257, 6325.082862984934, 6490.967545162244, 6503.934960650522, 6523.151990241238, 6541.672916354259, 6542.149520562487, 4867.318575399518, 5079.619028572798, 6144.262688477233, 6293.496520278458, 6297.685115744286, 5987.820365389045, 6193.876122477435, 6235.688215589294, 6296.181496405438, 6320.799048180831, 6129.141920131096, 6142.560166306883, 6164.229471316085, 6215.627062376272, 6250.124982502544, 6102.084687296763, 6131.754729810757, 6134.570580059353, 6155.2921414037955, 6158.938410616016, 5526.563093595613, 5553.611247212656, 6009.098635204754, 6037.667928263988, 6128.325884152829, 5208.114620514598, 5742.28221472316, 6121.971262793606, 6223.657698826608, 6228.0969259456215, 5013.623978201723, 6092.573519853568, 6108.5723999319625, 6109.258861224707, 6110.480609148094], "value": 5766.026804350334, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [488.6359662051771, 490.3429404597838, 502.5301343244065, 511.7159976213201, 525.1413938211024, 37157.25685486292, 37595.248095038085, 40296.589619363294, 40331.0, 40478.595214047884, 42254.0, 42531.36202956958, 42552.57447425525, 42687.35968960468, 42708.786456067755, 8447.915520844774, 8692.304615630766, 9067.773305667362, 9311.022342654025, 9330.486823224719, 10989.450527473635, 11349.886501134966, 11360.829587556193, 11382.544698212103, 11516.251443656178, 11432.37121958292, 11456.31262124271, 11473.655790326304, 11480.0, 11497.252678575907, 10825.67522974312, 11460.025897798698, 11461.312321260668, 11489.597864074718, 11499.425028748528, 11312.0, 11402.372869492174, 11422.485988130555, 11427.257228280136, 11427.885721142766, 39828.60171398278, 40152.79923600363, 40284.0, 40304.79847600743, 40310.79844600787, 3939.763614183158, 3943.3493473577114, 4055.959440405588, 4056.5334986476637, 4068.755874647501, 29369.559456608167, 29390.706092939225, 29418.705812942026, 29743.70256297431, 30369.696303036908, 2827.2366461055603, 3307.570015897918, 3330.150811543041, 3332.3835090508333, 3337.349216902705, 466351.0, 467376.0, 469644.0, 469904.0, 471925.921111187, 60852.69573652103, 61031.38968610257, 61084.69457652772, 61095.0, 61185.38814611886, 51699.0, 54029.02840343819, 62650.0, 62972.68513657494, 63435.0, 13418.597442076752, 16570.917145414194, 16644.750328745078, 16649.750253746202, 16674.166291685367, 11794.29234245948, 12013.339266340261, 12617.684557885943, 12865.742685146432, 12932.030097742707, 12227.633171004707, 16164.353425862833, 16167.625751811227, 16297.348106075624, 16302.836971630131, 6602.735890564323, 6636.236832764197, 6665.533412661164, 6676.933230667728, 6682.665866706645, 868.3053557154251, 869.9734313509992, 877.7849426890325, 897.6633762339122, 905.8686490458847, 29807.85096074549, 29833.552496712568, 30126.69873301283, 30225.395492090476, 30491.847540762155, 1029.34122161815, 1070.2454769387564, 1086.9945650271857, 1099.8405231241425, 1187.4715751490503, 15517.689646207238, 15532.92233538825, 15540.45608403723, 15567.922160389126, 15669.921650391676, 627951.860240705, 630936.0, 630998.0, 631608.0, 632087.0, 59695.70152149211, 59909.70045149746, 60052.69973650191, 60106.0, 60425.0, 1436.6839295355005, 1442.0410427065883, 1455.4251070826965, 1456.8470310617656, 1459.1391079263285, 28555.143345699664, 28619.570706439004, 29107.0, 29745.10764677063, 30099.849500753233, 50644.0, 51255.0, 51271.48728512667, 51367.0, 51376.48623513866, 373306.0, 465088.0, 466554.0, 466723.0, 467014.0, 24372.756272437047, 24437.144699935416, 24864.005439782206, 24963.87518062398, 46248.537514624426, 42542.0, 44221.55778442303, 48368.5163148364, 50975.0, 52012.47987520076, 40698.38952415657, 41149.588504114574, 42048.57951420569, 42072.0, 43341.0, 41717.37423938704, 41843.953901152716, 41851.372229415974, 42893.78553107214, 43233.7838310819, 40426.9893252671, 40959.59040409558, 41249.79375103105, 41378.586214137475, 41399.7930010348, 33473.66526334705, 36296.81851590725, 36449.63550364569, 37022.259554809294, 37184.07039824026, 24837.751622484266, 25608.463492190527, 26824.865875671276, 27058.05296814602, 27173.320666983484], "value": 20249.714152538723, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.3096332450007, 392.50348309388613, 392.7309792791938, 402.71608515996223, 422.97885105744723, 14543.636409089779, 16152.0, 19895.204191832327, 21121.260755873547, 21184.0, 20560.89719551404, 20958.790412095874, 21308.89345553274, 22048.0, 22354.776452235474, 5804.216430781833, 5886.735096920627, 6090.66501342426, 6144.938550614482, 6203.069539569055, 5126.7436628168625, 6006.189164462807, 6061.9393806062035, 6084.482818960394, 6094.146819445281, 5195.870103247411, 5942.97028514859, 6062.878742425149, 6124.0, 6124.693765311739, 5907.497862681677, 5911.438413350725, 5954.434328738763, 6100.0, 6120.540959428061, 5810.983077961382, 5841.123831425278, 5853.385394533555, 5861.677607731573, 5869.1196320551835, 13473.663158421117, 19938.900305498526, 25683.7158142094, 25715.22854314355, 25969.74030259692, 2600.973990260111, 2631.789456843448, 2638.775704065157, 2641.1152263991585, 2868.827870327787, 9855.211583073336, 10328.225383096298, 10391.636292729718, 10542.525586348633, 10589.205809564313, 1625.6098536351308, 1824.9087545622665, 1834.9534314820073, 1849.861260405475, 1891.7067854482577, 133322.0, 133724.0, 140228.0, 142102.0, 143774.0, 11563.88436115645, 11789.76420471603, 12094.455749491293, 12128.818067728991, 12132.211406258564, 15583.14292713889, 15723.921380393254, 15748.0, 15750.527484175493, 15765.527034188992, 8614.741557753277, 8742.21320081183, 8843.585026395875, 8845.159709827556, 8845.611684845057, 7025.0, 8505.0, 8569.228769410784, 8651.567421628893, 8714.0, 3958.990457433336, 4601.976990115028, 4748.430188377417, 4809.470958194595, 4824.589909857701, 1769.796473405549, 2001.2695366191526, 2049.3442098528626, 2074.388055523624, 2080.147139672727, 844.4004756622744, 1007.969760907174, 1024.6106479537727, 1036.6682661548232, 1044.383813550009, 20476.38570842877, 21859.672104918438, 21978.0, 22223.77769222676, 23098.53802923932, 1044.681372181492, 1057.9418132002659, 1063.8829728729834, 1089.1395797320188, 1106.2035334559105, 11170.720731981766, 11304.15218858589, 11448.54205831774, 11519.76960460803, 11528.308301501937, 741550.0, 773464.0, 794466.0, 809083.1821457956, 810403.0, 92943.07056929344, 117618.0, 137280.0, 164625.0, 166028.3397166013, 1068.1561566362486, 1074.4466599701161, 1100.0539535999035, 1106.9225154239125, 1108.2519299472663, 19729.90135049373, 20350.389488315373, 20799.064042118443, 20832.47918802042, 20848.37454876356, 50233.49766502434, 60133.39866601278, 62770.68614656897, 62946.685266573375, 65311.67344163249, 57626.7118664404, 69289.96065058927, 73493.89759153724, 91739.08260917572, 92729.53635231781, 7992.760217193261, 8167.101618821806, 8340.541270230196, 8384.706535271236, 8646.265067469083, 7214.494985350975, 9517.952410237904, 12088.637340879788, 12963.870361296265, 13375.398107085399, 10369.585216591553, 10777.46112694378, 10937.898288141947, 11121.555137794721, 11214.271072380596, 9770.923790986619, 10964.342139471657, 10972.957569030928, 11045.668629941114, 11094.057005154653, 10973.945130274298, 11244.212905096565, 11247.943760281474, 11271.774564508827, 11526.308421494738, 7083.964580177066, 7323.265005425738, 7505.061867266591, 7725.5364678119495, 8435.83128337442, 9421.905780942378, 11038.061764750086, 11208.66374008781, 11234.3259404436, 11241.100711942861], "value": 9881.875910463796, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1411.054593422407, 1417.4613646814216, 1420.2756594137, 1423.6440889777555, 1432.0, 7557.69769209231, 7819.061712594496, 8098.757037288883, 8576.485410875344, 8590.52752098635, 8055.879161812578, 8328.791780205484, 8345.791355216123, 8450.87323690145, 8464.449810762297, 2303.4586872085006, 2345.95308093838, 2355.49356888269, 2356.2460012795827, 2363.0, 1826.3333883132693, 2069.2411450267305, 2323.372689373868, 2359.740428552858, 2362.433016076138, 2251.684764133023, 2331.522037982218, 2335.789778919897, 2354.387859156623, 2355.3758254062686, 2324.0122947747222, 2324.407276144589, 2330.755270696578, 2336.0422226887063, 2340.6137987232087, 2302.2057390200353, 2310.6187479065934, 2357.941051473727, 2382.118616112032, 2382.2614989353356, 8424.747257582283, 8450.915490845075, 8488.618012189467, 8504.659813607448, 8532.061473237938, 5112.079825631385, 5259.658122222043, 5266.973665131688, 5281.894362112736, 5285.312909321764, 3273.5908011498564, 3340.866365345383, 3477.4436090225695, 3523.6652518010746, 3541.4687796830426, 1191.5114802930757, 1206.4751832952693, 1250.1374051904156, 1251.361805479212, 1270.104576273725, 10808.351498910011, 10826.917308269189, 10882.23824332297, 10886.836697449466, 10929.945350273198, 4675.345451636774, 4722.8583142505095, 4737.28940658897, 4818.578519336804, 4828.975855120772, 9545.952270238744, 9613.0, 9642.662506812228, 9654.372465789702, 9670.56482458291, 5228.9477105229225, 5281.419043905167, 5287.68273903567, 5320.866978325495, 5340.519353258225, 4741.739204343725, 4771.856844294677, 4786.8085276589245, 4837.395325584302, 4852.102361063215, 3866.240860408507, 3935.4293627424436, 3966.801659916993, 3994.4807175067053, 4045.5145382554283, 1179.9233049851732, 1230.2741382584318, 1263.2673049631192, 1300.3173333999725, 1303.648015035935, 790.0992868130336, 851.0978362935184, 909.8271328447573, 911.9316051296179, 913.8263729891299, 5501.092319767194, 5597.888042239132, 5604.159376093618, 5625.986557992191, 5806.622569532967, 981.0924894472585, 984.4733067808688, 996.14829320931, 1004.0160642570322, 1009.0968583118068, 3701.722370822199, 3775.1317197044286, 3785.432185172191, 3795.791231482295, 3816.637419445148, 8357.958210209032, 9817.607295708092, 10143.594256229815, 10163.644272450429, 10165.695029149138, 8142.226488483585, 10077.949610251902, 10093.646722364829, 10108.898911010943, 10138.898611013796, 7573.659185336563, 7879.842403151905, 7890.723824666109, 7983.84032319362, 8036.0, 4907.3620429343955, 5612.915806262828, 5635.605507614591, 5769.653820770767, 5830.125481177857, 8966.730998070068, 9123.406978546373, 9310.767230819283, 9364.578593963424, 9397.248220142235, 9148.725538233864, 9265.629374824932, 9332.673356432764, 9482.241420686467, 9505.524723763923, 7210.315020073084, 7416.443766717625, 7446.7021319146625, 7451.627418628938, 7455.627218639155, 7737.535747855147, 7941.086775020946, 7973.282404583615, 7977.122516523294, 8015.47899386538, 7258.129024517092, 7302.5253358533655, 7332.78001659951, 7349.448791340564, 7365.410767138723, 7075.716971321295, 7161.248068952685, 7176.461765367514, 7183.964080179566, 7252.854942901218, 6410.4871610272, 6417.1657684500715, 6495.9025614614875, 6499.447546958372, 6510.414062734377, 4892.0, 4922.852314430573, 5045.268436076822, 5068.873278168076, 5171.456997015259, 4964.726940018334, 5017.079845782012, 5059.46875578059, 5227.0591293566, 5231.398389185292], "value": 4466.381756117545, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.866410115448, 357.76208821133946, 363.7617360628788, 369.1012384842908, 371.75092687899104, 4267.786610669462, 4845.825983980494, 5131.563817075548, 5327.987682340362, 5349.679019258847, 4223.472065991751, 4380.364847097177, 5333.120035194198, 5363.007843548946, 5428.321459817523, 3715.7213209009296, 3966.9801650991703, 4072.2669919414493, 4230.217409779193, 4263.5736426357425, 3555.324488347219, 3776.4524143999242, 3903.8093381518624, 4043.8584649537274, 4101.9179616407655, 4099.467069281004, 4103.548609652936, 4111.856085037024, 4118.546959834416, 4120.299549076664, 3948.802559871995, 4096.651784598283, 4103.446034785311, 4121.0, 4123.876283711494, 3070.3705740323403, 3228.6287076985977, 3502.5446691929887, 3511.9639706286707, 3513.0, 5211.635185537014, 5212.478752124795, 5227.947720522784, 5232.738363081869, 5258.0, 3506.0, 4133.966508372907, 4435.556444355539, 4612.262038073925, 4685.812567497296, 4666.160091183586, 5000.499950005007, 5345.1447768356875, 5635.886542546545, 5756.740946657411, 3266.5100234964707, 3904.39481880309, 3905.8242379092726, 3913.5303763548554, 3929.2730844793805, 5062.962222666408, 5964.254468191476, 6018.846995573041, 6041.395860413967, 6048.939510604881, 3774.96188548146, 3896.648881961511, 3950.7827069511454, 3997.8411657704514, 4005.8998525036523, 3379.867744305636, 3682.963170368262, 3967.940480892789, 4022.1955608877756, 4023.7384570002855, 4528.728276303433, 4652.55800698933, 4689.546240665405, 4715.292706094114, 4730.810767569327, 4689.882752931136, 5775.797847075416, 5780.94219057804, 5802.0, 5814.563907706939, 1273.802625531997, 1295.7732396830706, 1315.283170671986, 1321.4317843327462, 1323.5837653710437, 787.5786454246951, 865.3726048614704, 884.39860894591, 896.6908313861704, 900.3832374823266, 4363.509192645871, 4649.465311489222, 4718.811247550059, 5083.186690129562, 5128.358955130609, 5273.965416456414, 5532.97639936613, 5725.312962444534, 5758.596898217168, 5772.5670574707065, 4711.599514041276, 4831.806727730851, 4849.80600775965, 5047.596192304607, 5140.946106048251, 2651.7480839320233, 2680.0, 2786.5927706508082, 2878.7265209805037, 2991.578999975038, 5301.761420736076, 5833.562482813721, 5945.435183657545, 5949.8580511016, 5990.371011043778, 5539.889202215933, 5789.134378482678, 5796.710164491843, 5839.839259474022, 5906.025505791582, 5200.843974680765, 5493.533049690741, 5897.174395584621, 5938.228030356113, 5967.791127310524, 4466.731996080245, 4759.428868535798, 4931.852044438672, 5085.338905942203, 5378.542823860016, 5177.8187763428095, 5540.22436858832, 5618.089849451207, 5624.943750562442, 5667.376588575171, 5125.7693403796175, 5248.711320877388, 5819.214406055128, 5921.5558833086825, 5922.466977971831, 3160.5891234139413, 3381.3575420669995, 3617.155250822047, 3811.5616704078275, 3821.273957948092, 4843.418789745112, 5381.704006279536, 5525.508112809599, 5686.947914635805, 5724.763674880642, 4536.659750518658, 5007.768435671997, 5368.597355198298, 5506.072874493895, 5647.745851436777, 5006.3992320921725, 5224.03355379256, 5708.971455142698, 5725.599208055396, 5760.020796464695, 5302.840914772563, 5536.667799932017, 5553.583481239004, 5575.358833734173, 5654.378018418053, 4952.876178095432, 5414.972925135349, 5682.420075352501, 5698.914516282342, 5756.740946657326, 4657.767111644472, 5221.869453263547, 5385.549574943469, 5395.730213489232, 5620.213170156099], "value": 4064.608573713976, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.4028655499548, 703.4969996452536, 755.5693254844738, 817.0, 846.6909578004029, 14458.27708614569, 15171.92414037931, 15189.088654680727, 15205.619859503518, 15370.385184592616, 13929.721405571883, 14131.858681413183, 14147.080439771407, 14151.0, 15512.069275843458, 846.3990566697637, 854.6111519258723, 868.5961028121922, 871.0636066228798, 872.2890843962182, 853.9274161696263, 864.2394692670473, 864.5936409887343, 864.8140649760301, 866.9133086691344, 912.5756523216703, 916.8853893263342, 917.9632814687404, 918.3387960668341, 919.7470695558708, 910.713125365511, 912.5938957164065, 912.6030176873081, 912.9452232866049, 915.7985243246509, 677.1197443323659, 677.1265068062194, 677.200902934542, 677.4444955136789, 680.7651360280695, 15572.92213538925, 15582.454614088565, 15589.922050389676, 15610.0, 15631.140287284195, 13725.45098196071, 13796.931015344959, 13901.023278080258, 14057.016008879382, 14102.083364581269, 11425.657230283105, 11681.0, 11727.472263748152, 11751.823722644167, 11763.294202347886, 3608.260306637133, 3623.9637603624155, 3625.6555627215635, 3631.564212294515, 3660.084978755311, 87519.0, 106523.93476065295, 112911.43544282226, 113831.43084284608, 114494.0, 8574.699885503978, 10453.0, 10775.568977240979, 10814.89185108139, 11070.169737269736, 20431.182752689725, 21521.89239053795, 21943.451413714785, 22074.66887996681, 22481.775182248297, 7604.201558836243, 7649.617519124022, 7685.077790665156, 7950.4832185907735, 8103.716369927024, 4267.509236437787, 4276.31578947367, 4317.093410383792, 4397.07661391105, 4422.20400327944, 3580.3197392495345, 3654.524911761507, 3679.7424180307657, 3703.7222208334483, 3705.2404257127223, 588.4644973074481, 655.4134050025201, 673.0207548017622, 673.9730410783612, 675.3584095109666, 675.5913919477944, 688.4905170174035, 695.0, 697.8262711653265, 739.3530660671912, 8444.746657600283, 9802.36284641496, 10133.460249469448, 10239.897601024044, 10648.201384896163, 612.6660969771485, 660.531022973694, 678.8438659108433, 691.8339598496325, 696.1646024770296, 4499.797509112098, 5036.899262014739, 5039.170862655463, 5040.79836806531, 5057.216131499624, 77009.0, 86198.56900715457, 108213.37679934807, 110114.0, 111060.0, 77573.61213194011, 77842.0, 84389.0, 85343.14656853351, 97849.0, 47212.7639361801, 72028.2797172032, 73825.0, 75995.72012839623, 80979.5951020253, 10481.895181048092, 10700.89299106999, 10908.781824363627, 10949.726256843642, 10968.725781855517, 47889.80275493141, 48242.27636585384, 49055.0, 50295.0, 54138.45861541334, 66290.33709662841, 67561.66219168872, 71610.0, 73688.26311736814, 74502.0, 12772.936135319263, 12886.608230337595, 13002.869971300544, 13037.0, 13735.812220788892, 14027.649308766955, 14493.420263189777, 14535.41858325655, 14643.9749217558, 15068.397264109313, 13156.473741050633, 13194.868051319363, 13420.328983550979, 13857.930710346383, 13937.926040600183, 13468.730625387634, 13834.37745301484, 13868.653283667989, 13884.375203116086, 14670.926645366704, 10265.897341026493, 13277.800832987707, 13521.0, 13694.041417100707, 13826.37781299864, 11103.833442498531, 11103.888961110286, 11187.552497899993, 11701.122415818678, 11896.22674526153, 10327.225458090523, 10887.618933337295, 11029.779404412027, 11033.779324413626, 11042.889571104508], "value": 7529.659303744113, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1569.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 119.0, 119.0, 117.0, 118.0, 118.0, 121.0, 118.0, 119.0, 120.0], "value": 117.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 115.0, 114.0, 146.0, 109.0, 150.0, 135.0, 134.0, 129.0, 144.0], "value": 132.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 204.0, 232.0, 267.0, 198.0, 204.0, 189.0, 200.0, 199.0, 230.0], "value": 212.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 62.0, 63.0, 89.0, 59.0, 61.0, 83.0, 80.0, 74.0, 60.0], "value": 71.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 71.0, 85.0, 72.0, 73.0, 93.0, 116.0, 104.0, 80.0, 82.0], "value": 86.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 111.0, 89.0, 104.0, 105.0, 87.0, 79.0, 132.0, 136.0, 85.0], "value": 106.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 96.0, 96.0, 124.0, 154.0, 95.0, 96.0, 97.0, 102.0, 150.0], "value": 116.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 146.0, 145.0, 94.0, 92.0, 91.0, 94.0, 94.0, 92.0, 103.0], "value": 103.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 59.0, 59.0, 60.0, 60.0, 59.0, 59.0, 61.0], "value": 58.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 76.0, 71.0, 88.0, 109.0, 104.0, 74.0, 74.0, 73.0, 73.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 86.0, 83.0, 86.0, 88.0, 86.0, 83.0, 91.0, 106.0], "value": 88.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 165.0, 150.0, 151.0, 160.0, 148.0, 142.0, 139.0, 186.0, 160.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 173.0, 168.0, 202.0, 190.0, 170.0, 151.0, 171.0, 157.0, 152.0], "value": 170.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 65.0, 75.0, 68.0, 68.0, 65.0, 66.0, 67.0, 67.0, 64.0], "value": 67.6, "unit": "score"}]}]} 20:21:48 INFO - Return code: 0 20:21:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:21:48 ERROR - # TBPL SUCCESS # 20:21:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:21:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:21:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:21:48 INFO - 2017-02-09 20:21:48.349 screenresolution[2178:25160] starting screenresolution argv=screenresolution get 20:21:48 INFO - 2017-02-09 20:21:48.351 screenresolution[2178:25160] Display 0: 1600x1200x32@60 20:21:48 INFO - 2017-02-09 20:21:48.358 screenresolution[2179:25163] starting screenresolution argv=screenresolution list 20:21:48 INFO - Available Modes on Display 0 20:21:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:21:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:21:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:21:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:21:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:21:48 INFO - Intel Iris: 20:21:48 INFO - Chipset Model: Intel Iris 20:21:48 INFO - Type: GPU 20:21:48 INFO - Bus: Built-In 20:21:48 INFO - VRAM (Dynamic, Max): 1536 MB 20:21:48 INFO - Vendor: Intel (0x8086) 20:21:48 INFO - Device ID: 0x0a2e 20:21:48 INFO - Revision ID: 0x0009 20:21:48 INFO - Displays: 20:21:48 INFO - Display: 20:21:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:21:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:21:48 INFO - Display Serial Number: 1600x1200 60 20:21:48 INFO - Main Display: Yes 20:21:48 INFO - Mirror: Off 20:21:48 INFO - Online: Yes 20:21:48 INFO - Rotation: Supported 20:21:48 INFO - Return code: 0 20:21:48 INFO - Running post-action listener: _resource_record_post_action 20:21:48 INFO - [mozharness: 2017-02-10 04:21:48.590132Z] Finished run-tests step (success) 20:21:48 INFO - Running post-run listener: _resource_record_post_run 20:21:48 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 2383872; Write bytes: 510105600; Read time: 11; Write time: 1772 20:21:48 INFO - TinderboxPrint: CPU usage
54.1% 20:21:48 INFO - TinderboxPrint: I/O read bytes / time
2,383,872 / 11 20:21:48 INFO - TinderboxPrint: I/O write bytes / time
510,105,600 / 1,772 20:21:48 INFO - TinderboxPrint: CPU idle
2,199.1 (45.9%) 20:21:48 INFO - TinderboxPrint: CPU system
961.2 (20.1%) 20:21:48 INFO - TinderboxPrint: CPU user
1,633.3 (34.1%) 20:21:48 INFO - TinderboxPrint: Swap in / out
209,416,192 / 0 20:21:48 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207231488; Write bytes: 201512448; Read time: 15943; Write time: 450 20:21:48 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 16384; Write bytes: 297554432; Read time: 1; Write time: 1285 20:21:49 INFO - Running post-run listener: _upload_blobber_files 20:21:49 INFO - Blob upload gear active. 20:21:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:21:49 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 20:21:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:21:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:21:49 INFO - (blobuploader) - INFO - Open directory for files ... 20:21:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:21:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:21:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:21:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:21:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:21:50 INFO - (blobuploader) - INFO - Done attempting. 20:21:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:21:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:21:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:21:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:21:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:21:51 INFO - (blobuploader) - INFO - Done attempting. 20:21:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:21:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:21:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:21:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:21:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:21:52 INFO - (blobuploader) - INFO - Done attempting. 20:21:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:21:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:21:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:21:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:21:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:21:54 INFO - (blobuploader) - INFO - Done attempting. 20:21:54 INFO - (blobuploader) - INFO - Iteration through files over. 20:21:54 INFO - Return code: 0 20:21:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:21:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:21:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a409aed1431cf75b6a464293ba3e8f6b6cf66585cb829fdbaad71b40f135eda8bddede8056ee79320045640ff11b943c7c5a62d00b230e7eb895dc60c8bb240e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/635dadf5102bb275e46a35e1901c2e3c22f73dd5e7a223c7b85a12e67d2bb4bb547d3bb87edc4d8496afa6c65e679e5ba19242fa540c6a316325158e38455502", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4c3817fa34cb261c6861fd1b1fdaa43fd1f43682b33b96a98910615e667dcd87eb9f08a7ae303260dd81734fa583ecd286acd4665e8dcc8186b69650282539b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/caa3395211f63ae622506e3bb34557e9522b1cee68b17b3b47160e2aada83c45b82e2ae003a7b858a1734dd9b02b22d4ad862db7b42f87d7c49799665e88368d"} 20:21:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:21:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:21:54 INFO - Contents: 20:21:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a409aed1431cf75b6a464293ba3e8f6b6cf66585cb829fdbaad71b40f135eda8bddede8056ee79320045640ff11b943c7c5a62d00b230e7eb895dc60c8bb240e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/635dadf5102bb275e46a35e1901c2e3c22f73dd5e7a223c7b85a12e67d2bb4bb547d3bb87edc4d8496afa6c65e679e5ba19242fa540c6a316325158e38455502", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4c3817fa34cb261c6861fd1b1fdaa43fd1f43682b33b96a98910615e667dcd87eb9f08a7ae303260dd81734fa583ecd286acd4665e8dcc8186b69650282539b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/caa3395211f63ae622506e3bb34557e9522b1cee68b17b3b47160e2aada83c45b82e2ae003a7b858a1734dd9b02b22d4ad862db7b42f87d7c49799665e88368d"} 20:21:54 INFO - Running post-run listener: copy_logs_to_upload_dir 20:21:54 INFO - Copying logs to upload dir... 20:21:54 INFO - mkdir: /builds/slave/test/build/upload/logs 20:21:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.905619 ========= master_lag: 3.03 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-09 20:21:57.474671) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 20:21:57.478032) ========= 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.rMAtioew4e/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.l2kopoFxMS/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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/Mozilla-Aurora/sha512/a409aed1431cf75b6a464293ba3e8f6b6cf66585cb829fdbaad71b40f135eda8bddede8056ee79320045640ff11b943c7c5a62d00b230e7eb895dc60c8bb240e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/635dadf5102bb275e46a35e1901c2e3c22f73dd5e7a223c7b85a12e67d2bb4bb547d3bb87edc4d8496afa6c65e679e5ba19242fa540c6a316325158e38455502", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4c3817fa34cb261c6861fd1b1fdaa43fd1f43682b33b96a98910615e667dcd87eb9f08a7ae303260dd81734fa583ecd286acd4665e8dcc8186b69650282539b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/caa3395211f63ae622506e3bb34557e9522b1cee68b17b3b47160e2aada83c45b82e2ae003a7b858a1734dd9b02b22d4ad862db7b42f87d7c49799665e88368d"} build_url:https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011512 build_url: 'https://queue.taskcluster.net/v1/task/ZpeuP9nWQ2mOrKOb-0s7og/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a409aed1431cf75b6a464293ba3e8f6b6cf66585cb829fdbaad71b40f135eda8bddede8056ee79320045640ff11b943c7c5a62d00b230e7eb895dc60c8bb240e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/635dadf5102bb275e46a35e1901c2e3c22f73dd5e7a223c7b85a12e67d2bb4bb547d3bb87edc4d8496afa6c65e679e5ba19242fa540c6a316325158e38455502", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4c3817fa34cb261c6861fd1b1fdaa43fd1f43682b33b96a98910615e667dcd87eb9f08a7ae303260dd81734fa583ecd286acd4665e8dcc8186b69650282539b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/caa3395211f63ae622506e3bb34557e9522b1cee68b17b3b47160e2aada83c45b82e2ae003a7b858a1734dd9b02b22d4ad862db7b42f87d7c49799665e88368d"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 20:21:57.517346) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 20:21:57.517693) ========= 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.rMAtioew4e/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.l2kopoFxMS/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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.005256 ========= master_lag: 0.44 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 20:21:57.959926) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 20:21:57.960235) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 20:21:57.961256) ========= ========= Total master_lag: 4.61 =========