builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0126 starttime: 1492211904.38 results: success (0) buildid: 20170414145415 builduid: 75d0e3fa11d8498e93e7b46cf08c7514 revision: d09143959b1af76d12d4429e92b1cd07544d0bef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-14 16:18:24.384241) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-14 16:18:24.385251) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-14 16:18:24.385828) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-14 16:18:24.414453) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-14 16:18:24.414851) ========= 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.XNMTO2NpYh/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.JemVZzxMX5/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-14 16:18:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 71.3M=0s 2017-04-14 16:18:24 (71.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.141537 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-14 16:18:24.583264) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-14 16:18:24.583846) ========= 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.XNMTO2NpYh/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.JemVZzxMX5/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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.038139 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-14 16:18:24.647449) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-14 16:18:24.648090) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d09143959b1af76d12d4429e92b1cd07544d0bef --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d09143959b1af76d12d4429e92b1cd07544d0bef --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XNMTO2NpYh/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.JemVZzxMX5/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-14 16:18:24,761 truncating revision to first 12 chars 2017-04-14 16:18:24,762 Setting DEBUG logging. 2017-04-14 16:18:24,762 attempt 1/10 2017-04-14 16:18:24,762 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d09143959b1a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-14 16:18:25,498 unpacking tar archive at: mozilla-central-d09143959b1a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.004450 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-14 16:18:25.680100) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-14 16:18:25.680714) ========= script_repo_revision: d09143959b1af76d12d4429e92b1cd07544d0bef ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-14 16:18:25.681464) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-14 16:18:25.681999) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-14 16:18:25.703623) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-14 16:18:25.704078) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XNMTO2NpYh/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.JemVZzxMX5/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 16:18:25 INFO - MultiFileLogger online at 20170414 16:18:25 in /builds/slave/test 16:18:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:18:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:18:25 INFO - {'append_to_log': False, 16:18:25 INFO - 'base_work_dir': '/builds/slave/test', 16:18:25 INFO - 'blob_upload_branch': 'Firefox', 16:18:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:18:25 INFO - 'branch': 'Firefox', 16:18:25 INFO - 'buildbot_json_path': 'buildprops.json', 16:18:25 INFO - 'config_files': ('talos/mac_config.py',), 16:18:25 INFO - 'default_actions': ('clobber', 16:18:25 INFO - 'read-buildbot-config', 16:18:25 INFO - 'download-and-extract', 16:18:25 INFO - 'populate-webroot', 16:18:25 INFO - 'create-virtualenv', 16:18:25 INFO - 'install', 16:18:25 INFO - 'run-tests'), 16:18:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:18:25 INFO - 'download_minidump_stackwalk': True, 16:18:25 INFO - 'download_symbols': 'ondemand', 16:18:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:18:25 INFO - 'tooltool.py': '/tools/tooltool.py', 16:18:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:18:25 INFO - '/tools/misc-python/virtualenv.py')}, 16:18:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:18:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:18:25 INFO - 'gecko_profile': False, 16:18:25 INFO - 'gecko_profile_interval': 0, 16:18:25 INFO - 'installer_path': 'installer.exe', 16:18:25 INFO - 'log_level': 'info', 16:18:25 INFO - 'log_name': 'talos', 16:18:25 INFO - 'log_to_console': True, 16:18:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:18:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:18:25 INFO - 'opt_config_files': (), 16:18:25 INFO - 'pip_index': False, 16:18:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:18:25 INFO - 'cmd': ('bash', 16:18:25 INFO - '-c', 16:18:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:18:25 INFO - 'enabled': True, 16:18:25 INFO - 'halt_on_failure': False, 16:18:25 INFO - 'name': 'check_screen_resolution'},), 16:18:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:18:25 INFO - 'cmd': ('bash', 16:18:25 INFO - '-c', 16:18:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:18:25 INFO - 'enabled': True, 16:18:25 INFO - 'halt_on_failure': False, 16:18:25 INFO - 'name': 'check_screen_resolution'},), 16:18:25 INFO - 'run_cmd_checks_enabled': True, 16:18:25 INFO - 'suite': 'dromaeojs-e10s', 16:18:25 INFO - 'system_bits': '32', 16:18:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:18:25 INFO - 'title': 't-yosemite-r7-0126', 16:18:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:18:25 INFO - 'use_talos_json': True, 16:18:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:18:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:18:25 INFO - 'work_dir': 'build'} 16:18:25 INFO - [mozharness: 2017-04-14 23:18:25.928663Z] Running clobber step. 16:18:25 INFO - Running pre-action listener: _resource_record_pre_action 16:18:25 INFO - Running main action method: clobber 16:18:25 INFO - rmtree: /builds/slave/test/build 16:18:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:18:28 INFO - Running post-action listener: _resource_record_post_action 16:18:28 INFO - [mozharness: 2017-04-14 23:18:28.678402Z] Finished clobber step (success) 16:18:28 INFO - [mozharness: 2017-04-14 23:18:28.678568Z] Running read-buildbot-config step. 16:18:28 INFO - Running pre-action listener: _resource_record_pre_action 16:18:28 INFO - Running main action method: read_buildbot_config 16:18:28 INFO - Using buildbot properties: 16:18:28 INFO - { 16:18:28 INFO - "project": "", 16:18:28 INFO - "product": "firefox", 16:18:28 INFO - "script_repo_revision": "production", 16:18:28 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 16:18:28 INFO - "repository": "", 16:18:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 16:18:28 INFO - "buildid": "20170414145415", 16:18:28 INFO - "pgo_build": "False", 16:18:28 INFO - "basedir": "/builds/slave/test", 16:18:28 INFO - "buildnumber": 34, 16:18:28 INFO - "slavename": "t-yosemite-r7-0126", 16:18:28 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 16:18:28 INFO - "platform": "yosemite_r7", 16:18:28 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 16:18:28 INFO - "branch": "mozilla-central", 16:18:28 INFO - "repo_path": "mozilla-central", 16:18:28 INFO - "revision": "d09143959b1af76d12d4429e92b1cd07544d0bef", 16:18:28 INFO - "stage_platform": "macosx64", 16:18:28 INFO - "builduid": "75d0e3fa11d8498e93e7b46cf08c7514", 16:18:28 INFO - "slavebuilddir": "test" 16:18:28 INFO - } 16:18:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/TQa6C1WRT8qIuD6UvE3O5g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 16:18:28 INFO - Running post-action listener: _resource_record_post_action 16:18:28 INFO - [mozharness: 2017-04-14 23:18:28.681864Z] Finished read-buildbot-config step (success) 16:18:28 INFO - [mozharness: 2017-04-14 23:18:28.681990Z] Running download-and-extract step. 16:18:28 INFO - Running pre-action listener: _resource_record_pre_action 16:18:28 INFO - Running main action method: download_and_extract 16:18:28 INFO - mkdir: /builds/slave/test/build/tests 16:18:28 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')]} 16:18:28 INFO - trying https://queue.taskcluster.net/v1/task/TQa6C1WRT8qIuD6UvE3O5g/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 16:18:28 INFO - Downloading https://queue.taskcluster.net/v1/task/TQa6C1WRT8qIuD6UvE3O5g/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 16:18:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TQa6C1WRT8qIuD6UvE3O5g/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 16:18:29 INFO - Downloaded 1325 bytes. 16:18:29 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 16:18:29 INFO - Using the following test package requirements: 16:18:29 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:18:29 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 16:18:29 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 16:18:29 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:18:29 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 16:18:29 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:18:29 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 16:18:29 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:18:29 INFO - u'jsshell-mac.zip'], 16:18:29 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:18:29 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 16:18:29 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 16:18:29 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:18:29 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 16:18:29 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:18:29 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 16:18:29 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:18:29 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 16:18:29 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:18:29 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 16:18:29 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:18:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TQa6C1WRT8qIuD6UvE3O5g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 16:18:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TQa6C1WRT8qIuD6UvE3O5g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:18:29 INFO - Fetch https://queue.taskcluster.net/v1/task/TQa6C1WRT8qIuD6UvE3O5g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 16:18:31 INFO - Expected file size: 52597342 16:18:31 INFO - Obtained file size: 52597342 16:18:47 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:18:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TQa6C1WRT8qIuD6UvE3O5g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 16:18:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TQa6C1WRT8qIuD6UvE3O5g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:18:47 INFO - Fetch https://queue.taskcluster.net/v1/task/TQa6C1WRT8qIuD6UvE3O5g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 16:18:49 INFO - Expected file size: 52597342 16:18:49 INFO - Obtained file size: 52597342 16:19:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TQa6C1WRT8qIuD6UvE3O5g/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 16:19:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TQa6C1WRT8qIuD6UvE3O5g/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:19:05 INFO - Fetch https://queue.taskcluster.net/v1/task/TQa6C1WRT8qIuD6UvE3O5g/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 16:19:06 INFO - Expected file size: 14408853 16:19:06 INFO - Obtained file size: 14408853 16:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:06 INFO - trying https://queue.taskcluster.net/v1/task/TQa6C1WRT8qIuD6UvE3O5g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:19:06 INFO - Downloading https://queue.taskcluster.net/v1/task/TQa6C1WRT8qIuD6UvE3O5g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 16:19:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TQa6C1WRT8qIuD6UvE3O5g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 16:19:08 INFO - Downloaded 71106369 bytes. 16:19:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TQa6C1WRT8qIuD6UvE3O5g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:19:08 INFO - mkdir: /builds/slave/test/properties 16:19:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:19:08 INFO - Writing to file /builds/slave/test/properties/build_url 16:19:08 INFO - Contents: 16:19:08 INFO - build_url:https://queue.taskcluster.net/v1/task/TQa6C1WRT8qIuD6UvE3O5g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:19:09 INFO - Running post-action listener: _resource_record_post_action 16:19:09 INFO - Running post-action listener: set_extra_try_arguments 16:19:09 INFO - [mozharness: 2017-04-14 23:19:09.662196Z] Finished download-and-extract step (success) 16:19:09 INFO - [mozharness: 2017-04-14 23:19:09.662319Z] Running populate-webroot step. 16:19:09 INFO - Running pre-action listener: _resource_record_pre_action 16:19:09 INFO - Running main action method: populate_webroot 16:19:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:19:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:19:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:19:09 INFO - '--tppagecycles', 16:19:09 INFO - '7'], 16:19:09 INFO - 'tests': ['tsvgm']}}, 16:19:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:19:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:19:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:19:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:19:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:19:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:19:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:19:09 INFO - 'talos_options': ['--disable-e10s'], 16:19:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:19:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:19:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:19:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:19:09 INFO - 'talos_options': ['--disable-e10s'], 16:19:09 INFO - 'tests': ['damp', 'tps']}, 16:19:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:19:09 INFO - 'tests': ['damp', 'tps']}, 16:19:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:19:09 INFO - 'tests': ['dromaeo_dom']}, 16:19:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:19:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:19:09 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:19:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:19:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:19:09 INFO - 'tests': ['a11yr', 16:19:09 INFO - 'ts_paint', 16:19:09 INFO - 'tpaint', 16:19:09 INFO - 'sessionrestore', 16:19:09 INFO - 'sessionrestore_no_auto_restore', 16:19:09 INFO - 'tabpaint']}, 16:19:09 INFO - 'other-e10s': {'tests': ['a11yr', 16:19:09 INFO - 'ts_paint', 16:19:09 INFO - 'tpaint', 16:19:09 INFO - 'sessionrestore', 16:19:09 INFO - 'sessionrestore_no_auto_restore', 16:19:09 INFO - 'tabpaint']}, 16:19:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:19:09 INFO - 'ts_paint', 16:19:09 INFO - 'tpaint', 16:19:09 INFO - 'sessionrestore', 16:19:09 INFO - 'sessionrestore_no_auto_restore', 16:19:09 INFO - 'tabpaint']}, 16:19:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:19:09 INFO - 'ts_paint', 16:19:09 INFO - 'tpaint', 16:19:09 INFO - 'sessionrestore', 16:19:09 INFO - 'sessionrestore_no_auto_restore', 16:19:09 INFO - 'tabpaint']}, 16:19:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:19:09 INFO - 'tests': ['a11yr', 16:19:09 INFO - 'ts_paint', 16:19:09 INFO - 'tpaint', 16:19:09 INFO - 'sessionrestore', 16:19:09 INFO - 'sessionrestore_no_auto_restore', 16:19:09 INFO - 'tabpaint']}, 16:19:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:19:09 INFO - 'tests': ['a11yr', 16:19:09 INFO - 'ts_paint', 16:19:09 INFO - 'tpaint', 16:19:09 INFO - 'sessionrestore', 16:19:09 INFO - 'sessionrestore_no_auto_restore', 16:19:09 INFO - 'tabpaint']}, 16:19:09 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 16:19:09 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 16:19:09 INFO - 'bloom_basic_ref']}, 16:19:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:19:09 INFO - 'tests': ['tsvgx', 16:19:09 INFO - 'tsvgr_opacity', 16:19:09 INFO - 'tart', 16:19:09 INFO - 'tscrollx', 16:19:09 INFO - 'cart', 16:19:09 INFO - 'tsvg_static']}, 16:19:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:19:09 INFO - 'tsvgr_opacity', 16:19:09 INFO - 'tart', 16:19:09 INFO - 'tscrollx', 16:19:09 INFO - 'cart', 16:19:09 INFO - 'tsvg_static']}, 16:19:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:19:09 INFO - 'talos_options': ['--disable-e10s'], 16:19:09 INFO - 'tests': ['tp5o']}, 16:19:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:19:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:19:09 INFO - 'talos_options': ['--disable-e10s', 16:19:09 INFO - '--xperf_path', 16:19:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:19:09 INFO - 'tests': ['tp5n']}, 16:19:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:19:09 INFO - 'talos_options': ['--xperf_path', 16:19:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:19:09 INFO - 'tests': ['tp5n']}}, 16:19:09 INFO - 'talos.zip': {'path': '', 16:19:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:19:09 INFO - Running post-action listener: _resource_record_post_action 16:19:09 INFO - [mozharness: 2017-04-14 23:19:09.680895Z] Finished populate-webroot step (success) 16:19:09 INFO - [mozharness: 2017-04-14 23:19:09.681024Z] Running create-virtualenv step. 16:19:09 INFO - Running pre-action listener: _resource_record_pre_action 16:19:09 INFO - Running main action method: create_virtualenv 16:19:09 INFO - Creating virtualenv /builds/slave/test/build/venv 16:19:09 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 16:19:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:19:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:19:09 INFO - Using real prefix '/tools/python27' 16:19:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:19:10 INFO - Installing distribute.............................................................................................................................................................................................done. 16:19:13 INFO - Installing pip.................done. 16:19:13 INFO - Return code: 0 16:19:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:19:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:19:13 INFO - Reading from file tmpfile_stdout 16:19:13 INFO - Output received: 16:19:13 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) 16:19:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:19:13 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')]} 16:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:13 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')]} 16:19:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:13 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 0x10b31fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b322768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbda4cece0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0fdd30>, '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 0x10b023db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0f2be8>, '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.XNMTO2NpYh/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.JemVZzxMX5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 16:19:13 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 16:19:13 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 16:19:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XNMTO2NpYh/Render', 16:19:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:13 INFO - 'HOME': '/Users/cltbld', 16:19:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:13 INFO - 'LOGNAME': 'cltbld', 16:19:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:13 INFO - 'MOZ_NO_REMOTE': '1', 16:19:13 INFO - 'NO_EM_RESTART': '1', 16:19:13 INFO - 'PAGER': '/bin/cat', 16:19:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:13 INFO - 'PWD': '/builds/slave/test', 16:19:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:13 INFO - 'SHELL': '/bin/bash', 16:19:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JemVZzxMX5/Listeners', 16:19:13 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 16:19:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:13 INFO - 'USER': 'cltbld', 16:19:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:13 INFO - 'XPC_FLAGS': '0x0', 16:19:13 INFO - 'XPC_SERVICE_NAME': '0', 16:19:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:13 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 16:19:13 INFO - Cleaning up... 16:19:13 INFO - Return code: 0 16:19:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:19:13 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')]} 16:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:13 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')]} 16:19:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:13 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 0x10b31fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b322768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbda4cece0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0fdd30>, '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 0x10b023db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0f2be8>, '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.XNMTO2NpYh/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.JemVZzxMX5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 16:19:13 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 16:19:13 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 16:19:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XNMTO2NpYh/Render', 16:19:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:13 INFO - 'HOME': '/Users/cltbld', 16:19:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:13 INFO - 'LOGNAME': 'cltbld', 16:19:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:13 INFO - 'MOZ_NO_REMOTE': '1', 16:19:13 INFO - 'NO_EM_RESTART': '1', 16:19:13 INFO - 'PAGER': '/bin/cat', 16:19:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:13 INFO - 'PWD': '/builds/slave/test', 16:19:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:13 INFO - 'SHELL': '/bin/bash', 16:19:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JemVZzxMX5/Listeners', 16:19:13 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 16:19:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:13 INFO - 'USER': 'cltbld', 16:19:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:13 INFO - 'XPC_FLAGS': '0x0', 16:19:13 INFO - 'XPC_SERVICE_NAME': '0', 16:19:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:14 INFO - Downloading/unpacking psutil>=3.1.1 16:19:14 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 16:19:14 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 16:19:14 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 16:19:14 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 16:19:14 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 16:19:14 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 16:19:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:19:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:19:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:19:17 INFO - Installing collected packages: psutil 16:19:17 INFO - Running setup.py install for psutil 16:19:17 INFO - building 'psutil._psutil_osx' extension 16:19:17 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 16:19:18 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 16:19:18 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 16:19:18 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 16:19:18 INFO - building 'psutil._psutil_posix' extension 16:19:18 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 16:19:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:19:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:19:18 INFO - ^ 16:19:18 INFO - 1 warning generated. 16:19:18 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 16:19:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:19:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:19:18 INFO - Successfully installed psutil 16:19:18 INFO - Cleaning up... 16:19:19 INFO - Return code: 0 16:19:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:19:19 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')]} 16:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:19 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')]} 16:19:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:19 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 0x10b31fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b322768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbda4cece0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0fdd30>, '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 0x10b023db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0f2be8>, '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.XNMTO2NpYh/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.JemVZzxMX5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 16:19:19 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 16:19:19 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 16:19:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XNMTO2NpYh/Render', 16:19:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:19 INFO - 'HOME': '/Users/cltbld', 16:19:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:19 INFO - 'LOGNAME': 'cltbld', 16:19:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:19 INFO - 'MOZ_NO_REMOTE': '1', 16:19:19 INFO - 'NO_EM_RESTART': '1', 16:19:19 INFO - 'PAGER': '/bin/cat', 16:19:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:19 INFO - 'PWD': '/builds/slave/test', 16:19:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:19 INFO - 'SHELL': '/bin/bash', 16:19:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JemVZzxMX5/Listeners', 16:19:19 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 16:19:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:19 INFO - 'USER': 'cltbld', 16:19:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:19 INFO - 'XPC_FLAGS': '0x0', 16:19:19 INFO - 'XPC_SERVICE_NAME': '0', 16:19:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:19:20 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 16:19:20 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 16:19:20 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 16:19:20 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 16:19:20 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 16:19:20 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 16:19:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:19:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:19:23 INFO - Installing collected packages: mozsystemmonitor 16:19:23 INFO - Running setup.py install for mozsystemmonitor 16:19:23 INFO - Successfully installed mozsystemmonitor 16:19:23 INFO - Cleaning up... 16:19:23 INFO - Return code: 0 16:19:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:19:23 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')]} 16:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:23 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')]} 16:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:23 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 0x10b31fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b322768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbda4cece0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0fdd30>, '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 0x10b023db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0f2be8>, '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.XNMTO2NpYh/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.JemVZzxMX5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 16:19:23 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 16:19:23 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 16:19:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XNMTO2NpYh/Render', 16:19:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:23 INFO - 'HOME': '/Users/cltbld', 16:19:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:23 INFO - 'LOGNAME': 'cltbld', 16:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:23 INFO - 'MOZ_NO_REMOTE': '1', 16:19:23 INFO - 'NO_EM_RESTART': '1', 16:19:23 INFO - 'PAGER': '/bin/cat', 16:19:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:23 INFO - 'PWD': '/builds/slave/test', 16:19:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:23 INFO - 'SHELL': '/bin/bash', 16:19:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JemVZzxMX5/Listeners', 16:19:23 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 16:19:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:23 INFO - 'USER': 'cltbld', 16:19:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:23 INFO - 'XPC_FLAGS': '0x0', 16:19:23 INFO - 'XPC_SERVICE_NAME': '0', 16:19:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:23 INFO - Downloading/unpacking jsonschema==2.5.1 16:19:23 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 16:19:23 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 16:19:23 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 16:19:23 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 16:19:23 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 16:19:23 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 16:19:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:19:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:19: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 16:19: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 16:19: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 16:19: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 16:19: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 16:19: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 16:19:26 INFO - Downloading functools32-3.2.3-2.tar.gz 16:19:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:19:27 INFO - warning: no files found matching '*.txt' 16:19:27 INFO - no previously-included directories found matching 'build' 16:19:27 INFO - no previously-included directories found matching 'dist' 16:19:27 INFO - no previously-included directories found matching '.git*' 16:19:27 INFO - Installing collected packages: jsonschema, functools32 16:19:27 INFO - Running setup.py install for functools32 16:19:27 INFO - warning: no files found matching '*.txt' 16:19:27 INFO - no previously-included directories found matching 'build' 16:19:27 INFO - no previously-included directories found matching 'dist' 16:19:27 INFO - no previously-included directories found matching '.git*' 16:19:27 INFO - Successfully installed jsonschema functools32 16:19:27 INFO - Cleaning up... 16:19:27 INFO - Return code: 0 16:19:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:19:27 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')]} 16:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:27 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')]} 16:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:27 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 0x10b31fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b322768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbda4cece0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0fdd30>, '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 0x10b023db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0f2be8>, '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.XNMTO2NpYh/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.JemVZzxMX5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 16:19:27 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 16:19:27 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 16:19:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XNMTO2NpYh/Render', 16:19:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:27 INFO - 'HOME': '/Users/cltbld', 16:19:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:27 INFO - 'LOGNAME': 'cltbld', 16:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:27 INFO - 'MOZ_NO_REMOTE': '1', 16:19:27 INFO - 'NO_EM_RESTART': '1', 16:19:27 INFO - 'PAGER': '/bin/cat', 16:19:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:27 INFO - 'PWD': '/builds/slave/test', 16:19:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:27 INFO - 'SHELL': '/bin/bash', 16:19:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JemVZzxMX5/Listeners', 16:19:27 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 16:19:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:27 INFO - 'USER': 'cltbld', 16:19:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:27 INFO - 'XPC_FLAGS': '0x0', 16:19:27 INFO - 'XPC_SERVICE_NAME': '0', 16:19:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:19:27 INFO - Cleaning up... 16:19:27 INFO - Return code: 0 16:19:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:19:27 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')]} 16:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:27 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')]} 16:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:27 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 0x10b31fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b322768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbda4cece0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0fdd30>, '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 0x10b023db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0f2be8>, '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.XNMTO2NpYh/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.JemVZzxMX5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 16:19:27 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 16:19:27 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 16:19:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XNMTO2NpYh/Render', 16:19:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:27 INFO - 'HOME': '/Users/cltbld', 16:19:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:27 INFO - 'LOGNAME': 'cltbld', 16:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:27 INFO - 'MOZ_NO_REMOTE': '1', 16:19:27 INFO - 'NO_EM_RESTART': '1', 16:19:27 INFO - 'PAGER': '/bin/cat', 16:19:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:27 INFO - 'PWD': '/builds/slave/test', 16:19:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:27 INFO - 'SHELL': '/bin/bash', 16:19:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JemVZzxMX5/Listeners', 16:19:27 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 16:19:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:27 INFO - 'USER': 'cltbld', 16:19:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:27 INFO - 'XPC_FLAGS': '0x0', 16:19:27 INFO - 'XPC_SERVICE_NAME': '0', 16:19:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:27 INFO - Downloading/unpacking blobuploader==1.2.4 16:19:27 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 16:19:27 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 16:19:27 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 16:19:27 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 16:19:27 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 16:19:27 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 16:19:30 INFO - Downloading blobuploader-1.2.4.tar.gz 16:19:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:19:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:19: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 16:19: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 16:19: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 16:19: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 16:19: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 16:19: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 16:19:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:19:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:31 INFO - Downloading docopt-0.6.1.tar.gz 16:19:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:19:31 INFO - Installing collected packages: blobuploader, requests, docopt 16:19:31 INFO - Running setup.py install for blobuploader 16:19:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:19:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:19:32 INFO - Running setup.py install for requests 16:19:32 INFO - Running setup.py install for docopt 16:19:32 INFO - Successfully installed blobuploader requests docopt 16:19:32 INFO - Cleaning up... 16:19:32 INFO - Return code: 0 16:19:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:32 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 0x10b31fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b322768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbda4cece0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0fdd30>, '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 0x10b023db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0f2be8>, '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.XNMTO2NpYh/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.JemVZzxMX5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 16:19:32 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 16:19:32 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 16:19:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XNMTO2NpYh/Render', 16:19:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:32 INFO - 'HOME': '/Users/cltbld', 16:19:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:32 INFO - 'LOGNAME': 'cltbld', 16:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:32 INFO - 'MOZ_NO_REMOTE': '1', 16:19:32 INFO - 'NO_EM_RESTART': '1', 16:19:32 INFO - 'PAGER': '/bin/cat', 16:19:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:32 INFO - 'PWD': '/builds/slave/test', 16:19:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:32 INFO - 'SHELL': '/bin/bash', 16:19:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JemVZzxMX5/Listeners', 16:19:32 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 16:19:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:32 INFO - 'USER': 'cltbld', 16:19:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:32 INFO - 'XPC_FLAGS': '0x0', 16:19:32 INFO - 'XPC_SERVICE_NAME': '0', 16:19:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:19:33 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-0FQUcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:19:33 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-uEOiOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:19:33 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-a52RXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:19:33 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-B6Ihas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:19:33 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-K4n0Yl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:19:33 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-asDCD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:19:33 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-FPuXVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:19:33 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-wwxT9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:19:33 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-6HAxsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:19:34 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-SrqRsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:19:34 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-P2zkdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:19:34 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-3tqxg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:19:34 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-JFf3zA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:19:34 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-52_izw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:34 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-VkToou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:19:34 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-jC7Brk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:19:34 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-ke7sdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:19:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:19:34 INFO - Running setup.py install for manifestparser 16:19:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:19:35 INFO - Running setup.py install for mozcrash 16:19:35 INFO - Running setup.py install for mozdebug 16:19:35 INFO - Running setup.py install for mozdevice 16:19:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:19:35 INFO - Running setup.py install for mozfile 16:19:35 INFO - Running setup.py install for mozhttpd 16:19:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:19:35 INFO - Running setup.py install for mozinfo 16:19:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:19:35 INFO - Running setup.py install for mozInstall 16:19:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:19:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:19:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:19:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:19:36 INFO - Running setup.py install for mozleak 16:19:36 INFO - Running setup.py install for mozlog 16:19:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:19:36 INFO - Running setup.py install for moznetwork 16:19:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:19:36 INFO - Running setup.py install for mozprocess 16:19:36 INFO - Running setup.py install for mozprofile 16:19:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:19:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:19:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:19:36 INFO - Running setup.py install for mozrunner 16:19:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:19:37 INFO - Running setup.py install for mozscreenshot 16:19:37 INFO - Running setup.py install for moztest 16:19:37 INFO - Running setup.py install for mozversion 16:19:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:19:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:19:37 INFO - Cleaning up... 16:19:37 INFO - Return code: 0 16:19:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:37 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 0x10b31fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b322768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbda4cece0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0fdd30>, '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 0x10b023db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0f2be8>, '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.XNMTO2NpYh/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.JemVZzxMX5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 16:19:37 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 16:19:37 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 16:19:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XNMTO2NpYh/Render', 16:19:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:37 INFO - 'HOME': '/Users/cltbld', 16:19:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:37 INFO - 'LOGNAME': 'cltbld', 16:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:37 INFO - 'MOZ_NO_REMOTE': '1', 16:19:37 INFO - 'NO_EM_RESTART': '1', 16:19:37 INFO - 'PAGER': '/bin/cat', 16:19:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:37 INFO - 'PWD': '/builds/slave/test', 16:19:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:37 INFO - 'SHELL': '/bin/bash', 16:19:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JemVZzxMX5/Listeners', 16:19:37 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 16:19:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:37 INFO - 'USER': 'cltbld', 16:19:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:37 INFO - 'XPC_FLAGS': '0x0', 16:19:37 INFO - 'XPC_SERVICE_NAME': '0', 16:19:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:19:37 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-BuC7TD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:19:37 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)) 16:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:19:37 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-O1v_C3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:19:37 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)) 16:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:19:37 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-E1m60r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:19:38 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)) 16:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:19:38 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-kK2b6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:19:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:19:38 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-lgmokm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:19:38 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)) 16:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:19:38 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-gs_neb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:19:38 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)) 16:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:19:38 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-zl3mHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:19:38 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)) 16:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:19:38 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-Yo5lgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:19:38 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)) 16:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:19:38 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-sCFVUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:19:38 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)) 16:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:19:38 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-4801Lj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:19:38 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)) 16:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:19:38 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-Pqu1o3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:19:38 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)) 16:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:19:38 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-etNmhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:19:39 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-HIYeIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:19:39 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)) 16:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:19:39 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-HSJ7ZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:19:39 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)) 16:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:39 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-H7gAPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:39 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)) 16:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:19:39 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-2h1ptg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:19:39 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)) 16:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:19:39 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-BWu1PR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:19:39 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)) 16:19:39 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)) 16:19:39 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)) 16:19:39 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)) 16:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:19:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:19:39 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 16:19:39 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 16:19:39 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 16:19:39 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 16:19:39 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 16:19:39 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 16:19:42 INFO - Downloading blessings-1.6.tar.gz 16:19:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:19:42 INFO - Installing collected packages: blessings 16:19:42 INFO - Running setup.py install for blessings 16:19:42 INFO - Successfully installed blessings 16:19:42 INFO - Cleaning up... 16:19:42 INFO - Return code: 0 16:19:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:19:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:19:42 INFO - Reading from file tmpfile_stdout 16:19:42 INFO - Current package versions: 16:19:42 INFO - blessings == 1.6 16:19:42 INFO - blobuploader == 1.2.4 16:19:42 INFO - docopt == 0.6.1 16:19:42 INFO - functools32 == 3.2.3-2 16:19:42 INFO - jsonschema == 2.5.1 16:19:42 INFO - manifestparser == 1.1 16:19:42 INFO - mozInstall == 1.12 16:19:42 INFO - mozcrash == 1.0 16:19:42 INFO - mozdebug == 0.1 16:19:42 INFO - mozdevice == 0.50 16:19:42 INFO - mozfile == 1.2 16:19:42 INFO - mozhttpd == 0.7 16:19:42 INFO - mozinfo == 0.9 16:19:42 INFO - mozleak == 0.1 16:19:42 INFO - mozlog == 3.4 16:19:42 INFO - moznetwork == 0.27 16:19:42 INFO - mozprocess == 0.25 16:19:42 INFO - mozprofile == 0.28 16:19:42 INFO - mozrunner == 6.13 16:19:42 INFO - mozscreenshot == 0.1 16:19:42 INFO - mozsystemmonitor == 0.3 16:19:42 INFO - moztest == 0.8 16:19:42 INFO - mozversion == 1.4 16:19:42 INFO - psutil == 3.1.1 16:19:42 INFO - requests == 1.2.3 16:19:42 INFO - wsgiref == 0.1.2 16:19:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:42 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 0x10b31fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b322768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbda4cece0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0fdd30>, '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 0x10b023db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0f2be8>, '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.XNMTO2NpYh/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.JemVZzxMX5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 16:19:42 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 16:19:42 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 16:19:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XNMTO2NpYh/Render', 16:19:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:42 INFO - 'HOME': '/Users/cltbld', 16:19:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:42 INFO - 'LOGNAME': 'cltbld', 16:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:42 INFO - 'MOZ_NO_REMOTE': '1', 16:19:42 INFO - 'NO_EM_RESTART': '1', 16:19:42 INFO - 'PAGER': '/bin/cat', 16:19:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:42 INFO - 'PWD': '/builds/slave/test', 16:19:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:42 INFO - 'SHELL': '/bin/bash', 16:19:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JemVZzxMX5/Listeners', 16:19:42 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 16:19:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:42 INFO - 'USER': 'cltbld', 16:19:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:42 INFO - 'XPC_FLAGS': '0x0', 16:19:42 INFO - 'XPC_SERVICE_NAME': '0', 16:19:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:43 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)) 16:19:43 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)) 16:19:43 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)) 16:19:43 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)) 16:19:43 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)) 16:19:43 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)) 16:19:43 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)) 16:19:43 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)) 16:19:43 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)) 16:19:43 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)) 16:19:43 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)) 16:19:43 INFO - Cleaning up... 16:19:43 INFO - Return code: 0 16:19:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:19: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')]} 16:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19: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')]} 16:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b31fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b322768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbda4cece0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0fdd30>, '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 0x10b023db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0f2be8>, '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.XNMTO2NpYh/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.JemVZzxMX5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 16:19:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:19:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XNMTO2NpYh/Render', 16:19:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:43 INFO - 'HOME': '/Users/cltbld', 16:19:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:43 INFO - 'LOGNAME': 'cltbld', 16:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:43 INFO - 'MOZ_NO_REMOTE': '1', 16:19:43 INFO - 'NO_EM_RESTART': '1', 16:19:43 INFO - 'PAGER': '/bin/cat', 16:19:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:43 INFO - 'PWD': '/builds/slave/test', 16:19:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:43 INFO - 'SHELL': '/bin/bash', 16:19:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JemVZzxMX5/Listeners', 16:19:43 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 16:19:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:43 INFO - 'USER': 'cltbld', 16:19:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:43 INFO - 'XPC_FLAGS': '0x0', 16:19:43 INFO - 'XPC_SERVICE_NAME': '0', 16:19:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:19:43 INFO - Cleaning up... 16:19:43 INFO - Return code: 0 16:19:43 INFO - Running post-action listener: _resource_record_post_action 16:19:43 INFO - Running post-action listener: _start_resource_monitoring 16:19:43 INFO - Starting resource monitoring. 16:19:43 INFO - [mozharness: 2017-04-14 23:19:43.376197Z] Finished create-virtualenv step (success) 16:19:43 INFO - [mozharness: 2017-04-14 23:19:43.377152Z] Running install step. 16:19:43 INFO - Running pre-action listener: _resource_record_pre_action 16:19:43 INFO - Running main action method: install 16:19:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:19:43 INFO - Reading from file tmpfile_stdout 16:19:43 INFO - Detecting whether we're running mozinstall >=1.0... 16:19:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:19:43 INFO - Reading from file tmpfile_stdout 16:19:43 INFO - Output received: 16:19:43 INFO - Usage: mozinstall [options] installer 16:19:43 INFO - Options: 16:19:43 INFO - -h, --help show this help message and exit 16:19:43 INFO - -d DEST, --destination=DEST 16:19:43 INFO - Directory to install application into. [default: 16:19:43 INFO - "/builds/slave/test"] 16:19:43 INFO - --app=APP Application being installed. [default: firefox] 16:19:43 INFO - mkdir: /builds/slave/test/build/application 16:19:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:20:03 INFO - Reading from file tmpfile_stdout 16:20:03 INFO - Output received: 16:20:03 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:20:03 INFO - Running post-action listener: _resource_record_post_action 16:20:03 INFO - [mozharness: 2017-04-14 23:20:03.067602Z] Finished install step (success) 16:20:03 INFO - [mozharness: 2017-04-14 23:20:03.067757Z] Running run-tests step. 16:20:03 INFO - Running pre-action listener: _resource_record_pre_action 16:20:03 INFO - Running main action method: run_tests 16:20:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:20:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:20:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:20:03 INFO - 2017-04-14 16:20:03.082 screenresolution[1628:7641] starting screenresolution argv=screenresolution get 16:20:03 INFO - 2017-04-14 16:20:03.085 screenresolution[1628:7641] Display 0: 1600x1200x32@60 16:20:03 INFO - 2017-04-14 16:20:03.091 screenresolution[1629:7644] starting screenresolution argv=screenresolution list 16:20:03 INFO - Available Modes on Display 0 16:20:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:20:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:20:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:20:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:20:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:20:03 INFO - Intel Iris: 16:20:03 INFO - Chipset Model: Intel Iris 16:20:03 INFO - Type: GPU 16:20:03 INFO - Bus: Built-In 16:20:03 INFO - VRAM (Dynamic, Max): 1536 MB 16:20:03 INFO - Vendor: Intel (0x8086) 16:20:03 INFO - Device ID: 0x0a2e 16:20:03 INFO - Revision ID: 0x0009 16:20:03 INFO - Displays: 16:20:03 INFO - Display: 16:20:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:20:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:20:03 INFO - Display Serial Number: 1600x1200 60 16:20:03 INFO - Main Display: Yes 16:20:03 INFO - Mirror: Off 16:20:03 INFO - Online: Yes 16:20:03 INFO - Rotation: Supported 16:20:03 INFO - Return code: 0 16:20:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:20:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:20:03 INFO - Python 2.7.3 16:20:03 INFO - Return code: 0 16:20:03 INFO - grabbing minidump binary from tooltool 16:20:03 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')]} 16:20:03 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 0x10b0fdd30>, '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 0x10b023db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0f2be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:20:03 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 16:20:03 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 16:20:03 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 16:20:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:20:03 INFO - Return code: 0 16:20:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:20:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:20:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:20:03 INFO - ENV: RUST_BACKTRACE is now 1 16:20:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:20:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:20:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TQa6C1WRT8qIuD6UvE3O5g/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0126', '--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 16:20:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TQa6C1WRT8qIuD6UvE3O5g/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0126 --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 16:20:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XNMTO2NpYh/Render', 16:20:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:20:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:20:03 INFO - 'HOME': '/Users/cltbld', 16:20:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:20:03 INFO - 'LOGNAME': 'cltbld', 16:20:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:20:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:20:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:03 INFO - 'MOZ_NO_REMOTE': '1', 16:20:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:20:03 INFO - 'NO_EM_RESTART': '1', 16:20:03 INFO - 'PAGER': '/bin/cat', 16:20:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:20:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:03 INFO - 'PWD': '/builds/slave/test', 16:20:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:20:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:20:03 INFO - 'RUST_BACKTRACE': '1', 16:20:03 INFO - 'SHELL': '/bin/bash', 16:20:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JemVZzxMX5/Listeners', 16:20:03 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 16:20:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:20:03 INFO - 'USER': 'cltbld', 16:20:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:20:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:20:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:03 INFO - 'XPC_FLAGS': '0x0', 16:20:03 INFO - 'XPC_SERVICE_NAME': '0', 16:20:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:20:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TQa6C1WRT8qIuD6UvE3O5g/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0126', '--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 16:20:03 INFO - mozversion application_buildid: 20170414145415 16:20:03 INFO - mozversion application_changeset: d09143959b1af76d12d4429e92b1cd07544d0bef 16:20:03 INFO - mozversion application_display_name: Nightly 16:20:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:20:03 INFO - mozversion application_name: Firefox 16:20:03 INFO - mozversion application_remotingname: firefox 16:20:03 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:20:03 INFO - mozversion application_vendor: Mozilla 16:20:03 INFO - mozversion application_version: 55.0a1 16:20:03 INFO - mozversion platform_buildid: 20170414145415 16:20:03 INFO - mozversion platform_changeset: d09143959b1af76d12d4429e92b1cd07544d0bef 16:20:03 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:20:03 INFO - mozversion platform_version: 55.0a1 16:20:03 INFO - using testdate: 1492212003 16:20:03 INFO - actual date: 1492212003 16:20:03 INFO - starting webserver on 'localhost:49241' 16:20:03 INFO - SUITE-START | Running 2 tests 16:20:03 INFO - TEST-START | dromaeo_css 16:20:03 INFO - operating with platform_type : mac_ 16:20:03 INFO - Initialising browser for dromaeo_css test... 16:20:03 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmp12vfM3/profile http://localhost:49241/getInfo.html) 16:20:06 INFO - PID 1639 | 2017-04-14 16:20:06.690 plugin-container[1641:7830] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3f, name = 'com.apple.tsm.portname' 16:20:06 INFO - PID 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:20:06 INFO - PID 1639 | 2017-04-14 16:20:06.693 plugin-container[1641:7830] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 16:20:06 INFO - PID 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:20:06 INFO - PID 1639 | 2017-04-14 16:20:06.693 plugin-container[1641:7830] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:20:06 INFO - PID 1639 | __metrics Screen width/height:1600/1200 16:20:06 INFO - PID 1639 | colorDepth:24 16:20:06 INFO - PID 1639 | Browser inner width/height: 1024/689 16:20:06 INFO - PID 1639 | __metrics 16:20:06 ERROR - PID 1639 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3374: TypeError: this.tabs is undefined 16:20:07 INFO - TEST-INFO | 1639: exit 0 16:20:07 INFO - Browser initialized. 16:20:07 INFO - Running cycle 1/1 for dromaeo_css test... 16:20:07 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmp12vfM3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:20:10 INFO - PID 1642 | 2017-04-14 16:20:10.257 plugin-container[1643:7968] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 16:20:10 INFO - PID 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:20:10 INFO - PID 1642 | 2017-04-14 16:20:10.258 plugin-container[1643:7968] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4717, name = 'com.apple.CFPasteboardClient' 16:20:10 INFO - PID 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:20:10 INFO - PID 1642 | 2017-04-14 16:20:10.258 plugin-container[1643:7968] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:20:20 INFO - PID 1642 | RSS: Main: 238309376 16:20:20 INFO - PID 1642 | 16:23:24 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 16:23:26 INFO - PID 1642 | RSS: Main: 256884736 16:23:26 INFO - PID 1642 | 16:25:08 INFO - PID 1642 | ************************* 16:25:08 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 16:25:08 INFO - PID 1642 | 16:25:08 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:25:08 INFO - PID 1642 | Full stack: 16:25:08 INFO - PID 1642 | ************************* 16:25:08 INFO - PID 1642 | ************************* 16:25:08 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 16:25:08 INFO - PID 1642 | 16:25:08 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:25:08 INFO - PID 1642 | Full stack: 16:25:08 INFO - PID 1642 | ************************* 16:25:08 INFO - PID 1642 | ************************* 16:25:08 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 16:25:08 INFO - PID 1642 | 16:25:08 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:25:08 INFO - PID 1642 | Full stack: 16:25:08 INFO - PID 1642 | ************************* 16:25:08 INFO - PID 1642 | ************************* 16:25:08 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 16:25:08 INFO - PID 1642 | 16:25:08 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:25:08 INFO - PID 1642 | Full stack: 16:25:08 INFO - PID 1642 | ************************* 16:26:28 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 16:26:28 INFO - PID 1642 | RSS: Main: 261742592 16:26:28 INFO - PID 1642 | 16:29:30 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 16:29:31 INFO - PID 1642 | RSS: Main: 272076800 16:29:31 INFO - PID 1642 | 16:32:32 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 16:32:33 INFO - PID 1642 | RSS: Main: 265351168 16:32:33 INFO - PID 1642 | 16:35:36 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 16:35:37 INFO - PID 1642 | RSS: Main: 274771968 16:35:37 INFO - PID 1642 | 16:38:38 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 16:38:39 INFO - PID 1642 | RSS: Main: 269365248 16:38:39 INFO - PID 1642 | 16:38:39 INFO - PID 1642 | __start_tp_report 16:38:39 INFO - PID 1642 | _x_x_mozilla_page_load 16:38:39 INFO - PID 1642 | _x_x_mozilla_page_load_details 16:38:39 INFO - PID 1642 | |i|pagename|runs| 16:38:39 INFO - PID 1642 | |0;dojo.html;3293.35779522993;3559.7864128152296;3578.033930838672;3593.6586024327694;3607.008072779986;6115.847103822395;6224.782132625353;6245.500359971197;6264.561480696353;6319.873602527947;6136.21274067861;6162.815115546541;6221.129041934121;6251.3123556408755;6291.591046581981;5478.123500239963;5556.277683901088;5595.664260144384;5606.971965140189;5675.4608312210485;5481.342238931334;5561.5272701820395;5612.719364031803;5631.9718401408145;5646.632968857031;5422.75597598109;5522.364928033247;5540.390557038722;5616.971915140419;5656.745446454919;4592.897704550884;5486.890262194774;5490.478404551562;5497.780088796443;5537.861553461155;5446.428125046853;5497.340319161686;5516.282883225155;5560.972195139039;5566.638168519074;6032.819015429544;6255.874882502325;6257;6276.497880169575;6295.653739044351;6480.4815614750705;6598.307177746316;6696.129503164606;6756.324367563205;6766.627835469048;6811.182658081012;6811.386975172259;6829;6843.8973415398805;6857.451403887677;6178.7219575119225;6315.3684631536935;6334.5565810393755;6354.015127655174;6361.522885783585;6729.394354508117;6807.625580593016;6962.408195303456;6977.860442791116;7016.894746578805;6397.904031439439;6503.447206987365;6517;6622.03980422836;6673.532852700265;6723.495737819683;6766.864662706718;6794.014867844135;6802.115724955823;6829.521933464709;6688.799336019927;6696.263411024784;6741.1910570731825;6778.288279730656;6794.694238759268;6449.806505804833;6559.048937903977;6563.409293163638;6718.832029199211;6757.189137303555;5383.919241211307;5408.891822163535;5419.701916394557;5444.700541470178;5468.808591699351;4813.229883218738;4818.734969576637;4825.324454576362;4837.467878533358;4840.34655321527;6144.4697282790075;6340.809775706736;6341.207349081365;6368.681565921685;6385.329540398191;6716.731330746716;6818.556793808387;6852.246252912176;6867.759628412981;6908.585484870924;6319.273283572356;6330.651814150174;6345.33373995733;6353.4599559038;6367.713452894538;5966.731497082642;5971.373005834412;6000.21997140369;6017;6026.517878569792;6639.336066393419;6731.293214212437;6846.075779769667;6934;6992.0560724303605;6854.143232095988;6878.621675807879;6897.41371983387;6907.13660792401;6922.996165556067;6915.786948176536;6916.619585922823;6947.687354068978;6973.79078627642;6983.336583024605;6474.125992991075;6540.345965403612;6586.209654841449;6591.274959754519;6789.524733268821;5521.282233309644;6603;6816.931830681629;6874.415674667709;6887.862242755217;5959.642421454727;6346.413396650837;6376.808695739135;6391.201099862517;6629.801105966829;6540.640264785482;6617.867642647024;6626.56927299724;6640.83397915056;6652.234992975869;6271.153394291712;6450.580712253689;6456.096146539394;6465.741370345134;6474.093626892333;6344.143540621957;6595.175603049619;6618.966905165444;6624.8343791405605;6639.535232533676;6359.841003974938;6416;6473.190851143607;6475.061116138228;6546.541742078009 16:38:39 INFO - PID 1642 | |1;ext.html;734.6473692627538;814.2630919018288;839.2866063845731;1282.6600950748048;1288.08545932388;38095.61904380955;38902.80548597257;38905.61094389059;39157.60842391575;39855;31385.686143138562;39163.80418097905;39172.412413813814;39265.41101883467;39403.605963940354;8109;8229.177082291753;8518.787030324229;8791.956040219822;8793.384463087554;8695.434796738224;8734.606942687595;8810.735677929672;8819.647214111428;8828.293736501064;8756.168164024408;8819.073997230294;8829.028806831244;8840.734777956639;8852.51311177885;8768;8770.824583508325;8807.515586642732;8809.163129502687;8815;8589.055203927563;8629.568521573896;8630.870536941951;8638.956805215934;8643.2653224476;31504.842475787475;38194.80902595497;38503.03742406434;38523.42214866779;38590.80704596459;3668.853245870189;3700.85196592136;3705.4441833724886;3709.0912726382207;3709.6290370962956;31374.686253137406;31396.174344308893;31453;31459;31488;3172.1752344390393;3193.1218914798383;3193.2495863472063;3202.823844688541;3208.0856955767495;228239.99999999834;231277;238271.80864095743;292510;294665;48105.27842082371;48347.03305933862;48518;48542.5145748538;48594.75702621464;50497.242541361906;50601;50607.49392506101;50737;50781.492185078416;14688.265586720621;14801.777973330409;14802.925985370219;14820.184889830947;14829.77755333671;12071.336076515876;12082.093842961813;12092.758144837055;12113.697157570956;12140.150189486827;13762.518311859038;13771.449142034407;13800.654983625489;13832.616738326287;13892;5932.555058370639;5979.252593425822;6019.645579744522;6023.608465449732;6028.367021462771;1014.9441780702132;1039.1686650679426;1049.1134990932649;1069.6149386220955;1092.6066616018227;23600.29199124029;23627.29118126459;24299.51400972006;25068.749312506643;25145.748542514706;1130.5421304371744;1138.561653763307;1173.2373956927895;1175.1656324010048;1181.2440038375446;12436.766440725296;16187.028778273341;16376;16740.916295418687;16755.2460139294;322983;325528;325779;325963;326241;59515.702421487615;59924.80150397055;59975;60001;60132;1411.4142630808099;1499.1080307217405;1535.8080239970004;1538.8461153884523;1543.5909483986752;30292.84853575718;30671.846640766653;30714;31292.687073129888;31322.530162048042;40019;40028.1994360117;40156;40303.59696402998;40432.59567404288;292606;293751;293959.5302023476;294095.52952235105;294685;30367.544486833158;34860.651393486754;37133.44299835559;37325.25349493049;37366.62633373631;45865;46780.53219467898;47088.52911470841;47097;47204;27030.86484567643;28884.7111528882;30704.692953070182;31337.216569585944;32145.839270803495;30905.381892362475;31819.522707158947;31874.681253187173;31992.68007319897;32118.357632846746;37855.62144378631;38018.8099059514;38040;38089;38123.42814857724;30556.388872222877;31460.37079258448;31516;32101.518477222395;32486.350272993936;21410.89294553517;24322.27033189007;24517.141900033414;24526.754732452446;24666.50666986686 16:38:39 INFO - PID 1642 | |2;jquery.html;420.57101756208647;431.6719293337065;448.80028387367616;454.5590776946361;459.5129163087128;19466.610667786652;20958.26646067388;21680.891595542038;21775.128994840226;21808.345749627515;21282.89358553209;21307.680384794203;21462.785372146274;21606.567868642658;21747.891260543674;4886.804527818883;5523.337199536041;5809.302883653967;5960.374160713128;6094.146819445281;5475.206095116206;5914.852128696774;6001.66990815505;6175.197224360849;6244.438000579947;6019.638821670714;6134.969325153368;6167.167432396636;6181.165542651729;6191.535634827384;6019.578629495937;6119.418655227746;6148.569600128015;6149.969250153743;6159.938400615982;5280.6039547034125;5439.292891924025;5447.291852059207;5448.046591846411;5464.180372944051;26286.73713262862;26472.338191545172;27008.054718084968;27100.45799084027;27428.314292142655;2191.2768786300644;2212.3362991102604;2289.5306462175213;2297.6094064009158;2303.8041766449874;16198.35206591735;17078.23147958345;17142.828571714246;17583.857049291884;17808.931464112196;2146.270268108835;2171.5982543229397;2177.8366622503218;2188.72640919885;2189.0805861538192;129595.99999999905;136977;159778;166192.16903915402;170209.29790702058;11972.700682483008;12466.937665311796;12615.873841261653;12630.81053784194;12662.49350026007;16288;16323.836761632232;16328.67342653164;16366.509004729876;16409.507714768577;7727.65225564851;8554.401191916631;8766.474011559327;8853.778655533662;8899.288056955427;8079.555624440594;8276.255137037695;8315.50320942224;8424.326053915673;8451;6831;7583.02841261265;7661.157272699998;7741.645212087862;7851.254130857559;1881.4543782302978;2091.891297612268;2133.306675330524;2134.978650213509;2299.0688771047753;956.6269155029544;966.6326795817545;1000.3747657713928;1005.9094681478703;1028.3315844700855;17437.30250789954;20431.8978405107;20463.28378506745;20511.8974405127;20711;991.7173605522391;998.2313618513704;1015.6242190389603;1022.3048327137469;1025.251566356564;9906.257030722725;9967.55146018431;10322.12261957727;10357.223208259411;10373.170146388271;579315;589272;591234.0438297781;596819;597160;110086.89913100767;113369.4331528337;136513.3174334122;140613;142499;1196.3001644038336;1241.6523373455627;1259.974800504003;1263.9684007899875;1271.3516106785605;18698.813011869708;20796.896015519826;21036.368908932145;21157.471063223544;21717;58649.70675146597;58898.70550647219;59113.70443147757;59619.70190149022;59638.70180649069;75239.62380188065;76180;76765.61617191878;77428;78526;8646.221840034426;8956.477398842342;9027.916650002042;9131.726048218565;9257.35198536096;12299.631011069681;12600.684982875502;13835.169889806644;14224;14745.11529308245;10885.455727213766;11932.642020739391;12060.457279422271;12101.031917446408;12160.270383777002;9665.516724163623;11418.543258269909;11618.727004602857;11683.707907302385;11748;11852.288862668267;11984.40077996114;12120.787921207808;12203.328816915155;12631.305278209788;7471.439642026979;8774.605142768718;8788.736337909873;9168.037356077515;9177.495237761721;10145.543450544596;11654.825177622173;12003.399830008639;12043.578474753342;12308.384580770746 16:38:39 INFO - PID 1642 | |3;mootools.html;1389.3678376338764;1429.885609151268;1446.8408475067733;1453.3895763779212;1459.2995362226134;11487.942560287207;11841.881581184185;11904.285742855434;11957.64127076187;12264.754704905896;11728.706782330446;11944.82082768757;11975.880241197585;11982.101342399334;12047.457864396101;2308.076769292288;2528.6839145106906;2561.4748976459873;2573.935651608706;2581.2385346322785;2120.533482633818;2388.3909603051284;2547.3249588858966;2554.463562651845;2555.3356127406823;2510.57320255557;2518.2193520008764;2527.810414218932;2550.3241640965066;2553.6552565403713;2436.4639779248537;2478.0583378316305;2503.086373473678;2516.3331717094984;2531.1520640585427;2215.6898034275055;2455.398427385302;2538.746125387465;2543.9315487495296;2551.808614353912;10658.946705266502;11263.21157518974;11880.524779008829;11978.281303121841;11984.041276697842;6533.575317604388;6791.932080679179;6799.354061364163;6805.421539169177;6821.829454263683;3830.3488406970882;4111.2188684150215;4339.739615623042;4375.299952007664;4469.307257375112;1145.9484323205477;1262.72851336963;1278.7532156147774;1328.103530117167;1343.5834891183765;16433.424830130887;16719.414820481346;16810.66378672432;16847.831521684748;17011.829881701273;5611.102223644198;5674.659520428788;5848.736806843703;5848.736806843703;5859.1797148399255;12417.503299867903;12497.312647804458;12509.49962001528;12523.56167534132;12552.184108032949;6637.70130344126;6666.600003999775;6667.133272674521;6672.699728512229;6672.83317917056;6006.159137720722;6178.351273116348;6193.071039344134;6255;6261.373862613702;4339.088791353851;4476.194285028661;4513.50351461339;4544.431946006749;4561.087782443525;1301.8372703412074;1321.1148530484597;1321.1280554833957;1342.2483409290828;1343;806.9354451643854;835.6197929941862;845.8012367093728;850.59596691571;871.2681347667863;5950.761969521257;5978.4021597839865;6187.628742275388;6416.7754128605275;6499.642519661464;588.8969430349672;599.7301214453513;607.7629724407485;609.1076572820839;622.4097431063585;3722.8696995605023;3846.74996125251;4370.497392799805;4451.287793952952;4578;12237;15329.540113796604;15406.22968851553;15504;15510.689786204213;12550.43523041447;15328.923355383151;15344.846551534341;15351.232438378036;15377;7623.618819059025;8193.590320483952;8545.957270213734;8566.357523185787;8756.649734010569;6632.867342653217;6773.932260677528;7209.026781384446;7296.7081316746735;7310.926890731237;12688.619341419771;12937.611871643865;12946.482140714266;12977.610671679864;13000.869991299965;13275.004374671746;13291;13310.534131305358;13414.798778018143;13495.325233738078;8462.984441867015;8675.522846243517;8686.78283042929;8696.086910874266;8816.823663526566;10666.146708263475;10706.571737130427;10773.569057237935;10788.946055269673;10803.135749140207;7621.504602201061;8998.685046023358;9071.365004449624;9107.362484626277;9132.543372831198;8820.558972051243;8898.55507224649;8900.976387715496;8905.643774248958;8926.107389261022;8055.436119471815;8156.877646835421;8183.058948221031;8207.548584827891;8213.178682131738;5677.77288908439;6035.456808887221;6117.235345581802;6154.446099851035;6200.3179650239335;5994.28068631767;6042.244719410074;6091.604045737013;6263.248410190624;6274.341194174546 16:38:39 INFO - PID 1642 | |4;prototype.html;365.1874579061588;396.986105486308;411.33774622857214;425.46816479400746;425.6573458366014;4882.974575339179;5246.422893481714;6188.907166392502;6272.247330320357;6388.936110638892;5194.974025129869;5942.405759424056;6049.455549000589;6238.59449135807;6290.308066112724;4423.579759922818;4725.8818529536775;4780.067886762083;4781.545753153445;4782.904341913159;4626.907461850761;4732.929006064912;4741.596964258042;4762.857114286577;4774.952250477503;4159.916801663965;4392.34114882767;4669.019505903764;4694.342792009104;4734.715917044989;4719.74041427723;4729.290606409032;4734.455537613184;4735.0293189896165;4763.618910487187;4114.341705327163;4131.690123240739;4143.549757584821;4184;4231.534531201565;6084.209052823149;6093.756249750005;6105.358937311607;6110.327863935008;6131.019036954066;4687.437507499088;4762.595179409755;5508.586855985817;5607.775688972477;5615.5507559395555;5624.9875022495935;6197.597156184834;6369.745210191587;6421.550491465599;6669.933300666979;4190.664746820247;4260.190563792869;4692.343071969927;4745.59662428694;4747.145513807513;5232.529072383504;5663;6882.174139103339;6983;7084.645767711645;4861;4931.506849315111;4940.481249468826;4943.777530011158;4943.802247910044;4613.100445413179;4938.38270216223;5048.29323894655;5051.520105589963;5062.367204099488;4962.5533701967;5030.2957585938;5397.622166448389;5606.243157173811;5617.691026993554;5409.5131438169965;5959.731812068468;6702.296258892844;6741.359570840762;6758.797236082925;1635.5011721424842;1666.8083170435314;1678.731402975518;1744.7208446648729;1751.8510926571385;1185.9229150105216;1191.7139886427194;1207.9939600302118;1211.473009240983;1225.5342969671467;6182.876342473215;6199.535034872402;6202.162708034358;6210.813675589739;6233.594816336924;5714;6813.659317034128;6814.829629259309;6826.4538836892925;6867.2102708189195;5178.766955487012;5893.793717219876;6094.512439004869;6201.224846894138;6236.282827474808;3078.768492602977;3222.2910959588853;3318;3561.5013898054294;3612.9277414451562;5734.741936612862;5818.709064546756;6725.520385515277;6999.475039371966;7068.586282743369;6143.56995010345;6779.694913728894;7026.4541800803745;7047.43620510358;7053.92946070543;6722.966385168141;6951.339622735832;6984.755533556301;7034.718611255595;7116.715331386687;6137.723802428991;6602.801915942529;6795.558288711218;6863.931360686329;6873.175218973755;5700;6298.937010629835;6569.667767942312;6770.1537307836525;6793.830154246183;5694.943050569441;6729.596224226562;6957.826054348479;6977.511574189961;7018.824529386806;4908.165611846066;4921.950780492292;4926.531979461945;4959.925601116059;4985.626078044089;5854.443827836349;6442.226932768098;6840;6840.247572767091;6862.279460656759;6600.966995164993;6616.239132499824;6618.536702430976;6653.833654158491;6654.500912431684;5633.352164501135;6323.873522529616;6527.934720652733;6630.988252107599;6632.280764886374;6460.806175814545;6487.967560162169;6492;6493.480521558358;6527.445167160845;5643.604947653625;6349.333320001518;6438.323975982642;6589.4069533742195;6641.369069938348;5281.419043905091;6453.128827608213;6469.805905822833;6509.414152726277;6519.902201466887 16:38:39 INFO - PID 1642 | |5;yui.html;832.5337810825935;841.8316336732659;870.6299822575404;877.9333110271021;878.9956050219748;14586.781198282008;15163.711084557826;16523.091229982347;17030.574235644115;17116.486505404842;12759.936200319009;13200.141990770593;16970.83029169708;16988.32046718133;17236.741448878278;963.4749061761322;996.6412091647002;1007.8286691262502;1026.5483187397522;1034.0796690945065;985.3102828020415;1002.9749256268578;1030.6083688198473;1032.401207299768;1037.7924415117006;1058.9099926506217;1087.7878813631346;1087.9782404351909;1089.8910108989116;1090.0462095666292;1059.9629012984547;1074.854894589236;1079.2067830144797;1079.87581428136;1080.0495563903753;794.6503538443125;801.7714951238869;806.330745481255;808.975730728079;812.9227723366271;16778.83221167797;17112.57218569546;17213.655726885518;17233.396831110975;17526.91236543822;17234.741478877826;17318.307267709275;17597.384091556734;17598.208080636403;17652.646947060988;12481.625551233477;12785.424655890414;13825.654358641115;14072.366743496566;14219.146851188962;3520.806355650438;3543.574771027493;3556.8399422025814;3557.2529768748595;3561.554805649294;102779.97220027779;114999;126215.47569048568;129930.3503482486;130164.04753928793;13101.344932753515;13142.211467311992;13154.750298721607;13267.469301227842;13356.799648005288;22615.321540353816;23646.817659117318;24452.75547244505;24828.131015414372;25218.873905630353;7807.219278072147;7850.371970242367;7858.0570331560575;7861.685532578747;7872.173421790744;3943.3690609502914;4069.694772891986;4091.8158682859344;4093.815778289984;4100.958990410118;3843.9039024024623;4241.27898257297;4367.716098453654;4375.2780791169735;4700.247960326331;899.9190072893471;905.9581481296561;923.385948344357;924.2975338742469;924.357571487823;646.977355792545;663.2306524431636;671.3789744486428;674.5851301449671;692.6882902693808;10245.385276883411;11142.665720028412;11437.771244575228;11866.347350895783;12076.818847717292;635.5614625908108;644.8516841126567;662.5660192573872;690.7927621713567;695.5548448992648;5447.700376479332;5516.123095594559;5693.202951586781;5713.085906254979;5801.767929282866;103107.93784124426;104937;105305.47347263368;106382.46808765907;107178.46410767896;84392;88721;88782;89895;90864.54567727119;77680;78206;78614;80249.19750802535;80274;10060.792704875461;10661.680149595524;11906.04751619851;12309.630711078682;12482.875171248534;38104.428433574074;38968.41547376848;39332.80333598314;41354.37968430416;42180.78909605432;53207;53768.462315376346;53838;53959.73020134874;53978.19032714591;15755.527334179993;15772.60568485797;15892.364305427653;16078.35686572524;16206.67586648284;17889.552761180556;18038.819611803712;18125.36561220351;18322.358717444826;18353.90823045876;16482.75275870839;16502.42241521541;16506.504804855875;16710.66578668444;16788.580285492473;15089.849101509284;15810.7628385572;15946.60133496672;16382.918085409498;16482.42311519091;16135.919320403324;16432.424865130142;16722.163891805605;16945.66108677844;16956.74564881503;11757.824217578174;11791.35147566892;11854.525818967144;12279.877201227873;12326.81509777336;12647.620571382506;13616;13641.181529107887;13661.79507307411;14054 16:38:39 INFO - PID 1642 | __end_tp_report 16:38:39 INFO - PID 1642 | __start_cc_report 16:38:39 INFO - PID 1642 | _x_x_mozilla_cycle_collect,424 16:38:39 INFO - PID 1642 | __end_cc_report 16:38:39 INFO - PID 1642 | __startTimestamp1492213119090__endTimestamp 16:38:39 INFO - PID 1642 | 16:38:39 INFO - PID 1642 | ------- Summary: start ------- 16:38:39 INFO - PID 1642 | Number of tests: 6 16:38:39 INFO - PID 1642 | 16:38:39 INFO - PID 1642 | [#0] dojo.html Cycles:165 Average:6214.37 Median:6391.20 stddev:726.44 (11.4%) stddev-sans-first:691.59 16:38:39 INFO - PID 1642 | Values: 3293.4 3559.8 3578.0 3593.7 3607.0 6115.8 6224.8 6245.5 6264.6 6319.9 6136.2 6162.8 6221.1 6251.3 6291.6 5478.1 5556.3 5595.7 5607.0 5675.5 5481.3 5561.5 5612.7 5632.0 5646.6 5422.8 5522.4 5540.4 5617.0 5656.7 4592.9 5486.9 5490.5 5497.8 5537.9 5446.4 5497.3 5516.3 5561.0 5566.6 6032.8 6255.9 6257.0 6276.5 6295.7 6480.5 6598.3 6696.1 6756.3 6766.6 6811.2 6811.4 6829.0 6843.9 6857.5 6178.7 6315.4 6334.6 6354.0 6361.5 6729.4 6807.6 6962.4 6977.9 7016.9 6397.9 6503.4 6517.0 6622.0 6673.5 6723.5 6766.9 6794.0 6802.1 6829.5 6688.8 6696.3 6741.2 6778.3 6794.7 6449.8 6559.0 6563.4 6718.8 6757.2 5383.9 5408.9 5419.7 5444.7 5468.8 4813.2 4818.7 4825.3 4837.5 4840.3 6144.5 6340.8 6341.2 6368.7 6385.3 6716.7 6818.6 6852.2 6867.8 6908.6 6319.3 6330.7 6345.3 6353.5 6367.7 5966.7 5971.4 6000.2 6017.0 6026.5 6639.3 6731.3 6846.1 6934.0 6992.1 6854.1 6878.6 6897.4 6907.1 6923.0 6915.8 6916.6 6947.7 6973.8 6983.3 6474.1 6540.3 6586.2 6591.3 6789.5 5521.3 6603.0 6816.9 6874.4 6887.9 5959.6 6346.4 6376.8 6391.2 6629.8 6540.6 6617.9 6626.6 6640.8 6652.2 6271.2 6450.6 6456.1 6465.7 6474.1 6344.1 6595.2 6619.0 6624.8 6639.5 6359.8 6416.0 6473.2 6475.1 6546.5 16:38:39 INFO - PID 1642 | 16:38:39 INFO - PID 1642 | [#1] ext.html Cycles:180 Average:45296.26 Median:179007.18 stddev:76925.66 (43.0%) stddev-sans-first:77068.69 16:38:39 INFO - PID 1642 | Values: 734.6 814.3 839.3 1282.7 1288.1 38095.6 38902.8 38905.6 39157.6 39855.0 31385.7 39163.8 39172.4 39265.4 39403.6 8109.0 8229.2 8518.8 8792.0 8793.4 8695.4 8734.6 8810.7 8819.6 8828.3 8756.2 8819.1 8829.0 8840.7 8852.5 8768.0 8770.8 8807.5 8809.2 8815.0 8589.1 8629.6 8630.9 8639.0 8643.3 31504.8 38194.8 38503.0 38523.4 38590.8 3668.9 3700.9 3705.4 3709.1 3709.6 31374.7 31396.2 31453.0 31459.0 31488.0 3172.2 3193.1 3193.2 3202.8 3208.1 228240.0 231277.0 238271.8 292510.0 294665.0 48105.3 48347.0 48518.0 48542.5 48594.8 50497.2 50601.0 50607.5 50737.0 50781.5 14688.3 14801.8 14802.9 14820.2 14829.8 12071.3 12082.1 12092.8 12113.7 12140.2 13762.5 13771.4 13800.7 13832.6 13892.0 5932.6 5979.3 6019.6 6023.6 6028.4 1014.9 1039.2 1049.1 1069.6 1092.6 23600.3 23627.3 24299.5 25068.7 25145.7 1130.5 1138.6 1173.2 1175.2 1181.2 12436.8 16187.0 16376.0 16740.9 16755.2 322983.0 325528.0 325779.0 325963.0 326241.0 59515.7 59924.8 59975.0 60001.0 60132.0 1411.4 1499.1 1535.8 1538.8 1543.6 30292.8 30671.8 30714.0 31292.7 31322.5 40019.0 40028.2 40156.0 40303.6 40432.6 292606.0 293751.0 293959.5 294095.5 294685.0 30367.5 34860.7 37133.4 37325.3 37366.6 45865.0 46780.5 47088.5 47097.0 47204.0 27030.9 28884.7 30704.7 31337.2 32145.8 30905.4 31819.5 31874.7 31992.7 32118.4 37855.6 38018.8 38040.0 38089.0 38123.4 30556.4 31460.4 31516.0 32101.5 32486.4 21410.9 24322.3 24517.1 24526.8 24666.5 16:38:39 INFO - PID 1642 | 16:38:39 INFO - PID 1642 | [#2] jquery.html Cycles:180 Average:36560.11 Median:2188.90 stddev:99602.56 (4550.3%) stddev-sans-first:99845.00 16:38:39 INFO - PID 1642 | Values: 420.6 431.7 448.8 454.6 459.5 19466.6 20958.3 21680.9 21775.1 21808.3 21282.9 21307.7 21462.8 21606.6 21747.9 4886.8 5523.3 5809.3 5960.4 6094.1 5475.2 5914.9 6001.7 6175.2 6244.4 6019.6 6135.0 6167.2 6181.2 6191.5 6019.6 6119.4 6148.6 6150.0 6159.9 5280.6 5439.3 5447.3 5448.0 5464.2 26286.7 26472.3 27008.1 27100.5 27428.3 2191.3 2212.3 2289.5 2297.6 2303.8 16198.4 17078.2 17142.8 17583.9 17808.9 2146.3 2171.6 2177.8 2188.7 2189.1 129596.0 136977.0 159778.0 166192.2 170209.3 11972.7 12466.9 12615.9 12630.8 12662.5 16288.0 16323.8 16328.7 16366.5 16409.5 7727.7 8554.4 8766.5 8853.8 8899.3 8079.6 8276.3 8315.5 8424.3 8451.0 6831.0 7583.0 7661.2 7741.6 7851.3 1881.5 2091.9 2133.3 2135.0 2299.1 956.6 966.6 1000.4 1005.9 1028.3 17437.3 20431.9 20463.3 20511.9 20711.0 991.7 998.2 1015.6 1022.3 1025.3 9906.3 9967.6 10322.1 10357.2 10373.2 579315.0 589272.0 591234.0 596819.0 597160.0 110086.9 113369.4 136513.3 140613.0 142499.0 1196.3 1241.7 1260.0 1264.0 1271.4 18698.8 20796.9 21036.4 21157.5 21717.0 58649.7 58898.7 59113.7 59619.7 59638.7 75239.6 76180.0 76765.6 77428.0 78526.0 8646.2 8956.5 9027.9 9131.7 9257.4 12299.6 12600.7 13835.2 14224.0 14745.1 10885.5 11932.6 12060.5 12101.0 12160.3 9665.5 11418.5 11618.7 11683.7 11748.0 11852.3 11984.4 12120.8 12203.3 12631.3 7471.4 8774.6 8788.7 9168.0 9177.5 10145.5 11654.8 12003.4 12043.6 12308.4 16:38:39 INFO - PID 1642 | 16:38:39 INFO - PID 1642 | [#3] mootools.html Cycles:180 Average:7102.57 Median:3776.61 stddev:4501.12 (119.2%) stddev-sans-first:4493.27 16:38:39 INFO - PID 1642 | Values: 1389.4 1429.9 1446.8 1453.4 1459.3 11487.9 11841.9 11904.3 11957.6 12264.8 11728.7 11944.8 11975.9 11982.1 12047.5 2308.1 2528.7 2561.5 2573.9 2581.2 2120.5 2388.4 2547.3 2554.5 2555.3 2510.6 2518.2 2527.8 2550.3 2553.7 2436.5 2478.1 2503.1 2516.3 2531.2 2215.7 2455.4 2538.7 2543.9 2551.8 10658.9 11263.2 11880.5 11978.3 11984.0 6533.6 6791.9 6799.4 6805.4 6821.8 3830.3 4111.2 4339.7 4375.3 4469.3 1145.9 1262.7 1278.8 1328.1 1343.6 16433.4 16719.4 16810.7 16847.8 17011.8 5611.1 5674.7 5848.7 5848.7 5859.2 12417.5 12497.3 12509.5 12523.6 12552.2 6637.7 6666.6 6667.1 6672.7 6672.8 6006.2 6178.4 6193.1 6255.0 6261.4 4339.1 4476.2 4513.5 4544.4 4561.1 1301.8 1321.1 1321.1 1342.2 1343.0 806.9 835.6 845.8 850.6 871.3 5950.8 5978.4 6187.6 6416.8 6499.6 588.9 599.7 607.8 609.1 622.4 3722.9 3846.7 4370.5 4451.3 4578.0 12237.0 15329.5 15406.2 15504.0 15510.7 12550.4 15328.9 15344.8 15351.2 15377.0 7623.6 8193.6 8546.0 8566.4 8756.6 6632.9 6773.9 7209.0 7296.7 7310.9 12688.6 12937.6 12946.5 12977.6 13000.9 13275.0 13291.0 13310.5 13414.8 13495.3 8463.0 8675.5 8686.8 8696.1 8816.8 10666.1 10706.6 10773.6 10788.9 10803.1 7621.5 8998.7 9071.4 9107.4 9132.5 8820.6 8898.6 8901.0 8905.6 8926.1 8055.4 8156.9 8183.1 8207.5 8213.2 5677.8 6035.5 6117.2 6154.4 6200.3 5994.3 6042.2 6091.6 6263.2 6274.3 16:38:39 INFO - PID 1642 | 16:38:39 INFO - PID 1642 | [#4] prototype.html Cycles:180 Average:5376.28 Median:5836.58 stddev:1600.71 (27.4%) stddev-sans-first:1560.39 16:38:39 INFO - PID 1642 | Values: 365.2 397.0 411.3 425.5 425.7 4883.0 5246.4 6188.9 6272.2 6388.9 5195.0 5942.4 6049.5 6238.6 6290.3 4423.6 4725.9 4780.1 4781.5 4782.9 4626.9 4732.9 4741.6 4762.9 4775.0 4159.9 4392.3 4669.0 4694.3 4734.7 4719.7 4729.3 4734.5 4735.0 4763.6 4114.3 4131.7 4143.5 4184.0 4231.5 6084.2 6093.8 6105.4 6110.3 6131.0 4687.4 4762.6 5508.6 5607.8 5615.6 5625.0 6197.6 6369.7 6421.6 6669.9 4190.7 4260.2 4692.3 4745.6 4747.1 5232.5 5663.0 6882.2 6983.0 7084.6 4861.0 4931.5 4940.5 4943.8 4943.8 4613.1 4938.4 5048.3 5051.5 5062.4 4962.6 5030.3 5397.6 5606.2 5617.7 5409.5 5959.7 6702.3 6741.4 6758.8 1635.5 1666.8 1678.7 1744.7 1751.9 1185.9 1191.7 1208.0 1211.5 1225.5 6182.9 6199.5 6202.2 6210.8 6233.6 5714.0 6813.7 6814.8 6826.5 6867.2 5178.8 5893.8 6094.5 6201.2 6236.3 3078.8 3222.3 3318.0 3561.5 3612.9 5734.7 5818.7 6725.5 6999.5 7068.6 6143.6 6779.7 7026.5 7047.4 7053.9 6723.0 6951.3 6984.8 7034.7 7116.7 6137.7 6602.8 6795.6 6863.9 6873.2 5700.0 6298.9 6569.7 6770.2 6793.8 5694.9 6729.6 6957.8 6977.5 7018.8 4908.2 4922.0 4926.5 4959.9 4985.6 5854.4 6442.2 6840.0 6840.2 6862.3 6601.0 6616.2 6618.5 6653.8 6654.5 5633.4 6323.9 6527.9 6631.0 6632.3 6460.8 6488.0 6492.0 6493.5 6527.4 5643.6 6349.3 6438.3 6589.4 6641.4 5281.4 6453.1 6469.8 6509.4 6519.9 16:38:39 INFO - PID 1642 | 16:38:39 INFO - PID 1642 | [#5] yui.html Cycles:180 Average:21377.85 Median:17235.74 stddev:29949.23 (173.8%) stddev-sans-first:29993.52 16:38:39 INFO - PID 1642 | Values: 832.5 841.8 870.6 877.9 879.0 14586.8 15163.7 16523.1 17030.6 17116.5 12759.9 13200.1 16970.8 16988.3 17236.7 963.5 996.6 1007.8 1026.5 1034.1 985.3 1003.0 1030.6 1032.4 1037.8 1058.9 1087.8 1088.0 1089.9 1090.0 1060.0 1074.9 1079.2 1079.9 1080.0 794.7 801.8 806.3 809.0 812.9 16778.8 17112.6 17213.7 17233.4 17526.9 17234.7 17318.3 17597.4 17598.2 17652.6 12481.6 12785.4 13825.7 14072.4 14219.1 3520.8 3543.6 3556.8 3557.3 3561.6 102780.0 114999.0 126215.5 129930.4 130164.0 13101.3 13142.2 13154.8 13267.5 13356.8 22615.3 23646.8 24452.8 24828.1 25218.9 7807.2 7850.4 7858.1 7861.7 7872.2 3943.4 4069.7 4091.8 4093.8 4101.0 3843.9 4241.3 4367.7 4375.3 4700.2 899.9 906.0 923.4 924.3 924.4 647.0 663.2 671.4 674.6 692.7 10245.4 11142.7 11437.8 11866.3 12076.8 635.6 644.9 662.6 690.8 695.6 5447.7 5516.1 5693.2 5713.1 5801.8 103107.9 104937.0 105305.5 106382.5 107178.5 84392.0 88721.0 88782.0 89895.0 90864.5 77680.0 78206.0 78614.0 80249.2 80274.0 10060.8 10661.7 11906.0 12309.6 12482.9 38104.4 38968.4 39332.8 41354.4 42180.8 53207.0 53768.5 53838.0 53959.7 53978.2 15755.5 15772.6 15892.4 16078.4 16206.7 17889.6 18038.8 18125.4 18322.4 18353.9 16482.8 16502.4 16506.5 16710.7 16788.6 15089.8 15810.8 15946.6 16382.9 16482.4 16135.9 16432.4 16722.2 16945.7 16956.7 11757.8 11791.4 11854.5 12279.9 12326.8 12647.6 13616.0 13641.2 13661.8 14054.0 16:38:39 INFO - PID 1642 | -------- Summary: end -------- 16:38:39 INFO - PID 1642 | 16:38:39 INFO - TEST-INFO | 1642: exit 0 16:38:39 INFO - TEST-OK | dromaeo_css | took 1116145ms 16:38:39 INFO - TEST-START | kraken 16:38:39 INFO - operating with platform_type : mac_ 16:38:39 INFO - Initialising browser for kraken test... 16:38:39 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmpowmhD1/profile http://localhost:49241/getInfo.html) 16:38:42 INFO - PID 1656 | 2017-04-14 16:38:42.548 plugin-container[1657:10456] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b3f, name = 'com.apple.tsm.portname' 16:38:42 INFO - PID 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:38:42 INFO - PID 1656 | 2017-04-14 16:38:42.550 plugin-container[1657:10456] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900f, name = 'com.apple.CFPasteboardClient' 16:38:42 INFO - PID 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:38:42 INFO - PID 1656 | 2017-04-14 16:38:42.550 plugin-container[1657:10456] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:38:42 INFO - PID 1656 | __metrics Screen width/height:1600/1200 16:38:42 INFO - PID 1656 | colorDepth:24 16:38:42 INFO - PID 1656 | Browser inner width/height: 1024/689 16:38:42 INFO - PID 1656 | __metrics 16:38:42 ERROR - PID 1656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3374: TypeError: this.tabs is undefined 16:38:43 INFO - TEST-INFO | 1656: exit 0 16:38:43 INFO - Browser initialized. 16:38:43 INFO - Running cycle 1/1 for kraken test... 16:38:43 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmpowmhD1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:38:46 INFO - PID 1658 | 2017-04-14 16:38:46.007 plugin-container[1659:10584] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b47, name = 'com.apple.tsm.portname' 16:38:46 INFO - PID 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:38:46 INFO - PID 1658 | 2017-04-14 16:38:46.007 plugin-container[1659:10584] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x431b, name = 'com.apple.CFPasteboardClient' 16:38:46 INFO - PID 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:38:46 INFO - PID 1658 | 2017-04-14 16:38:46.007 plugin-container[1659:10584] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:38:55 INFO - PID 1658 | RSS: Main: 238981120 16:38:55 INFO - PID 1658 | 16:38:58 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 16:38:59 INFO - PID 1658 | RSS: Main: 250212352 16:38:59 INFO - PID 1658 | 16:39:02 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 16:39:02 INFO - PID 1658 | RSS: Main: 259047424 16:39:02 INFO - PID 1658 | 16:39:06 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 16:39:07 INFO - PID 1658 | RSS: Main: 261541888 16:39:07 INFO - PID 1658 | 16:39:09 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 16:39:09 INFO - PID 1658 | RSS: Main: 263319552 16:39:09 INFO - PID 1658 | 16:39:11 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:39:12 INFO - PID 1658 | RSS: Main: 264433664 16:39:12 INFO - PID 1658 | 16:39:15 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 16:39:16 INFO - PID 1658 | RSS: Main: 269549568 16:39:16 INFO - PID 1658 | 16:39:18 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 16:39:19 INFO - PID 1658 | RSS: Main: 270815232 16:39:19 INFO - PID 1658 | 16:39:22 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 16:39:23 INFO - PID 1658 | RSS: Main: 270671872 16:39:23 INFO - PID 1658 | 16:39:24 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:39:25 INFO - PID 1658 | RSS: Main: 270131200 16:39:25 INFO - PID 1658 | 16:39:26 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:39:27 INFO - PID 1658 | RSS: Main: 270245888 16:39:27 INFO - PID 1658 | 16:39:29 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:39:30 INFO - PID 1658 | RSS: Main: 269889536 16:39:30 INFO - PID 1658 | 16:39:33 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:39:34 INFO - PID 1658 | RSS: Main: 270528512 16:39:34 INFO - PID 1658 | 16:39:37 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:39:38 INFO - PID 1658 | RSS: Main: 270131200 16:39:38 INFO - PID 1658 | 16:39:39 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 16:39:40 INFO - PID 1658 | RSS: Main: 271605760 16:39:40 INFO - PID 1658 | 16:39:40 INFO - PID 1658 | __start_tp_report 16:39:40 INFO - PID 1658 | _x_x_mozilla_page_load 16:39:40 INFO - PID 1658 | _x_x_mozilla_page_load_details 16:39:40 INFO - PID 1658 | |i|pagename|runs| 16:39:40 INFO - PID 1658 | |0;ai-astar;101;98;138;109;163;162;129;116;118;115 16:39:40 INFO - PID 1658 | |1;audio-beat-detection;140;124;110;150;112;143;98;97;157;140 16:39:40 INFO - PID 1658 | |2;audio-dft;198;200;209;222;256;233;272;206;274;236 16:39:40 INFO - PID 1658 | |3;audio-fft;80;57;60;93;82;77;58;61;78;62 16:39:40 INFO - PID 1658 | |4;audio-oscillator;85;74;85;69;65;71;94;97;97;107 16:39:40 INFO - PID 1658 | |5;imaging-gaussian-blur;89;88;89;88;89;129;129;99;128;91 16:39:40 INFO - PID 1658 | |6;imaging-darkroom;96;95;103;95;96;96;96;96;97;96 16:39:40 INFO - PID 1658 | |7;imaging-desaturate;89;92;105;90;94;90;90;100;91;90 16:39:40 INFO - PID 1658 | |8;json-parse-financial;50;48;52;51;52;54;51;52;51;53 16:39:40 INFO - PID 1658 | |9;json-stringify-tinderbox;63;56;65;63;61;59;56;57;57;57 16:39:40 INFO - PID 1658 | |10;stanford-crypto-aes;93;99;80;100;104;105;103;91;84;83 16:39:40 INFO - PID 1658 | |11;stanford-crypto-ccm;158;151;167;159;128;145;142;166;200;146 16:39:40 INFO - PID 1658 | |12;stanford-crypto-pbkdf2;183;226;225;193;189;185;189;191;176;192 16:39:40 INFO - PID 1658 | |13;stanford-crypto-sha256-iterative;72;69;71;70;71;71;69;69;71;73 16:39:40 INFO - PID 1658 | __end_tp_report 16:39:40 INFO - PID 1658 | __start_cc_report 16:39:40 INFO - PID 1658 | _x_x_mozilla_cycle_collect,1011 16:39:40 INFO - PID 1658 | __end_cc_report 16:39:40 INFO - PID 1658 | __startTimestamp1492213180190__endTimestamp 16:39:40 INFO - PID 1658 | 16:39:40 INFO - PID 1658 | ------- Summary: start ------- 16:39:40 INFO - PID 1658 | Number of tests: 14 16:39:40 INFO - PID 1658 | 16:39:40 INFO - PID 1658 | [#0] ai-astar Cycles:10 Average:124.90 Median:133.50 stddev:23.07 (17.3%) stddev-sans-first:22.79 16:39:40 INFO - PID 1658 | Values: 101.0 98.0 138.0 109.0 163.0 162.0 129.0 116.0 118.0 115.0 16:39:40 INFO - PID 1658 | 16:39:40 INFO - PID 1658 | [#1] audio-beat-detection Cycles:10 Average:127.10 Median:146.50 stddev:21.82 (14.9%) stddev-sans-first:22.64 16:39:40 INFO - PID 1658 | Values: 140.0 124.0 110.0 150.0 112.0 143.0 98.0 97.0 157.0 140.0 16:39:40 INFO - PID 1658 | 16:39:40 INFO - PID 1658 | [#2] audio-dft Cycles:10 Average:230.60 Median:234.50 stddev:28.72 (12.2%) stddev-sans-first:27.93 16:39:40 INFO - PID 1658 | Values: 198.0 200.0 209.0 222.0 256.0 233.0 272.0 206.0 274.0 236.0 16:39:40 INFO - PID 1658 | 16:39:40 INFO - PID 1658 | [#3] audio-fft Cycles:10 Average:70.80 Median:77.50 stddev:12.64 (16.3%) stddev-sans-first:12.96 16:39:40 INFO - PID 1658 | Values: 80.0 57.0 60.0 93.0 82.0 77.0 58.0 61.0 78.0 62.0 16:39:40 INFO - PID 1658 | 16:39:40 INFO - PID 1658 | [#4] audio-oscillator Cycles:10 Average:84.40 Median:85.00 stddev:14.23 (16.7%) stddev-sans-first:15.09 16:39:40 INFO - PID 1658 | Values: 85.0 74.0 85.0 69.0 65.0 71.0 94.0 97.0 97.0 107.0 16:39:40 INFO - PID 1658 | 16:39:40 INFO - PID 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:101.90 Median:89.00 stddev:18.75 (21.1%) stddev-sans-first:19.29 16:39:40 INFO - PID 1658 | Values: 89.0 88.0 89.0 88.0 89.0 129.0 129.0 99.0 128.0 91.0 16:39:40 INFO - PID 1658 | 16:39:40 INFO - PID 1658 | [#6] imaging-darkroom Cycles:10 Average:96.60 Median:96.00 stddev:2.32 (2.4%) stddev-sans-first:2.45 16:39:40 INFO - PID 1658 | Values: 96.0 95.0 103.0 95.0 96.0 96.0 96.0 96.0 97.0 96.0 16:39:40 INFO - PID 1658 | 16:39:40 INFO - PID 1658 | [#7] imaging-desaturate Cycles:10 Average:93.10 Median:90.00 stddev:5.28 (5.9%) stddev-sans-first:5.39 16:39:40 INFO - PID 1658 | Values: 89.0 92.0 105.0 90.0 94.0 90.0 90.0 100.0 91.0 90.0 16:39:40 INFO - PID 1658 | 16:39:40 INFO - PID 1658 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:52.00 stddev:1.65 (3.2%) stddev-sans-first:1.67 16:39:40 INFO - PID 1658 | Values: 50.0 48.0 52.0 51.0 52.0 54.0 51.0 52.0 51.0 53.0 16:39:40 INFO - PID 1658 | 16:39:40 INFO - PID 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:60.00 stddev:3.34 (5.6%) stddev-sans-first:3.28 16:39:40 INFO - PID 1658 | Values: 63.0 56.0 65.0 63.0 61.0 59.0 56.0 57.0 57.0 57.0 16:39:40 INFO - PID 1658 | 16:39:40 INFO - PID 1658 | [#10] stanford-crypto-aes Cycles:10 Average:94.20 Median:83.50 stddev:9.37 (11.2%) stddev-sans-first:9.92 16:39:40 INFO - PID 1658 | Values: 93.0 99.0 80.0 100.0 104.0 105.0 103.0 91.0 84.0 83.0 16:39:40 INFO - PID 1658 | 16:39:40 INFO - PID 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:156.20 Median:158.50 stddev:19.42 (12.3%) stddev-sans-first:20.59 16:39:40 INFO - PID 1658 | Values: 158.0 151.0 167.0 159.0 128.0 145.0 142.0 166.0 200.0 146.0 16:39:40 INFO - PID 1658 | 16:39:40 INFO - PID 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.90 Median:191.50 stddev:16.89 (8.8%) stddev-sans-first:17.35 16:39:40 INFO - PID 1658 | Values: 183.0 226.0 225.0 193.0 189.0 185.0 189.0 191.0 176.0 192.0 16:39:40 INFO - PID 1658 | 16:39:40 INFO - PID 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:71.00 stddev:1.35 (1.9%) stddev-sans-first:1.33 16:39:40 INFO - PID 1658 | Values: 72.0 69.0 71.0 70.0 71.0 71.0 69.0 69.0 71.0 73.0 16:39:40 INFO - PID 1658 | -------- Summary: end -------- 16:39:40 INFO - PID 1658 | 16:39:41 INFO - TEST-INFO | 1658: exit 0 16:39:41 INFO - TEST-OK | kraken | took 61516ms 16:39:41 INFO - SUITE-END | took 1177s 16:39:41 INFO - Completed test suite (00:19:37) 16:39:41 INFO - javascript benchmark 16:39:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7957.74512884693, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3293.35779522993, 3559.7864128152296, 3578.033930838672, 3593.6586024327694, 3607.008072779986, 6115.847103822395, 6224.782132625353, 6245.500359971197, 6264.561480696353, 6319.873602527947, 6136.21274067861, 6162.815115546541, 6221.129041934121, 6251.3123556408755, 6291.591046581981, 5478.123500239963, 5556.277683901088, 5595.664260144384, 5606.971965140189, 5675.4608312210485, 5481.342238931334, 5561.5272701820395, 5612.719364031803, 5631.9718401408145, 5646.632968857031, 5422.75597598109, 5522.364928033247, 5540.390557038722, 5616.971915140419, 5656.745446454919, 4592.897704550884, 5486.890262194774, 5490.478404551562, 5497.780088796443, 5537.861553461155, 5446.428125046853, 5497.340319161686, 5516.282883225155, 5560.972195139039, 5566.638168519074, 6032.819015429544, 6255.874882502325, 6257.0, 6276.497880169575, 6295.653739044351, 6480.4815614750705, 6598.307177746316, 6696.129503164606, 6756.324367563205, 6766.627835469048, 6811.182658081012, 6811.386975172259, 6829.0, 6843.8973415398805, 6857.451403887677, 6178.7219575119225, 6315.3684631536935, 6334.5565810393755, 6354.015127655174, 6361.522885783585, 6729.394354508117, 6807.625580593016, 6962.408195303456, 6977.860442791116, 7016.894746578805, 6397.904031439439, 6503.447206987365, 6517.0, 6622.03980422836, 6673.532852700265, 6723.495737819683, 6766.864662706718, 6794.014867844135, 6802.115724955823, 6829.521933464709, 6688.799336019927, 6696.263411024784, 6741.1910570731825, 6778.288279730656, 6794.694238759268, 6449.806505804833, 6559.048937903977, 6563.409293163638, 6718.832029199211, 6757.189137303555, 5383.919241211307, 5408.891822163535, 5419.701916394557, 5444.700541470178, 5468.808591699351, 4813.229883218738, 4818.734969576637, 4825.324454576362, 4837.467878533358, 4840.34655321527, 6144.4697282790075, 6340.809775706736, 6341.207349081365, 6368.681565921685, 6385.329540398191, 6716.731330746716, 6818.556793808387, 6852.246252912176, 6867.759628412981, 6908.585484870924, 6319.273283572356, 6330.651814150174, 6345.33373995733, 6353.4599559038, 6367.713452894538, 5966.731497082642, 5971.373005834412, 6000.21997140369, 6017.0, 6026.517878569792, 6639.336066393419, 6731.293214212437, 6846.075779769667, 6934.0, 6992.0560724303605, 6854.143232095988, 6878.621675807879, 6897.41371983387, 6907.13660792401, 6922.996165556067, 6915.786948176536, 6916.619585922823, 6947.687354068978, 6973.79078627642, 6983.336583024605, 6474.125992991075, 6540.345965403612, 6586.209654841449, 6591.274959754519, 6789.524733268821, 5521.282233309644, 6603.0, 6816.931830681629, 6874.415674667709, 6887.862242755217, 5959.642421454727, 6346.413396650837, 6376.808695739135, 6391.201099862517, 6629.801105966829, 6540.640264785482, 6617.867642647024, 6626.56927299724, 6640.83397915056, 6652.234992975869, 6271.153394291712, 6450.580712253689, 6456.096146539394, 6465.741370345134, 6474.093626892333, 6344.143540621957, 6595.175603049619, 6618.966905165444, 6624.8343791405605, 6639.535232533676, 6359.841003974938, 6416.0, 6473.190851143607, 6475.061116138228, 6546.541742078009], "value": 6165.33910414274, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.6473692627538, 814.2630919018288, 839.2866063845731, 1282.6600950748048, 1288.08545932388, 38095.61904380955, 38902.80548597257, 38905.61094389059, 39157.60842391575, 39855.0, 31385.686143138562, 39163.80418097905, 39172.412413813814, 39265.41101883467, 39403.605963940354, 8109.0, 8229.177082291753, 8518.787030324229, 8791.956040219822, 8793.384463087554, 8695.434796738224, 8734.606942687595, 8810.735677929672, 8819.647214111428, 8828.293736501064, 8756.168164024408, 8819.073997230294, 8829.028806831244, 8840.734777956639, 8852.51311177885, 8768.0, 8770.824583508325, 8807.515586642732, 8809.163129502687, 8815.0, 8589.055203927563, 8629.568521573896, 8630.870536941951, 8638.956805215934, 8643.2653224476, 31504.842475787475, 38194.80902595497, 38503.03742406434, 38523.42214866779, 38590.80704596459, 3668.853245870189, 3700.85196592136, 3705.4441833724886, 3709.0912726382207, 3709.6290370962956, 31374.686253137406, 31396.174344308893, 31453.0, 31459.0, 31488.0, 3172.1752344390393, 3193.1218914798383, 3193.2495863472063, 3202.823844688541, 3208.0856955767495, 228239.99999999834, 231277.0, 238271.80864095743, 292510.0, 294665.0, 48105.27842082371, 48347.03305933862, 48518.0, 48542.5145748538, 48594.75702621464, 50497.242541361906, 50601.0, 50607.49392506101, 50737.0, 50781.492185078416, 14688.265586720621, 14801.777973330409, 14802.925985370219, 14820.184889830947, 14829.77755333671, 12071.336076515876, 12082.093842961813, 12092.758144837055, 12113.697157570956, 12140.150189486827, 13762.518311859038, 13771.449142034407, 13800.654983625489, 13832.616738326287, 13892.0, 5932.555058370639, 5979.252593425822, 6019.645579744522, 6023.608465449732, 6028.367021462771, 1014.9441780702132, 1039.1686650679426, 1049.1134990932649, 1069.6149386220955, 1092.6066616018227, 23600.29199124029, 23627.29118126459, 24299.51400972006, 25068.749312506643, 25145.748542514706, 1130.5421304371744, 1138.561653763307, 1173.2373956927895, 1175.1656324010048, 1181.2440038375446, 12436.766440725296, 16187.028778273341, 16376.0, 16740.916295418687, 16755.2460139294, 322983.0, 325528.0, 325779.0, 325963.0, 326241.0, 59515.702421487615, 59924.80150397055, 59975.0, 60001.0, 60132.0, 1411.4142630808099, 1499.1080307217405, 1535.8080239970004, 1538.8461153884523, 1543.5909483986752, 30292.84853575718, 30671.846640766653, 30714.0, 31292.687073129888, 31322.530162048042, 40019.0, 40028.1994360117, 40156.0, 40303.59696402998, 40432.59567404288, 292606.0, 293751.0, 293959.5302023476, 294095.52952235105, 294685.0, 30367.544486833158, 34860.651393486754, 37133.44299835559, 37325.25349493049, 37366.62633373631, 45865.0, 46780.53219467898, 47088.52911470841, 47097.0, 47204.0, 27030.86484567643, 28884.7111528882, 30704.692953070182, 31337.216569585944, 32145.839270803495, 30905.381892362475, 31819.522707158947, 31874.681253187173, 31992.68007319897, 32118.357632846746, 37855.62144378631, 38018.8099059514, 38040.0, 38089.0, 38123.42814857724, 30556.388872222877, 31460.37079258448, 31516.0, 32101.518477222395, 32486.350272993936, 21410.89294553517, 24322.27033189007, 24517.141900033414, 24526.754732452446, 24666.50666986686], "value": 18158.375719296062, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.57101756208647, 431.6719293337065, 448.80028387367616, 454.5590776946361, 459.5129163087128, 19466.610667786652, 20958.26646067388, 21680.891595542038, 21775.128994840226, 21808.345749627515, 21282.89358553209, 21307.680384794203, 21462.785372146274, 21606.567868642658, 21747.891260543674, 4886.804527818883, 5523.337199536041, 5809.302883653967, 5960.374160713128, 6094.146819445281, 5475.206095116206, 5914.852128696774, 6001.66990815505, 6175.197224360849, 6244.438000579947, 6019.638821670714, 6134.969325153368, 6167.167432396636, 6181.165542651729, 6191.535634827384, 6019.578629495937, 6119.418655227746, 6148.569600128015, 6149.969250153743, 6159.938400615982, 5280.6039547034125, 5439.292891924025, 5447.291852059207, 5448.046591846411, 5464.180372944051, 26286.73713262862, 26472.338191545172, 27008.054718084968, 27100.45799084027, 27428.314292142655, 2191.2768786300644, 2212.3362991102604, 2289.5306462175213, 2297.6094064009158, 2303.8041766449874, 16198.35206591735, 17078.23147958345, 17142.828571714246, 17583.857049291884, 17808.931464112196, 2146.270268108835, 2171.5982543229397, 2177.8366622503218, 2188.72640919885, 2189.0805861538192, 129595.99999999905, 136977.0, 159778.0, 166192.16903915402, 170209.29790702058, 11972.700682483008, 12466.937665311796, 12615.873841261653, 12630.81053784194, 12662.49350026007, 16288.0, 16323.836761632232, 16328.67342653164, 16366.509004729876, 16409.507714768577, 7727.65225564851, 8554.401191916631, 8766.474011559327, 8853.778655533662, 8899.288056955427, 8079.555624440594, 8276.255137037695, 8315.50320942224, 8424.326053915673, 8451.0, 6831.0, 7583.02841261265, 7661.157272699998, 7741.645212087862, 7851.254130857559, 1881.4543782302978, 2091.891297612268, 2133.306675330524, 2134.978650213509, 2299.0688771047753, 956.6269155029544, 966.6326795817545, 1000.3747657713928, 1005.9094681478703, 1028.3315844700855, 17437.30250789954, 20431.8978405107, 20463.28378506745, 20511.8974405127, 20711.0, 991.7173605522391, 998.2313618513704, 1015.6242190389603, 1022.3048327137469, 1025.251566356564, 9906.257030722725, 9967.55146018431, 10322.12261957727, 10357.223208259411, 10373.170146388271, 579315.0, 589272.0, 591234.0438297781, 596819.0, 597160.0, 110086.89913100767, 113369.4331528337, 136513.3174334122, 140613.0, 142499.0, 1196.3001644038336, 1241.6523373455627, 1259.974800504003, 1263.9684007899875, 1271.3516106785605, 18698.813011869708, 20796.896015519826, 21036.368908932145, 21157.471063223544, 21717.0, 58649.70675146597, 58898.70550647219, 59113.70443147757, 59619.70190149022, 59638.70180649069, 75239.62380188065, 76180.0, 76765.61617191878, 77428.0, 78526.0, 8646.221840034426, 8956.477398842342, 9027.916650002042, 9131.726048218565, 9257.35198536096, 12299.631011069681, 12600.684982875502, 13835.169889806644, 14224.0, 14745.11529308245, 10885.455727213766, 11932.642020739391, 12060.457279422271, 12101.031917446408, 12160.270383777002, 9665.516724163623, 11418.543258269909, 11618.727004602857, 11683.707907302385, 11748.0, 11852.288862668267, 11984.40077996114, 12120.787921207808, 12203.328816915155, 12631.305278209788, 7471.439642026979, 8774.605142768718, 8788.736337909873, 9168.037356077515, 9177.495237761721, 10145.543450544596, 11654.825177622173, 12003.399830008639, 12043.578474753342, 12308.384580770746], "value": 10390.26305075933, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1389.3678376338764, 1429.885609151268, 1446.8408475067733, 1453.3895763779212, 1459.2995362226134, 11487.942560287207, 11841.881581184185, 11904.285742855434, 11957.64127076187, 12264.754704905896, 11728.706782330446, 11944.82082768757, 11975.880241197585, 11982.101342399334, 12047.457864396101, 2308.076769292288, 2528.6839145106906, 2561.4748976459873, 2573.935651608706, 2581.2385346322785, 2120.533482633818, 2388.3909603051284, 2547.3249588858966, 2554.463562651845, 2555.3356127406823, 2510.57320255557, 2518.2193520008764, 2527.810414218932, 2550.3241640965066, 2553.6552565403713, 2436.4639779248537, 2478.0583378316305, 2503.086373473678, 2516.3331717094984, 2531.1520640585427, 2215.6898034275055, 2455.398427385302, 2538.746125387465, 2543.9315487495296, 2551.808614353912, 10658.946705266502, 11263.21157518974, 11880.524779008829, 11978.281303121841, 11984.041276697842, 6533.575317604388, 6791.932080679179, 6799.354061364163, 6805.421539169177, 6821.829454263683, 3830.3488406970882, 4111.2188684150215, 4339.739615623042, 4375.299952007664, 4469.307257375112, 1145.9484323205477, 1262.72851336963, 1278.7532156147774, 1328.103530117167, 1343.5834891183765, 16433.424830130887, 16719.414820481346, 16810.66378672432, 16847.831521684748, 17011.829881701273, 5611.102223644198, 5674.659520428788, 5848.736806843703, 5848.736806843703, 5859.1797148399255, 12417.503299867903, 12497.312647804458, 12509.49962001528, 12523.56167534132, 12552.184108032949, 6637.70130344126, 6666.600003999775, 6667.133272674521, 6672.699728512229, 6672.83317917056, 6006.159137720722, 6178.351273116348, 6193.071039344134, 6255.0, 6261.373862613702, 4339.088791353851, 4476.194285028661, 4513.50351461339, 4544.431946006749, 4561.087782443525, 1301.8372703412074, 1321.1148530484597, 1321.1280554833957, 1342.2483409290828, 1343.0, 806.9354451643854, 835.6197929941862, 845.8012367093728, 850.59596691571, 871.2681347667863, 5950.761969521257, 5978.4021597839865, 6187.628742275388, 6416.7754128605275, 6499.642519661464, 588.8969430349672, 599.7301214453513, 607.7629724407485, 609.1076572820839, 622.4097431063585, 3722.8696995605023, 3846.74996125251, 4370.497392799805, 4451.287793952952, 4578.0, 12237.0, 15329.540113796604, 15406.22968851553, 15504.0, 15510.689786204213, 12550.43523041447, 15328.923355383151, 15344.846551534341, 15351.232438378036, 15377.0, 7623.618819059025, 8193.590320483952, 8545.957270213734, 8566.357523185787, 8756.649734010569, 6632.867342653217, 6773.932260677528, 7209.026781384446, 7296.7081316746735, 7310.926890731237, 12688.619341419771, 12937.611871643865, 12946.482140714266, 12977.610671679864, 13000.869991299965, 13275.004374671746, 13291.0, 13310.534131305358, 13414.798778018143, 13495.325233738078, 8462.984441867015, 8675.522846243517, 8686.78283042929, 8696.086910874266, 8816.823663526566, 10666.146708263475, 10706.571737130427, 10773.569057237935, 10788.946055269673, 10803.135749140207, 7621.504602201061, 8998.685046023358, 9071.365004449624, 9107.362484626277, 9132.543372831198, 8820.558972051243, 8898.55507224649, 8900.976387715496, 8905.643774248958, 8926.107389261022, 8055.436119471815, 8156.877646835421, 8183.058948221031, 8207.548584827891, 8213.178682131738, 5677.77288908439, 6035.456808887221, 6117.235345581802, 6154.446099851035, 6200.3179650239335, 5994.28068631767, 6042.244719410074, 6091.604045737013, 6263.248410190624, 6274.341194174546], "value": 5340.438799783656, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.1874579061588, 396.986105486308, 411.33774622857214, 425.46816479400746, 425.6573458366014, 4882.974575339179, 5246.422893481714, 6188.907166392502, 6272.247330320357, 6388.936110638892, 5194.974025129869, 5942.405759424056, 6049.455549000589, 6238.59449135807, 6290.308066112724, 4423.579759922818, 4725.8818529536775, 4780.067886762083, 4781.545753153445, 4782.904341913159, 4626.907461850761, 4732.929006064912, 4741.596964258042, 4762.857114286577, 4774.952250477503, 4159.916801663965, 4392.34114882767, 4669.019505903764, 4694.342792009104, 4734.715917044989, 4719.74041427723, 4729.290606409032, 4734.455537613184, 4735.0293189896165, 4763.618910487187, 4114.341705327163, 4131.690123240739, 4143.549757584821, 4184.0, 4231.534531201565, 6084.209052823149, 6093.756249750005, 6105.358937311607, 6110.327863935008, 6131.019036954066, 4687.437507499088, 4762.595179409755, 5508.586855985817, 5607.775688972477, 5615.5507559395555, 5624.9875022495935, 6197.597156184834, 6369.745210191587, 6421.550491465599, 6669.933300666979, 4190.664746820247, 4260.190563792869, 4692.343071969927, 4745.59662428694, 4747.145513807513, 5232.529072383504, 5663.0, 6882.174139103339, 6983.0, 7084.645767711645, 4861.0, 4931.506849315111, 4940.481249468826, 4943.777530011158, 4943.802247910044, 4613.100445413179, 4938.38270216223, 5048.29323894655, 5051.520105589963, 5062.367204099488, 4962.5533701967, 5030.2957585938, 5397.622166448389, 5606.243157173811, 5617.691026993554, 5409.5131438169965, 5959.731812068468, 6702.296258892844, 6741.359570840762, 6758.797236082925, 1635.5011721424842, 1666.8083170435314, 1678.731402975518, 1744.7208446648729, 1751.8510926571385, 1185.9229150105216, 1191.7139886427194, 1207.9939600302118, 1211.473009240983, 1225.5342969671467, 6182.876342473215, 6199.535034872402, 6202.162708034358, 6210.813675589739, 6233.594816336924, 5714.0, 6813.659317034128, 6814.829629259309, 6826.4538836892925, 6867.2102708189195, 5178.766955487012, 5893.793717219876, 6094.512439004869, 6201.224846894138, 6236.282827474808, 3078.768492602977, 3222.2910959588853, 3318.0, 3561.5013898054294, 3612.9277414451562, 5734.741936612862, 5818.709064546756, 6725.520385515277, 6999.475039371966, 7068.586282743369, 6143.56995010345, 6779.694913728894, 7026.4541800803745, 7047.43620510358, 7053.92946070543, 6722.966385168141, 6951.339622735832, 6984.755533556301, 7034.718611255595, 7116.715331386687, 6137.723802428991, 6602.801915942529, 6795.558288711218, 6863.931360686329, 6873.175218973755, 5700.0, 6298.937010629835, 6569.667767942312, 6770.1537307836525, 6793.830154246183, 5694.943050569441, 6729.596224226562, 6957.826054348479, 6977.511574189961, 7018.824529386806, 4908.165611846066, 4921.950780492292, 4926.531979461945, 4959.925601116059, 4985.626078044089, 5854.443827836349, 6442.226932768098, 6840.0, 6840.247572767091, 6862.279460656759, 6600.966995164993, 6616.239132499824, 6618.536702430976, 6653.833654158491, 6654.500912431684, 5633.352164501135, 6323.873522529616, 6527.934720652733, 6630.988252107599, 6632.280764886374, 6460.806175814545, 6487.967560162169, 6492.0, 6493.480521558358, 6527.445167160845, 5643.604947653625, 6349.333320001518, 6438.323975982642, 6589.4069533742195, 6641.369069938348, 5281.419043905091, 6453.128827608213, 6469.805905822833, 6509.414152726277, 6519.902201466887], "value": 4893.270587310833, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [832.5337810825935, 841.8316336732659, 870.6299822575404, 877.9333110271021, 878.9956050219748, 14586.781198282008, 15163.711084557826, 16523.091229982347, 17030.574235644115, 17116.486505404842, 12759.936200319009, 13200.141990770593, 16970.83029169708, 16988.32046718133, 17236.741448878278, 963.4749061761322, 996.6412091647002, 1007.8286691262502, 1026.5483187397522, 1034.0796690945065, 985.3102828020415, 1002.9749256268578, 1030.6083688198473, 1032.401207299768, 1037.7924415117006, 1058.9099926506217, 1087.7878813631346, 1087.9782404351909, 1089.8910108989116, 1090.0462095666292, 1059.9629012984547, 1074.854894589236, 1079.2067830144797, 1079.87581428136, 1080.0495563903753, 794.6503538443125, 801.7714951238869, 806.330745481255, 808.975730728079, 812.9227723366271, 16778.83221167797, 17112.57218569546, 17213.655726885518, 17233.396831110975, 17526.91236543822, 17234.741478877826, 17318.307267709275, 17597.384091556734, 17598.208080636403, 17652.646947060988, 12481.625551233477, 12785.424655890414, 13825.654358641115, 14072.366743496566, 14219.146851188962, 3520.806355650438, 3543.574771027493, 3556.8399422025814, 3557.2529768748595, 3561.554805649294, 102779.97220027779, 114999.0, 126215.47569048568, 129930.3503482486, 130164.04753928793, 13101.344932753515, 13142.211467311992, 13154.750298721607, 13267.469301227842, 13356.799648005288, 22615.321540353816, 23646.817659117318, 24452.75547244505, 24828.131015414372, 25218.873905630353, 7807.219278072147, 7850.371970242367, 7858.0570331560575, 7861.685532578747, 7872.173421790744, 3943.3690609502914, 4069.694772891986, 4091.8158682859344, 4093.815778289984, 4100.958990410118, 3843.9039024024623, 4241.27898257297, 4367.716098453654, 4375.2780791169735, 4700.247960326331, 899.9190072893471, 905.9581481296561, 923.385948344357, 924.2975338742469, 924.357571487823, 646.977355792545, 663.2306524431636, 671.3789744486428, 674.5851301449671, 692.6882902693808, 10245.385276883411, 11142.665720028412, 11437.771244575228, 11866.347350895783, 12076.818847717292, 635.5614625908108, 644.8516841126567, 662.5660192573872, 690.7927621713567, 695.5548448992648, 5447.700376479332, 5516.123095594559, 5693.202951586781, 5713.085906254979, 5801.767929282866, 103107.93784124426, 104937.0, 105305.47347263368, 106382.46808765907, 107178.46410767896, 84392.0, 88721.0, 88782.0, 89895.0, 90864.54567727119, 77680.0, 78206.0, 78614.0, 80249.19750802535, 80274.0, 10060.792704875461, 10661.680149595524, 11906.04751619851, 12309.630711078682, 12482.875171248534, 38104.428433574074, 38968.41547376848, 39332.80333598314, 41354.37968430416, 42180.78909605432, 53207.0, 53768.462315376346, 53838.0, 53959.73020134874, 53978.19032714591, 15755.527334179993, 15772.60568485797, 15892.364305427653, 16078.35686572524, 16206.67586648284, 17889.552761180556, 18038.819611803712, 18125.36561220351, 18322.358717444826, 18353.90823045876, 16482.75275870839, 16502.42241521541, 16506.504804855875, 16710.66578668444, 16788.580285492473, 15089.849101509284, 15810.7628385572, 15946.60133496672, 16382.918085409498, 16482.42311519091, 16135.919320403324, 16432.424865130142, 16722.163891805605, 16945.66108677844, 16956.74564881503, 11757.824217578174, 11791.35147566892, 11854.525818967144, 12279.877201227873, 12326.81509777336, 12647.620571382506, 13616.0, 13641.181529107887, 13661.79507307411, 14054.0], "value": 8353.581344454193, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1556.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 98.0, 138.0, 109.0, 163.0, 162.0, 129.0, 116.0, 118.0, 115.0], "value": 124.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 124.0, 110.0, 150.0, 112.0, 143.0, 98.0, 97.0, 157.0, 140.0], "value": 127.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 200.0, 209.0, 222.0, 256.0, 233.0, 272.0, 206.0, 274.0, 236.0], "value": 230.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 60.0, 93.0, 82.0, 77.0, 58.0, 61.0, 78.0, 62.0], "value": 70.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 74.0, 85.0, 69.0, 65.0, 71.0, 94.0, 97.0, 97.0, 107.0], "value": 84.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 89.0, 88.0, 89.0, 129.0, 129.0, 99.0, 128.0, 91.0], "value": 101.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 103.0, 95.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0], "value": 96.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 105.0, 90.0, 94.0, 90.0, 90.0, 100.0, 91.0, 90.0], "value": 93.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 48.0, 52.0, 51.0, 52.0, 54.0, 51.0, 52.0, 51.0, 53.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 56.0, 65.0, 63.0, 61.0, 59.0, 56.0, 57.0, 57.0, 57.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 99.0, 80.0, 100.0, 104.0, 105.0, 103.0, 91.0, 84.0, 83.0], "value": 94.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 151.0, 167.0, 159.0, 128.0, 145.0, 142.0, 166.0, 200.0, 146.0], "value": 156.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 226.0, 225.0, 193.0, 189.0, 185.0, 189.0, 191.0, 176.0, 192.0], "value": 194.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 71.0, 70.0, 71.0, 71.0, 69.0, 69.0, 71.0, 73.0], "value": 70.6, "unit": "score"}]}]} 16:39:41 INFO - Return code: 0 16:39:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:39:41 ERROR - # TBPL SUCCESS # 16:39:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:39:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:39:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:39:41 INFO - 2017-04-14 16:39:41.492 screenresolution[1664:10974] starting screenresolution argv=screenresolution get 16:39:41 INFO - 2017-04-14 16:39:41.495 screenresolution[1664:10974] Display 0: 1600x1200x32@60 16:39:41 INFO - 2017-04-14 16:39:41.502 screenresolution[1665:10977] starting screenresolution argv=screenresolution list 16:39:41 INFO - Available Modes on Display 0 16:39:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:39:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:39:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:39:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:39:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:39:41 INFO - Intel Iris: 16:39:41 INFO - Chipset Model: Intel Iris 16:39:41 INFO - Type: GPU 16:39:41 INFO - Bus: Built-In 16:39:41 INFO - VRAM (Dynamic, Max): 1536 MB 16:39:41 INFO - Vendor: Intel (0x8086) 16:39:41 INFO - Device ID: 0x0a2e 16:39:41 INFO - Revision ID: 0x0009 16:39:41 INFO - Displays: 16:39:41 INFO - Display: 16:39:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:39:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:39:41 INFO - Display Serial Number: 1600x1200 60 16:39:41 INFO - Main Display: Yes 16:39:41 INFO - Mirror: Off 16:39:41 INFO - Online: Yes 16:39:41 INFO - Rotation: Supported 16:39:41 INFO - Return code: 0 16:39:41 INFO - Running post-action listener: _resource_record_post_action 16:39:41 INFO - [mozharness: 2017-04-14 23:39:41.750343Z] Finished run-tests step (success) 16:39:41 INFO - Running post-run listener: _resource_record_post_run 16:39:41 INFO - Total resource usage - Wall time: 1197s; CPU: 55.0%; Read bytes: 43203584; Write bytes: 513558528; Read time: 439; Write time: 1710 16:39:41 INFO - TinderboxPrint: CPU usage
54.6% 16:39:41 INFO - TinderboxPrint: I/O read bytes / time
43,203,584 / 439 16:39:41 INFO - TinderboxPrint: I/O write bytes / time
513,558,528 / 1,710 16:39:41 INFO - TinderboxPrint: CPU idle
2,173.9 (45.4%) 16:39:41 INFO - TinderboxPrint: CPU system
965.9 (20.2%) 16:39:41 INFO - TinderboxPrint: CPU user
1,649.9 (34.4%) 16:39:41 INFO - TinderboxPrint: Swap in / out
248,619,008 / 0 16:39:41 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 198783488; Write bytes: 193210368; Read time: 15132; Write time: 391 16:39:41 INFO - run-tests - Wall time: 1179s; CPU: 55.0%; Read bytes: 42204160; Write bytes: 303505408; Read time: 422; Write time: 1270 16:39:42 INFO - Running post-run listener: _upload_blobber_files 16:39:42 INFO - Blob upload gear active. 16:39:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:39:42 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 16:39:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:39:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:39:42 INFO - (blobuploader) - INFO - Open directory for files ... 16:39:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:39:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:39:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:39:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:39:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:39:43 INFO - (blobuploader) - INFO - Done attempting. 16:39:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:39:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:39:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:39:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:39:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:39:44 INFO - (blobuploader) - INFO - Done attempting. 16:39:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:39:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:39:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:39:45 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:39:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:39:45 INFO - (blobuploader) - INFO - Done attempting. 16:39:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:39:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:39:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:39:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:39:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:39:49 INFO - (blobuploader) - INFO - Done attempting. 16:39:49 INFO - (blobuploader) - INFO - Iteration through files over. 16:39:49 INFO - Return code: 0 16:39:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:39:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:39:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd3083d98c50532412919e95476c0486a2be8a4b04396bc8285668e977618fb35e629e86c79eb8f2f20bc834d61c9a84301b7919f5f0e6edc4f3ea8d36083541", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cf8c0c0f78cb0bb0573c4ef57a98c92b10202ed5c54c507803b69143326e811611b2156ceb7839539b958aa897f37061ffe57203d024e0f698d018005292b08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9ceb47cd86e14afc25ca5f5d81fd382cf71581d9e26c2cc0d7da2cd116034af36d569f0dde4d008ef242c89e2f919b1e9d78e1f41cb3486fea1b10c4e6c7ff2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ad0a1428f0d1234fa16cd4c2c4f8c0555a0905f970d6363f3ee2d671799233d2cdb3645286444823c58cbbeaf595ed3ada342ac373e5b64531b62575b1464ec"} 16:39:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:39:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:39:49 INFO - Contents: 16:39:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd3083d98c50532412919e95476c0486a2be8a4b04396bc8285668e977618fb35e629e86c79eb8f2f20bc834d61c9a84301b7919f5f0e6edc4f3ea8d36083541", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cf8c0c0f78cb0bb0573c4ef57a98c92b10202ed5c54c507803b69143326e811611b2156ceb7839539b958aa897f37061ffe57203d024e0f698d018005292b08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9ceb47cd86e14afc25ca5f5d81fd382cf71581d9e26c2cc0d7da2cd116034af36d569f0dde4d008ef242c89e2f919b1e9d78e1f41cb3486fea1b10c4e6c7ff2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ad0a1428f0d1234fa16cd4c2c4f8c0555a0905f970d6363f3ee2d671799233d2cdb3645286444823c58cbbeaf595ed3ada342ac373e5b64531b62575b1464ec"} 16:39:49 INFO - Running post-run listener: copy_logs_to_upload_dir 16:39:49 INFO - Copying logs to upload dir... 16:39:49 INFO - mkdir: /builds/slave/test/build/upload/logs 16:39:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.401170 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-14 16:39:49.144206) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-14 16:39:49.147242) ========= 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.XNMTO2NpYh/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.JemVZzxMX5/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd3083d98c50532412919e95476c0486a2be8a4b04396bc8285668e977618fb35e629e86c79eb8f2f20bc834d61c9a84301b7919f5f0e6edc4f3ea8d36083541", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cf8c0c0f78cb0bb0573c4ef57a98c92b10202ed5c54c507803b69143326e811611b2156ceb7839539b958aa897f37061ffe57203d024e0f698d018005292b08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9ceb47cd86e14afc25ca5f5d81fd382cf71581d9e26c2cc0d7da2cd116034af36d569f0dde4d008ef242c89e2f919b1e9d78e1f41cb3486fea1b10c4e6c7ff2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ad0a1428f0d1234fa16cd4c2c4f8c0555a0905f970d6363f3ee2d671799233d2cdb3645286444823c58cbbeaf595ed3ada342ac373e5b64531b62575b1464ec"} build_url:https://queue.taskcluster.net/v1/task/TQa6C1WRT8qIuD6UvE3O5g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011020 build_url: 'https://queue.taskcluster.net/v1/task/TQa6C1WRT8qIuD6UvE3O5g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd3083d98c50532412919e95476c0486a2be8a4b04396bc8285668e977618fb35e629e86c79eb8f2f20bc834d61c9a84301b7919f5f0e6edc4f3ea8d36083541", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cf8c0c0f78cb0bb0573c4ef57a98c92b10202ed5c54c507803b69143326e811611b2156ceb7839539b958aa897f37061ffe57203d024e0f698d018005292b08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9ceb47cd86e14afc25ca5f5d81fd382cf71581d9e26c2cc0d7da2cd116034af36d569f0dde4d008ef242c89e2f919b1e9d78e1f41cb3486fea1b10c4e6c7ff2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ad0a1428f0d1234fa16cd4c2c4f8c0555a0905f970d6363f3ee2d671799233d2cdb3645286444823c58cbbeaf595ed3ada342ac373e5b64531b62575b1464ec"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-14 16:39:49.180926) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-14 16:39:49.181279) ========= 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.XNMTO2NpYh/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.JemVZzxMX5/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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.005234 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-14 16:39:49.229694) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-14 16:39:49.230015) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-14 16:39:49.230333) ========= ========= Total master_lag: 0.18 =========