builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0115 starttime: 1485432352.74 results: success (0) buildid: 20170126033131 builduid: 3832566940ab4cc88edd6d6d35f022e0 revision: 1e036cc4bf25338708b1466a4756316390557241 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-26 04:05:52.740485) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-26 04:05:52.741330) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-26 04:05:52.741975) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-26 04:05:52.920095) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 04:05:52.920408) ========= 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.a56emPfuzQ/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.A0RkPQ3DpR/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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-01-26 04:05:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 66.0M=0s 2017-01-26 04:05:53 (66.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.556643 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 04:05:53.526686) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 04:05:53.526965) ========= 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.a56emPfuzQ/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.A0RkPQ3DpR/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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.027108 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 04:05:53.579276) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-26 04:05:53.579640) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1e036cc4bf25338708b1466a4756316390557241 --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 1e036cc4bf25338708b1466a4756316390557241 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.a56emPfuzQ/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.A0RkPQ3DpR/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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-01-26 04:05:53,565 truncating revision to first 12 chars 2017-01-26 04:05:53,565 Setting DEBUG logging. 2017-01-26 04:05:53,565 attempt 1/10 2017-01-26 04:05:53,565 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1e036cc4bf25?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-26 04:05:54,558 unpacking tar archive at: mozilla-central-1e036cc4bf25/testing/mozharness/ program finished with exit code 0 elapsedTime=1.264066 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-26 04:05:54.870503) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-26 04:05:54.873960) ========= script_repo_revision: 1e036cc4bf25338708b1466a4756316390557241 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-26 04:05:54.874807) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-26 04:05:54.875077) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-26 04:05:54.894896) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-01-26 04:05:54.895280) ========= /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.a56emPfuzQ/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.A0RkPQ3DpR/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 04:05:54 INFO - MultiFileLogger online at 20170126 04:05:54 in /builds/slave/test 04:05:54 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 04:05:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:05:54 INFO - {'append_to_log': False, 04:05:54 INFO - 'base_work_dir': '/builds/slave/test', 04:05:54 INFO - 'blob_upload_branch': 'Firefox', 04:05:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:05:54 INFO - 'branch': 'Firefox', 04:05:54 INFO - 'buildbot_json_path': 'buildprops.json', 04:05:54 INFO - 'config_files': ('talos/mac_config.py',), 04:05:54 INFO - 'default_actions': ('clobber', 04:05:54 INFO - 'read-buildbot-config', 04:05:54 INFO - 'download-and-extract', 04:05:54 INFO - 'populate-webroot', 04:05:54 INFO - 'create-virtualenv', 04:05:54 INFO - 'install', 04:05:54 INFO - 'run-tests'), 04:05:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:05:54 INFO - 'download_minidump_stackwalk': True, 04:05:54 INFO - 'download_symbols': 'ondemand', 04:05:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:05:54 INFO - 'tooltool.py': '/tools/tooltool.py', 04:05:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:05:54 INFO - '/tools/misc-python/virtualenv.py')}, 04:05:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:05:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:05:54 INFO - 'installer_path': 'installer.exe', 04:05:54 INFO - 'log_level': 'info', 04:05:54 INFO - 'log_name': 'talos', 04:05:54 INFO - 'log_to_console': True, 04:05:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:05:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:05:54 INFO - 'opt_config_files': (), 04:05:54 INFO - 'pip_index': False, 04:05:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:05:54 INFO - 'cmd': ('bash', 04:05:54 INFO - '-c', 04:05:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:05:54 INFO - 'enabled': True, 04:05:54 INFO - 'halt_on_failure': False, 04:05:54 INFO - 'name': 'check_screen_resolution'},), 04:05:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:05:54 INFO - 'cmd': ('bash', 04:05:54 INFO - '-c', 04:05:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:05:54 INFO - 'enabled': True, 04:05:54 INFO - 'halt_on_failure': False, 04:05:54 INFO - 'name': 'check_screen_resolution'},), 04:05:54 INFO - 'run_cmd_checks_enabled': True, 04:05:54 INFO - 'sps_profile': False, 04:05:54 INFO - 'sps_profile_interval': 0, 04:05:54 INFO - 'suite': 'dromaeojs-e10s', 04:05:54 INFO - 'system_bits': '32', 04:05:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:05:54 INFO - 'title': 't-yosemite-r7-0115', 04:05:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:05:54 INFO - 'use_talos_json': True, 04:05:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:05:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:05:54 INFO - 'work_dir': 'build'} 04:05:54 INFO - [mozharness: 2017-01-26 12:05:54.993064Z] Running clobber step. 04:05:54 INFO - Running pre-action listener: _resource_record_pre_action 04:05:54 INFO - Running main action method: clobber 04:05:54 INFO - rmtree: /builds/slave/test/build 04:05:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:05:58 INFO - Running post-action listener: _resource_record_post_action 04:05:58 INFO - [mozharness: 2017-01-26 12:05:58.058979Z] Finished clobber step (success) 04:05:58 INFO - [mozharness: 2017-01-26 12:05:58.059129Z] Running read-buildbot-config step. 04:05:58 INFO - Running pre-action listener: _resource_record_pre_action 04:05:58 INFO - Running main action method: read_buildbot_config 04:05:58 INFO - Using buildbot properties: 04:05:58 INFO - { 04:05:58 INFO - "project": "", 04:05:58 INFO - "product": "firefox", 04:05:58 INFO - "script_repo_revision": "production", 04:05:58 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:05:58 INFO - "repository": "", 04:05:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:05:58 INFO - "buildid": "20170126033131", 04:05:58 INFO - "pgo_build": "False", 04:05:58 INFO - "basedir": "/builds/slave/test", 04:05:58 INFO - "buildnumber": 23, 04:05:58 INFO - "slavename": "t-yosemite-r7-0115", 04:05:58 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 04:05:58 INFO - "platform": "yosemite_r7", 04:05:58 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:05:58 INFO - "branch": "mozilla-central", 04:05:58 INFO - "repo_path": "mozilla-central", 04:05:58 INFO - "revision": "1e036cc4bf25338708b1466a4756316390557241", 04:05:58 INFO - "stage_platform": "macosx64", 04:05:58 INFO - "builduid": "3832566940ab4cc88edd6d6d35f022e0", 04:05:58 INFO - "slavebuilddir": "test" 04:05:58 INFO - } 04:05:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 04:05:58 INFO - Running post-action listener: _resource_record_post_action 04:05:58 INFO - [mozharness: 2017-01-26 12:05:58.062396Z] Finished read-buildbot-config step (success) 04:05:58 INFO - [mozharness: 2017-01-26 12:05:58.062529Z] Running download-and-extract step. 04:05:58 INFO - Running pre-action listener: _resource_record_pre_action 04:05:58 INFO - Running main action method: download_and_extract 04:05:58 INFO - mkdir: /builds/slave/test/build/tests 04:05:58 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')]} 04:05:58 INFO - trying https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 04:05:58 INFO - Downloading https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:05:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 04:05:59 INFO - Downloaded 1199 bytes. 04:05:59 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:05:59 INFO - Using the following test package requirements: 04:05:59 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:05:59 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:05:59 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 04:05:59 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:05:59 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 04:05:59 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:05:59 INFO - u'jsshell-mac.zip'], 04:05:59 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:05:59 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 04:05:59 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:05:59 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:05:59 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 04:05:59 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:05:59 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 04:05:59 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:05:59 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 04:05:59 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:05:59 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 04:05:59 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:05:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:05:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:05:59 INFO - Fetch https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:06:00 INFO - Expected file size: 16351810 04:06:00 INFO - Obtained file size: 16351810 04:06:06 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:06:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:06:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:06:06 INFO - Fetch https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:06:07 INFO - Expected file size: 16351810 04:06:07 INFO - Obtained file size: 16351810 04:06:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 04:06:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:06:14 INFO - Fetch https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 04:06:15 INFO - Expected file size: 14403435 04:06:15 INFO - Obtained file size: 14403435 04:06:15 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')]} 04:06:15 INFO - trying https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:06:15 INFO - Downloading https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 04:06:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 04:06:18 INFO - Downloaded 69884182 bytes. 04:06:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:06:18 INFO - mkdir: /builds/slave/test/properties 04:06:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:06:18 INFO - Writing to file /builds/slave/test/properties/build_url 04:06:18 INFO - Contents: 04:06:18 INFO - build_url:https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:06:18 INFO - Running post-action listener: _resource_record_post_action 04:06:18 INFO - Running post-action listener: set_extra_try_arguments 04:06:18 INFO - [mozharness: 2017-01-26 12:06:18.944332Z] Finished download-and-extract step (success) 04:06:18 INFO - [mozharness: 2017-01-26 12:06:18.944476Z] Running populate-webroot step. 04:06:18 INFO - Running pre-action listener: _resource_record_pre_action 04:06:18 INFO - Running main action method: populate_webroot 04:06:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:06:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:06:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:06:18 INFO - '--tppagecycles', 04:06:18 INFO - '7'], 04:06:18 INFO - 'tests': ['tsvgm']}}, 04:06:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:06:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:06:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:06:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:06:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:06:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:06:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:06:18 INFO - 'talos_options': ['--disable-e10s'], 04:06:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:06:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:06:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:06:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:06:18 INFO - 'talos_options': ['--disable-e10s'], 04:06:18 INFO - 'tests': ['damp', 'tps']}, 04:06:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:06:18 INFO - 'tests': ['damp', 'tps']}, 04:06:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:06:18 INFO - 'tests': ['dromaeo_dom']}, 04:06:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:06:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:06:18 INFO - 'tests': ['basic_compositor_video']}, 04:06:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:06:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:06:18 INFO - 'tests': ['a11yr', 04:06:18 INFO - 'ts_paint', 04:06:18 INFO - 'tpaint', 04:06:18 INFO - 'sessionrestore', 04:06:18 INFO - 'sessionrestore_no_auto_restore', 04:06:18 INFO - 'tabpaint']}, 04:06:18 INFO - 'other-e10s': {'tests': ['a11yr', 04:06:18 INFO - 'ts_paint', 04:06:18 INFO - 'tpaint', 04:06:18 INFO - 'sessionrestore', 04:06:18 INFO - 'sessionrestore_no_auto_restore', 04:06:18 INFO - 'tabpaint']}, 04:06:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:06:18 INFO - 'ts_paint', 04:06:18 INFO - 'tpaint', 04:06:18 INFO - 'sessionrestore', 04:06:18 INFO - 'sessionrestore_no_auto_restore', 04:06:18 INFO - 'tabpaint']}, 04:06:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:06:18 INFO - 'ts_paint', 04:06:18 INFO - 'tpaint', 04:06:18 INFO - 'sessionrestore', 04:06:18 INFO - 'sessionrestore_no_auto_restore', 04:06:18 INFO - 'tabpaint']}, 04:06:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:06:18 INFO - 'tests': ['a11yr', 04:06:18 INFO - 'ts_paint', 04:06:18 INFO - 'tpaint', 04:06:18 INFO - 'sessionrestore', 04:06:18 INFO - 'sessionrestore_no_auto_restore', 04:06:18 INFO - 'tabpaint']}, 04:06:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:06:18 INFO - 'tests': ['a11yr', 04:06:18 INFO - 'ts_paint', 04:06:18 INFO - 'tpaint', 04:06:18 INFO - 'sessionrestore', 04:06:18 INFO - 'sessionrestore_no_auto_restore', 04:06:18 INFO - 'tabpaint']}, 04:06:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:06:18 INFO - 'tests': ['tsvgx', 04:06:18 INFO - 'tsvgr_opacity', 04:06:18 INFO - 'tart', 04:06:18 INFO - 'tscrollx', 04:06:18 INFO - 'cart', 04:06:18 INFO - 'tsvg_static']}, 04:06:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:06:18 INFO - 'tsvgr_opacity', 04:06:18 INFO - 'tart', 04:06:18 INFO - 'tscrollx', 04:06:18 INFO - 'cart', 04:06:18 INFO - 'tsvg_static']}, 04:06:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:06:18 INFO - 'talos_options': ['--disable-e10s'], 04:06:18 INFO - 'tests': ['tp5o']}, 04:06:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:06:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:06:18 INFO - 'talos_options': ['--disable-e10s', 04:06:18 INFO - '--xperf_path', 04:06:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:06:18 INFO - 'tests': ['tp5n']}, 04:06:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:06:18 INFO - 'talos_options': ['--xperf_path', 04:06:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:06:18 INFO - 'tests': ['tp5n']}}, 04:06:18 INFO - 'talos.zip': {'path': '', 04:06:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:06:18 INFO - Running post-action listener: _resource_record_post_action 04:06:18 INFO - [mozharness: 2017-01-26 12:06:18.963454Z] Finished populate-webroot step (success) 04:06:18 INFO - [mozharness: 2017-01-26 12:06:18.963597Z] Running create-virtualenv step. 04:06:18 INFO - Running pre-action listener: _resource_record_pre_action 04:06:18 INFO - Running main action method: create_virtualenv 04:06:18 INFO - Creating virtualenv /builds/slave/test/build/venv 04:06:18 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 04:06:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:06:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:06:19 INFO - Using real prefix '/tools/python27' 04:06:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:06:19 INFO - Installing distribute.............................................................................................................................................................................................done. 04:06:22 INFO - Installing pip.................done. 04:06:22 INFO - Return code: 0 04:06:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:06:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:06:23 INFO - Reading from file tmpfile_stdout 04:06:23 INFO - Output received: 04:06:23 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) 04:06:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:06: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')]} 04:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06: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')]} 04:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c460b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c463768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa81c85f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c23ed30>, '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 0x10c165db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c233be8>, '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.a56emPfuzQ/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.A0RkPQ3DpR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 04:06: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', 'pip>=1.5'] in /builds/slave/test/build 04:06: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 pip>=1.5 04:06:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a56emPfuzQ/Render', 04:06:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:23 INFO - 'HOME': '/Users/cltbld', 04:06:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:23 INFO - 'LOGNAME': 'cltbld', 04:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:23 INFO - 'MOZ_NO_REMOTE': '1', 04:06:23 INFO - 'NO_EM_RESTART': '1', 04:06:23 INFO - 'PAGER': '/bin/cat', 04:06:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:23 INFO - 'PWD': '/builds/slave/test', 04:06:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:23 INFO - 'SHELL': '/bin/bash', 04:06:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A0RkPQ3DpR/Listeners', 04:06:23 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 04:06:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:23 INFO - 'USER': 'cltbld', 04:06:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:23 INFO - 'XPC_FLAGS': '0x0', 04:06:23 INFO - 'XPC_SERVICE_NAME': '0', 04:06:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:23 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 04:06:23 INFO - Cleaning up... 04:06:23 INFO - Return code: 0 04:06:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:06: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')]} 04:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06: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')]} 04:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06: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', '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 0x10c460b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c463768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa81c85f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c23ed30>, '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 0x10c165db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c233be8>, '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.a56emPfuzQ/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.A0RkPQ3DpR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 04:06: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', 'psutil>=3.1.1'] in /builds/slave/test/build 04:06: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 psutil>=3.1.1 04:06:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a56emPfuzQ/Render', 04:06:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:23 INFO - 'HOME': '/Users/cltbld', 04:06:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:23 INFO - 'LOGNAME': 'cltbld', 04:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:23 INFO - 'MOZ_NO_REMOTE': '1', 04:06:23 INFO - 'NO_EM_RESTART': '1', 04:06:23 INFO - 'PAGER': '/bin/cat', 04:06:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:23 INFO - 'PWD': '/builds/slave/test', 04:06:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:23 INFO - 'SHELL': '/bin/bash', 04:06:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A0RkPQ3DpR/Listeners', 04:06:23 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 04:06:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:23 INFO - 'USER': 'cltbld', 04:06:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:23 INFO - 'XPC_FLAGS': '0x0', 04:06:23 INFO - 'XPC_SERVICE_NAME': '0', 04:06:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:23 INFO - Downloading/unpacking psutil>=3.1.1 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:06:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:06:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:06:27 INFO - Installing collected packages: psutil 04:06:27 INFO - Running setup.py install for psutil 04:06:27 INFO - building 'psutil._psutil_osx' extension 04:06:27 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 04:06:28 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 04:06:28 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 04:06:28 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 04:06:28 INFO - building 'psutil._psutil_posix' extension 04:06:28 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 04:06:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:06:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:06:28 INFO - ^ 04:06:28 INFO - 1 warning generated. 04:06:28 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 04:06:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:06:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:06:28 INFO - Successfully installed psutil 04:06:28 INFO - Cleaning up... 04:06:28 INFO - Return code: 0 04:06:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:06: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')]} 04:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06: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')]} 04:06:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:28 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 0x10c460b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c463768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa81c85f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c23ed30>, '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 0x10c165db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c233be8>, '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.a56emPfuzQ/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.A0RkPQ3DpR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 04:06:28 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 04:06:28 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 04:06:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a56emPfuzQ/Render', 04:06:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:28 INFO - 'HOME': '/Users/cltbld', 04:06:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:28 INFO - 'LOGNAME': 'cltbld', 04:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:28 INFO - 'MOZ_NO_REMOTE': '1', 04:06:28 INFO - 'NO_EM_RESTART': '1', 04:06:28 INFO - 'PAGER': '/bin/cat', 04:06:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:28 INFO - 'PWD': '/builds/slave/test', 04:06:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:28 INFO - 'SHELL': '/bin/bash', 04:06:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A0RkPQ3DpR/Listeners', 04:06:28 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 04:06:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:28 INFO - 'USER': 'cltbld', 04:06:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:28 INFO - 'XPC_FLAGS': '0x0', 04:06:28 INFO - 'XPC_SERVICE_NAME': '0', 04:06:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:06:29 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 04:06:29 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 04:06:29 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 04:06:29 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 04:06:29 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 04:06:29 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 04:06:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:06:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:06:31 INFO - Installing collected packages: mozsystemmonitor 04:06:31 INFO - Running setup.py install for mozsystemmonitor 04:06:31 INFO - Successfully installed mozsystemmonitor 04:06:31 INFO - Cleaning up... 04:06:32 INFO - Return code: 0 04:06:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:06: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')]} 04:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06: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')]} 04:06:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:32 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 0x10c460b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c463768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa81c85f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c23ed30>, '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 0x10c165db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c233be8>, '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.a56emPfuzQ/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.A0RkPQ3DpR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 04:06:32 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 04:06:32 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 04:06:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a56emPfuzQ/Render', 04:06:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:32 INFO - 'HOME': '/Users/cltbld', 04:06:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:32 INFO - 'LOGNAME': 'cltbld', 04:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:32 INFO - 'MOZ_NO_REMOTE': '1', 04:06:32 INFO - 'NO_EM_RESTART': '1', 04:06:32 INFO - 'PAGER': '/bin/cat', 04:06:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:32 INFO - 'PWD': '/builds/slave/test', 04:06:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:32 INFO - 'SHELL': '/bin/bash', 04:06:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A0RkPQ3DpR/Listeners', 04:06:32 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 04:06:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:32 INFO - 'USER': 'cltbld', 04:06:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:32 INFO - 'XPC_FLAGS': '0x0', 04:06:32 INFO - 'XPC_SERVICE_NAME': '0', 04:06:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:32 INFO - Downloading/unpacking jsonschema==2.5.1 04:06:32 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 04:06:32 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 04:06:32 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 04:06:32 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 04:06:32 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 04:06:32 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 04:06:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:06:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:35 INFO - Downloading functools32-3.2.3-2.tar.gz 04:06:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:06:35 INFO - warning: no files found matching '*.txt' 04:06:35 INFO - no previously-included directories found matching 'build' 04:06:35 INFO - no previously-included directories found matching 'dist' 04:06:35 INFO - no previously-included directories found matching '.git*' 04:06:35 INFO - Installing collected packages: jsonschema, functools32 04:06:35 INFO - Running setup.py install for functools32 04:06:35 INFO - warning: no files found matching '*.txt' 04:06:35 INFO - no previously-included directories found matching 'build' 04:06:35 INFO - no previously-included directories found matching 'dist' 04:06:35 INFO - no previously-included directories found matching '.git*' 04:06:35 INFO - Successfully installed jsonschema functools32 04:06:35 INFO - Cleaning up... 04:06:35 INFO - Return code: 0 04:06:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:06:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:35 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 0x10c460b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c463768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa81c85f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c23ed30>, '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 0x10c165db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c233be8>, '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.a56emPfuzQ/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.A0RkPQ3DpR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 04:06:35 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 04:06:35 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 04:06:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a56emPfuzQ/Render', 04:06:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:35 INFO - 'HOME': '/Users/cltbld', 04:06:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:35 INFO - 'LOGNAME': 'cltbld', 04:06:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:35 INFO - 'MOZ_NO_REMOTE': '1', 04:06:35 INFO - 'NO_EM_RESTART': '1', 04:06:35 INFO - 'PAGER': '/bin/cat', 04:06:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:35 INFO - 'PWD': '/builds/slave/test', 04:06:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:35 INFO - 'SHELL': '/bin/bash', 04:06:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A0RkPQ3DpR/Listeners', 04:06:35 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 04:06:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:35 INFO - 'USER': 'cltbld', 04:06:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:35 INFO - 'XPC_FLAGS': '0x0', 04:06:35 INFO - 'XPC_SERVICE_NAME': '0', 04:06:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:06:36 INFO - Cleaning up... 04:06:36 INFO - Return code: 0 04:06:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:06:36 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')]} 04:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:36 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')]} 04:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:36 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 0x10c460b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c463768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa81c85f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c23ed30>, '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 0x10c165db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c233be8>, '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.a56emPfuzQ/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.A0RkPQ3DpR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 04:06:36 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 04:06:36 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 04:06:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a56emPfuzQ/Render', 04:06:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:36 INFO - 'HOME': '/Users/cltbld', 04:06:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:36 INFO - 'LOGNAME': 'cltbld', 04:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:36 INFO - 'MOZ_NO_REMOTE': '1', 04:06:36 INFO - 'NO_EM_RESTART': '1', 04:06:36 INFO - 'PAGER': '/bin/cat', 04:06:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:36 INFO - 'PWD': '/builds/slave/test', 04:06:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:36 INFO - 'SHELL': '/bin/bash', 04:06:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A0RkPQ3DpR/Listeners', 04:06:36 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 04:06:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:36 INFO - 'USER': 'cltbld', 04:06:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:36 INFO - 'XPC_FLAGS': '0x0', 04:06:36 INFO - 'XPC_SERVICE_NAME': '0', 04:06:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:36 INFO - Downloading/unpacking blobuploader==1.2.4 04:06:36 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 04:06:36 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 04:06:36 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 04:06:36 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 04:06:36 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 04:06:36 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 04:06:38 INFO - Downloading blobuploader-1.2.4.tar.gz 04:06:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:06:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:06:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06:40 INFO - Downloading docopt-0.6.1.tar.gz 04:06:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:06:40 INFO - Installing collected packages: blobuploader, requests, docopt 04:06:40 INFO - Running setup.py install for blobuploader 04:06:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:06:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:06:40 INFO - Running setup.py install for requests 04:06:40 INFO - Running setup.py install for docopt 04:06:41 INFO - Successfully installed blobuploader requests docopt 04:06:41 INFO - Cleaning up... 04:06:41 INFO - Return code: 0 04:06:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:41 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 0x10c460b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c463768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa81c85f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c23ed30>, '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 0x10c165db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c233be8>, '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.a56emPfuzQ/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.A0RkPQ3DpR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 04:06:41 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 04:06:41 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 04:06:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a56emPfuzQ/Render', 04:06:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:41 INFO - 'HOME': '/Users/cltbld', 04:06:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:41 INFO - 'LOGNAME': 'cltbld', 04:06:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:41 INFO - 'MOZ_NO_REMOTE': '1', 04:06:41 INFO - 'NO_EM_RESTART': '1', 04:06:41 INFO - 'PAGER': '/bin/cat', 04:06:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:41 INFO - 'PWD': '/builds/slave/test', 04:06:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:41 INFO - 'SHELL': '/bin/bash', 04:06:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A0RkPQ3DpR/Listeners', 04:06:41 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 04:06:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:41 INFO - 'USER': 'cltbld', 04:06:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:41 INFO - 'XPC_FLAGS': '0x0', 04:06:41 INFO - 'XPC_SERVICE_NAME': '0', 04:06:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:41 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-8qzzyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:41 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-sR9aXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:41 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-TBBPtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:41 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-eVbCRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:41 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-95yt9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:41 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-AaLWeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:42 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-8sG4tm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:42 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-zINoAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:42 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-UJpkqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:42 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-kczHH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:42 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-CEILnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:42 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-IPiNhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:42 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-mvzvYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:42 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-j5ZJ8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:42 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-45Go0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:43 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-9Q13Yh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:43 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-cOsRlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:06:43 INFO - Running setup.py install for manifestparser 04:06:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:06:43 INFO - Running setup.py install for mozcrash 04:06:43 INFO - Running setup.py install for mozdebug 04:06:43 INFO - Running setup.py install for mozdevice 04:06:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:06:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:06:43 INFO - Running setup.py install for mozfile 04:06:43 INFO - Running setup.py install for mozhttpd 04:06:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:06:44 INFO - Running setup.py install for mozinfo 04:06:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:06:44 INFO - Running setup.py install for mozInstall 04:06:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:06:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:06:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:06:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:06:44 INFO - Running setup.py install for mozleak 04:06:44 INFO - Running setup.py install for mozlog 04:06:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:06:44 INFO - Running setup.py install for moznetwork 04:06:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:06:44 INFO - Running setup.py install for mozprocess 04:06:45 INFO - Running setup.py install for mozprofile 04:06:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:06:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:06:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:06:45 INFO - Running setup.py install for mozrunner 04:06:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:06:45 INFO - Running setup.py install for mozscreenshot 04:06:45 INFO - Running setup.py install for moztest 04:06:45 INFO - Running setup.py install for mozversion 04:06:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:06:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:06:45 INFO - Cleaning up... 04:06:45 INFO - Return code: 0 04:06:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:45 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')]} 04:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:45 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')]} 04:06:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:45 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 0x10c460b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c463768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa81c85f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c23ed30>, '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 0x10c165db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c233be8>, '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.a56emPfuzQ/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.A0RkPQ3DpR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 04:06:45 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 04:06:45 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 04:06:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a56emPfuzQ/Render', 04:06:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:45 INFO - 'HOME': '/Users/cltbld', 04:06:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:45 INFO - 'LOGNAME': 'cltbld', 04:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:45 INFO - 'MOZ_NO_REMOTE': '1', 04:06:45 INFO - 'NO_EM_RESTART': '1', 04:06:45 INFO - 'PAGER': '/bin/cat', 04:06:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:45 INFO - 'PWD': '/builds/slave/test', 04:06:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:45 INFO - 'SHELL': '/bin/bash', 04:06:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A0RkPQ3DpR/Listeners', 04:06:45 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 04:06:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:45 INFO - 'USER': 'cltbld', 04:06:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:45 INFO - 'XPC_FLAGS': '0x0', 04:06:45 INFO - 'XPC_SERVICE_NAME': '0', 04:06:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:46 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-fHWmQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:46 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)) 04:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:46 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-7tTO3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:46 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)) 04:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:46 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-OZPezf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:46 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)) 04:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:46 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-DhKe34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:46 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-UmTz1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:46 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)) 04:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:46 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-l4atVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:46 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)) 04:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:46 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-Neez2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:46 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)) 04:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:46 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-dIJaUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:46 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)) 04:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:46 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-up4Pyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:47 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)) 04:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:47 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-Ea2fpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:47 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)) 04:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:47 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-0zNBA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:47 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)) 04:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:47 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-L95GeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:47 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-2i7HX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:47 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)) 04:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:47 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-zcR63G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:47 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)) 04:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:47 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-MA9YkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:47 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)) 04:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:47 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-PyP1xm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:47 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)) 04:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:47 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-OxVnmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:47 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)) 04:06:47 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)) 04:06:47 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)) 04:06:47 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)) 04:06:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:06:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:06:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:06:47 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 04:06:47 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 04:06:47 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 04:06:47 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 04:06:47 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 04:06:47 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 04:06:50 INFO - Downloading blessings-1.6.tar.gz 04:06:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:06:50 INFO - Installing collected packages: blessings 04:06:50 INFO - Running setup.py install for blessings 04:06:50 INFO - Successfully installed blessings 04:06:50 INFO - Cleaning up... 04:06:50 INFO - Return code: 0 04:06:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:06:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:06:51 INFO - Reading from file tmpfile_stdout 04:06:51 INFO - Current package versions: 04:06:51 INFO - blessings == 1.6 04:06:51 INFO - blobuploader == 1.2.4 04:06:51 INFO - docopt == 0.6.1 04:06:51 INFO - functools32 == 3.2.3-2 04:06:51 INFO - jsonschema == 2.5.1 04:06:51 INFO - manifestparser == 1.1 04:06:51 INFO - mozInstall == 1.12 04:06:51 INFO - mozcrash == 1.0 04:06:51 INFO - mozdebug == 0.1 04:06:51 INFO - mozdevice == 0.49 04:06:51 INFO - mozfile == 1.2 04:06:51 INFO - mozhttpd == 0.7 04:06:51 INFO - mozinfo == 0.9 04:06:51 INFO - mozleak == 0.1 04:06:51 INFO - mozlog == 3.4 04:06:51 INFO - moznetwork == 0.27 04:06:51 INFO - mozprocess == 0.24 04:06:51 INFO - mozprofile == 0.28 04:06:51 INFO - mozrunner == 6.13 04:06:51 INFO - mozscreenshot == 0.1 04:06:51 INFO - mozsystemmonitor == 0.3 04:06:51 INFO - moztest == 0.8 04:06:51 INFO - mozversion == 1.4 04:06:51 INFO - psutil == 3.1.1 04:06:51 INFO - requests == 1.2.3 04:06:51 INFO - wsgiref == 0.1.2 04:06:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:51 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 0x10c460b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c463768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa81c85f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c23ed30>, '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 0x10c165db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c233be8>, '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.a56emPfuzQ/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.A0RkPQ3DpR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 04:06:51 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 04:06:51 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 04:06:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a56emPfuzQ/Render', 04:06:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:51 INFO - 'HOME': '/Users/cltbld', 04:06:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:51 INFO - 'LOGNAME': 'cltbld', 04:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:51 INFO - 'MOZ_NO_REMOTE': '1', 04:06:51 INFO - 'NO_EM_RESTART': '1', 04:06:51 INFO - 'PAGER': '/bin/cat', 04:06:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:51 INFO - 'PWD': '/builds/slave/test', 04:06:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:51 INFO - 'SHELL': '/bin/bash', 04:06:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A0RkPQ3DpR/Listeners', 04:06:51 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 04:06:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:51 INFO - 'USER': 'cltbld', 04:06:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:51 INFO - 'XPC_FLAGS': '0x0', 04:06:51 INFO - 'XPC_SERVICE_NAME': '0', 04:06:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:51 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)) 04:06:51 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)) 04:06:51 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)) 04:06:51 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)) 04:06:51 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)) 04:06:51 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)) 04:06:51 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)) 04:06:51 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)) 04:06:51 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)) 04:06:51 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)) 04:06:51 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)) 04:06:51 INFO - Cleaning up... 04:06:51 INFO - Return code: 0 04:06:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c460b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c463768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa81c85f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c23ed30>, '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 0x10c165db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c233be8>, '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.a56emPfuzQ/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.A0RkPQ3DpR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 04:06:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:06:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:06:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a56emPfuzQ/Render', 04:06:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:51 INFO - 'HOME': '/Users/cltbld', 04:06:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:51 INFO - 'LOGNAME': 'cltbld', 04:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:51 INFO - 'MOZ_NO_REMOTE': '1', 04:06:51 INFO - 'NO_EM_RESTART': '1', 04:06:51 INFO - 'PAGER': '/bin/cat', 04:06:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:51 INFO - 'PWD': '/builds/slave/test', 04:06:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:51 INFO - 'SHELL': '/bin/bash', 04:06:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A0RkPQ3DpR/Listeners', 04:06:51 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 04:06:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:51 INFO - 'USER': 'cltbld', 04:06:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:51 INFO - 'XPC_FLAGS': '0x0', 04:06:51 INFO - 'XPC_SERVICE_NAME': '0', 04:06:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:06:51 INFO - Cleaning up... 04:06:51 INFO - Return code: 0 04:06:51 INFO - Running post-action listener: _resource_record_post_action 04:06:51 INFO - Running post-action listener: _start_resource_monitoring 04:06:51 INFO - Starting resource monitoring. 04:06:51 INFO - [mozharness: 2017-01-26 12:06:51.762439Z] Finished create-virtualenv step (success) 04:06:51 INFO - [mozharness: 2017-01-26 12:06:51.763462Z] Running install step. 04:06:51 INFO - Running pre-action listener: _resource_record_pre_action 04:06:51 INFO - Running main action method: install 04:06:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:06:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:06:52 INFO - Reading from file tmpfile_stdout 04:06:52 INFO - Detecting whether we're running mozinstall >=1.0... 04:06:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:06:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:06:52 INFO - Reading from file tmpfile_stdout 04:06:52 INFO - Output received: 04:06:52 INFO - Usage: mozinstall [options] installer 04:06:52 INFO - Options: 04:06:52 INFO - -h, --help show this help message and exit 04:06:52 INFO - -d DEST, --destination=DEST 04:06:52 INFO - Directory to install application into. [default: 04:06:52 INFO - "/builds/slave/test"] 04:06:52 INFO - --app=APP Application being installed. [default: firefox] 04:06:52 INFO - mkdir: /builds/slave/test/build/application 04:06:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:06:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:07:14 INFO - Reading from file tmpfile_stdout 04:07:14 INFO - Output received: 04:07:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:07:14 INFO - Running post-action listener: _resource_record_post_action 04:07:14 INFO - [mozharness: 2017-01-26 12:07:14.393127Z] Finished install step (success) 04:07:14 INFO - [mozharness: 2017-01-26 12:07:14.393265Z] Running run-tests step. 04:07:14 INFO - Running pre-action listener: _resource_record_pre_action 04:07:14 INFO - Running main action method: run_tests 04:07:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:07:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:07:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:07:14 INFO - 2017-01-26 04:07:14.408 screenresolution[1634:8326] starting screenresolution argv=screenresolution get 04:07:14 INFO - 2017-01-26 04:07:14.410 screenresolution[1634:8326] Display 0: 1600x1200x32@60 04:07:14 INFO - 2017-01-26 04:07:14.416 screenresolution[1635:8328] starting screenresolution argv=screenresolution list 04:07:14 INFO - Available Modes on Display 0 04:07:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:07:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:07:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:07:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:07:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:07:14 INFO - Intel Iris: 04:07:14 INFO - Chipset Model: Intel Iris 04:07:14 INFO - Type: GPU 04:07:14 INFO - Bus: Built-In 04:07:14 INFO - VRAM (Dynamic, Max): 1536 MB 04:07:14 INFO - Vendor: Intel (0x8086) 04:07:14 INFO - Device ID: 0x0a2e 04:07:14 INFO - Revision ID: 0x0009 04:07:14 INFO - Displays: 04:07:14 INFO - Display: 04:07:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:07:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:07:14 INFO - Display Serial Number: 1600x1200 60 04:07:14 INFO - Main Display: Yes 04:07:14 INFO - Mirror: Off 04:07:14 INFO - Online: Yes 04:07:14 INFO - Rotation: Supported 04:07:14 INFO - Return code: 0 04:07:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:07:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:07:14 INFO - Python 2.7.3 04:07:14 INFO - Return code: 0 04:07:14 INFO - grabbing minidump binary from tooltool 04:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:14 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 0x10c23ed30>, '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 0x10c165db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c233be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:07:14 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 04:07:14 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 04:07:14 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 04:07:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:07:14 INFO - Return code: 0 04:07:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:07:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:07:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:07:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:07:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:07:14 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/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0115', '--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 04:07:14 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/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0115 --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 04:07:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a56emPfuzQ/Render', 04:07:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:14 INFO - 'HOME': '/Users/cltbld', 04:07:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:14 INFO - 'LOGNAME': 'cltbld', 04:07:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:07:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:14 INFO - 'MOZ_NO_REMOTE': '1', 04:07:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:07:14 INFO - 'NO_EM_RESTART': '1', 04:07:14 INFO - 'PAGER': '/bin/cat', 04:07:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:14 INFO - 'PWD': '/builds/slave/test', 04:07:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:07:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:14 INFO - 'SHELL': '/bin/bash', 04:07:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A0RkPQ3DpR/Listeners', 04:07:14 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 04:07:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:14 INFO - 'USER': 'cltbld', 04:07:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:14 INFO - 'XPC_FLAGS': '0x0', 04:07:14 INFO - 'XPC_SERVICE_NAME': '0', 04:07:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:14 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/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0115', '--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 04:07:15 INFO - mozversion application_buildid: 20170126033131 04:07:15 INFO - mozversion application_changeset: 1e036cc4bf25338708b1466a4756316390557241 04:07:15 INFO - mozversion application_display_name: Nightly 04:07:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:07:15 INFO - mozversion application_name: Firefox 04:07:15 INFO - mozversion application_remotingname: firefox 04:07:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:07:15 INFO - mozversion application_vendor: Mozilla 04:07:15 INFO - mozversion application_version: 54.0a1 04:07:15 INFO - mozversion platform_buildid: 20170126033131 04:07:15 INFO - mozversion platform_changeset: 1e036cc4bf25338708b1466a4756316390557241 04:07:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:07:15 INFO - mozversion platform_version: 54.0a1 04:07:15 INFO - using testdate: 1485432435 04:07:15 INFO - actual date: 1485432435 04:07:15 INFO - starting webserver on 'localhost:49248' 04:07:15 INFO - SUITE-START | Running 2 tests 04:07:15 INFO - TEST-START | dromaeo_css 04:07:15 INFO - operating with platform_type : mac_ 04:07:15 INFO - Initialising browser for dromaeo_css test... 04:07:15 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/tmpZgoHzC/profile http://localhost:49248/getInfo.html) 04:07:17 INFO - PROCESS | 1645 | 2017-01-26 04:07:17.704 plugin-container[1647:8499] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b47, name = 'com.apple.tsm.portname' 04:07:17 INFO - PROCESS | 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:07:17 INFO - PROCESS | 1645 | 2017-01-26 04:07:17.708 plugin-container[1647:8499] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950b, name = 'com.apple.CFPasteboardClient' 04:07:17 INFO - PROCESS | 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:07:17 INFO - PROCESS | 1645 | 2017-01-26 04:07:17.708 plugin-container[1647:8499] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:07:17 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 04:07:17 INFO - PROCESS | 1645 | colorDepth:24 04:07:17 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 04:07:17 INFO - PROCESS | 1645 | __metrics 04:07:17 ERROR - PROCESS | 1645 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3279: TypeError: this.tabs is undefined 04:07:18 INFO - TEST-INFO | 1645: exit 0 04:07:18 INFO - Browser initialized. 04:07:18 INFO - Running cycle 1/1 for dromaeo_css test... 04:07:18 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/tmpZgoHzC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:07:20 INFO - PROCESS | 1649 | 2017-01-26 04:07:20.878 plugin-container[1650:8624] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8843, name = 'com.apple.tsm.portname' 04:07:20 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:07:20 INFO - PROCESS | 1649 | 2017-01-26 04:07:20.878 plugin-container[1650:8624] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4717, name = 'com.apple.CFPasteboardClient' 04:07:20 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:07:20 INFO - PROCESS | 1649 | 2017-01-26 04:07:20.878 plugin-container[1650:8624] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:07:30 INFO - PROCESS | 1649 | RSS: Main: 234151936 04:07:30 INFO - PROCESS | 1649 | 04:10:33 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 04:10:34 INFO - PROCESS | 1649 | RSS: Main: 257658880 04:10:34 INFO - PROCESS | 1649 | 04:12:18 INFO - PROCESS | 1649 | ************************* 04:12:18 INFO - PROCESS | 1649 | A coding exception was thrown and uncaught in a Task. 04:12:18 INFO - PROCESS | 1649 | 04:12:18 ERROR - PROCESS | 1649 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:12:18 INFO - PROCESS | 1649 | Full stack: 04:12:18 INFO - PROCESS | 1649 | ************************* 04:13:37 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 04:13:37 INFO - PROCESS | 1649 | RSS: Main: 263208960 04:13:37 INFO - PROCESS | 1649 | 04:16:39 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 04:16:40 INFO - PROCESS | 1649 | RSS: Main: 274485248 04:16:40 INFO - PROCESS | 1649 | 04:19:42 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 04:19:42 INFO - PROCESS | 1649 | RSS: Main: 267923456 04:19:42 INFO - PROCESS | 1649 | 04:22:45 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 04:22:46 INFO - PROCESS | 1649 | RSS: Main: 272871424 04:22:46 INFO - PROCESS | 1649 | 04:25:48 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 04:25:49 INFO - PROCESS | 1649 | RSS: Main: 274939904 04:25:49 INFO - PROCESS | 1649 | 04:25:49 INFO - PROCESS | 1649 | __start_tp_report 04:25:49 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 04:25:49 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 04:25:49 INFO - PROCESS | 1649 | |i|pagename|runs| 04:25:49 INFO - PROCESS | 1649 | |0;dojo.html;2603.4662894106714;2817.5491921292573;2878.798484106113;3426.1263377838645;3471.149568355753;5613.859653508664;5690.089585666289;5726.484616384525;5769.798057068004;5774.632400715707;4743.217369134089;5641.605087643857;5703.515201207892;5802.680852553108;5824.737886795094;5146.382434107913;5197.220416937452;5239.292695486118;5250.212468129792;5302.2311764794085;4725.362076119732;5197.194434862602;5251.816186433456;5263.973680131594;5284.313039304885;4428.645708343325;4681.6722829401615;5291;5302.072137375963;5340.546053585431;5159.993801208766;5165.63840531163;5211.42674305826;5254.106801843657;5318.654287471302;5130.615203859726;5228.032813929397;5236.502532259429;5238.554722848562;5247.39654939683;5496.890062198733;5704.743286552115;5776.133579962997;5814.302283725938;5821.126830975345;6126.3650001744745;6135.141080248769;6185.845353866144;6247.344028876948;6257.9687101564205;6208.534359923024;6213.751449941997;6214.533909956726;6232.158658581079;6240.313565507836;5865.76536938522;5892.793752218652;5909.8227053188475;5922.703864806828;5952.434518720715;6132.171952247653;6154.7230374633245;6165.32181460048;6171.228596425447;6301.180846489927;6106;6109.374301065143;6116.761878222105;6118.60229085108;6149.846253843601;6199.236202980234;6227.159333490012;6261.373862613702;6270.278917924497;6274.341194174637;6111.449969502677;6122.051082082285;6132.8756461173125;6163.84590385244;6188.597741146811;6235.314115447297;6266.373362663697;6270.811875643738;6277.372262773686;6284.088807122942;5029.346184995927;5030.723310217973;5047.318611987334;5047.545720885065;5056.443791182967;3748.381517049711;4434.490033646108;4435.179491794029;4502.684812063189;4505.684602077823;5870.471657550841;5926.259217597801;5979.133025711248;6005.429484198994;6022.09668549721;6183.907241391383;6205.937940620536;6207.255129384503;6216.968915155395;6224.315325314303;5791.768329266866;5851.239338886003;5967.283925928917;5973.671448070398;6012.789552365646;5463.726813659301;5479.6164268500825;5512.228288039678;5525.668459892419;5581.274434323512;6348.555601108063;6381.8085457436355;6394.0408938659575;6400;6421.839454013687;6167.444929956326;6202.069689546604;6221.595596286227;6226.315105338319;6228.4705800007505;6136.243373036893;6251.4061164189325;6271.466925311217;6284.120223168668;6400.51996100285;6213.596116252429;6245.5628106033955;6255.874882502416;6260.843478912881;6283.842903927439;6222.377762223741;6239.532035097477;6241.500679945684;6244.968775156095;6256.374362563707;5762.078067509178;6062.605930614496;6087.66517841523;6089.695515224133;6098.512119030378;6131.448169664752;6143.450468055707;6154.138420621206;6157.107219453064;6168.475679567287;5029.27075574047;5759.350698678655;5761.107028410603;6034.426729460694;6043.879122417615;6117.188044311343;6121.479674227562;6127.969360153171;6219.906701399392;6225.501959843111;6039.033754599243;6044.879102417839;6044.879102418015;6060.424259695322;6080.7567697291615 04:25:49 INFO - PROCESS | 1649 | |1;ext.html;457.25239233852653;487.96828206166595;491.14050411779385;496.3696105945452;514.7297668723921;36440.81779591102;40778.59221407785;40899.18201635966;40924.79537602308;40942.59057409425;41310.38034429486;41808;41826.37260441096;41831.95420114499;41850.162996740044;9144.634214631424;9396.295277854155;9419.434833909952;10753.193510486706;11194.88051194882;11066.336019838795;11158.497867595937;11160.274582152175;11161.274517156358;11201.327920324766;11087.944560277187;11213.10295176388;11235.550577976872;11242.718932026683;11259.662210133709;11154.386508742016;11197.60808371703;11202.43987800615;11204.439778011067;11216.383098929555;10921.290116142425;10969.83545246814;11000.559977600886;11026.338419694765;11053.336799792038;30186.245343866358;36707.4493882592;36735.81632091849;37261.06847328811;37413.43879841804;3928.273269445162;3979.3633018717155;3984.203159368138;4000.439938408625;4142.544320124784;28222.87108515657;28453.430931381256;28611.427771444454;28676.426471470662;28693;3175.301433684586;3256.495243237302;3275.164832967602;3322.1694576355912;3322.8670853166086;477607;477834;480578;481933;482117.5894120542;55842;55937.440625593226;56107;56265;56427;57831.42168578345;57966.71016644974;58188.79961602068;58579.5355116117;58688.82622347614;15087.019343742622;15362.615934601725;15561.610959726097;15568.610784730472;15601.60995975087;10770.138388928866;11073.557057717762;11822.940885295518;12031.87968120325;12134.15060945743;17478.563035924202;17505;17510.91244543769;17544.94730316185;17766.289348426177;7714.190010048864;7832.451728379073;7838.804029899298;7845.293923546908;7909.1299957004685;863.2101627011215;867.4621734524635;877.6664867350366;882.9823403532022;902.3953950852945;29432.11703648894;29910.953116640812;29942.700572993992;30580.84709576438;30628.693713062585;1060.2949038889205;1062.3413483640038;1091.770728147098;1106.5684383090602;1191.3923898811668;14687.685101765537;15472;15577;15589.844101559067;15649.843501565067;612287;614053;616839;616863.9156804187;617096;50221.74889125531;59156;59554;59875.80248395008;59963.800723985274;1408.5774267719644;1436.74138655041;1457.9781303280458;1458.8978771485895;1463.9971619440716;24472.388190295384;25599;29306.70693293125;29530.852345738134;30175.69824301729;44227;46861.53138468708;50479.73800655013;50518.242226365895;50549;543004;545744;546978;547879;549313.0274789124;22798.658020130042;23310.417239569146;24718.629220562067;25591.6161257585;26554.734452655226;44151;46837.29744053774;46913.06173876572;47142;47640.28539571979;32457.675423245466;33251.50122748112;38806.61193388143;39578.60421395749;40231.1953760929;36951.89144325675;37406;38390;38737.80631096826;39549.40675889922;37023.81488092542;37084;37451.625483745906;37663.435048473744;38485.03787405225;26818.865905670347;28892.27769305784;28951.565726514542;34578.82710586431;34581.82709086438;22439.663405049265;23780.692061936068;23884.76115238895;24902.770298570005;25518.489630207663 04:25:49 INFO - PROCESS | 1649 | |2;jquery.html;386.81819544813965;388.82697199746127;400.2695081476306;406.61777928746983;420.2183937875551;18518.722219166688;20763.16947322107;21116.260930867422;21956.341309760694;22040.779592204093;20126.19495220193;20529.486762830937;20938.581228375424;21308.36074917751;21907.780922190774;5782.681952492611;6045.304789949146;6098.54260930432;6103.084537319393;6110.175126357952;5821.18503409523;5975.43233392827;5995.13070604762;6063.151158837766;6079.05774604937;5962.463378295953;6010.639361638294;6012.518998480111;6014.248218972629;6020.879582408349;5272.683638981635;5945.702714864239;5951.166836642873;5988.700564971756;5989;5861.970690146564;5872.265966754156;5873.882522349571;5881.470667639933;5885.646861188299;13051.804222936664;13442.12626179305;13608;13767.242801646005;13771.724565508634;2585;2625.330540712106;2658.322127857384;2815.1554533640033;2971.6178753328886;9896.307258491908;10001.849787274485;10057.597696092147;10493.475326233734;10505.212109091848;1606.7911171547623;1746.950794882508;1804.7653805005395;1902.9333973310868;1905.9332923347615;114159;117444;117690.41154794171;118622.40688796501;119277;11995.100367472474;12000.759984800256;12200.572979945659;12242.653308136098;12328.75342493163;15319.92340038315;15860;15872.92063539675;15873.52379428619;15902.44341448067;7153.89269160963;7234.746783862644;7308.232635573295;8467.915320846712;8822.338324625678;6821.69302381394;8400.495970241805;8418.242358187792;8549.529775862264;8575.271101956403;4091.8772436826944;4824.276358546246;4825.348577942003;4839.395075615548;4858.149823780825;1683.3603230772228;2070.5257217625094;2074.284371891695;2075.3877606106234;2076.2733043434678;377.2323322039636;379.5805634773591;1020.1889497849228;1026.2098184398121;1065.9946700266448;10809.621663241749;11498.677652069951;11514.596989105341;11776.646700598996;12059.15585908978;420.09469593027075;422.7759287577589;425.46179083459447;429.9080335946723;431.99352009719877;5028.34631497903;5704.971475142598;5910.290765108214;6013.188219590387;6201.937980620226;426925;427587.8620606877;434371;436729;437066;133051.33474332566;133079;140302;155348.1162970912;163975.360246396;432.4831825968001;445.92196365635886;447.53903479416255;449.42698059973793;449.4763600405491;11035.39305338214;11529.884701152881;11584.768304633692;11596.536138554364;11825.704357391134;45267.547324526335;47896.28155577739;58700.706496467246;59762.10356844564;60424;81309;82025.15698116264;83328.58335708283;84579;86134.56932715296;7979.5611241382285;8066.7579972600915;8275.255227029596;8391.538465384217;8632.223099921037;8327.37544684139;12359.134860560034;13215.471381145031;13567.86432135666;13672.726545469233;11419;11593.88406115928;11609.47757350938;11661.24201926872;11967.461464234304;11102.666919992413;11309.830352544554;11353.921377469127;11361.829572556584;11656.358900260568;9644.614215431304;11467.254628449124;11621.767564648491;11822.645320640395;12089.335086570323;8235.547044912588;8385.203405676451;8460.91539084626;8493.193146651058;8505.574721264036;8009.399295053011;8957.59690813928;11451.828222576502;11652.009579185864;11704.648860534198 04:25:49 INFO - PROCESS | 1649 | |3;mootools.html;1403.4245959156747;1413.5194034028427;1421.928903554822;1438.0077746355012;1439.5321520505836;7487.887681684765;7731.961340193306;8025.277725004748;8449.788755281113;8501.48991060536;8011.879821802678;8273.91726082739;8275.131111233324;8375.455595386296;8379.203975622322;2256.1386855843953;2295.0819672131115;2298.8620682759006;2301.7928386445215;2305.3199306204624;1884.7926728059902;2051.3743308290964;2116.4285642876416;2311.087120587367;2311.3643747969277;2025.281025236042;2291.3813270416977;2295.6326987681973;2298.0233400804673;2300.8389412741117;2274.65880117982;2281.8973146208377;2284.474570848714;2289.198780426854;2303.2284184798114;2233.8212942964524;2265.7054582904284;2281.6121259385777;2289.072925465189;2296.6899468571696;6970.93029069713;8350.290225330855;8423.536705481196;8482.575871206414;8494.980602327698;4493.326001099861;5116.283720279164;5128.666636668605;5232.084385232569;5256.526912577848;3391.1687491364128;3518.665726755954;3518.736094792875;3571.017970058229;3596.1189508570305;1187.821826725998;1225.5342969671558;1229.8155276708476;1256.6669832494397;1279.8400199975003;10702.250842441032;10759.51582178796;10820.350778953289;10822.296550724177;10825.025747682746;4316.309390497506;4522.819087236539;4675.76621168947;4676.18166820805;4757.238841785298;8599.871001934851;8640.697575584825;8645.481271123752;8711.912880871238;8715.259202967818;5108.106081435734;5115.667481613683;5117.053345131163;5121.590272778169;5124.256982737482;3373.8819141329936;3836.290286297044;4043.636072753466;4786.0667169902235;4794.065157294294;2781.6648008955813;2998.745106665958;3486.198174419847;3684.4473329000866;3782.71629627779;1071.59815069349;1109.6005438042298;1141.0643272516622;1155.5493357590547;1180.3508070561156;657.5430076097163;698.5878331784272;731.2212493694304;750.8385697075155;761.2501685839444;5221.7128057956415;5260.473952604785;5292.867678308073;5603.691796951125;5629.043062679354;838.4508147163617;951.9381240219363;957.899420560845;960.9423434593947;1015.5074788727461;3598.2983318253214;3599.352116618981;3627.6190999944624;3725.869594564177;3732.5520937487677;9204.401713888576;9848;9892.604295828087;9895.01049895019;9916.057974492413;9771.022897710172;9871.160951319074;9875.061869122423;9876.160526355197;9880.901190988141;7641.159472458025;7853.09689385728;7859.096203936506;7860.882086768703;7872.685092596346;5020.723860187724;5304.151335786256;5353.2773075634295;5381.784728610812;5417.475343605156;8928.10718928102;8946.881639795025;9025.954870225607;9047.728568142966;9109.77225569366;9173.128552787475;9228.984811670845;9256.676016339396;9289.489078100769;9326.766830829283;6649.501287403561;6796.830079248059;6806.115205023315;6806.727730890907;6824.522283440111;7547.622618869144;7711.575863327571;7795.454318197899;7830.099538552911;7901.446898717035;7086.39765619928;7138.535995160298;7141.143062832493;7154.785356439315;7177;5982.790602328898;6830.180378354629;6923.342282483156;6961.408280296231;7047.647617619201;6298.874022519432;6315.621062736251;6420.903686444801;6437.420632143129;6443.967780161257;4898.485659005753;4911.7298548580175;4927.507249275044;4988.850334489971;4995.700257984533;4938.358013458227;4944.15949288629;5044.066847633199;5091.287219789307;5198.090334191577 04:25:49 INFO - PROCESS | 1649 | |4;prototype.html;312.3409605731906;317.74897830713724;344.99999999999994;369.50855362368054;379.75695554844884;4733.668643194977;4768.308595253686;4875.92729599488;5177.326947496829;5500.202470641764;5427.728613569316;5480.205370221315;5523;5552.222688823558;5620.887582248362;3754.2679177560385;4018.81444973732;4023.8994025149386;4169.499660040799;4175.290200665879;3281.4913688378338;3511.666391692798;4223.788810559475;4244.49066112067;4248.086661367805;3608.8632080894567;3714.758540694846;3747.86882459114;4191.784382529078;4297.247981603223;3581.6418358164237;4122.319817230154;4193.412922190896;4202.789860506993;4347.847825326115;3682.2935142670117;3733.8693145739767;3734.2158146789207;3744.569374521938;3748.194138260287;4683.531646835323;4780.275243111428;5278.703763862732;5404.756785944642;5447.291852059247;3754.9812250938844;3980.5073097588406;4900.901981960341;4952.851414457572;4997.350344455234;5181.533661970403;5277.076511610453;5763.423657634203;5773.653580785166;5787.164289498116;3867.574566797678;3898.6491215790716;3961.722679412442;3973.205358928197;3991.341428664267;5133.383993920716;5796.478316951495;6049.455549000655;6104.542159338067;6132.799032662596;3690.3910854708674;3936.488256526633;3974.324364857981;3990.541087774943;3991.62289010291;4065.8044655886083;4066.2477441673386;4069.9389509157386;4071.65635340337;4096.692748043909;4353.434053573079;4445.466544014675;4624.884377890579;4775.2359622460235;4779.02030083832;5202.713850738246;5300.390455097713;5361.919571206435;5444.40111587725;5875.588708790344;1313.6026751179136;1322.768515509801;1322.9470821167045;1325.4300650720284;1325.907186496936;835.4402550291198;889.4263200235812;892.9775407158767;896.7578753736454;901.5221932375852;5289.2710638999415;5307.469253074739;5384.78460861569;5448.891022179534;5556.9156669847625;5271.71005594696;5523.28197334344;5951.434613711691;6011.338752737195;6070.605410648382;4344;5232.947670523322;5532.5297349724915;5539.233321341527;5562.749676264578;2625.724298948583;2631.381625318049;2749.5738160585142;2924.5174546199637;3012.6987301270137;5238.659487133325;5420.83737487876;5689.971550142222;6022.427869352405;6026.879462410728;5133.537981581676;5533.972330138324;5918.437748413894;5940.851478713067;5943.5839491236065;5721.742521586455;5968.253968253968;5983.670898100646;6004.399560044048;6026.487748541423;5304.522592966651;5565.4363421995195;5595.776168953359;5714.828555143353;5766.192733017465;4871.565546289928;5726.713664316851;5904.228731380655;5948.5426070612975;6020.729067191899;5600.551955843442;6246.656433896179;6315.747370105144;6340.270868850142;6341.653588172406;3203.1741907113656;3513.3851575974613;3882.650561449483;3962.8258967202282;3982.8008599570485;5284.682919024871;5445.821671331499;5567.24842146305;5724.74238659253;5950.940490595039;5799.536037117105;5840.503557197686;5841.707914604338;5881.852953676022;5889.676067816311;4649.558291962258;4785.282207668877;5555.583331250254;5807.361190269152;5930.762769489172;4908.730019848943;5730.054541000688;5768.855778605568;5777.595568310178;5797.8550536236935;4570.200214962302;4705.717656940595;4788.11419887322;4922.704637721748;5476.288082549243;5412.323459567554;5535.972320138373;5630.943690563042;5701.372848986691;5726.026575482095 04:25:49 INFO - PROCESS | 1649 | |5;yui.html;649.3311888754579;706.7243774927775;774.5778550689873;830.9792255193621;832.5379414424993;15232.162231077285;15831.366745330173;15842.049477031358;15864.206789660528;15905.84094159058;14314.069585476936;14355.78466323006;14380.640483987905;14478.13131212128;14509.782353264709;670.8926571748522;687.388224480213;833.1293797981124;845.8900342955423;856.5117882806802;852.0286872964795;865.3336930563462;865.9004214515348;866.3675516872687;867.3581549653243;917.2982668258754;922.0226559846551;923.8244733500647;924.4545718026363;924.6624981881598;885.716570697377;915.4187091197072;916.5463095767604;918.2011649864661;918.3709159225884;676.070403195606;676.2696288008939;676.4858707382375;677.5358879167786;678.6606696651675;14767.778483322758;15121.924390378088;15190;15489.993150445185;15784.526464206092;14247.715045699131;14493.202873841934;14637.92681036588;14663.63340916475;14798.852011479963;11706.70733231676;11784.764304713857;11842.881571184264;11862.288262704265;11892;3680.7607505512324;3707.721920855947;3728.608496107897;3755.1926335837925;3841.308564458396;99910.50134247993;103659.48170259176;103809;104563;104790;11085.612003579836;11117.833232501518;11219.439028048564;11263.211575189822;11497.252678575866;23100.768992310197;23394;23398.18106366269;23416.712080835718;23464.06143754265;7745.264199901;7783.922160778433;7803.063632364153;7825.686972521035;7927.8810817837775;4237.152569486115;4288.142371525645;4321.69748117635;4407.272799987966;4481.551844815493;3097.760895641761;3495.702865256482;3565.868263473054;3583.6953858922284;3584.2831433713363;609.1015751766109;611.0467670434138;618.7246675229479;629.3706293706293;630.760311081786;633.8763941031455;646.705748884266;648.9805305840832;676.6853413162903;679.6363945289246;9372.265966754188;10288.691339259834;10880.347179169275;10881.238313317992;10997.900209979098;476.94276686797804;556.6854727079187;567.7161419290355;572.4189947203591;603.9822898416182;4645.419322584677;4905.3623029006;4911.926321105187;4966.553010229097;5087.949120508748;95162.9595188456;99600;100488;103485;105643.94356056495;88563.22873542493;89882;90185;91229.54385228164;91547;67686;71957.20106997262;76333;77410;77831.61084194656;9605.519724013631;9627.951860240933;9710.514474276117;9713.222942164468;9740.415575065519;49045.50954490552;49534.51396458112;49923;50371;50702.23946640877;60817.69591152016;64222;67401.65196696136;68809.96785048328;69293.3070669307;11306.378149201873;11453.942730286295;11500.53997840077;11573.363465009505;11738.119641026786;11240.606578769704;12385.62843114708;12555.309457979898;12953.676158096123;13041.413136409074;10681.839772403264;11208.439578020903;11722.296662200295;11953.760924781282;11986.28082315029;9596.95201523988;11275.210735248455;11331.263467874562;11369.829452558384;11406.885931140583;11733.35466549348;11806.350650714294;11823.408829558659;11893.583724569598;12380.504779808707;9582.952085239529;9611.567479463301;9779.657711980046;9840.261980351359;10021.699349019542;8500.702475413578;9291;9531.428114313163;9664.613415463584;9732.659356922473 04:25:49 INFO - PROCESS | 1649 | __end_tp_report 04:25:49 INFO - PROCESS | 1649 | __start_cc_report 04:25:49 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,382 04:25:49 INFO - PROCESS | 1649 | __end_cc_report 04:25:49 INFO - PROCESS | 1649 | __startTimestamp1485433549217__endTimestamp 04:25:49 INFO - PROCESS | 1649 | 04:25:49 INFO - PROCESS | 1649 | ------- Summary: start ------- 04:25:49 INFO - PROCESS | 1649 | Number of tests: 6 04:25:49 INFO - PROCESS | 1649 | 04:25:49 INFO - PROCESS | 1649 | [#0] dojo.html Cycles:165 Average:5744.33 Median:6044.88 stddev:700.59 (11.6%) stddev-sans-first:657.99 04:25:49 INFO - PROCESS | 1649 | Values: 2603.5 2817.5 2878.8 3426.1 3471.1 5613.9 5690.1 5726.5 5769.8 5774.6 4743.2 5641.6 5703.5 5802.7 5824.7 5146.4 5197.2 5239.3 5250.2 5302.2 4725.4 5197.2 5251.8 5264.0 5284.3 4428.6 4681.7 5291.0 5302.1 5340.5 5160.0 5165.6 5211.4 5254.1 5318.7 5130.6 5228.0 5236.5 5238.6 5247.4 5496.9 5704.7 5776.1 5814.3 5821.1 6126.4 6135.1 6185.8 6247.3 6258.0 6208.5 6213.8 6214.5 6232.2 6240.3 5865.8 5892.8 5909.8 5922.7 5952.4 6132.2 6154.7 6165.3 6171.2 6301.2 6106.0 6109.4 6116.8 6118.6 6149.8 6199.2 6227.2 6261.4 6270.3 6274.3 6111.4 6122.1 6132.9 6163.8 6188.6 6235.3 6266.4 6270.8 6277.4 6284.1 5029.3 5030.7 5047.3 5047.5 5056.4 3748.4 4434.5 4435.2 4502.7 4505.7 5870.5 5926.3 5979.1 6005.4 6022.1 6183.9 6205.9 6207.3 6217.0 6224.3 5791.8 5851.2 5967.3 5973.7 6012.8 5463.7 5479.6 5512.2 5525.7 5581.3 6348.6 6381.8 6394.0 6400.0 6421.8 6167.4 6202.1 6221.6 6226.3 6228.5 6136.2 6251.4 6271.5 6284.1 6400.5 6213.6 6245.6 6255.9 6260.8 6283.8 6222.4 6239.5 6241.5 6245.0 6256.4 5762.1 6062.6 6087.7 6089.7 6098.5 6131.4 6143.5 6154.1 6157.1 6168.5 5029.3 5759.4 5761.1 6034.4 6043.9 6117.2 6121.5 6128.0 6219.9 6225.5 6039.0 6044.9 6044.9 6060.4 6080.8 04:25:49 INFO - PROCESS | 1649 | 04:25:49 INFO - PROCESS | 1649 | [#1] ext.html Cycles:180 Average:67739.68 Median:36574.13 stddev:146873.83 (401.6%) stddev-sans-first:147198.98 04:25:49 INFO - PROCESS | 1649 | Values: 457.3 488.0 491.1 496.4 514.7 36440.8 40778.6 40899.2 40924.8 40942.6 41310.4 41808.0 41826.4 41832.0 41850.2 9144.6 9396.3 9419.4 10753.2 11194.9 11066.3 11158.5 11160.3 11161.3 11201.3 11087.9 11213.1 11235.6 11242.7 11259.7 11154.4 11197.6 11202.4 11204.4 11216.4 10921.3 10969.8 11000.6 11026.3 11053.3 30186.2 36707.4 36735.8 37261.1 37413.4 3928.3 3979.4 3984.2 4000.4 4142.5 28222.9 28453.4 28611.4 28676.4 28693.0 3175.3 3256.5 3275.2 3322.2 3322.9 477607.0 477834.0 480578.0 481933.0 482117.6 55842.0 55937.4 56107.0 56265.0 56427.0 57831.4 57966.7 58188.8 58579.5 58688.8 15087.0 15362.6 15561.6 15568.6 15601.6 10770.1 11073.6 11822.9 12031.9 12134.2 17478.6 17505.0 17510.9 17544.9 17766.3 7714.2 7832.5 7838.8 7845.3 7909.1 863.2 867.5 877.7 883.0 902.4 29432.1 29911.0 29942.7 30580.8 30628.7 1060.3 1062.3 1091.8 1106.6 1191.4 14687.7 15472.0 15577.0 15589.8 15649.8 612287.0 614053.0 616839.0 616863.9 617096.0 50221.7 59156.0 59554.0 59875.8 59963.8 1408.6 1436.7 1458.0 1458.9 1464.0 24472.4 25599.0 29306.7 29530.9 30175.7 44227.0 46861.5 50479.7 50518.2 50549.0 543004.0 545744.0 546978.0 547879.0 549313.0 22798.7 23310.4 24718.6 25591.6 26554.7 44151.0 46837.3 46913.1 47142.0 47640.3 32457.7 33251.5 38806.6 39578.6 40231.2 36951.9 37406.0 38390.0 38737.8 39549.4 37023.8 37084.0 37451.6 37663.4 38485.0 26818.9 28892.3 28951.6 34578.8 34581.8 22439.7 23780.7 23884.8 24902.8 25518.5 04:25:49 INFO - PROCESS | 1649 | 04:25:49 INFO - PROCESS | 1649 | [#2] jquery.html Cycles:180 Average:30217.81 Median:387.82 stddev:75158.30 (19379.6%) stddev-sans-first:75335.76 04:25:49 INFO - PROCESS | 1649 | Values: 386.8 388.8 400.3 406.6 420.2 18518.7 20763.2 21116.3 21956.3 22040.8 20126.2 20529.5 20938.6 21308.4 21907.8 5782.7 6045.3 6098.5 6103.1 6110.2 5821.2 5975.4 5995.1 6063.2 6079.1 5962.5 6010.6 6012.5 6014.2 6020.9 5272.7 5945.7 5951.2 5988.7 5989.0 5862.0 5872.3 5873.9 5881.5 5885.6 13051.8 13442.1 13608.0 13767.2 13771.7 2585.0 2625.3 2658.3 2815.2 2971.6 9896.3 10001.8 10057.6 10493.5 10505.2 1606.8 1747.0 1804.8 1902.9 1905.9 114159.0 117444.0 117690.4 118622.4 119277.0 11995.1 12000.8 12200.6 12242.7 12328.8 15319.9 15860.0 15872.9 15873.5 15902.4 7153.9 7234.7 7308.2 8467.9 8822.3 6821.7 8400.5 8418.2 8549.5 8575.3 4091.9 4824.3 4825.3 4839.4 4858.1 1683.4 2070.5 2074.3 2075.4 2076.3 377.2 379.6 1020.2 1026.2 1066.0 10809.6 11498.7 11514.6 11776.6 12059.2 420.1 422.8 425.5 429.9 432.0 5028.3 5705.0 5910.3 6013.2 6201.9 426925.0 427587.9 434371.0 436729.0 437066.0 133051.3 133079.0 140302.0 155348.1 163975.4 432.5 445.9 447.5 449.4 449.5 11035.4 11529.9 11584.8 11596.5 11825.7 45267.5 47896.3 58700.7 59762.1 60424.0 81309.0 82025.2 83328.6 84579.0 86134.6 7979.6 8066.8 8275.3 8391.5 8632.2 8327.4 12359.1 13215.5 13567.9 13672.7 11419.0 11593.9 11609.5 11661.2 11967.5 11102.7 11309.8 11353.9 11361.8 11656.4 9644.6 11467.3 11621.8 11822.6 12089.3 8235.5 8385.2 8460.9 8493.2 8505.6 8009.4 8957.6 11451.8 11652.0 11704.6 04:25:49 INFO - PROCESS | 1649 | 04:25:49 INFO - PROCESS | 1649 | [#3] mootools.html Cycles:180 Average:5311.18 Median:5226.90 stddev:2922.36 (55.9%) stddev-sans-first:2915.80 04:25:49 INFO - PROCESS | 1649 | Values: 1403.4 1413.5 1421.9 1438.0 1439.5 7487.9 7732.0 8025.3 8449.8 8501.5 8011.9 8273.9 8275.1 8375.5 8379.2 2256.1 2295.1 2298.9 2301.8 2305.3 1884.8 2051.4 2116.4 2311.1 2311.4 2025.3 2291.4 2295.6 2298.0 2300.8 2274.7 2281.9 2284.5 2289.2 2303.2 2233.8 2265.7 2281.6 2289.1 2296.7 6970.9 8350.3 8423.5 8482.6 8495.0 4493.3 5116.3 5128.7 5232.1 5256.5 3391.2 3518.7 3518.7 3571.0 3596.1 1187.8 1225.5 1229.8 1256.7 1279.8 10702.3 10759.5 10820.4 10822.3 10825.0 4316.3 4522.8 4675.8 4676.2 4757.2 8599.9 8640.7 8645.5 8711.9 8715.3 5108.1 5115.7 5117.1 5121.6 5124.3 3373.9 3836.3 4043.6 4786.1 4794.1 2781.7 2998.7 3486.2 3684.4 3782.7 1071.6 1109.6 1141.1 1155.5 1180.4 657.5 698.6 731.2 750.8 761.3 5221.7 5260.5 5292.9 5603.7 5629.0 838.5 951.9 957.9 960.9 1015.5 3598.3 3599.4 3627.6 3725.9 3732.6 9204.4 9848.0 9892.6 9895.0 9916.1 9771.0 9871.2 9875.1 9876.2 9880.9 7641.2 7853.1 7859.1 7860.9 7872.7 5020.7 5304.2 5353.3 5381.8 5417.5 8928.1 8946.9 9026.0 9047.7 9109.8 9173.1 9229.0 9256.7 9289.5 9326.8 6649.5 6796.8 6806.1 6806.7 6824.5 7547.6 7711.6 7795.5 7830.1 7901.4 7086.4 7138.5 7141.1 7154.8 7177.0 5982.8 6830.2 6923.3 6961.4 7047.6 6298.9 6315.6 6420.9 6437.4 6444.0 4898.5 4911.7 4927.5 4988.9 4995.7 4938.4 4944.2 5044.1 5091.3 5198.1 04:25:49 INFO - PROCESS | 1649 | 04:25:49 INFO - PROCESS | 1649 | [#4] prototype.html Cycles:180 Average:4619.25 Median:5255.18 stddev:1434.92 (27.3%) stddev-sans-first:1402.06 04:25:49 INFO - PROCESS | 1649 | Values: 312.3 317.7 345.0 369.5 379.8 4733.7 4768.3 4875.9 5177.3 5500.2 5427.7 5480.2 5523.0 5552.2 5620.9 3754.3 4018.8 4023.9 4169.5 4175.3 3281.5 3511.7 4223.8 4244.5 4248.1 3608.9 3714.8 3747.9 4191.8 4297.2 3581.6 4122.3 4193.4 4202.8 4347.8 3682.3 3733.9 3734.2 3744.6 3748.2 4683.5 4780.3 5278.7 5404.8 5447.3 3755.0 3980.5 4900.9 4952.9 4997.4 5181.5 5277.1 5763.4 5773.7 5787.2 3867.6 3898.6 3961.7 3973.2 3991.3 5133.4 5796.5 6049.5 6104.5 6132.8 3690.4 3936.5 3974.3 3990.5 3991.6 4065.8 4066.2 4069.9 4071.7 4096.7 4353.4 4445.5 4624.9 4775.2 4779.0 5202.7 5300.4 5361.9 5444.4 5875.6 1313.6 1322.8 1322.9 1325.4 1325.9 835.4 889.4 893.0 896.8 901.5 5289.3 5307.5 5384.8 5448.9 5556.9 5271.7 5523.3 5951.4 6011.3 6070.6 4344.0 5232.9 5532.5 5539.2 5562.7 2625.7 2631.4 2749.6 2924.5 3012.7 5238.7 5420.8 5690.0 6022.4 6026.9 5133.5 5534.0 5918.4 5940.9 5943.6 5721.7 5968.3 5983.7 6004.4 6026.5 5304.5 5565.4 5595.8 5714.8 5766.2 4871.6 5726.7 5904.2 5948.5 6020.7 5600.6 6246.7 6315.7 6340.3 6341.7 3203.2 3513.4 3882.7 3962.8 3982.8 5284.7 5445.8 5567.2 5724.7 5950.9 5799.5 5840.5 5841.7 5881.9 5889.7 4649.6 4785.3 5555.6 5807.4 5930.8 4908.7 5730.1 5768.9 5777.6 5797.9 4570.2 4705.7 4788.1 4922.7 5476.3 5412.3 5536.0 5630.9 5701.4 5726.0 04:25:49 INFO - PROCESS | 1649 | 04:25:49 INFO - PROCESS | 1649 | [#5] yui.html Cycles:180 Average:19995.58 Median:27223.22 stddev:28923.33 (106.2%) stddev-sans-first:28967.98 04:25:49 INFO - PROCESS | 1649 | Values: 649.3 706.7 774.6 831.0 832.5 15232.2 15831.4 15842.0 15864.2 15905.8 14314.1 14355.8 14380.6 14478.1 14509.8 670.9 687.4 833.1 845.9 856.5 852.0 865.3 865.9 866.4 867.4 917.3 922.0 923.8 924.5 924.7 885.7 915.4 916.5 918.2 918.4 676.1 676.3 676.5 677.5 678.7 14767.8 15121.9 15190.0 15490.0 15784.5 14247.7 14493.2 14637.9 14663.6 14798.9 11706.7 11784.8 11842.9 11862.3 11892.0 3680.8 3707.7 3728.6 3755.2 3841.3 99910.5 103659.5 103809.0 104563.0 104790.0 11085.6 11117.8 11219.4 11263.2 11497.3 23100.8 23394.0 23398.2 23416.7 23464.1 7745.3 7783.9 7803.1 7825.7 7927.9 4237.2 4288.1 4321.7 4407.3 4481.6 3097.8 3495.7 3565.9 3583.7 3584.3 609.1 611.0 618.7 629.4 630.8 633.9 646.7 649.0 676.7 679.6 9372.3 10288.7 10880.3 10881.2 10997.9 476.9 556.7 567.7 572.4 604.0 4645.4 4905.4 4911.9 4966.6 5087.9 95163.0 99600.0 100488.0 103485.0 105643.9 88563.2 89882.0 90185.0 91229.5 91547.0 67686.0 71957.2 76333.0 77410.0 77831.6 9605.5 9628.0 9710.5 9713.2 9740.4 49045.5 49534.5 49923.0 50371.0 50702.2 60817.7 64222.0 67401.7 68810.0 69293.3 11306.4 11453.9 11500.5 11573.4 11738.1 11240.6 12385.6 12555.3 12953.7 13041.4 10681.8 11208.4 11722.3 11953.8 11986.3 9597.0 11275.2 11331.3 11369.8 11406.9 11733.4 11806.4 11823.4 11893.6 12380.5 9583.0 9611.6 9779.7 9840.3 10021.7 8500.7 9291.0 9531.4 9664.6 9732.7 04:25:49 INFO - PROCESS | 1649 | -------- Summary: end -------- 04:25:49 INFO - PROCESS | 1649 | 04:25:49 INFO - TEST-INFO | 1649: exit 0 04:25:49 INFO - TEST-OK | dromaeo_css | took 1114865ms 04:25:49 INFO - TEST-START | kraken 04:25:49 INFO - operating with platform_type : mac_ 04:25:49 INFO - Initialising browser for kraken test... 04:25:49 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/tmpvJ3t5B/profile http://localhost:49248/getInfo.html) 04:25:52 INFO - PROCESS | 1657 | 2017-01-26 04:25:52.644 plugin-container[1658:10705] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x473b, name = 'com.apple.tsm.portname' 04:25:52 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:25:52 INFO - PROCESS | 1657 | 2017-01-26 04:25:52.646 plugin-container[1658:10705] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 04:25:52 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:25:52 INFO - PROCESS | 1657 | 2017-01-26 04:25:52.646 plugin-container[1658:10705] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:25:52 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 04:25:52 INFO - PROCESS | 1657 | colorDepth:24 04:25:52 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 04:25:52 INFO - PROCESS | 1657 | __metrics 04:25:52 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3279: TypeError: this.tabs is undefined 04:25:53 INFO - TEST-INFO | 1657: exit 0 04:25:53 INFO - Browser initialized. 04:25:53 INFO - Running cycle 1/1 for kraken test... 04:25:53 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/tmpvJ3t5B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:25:56 INFO - PROCESS | 1659 | 2017-01-26 04:25:56.130 plugin-container[1660:10825] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x443b, name = 'com.apple.tsm.portname' 04:25:56 INFO - PROCESS | 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:25:56 INFO - PROCESS | 1659 | 2017-01-26 04:25:56.131 plugin-container[1660:10825] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8747, name = 'com.apple.CFPasteboardClient' 04:25:56 INFO - PROCESS | 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:25:56 INFO - PROCESS | 1659 | 2017-01-26 04:25:56.131 plugin-container[1660:10825] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:26:05 INFO - PROCESS | 1659 | RSS: Main: 233816064 04:26:05 INFO - PROCESS | 1659 | 04:26:08 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 04:26:09 INFO - PROCESS | 1659 | RSS: Main: 247365632 04:26:09 INFO - PROCESS | 1659 | 04:26:12 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 04:26:12 INFO - PROCESS | 1659 | RSS: Main: 255074304 04:26:12 INFO - PROCESS | 1659 | 04:26:16 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 04:26:16 INFO - PROCESS | 1659 | RSS: Main: 258195456 04:26:16 INFO - PROCESS | 1659 | 04:26:18 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 04:26:19 INFO - PROCESS | 1659 | RSS: Main: 260460544 04:26:19 INFO - PROCESS | 1659 | 04:26:21 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:26:21 INFO - PROCESS | 1659 | RSS: Main: 260780032 04:26:21 INFO - PROCESS | 1659 | 04:26:24 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 04:26:25 INFO - PROCESS | 1659 | RSS: Main: 266211328 04:26:25 INFO - PROCESS | 1659 | 04:26:28 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 04:26:29 INFO - PROCESS | 1659 | RSS: Main: 265859072 04:26:29 INFO - PROCESS | 1659 | 04:26:32 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 04:26:33 INFO - PROCESS | 1659 | RSS: Main: 265920512 04:26:33 INFO - PROCESS | 1659 | 04:26:34 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:26:35 INFO - PROCESS | 1659 | RSS: Main: 265261056 04:26:35 INFO - PROCESS | 1659 | 04:26:37 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:26:38 INFO - PROCESS | 1659 | RSS: Main: 265244672 04:26:38 INFO - PROCESS | 1659 | 04:26:40 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:26:41 INFO - PROCESS | 1659 | RSS: Main: 265351168 04:26:41 INFO - PROCESS | 1659 | 04:26:43 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:26:44 INFO - PROCESS | 1659 | RSS: Main: 265666560 04:26:44 INFO - PROCESS | 1659 | 04:26:47 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:26:48 INFO - PROCESS | 1659 | RSS: Main: 265441280 04:26:48 INFO - PROCESS | 1659 | 04:26:49 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 04:26:50 INFO - PROCESS | 1659 | RSS: Main: 267108352 04:26:50 INFO - PROCESS | 1659 | 04:26:50 INFO - PROCESS | 1659 | __start_tp_report 04:26:50 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 04:26:50 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 04:26:50 INFO - PROCESS | 1659 | |i|pagename|runs| 04:26:50 INFO - PROCESS | 1659 | |0;ai-astar;106;118;118;117;117;117;117;120;116;119 04:26:50 INFO - PROCESS | 1659 | |1;audio-beat-detection;144;126;114;149;111;115;114;113;131;114 04:26:50 INFO - PROCESS | 1659 | |2;audio-dft;195;213;202;214;199;196;198;196;193;198 04:26:50 INFO - PROCESS | 1659 | |3;audio-fft;87;85;68;84;67;87;85;65;75;58 04:26:50 INFO - PROCESS | 1659 | |4;audio-oscillator;93;71;84;73;69;72;81;69;73;83 04:26:50 INFO - PROCESS | 1659 | |5;imaging-gaussian-blur;93;75;137;90;92;89;97;89;120;133 04:26:50 INFO - PROCESS | 1659 | |6;imaging-darkroom;98;99;98;147;96;139;132;151;100;101 04:26:50 INFO - PROCESS | 1659 | |7;imaging-desaturate;129;78;146;144;115;92;94;90;98;100 04:26:50 INFO - PROCESS | 1659 | |8;json-parse-financial;61;61;62;61;62;67;81;91;93;93 04:26:50 INFO - PROCESS | 1659 | |9;json-stringify-tinderbox;71;74;74;84;78;75;77;95;73;71 04:26:50 INFO - PROCESS | 1659 | |10;stanford-crypto-aes;88;88;92;78;101;109;114;91;91;116 04:26:50 INFO - PROCESS | 1659 | |11;stanford-crypto-ccm;142;143;147;157;143;142;141;143;201;161 04:26:50 INFO - PROCESS | 1659 | |12;stanford-crypto-pbkdf2;173;184;173;173;177;166;170;176;175;171 04:26:50 INFO - PROCESS | 1659 | |13;stanford-crypto-sha256-iterative;70;68;69;68;67;66;67;68;66;70 04:26:50 INFO - PROCESS | 1659 | __end_tp_report 04:26:50 INFO - PROCESS | 1659 | __start_cc_report 04:26:50 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,922 04:26:50 INFO - PROCESS | 1659 | __end_cc_report 04:26:50 INFO - PROCESS | 1659 | __startTimestamp1485433610143__endTimestamp 04:26:50 INFO - PROCESS | 1659 | 04:26:50 INFO - PROCESS | 1659 | ------- Summary: start ------- 04:26:50 INFO - PROCESS | 1659 | Number of tests: 14 04:26:50 INFO - PROCESS | 1659 | 04:26:50 INFO - PROCESS | 1659 | [#0] ai-astar Cycles:10 Average:116.50 Median:117.50 stddev:3.87 (3.3%) stddev-sans-first:1.22 04:26:50 INFO - PROCESS | 1659 | Values: 106.0 118.0 118.0 117.0 117.0 117.0 117.0 120.0 116.0 119.0 04:26:50 INFO - PROCESS | 1659 | 04:26:50 INFO - PROCESS | 1659 | [#1] audio-beat-detection Cycles:10 Average:123.10 Median:120.50 stddev:13.91 (11.5%) stddev-sans-first:12.53 04:26:50 INFO - PROCESS | 1659 | Values: 144.0 126.0 114.0 149.0 111.0 115.0 114.0 113.0 131.0 114.0 04:26:50 INFO - PROCESS | 1659 | 04:26:50 INFO - PROCESS | 1659 | [#2] audio-dft Cycles:10 Average:200.40 Median:198.50 stddev:7.32 (3.7%) stddev-sans-first:7.50 04:26:50 INFO - PROCESS | 1659 | Values: 195.0 213.0 202.0 214.0 199.0 196.0 198.0 196.0 193.0 198.0 04:26:50 INFO - PROCESS | 1659 | 04:26:50 INFO - PROCESS | 1659 | [#3] audio-fft Cycles:10 Average:76.10 Median:84.50 stddev:10.85 (12.8%) stddev-sans-first:10.76 04:26:50 INFO - PROCESS | 1659 | Values: 87.0 85.0 68.0 84.0 67.0 87.0 85.0 65.0 75.0 58.0 04:26:50 INFO - PROCESS | 1659 | 04:26:50 INFO - PROCESS | 1659 | [#4] audio-oscillator Cycles:10 Average:76.80 Median:77.00 stddev:8.01 (10.4%) stddev-sans-first:5.98 04:26:50 INFO - PROCESS | 1659 | Values: 93.0 71.0 84.0 73.0 69.0 72.0 81.0 69.0 73.0 83.0 04:26:50 INFO - PROCESS | 1659 | 04:26:50 INFO - PROCESS | 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:101.50 Median:89.50 stddev:20.88 (23.3%) stddev-sans-first:21.92 04:26:50 INFO - PROCESS | 1659 | Values: 93.0 75.0 137.0 90.0 92.0 89.0 97.0 89.0 120.0 133.0 04:26:50 INFO - PROCESS | 1659 | 04:26:50 INFO - PROCESS | 1659 | [#6] imaging-darkroom Cycles:10 Average:116.10 Median:123.50 stddev:23.07 (18.7%) stddev-sans-first:23.52 04:26:50 INFO - PROCESS | 1659 | Values: 98.0 99.0 98.0 147.0 96.0 139.0 132.0 151.0 100.0 101.0 04:26:50 INFO - PROCESS | 1659 | 04:26:50 INFO - PROCESS | 1659 | [#7] imaging-desaturate Cycles:10 Average:108.60 Median:84.00 stddev:23.73 (28.2%) stddev-sans-first:23.99 04:26:50 INFO - PROCESS | 1659 | Values: 129.0 78.0 146.0 144.0 115.0 92.0 94.0 90.0 98.0 100.0 04:26:50 INFO - PROCESS | 1659 | 04:26:50 INFO - PROCESS | 1659 | [#8] json-parse-financial Cycles:10 Average:73.20 Median:74.00 stddev:14.52 (19.6%) stddev-sans-first:14.71 04:26:50 INFO - PROCESS | 1659 | Values: 61.0 61.0 62.0 61.0 62.0 67.0 81.0 91.0 93.0 93.0 04:26:50 INFO - PROCESS | 1659 | 04:26:50 INFO - PROCESS | 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:77.20 Median:76.00 stddev:7.33 (9.6%) stddev-sans-first:7.42 04:26:50 INFO - PROCESS | 1659 | Values: 71.0 74.0 74.0 84.0 78.0 75.0 77.0 95.0 73.0 71.0 04:26:50 INFO - PROCESS | 1659 | 04:26:50 INFO - PROCESS | 1659 | [#10] stanford-crypto-aes Cycles:10 Average:96.80 Median:88.00 stddev:12.60 (14.3%) stddev-sans-first:12.96 04:26:50 INFO - PROCESS | 1659 | Values: 88.0 88.0 92.0 78.0 101.0 109.0 114.0 91.0 91.0 116.0 04:26:50 INFO - PROCESS | 1659 | 04:26:50 INFO - PROCESS | 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:152.00 Median:145.00 stddev:18.55 (12.8%) stddev-sans-first:19.32 04:26:50 INFO - PROCESS | 1659 | Values: 142.0 143.0 147.0 157.0 143.0 142.0 141.0 143.0 201.0 161.0 04:26:50 INFO - PROCESS | 1659 | 04:26:50 INFO - PROCESS | 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.80 Median:174.00 stddev:4.78 (2.7%) stddev-sans-first:5.06 04:26:50 INFO - PROCESS | 1659 | Values: 173.0 184.0 173.0 173.0 177.0 166.0 170.0 176.0 175.0 171.0 04:26:50 INFO - PROCESS | 1659 | 04:26:50 INFO - PROCESS | 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.45 (2.1%) stddev-sans-first:1.32 04:26:50 INFO - PROCESS | 1659 | Values: 70.0 68.0 69.0 68.0 67.0 66.0 67.0 68.0 66.0 70.0 04:26:50 INFO - PROCESS | 1659 | -------- Summary: end -------- 04:26:50 INFO - PROCESS | 1659 | 04:26:51 INFO - TEST-INFO | 1659: exit 0 04:26:51 INFO - TEST-OK | kraken | took 61225ms 04:26:51 INFO - SUITE-END | took 1176s 04:26:51 INFO - Completed test suite (00:19:36) 04:26:51 INFO - javascript benchmark 04:26:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7087.683310420357, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2603.4662894106714, 2817.5491921292573, 2878.798484106113, 3426.1263377838645, 3471.149568355753, 5613.859653508664, 5690.089585666289, 5726.484616384525, 5769.798057068004, 5774.632400715707, 4743.217369134089, 5641.605087643857, 5703.515201207892, 5802.680852553108, 5824.737886795094, 5146.382434107913, 5197.220416937452, 5239.292695486118, 5250.212468129792, 5302.2311764794085, 4725.362076119732, 5197.194434862602, 5251.816186433456, 5263.973680131594, 5284.313039304885, 4428.645708343325, 4681.6722829401615, 5291.0, 5302.072137375963, 5340.546053585431, 5159.993801208766, 5165.63840531163, 5211.42674305826, 5254.106801843657, 5318.654287471302, 5130.615203859726, 5228.032813929397, 5236.502532259429, 5238.554722848562, 5247.39654939683, 5496.890062198733, 5704.743286552115, 5776.133579962997, 5814.302283725938, 5821.126830975345, 6126.3650001744745, 6135.141080248769, 6185.845353866144, 6247.344028876948, 6257.9687101564205, 6208.534359923024, 6213.751449941997, 6214.533909956726, 6232.158658581079, 6240.313565507836, 5865.76536938522, 5892.793752218652, 5909.8227053188475, 5922.703864806828, 5952.434518720715, 6132.171952247653, 6154.7230374633245, 6165.32181460048, 6171.228596425447, 6301.180846489927, 6106.0, 6109.374301065143, 6116.761878222105, 6118.60229085108, 6149.846253843601, 6199.236202980234, 6227.159333490012, 6261.373862613702, 6270.278917924497, 6274.341194174637, 6111.449969502677, 6122.051082082285, 6132.8756461173125, 6163.84590385244, 6188.597741146811, 6235.314115447297, 6266.373362663697, 6270.811875643738, 6277.372262773686, 6284.088807122942, 5029.346184995927, 5030.723310217973, 5047.318611987334, 5047.545720885065, 5056.443791182967, 3748.381517049711, 4434.490033646108, 4435.179491794029, 4502.684812063189, 4505.684602077823, 5870.471657550841, 5926.259217597801, 5979.133025711248, 6005.429484198994, 6022.09668549721, 6183.907241391383, 6205.937940620536, 6207.255129384503, 6216.968915155395, 6224.315325314303, 5791.768329266866, 5851.239338886003, 5967.283925928917, 5973.671448070398, 6012.789552365646, 5463.726813659301, 5479.6164268500825, 5512.228288039678, 5525.668459892419, 5581.274434323512, 6348.555601108063, 6381.8085457436355, 6394.0408938659575, 6400.0, 6421.839454013687, 6167.444929956326, 6202.069689546604, 6221.595596286227, 6226.315105338319, 6228.4705800007505, 6136.243373036893, 6251.4061164189325, 6271.466925311217, 6284.120223168668, 6400.51996100285, 6213.596116252429, 6245.5628106033955, 6255.874882502416, 6260.843478912881, 6283.842903927439, 6222.377762223741, 6239.532035097477, 6241.500679945684, 6244.968775156095, 6256.374362563707, 5762.078067509178, 6062.605930614496, 6087.66517841523, 6089.695515224133, 6098.512119030378, 6131.448169664752, 6143.450468055707, 6154.138420621206, 6157.107219453064, 6168.475679567287, 5029.27075574047, 5759.350698678655, 5761.107028410603, 6034.426729460694, 6043.879122417615, 6117.188044311343, 6121.479674227562, 6127.969360153171, 6219.906701399392, 6225.501959843111, 6039.033754599243, 6044.879102417839, 6044.879102418015, 6060.424259695322, 6080.7567697291615], "value": 5693.5492392020815, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [457.25239233852653, 487.96828206166595, 491.14050411779385, 496.3696105945452, 514.7297668723921, 36440.81779591102, 40778.59221407785, 40899.18201635966, 40924.79537602308, 40942.59057409425, 41310.38034429486, 41808.0, 41826.37260441096, 41831.95420114499, 41850.162996740044, 9144.634214631424, 9396.295277854155, 9419.434833909952, 10753.193510486706, 11194.88051194882, 11066.336019838795, 11158.497867595937, 11160.274582152175, 11161.274517156358, 11201.327920324766, 11087.944560277187, 11213.10295176388, 11235.550577976872, 11242.718932026683, 11259.662210133709, 11154.386508742016, 11197.60808371703, 11202.43987800615, 11204.439778011067, 11216.383098929555, 10921.290116142425, 10969.83545246814, 11000.559977600886, 11026.338419694765, 11053.336799792038, 30186.245343866358, 36707.4493882592, 36735.81632091849, 37261.06847328811, 37413.43879841804, 3928.273269445162, 3979.3633018717155, 3984.203159368138, 4000.439938408625, 4142.544320124784, 28222.87108515657, 28453.430931381256, 28611.427771444454, 28676.426471470662, 28693.0, 3175.301433684586, 3256.495243237302, 3275.164832967602, 3322.1694576355912, 3322.8670853166086, 477607.0, 477834.0, 480578.0, 481933.0, 482117.5894120542, 55842.0, 55937.440625593226, 56107.0, 56265.0, 56427.0, 57831.42168578345, 57966.71016644974, 58188.79961602068, 58579.5355116117, 58688.82622347614, 15087.019343742622, 15362.615934601725, 15561.610959726097, 15568.610784730472, 15601.60995975087, 10770.138388928866, 11073.557057717762, 11822.940885295518, 12031.87968120325, 12134.15060945743, 17478.563035924202, 17505.0, 17510.91244543769, 17544.94730316185, 17766.289348426177, 7714.190010048864, 7832.451728379073, 7838.804029899298, 7845.293923546908, 7909.1299957004685, 863.2101627011215, 867.4621734524635, 877.6664867350366, 882.9823403532022, 902.3953950852945, 29432.11703648894, 29910.953116640812, 29942.700572993992, 30580.84709576438, 30628.693713062585, 1060.2949038889205, 1062.3413483640038, 1091.770728147098, 1106.5684383090602, 1191.3923898811668, 14687.685101765537, 15472.0, 15577.0, 15589.844101559067, 15649.843501565067, 612287.0, 614053.0, 616839.0, 616863.9156804187, 617096.0, 50221.74889125531, 59156.0, 59554.0, 59875.80248395008, 59963.800723985274, 1408.5774267719644, 1436.74138655041, 1457.9781303280458, 1458.8978771485895, 1463.9971619440716, 24472.388190295384, 25599.0, 29306.70693293125, 29530.852345738134, 30175.69824301729, 44227.0, 46861.53138468708, 50479.73800655013, 50518.242226365895, 50549.0, 543004.0, 545744.0, 546978.0, 547879.0, 549313.0274789124, 22798.658020130042, 23310.417239569146, 24718.629220562067, 25591.6161257585, 26554.734452655226, 44151.0, 46837.29744053774, 46913.06173876572, 47142.0, 47640.28539571979, 32457.675423245466, 33251.50122748112, 38806.61193388143, 39578.60421395749, 40231.1953760929, 36951.89144325675, 37406.0, 38390.0, 38737.80631096826, 39549.40675889922, 37023.81488092542, 37084.0, 37451.625483745906, 37663.435048473744, 38485.03787405225, 26818.865905670347, 28892.27769305784, 28951.565726514542, 34578.82710586431, 34581.82709086438, 22439.663405049265, 23780.692061936068, 23884.76115238895, 24902.770298570005, 25518.489630207663], "value": 19817.645590001157, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.81819544813965, 388.82697199746127, 400.2695081476306, 406.61777928746983, 420.2183937875551, 18518.722219166688, 20763.16947322107, 21116.260930867422, 21956.341309760694, 22040.779592204093, 20126.19495220193, 20529.486762830937, 20938.581228375424, 21308.36074917751, 21907.780922190774, 5782.681952492611, 6045.304789949146, 6098.54260930432, 6103.084537319393, 6110.175126357952, 5821.18503409523, 5975.43233392827, 5995.13070604762, 6063.151158837766, 6079.05774604937, 5962.463378295953, 6010.639361638294, 6012.518998480111, 6014.248218972629, 6020.879582408349, 5272.683638981635, 5945.702714864239, 5951.166836642873, 5988.700564971756, 5989.0, 5861.970690146564, 5872.265966754156, 5873.882522349571, 5881.470667639933, 5885.646861188299, 13051.804222936664, 13442.12626179305, 13608.0, 13767.242801646005, 13771.724565508634, 2585.0, 2625.330540712106, 2658.322127857384, 2815.1554533640033, 2971.6178753328886, 9896.307258491908, 10001.849787274485, 10057.597696092147, 10493.475326233734, 10505.212109091848, 1606.7911171547623, 1746.950794882508, 1804.7653805005395, 1902.9333973310868, 1905.9332923347615, 114159.0, 117444.0, 117690.41154794171, 118622.40688796501, 119277.0, 11995.100367472474, 12000.759984800256, 12200.572979945659, 12242.653308136098, 12328.75342493163, 15319.92340038315, 15860.0, 15872.92063539675, 15873.52379428619, 15902.44341448067, 7153.89269160963, 7234.746783862644, 7308.232635573295, 8467.915320846712, 8822.338324625678, 6821.69302381394, 8400.495970241805, 8418.242358187792, 8549.529775862264, 8575.271101956403, 4091.8772436826944, 4824.276358546246, 4825.348577942003, 4839.395075615548, 4858.149823780825, 1683.3603230772228, 2070.5257217625094, 2074.284371891695, 2075.3877606106234, 2076.2733043434678, 377.2323322039636, 379.5805634773591, 1020.1889497849228, 1026.2098184398121, 1065.9946700266448, 10809.621663241749, 11498.677652069951, 11514.596989105341, 11776.646700598996, 12059.15585908978, 420.09469593027075, 422.7759287577589, 425.46179083459447, 429.9080335946723, 431.99352009719877, 5028.34631497903, 5704.971475142598, 5910.290765108214, 6013.188219590387, 6201.937980620226, 426925.0, 427587.8620606877, 434371.0, 436729.0, 437066.0, 133051.33474332566, 133079.0, 140302.0, 155348.1162970912, 163975.360246396, 432.4831825968001, 445.92196365635886, 447.53903479416255, 449.42698059973793, 449.4763600405491, 11035.39305338214, 11529.884701152881, 11584.768304633692, 11596.536138554364, 11825.704357391134, 45267.547324526335, 47896.28155577739, 58700.706496467246, 59762.10356844564, 60424.0, 81309.0, 82025.15698116264, 83328.58335708283, 84579.0, 86134.56932715296, 7979.5611241382285, 8066.7579972600915, 8275.255227029596, 8391.538465384217, 8632.223099921037, 8327.37544684139, 12359.134860560034, 13215.471381145031, 13567.86432135666, 13672.726545469233, 11419.0, 11593.88406115928, 11609.47757350938, 11661.24201926872, 11967.461464234304, 11102.666919992413, 11309.830352544554, 11353.921377469127, 11361.829572556584, 11656.358900260568, 9644.614215431304, 11467.254628449124, 11621.767564648491, 11822.645320640395, 12089.335086570323, 8235.547044912588, 8385.203405676451, 8460.91539084626, 8493.193146651058, 8505.574721264036, 8009.399295053011, 8957.59690813928, 11451.828222576502, 11652.009579185864, 11704.648860534198], "value": 8632.47449193229, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1403.4245959156747, 1413.5194034028427, 1421.928903554822, 1438.0077746355012, 1439.5321520505836, 7487.887681684765, 7731.961340193306, 8025.277725004748, 8449.788755281113, 8501.48991060536, 8011.879821802678, 8273.91726082739, 8275.131111233324, 8375.455595386296, 8379.203975622322, 2256.1386855843953, 2295.0819672131115, 2298.8620682759006, 2301.7928386445215, 2305.3199306204624, 1884.7926728059902, 2051.3743308290964, 2116.4285642876416, 2311.087120587367, 2311.3643747969277, 2025.281025236042, 2291.3813270416977, 2295.6326987681973, 2298.0233400804673, 2300.8389412741117, 2274.65880117982, 2281.8973146208377, 2284.474570848714, 2289.198780426854, 2303.2284184798114, 2233.8212942964524, 2265.7054582904284, 2281.6121259385777, 2289.072925465189, 2296.6899468571696, 6970.93029069713, 8350.290225330855, 8423.536705481196, 8482.575871206414, 8494.980602327698, 4493.326001099861, 5116.283720279164, 5128.666636668605, 5232.084385232569, 5256.526912577848, 3391.1687491364128, 3518.665726755954, 3518.736094792875, 3571.017970058229, 3596.1189508570305, 1187.821826725998, 1225.5342969671558, 1229.8155276708476, 1256.6669832494397, 1279.8400199975003, 10702.250842441032, 10759.51582178796, 10820.350778953289, 10822.296550724177, 10825.025747682746, 4316.309390497506, 4522.819087236539, 4675.76621168947, 4676.18166820805, 4757.238841785298, 8599.871001934851, 8640.697575584825, 8645.481271123752, 8711.912880871238, 8715.259202967818, 5108.106081435734, 5115.667481613683, 5117.053345131163, 5121.590272778169, 5124.256982737482, 3373.8819141329936, 3836.290286297044, 4043.636072753466, 4786.0667169902235, 4794.065157294294, 2781.6648008955813, 2998.745106665958, 3486.198174419847, 3684.4473329000866, 3782.71629627779, 1071.59815069349, 1109.6005438042298, 1141.0643272516622, 1155.5493357590547, 1180.3508070561156, 657.5430076097163, 698.5878331784272, 731.2212493694304, 750.8385697075155, 761.2501685839444, 5221.7128057956415, 5260.473952604785, 5292.867678308073, 5603.691796951125, 5629.043062679354, 838.4508147163617, 951.9381240219363, 957.899420560845, 960.9423434593947, 1015.5074788727461, 3598.2983318253214, 3599.352116618981, 3627.6190999944624, 3725.869594564177, 3732.5520937487677, 9204.401713888576, 9848.0, 9892.604295828087, 9895.01049895019, 9916.057974492413, 9771.022897710172, 9871.160951319074, 9875.061869122423, 9876.160526355197, 9880.901190988141, 7641.159472458025, 7853.09689385728, 7859.096203936506, 7860.882086768703, 7872.685092596346, 5020.723860187724, 5304.151335786256, 5353.2773075634295, 5381.784728610812, 5417.475343605156, 8928.10718928102, 8946.881639795025, 9025.954870225607, 9047.728568142966, 9109.77225569366, 9173.128552787475, 9228.984811670845, 9256.676016339396, 9289.489078100769, 9326.766830829283, 6649.501287403561, 6796.830079248059, 6806.115205023315, 6806.727730890907, 6824.522283440111, 7547.622618869144, 7711.575863327571, 7795.454318197899, 7830.099538552911, 7901.446898717035, 7086.39765619928, 7138.535995160298, 7141.143062832493, 7154.785356439315, 7177.0, 5982.790602328898, 6830.180378354629, 6923.342282483156, 6961.408280296231, 7047.647617619201, 6298.874022519432, 6315.621062736251, 6420.903686444801, 6437.420632143129, 6443.967780161257, 4898.485659005753, 4911.7298548580175, 4927.507249275044, 4988.850334489971, 4995.700257984533, 4938.358013458227, 4944.15949288629, 5044.066847633199, 5091.287219789307, 5198.090334191577], "value": 4292.986334385356, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.3409605731906, 317.74897830713724, 344.99999999999994, 369.50855362368054, 379.75695554844884, 4733.668643194977, 4768.308595253686, 4875.92729599488, 5177.326947496829, 5500.202470641764, 5427.728613569316, 5480.205370221315, 5523.0, 5552.222688823558, 5620.887582248362, 3754.2679177560385, 4018.81444973732, 4023.8994025149386, 4169.499660040799, 4175.290200665879, 3281.4913688378338, 3511.666391692798, 4223.788810559475, 4244.49066112067, 4248.086661367805, 3608.8632080894567, 3714.758540694846, 3747.86882459114, 4191.784382529078, 4297.247981603223, 3581.6418358164237, 4122.319817230154, 4193.412922190896, 4202.789860506993, 4347.847825326115, 3682.2935142670117, 3733.8693145739767, 3734.2158146789207, 3744.569374521938, 3748.194138260287, 4683.531646835323, 4780.275243111428, 5278.703763862732, 5404.756785944642, 5447.291852059247, 3754.9812250938844, 3980.5073097588406, 4900.901981960341, 4952.851414457572, 4997.350344455234, 5181.533661970403, 5277.076511610453, 5763.423657634203, 5773.653580785166, 5787.164289498116, 3867.574566797678, 3898.6491215790716, 3961.722679412442, 3973.205358928197, 3991.341428664267, 5133.383993920716, 5796.478316951495, 6049.455549000655, 6104.542159338067, 6132.799032662596, 3690.3910854708674, 3936.488256526633, 3974.324364857981, 3990.541087774943, 3991.62289010291, 4065.8044655886083, 4066.2477441673386, 4069.9389509157386, 4071.65635340337, 4096.692748043909, 4353.434053573079, 4445.466544014675, 4624.884377890579, 4775.2359622460235, 4779.02030083832, 5202.713850738246, 5300.390455097713, 5361.919571206435, 5444.40111587725, 5875.588708790344, 1313.6026751179136, 1322.768515509801, 1322.9470821167045, 1325.4300650720284, 1325.907186496936, 835.4402550291198, 889.4263200235812, 892.9775407158767, 896.7578753736454, 901.5221932375852, 5289.2710638999415, 5307.469253074739, 5384.78460861569, 5448.891022179534, 5556.9156669847625, 5271.71005594696, 5523.28197334344, 5951.434613711691, 6011.338752737195, 6070.605410648382, 4344.0, 5232.947670523322, 5532.5297349724915, 5539.233321341527, 5562.749676264578, 2625.724298948583, 2631.381625318049, 2749.5738160585142, 2924.5174546199637, 3012.6987301270137, 5238.659487133325, 5420.83737487876, 5689.971550142222, 6022.427869352405, 6026.879462410728, 5133.537981581676, 5533.972330138324, 5918.437748413894, 5940.851478713067, 5943.5839491236065, 5721.742521586455, 5968.253968253968, 5983.670898100646, 6004.399560044048, 6026.487748541423, 5304.522592966651, 5565.4363421995195, 5595.776168953359, 5714.828555143353, 5766.192733017465, 4871.565546289928, 5726.713664316851, 5904.228731380655, 5948.5426070612975, 6020.729067191899, 5600.551955843442, 6246.656433896179, 6315.747370105144, 6340.270868850142, 6341.653588172406, 3203.1741907113656, 3513.3851575974613, 3882.650561449483, 3962.8258967202282, 3982.8008599570485, 5284.682919024871, 5445.821671331499, 5567.24842146305, 5724.74238659253, 5950.940490595039, 5799.536037117105, 5840.503557197686, 5841.707914604338, 5881.852953676022, 5889.676067816311, 4649.558291962258, 4785.282207668877, 5555.583331250254, 5807.361190269152, 5930.762769489172, 4908.730019848943, 5730.054541000688, 5768.855778605568, 5777.595568310178, 5797.8550536236935, 4570.200214962302, 4705.717656940595, 4788.11419887322, 4922.704637721748, 5476.288082549243, 5412.323459567554, 5535.972320138373, 5630.943690563042, 5701.372848986691, 5726.026575482095], "value": 4169.868017958263, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.3311888754579, 706.7243774927775, 774.5778550689873, 830.9792255193621, 832.5379414424993, 15232.162231077285, 15831.366745330173, 15842.049477031358, 15864.206789660528, 15905.84094159058, 14314.069585476936, 14355.78466323006, 14380.640483987905, 14478.13131212128, 14509.782353264709, 670.8926571748522, 687.388224480213, 833.1293797981124, 845.8900342955423, 856.5117882806802, 852.0286872964795, 865.3336930563462, 865.9004214515348, 866.3675516872687, 867.3581549653243, 917.2982668258754, 922.0226559846551, 923.8244733500647, 924.4545718026363, 924.6624981881598, 885.716570697377, 915.4187091197072, 916.5463095767604, 918.2011649864661, 918.3709159225884, 676.070403195606, 676.2696288008939, 676.4858707382375, 677.5358879167786, 678.6606696651675, 14767.778483322758, 15121.924390378088, 15190.0, 15489.993150445185, 15784.526464206092, 14247.715045699131, 14493.202873841934, 14637.92681036588, 14663.63340916475, 14798.852011479963, 11706.70733231676, 11784.764304713857, 11842.881571184264, 11862.288262704265, 11892.0, 3680.7607505512324, 3707.721920855947, 3728.608496107897, 3755.1926335837925, 3841.308564458396, 99910.50134247993, 103659.48170259176, 103809.0, 104563.0, 104790.0, 11085.612003579836, 11117.833232501518, 11219.439028048564, 11263.211575189822, 11497.252678575866, 23100.768992310197, 23394.0, 23398.18106366269, 23416.712080835718, 23464.06143754265, 7745.264199901, 7783.922160778433, 7803.063632364153, 7825.686972521035, 7927.8810817837775, 4237.152569486115, 4288.142371525645, 4321.69748117635, 4407.272799987966, 4481.551844815493, 3097.760895641761, 3495.702865256482, 3565.868263473054, 3583.6953858922284, 3584.2831433713363, 609.1015751766109, 611.0467670434138, 618.7246675229479, 629.3706293706293, 630.760311081786, 633.8763941031455, 646.705748884266, 648.9805305840832, 676.6853413162903, 679.6363945289246, 9372.265966754188, 10288.691339259834, 10880.347179169275, 10881.238313317992, 10997.900209979098, 476.94276686797804, 556.6854727079187, 567.7161419290355, 572.4189947203591, 603.9822898416182, 4645.419322584677, 4905.3623029006, 4911.926321105187, 4966.553010229097, 5087.949120508748, 95162.9595188456, 99600.0, 100488.0, 103485.0, 105643.94356056495, 88563.22873542493, 89882.0, 90185.0, 91229.54385228164, 91547.0, 67686.0, 71957.20106997262, 76333.0, 77410.0, 77831.61084194656, 9605.519724013631, 9627.951860240933, 9710.514474276117, 9713.222942164468, 9740.415575065519, 49045.50954490552, 49534.51396458112, 49923.0, 50371.0, 50702.23946640877, 60817.69591152016, 64222.0, 67401.65196696136, 68809.96785048328, 69293.3070669307, 11306.378149201873, 11453.942730286295, 11500.53997840077, 11573.363465009505, 11738.119641026786, 11240.606578769704, 12385.62843114708, 12555.309457979898, 12953.676158096123, 13041.413136409074, 10681.839772403264, 11208.439578020903, 11722.296662200295, 11953.760924781282, 11986.28082315029, 9596.95201523988, 11275.210735248455, 11331.263467874562, 11369.829452558384, 11406.885931140583, 11733.35466549348, 11806.350650714294, 11823.408829558659, 11893.583724569598, 12380.504779808707, 9582.952085239529, 9611.567479463301, 9779.657711980046, 9840.261980351359, 10021.699349019542, 8500.702475413578, 9291.0, 9531.428114313163, 9664.613415463584, 9732.659356922473], "value": 7269.88720988959, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1560.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 120.0, 116.0, 119.0], "value": 116.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 126.0, 114.0, 149.0, 111.0, 115.0, 114.0, 113.0, 131.0, 114.0], "value": 123.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 213.0, 202.0, 214.0, 199.0, 196.0, 198.0, 196.0, 193.0, 198.0], "value": 200.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 68.0, 84.0, 67.0, 87.0, 85.0, 65.0, 75.0, 58.0], "value": 76.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 71.0, 84.0, 73.0, 69.0, 72.0, 81.0, 69.0, 73.0, 83.0], "value": 76.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 75.0, 137.0, 90.0, 92.0, 89.0, 97.0, 89.0, 120.0, 133.0], "value": 101.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 99.0, 98.0, 147.0, 96.0, 139.0, 132.0, 151.0, 100.0, 101.0], "value": 116.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 78.0, 146.0, 144.0, 115.0, 92.0, 94.0, 90.0, 98.0, 100.0], "value": 108.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 61.0, 62.0, 67.0, 81.0, 91.0, 93.0, 93.0], "value": 73.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 74.0, 74.0, 84.0, 78.0, 75.0, 77.0, 95.0, 73.0, 71.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 92.0, 78.0, 101.0, 109.0, 114.0, 91.0, 91.0, 116.0], "value": 96.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 143.0, 147.0, 157.0, 143.0, 142.0, 141.0, 143.0, 201.0, 161.0], "value": 152.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 184.0, 173.0, 173.0, 177.0, 166.0, 170.0, 176.0, 175.0, 171.0], "value": 173.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 69.0, 68.0, 67.0, 66.0, 67.0, 68.0, 66.0, 70.0], "value": 67.9, "unit": "score"}]}]} 04:26:51 INFO - Return code: 0 04:26:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:26:51 ERROR - # TBPL SUCCESS # 04:26:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:26:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:26:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:26:51 INFO - 2017-01-26 04:26:51.452 screenresolution[1664:11214] starting screenresolution argv=screenresolution get 04:26:51 INFO - 2017-01-26 04:26:51.455 screenresolution[1664:11214] Display 0: 1600x1200x32@60 04:26:51 INFO - 2017-01-26 04:26:51.461 screenresolution[1665:11217] starting screenresolution argv=screenresolution list 04:26:51 INFO - Available Modes on Display 0 04:26:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:26:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:26:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:26:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:26:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:26:51 INFO - Intel Iris: 04:26:51 INFO - Chipset Model: Intel Iris 04:26:51 INFO - Type: GPU 04:26:51 INFO - Bus: Built-In 04:26:51 INFO - VRAM (Dynamic, Max): 1536 MB 04:26:51 INFO - Vendor: Intel (0x8086) 04:26:51 INFO - Device ID: 0x0a2e 04:26:51 INFO - Revision ID: 0x0009 04:26:51 INFO - Displays: 04:26:51 INFO - Display: 04:26:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:26:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:26:51 INFO - Display Serial Number: 1600x1200 60 04:26:51 INFO - Main Display: Yes 04:26:51 INFO - Mirror: Off 04:26:51 INFO - Online: Yes 04:26:51 INFO - Rotation: Supported 04:26:51 INFO - Return code: 0 04:26:51 INFO - Running post-action listener: _resource_record_post_action 04:26:51 INFO - [mozharness: 2017-01-26 12:26:51.697828Z] Finished run-tests step (success) 04:26:51 INFO - Running post-run listener: _resource_record_post_run 04:26:51 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 32763392; Write bytes: 556419584; Read time: 296; Write time: 1816 04:26:51 INFO - TinderboxPrint: CPU usage
54.5% 04:26:51 INFO - TinderboxPrint: I/O read bytes / time
32,763,392 / 296 04:26:51 INFO - TinderboxPrint: I/O write bytes / time
556,419,584 / 1,816 04:26:51 INFO - TinderboxPrint: CPU idle
2,183.1 (45.5%) 04:26:51 INFO - TinderboxPrint: CPU system
966.9 (20.2%) 04:26:51 INFO - TinderboxPrint: CPU user
1,647.7 (34.3%) 04:26:51 INFO - TinderboxPrint: Swap in / out
282,152,960 / 0 04:26:51 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 238912000; Write bytes: 231280640; Read time: 17579; Write time: 417 04:26:51 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 30977536; Write bytes: 303614464; Read time: 279; Write time: 1351 04:26:52 INFO - Running post-run listener: _upload_blobber_files 04:26:52 INFO - Blob upload gear active. 04:26:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:26:52 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 04:26:52 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'] 04:26:52 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 04:26:52 INFO - (blobuploader) - INFO - Open directory for files ... 04:26:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:26:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:26:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:53 INFO - (blobuploader) - INFO - Done attempting. 04:26:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:26:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:26:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:54 INFO - (blobuploader) - INFO - Done attempting. 04:26:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:26:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:26:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:55 INFO - (blobuploader) - INFO - Done attempting. 04:26:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:26:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:26:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:58 INFO - (blobuploader) - INFO - Done attempting. 04:26:58 INFO - (blobuploader) - INFO - Iteration through files over. 04:26:58 INFO - Return code: 0 04:26:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:26:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:26:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/10273d04097ae9f60be20efc024ceb5bfa682cdd990badba908e3ce2c8bbde2954936c815f371ef40db68d86d720a8d092a690dec949bdb0426744d7d4327d63", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9422cbb4bed302bf9b8b359f7968fe46b00b7b6382027c7983ceefecd461fb8a89e87ff86f641ccd24823c28b069f8aab44f5ae5faa1078136dd91f8a938b6ba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/571be07ff787aaa5a0c252ad30d014cb8d56de3e6e8c62f2918c86a0f6bdf943f01d5bb8ca68191f17125636546fb956dce804c47e86b25b99f39620c7b154a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fcbee3ec01adc656cc486635e9c19e4d9981ec69eb13de58b25fe475cf88f69a479699e221491c814ea909dee9db827cae4f5abd72b389827bea321d5a35f9f1"} 04:26:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:26:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:26:58 INFO - Contents: 04:26:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/10273d04097ae9f60be20efc024ceb5bfa682cdd990badba908e3ce2c8bbde2954936c815f371ef40db68d86d720a8d092a690dec949bdb0426744d7d4327d63", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9422cbb4bed302bf9b8b359f7968fe46b00b7b6382027c7983ceefecd461fb8a89e87ff86f641ccd24823c28b069f8aab44f5ae5faa1078136dd91f8a938b6ba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/571be07ff787aaa5a0c252ad30d014cb8d56de3e6e8c62f2918c86a0f6bdf943f01d5bb8ca68191f17125636546fb956dce804c47e86b25b99f39620c7b154a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fcbee3ec01adc656cc486635e9c19e4d9981ec69eb13de58b25fe475cf88f69a479699e221491c814ea909dee9db827cae4f5abd72b389827bea321d5a35f9f1"} 04:26:58 INFO - Running post-run listener: copy_logs_to_upload_dir 04:26:58 INFO - Copying logs to upload dir... 04:26:58 INFO - mkdir: /builds/slave/test/build/upload/logs 04:26:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.321751 ========= master_lag: 2.85 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-01-26 04:27:01.063616) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-26 04:27:01.071859) ========= 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.a56emPfuzQ/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.A0RkPQ3DpR/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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/10273d04097ae9f60be20efc024ceb5bfa682cdd990badba908e3ce2c8bbde2954936c815f371ef40db68d86d720a8d092a690dec949bdb0426744d7d4327d63", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9422cbb4bed302bf9b8b359f7968fe46b00b7b6382027c7983ceefecd461fb8a89e87ff86f641ccd24823c28b069f8aab44f5ae5faa1078136dd91f8a938b6ba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/571be07ff787aaa5a0c252ad30d014cb8d56de3e6e8c62f2918c86a0f6bdf943f01d5bb8ca68191f17125636546fb956dce804c47e86b25b99f39620c7b154a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fcbee3ec01adc656cc486635e9c19e4d9981ec69eb13de58b25fe475cf88f69a479699e221491c814ea909dee9db827cae4f5abd72b389827bea321d5a35f9f1"} build_url:https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011238 build_url: 'https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/10273d04097ae9f60be20efc024ceb5bfa682cdd990badba908e3ce2c8bbde2954936c815f371ef40db68d86d720a8d092a690dec949bdb0426744d7d4327d63", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9422cbb4bed302bf9b8b359f7968fe46b00b7b6382027c7983ceefecd461fb8a89e87ff86f641ccd24823c28b069f8aab44f5ae5faa1078136dd91f8a938b6ba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/571be07ff787aaa5a0c252ad30d014cb8d56de3e6e8c62f2918c86a0f6bdf943f01d5bb8ca68191f17125636546fb956dce804c47e86b25b99f39620c7b154a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fcbee3ec01adc656cc486635e9c19e4d9981ec69eb13de58b25fe475cf88f69a479699e221491c814ea909dee9db827cae4f5abd72b389827bea321d5a35f9f1"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-26 04:27:01.128622) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 8 secs) (at 2017-01-26 04:27:01.128920) ========= 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.a56emPfuzQ/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.A0RkPQ3DpR/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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.005155 ========= master_lag: 8.67 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 8 secs) (at 2017-01-26 04:27:09.806893) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-26 04:27:09.807198) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-26 04:27:09.817774) ========= ========= Total master_lag: 11.67 =========