builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0019 starttime: 1489657524.98 results: success (0) buildid: 20170316004004 builduid: 35361066cde144a9ae48aec95a4d485c revision: e00635bc10f072b7ab93640a6094b3d92e8ab740 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-16 02:45:24.976750) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-16 02:45:24.977229) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-16 02:45:24.977514) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-16 02:45:25.047858) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 02:45:25.048256) ========= 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.eFmIgJ125h/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.sj8kTECbH4/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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-03-16 02:45:25-- 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% 181M=0s 2017-03-16 02:45:25 (181 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.489564 ========= master_lag: 0.49 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 02:45:26.024599) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 02:45:26.024996) ========= 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.eFmIgJ125h/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.sj8kTECbH4/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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.032022 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 02:45:26.097255) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-16 02:45:26.097637) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e00635bc10f072b7ab93640a6094b3d92e8ab740 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e00635bc10f072b7ab93640a6094b3d92e8ab740 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.eFmIgJ125h/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.sj8kTECbH4/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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-03-16 02:45:26,202 truncating revision to first 12 chars 2017-03-16 02:45:26,202 Setting DEBUG logging. 2017-03-16 02:45:26,202 attempt 1/10 2017-03-16 02:45:26,203 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e00635bc10f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-16 02:45:27,264 unpacking tar archive at: mozilla-aurora-e00635bc10f0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.331782 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-16 02:45:27.453790) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-16 02:45:27.454124) ========= script_repo_revision: e00635bc10f072b7ab93640a6094b3d92e8ab740 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-16 02:45:27.454534) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-16 02:45:27.454806) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-16 02:45:27.474915) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-16 02:45:27.475313) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.eFmIgJ125h/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.sj8kTECbH4/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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 02:45:27 INFO - MultiFileLogger online at 20170316 02:45:27 in /builds/slave/test 02:45:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:45:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:45:27 INFO - {'append_to_log': False, 02:45:27 INFO - 'base_work_dir': '/builds/slave/test', 02:45:27 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:45:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:45:27 INFO - 'branch': 'Mozilla-Aurora', 02:45:27 INFO - 'buildbot_json_path': 'buildprops.json', 02:45:27 INFO - 'config_files': ('talos/mac_config.py',), 02:45:27 INFO - 'default_actions': ('clobber', 02:45:27 INFO - 'read-buildbot-config', 02:45:27 INFO - 'download-and-extract', 02:45:27 INFO - 'populate-webroot', 02:45:27 INFO - 'create-virtualenv', 02:45:27 INFO - 'install', 02:45:27 INFO - 'run-tests'), 02:45:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:45:27 INFO - 'download_minidump_stackwalk': True, 02:45:27 INFO - 'download_symbols': 'ondemand', 02:45:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:45:27 INFO - 'tooltool.py': '/tools/tooltool.py', 02:45:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:45:27 INFO - '/tools/misc-python/virtualenv.py')}, 02:45:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:45:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:45:27 INFO - 'gecko_profile': False, 02:45:27 INFO - 'gecko_profile_interval': 0, 02:45:27 INFO - 'installer_path': 'installer.exe', 02:45:27 INFO - 'log_level': 'info', 02:45:27 INFO - 'log_name': 'talos', 02:45:27 INFO - 'log_to_console': True, 02:45:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:45:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:45:27 INFO - 'opt_config_files': (), 02:45:27 INFO - 'pip_index': False, 02:45:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:45:27 INFO - 'cmd': ('bash', 02:45:27 INFO - '-c', 02:45:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:45:27 INFO - 'enabled': True, 02:45:27 INFO - 'halt_on_failure': False, 02:45:27 INFO - 'name': 'check_screen_resolution'},), 02:45:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:45:27 INFO - 'cmd': ('bash', 02:45:27 INFO - '-c', 02:45:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:45:27 INFO - 'enabled': True, 02:45:27 INFO - 'halt_on_failure': False, 02:45:27 INFO - 'name': 'check_screen_resolution'},), 02:45:27 INFO - 'run_cmd_checks_enabled': True, 02:45:27 INFO - 'suite': 'dromaeojs-e10s', 02:45:27 INFO - 'system_bits': '32', 02:45:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:45:27 INFO - 'title': 't-yosemite-r7-0019', 02:45:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:45:27 INFO - 'use_talos_json': True, 02:45:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:45:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:45:27 INFO - 'work_dir': 'build'} 02:45:27 INFO - [mozharness: 2017-03-16 09:45:27.689275Z] Running clobber step. 02:45:27 INFO - Running pre-action listener: _resource_record_pre_action 02:45:27 INFO - Running main action method: clobber 02:45:27 INFO - rmtree: /builds/slave/test/build 02:45:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:45:30 INFO - Running post-action listener: _resource_record_post_action 02:45:30 INFO - [mozharness: 2017-03-16 09:45:30.290125Z] Finished clobber step (success) 02:45:30 INFO - [mozharness: 2017-03-16 09:45:30.290236Z] Running read-buildbot-config step. 02:45:30 INFO - Running pre-action listener: _resource_record_pre_action 02:45:30 INFO - Running main action method: read_buildbot_config 02:45:30 INFO - Using buildbot properties: 02:45:30 INFO - { 02:45:30 INFO - "project": "", 02:45:30 INFO - "product": "firefox", 02:45:30 INFO - "script_repo_revision": "production", 02:45:30 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:45:30 INFO - "repository": "", 02:45:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:45:30 INFO - "buildid": "20170316004004", 02:45:30 INFO - "stage_platform": "macosx64", 02:45:30 INFO - "basedir": "/builds/slave/test", 02:45:30 INFO - "nightly_build": "True", 02:45:30 INFO - "buildnumber": 24, 02:45:30 INFO - "slavename": "t-yosemite-r7-0019", 02:45:30 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 02:45:30 INFO - "platform": "yosemite_r7", 02:45:30 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:45:30 INFO - "branch": "mozilla-aurora", 02:45:30 INFO - "repo_path": "releases/mozilla-aurora", 02:45:30 INFO - "revision": "e00635bc10f072b7ab93640a6094b3d92e8ab740", 02:45:30 INFO - "pgo_build": "False", 02:45:30 INFO - "builduid": "35361066cde144a9ae48aec95a4d485c", 02:45:30 INFO - "slavebuilddir": "test" 02:45:30 INFO - } 02:45:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/XohZgmNbTZOZLcuEzLN0Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 02:45:30 INFO - Running post-action listener: _resource_record_post_action 02:45:30 INFO - [mozharness: 2017-03-16 09:45:30.293548Z] Finished read-buildbot-config step (success) 02:45:30 INFO - [mozharness: 2017-03-16 09:45:30.293665Z] Running download-and-extract step. 02:45:30 INFO - Running pre-action listener: _resource_record_pre_action 02:45:30 INFO - Running main action method: download_and_extract 02:45:30 INFO - mkdir: /builds/slave/test/build/tests 02:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:30 INFO - trying https://queue.taskcluster.net/v1/task/XohZgmNbTZOZLcuEzLN0Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 02:45:30 INFO - Downloading https://queue.taskcluster.net/v1/task/XohZgmNbTZOZLcuEzLN0Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:45:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XohZgmNbTZOZLcuEzLN0Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 02:45:31 INFO - Downloaded 1199 bytes. 02:45:31 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:45:31 INFO - Using the following test package requirements: 02:45:31 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:45:31 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:45:31 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 02:45:31 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:45:31 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 02:45:31 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:45:31 INFO - u'jsshell-mac.zip'], 02:45:31 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:45:31 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 02:45:31 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:45:31 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:45:31 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 02:45:31 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:45:31 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 02:45:31 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:45:31 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 02:45:31 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:45:31 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 02:45:31 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:45:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XohZgmNbTZOZLcuEzLN0Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:45:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XohZgmNbTZOZLcuEzLN0Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:45:31 INFO - Fetch https://queue.taskcluster.net/v1/task/XohZgmNbTZOZLcuEzLN0Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:45:33 INFO - Expected file size: 51780113 02:45:33 INFO - Obtained file size: 51780113 02:45:49 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:45:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XohZgmNbTZOZLcuEzLN0Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:45:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XohZgmNbTZOZLcuEzLN0Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:45:49 INFO - Fetch https://queue.taskcluster.net/v1/task/XohZgmNbTZOZLcuEzLN0Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:45:51 INFO - Expected file size: 51780113 02:45:51 INFO - Obtained file size: 51780113 02:46:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XohZgmNbTZOZLcuEzLN0Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 02:46:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XohZgmNbTZOZLcuEzLN0Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:46:06 INFO - Fetch https://queue.taskcluster.net/v1/task/XohZgmNbTZOZLcuEzLN0Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 02:46:07 INFO - Expected file size: 14404424 02:46:07 INFO - Obtained file size: 14404424 02:46:07 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')]} 02:46:07 INFO - trying https://queue.taskcluster.net/v1/task/XohZgmNbTZOZLcuEzLN0Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:46:07 INFO - Downloading https://queue.taskcluster.net/v1/task/XohZgmNbTZOZLcuEzLN0Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 02:46:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XohZgmNbTZOZLcuEzLN0Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 02:46:10 INFO - Downloaded 74647271 bytes. 02:46:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XohZgmNbTZOZLcuEzLN0Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:46:10 INFO - mkdir: /builds/slave/test/properties 02:46:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:46:10 INFO - Writing to file /builds/slave/test/properties/build_url 02:46:10 INFO - Contents: 02:46:10 INFO - build_url:https://queue.taskcluster.net/v1/task/XohZgmNbTZOZLcuEzLN0Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:46:10 INFO - Running post-action listener: _resource_record_post_action 02:46:10 INFO - Running post-action listener: set_extra_try_arguments 02:46:10 INFO - [mozharness: 2017-03-16 09:46:10.777632Z] Finished download-and-extract step (success) 02:46:10 INFO - [mozharness: 2017-03-16 09:46:10.777771Z] Running populate-webroot step. 02:46:10 INFO - Running pre-action listener: _resource_record_pre_action 02:46:10 INFO - Running main action method: populate_webroot 02:46:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:46:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:46:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:46:10 INFO - '--tppagecycles', 02:46:10 INFO - '7'], 02:46:10 INFO - 'tests': ['tsvgm']}}, 02:46:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:46:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:46:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:46:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:46:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:46:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:46:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:46:10 INFO - 'talos_options': ['--disable-e10s'], 02:46:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:46:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:46:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:46:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:46:10 INFO - 'talos_options': ['--disable-e10s'], 02:46:10 INFO - 'tests': ['damp', 'tps']}, 02:46:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:46:10 INFO - 'tests': ['damp', 'tps']}, 02:46:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:46:10 INFO - 'tests': ['dromaeo_dom']}, 02:46:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:46:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:46:10 INFO - 'tests': ['basic_compositor_video']}, 02:46:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:46:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:46:10 INFO - 'tests': ['a11yr', 02:46:10 INFO - 'ts_paint', 02:46:10 INFO - 'tpaint', 02:46:10 INFO - 'sessionrestore', 02:46:10 INFO - 'sessionrestore_no_auto_restore', 02:46:10 INFO - 'tabpaint']}, 02:46:10 INFO - 'other-e10s': {'tests': ['a11yr', 02:46:10 INFO - 'ts_paint', 02:46:10 INFO - 'tpaint', 02:46:10 INFO - 'sessionrestore', 02:46:10 INFO - 'sessionrestore_no_auto_restore', 02:46:10 INFO - 'tabpaint']}, 02:46:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:46:10 INFO - 'ts_paint', 02:46:10 INFO - 'tpaint', 02:46:10 INFO - 'sessionrestore', 02:46:10 INFO - 'sessionrestore_no_auto_restore', 02:46:10 INFO - 'tabpaint']}, 02:46:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:46:10 INFO - 'ts_paint', 02:46:10 INFO - 'tpaint', 02:46:10 INFO - 'sessionrestore', 02:46:10 INFO - 'sessionrestore_no_auto_restore', 02:46:10 INFO - 'tabpaint']}, 02:46:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:46:10 INFO - 'tests': ['a11yr', 02:46:10 INFO - 'ts_paint', 02:46:10 INFO - 'tpaint', 02:46:10 INFO - 'sessionrestore', 02:46:10 INFO - 'sessionrestore_no_auto_restore', 02:46:10 INFO - 'tabpaint']}, 02:46:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:46:10 INFO - 'tests': ['a11yr', 02:46:10 INFO - 'ts_paint', 02:46:10 INFO - 'tpaint', 02:46:10 INFO - 'sessionrestore', 02:46:10 INFO - 'sessionrestore_no_auto_restore', 02:46:10 INFO - 'tabpaint']}, 02:46:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:46:10 INFO - 'tests': ['tsvgx', 02:46:10 INFO - 'tsvgr_opacity', 02:46:10 INFO - 'tart', 02:46:10 INFO - 'tscrollx', 02:46:10 INFO - 'cart', 02:46:10 INFO - 'tsvg_static']}, 02:46:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:46:10 INFO - 'tsvgr_opacity', 02:46:10 INFO - 'tart', 02:46:10 INFO - 'tscrollx', 02:46:10 INFO - 'cart', 02:46:10 INFO - 'tsvg_static']}, 02:46:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:46:10 INFO - 'talos_options': ['--disable-e10s'], 02:46:10 INFO - 'tests': ['tp5o']}, 02:46:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:46:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:46:10 INFO - 'talos_options': ['--disable-e10s', 02:46:10 INFO - '--xperf_path', 02:46:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:46:10 INFO - 'tests': ['tp5n']}, 02:46:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:46:10 INFO - 'talos_options': ['--xperf_path', 02:46:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:46:10 INFO - 'tests': ['tp5n']}}, 02:46:10 INFO - 'talos.zip': {'path': '', 02:46:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:46:10 INFO - Running post-action listener: _resource_record_post_action 02:46:10 INFO - [mozharness: 2017-03-16 09:46:10.795568Z] Finished populate-webroot step (success) 02:46:10 INFO - [mozharness: 2017-03-16 09:46:10.795659Z] Running create-virtualenv step. 02:46:10 INFO - Running pre-action listener: _resource_record_pre_action 02:46:10 INFO - Running main action method: create_virtualenv 02:46:10 INFO - Creating virtualenv /builds/slave/test/build/venv 02:46:10 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 02:46:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:46:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:46:10 INFO - Using real prefix '/tools/python27' 02:46:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:46:11 INFO - Installing distribute.............................................................................................................................................................................................done. 02:46:14 INFO - Installing pip.................done. 02:46:14 INFO - Return code: 0 02:46:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:46:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:46:14 INFO - Reading from file tmpfile_stdout 02:46:14 INFO - Output received: 02:46:14 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) 02:46:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:46: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')]} 02:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46: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')]} 02:46:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:14 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 0x104873b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104876768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda38cc7ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104651d30>, '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 0x104578db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104646be8>, '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.eFmIgJ125h/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.sj8kTECbH4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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 02:46:14 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 02:46:14 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 02:46:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eFmIgJ125h/Render', 02:46:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:14 INFO - 'HOME': '/Users/cltbld', 02:46:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:14 INFO - 'LOGNAME': 'cltbld', 02:46:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:14 INFO - 'MOZ_NO_REMOTE': '1', 02:46:14 INFO - 'NO_EM_RESTART': '1', 02:46:14 INFO - 'PAGER': '/bin/cat', 02:46:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:14 INFO - 'PWD': '/builds/slave/test', 02:46:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:14 INFO - 'SHELL': '/bin/bash', 02:46:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sj8kTECbH4/Listeners', 02:46:14 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 02:46:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:14 INFO - 'USER': 'cltbld', 02:46:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:14 INFO - 'XPC_FLAGS': '0x0', 02:46:14 INFO - 'XPC_SERVICE_NAME': '0', 02:46:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:15 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 02:46:15 INFO - Cleaning up... 02:46:15 INFO - Return code: 0 02:46:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:46: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')]} 02:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46: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')]} 02:46:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:15 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 0x104873b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104876768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda38cc7ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104651d30>, '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 0x104578db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104646be8>, '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.eFmIgJ125h/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.sj8kTECbH4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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 02:46:15 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 02:46:15 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 02:46:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eFmIgJ125h/Render', 02:46:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:15 INFO - 'HOME': '/Users/cltbld', 02:46:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:15 INFO - 'LOGNAME': 'cltbld', 02:46:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:15 INFO - 'MOZ_NO_REMOTE': '1', 02:46:15 INFO - 'NO_EM_RESTART': '1', 02:46:15 INFO - 'PAGER': '/bin/cat', 02:46:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:15 INFO - 'PWD': '/builds/slave/test', 02:46:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:15 INFO - 'SHELL': '/bin/bash', 02:46:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sj8kTECbH4/Listeners', 02:46:15 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 02:46:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:15 INFO - 'USER': 'cltbld', 02:46:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:15 INFO - 'XPC_FLAGS': '0x0', 02:46:15 INFO - 'XPC_SERVICE_NAME': '0', 02:46:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:15 INFO - Downloading/unpacking psutil>=3.1.1 02:46:15 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 02:46:15 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 02:46:15 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 02:46:15 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 02:46:15 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 02:46:15 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 02:46:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:46:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:46:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:46:19 INFO - Installing collected packages: psutil 02:46:19 INFO - Running setup.py install for psutil 02:46:19 INFO - building 'psutil._psutil_osx' extension 02:46:19 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 02:46:20 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 02:46:20 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 02:46:20 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 02:46:20 INFO - building 'psutil._psutil_posix' extension 02:46:20 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 02:46:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:46:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:46:20 INFO - ^ 02:46:20 INFO - 1 warning generated. 02:46:20 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 02:46:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:46:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:46:20 INFO - Successfully installed psutil 02:46:20 INFO - Cleaning up... 02:46:20 INFO - Return code: 0 02:46:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:46:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104873b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104876768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda38cc7ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104651d30>, '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 0x104578db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104646be8>, '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.eFmIgJ125h/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.sj8kTECbH4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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 02:46:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:46:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:46:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eFmIgJ125h/Render', 02:46:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:20 INFO - 'HOME': '/Users/cltbld', 02:46:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:20 INFO - 'LOGNAME': 'cltbld', 02:46:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:20 INFO - 'MOZ_NO_REMOTE': '1', 02:46:20 INFO - 'NO_EM_RESTART': '1', 02:46:20 INFO - 'PAGER': '/bin/cat', 02:46:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:20 INFO - 'PWD': '/builds/slave/test', 02:46:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:20 INFO - 'SHELL': '/bin/bash', 02:46:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sj8kTECbH4/Listeners', 02:46:20 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 02:46:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:20 INFO - 'USER': 'cltbld', 02:46:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:20 INFO - 'XPC_FLAGS': '0x0', 02:46:20 INFO - 'XPC_SERVICE_NAME': '0', 02:46:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:46:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:46:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:46:23 INFO - Installing collected packages: mozsystemmonitor 02:46:23 INFO - Running setup.py install for mozsystemmonitor 02:46:23 INFO - Successfully installed mozsystemmonitor 02:46:23 INFO - Cleaning up... 02:46:23 INFO - Return code: 0 02:46:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:46: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')]} 02:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46: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')]} 02:46:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104873b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104876768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda38cc7ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104651d30>, '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 0x104578db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104646be8>, '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.eFmIgJ125h/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.sj8kTECbH4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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 02:46:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:46:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:46:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eFmIgJ125h/Render', 02:46:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:23 INFO - 'HOME': '/Users/cltbld', 02:46:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:23 INFO - 'LOGNAME': 'cltbld', 02:46:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:23 INFO - 'MOZ_NO_REMOTE': '1', 02:46:23 INFO - 'NO_EM_RESTART': '1', 02:46:23 INFO - 'PAGER': '/bin/cat', 02:46:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:23 INFO - 'PWD': '/builds/slave/test', 02:46:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:23 INFO - 'SHELL': '/bin/bash', 02:46:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sj8kTECbH4/Listeners', 02:46:23 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 02:46:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:23 INFO - 'USER': 'cltbld', 02:46:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:23 INFO - 'XPC_FLAGS': '0x0', 02:46:23 INFO - 'XPC_SERVICE_NAME': '0', 02:46:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:24 INFO - Downloading/unpacking jsonschema==2.5.1 02:46:24 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 02:46:24 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 02:46:24 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 02:46:24 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 02:46:24 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 02:46:24 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 02:46:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:46:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:27 INFO - Downloading functools32-3.2.3-2.tar.gz 02:46:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:46:27 INFO - warning: no files found matching '*.txt' 02:46:27 INFO - no previously-included directories found matching 'build' 02:46:27 INFO - no previously-included directories found matching 'dist' 02:46:27 INFO - no previously-included directories found matching '.git*' 02:46:27 INFO - Installing collected packages: jsonschema, functools32 02:46:27 INFO - Running setup.py install for functools32 02:46:27 INFO - warning: no files found matching '*.txt' 02:46:27 INFO - no previously-included directories found matching 'build' 02:46:27 INFO - no previously-included directories found matching 'dist' 02:46:27 INFO - no previously-included directories found matching '.git*' 02:46:27 INFO - Successfully installed jsonschema functools32 02:46:27 INFO - Cleaning up... 02:46:27 INFO - Return code: 0 02:46:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:46:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104873b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104876768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda38cc7ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104651d30>, '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 0x104578db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104646be8>, '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.eFmIgJ125h/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.sj8kTECbH4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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 02:46:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:46:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:46:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eFmIgJ125h/Render', 02:46:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:27 INFO - 'HOME': '/Users/cltbld', 02:46:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:27 INFO - 'LOGNAME': 'cltbld', 02:46:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:27 INFO - 'MOZ_NO_REMOTE': '1', 02:46:27 INFO - 'NO_EM_RESTART': '1', 02:46:27 INFO - 'PAGER': '/bin/cat', 02:46:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:27 INFO - 'PWD': '/builds/slave/test', 02:46:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:27 INFO - 'SHELL': '/bin/bash', 02:46:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sj8kTECbH4/Listeners', 02:46:27 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 02:46:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:27 INFO - 'USER': 'cltbld', 02:46:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:27 INFO - 'XPC_FLAGS': '0x0', 02:46:27 INFO - 'XPC_SERVICE_NAME': '0', 02:46:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:46:27 INFO - Cleaning up... 02:46:27 INFO - Return code: 0 02:46:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:46:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104873b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104876768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda38cc7ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104651d30>, '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 0x104578db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104646be8>, '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.eFmIgJ125h/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.sj8kTECbH4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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 02:46:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:46:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:46:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eFmIgJ125h/Render', 02:46:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:27 INFO - 'HOME': '/Users/cltbld', 02:46:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:27 INFO - 'LOGNAME': 'cltbld', 02:46:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:27 INFO - 'MOZ_NO_REMOTE': '1', 02:46:27 INFO - 'NO_EM_RESTART': '1', 02:46:27 INFO - 'PAGER': '/bin/cat', 02:46:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:27 INFO - 'PWD': '/builds/slave/test', 02:46:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:27 INFO - 'SHELL': '/bin/bash', 02:46:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sj8kTECbH4/Listeners', 02:46:27 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 02:46:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:27 INFO - 'USER': 'cltbld', 02:46:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:27 INFO - 'XPC_FLAGS': '0x0', 02:46:27 INFO - 'XPC_SERVICE_NAME': '0', 02:46:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:28 INFO - Downloading/unpacking blobuploader==1.2.4 02:46:28 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 02:46:28 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 02:46:28 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 02:46:28 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 02:46:28 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 02:46:28 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 02:46:30 INFO - Downloading blobuploader-1.2.4.tar.gz 02:46:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:46:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:46:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:31 INFO - Downloading docopt-0.6.1.tar.gz 02:46:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:46:31 INFO - Installing collected packages: blobuploader, requests, docopt 02:46:31 INFO - Running setup.py install for blobuploader 02:46:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:46:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:46:32 INFO - Running setup.py install for requests 02:46:32 INFO - Running setup.py install for docopt 02:46:32 INFO - Successfully installed blobuploader requests docopt 02:46:32 INFO - Cleaning up... 02:46:32 INFO - Return code: 0 02:46:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:46: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')]} 02:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46: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')]} 02:46:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104873b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104876768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda38cc7ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104651d30>, '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 0x104578db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104646be8>, '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.eFmIgJ125h/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.sj8kTECbH4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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 02:46:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:46:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:46:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eFmIgJ125h/Render', 02:46:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:32 INFO - 'HOME': '/Users/cltbld', 02:46:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:32 INFO - 'LOGNAME': 'cltbld', 02:46:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:32 INFO - 'MOZ_NO_REMOTE': '1', 02:46:32 INFO - 'NO_EM_RESTART': '1', 02:46:32 INFO - 'PAGER': '/bin/cat', 02:46:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:32 INFO - 'PWD': '/builds/slave/test', 02:46:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:32 INFO - 'SHELL': '/bin/bash', 02:46:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sj8kTECbH4/Listeners', 02:46:32 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 02:46:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:32 INFO - 'USER': 'cltbld', 02:46:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:32 INFO - 'XPC_FLAGS': '0x0', 02:46:32 INFO - 'XPC_SERVICE_NAME': '0', 02:46:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:46:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-r4kXFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:46:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-l6Jk3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:46:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-aXPHpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:46:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-uFJtUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:46:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-D5KvTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:46:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-0l7A2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:46:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-kZv0iI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:46:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-4VIRUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:46:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-HRQAUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:46:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-iIFVId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:46:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-tfTDmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:46:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-uE_XGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:46:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-V4fXi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:46:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-ID7vxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-WewAZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:46:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-pFyhWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:46:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-1s0wL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:46:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:46:34 INFO - Running setup.py install for manifestparser 02:46:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:46:35 INFO - Running setup.py install for mozcrash 02:46:35 INFO - Running setup.py install for mozdebug 02:46:35 INFO - Running setup.py install for mozdevice 02:46:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:46:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:46:35 INFO - Running setup.py install for mozfile 02:46:35 INFO - Running setup.py install for mozhttpd 02:46:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:46:35 INFO - Running setup.py install for mozinfo 02:46:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:46:35 INFO - Running setup.py install for mozInstall 02:46:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:46:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:46:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:46:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:46:36 INFO - Running setup.py install for mozleak 02:46:36 INFO - Running setup.py install for mozlog 02:46:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:46:36 INFO - Running setup.py install for moznetwork 02:46:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:46:36 INFO - Running setup.py install for mozprocess 02:46:36 INFO - Running setup.py install for mozprofile 02:46:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:46:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:46:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:46:36 INFO - Running setup.py install for mozrunner 02:46:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:46:37 INFO - Running setup.py install for mozscreenshot 02:46:37 INFO - Running setup.py install for moztest 02:46:37 INFO - Running setup.py install for mozversion 02:46:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:46:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:46:37 INFO - Cleaning up... 02:46:37 INFO - Return code: 0 02:46:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104873b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104876768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda38cc7ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104651d30>, '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 0x104578db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104646be8>, '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.eFmIgJ125h/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.sj8kTECbH4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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 02:46:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:46:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:46:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eFmIgJ125h/Render', 02:46:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:37 INFO - 'HOME': '/Users/cltbld', 02:46:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:37 INFO - 'LOGNAME': 'cltbld', 02:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:37 INFO - 'MOZ_NO_REMOTE': '1', 02:46:37 INFO - 'NO_EM_RESTART': '1', 02:46:37 INFO - 'PAGER': '/bin/cat', 02:46:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:37 INFO - 'PWD': '/builds/slave/test', 02:46:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:37 INFO - 'SHELL': '/bin/bash', 02:46:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sj8kTECbH4/Listeners', 02:46:37 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 02:46:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:37 INFO - 'USER': 'cltbld', 02:46:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:37 INFO - 'XPC_FLAGS': '0x0', 02:46:37 INFO - 'XPC_SERVICE_NAME': '0', 02:46:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:46:37 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-dYERlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:46:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:46:37 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-oxh4e5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:46:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:46:37 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-177uvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:46:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:46:38 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-TlhKhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:46:38 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)) 02:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:46:38 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-VSM8Fq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:46:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:46:38 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-ijORIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:46:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:46:38 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-VGaDAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:46:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:46:38 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-1J4oVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:46:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:46:38 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-mHy9iU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:46:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:46:38 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-JWkCfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:46:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:46:38 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-3nOQD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:46:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:46:38 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-fyaEMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:46:39 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-EJ_tE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:46:39 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-VubWSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:39 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-ln9e6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:46:39 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-jIFp0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:46:39 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-DQCrRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:46:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:46: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 02:46: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 02:46: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 02:46: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 02:46: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 02:46: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 02:46:42 INFO - Downloading blessings-1.6.tar.gz 02:46:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:46:42 INFO - Installing collected packages: blessings 02:46:42 INFO - Running setup.py install for blessings 02:46:42 INFO - Successfully installed blessings 02:46:42 INFO - Cleaning up... 02:46:42 INFO - Return code: 0 02:46:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:46:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:46:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:46:42 INFO - Reading from file tmpfile_stdout 02:46:42 INFO - Current package versions: 02:46:42 INFO - blessings == 1.6 02:46:42 INFO - blobuploader == 1.2.4 02:46:42 INFO - docopt == 0.6.1 02:46:42 INFO - functools32 == 3.2.3-2 02:46:42 INFO - jsonschema == 2.5.1 02:46:42 INFO - manifestparser == 1.1 02:46:42 INFO - mozInstall == 1.12 02:46:42 INFO - mozcrash == 1.0 02:46:42 INFO - mozdebug == 0.1 02:46:42 INFO - mozdevice == 0.49 02:46:42 INFO - mozfile == 1.2 02:46:42 INFO - mozhttpd == 0.7 02:46:42 INFO - mozinfo == 0.9 02:46:42 INFO - mozleak == 0.1 02:46:42 INFO - mozlog == 3.4 02:46:42 INFO - moznetwork == 0.27 02:46:42 INFO - mozprocess == 0.25 02:46:42 INFO - mozprofile == 0.28 02:46:42 INFO - mozrunner == 6.13 02:46:42 INFO - mozscreenshot == 0.1 02:46:42 INFO - mozsystemmonitor == 0.3 02:46:42 INFO - moztest == 0.8 02:46:42 INFO - mozversion == 1.4 02:46:42 INFO - psutil == 3.1.1 02:46:42 INFO - requests == 1.2.3 02:46:42 INFO - wsgiref == 0.1.2 02:46:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104873b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104876768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda38cc7ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104651d30>, '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 0x104578db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104646be8>, '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.eFmIgJ125h/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.sj8kTECbH4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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 02:46:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:46:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:46:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eFmIgJ125h/Render', 02:46:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:42 INFO - 'HOME': '/Users/cltbld', 02:46:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:42 INFO - 'LOGNAME': 'cltbld', 02:46:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:42 INFO - 'MOZ_NO_REMOTE': '1', 02:46:42 INFO - 'NO_EM_RESTART': '1', 02:46:42 INFO - 'PAGER': '/bin/cat', 02:46:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:42 INFO - 'PWD': '/builds/slave/test', 02:46:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:42 INFO - 'SHELL': '/bin/bash', 02:46:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sj8kTECbH4/Listeners', 02:46:42 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 02:46:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:42 INFO - 'USER': 'cltbld', 02:46:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:42 INFO - 'XPC_FLAGS': '0x0', 02:46:42 INFO - 'XPC_SERVICE_NAME': '0', 02:46:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:46:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:46:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:46:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:46:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:46:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:46:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:46:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:46:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:46:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:46:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:46:43 INFO - Cleaning up... 02:46:43 INFO - Return code: 0 02:46:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104873b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104876768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda38cc7ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104651d30>, '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 0x104578db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104646be8>, '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.eFmIgJ125h/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.sj8kTECbH4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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 02:46:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:46:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eFmIgJ125h/Render', 02:46:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:43 INFO - 'HOME': '/Users/cltbld', 02:46:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:43 INFO - 'LOGNAME': 'cltbld', 02:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:43 INFO - 'MOZ_NO_REMOTE': '1', 02:46:43 INFO - 'NO_EM_RESTART': '1', 02:46:43 INFO - 'PAGER': '/bin/cat', 02:46:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:43 INFO - 'PWD': '/builds/slave/test', 02:46:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:43 INFO - 'SHELL': '/bin/bash', 02:46:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sj8kTECbH4/Listeners', 02:46:43 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 02:46:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:43 INFO - 'USER': 'cltbld', 02:46:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:43 INFO - 'XPC_FLAGS': '0x0', 02:46:43 INFO - 'XPC_SERVICE_NAME': '0', 02:46:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:46:43 INFO - Cleaning up... 02:46:43 INFO - Return code: 0 02:46:43 INFO - Running post-action listener: _resource_record_post_action 02:46:43 INFO - Running post-action listener: _start_resource_monitoring 02:46:43 INFO - Starting resource monitoring. 02:46:43 INFO - [mozharness: 2017-03-16 09:46:43.409118Z] Finished create-virtualenv step (success) 02:46:43 INFO - [mozharness: 2017-03-16 09:46:43.410076Z] Running install step. 02:46:43 INFO - Running pre-action listener: _resource_record_pre_action 02:46:43 INFO - Running main action method: install 02:46:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:46:43 INFO - Reading from file tmpfile_stdout 02:46:43 INFO - Detecting whether we're running mozinstall >=1.0... 02:46:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:46:43 INFO - Reading from file tmpfile_stdout 02:46:43 INFO - Output received: 02:46:43 INFO - Usage: mozinstall [options] installer 02:46:43 INFO - Options: 02:46:43 INFO - -h, --help show this help message and exit 02:46:43 INFO - -d DEST, --destination=DEST 02:46:43 INFO - Directory to install application into. [default: 02:46:43 INFO - "/builds/slave/test"] 02:46:43 INFO - --app=APP Application being installed. [default: firefox] 02:46:43 INFO - mkdir: /builds/slave/test/build/application 02:46:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:47:04 INFO - Reading from file tmpfile_stdout 02:47:04 INFO - Output received: 02:47:04 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:47:04 INFO - Running post-action listener: _resource_record_post_action 02:47:04 INFO - [mozharness: 2017-03-16 09:47:04.134222Z] Finished install step (success) 02:47:04 INFO - [mozharness: 2017-03-16 09:47:04.134318Z] Running run-tests step. 02:47:04 INFO - Running pre-action listener: _resource_record_pre_action 02:47:04 INFO - Running main action method: run_tests 02:47:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:47:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:47:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:47:04 INFO - 2017-03-16 02:47:04.146 screenresolution[1626:8009] starting screenresolution argv=screenresolution get 02:47:04 INFO - 2017-03-16 02:47:04.149 screenresolution[1626:8009] Display 0: 1600x1200x32@60 02:47:04 INFO - 2017-03-16 02:47:04.154 screenresolution[1627:8012] starting screenresolution argv=screenresolution list 02:47:04 INFO - Available Modes on Display 0 02:47:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:47:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:47:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:47:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:47:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:47:04 INFO - Intel Iris: 02:47:04 INFO - Chipset Model: Intel Iris 02:47:04 INFO - Type: GPU 02:47:04 INFO - Bus: Built-In 02:47:04 INFO - VRAM (Dynamic, Max): 1536 MB 02:47:04 INFO - Vendor: Intel (0x8086) 02:47:04 INFO - Device ID: 0x0a2e 02:47:04 INFO - Revision ID: 0x0009 02:47:04 INFO - Displays: 02:47:04 INFO - Display: 02:47:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:47:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:47:04 INFO - Display Serial Number: 1600x1200 60 02:47:04 INFO - Main Display: Yes 02:47:04 INFO - Mirror: Off 02:47:04 INFO - Online: Yes 02:47:04 INFO - Rotation: Supported 02:47:04 INFO - Return code: 0 02:47:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:47:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:47:04 INFO - Python 2.7.3 02:47:04 INFO - Return code: 0 02:47:04 INFO - grabbing minidump binary from tooltool 02:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:47:04 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 0x104651d30>, '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 0x104578db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104646be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:47:04 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 02:47:04 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 02:47:04 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 02:47:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:47:04 INFO - Return code: 0 02:47:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:47:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:47:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:47:04 INFO - ENV: RUST_BACKTRACE is now 1 02:47:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:47:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:47:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XohZgmNbTZOZLcuEzLN0Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0019', '--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 02:47:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XohZgmNbTZOZLcuEzLN0Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0019 --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 02:47:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eFmIgJ125h/Render', 02:47:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:47:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:47:04 INFO - 'HOME': '/Users/cltbld', 02:47:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:47:04 INFO - 'LOGNAME': 'cltbld', 02:47:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:47:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:04 INFO - 'MOZ_NO_REMOTE': '1', 02:47:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:47:04 INFO - 'NO_EM_RESTART': '1', 02:47:04 INFO - 'PAGER': '/bin/cat', 02:47:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:04 INFO - 'PWD': '/builds/slave/test', 02:47:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:47:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:47:04 INFO - 'RUST_BACKTRACE': '1', 02:47:04 INFO - 'SHELL': '/bin/bash', 02:47:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sj8kTECbH4/Listeners', 02:47:04 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 02:47:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:47:04 INFO - 'USER': 'cltbld', 02:47:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:47:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:04 INFO - 'XPC_FLAGS': '0x0', 02:47:04 INFO - 'XPC_SERVICE_NAME': '0', 02:47:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:47:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XohZgmNbTZOZLcuEzLN0Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0019', '--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 02:47:04 INFO - mozversion application_buildid: 20170316004004 02:47:04 INFO - mozversion application_changeset: e00635bc10f072b7ab93640a6094b3d92e8ab740 02:47:04 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:47:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:47:04 INFO - mozversion application_name: Firefox 02:47:04 INFO - mozversion application_remotingname: firefox-dev 02:47:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:47:04 INFO - mozversion application_vendor: Mozilla 02:47:04 INFO - mozversion application_version: 54.0a2 02:47:04 INFO - mozversion platform_buildid: 20170316004004 02:47:04 INFO - mozversion platform_changeset: e00635bc10f072b7ab93640a6094b3d92e8ab740 02:47:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:47:04 INFO - mozversion platform_version: 54.0a2 02:47:04 INFO - using testdate: 1489657624 02:47:04 INFO - actual date: 1489657624 02:47:04 INFO - starting webserver on 'localhost:49242' 02:47:04 INFO - SUITE-START | Running 2 tests 02:47:04 INFO - TEST-START | dromaeo_css 02:47:04 INFO - operating with platform_type : mac_ 02:47:04 INFO - Initialising browser for dromaeo_css test... 02:47:04 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/tmpEH9bGG/profile http://localhost:49242/getInfo.html) 02:47:08 INFO - PROCESS | 1637 | 2017-03-16 02:47:08.127 plugin-container[1642:8202] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x954b, name = 'com.apple.tsm.portname' 02:47:08 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:47:08 INFO - PROCESS | 1637 | 2017-03-16 02:47:08.128 plugin-container[1642:8202] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f3b, name = 'com.apple.CFPasteboardClient' 02:47:08 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:47:08 INFO - PROCESS | 1637 | 2017-03-16 02:47:08.128 plugin-container[1642:8202] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:47:08 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 02:47:08 INFO - PROCESS | 1637 | colorDepth:24 02:47:08 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 02:47:08 INFO - PROCESS | 1637 | __metrics 02:47:08 ERROR - PROCESS | 1637 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 02:47:08 INFO - TEST-INFO | 1637: exit 0 02:47:08 INFO - Browser initialized. 02:47:08 INFO - Running cycle 1/1 for dromaeo_css test... 02:47:08 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/tmpEH9bGG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:47:11 INFO - PROCESS | 1643 | 2017-03-16 02:47:11.638 plugin-container[1644:8334] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4543, name = 'com.apple.tsm.portname' 02:47:11 INFO - PROCESS | 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:47:11 INFO - PROCESS | 1643 | 2017-03-16 02:47:11.638 plugin-container[1644:8334] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 02:47:11 INFO - PROCESS | 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:47:11 INFO - PROCESS | 1643 | 2017-03-16 02:47:11.638 plugin-container[1644:8334] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:47:21 INFO - PROCESS | 1643 | RSS: Main: 220205056 02:47:21 INFO - PROCESS | 1643 | 02:50:24 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 02:50:25 INFO - PROCESS | 1643 | RSS: Main: 238206976 02:50:25 INFO - PROCESS | 1643 | 02:52:09 INFO - PROCESS | 1643 | ************************* 02:52:09 INFO - PROCESS | 1643 | A coding exception was thrown and uncaught in a Task. 02:52:09 INFO - PROCESS | 1643 | 02:52:09 ERROR - PROCESS | 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:52:09 INFO - PROCESS | 1643 | Full stack: 02:52:09 INFO - PROCESS | 1643 | ************************* 02:53:28 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 02:53:28 INFO - PROCESS | 1643 | RSS: Main: 250306560 02:53:28 INFO - PROCESS | 1643 | 02:56:30 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 02:56:31 INFO - PROCESS | 1643 | RSS: Main: 256790528 02:56:31 INFO - PROCESS | 1643 | 02:59:33 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 02:59:34 INFO - PROCESS | 1643 | RSS: Main: 253128704 02:59:34 INFO - PROCESS | 1643 | 03:02:37 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 03:02:37 INFO - PROCESS | 1643 | RSS: Main: 257896448 03:02:37 INFO - PROCESS | 1643 | 03:05:40 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 03:05:40 INFO - PROCESS | 1643 | RSS: Main: 254103552 03:05:40 INFO - PROCESS | 1643 | 03:05:40 INFO - PROCESS | 1643 | __start_tp_report 03:05:40 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 03:05:40 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 03:05:40 INFO - PROCESS | 1643 | |i|pagename|runs| 03:05:40 INFO - PROCESS | 1643 | |0;dojo.html;2905.636795400574;2964.1996660901555;3484.3205574912904;3530.24099818539;3547.2728090741384;5972.343042265353;5989.251343582052;5995.430434108764;6009.81970540884;6055.212822333102;5978.760849566012;6002.399760023995;6040.516758659308;6060.787872424466;6074.240719910012;5348.037353276409;5443.646162999412;5490.286262785832;5517.834464966058;5548.309070101018;5511.9724401378135;5529.30883639545;5535.25274087999;5543.833684989457;5599.244102046212;4084.4335048855164;5046.7224302663335;5297.8940421191555;5318.574514038867;5359.062164121283;5433.972830135864;5437.918431223535;5461.5357694596005;5468.398476167618;5481.287432633732;4686.742229177394;5170.896582068338;5413.756380962866;5431.8098866539485;5436.456354364572;5196.76614552346;5734.16854556087;6042.184305118797;6126.969365153191;6136.6011209271255;5320.680759154463;6235.968820155916;6270.435660790551;6279.591826531307;6305.211848518935;5423.972880135613;6488.870222595521;6499.837504062389;6507.93492065078;6540.542162048659;6088.4215999479975;6166.260048794174;6167.568270221086;6171.444569988677;6179.84550386244;5066.645334826527;6285.308616052231;6345.397187267202;6489.805305840832;6546.0508226307875;5544.3346798384455;6355.713992870332;6368.713407896656;6377.489800815923;6399.264084630234;6441.71012304438;6470.838229044311;6492.902606460907;6495.837604059841;6498.350164983463;6148.1392605035335;6202.72087756052;6318.462930650854;6423.518236132309;6469.417752402306;6253.999360102362;6290.55966082379;6318.7472501100365;6427.2929977702415;6437.259715132726;5163.535281824578;5174.042802081552;5174.896502069938;5174.97412512935;5197.610179236497;4597.885052873705;4597.908041839144;4598.402207712976;4620.260758278727;4642.117997580516;5890.734916928748;5984.910226346608;6001.849953751103;6021.6989150542295;6055.818325450244;6397.712102955378;6516.869662606721;6522;6539.607623542603;6544.378284063102;5956.55325850563;5994.100884867217;6048.60684055535;6108.205933228652;6151.66165860873;4540.387047748578;5637.915431268534;5686.658800471902;5718.571107166979;5730.656160630376;6370.617762934239;6431.260405053292;6580.967095164494;6690.832729181712;6704;6415.518836087219;6481.708323125376;6493.253275873335;6501.512386570931;6509.283978762238;6674.199096108304;6695.665216739241;6696.1629796275465;6708.731650733916;6722.831929201809;6188.566800324114;6242.5942313751275;6413.16628838248;6422.293547709842;6437.967810160919;6327.050942358683;6355.841103972438;6372.362763723776;6374.426301632875;6398.5201109916015;6191.597546159485;6280.811575652738;6282.842928926813;6299.937000629935;6306.4639505642535;6114.296855861633;6135.263768347827;6283.434490895841;6306.495480361652;6309.4952403806665;5528.889422211614;6067.514598832171;6100.389961004042;6108.827782940854;6126.639818174547;6259.092431597484;6274;6280.905786413299;6296.5277604178955;6316.273628532777;5353.946460535345;5998.760049598141;6156.661383623765;6159.72281247336;6216.160818289654 03:05:40 INFO - PROCESS | 1643 | |1;ext.html;729.8249817793352;763.076677220563;811.2941740685602;918.582045169448;952.9714108576745;38299.85100446984;38738.612613873855;40258.59741402593;40304;40348;38436;38689.41965870507;38709.225815483675;38750.80624596873;39196.80401597995;7851.254130857559;8025.357971362277;10474.685759427191;10777.299475534066;10916.727081822939;10723.624673136443;10756.677299680983;10817;10819.83770243447;10832.512536935817;10771.461426928661;10777.730556736065;10831.404272765034;10835.241533092687;10877;9268.443893366351;10588.258821882471;10783.245172837904;10828.566857325737;10863.83704244437;10468.94765526175;10477.58089676412;10485.21360897928;10550.15598752098;10557.524911378929;33488;33583.83208083968;33647;33665.83167084173;33810.661893380995;3660.560732712065;3693.150575367654;3731.328360895065;3746;3786.9431958520645;23451.530969380517;24643.876780616163;25073.874630626913;25315.11397101111;26300.473990520084;3042.9391412171854;3098.90703278902;3155.2269693924904;3156.2740569668877;3247.902562923116;334547;340065;343697;343940;392841.03579482203;52430.47569524256;52608.47391526112;54486.91026179533;54763.17855232175;55204;56260;56476.717616412476;56843.715781420826;56892.86214275774;56941.71529142328;14866.776998344818;14920.17939013343;14933.70132597342;14951.40194392234;14960.625984350261;12833.614991550268;12845.48618055286;12847.48610055606;12870.935645321713;12898.80651790224;13376.929845612327;13379.063465557318;13391.397387117602;13445.394957226948;13544.984126190575;6091.817245482643;6210.4100110489435;6231.688415579203;6239.719212635442;6242.875142497124;923.6997975657938;1021.2851004296873;1024.5491983527224;1059.1685526861531;1067.6263307842194;27676.03133890304;28040.579391309147;28078.876844925973;28154.296142596188;28308.71691283102;911.6672414568767;1036.2694300518117;1049.9867627739268;1116.0903863351343;1125.5554056147776;12518.561850335194;13170.539031133865;13223;13357.46570137203;13402.932985335206;497587;500546;502837;512093;522942.3852880711;44810.55189448129;44912;45146.09707805826;45168.774156129664;45262.773686132015;1381.4957540497646;1417.3338530890671;1429.5711286613973;1429.9213543255012;1430.4921752777823;21405.89297053505;24793.62809557822;25026.499470010862;25325.366865828502;25499.47003179815;40143.799281004576;40323.395149073374;40440;40549.594504054585;40709;489618;491328;491516;491783;495620;29314.7068529312;33014.51434685493;34658.82670586631;38117;39400.802995984835;42701.572984271;45217;45603.54396456126;47895;48886;38135.2372952545;39166.02084947899;39869.202615948096;40675.79662101671;40909.38635920523;36700;39068.6093139065;39626;40072.79963600163;40489.39265911072;39145.41281880831;39654.60345396624;39845;39927;39994.800025999684;32786.85246016474;34426.48360274548;34894;35061;35141.64858351384;20805.1677932881;26401.60397594076;26447.471050579265;26480;26603.866980664974 03:05:40 INFO - PROCESS | 1643 | |2;jquery.html;381.31744177921524;406.78237143128433;411.1304590790479;419.23908106786183;450.1739308369142;15999.280032398541;19959.900200498996;20766.48083797906;21430.571388572218;21481.355559333224;21343.466413339673;21534.89232553839;21618.351449456502;21630.35108946734;21911.561768764615;6520.608763474195;6774.762883299061;6783;6835.93164068358;6862.416694580967;6596.340365963413;6615.643793022419;6641.6015039097565;6804.319568043205;6806.761763338284;6685.0671551280975;6765.289644587297;6807;6817.216020157695;6820.727170913157;6512.804615861532;6688.197416310049;6708.262091169968;6746.257911629717;6753.088333075046;6593.241777195636;6635.43598794103;6662.400383965418;6988.371046605779;7074.186468556079;24840.25479235626;24863.751362486324;25114;25287.74712252891;25350;2417.492326611414;2781.2490627530656;2909.8836046558113;2929.970700293012;2939.3392733105725;14764.483243086548;15334.386624535005;15461.690766184725;15462.690746185013;15945.601359965978;1986.860919735619;1987.8855447771982;2035.4097311779567;2038.2865996901114;2045.2739277556402;142677;142931;155325;160751.1962440192;163193;19781.703274450894;20385.388438346577;20611.278605248743;20757.584848302948;20779.857107859214;29444.852775735984;29524.704752952624;29568.55647165294;29746.810127595087;29859.954901578774;9896;10055.547500362502;10182.389056656624;10213.182945364502;10309.742256443498;8564.443311184754;8565.828683426296;8568.400211985101;8663.826723465496;8679.869801952977;9010.414323068979;9084.31867609932;9117.31620128493;9173.35786494939;9203.309751768644;3104.332568497784;3994.5206575210577;4048.4736984192455;4051.4125451809323;4052.230076285496;780.5823884221915;865.8528050231475;891.3225948279354;901.9368644194843;913.2420091324185;20641.58716825685;21135.365939021853;21290;21355.57288854214;23290.65064024041;833.8374017066735;1005.215931573374;1023.8720159980003;1036.264252380803;1037.4657051618422;6808.2510923798345;6822.829429264308;6846.110005699227;6923.515353925278;7160.427165826722;394522;397352;415173;797663;801631;132991;138176.61823381638;160531.39468605397;162561;163756;1143.988560114405;1232.7534493101416;1267.3916520070418;1279.8016307472171;1282.33959510852;12160.817587736014;12214.633560993185;12224.083193760325;12494.875051249372;12512.749745004867;52399.73800130975;63285.367146327946;64721.67639161774;65807;66035.66982165059;61114;64064.67967660132;76721.84917226134;76925;78416.82374764269;11327.830082548604;11648.475818588015;11763.705907352385;11835.704107397383;11913.761724765283;12670.303133327387;12816.166949148275;12839.679008024874;12966.351682415652;13032.218066916015;11194.6558025284;11305.773884522428;11426.25729327591;11510.251833630788;11698.94150529242;11111.611093611686;11293.604723834625;11460.484278207667;11534.365609891536;11583.710407239887;11506;11624.302541847515;11673.766524669629;11721;11807.291562506278;11430.771384572428;11470.770584588094;11599.942000289944;11720;11765.88234117682;8374.706885258987;9011.414258073204;11184.608538701106;11195;11260.268082574607 03:05:40 INFO - PROCESS | 1643 | |3;mootools.html;1285.4858056777289;1469.941202351906;1565.9351640884202;1573.9527814165579;1580.4705423683065;9329.253659707207;9516.04839516048;10551;11218.551257949692;11243.718907027329;10448.425336606484;10804;10832.512536935837;10870.891291087086;10887.020168184861;2243.753187149412;2275.180934863448;2275.943101422469;2280.749117597063;2292.816574674022;2218.301235110935;2253.661950707399;2258.6160352740076;2265.7764807004282;2267.161150374364;2221.3002904085242;2224.510607666311;2231.843770936035;2236.3626366485555;2243.349428665685;2195.6706494025943;2195.747489038749;2208;2208.4920468292303;2215;2170.576737536181;2222.3666255117378;2227.5767604155158;2230.933072007826;2231.386368748591;11114.555417783278;11161.83257251142;11167;11176.776464470746;11178.938000889902;4426.712263702849;5190.92213616796;5350.411454739976;5357.7589008494715;5360.383555891044;2687.784977201819;2832.8583570821374;3123.281645221589;3147.693707111569;3404.3531728971416;1064.4837253931837;1075.172117469544;1131.2251107991053;1143.5654451308533;1154.7344110854467;13209.745074217934;14857.925710371486;14873.553793386216;15243.085414875142;15255.008424452375;3914.784686842194;4028.3756017817286;4116.217918595457;4267.466566679165;4276.2516559601945;9324.953375233215;11072.280301780358;11249.381284029294;11685.591004314809;11692.590759323382;5263.6315457918345;5268.762905669254;5281.287026251407;5317.335333083364;5329.600279978939;4030.3551431770775;4810.470848206694;4917.385326834145;4938.037082768898;4971.726555039435;3562.07386079616;3578.284343131384;3658.9634103658623;3668.3947148720695;3708.332500149999;872.4459967920416;892.3530440430636;896.6771962093641;902.9277657787361;903.0743487924798;804.1154729797294;844.5439462690201;903.3586153830722;919.1681528216974;939.68050862707;6420.711068001951;6446.838829029218;6483.3192514786215;6521.902171467432;6678.966605166943;1024.0987930621006;1026.7895081508423;1051.6897515233024;1059.6238335390826;1064.1008347945974;4162.500499939966;4191.916161676811;4260.169266992969;4339.500957389878;4359.607635312837;13472.663183420296;13694.93152534231;13814.516491922734;13948.58154255374;13960.790588141186;11063;13906.235157066256;13938.790918136236;13962.162270263816;13968.231747253998;9797.412155270707;10150.746231344128;10210.591576337012;10316.484175791331;10316.742081447874;6345.96827015862;6415.71129299192;6460.676966151767;6499.6750162492635;6533.575317604341;12047.51809927593;12200.267983920992;12333.198342107735;12341.50633974667;12385.752284954431;12315.69210769738;12378.81431778506;12583.748325033632;12740.426680799572;12792.74414511686;8436.114208008315;8503.319734421108;8528.360372972176;8541.444806087584;8594.613242403982;10204.846927296245;10271.024252695983;10280.588776448858;10334.328268662513;10356.067953884187;9165.679201227926;9212.769680757767;9226.169644732006;9253.444793312423;9277.907220927704;7346.889796653161;7563.508371955805;8646.524441155796;8957.552122393985;9062.818743625223;5654.547636189177;6702.3967842892425;7385.778426647209;7776.222377762178;7938.404619653434;5791.160281759037;5961.7615295387695;5963.403659634002;5990.31111422192;6021;4377.343398490252;5755.36690964002;5840.299164100165;5868.178455016387;5937.554683398676 03:05:40 INFO - PROCESS | 1643 | |4;prototype.html;334.6619913886974;350.7216196962072;359.6475454055026;372.1162239680758;384.2027792330914;4470.619997300225;4900.76549477345;5036;5321.201819727043;5342.545883599893;3961.9405708914387;5036.974815125928;5123.5388815006645;5147.2021836615295;5198.568944496633;3822.5795162532168;3839.8080095995088;4291.291936830435;4305.870823875289;4371.540988196241;3692.981535092334;3849.441830934513;4213.283741763892;4216.388623649569;4317.122051907415;4016.417619445179;4111.979440102796;4137.296659567865;4335.6748243881675;4339.566043395666;3521.7358698097487;4166.395872598471;4312.935305970413;4320.170288461063;4329.415528903605;3537.425845498754;4019.8995025124605;4021.8391264349393;4034.072163402434;4055.959440405617;4094.7952602369764;4987.576056035241;5080.517350851663;5083.79664813407;5143.5113664201845;4224.387463817729;4497.550244975509;4503.932441013388;4936.432310284327;4969.850904472872;4817.759112044384;5483.683915860205;5605.542558934666;5626.396477004075;5684.573656975744;4102.230994079015;4328.523862375137;4477.507474177838;4509.436320459942;4528.554580526512;5513.807016754395;5691.260136182311;5843.678597677126;5975.850603734898;5988;3719.9956011876643;4138.13099249155;4307.255561497598;4516.5998540452565;4540.72755634663;4095.28332541804;4182.832686692498;4662.829276092222;4669.392978912788;4683.601893838993;4595.609373203315;4686.625069994392;4846.321514987834;4961.801527938842;4968.033432740544;4492.910141797146;5015.996800639887;5047.369078865142;5425.864353391197;5595.496405323541;1455.1414665347495;1524.8246451657978;1578.7868637733989;1604.9839501605068;1605.2615796733633;1006.6124542051363;1108.5731993182521;1194.898433633151;1195.1753290229713;1219.2014230678742;4741.170295198326;4994.950050499521;5071.644984851099;5244.5279924806955;5283.049051170826;5076.349981524215;5411.323584551931;5435.972820135874;5584.855104703526;5831;4567.36056952027;4869.63477739171;5213.2701421800975;5269.578433725293;5356.250124982505;2589.928057553949;2990.1627544287635;3004.248937765559;3042.589250451205;3057.5107982723102;4897.1185186666025;5135.7432128394175;5322.600804939645;5381.730913454312;6000.76984218243;4625.7455839929125;5092.796288148433;5178.964207158583;5318.893622127536;5762.279715035621;5270.657407268515;5359.946400535945;5782.583267099503;5828.795992140254;5839.474447299764;4802.399700037496;5324.574034077342;5432.782688692408;5786.594938354275;5854.302252346942;4584.693362391836;5357.651752636066;5529.917051244154;5659.971700141473;5758.596898217084;5883.323417807007;5914.792982245601;5915.822525324247;5921.733521991607;5933.614315069507;4525.411696479437;4562.794674239601;4572.4741654708805;4625.699329543569;4645.883852903569;5305.143199880011;5353.75908084145;5748.770049197985;5752.482276595127;5794.362620111869;4674.649401294849;5153.123968925217;5398.811041613525;5477.863053423696;5567.91203298763;5416.83749487516;5536.418676039119;5569.248151499496;5601.991641504568;5607.383187849252;5017.698938063728;5414.159185876821;5439.401665816836;5471.194505813151;5518.5100022992765;4513.796879140512;5580.600341853042;5583.436637741439;5675.375708672125;5729.713514324184;4607.193741095228;4655.464621568563;4930;5428.348598168245;5484.588655850907 03:05:40 INFO - PROCESS | 1643 | |5;yui.html;701.7228194863026;720.8270015196355;756.5460723565861;760.40308357939;847.525385783961;15350.846491535081;15720.056796592198;15761.054336739804;15887.80841436891;16043.83956160438;11677.474513646885;14836.629084272872;14841.703165936675;15018.549443516684;15132;913.2191975860643;944.4239014201331;947.1901524196816;948.1656142594508;949.2975198353238;939.1547607153582;942.924566034719;944.8866136063682;946.2950102173891;946.9621215151386;977.3988996767008;993.3692105512979;995.3629677006721;995.5768798260747;995.8655581496478;981.6662334806165;989.5052473763119;989.8267803134422;992.1764935103846;992.2260636703382;726.7638017644234;731.7877815433518;735.6615956659942;739.3013602145974;741.3513175971025;15129.243537823175;15195;15206.46777362787;15243.932924695277;15287.388504459808;12577.559785407559;14397;14621;14727.55817325482;14729.779053314209;11149.331040137618;11410;11518.769624607461;11734.413279336084;11910.702232444171;3542;3632.0919770057485;3686.7234957378037;3778.8299526521373;3784.7729136251637;107057.46471267594;112144.4392778039;113092.86907130906;114217.42891285573;116422;10402.219833512518;10422.895771042344;10466.476676166314;10587.258891877495;11004.119670426348;20232.79767202309;20307.79692203059;20347.9826008699;20496.335476387972;20643.380698579065;7614.657340419694;7677.961610191914;7759.57322347265;7765.301122898966;7948.801279967932;4176.937345939813;4282.828686852553;4298.935515967263;4341.522432532419;4395.956040439554;3416.85535345662;3474.6872781449792;3501.7373696972827;3510.8069056201643;3511.8244087795506;590.2710152961175;610.9908351374733;645.3578689204272;671.3214275042642;690.6270613868455;659.577870163096;671.9428848547929;702.1118285369013;706.2690115730195;721.1598487761698;9585.664501742405;10285.794284114276;10289.228307876789;10311.175105991653;10332.328398654214;680.1803826389189;697.9685914133876;705.3616477088141;708.9574625522486;743.171363929215;4600.907981840412;5032;5037.874053148627;5039;5047.520485553867;103499;107223;107530;107778;108377.45811270893;85823.14176858276;87312.56343718368;87598;88009;89705;69302.61394772177;80684;82376;84266.15733842706;84879;8410.663573457237;9371.906280937375;9659.758506037406;9688.85466718014;9713.27150463704;49783;53969.380918572504;54477;54538;54796.45203547914;67384.6630766843;68094;68840.62318753697;69220.3077969234;69358.65320673364;11378.146639001943;11527.8270825936;11601.477933492844;11822.645320640395;12107.75784484323;12338.003069155135;12513.436895339913;12526.498940042296;12852.742945140857;12864.099513033998;11887.821682674594;11969.64091077269;11998.880011199777;12008.39958002114;12056;12041.939790300992;12079.456424460745;12330.383480825743;12352;12502.749945000867;11957.103217258566;11968;11980.880191197977;11981.981531569914;12108.697282568006;10138.184710209822;10324.741881453023;10557.894421055691;10719.517621707198;11010.669679909615;9241.399309044891;9516.524173791422;9958.601655933971;9958.850617240601;10052.84920726175 03:05:40 INFO - PROCESS | 1643 | __end_tp_report 03:05:40 INFO - PROCESS | 1643 | __start_cc_report 03:05:40 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,427 03:05:40 INFO - PROCESS | 1643 | __end_cc_report 03:05:40 INFO - PROCESS | 1643 | __startTimestamp1489658740934__endTimestamp 03:05:40 INFO - PROCESS | 1643 | 03:05:40 INFO - PROCESS | 1643 | ------- Summary: start ------- 03:05:40 INFO - PROCESS | 1643 | Number of tests: 6 03:05:40 INFO - PROCESS | 1643 | 03:05:40 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:5906.15 Median:6136.60 stddev:707.65 (11.5%) stddev-sans-first:669.53 03:05:40 INFO - PROCESS | 1643 | Values: 2905.6 2964.2 3484.3 3530.2 3547.3 5972.3 5989.3 5995.4 6009.8 6055.2 5978.8 6002.4 6040.5 6060.8 6074.2 5348.0 5443.6 5490.3 5517.8 5548.3 5512.0 5529.3 5535.3 5543.8 5599.2 4084.4 5046.7 5297.9 5318.6 5359.1 5434.0 5437.9 5461.5 5468.4 5481.3 4686.7 5170.9 5413.8 5431.8 5436.5 5196.8 5734.2 6042.2 6127.0 6136.6 5320.7 6236.0 6270.4 6279.6 6305.2 5424.0 6488.9 6499.8 6507.9 6540.5 6088.4 6166.3 6167.6 6171.4 6179.8 5066.6 6285.3 6345.4 6489.8 6546.1 5544.3 6355.7 6368.7 6377.5 6399.3 6441.7 6470.8 6492.9 6495.8 6498.4 6148.1 6202.7 6318.5 6423.5 6469.4 6254.0 6290.6 6318.7 6427.3 6437.3 5163.5 5174.0 5174.9 5175.0 5197.6 4597.9 4597.9 4598.4 4620.3 4642.1 5890.7 5984.9 6001.8 6021.7 6055.8 6397.7 6516.9 6522.0 6539.6 6544.4 5956.6 5994.1 6048.6 6108.2 6151.7 4540.4 5637.9 5686.7 5718.6 5730.7 6370.6 6431.3 6581.0 6690.8 6704.0 6415.5 6481.7 6493.3 6501.5 6509.3 6674.2 6695.7 6696.2 6708.7 6722.8 6188.6 6242.6 6413.2 6422.3 6438.0 6327.1 6355.8 6372.4 6374.4 6398.5 6191.6 6280.8 6282.8 6299.9 6306.5 6114.3 6135.3 6283.4 6306.5 6309.5 5528.9 6067.5 6100.4 6108.8 6126.6 6259.1 6274.0 6280.9 6296.5 6316.3 5353.9 5998.8 6156.7 6159.7 6216.2 03:05:40 INFO - PROCESS | 1643 | 03:05:40 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:58861.82 Median:343818.50 stddev:121162.18 (35.2%) stddev-sans-first:121423.46 03:05:40 INFO - PROCESS | 1643 | Values: 729.8 763.1 811.3 918.6 953.0 38299.9 38738.6 40258.6 40304.0 40348.0 38436.0 38689.4 38709.2 38750.8 39196.8 7851.3 8025.4 10474.7 10777.3 10916.7 10723.6 10756.7 10817.0 10819.8 10832.5 10771.5 10777.7 10831.4 10835.2 10877.0 9268.4 10588.3 10783.2 10828.6 10863.8 10468.9 10477.6 10485.2 10550.2 10557.5 33488.0 33583.8 33647.0 33665.8 33810.7 3660.6 3693.2 3731.3 3746.0 3786.9 23451.5 24643.9 25073.9 25315.1 26300.5 3042.9 3098.9 3155.2 3156.3 3247.9 334547.0 340065.0 343697.0 343940.0 392841.0 52430.5 52608.5 54486.9 54763.2 55204.0 56260.0 56476.7 56843.7 56892.9 56941.7 14866.8 14920.2 14933.7 14951.4 14960.6 12833.6 12845.5 12847.5 12870.9 12898.8 13376.9 13379.1 13391.4 13445.4 13545.0 6091.8 6210.4 6231.7 6239.7 6242.9 923.7 1021.3 1024.5 1059.2 1067.6 27676.0 28040.6 28078.9 28154.3 28308.7 911.7 1036.3 1050.0 1116.1 1125.6 12518.6 13170.5 13223.0 13357.5 13402.9 497587.0 500546.0 502837.0 512093.0 522942.4 44810.6 44912.0 45146.1 45168.8 45262.8 1381.5 1417.3 1429.6 1429.9 1430.5 21405.9 24793.6 25026.5 25325.4 25499.5 40143.8 40323.4 40440.0 40549.6 40709.0 489618.0 491328.0 491516.0 491783.0 495620.0 29314.7 33014.5 34658.8 38117.0 39400.8 42701.6 45217.0 45603.5 47895.0 48886.0 38135.2 39166.0 39869.2 40675.8 40909.4 36700.0 39068.6 39626.0 40072.8 40489.4 39145.4 39654.6 39845.0 39927.0 39994.8 32786.9 34426.5 34894.0 35061.0 35141.6 20805.2 26401.6 26447.5 26480.0 26603.9 03:05:40 INFO - PROCESS | 1643 | 03:05:40 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:36867.35 Median:12854.07 stddev:100958.86 (785.4%) stddev-sans-first:101204.91 03:05:40 INFO - PROCESS | 1643 | Values: 381.3 406.8 411.1 419.2 450.2 15999.3 19959.9 20766.5 21430.6 21481.4 21343.5 21534.9 21618.4 21630.4 21911.6 6520.6 6774.8 6783.0 6835.9 6862.4 6596.3 6615.6 6641.6 6804.3 6806.8 6685.1 6765.3 6807.0 6817.2 6820.7 6512.8 6688.2 6708.3 6746.3 6753.1 6593.2 6635.4 6662.4 6988.4 7074.2 24840.3 24863.8 25114.0 25287.7 25350.0 2417.5 2781.2 2909.9 2930.0 2939.3 14764.5 15334.4 15461.7 15462.7 15945.6 1986.9 1987.9 2035.4 2038.3 2045.3 142677.0 142931.0 155325.0 160751.2 163193.0 19781.7 20385.4 20611.3 20757.6 20779.9 29444.9 29524.7 29568.6 29746.8 29860.0 9896.0 10055.5 10182.4 10213.2 10309.7 8564.4 8565.8 8568.4 8663.8 8679.9 9010.4 9084.3 9117.3 9173.4 9203.3 3104.3 3994.5 4048.5 4051.4 4052.2 780.6 865.9 891.3 901.9 913.2 20641.6 21135.4 21290.0 21355.6 23290.7 833.8 1005.2 1023.9 1036.3 1037.5 6808.3 6822.8 6846.1 6923.5 7160.4 394522.0 397352.0 415173.0 797663.0 801631.0 132991.0 138176.6 160531.4 162561.0 163756.0 1144.0 1232.8 1267.4 1279.8 1282.3 12160.8 12214.6 12224.1 12494.9 12512.7 52399.7 63285.4 64721.7 65807.0 66035.7 61114.0 64064.7 76721.8 76925.0 78416.8 11327.8 11648.5 11763.7 11835.7 11913.8 12670.3 12816.2 12839.7 12966.4 13032.2 11194.7 11305.8 11426.3 11510.3 11698.9 11111.6 11293.6 11460.5 11534.4 11583.7 11506.0 11624.3 11673.8 11721.0 11807.3 11430.8 11470.8 11599.9 11720.0 11765.9 8374.7 9011.4 11184.6 11195.0 11260.3 03:05:40 INFO - PROCESS | 1643 | 03:05:40 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:6523.83 Median:2490.30 stddev:4217.85 (169.4%) stddev-sans-first:4211.32 03:05:40 INFO - PROCESS | 1643 | Values: 1285.5 1469.9 1565.9 1574.0 1580.5 9329.3 9516.0 10551.0 11218.6 11243.7 10448.4 10804.0 10832.5 10870.9 10887.0 2243.8 2275.2 2275.9 2280.7 2292.8 2218.3 2253.7 2258.6 2265.8 2267.2 2221.3 2224.5 2231.8 2236.4 2243.3 2195.7 2195.7 2208.0 2208.5 2215.0 2170.6 2222.4 2227.6 2230.9 2231.4 11114.6 11161.8 11167.0 11176.8 11178.9 4426.7 5190.9 5350.4 5357.8 5360.4 2687.8 2832.9 3123.3 3147.7 3404.4 1064.5 1075.2 1131.2 1143.6 1154.7 13209.7 14857.9 14873.6 15243.1 15255.0 3914.8 4028.4 4116.2 4267.5 4276.3 9325.0 11072.3 11249.4 11685.6 11692.6 5263.6 5268.8 5281.3 5317.3 5329.6 4030.4 4810.5 4917.4 4938.0 4971.7 3562.1 3578.3 3659.0 3668.4 3708.3 872.4 892.4 896.7 902.9 903.1 804.1 844.5 903.4 919.2 939.7 6420.7 6446.8 6483.3 6521.9 6679.0 1024.1 1026.8 1051.7 1059.6 1064.1 4162.5 4191.9 4260.2 4339.5 4359.6 13472.7 13694.9 13814.5 13948.6 13960.8 11063.0 13906.2 13938.8 13962.2 13968.2 9797.4 10150.7 10210.6 10316.5 10316.7 6346.0 6415.7 6460.7 6499.7 6533.6 12047.5 12200.3 12333.2 12341.5 12385.8 12315.7 12378.8 12583.7 12740.4 12792.7 8436.1 8503.3 8528.4 8541.4 8594.6 10204.8 10271.0 10280.6 10334.3 10356.1 9165.7 9212.8 9226.2 9253.4 9277.9 7346.9 7563.5 8646.5 8957.6 9062.8 5654.5 6702.4 7385.8 7776.2 7938.4 5791.2 5961.8 5963.4 5990.3 6021.0 4377.3 5755.4 5840.3 5868.2 5937.6 03:05:40 INFO - PROCESS | 1643 | 03:05:40 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4593.90 Median:4964.92 stddev:1283.10 (25.8%) stddev-sans-first:1246.24 03:05:40 INFO - PROCESS | 1643 | Values: 334.7 350.7 359.6 372.1 384.2 4470.6 4900.8 5036.0 5321.2 5342.5 3961.9 5037.0 5123.5 5147.2 5198.6 3822.6 3839.8 4291.3 4305.9 4371.5 3693.0 3849.4 4213.3 4216.4 4317.1 4016.4 4112.0 4137.3 4335.7 4339.6 3521.7 4166.4 4312.9 4320.2 4329.4 3537.4 4019.9 4021.8 4034.1 4056.0 4094.8 4987.6 5080.5 5083.8 5143.5 4224.4 4497.6 4503.9 4936.4 4969.9 4817.8 5483.7 5605.5 5626.4 5684.6 4102.2 4328.5 4477.5 4509.4 4528.6 5513.8 5691.3 5843.7 5975.9 5988.0 3720.0 4138.1 4307.3 4516.6 4540.7 4095.3 4182.8 4662.8 4669.4 4683.6 4595.6 4686.6 4846.3 4961.8 4968.0 4492.9 5016.0 5047.4 5425.9 5595.5 1455.1 1524.8 1578.8 1605.0 1605.3 1006.6 1108.6 1194.9 1195.2 1219.2 4741.2 4995.0 5071.6 5244.5 5283.0 5076.3 5411.3 5436.0 5584.9 5831.0 4567.4 4869.6 5213.3 5269.6 5356.3 2589.9 2990.2 3004.2 3042.6 3057.5 4897.1 5135.7 5322.6 5381.7 6000.8 4625.7 5092.8 5179.0 5318.9 5762.3 5270.7 5359.9 5782.6 5828.8 5839.5 4802.4 5324.6 5432.8 5786.6 5854.3 4584.7 5357.7 5529.9 5660.0 5758.6 5883.3 5914.8 5915.8 5921.7 5933.6 4525.4 4562.8 4572.5 4625.7 4645.9 5305.1 5353.8 5748.8 5752.5 5794.4 4674.6 5153.1 5398.8 5477.9 5567.9 5416.8 5536.4 5569.2 5602.0 5607.4 5017.7 5414.2 5439.4 5471.2 5518.5 4513.8 5580.6 5583.4 5675.4 5729.7 4607.2 4655.5 4930.0 5428.3 5484.6 03:05:40 INFO - PROCESS | 1643 | 03:05:40 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:20652.87 Median:4229.88 stddev:30506.15 (721.2%) stddev-sans-first:30554.94 03:05:40 INFO - PROCESS | 1643 | Values: 701.7 720.8 756.5 760.4 847.5 15350.8 15720.1 15761.1 15887.8 16043.8 11677.5 14836.6 14841.7 15018.5 15132.0 913.2 944.4 947.2 948.2 949.3 939.2 942.9 944.9 946.3 947.0 977.4 993.4 995.4 995.6 995.9 981.7 989.5 989.8 992.2 992.2 726.8 731.8 735.7 739.3 741.4 15129.2 15195.0 15206.5 15243.9 15287.4 12577.6 14397.0 14621.0 14727.6 14729.8 11149.3 11410.0 11518.8 11734.4 11910.7 3542.0 3632.1 3686.7 3778.8 3784.8 107057.5 112144.4 113092.9 114217.4 116422.0 10402.2 10422.9 10466.5 10587.3 11004.1 20232.8 20307.8 20348.0 20496.3 20643.4 7614.7 7678.0 7759.6 7765.3 7948.8 4176.9 4282.8 4298.9 4341.5 4396.0 3416.9 3474.7 3501.7 3510.8 3511.8 590.3 611.0 645.4 671.3 690.6 659.6 671.9 702.1 706.3 721.2 9585.7 10285.8 10289.2 10311.2 10332.3 680.2 698.0 705.4 709.0 743.2 4600.9 5032.0 5037.9 5039.0 5047.5 103499.0 107223.0 107530.0 107778.0 108377.5 85823.1 87312.6 87598.0 88009.0 89705.0 69302.6 80684.0 82376.0 84266.2 84879.0 8410.7 9371.9 9659.8 9688.9 9713.3 49783.0 53969.4 54477.0 54538.0 54796.5 67384.7 68094.0 68840.6 69220.3 69358.7 11378.1 11527.8 11601.5 11822.6 12107.8 12338.0 12513.4 12526.5 12852.7 12864.1 11887.8 11969.6 11998.9 12008.4 12056.0 12041.9 12079.5 12330.4 12352.0 12502.7 11957.1 11968.0 11980.9 11982.0 12108.7 10138.2 10324.7 10557.9 10719.5 11010.7 9241.4 9516.5 9958.6 9958.9 10052.8 03:05:40 INFO - PROCESS | 1643 | -------- Summary: end -------- 03:05:40 INFO - PROCESS | 1643 | 03:05:41 INFO - TEST-INFO | 1643: exit 0 03:05:41 INFO - TEST-OK | dromaeo_css | took 1116859ms 03:05:41 INFO - TEST-START | kraken 03:05:41 INFO - operating with platform_type : mac_ 03:05:41 INFO - Initialising browser for kraken test... 03:05:41 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/tmpM0Sr6c/profile http://localhost:49242/getInfo.html) 03:05:44 INFO - PROCESS | 1651 | 2017-03-16 03:05:44.197 plugin-container[1653:10836] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x443f, name = 'com.apple.tsm.portname' 03:05:44 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:05:44 INFO - PROCESS | 1651 | 2017-03-16 03:05:44.198 plugin-container[1653:10836] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 03:05:44 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:05:44 INFO - PROCESS | 1651 | 2017-03-16 03:05:44.198 plugin-container[1653:10836] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:05:44 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 03:05:44 INFO - PROCESS | 1651 | colorDepth:24 03:05:44 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 03:05:44 INFO - PROCESS | 1651 | __metrics 03:05:44 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 03:05:45 INFO - TEST-INFO | 1651: exit 0 03:05:45 INFO - Browser initialized. 03:05:45 INFO - Running cycle 1/1 for kraken test... 03:05:45 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/tmpM0Sr6c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:05:47 INFO - PROCESS | 1654 | 2017-03-16 03:05:47.760 plugin-container[1655:10958] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 03:05:47 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:05:47 INFO - PROCESS | 1654 | 2017-03-16 03:05:47.760 plugin-container[1655:10958] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d17, name = 'com.apple.CFPasteboardClient' 03:05:47 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:05:47 INFO - PROCESS | 1654 | 2017-03-16 03:05:47.761 plugin-container[1655:10958] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:05:57 INFO - PROCESS | 1654 | RSS: Main: 220065792 03:05:57 INFO - PROCESS | 1654 | 03:06:00 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 03:06:01 INFO - PROCESS | 1654 | RSS: Main: 234766336 03:06:01 INFO - PROCESS | 1654 | 03:06:04 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 03:06:05 INFO - PROCESS | 1654 | RSS: Main: 242896896 03:06:05 INFO - PROCESS | 1654 | 03:06:08 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 03:06:09 INFO - PROCESS | 1654 | RSS: Main: 246759424 03:06:09 INFO - PROCESS | 1654 | 03:06:10 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 03:06:11 INFO - PROCESS | 1654 | RSS: Main: 247103488 03:06:11 INFO - PROCESS | 1654 | 03:06:13 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:06:14 INFO - PROCESS | 1654 | RSS: Main: 247070720 03:06:14 INFO - PROCESS | 1654 | 03:06:17 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 03:06:17 INFO - PROCESS | 1654 | RSS: Main: 250941440 03:06:17 INFO - PROCESS | 1654 | 03:06:21 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 03:06:21 INFO - PROCESS | 1654 | RSS: Main: 252510208 03:06:21 INFO - PROCESS | 1654 | 03:06:24 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 03:06:25 INFO - PROCESS | 1654 | RSS: Main: 252063744 03:06:25 INFO - PROCESS | 1654 | 03:06:27 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:06:27 INFO - PROCESS | 1654 | RSS: Main: 251293696 03:06:27 INFO - PROCESS | 1654 | 03:06:29 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:06:30 INFO - PROCESS | 1654 | RSS: Main: 251297792 03:06:30 INFO - PROCESS | 1654 | 03:06:32 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:06:33 INFO - PROCESS | 1654 | RSS: Main: 251310080 03:06:33 INFO - PROCESS | 1654 | 03:06:36 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:06:37 INFO - PROCESS | 1654 | RSS: Main: 251703296 03:06:37 INFO - PROCESS | 1654 | 03:06:39 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:06:40 INFO - PROCESS | 1654 | RSS: Main: 251518976 03:06:40 INFO - PROCESS | 1654 | 03:06:42 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 03:06:42 INFO - PROCESS | 1654 | RSS: Main: 253460480 03:06:42 INFO - PROCESS | 1654 | 03:06:42 INFO - PROCESS | 1654 | __start_tp_report 03:06:42 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 03:06:42 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 03:06:42 INFO - PROCESS | 1654 | |i|pagename|runs| 03:06:42 INFO - PROCESS | 1654 | |0;ai-astar;107;122;128;176;179;122;121;121;120;121 03:06:42 INFO - PROCESS | 1654 | |1;audio-beat-detection;164;135;109;147;100;139;142;142;152;140 03:06:42 INFO - PROCESS | 1654 | |2;audio-dft;194;219;251;198;198;199;199;196;197;216 03:06:42 INFO - PROCESS | 1654 | |3;audio-fft;83;60;59;90;65;63;61;59;78;72 03:06:42 INFO - PROCESS | 1654 | |4;audio-oscillator;82;70;86;74;72;70;82;70;72;83 03:06:42 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;90;90;90;90;90;91;122;91;90;91 03:06:42 INFO - PROCESS | 1654 | |6;imaging-darkroom;156;113;152;97;116;149;97;105;98;103 03:06:42 INFO - PROCESS | 1654 | |7;imaging-desaturate;122;96;94;99;76;75;148;76;143;142 03:06:42 INFO - PROCESS | 1654 | |8;json-parse-financial;67;66;68;69;70;68;105;107;106;90 03:06:42 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;54;70;101;69;65;61;61;61;64;68 03:06:42 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;87;81;95;85;83;85;88;83;95;85 03:06:42 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;131;139;132;139;129;155;150;160;188;153 03:06:42 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;168;166;166;169;168;178;224;209;170;174 03:06:42 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;68;80;73;57;82;83;88;80;69;63 03:06:42 INFO - PROCESS | 1654 | __end_tp_report 03:06:42 INFO - PROCESS | 1654 | __start_cc_report 03:06:42 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,1015 03:06:42 INFO - PROCESS | 1654 | __end_cc_report 03:06:42 INFO - PROCESS | 1654 | __startTimestamp1489658802682__endTimestamp 03:06:42 INFO - PROCESS | 1654 | 03:06:42 INFO - PROCESS | 1654 | ------- Summary: start ------- 03:06:42 INFO - PROCESS | 1654 | Number of tests: 14 03:06:42 INFO - PROCESS | 1654 | 03:06:42 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:131.70 Median:122.00 stddev:24.70 (20.2%) stddev-sans-first:24.53 03:06:42 INFO - PROCESS | 1654 | Values: 107.0 122.0 128.0 176.0 179.0 122.0 121.0 121.0 120.0 121.0 03:06:42 INFO - PROCESS | 1654 | 03:06:42 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:137.00 Median:142.00 stddev:19.07 (13.4%) stddev-sans-first:17.55 03:06:42 INFO - PROCESS | 1654 | Values: 164.0 135.0 109.0 147.0 100.0 139.0 142.0 142.0 152.0 140.0 03:06:42 INFO - PROCESS | 1654 | 03:06:42 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:206.70 Median:199.00 stddev:17.76 (8.9%) stddev-sans-first:18.24 03:06:42 INFO - PROCESS | 1654 | Values: 194.0 219.0 251.0 198.0 198.0 199.0 199.0 196.0 197.0 216.0 03:06:42 INFO - PROCESS | 1654 | 03:06:42 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:69.00 Median:68.50 stddev:11.18 (16.3%) stddev-sans-first:10.64 03:06:42 INFO - PROCESS | 1654 | Values: 83.0 60.0 59.0 90.0 65.0 63.0 61.0 59.0 78.0 72.0 03:06:42 INFO - PROCESS | 1654 | 03:06:42 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:76.10 Median:78.00 stddev:6.37 (8.2%) stddev-sans-first:6.39 03:06:42 INFO - PROCESS | 1654 | Values: 82.0 70.0 86.0 74.0 72.0 70.0 82.0 70.0 72.0 83.0 03:06:42 INFO - PROCESS | 1654 | 03:06:42 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:93.50 Median:90.00 stddev:10.02 (11.1%) stddev-sans-first:10.55 03:06:42 INFO - PROCESS | 1654 | Values: 90.0 90.0 90.0 90.0 90.0 91.0 122.0 91.0 90.0 91.0 03:06:42 INFO - PROCESS | 1654 | 03:06:42 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:118.60 Median:154.00 stddev:24.18 (15.7%) stddev-sans-first:21.53 03:06:42 INFO - PROCESS | 1654 | Values: 156.0 113.0 152.0 97.0 116.0 149.0 97.0 105.0 98.0 103.0 03:06:42 INFO - PROCESS | 1654 | 03:06:42 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:107.10 Median:76.00 stddev:29.30 (38.6%) stddev-sans-first:30.58 03:06:42 INFO - PROCESS | 1654 | Values: 122.0 96.0 94.0 99.0 76.0 75.0 148.0 76.0 143.0 142.0 03:06:42 INFO - PROCESS | 1654 | 03:06:42 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:81.60 Median:68.00 stddev:18.19 (26.8%) stddev-sans-first:18.51 03:06:42 INFO - PROCESS | 1654 | Values: 67.0 66.0 68.0 69.0 70.0 68.0 105.0 107.0 106.0 90.0 03:06:42 INFO - PROCESS | 1654 | 03:06:42 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:64.50 stddev:12.73 (19.7%) stddev-sans-first:12.54 03:06:42 INFO - PROCESS | 1654 | Values: 54.0 70.0 101.0 69.0 65.0 61.0 61.0 61.0 64.0 68.0 03:06:42 INFO - PROCESS | 1654 | 03:06:42 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:86.00 stddev:4.81 (5.6%) stddev-sans-first:5.10 03:06:42 INFO - PROCESS | 1654 | Values: 87.0 81.0 95.0 85.0 83.0 85.0 88.0 83.0 95.0 85.0 03:06:42 INFO - PROCESS | 1654 | 03:06:42 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:147.60 Median:151.50 stddev:17.91 (11.8%) stddev-sans-first:17.97 03:06:42 INFO - PROCESS | 1654 | Values: 131.0 139.0 132.0 139.0 129.0 155.0 150.0 160.0 188.0 153.0 03:06:42 INFO - PROCESS | 1654 | 03:06:42 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.20 Median:172.00 stddev:20.31 (11.8%) stddev-sans-first:21.13 03:06:42 INFO - PROCESS | 1654 | Values: 168.0 166.0 166.0 169.0 168.0 178.0 224.0 209.0 170.0 174.0 03:06:42 INFO - PROCESS | 1654 | 03:06:42 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.30 Median:80.00 stddev:9.91 (12.4%) stddev-sans-first:10.25 03:06:42 INFO - PROCESS | 1654 | Values: 68.0 80.0 73.0 57.0 82.0 83.0 88.0 80.0 69.0 63.0 03:06:42 INFO - PROCESS | 1654 | -------- Summary: end -------- 03:06:42 INFO - PROCESS | 1654 | 03:06:43 INFO - TEST-INFO | 1654: exit 0 03:06:43 INFO - TEST-OK | kraken | took 62007ms 03:06:43 INFO - SUITE-END | took 1178s 03:06:43 INFO - Completed test suite (00:19:39) 03:06:43 INFO - javascript benchmark 03:06:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7592.197975790226, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2905.636795400574, 2964.1996660901555, 3484.3205574912904, 3530.24099818539, 3547.2728090741384, 5972.343042265353, 5989.251343582052, 5995.430434108764, 6009.81970540884, 6055.212822333102, 5978.760849566012, 6002.399760023995, 6040.516758659308, 6060.787872424466, 6074.240719910012, 5348.037353276409, 5443.646162999412, 5490.286262785832, 5517.834464966058, 5548.309070101018, 5511.9724401378135, 5529.30883639545, 5535.25274087999, 5543.833684989457, 5599.244102046212, 4084.4335048855164, 5046.7224302663335, 5297.8940421191555, 5318.574514038867, 5359.062164121283, 5433.972830135864, 5437.918431223535, 5461.5357694596005, 5468.398476167618, 5481.287432633732, 4686.742229177394, 5170.896582068338, 5413.756380962866, 5431.8098866539485, 5436.456354364572, 5196.76614552346, 5734.16854556087, 6042.184305118797, 6126.969365153191, 6136.6011209271255, 5320.680759154463, 6235.968820155916, 6270.435660790551, 6279.591826531307, 6305.211848518935, 5423.972880135613, 6488.870222595521, 6499.837504062389, 6507.93492065078, 6540.542162048659, 6088.4215999479975, 6166.260048794174, 6167.568270221086, 6171.444569988677, 6179.84550386244, 5066.645334826527, 6285.308616052231, 6345.397187267202, 6489.805305840832, 6546.0508226307875, 5544.3346798384455, 6355.713992870332, 6368.713407896656, 6377.489800815923, 6399.264084630234, 6441.71012304438, 6470.838229044311, 6492.902606460907, 6495.837604059841, 6498.350164983463, 6148.1392605035335, 6202.72087756052, 6318.462930650854, 6423.518236132309, 6469.417752402306, 6253.999360102362, 6290.55966082379, 6318.7472501100365, 6427.2929977702415, 6437.259715132726, 5163.535281824578, 5174.042802081552, 5174.896502069938, 5174.97412512935, 5197.610179236497, 4597.885052873705, 4597.908041839144, 4598.402207712976, 4620.260758278727, 4642.117997580516, 5890.734916928748, 5984.910226346608, 6001.849953751103, 6021.6989150542295, 6055.818325450244, 6397.712102955378, 6516.869662606721, 6522.0, 6539.607623542603, 6544.378284063102, 5956.55325850563, 5994.100884867217, 6048.60684055535, 6108.205933228652, 6151.66165860873, 4540.387047748578, 5637.915431268534, 5686.658800471902, 5718.571107166979, 5730.656160630376, 6370.617762934239, 6431.260405053292, 6580.967095164494, 6690.832729181712, 6704.0, 6415.518836087219, 6481.708323125376, 6493.253275873335, 6501.512386570931, 6509.283978762238, 6674.199096108304, 6695.665216739241, 6696.1629796275465, 6708.731650733916, 6722.831929201809, 6188.566800324114, 6242.5942313751275, 6413.16628838248, 6422.293547709842, 6437.967810160919, 6327.050942358683, 6355.841103972438, 6372.362763723776, 6374.426301632875, 6398.5201109916015, 6191.597546159485, 6280.811575652738, 6282.842928926813, 6299.937000629935, 6306.4639505642535, 6114.296855861633, 6135.263768347827, 6283.434490895841, 6306.495480361652, 6309.4952403806665, 5528.889422211614, 6067.514598832171, 6100.389961004042, 6108.827782940854, 6126.639818174547, 6259.092431597484, 6274.0, 6280.905786413299, 6296.5277604178955, 6316.273628532777, 5353.946460535345, 5998.760049598141, 6156.661383623765, 6159.72281247336, 6216.160818289654], "value": 5859.926481263789, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.8249817793352, 763.076677220563, 811.2941740685602, 918.582045169448, 952.9714108576745, 38299.85100446984, 38738.612613873855, 40258.59741402593, 40304.0, 40348.0, 38436.0, 38689.41965870507, 38709.225815483675, 38750.80624596873, 39196.80401597995, 7851.254130857559, 8025.357971362277, 10474.685759427191, 10777.299475534066, 10916.727081822939, 10723.624673136443, 10756.677299680983, 10817.0, 10819.83770243447, 10832.512536935817, 10771.461426928661, 10777.730556736065, 10831.404272765034, 10835.241533092687, 10877.0, 9268.443893366351, 10588.258821882471, 10783.245172837904, 10828.566857325737, 10863.83704244437, 10468.94765526175, 10477.58089676412, 10485.21360897928, 10550.15598752098, 10557.524911378929, 33488.0, 33583.83208083968, 33647.0, 33665.83167084173, 33810.661893380995, 3660.560732712065, 3693.150575367654, 3731.328360895065, 3746.0, 3786.9431958520645, 23451.530969380517, 24643.876780616163, 25073.874630626913, 25315.11397101111, 26300.473990520084, 3042.9391412171854, 3098.90703278902, 3155.2269693924904, 3156.2740569668877, 3247.902562923116, 334547.0, 340065.0, 343697.0, 343940.0, 392841.03579482203, 52430.47569524256, 52608.47391526112, 54486.91026179533, 54763.17855232175, 55204.0, 56260.0, 56476.717616412476, 56843.715781420826, 56892.86214275774, 56941.71529142328, 14866.776998344818, 14920.17939013343, 14933.70132597342, 14951.40194392234, 14960.625984350261, 12833.614991550268, 12845.48618055286, 12847.48610055606, 12870.935645321713, 12898.80651790224, 13376.929845612327, 13379.063465557318, 13391.397387117602, 13445.394957226948, 13544.984126190575, 6091.817245482643, 6210.4100110489435, 6231.688415579203, 6239.719212635442, 6242.875142497124, 923.6997975657938, 1021.2851004296873, 1024.5491983527224, 1059.1685526861531, 1067.6263307842194, 27676.03133890304, 28040.579391309147, 28078.876844925973, 28154.296142596188, 28308.71691283102, 911.6672414568767, 1036.2694300518117, 1049.9867627739268, 1116.0903863351343, 1125.5554056147776, 12518.561850335194, 13170.539031133865, 13223.0, 13357.46570137203, 13402.932985335206, 497587.0, 500546.0, 502837.0, 512093.0, 522942.3852880711, 44810.55189448129, 44912.0, 45146.09707805826, 45168.774156129664, 45262.773686132015, 1381.4957540497646, 1417.3338530890671, 1429.5711286613973, 1429.9213543255012, 1430.4921752777823, 21405.89297053505, 24793.62809557822, 25026.499470010862, 25325.366865828502, 25499.47003179815, 40143.799281004576, 40323.395149073374, 40440.0, 40549.594504054585, 40709.0, 489618.0, 491328.0, 491516.0, 491783.0, 495620.0, 29314.7068529312, 33014.51434685493, 34658.82670586631, 38117.0, 39400.802995984835, 42701.572984271, 45217.0, 45603.54396456126, 47895.0, 48886.0, 38135.2372952545, 39166.02084947899, 39869.202615948096, 40675.79662101671, 40909.38635920523, 36700.0, 39068.6093139065, 39626.0, 40072.79963600163, 40489.39265911072, 39145.41281880831, 39654.60345396624, 39845.0, 39927.0, 39994.800025999684, 32786.85246016474, 34426.48360274548, 34894.0, 35061.0, 35141.64858351384, 20805.1677932881, 26401.60397594076, 26447.471050579265, 26480.0, 26603.866980664974], "value": 19149.233010156993, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.31744177921524, 406.78237143128433, 411.1304590790479, 419.23908106786183, 450.1739308369142, 15999.280032398541, 19959.900200498996, 20766.48083797906, 21430.571388572218, 21481.355559333224, 21343.466413339673, 21534.89232553839, 21618.351449456502, 21630.35108946734, 21911.561768764615, 6520.608763474195, 6774.762883299061, 6783.0, 6835.93164068358, 6862.416694580967, 6596.340365963413, 6615.643793022419, 6641.6015039097565, 6804.319568043205, 6806.761763338284, 6685.0671551280975, 6765.289644587297, 6807.0, 6817.216020157695, 6820.727170913157, 6512.804615861532, 6688.197416310049, 6708.262091169968, 6746.257911629717, 6753.088333075046, 6593.241777195636, 6635.43598794103, 6662.400383965418, 6988.371046605779, 7074.186468556079, 24840.25479235626, 24863.751362486324, 25114.0, 25287.74712252891, 25350.0, 2417.492326611414, 2781.2490627530656, 2909.8836046558113, 2929.970700293012, 2939.3392733105725, 14764.483243086548, 15334.386624535005, 15461.690766184725, 15462.690746185013, 15945.601359965978, 1986.860919735619, 1987.8855447771982, 2035.4097311779567, 2038.2865996901114, 2045.2739277556402, 142677.0, 142931.0, 155325.0, 160751.1962440192, 163193.0, 19781.703274450894, 20385.388438346577, 20611.278605248743, 20757.584848302948, 20779.857107859214, 29444.852775735984, 29524.704752952624, 29568.55647165294, 29746.810127595087, 29859.954901578774, 9896.0, 10055.547500362502, 10182.389056656624, 10213.182945364502, 10309.742256443498, 8564.443311184754, 8565.828683426296, 8568.400211985101, 8663.826723465496, 8679.869801952977, 9010.414323068979, 9084.31867609932, 9117.31620128493, 9173.35786494939, 9203.309751768644, 3104.332568497784, 3994.5206575210577, 4048.4736984192455, 4051.4125451809323, 4052.230076285496, 780.5823884221915, 865.8528050231475, 891.3225948279354, 901.9368644194843, 913.2420091324185, 20641.58716825685, 21135.365939021853, 21290.0, 21355.57288854214, 23290.65064024041, 833.8374017066735, 1005.215931573374, 1023.8720159980003, 1036.264252380803, 1037.4657051618422, 6808.2510923798345, 6822.829429264308, 6846.110005699227, 6923.515353925278, 7160.427165826722, 394522.0, 397352.0, 415173.0, 797663.0, 801631.0, 132991.0, 138176.61823381638, 160531.39468605397, 162561.0, 163756.0, 1143.988560114405, 1232.7534493101416, 1267.3916520070418, 1279.8016307472171, 1282.33959510852, 12160.817587736014, 12214.633560993185, 12224.083193760325, 12494.875051249372, 12512.749745004867, 52399.73800130975, 63285.367146327946, 64721.67639161774, 65807.0, 66035.66982165059, 61114.0, 64064.67967660132, 76721.84917226134, 76925.0, 78416.82374764269, 11327.830082548604, 11648.475818588015, 11763.705907352385, 11835.704107397383, 11913.761724765283, 12670.303133327387, 12816.166949148275, 12839.679008024874, 12966.351682415652, 13032.218066916015, 11194.6558025284, 11305.773884522428, 11426.25729327591, 11510.251833630788, 11698.94150529242, 11111.611093611686, 11293.604723834625, 11460.484278207667, 11534.365609891536, 11583.710407239887, 11506.0, 11624.302541847515, 11673.766524669629, 11721.0, 11807.291562506278, 11430.771384572428, 11470.770584588094, 11599.942000289944, 11720.0, 11765.88234117682, 8374.706885258987, 9011.414258073204, 11184.608538701106, 11195.0, 11260.268082574607], "value": 11001.01253254318, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1285.4858056777289, 1469.941202351906, 1565.9351640884202, 1573.9527814165579, 1580.4705423683065, 9329.253659707207, 9516.04839516048, 10551.0, 11218.551257949692, 11243.718907027329, 10448.425336606484, 10804.0, 10832.512536935837, 10870.891291087086, 10887.020168184861, 2243.753187149412, 2275.180934863448, 2275.943101422469, 2280.749117597063, 2292.816574674022, 2218.301235110935, 2253.661950707399, 2258.6160352740076, 2265.7764807004282, 2267.161150374364, 2221.3002904085242, 2224.510607666311, 2231.843770936035, 2236.3626366485555, 2243.349428665685, 2195.6706494025943, 2195.747489038749, 2208.0, 2208.4920468292303, 2215.0, 2170.576737536181, 2222.3666255117378, 2227.5767604155158, 2230.933072007826, 2231.386368748591, 11114.555417783278, 11161.83257251142, 11167.0, 11176.776464470746, 11178.938000889902, 4426.712263702849, 5190.92213616796, 5350.411454739976, 5357.7589008494715, 5360.383555891044, 2687.784977201819, 2832.8583570821374, 3123.281645221589, 3147.693707111569, 3404.3531728971416, 1064.4837253931837, 1075.172117469544, 1131.2251107991053, 1143.5654451308533, 1154.7344110854467, 13209.745074217934, 14857.925710371486, 14873.553793386216, 15243.085414875142, 15255.008424452375, 3914.784686842194, 4028.3756017817286, 4116.217918595457, 4267.466566679165, 4276.2516559601945, 9324.953375233215, 11072.280301780358, 11249.381284029294, 11685.591004314809, 11692.590759323382, 5263.6315457918345, 5268.762905669254, 5281.287026251407, 5317.335333083364, 5329.600279978939, 4030.3551431770775, 4810.470848206694, 4917.385326834145, 4938.037082768898, 4971.726555039435, 3562.07386079616, 3578.284343131384, 3658.9634103658623, 3668.3947148720695, 3708.332500149999, 872.4459967920416, 892.3530440430636, 896.6771962093641, 902.9277657787361, 903.0743487924798, 804.1154729797294, 844.5439462690201, 903.3586153830722, 919.1681528216974, 939.68050862707, 6420.711068001951, 6446.838829029218, 6483.3192514786215, 6521.902171467432, 6678.966605166943, 1024.0987930621006, 1026.7895081508423, 1051.6897515233024, 1059.6238335390826, 1064.1008347945974, 4162.500499939966, 4191.916161676811, 4260.169266992969, 4339.500957389878, 4359.607635312837, 13472.663183420296, 13694.93152534231, 13814.516491922734, 13948.58154255374, 13960.790588141186, 11063.0, 13906.235157066256, 13938.790918136236, 13962.162270263816, 13968.231747253998, 9797.412155270707, 10150.746231344128, 10210.591576337012, 10316.484175791331, 10316.742081447874, 6345.96827015862, 6415.71129299192, 6460.676966151767, 6499.6750162492635, 6533.575317604341, 12047.51809927593, 12200.267983920992, 12333.198342107735, 12341.50633974667, 12385.752284954431, 12315.69210769738, 12378.81431778506, 12583.748325033632, 12740.426680799572, 12792.74414511686, 8436.114208008315, 8503.319734421108, 8528.360372972176, 8541.444806087584, 8594.613242403982, 10204.846927296245, 10271.024252695983, 10280.588776448858, 10334.328268662513, 10356.067953884187, 9165.679201227926, 9212.769680757767, 9226.169644732006, 9253.444793312423, 9277.907220927704, 7346.889796653161, 7563.508371955805, 8646.524441155796, 8957.552122393985, 9062.818743625223, 5654.547636189177, 6702.3967842892425, 7385.778426647209, 7776.222377762178, 7938.404619653434, 5791.160281759037, 5961.7615295387695, 5963.403659634002, 5990.31111422192, 6021.0, 4377.343398490252, 5755.36690964002, 5840.299164100165, 5868.178455016387, 5937.554683398676], "value": 4906.578250953906, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.6619913886974, 350.7216196962072, 359.6475454055026, 372.1162239680758, 384.2027792330914, 4470.619997300225, 4900.76549477345, 5036.0, 5321.201819727043, 5342.545883599893, 3961.9405708914387, 5036.974815125928, 5123.5388815006645, 5147.2021836615295, 5198.568944496633, 3822.5795162532168, 3839.8080095995088, 4291.291936830435, 4305.870823875289, 4371.540988196241, 3692.981535092334, 3849.441830934513, 4213.283741763892, 4216.388623649569, 4317.122051907415, 4016.417619445179, 4111.979440102796, 4137.296659567865, 4335.6748243881675, 4339.566043395666, 3521.7358698097487, 4166.395872598471, 4312.935305970413, 4320.170288461063, 4329.415528903605, 3537.425845498754, 4019.8995025124605, 4021.8391264349393, 4034.072163402434, 4055.959440405617, 4094.7952602369764, 4987.576056035241, 5080.517350851663, 5083.79664813407, 5143.5113664201845, 4224.387463817729, 4497.550244975509, 4503.932441013388, 4936.432310284327, 4969.850904472872, 4817.759112044384, 5483.683915860205, 5605.542558934666, 5626.396477004075, 5684.573656975744, 4102.230994079015, 4328.523862375137, 4477.507474177838, 4509.436320459942, 4528.554580526512, 5513.807016754395, 5691.260136182311, 5843.678597677126, 5975.850603734898, 5988.0, 3719.9956011876643, 4138.13099249155, 4307.255561497598, 4516.5998540452565, 4540.72755634663, 4095.28332541804, 4182.832686692498, 4662.829276092222, 4669.392978912788, 4683.601893838993, 4595.609373203315, 4686.625069994392, 4846.321514987834, 4961.801527938842, 4968.033432740544, 4492.910141797146, 5015.996800639887, 5047.369078865142, 5425.864353391197, 5595.496405323541, 1455.1414665347495, 1524.8246451657978, 1578.7868637733989, 1604.9839501605068, 1605.2615796733633, 1006.6124542051363, 1108.5731993182521, 1194.898433633151, 1195.1753290229713, 1219.2014230678742, 4741.170295198326, 4994.950050499521, 5071.644984851099, 5244.5279924806955, 5283.049051170826, 5076.349981524215, 5411.323584551931, 5435.972820135874, 5584.855104703526, 5831.0, 4567.36056952027, 4869.63477739171, 5213.2701421800975, 5269.578433725293, 5356.250124982505, 2589.928057553949, 2990.1627544287635, 3004.248937765559, 3042.589250451205, 3057.5107982723102, 4897.1185186666025, 5135.7432128394175, 5322.600804939645, 5381.730913454312, 6000.76984218243, 4625.7455839929125, 5092.796288148433, 5178.964207158583, 5318.893622127536, 5762.279715035621, 5270.657407268515, 5359.946400535945, 5782.583267099503, 5828.795992140254, 5839.474447299764, 4802.399700037496, 5324.574034077342, 5432.782688692408, 5786.594938354275, 5854.302252346942, 4584.693362391836, 5357.651752636066, 5529.917051244154, 5659.971700141473, 5758.596898217084, 5883.323417807007, 5914.792982245601, 5915.822525324247, 5921.733521991607, 5933.614315069507, 4525.411696479437, 4562.794674239601, 4572.4741654708805, 4625.699329543569, 4645.883852903569, 5305.143199880011, 5353.75908084145, 5748.770049197985, 5752.482276595127, 5794.362620111869, 4674.649401294849, 5153.123968925217, 5398.811041613525, 5477.863053423696, 5567.91203298763, 5416.83749487516, 5536.418676039119, 5569.248151499496, 5601.991641504568, 5607.383187849252, 5017.698938063728, 5414.159185876821, 5439.401665816836, 5471.194505813151, 5518.5100022992765, 4513.796879140512, 5580.600341853042, 5583.436637741439, 5675.375708672125, 5729.713514324184, 4607.193741095228, 4655.464621568563, 4930.0, 5428.348598168245, 5484.588655850907], "value": 4217.443858266161, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.7228194863026, 720.8270015196355, 756.5460723565861, 760.40308357939, 847.525385783961, 15350.846491535081, 15720.056796592198, 15761.054336739804, 15887.80841436891, 16043.83956160438, 11677.474513646885, 14836.629084272872, 14841.703165936675, 15018.549443516684, 15132.0, 913.2191975860643, 944.4239014201331, 947.1901524196816, 948.1656142594508, 949.2975198353238, 939.1547607153582, 942.924566034719, 944.8866136063682, 946.2950102173891, 946.9621215151386, 977.3988996767008, 993.3692105512979, 995.3629677006721, 995.5768798260747, 995.8655581496478, 981.6662334806165, 989.5052473763119, 989.8267803134422, 992.1764935103846, 992.2260636703382, 726.7638017644234, 731.7877815433518, 735.6615956659942, 739.3013602145974, 741.3513175971025, 15129.243537823175, 15195.0, 15206.46777362787, 15243.932924695277, 15287.388504459808, 12577.559785407559, 14397.0, 14621.0, 14727.55817325482, 14729.779053314209, 11149.331040137618, 11410.0, 11518.769624607461, 11734.413279336084, 11910.702232444171, 3542.0, 3632.0919770057485, 3686.7234957378037, 3778.8299526521373, 3784.7729136251637, 107057.46471267594, 112144.4392778039, 113092.86907130906, 114217.42891285573, 116422.0, 10402.219833512518, 10422.895771042344, 10466.476676166314, 10587.258891877495, 11004.119670426348, 20232.79767202309, 20307.79692203059, 20347.9826008699, 20496.335476387972, 20643.380698579065, 7614.657340419694, 7677.961610191914, 7759.57322347265, 7765.301122898966, 7948.801279967932, 4176.937345939813, 4282.828686852553, 4298.935515967263, 4341.522432532419, 4395.956040439554, 3416.85535345662, 3474.6872781449792, 3501.7373696972827, 3510.8069056201643, 3511.8244087795506, 590.2710152961175, 610.9908351374733, 645.3578689204272, 671.3214275042642, 690.6270613868455, 659.577870163096, 671.9428848547929, 702.1118285369013, 706.2690115730195, 721.1598487761698, 9585.664501742405, 10285.794284114276, 10289.228307876789, 10311.175105991653, 10332.328398654214, 680.1803826389189, 697.9685914133876, 705.3616477088141, 708.9574625522486, 743.171363929215, 4600.907981840412, 5032.0, 5037.874053148627, 5039.0, 5047.520485553867, 103499.0, 107223.0, 107530.0, 107778.0, 108377.45811270893, 85823.14176858276, 87312.56343718368, 87598.0, 88009.0, 89705.0, 69302.61394772177, 80684.0, 82376.0, 84266.15733842706, 84879.0, 8410.663573457237, 9371.906280937375, 9659.758506037406, 9688.85466718014, 9713.27150463704, 49783.0, 53969.380918572504, 54477.0, 54538.0, 54796.45203547914, 67384.6630766843, 68094.0, 68840.62318753697, 69220.3077969234, 69358.65320673364, 11378.146639001943, 11527.8270825936, 11601.477933492844, 11822.645320640395, 12107.75784484323, 12338.003069155135, 12513.436895339913, 12526.498940042296, 12852.742945140857, 12864.099513033998, 11887.821682674594, 11969.64091077269, 11998.880011199777, 12008.39958002114, 12056.0, 12041.939790300992, 12079.456424460745, 12330.383480825743, 12352.0, 12502.749945000867, 11957.103217258566, 11968.0, 11980.880191197977, 11981.981531569914, 12108.697282568006, 10138.184710209822, 10324.741881453023, 10557.894421055691, 10719.517621707198, 11010.669679909615, 9241.399309044891, 9516.524173791422, 9958.601655933971, 9958.850617240601, 10052.84920726175], "value": 7496.4980486227105, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1576.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 122.0, 128.0, 176.0, 179.0, 122.0, 121.0, 121.0, 120.0, 121.0], "value": 131.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 135.0, 109.0, 147.0, 100.0, 139.0, 142.0, 142.0, 152.0, 140.0], "value": 137.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 219.0, 251.0, 198.0, 198.0, 199.0, 199.0, 196.0, 197.0, 216.0], "value": 206.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 60.0, 59.0, 90.0, 65.0, 63.0, 61.0, 59.0, 78.0, 72.0], "value": 69.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 70.0, 86.0, 74.0, 72.0, 70.0, 82.0, 70.0, 72.0, 83.0], "value": 76.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 90.0, 90.0, 90.0, 91.0, 122.0, 91.0, 90.0, 91.0], "value": 93.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 113.0, 152.0, 97.0, 116.0, 149.0, 97.0, 105.0, 98.0, 103.0], "value": 118.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 96.0, 94.0, 99.0, 76.0, 75.0, 148.0, 76.0, 143.0, 142.0], "value": 107.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 69.0, 70.0, 68.0, 105.0, 107.0, 106.0, 90.0], "value": 81.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 70.0, 101.0, 69.0, 65.0, 61.0, 61.0, 61.0, 64.0, 68.0], "value": 67.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 81.0, 95.0, 85.0, 83.0, 85.0, 88.0, 83.0, 95.0, 85.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 139.0, 132.0, 139.0, 129.0, 155.0, 150.0, 160.0, 188.0, 153.0], "value": 147.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 166.0, 166.0, 169.0, 168.0, 178.0, 224.0, 209.0, 170.0, 174.0], "value": 179.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 80.0, 73.0, 57.0, 82.0, 83.0, 88.0, 80.0, 69.0, 63.0], "value": 74.3, "unit": "score"}]}]} 03:06:43 INFO - Return code: 0 03:06:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:06:44 ERROR - # TBPL SUCCESS # 03:06:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:06:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:06:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:06:44 INFO - 2017-03-16 03:06:44.028 screenresolution[1659:11353] starting screenresolution argv=screenresolution get 03:06:44 INFO - 2017-03-16 03:06:44.031 screenresolution[1659:11353] Display 0: 1600x1200x32@60 03:06:44 INFO - 2017-03-16 03:06:44.038 screenresolution[1660:11356] starting screenresolution argv=screenresolution list 03:06:44 INFO - Available Modes on Display 0 03:06:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:06:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:06:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:06:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:06:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:06:44 INFO - Intel Iris: 03:06:44 INFO - Chipset Model: Intel Iris 03:06:44 INFO - Type: GPU 03:06:44 INFO - Bus: Built-In 03:06:44 INFO - VRAM (Dynamic, Max): 1536 MB 03:06:44 INFO - Vendor: Intel (0x8086) 03:06:44 INFO - Device ID: 0x0a2e 03:06:44 INFO - Revision ID: 0x0009 03:06:44 INFO - Displays: 03:06:44 INFO - Display: 03:06:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:06:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:06:44 INFO - Display Serial Number: 1600x1200 60 03:06:44 INFO - Main Display: Yes 03:06:44 INFO - Mirror: Off 03:06:44 INFO - Online: Yes 03:06:44 INFO - Rotation: Supported 03:06:44 INFO - Return code: 0 03:06:44 INFO - Running post-action listener: _resource_record_post_action 03:06:44 INFO - [mozharness: 2017-03-16 10:06:44.279490Z] Finished run-tests step (success) 03:06:44 INFO - Running post-run listener: _resource_record_post_run 03:06:44 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 41415168; Write bytes: 515107840; Read time: 377; Write time: 1667 03:06:44 INFO - TinderboxPrint: CPU usage
54.5% 03:06:44 INFO - TinderboxPrint: I/O read bytes / time
41,415,168 / 377 03:06:44 INFO - TinderboxPrint: I/O write bytes / time
515,107,840 / 1,667 03:06:44 INFO - TinderboxPrint: CPU idle
2,184.1 (45.5%) 03:06:44 INFO - TinderboxPrint: CPU system
965.8 (20.1%) 03:06:44 INFO - TinderboxPrint: CPU user
1,651.7 (34.4%) 03:06:44 INFO - TinderboxPrint: Swap in / out
253,788,160 / 0 03:06:44 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 200942080; Write bytes: 201693184; Read time: 15607; Write time: 400 03:06:44 INFO - run-tests - Wall time: 1180s; CPU: 55.0%; Read bytes: 40485376; Write bytes: 303522816; Read time: 362; Write time: 1239 03:06:44 INFO - Running post-run listener: _upload_blobber_files 03:06:44 INFO - Blob upload gear active. 03:06:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:06:44 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 03:06:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:06:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:06:45 INFO - (blobuploader) - INFO - Open directory for files ... 03:06:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:06:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:06:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:46 INFO - (blobuploader) - INFO - Done attempting. 03:06:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:06:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:06:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:47 INFO - (blobuploader) - INFO - Done attempting. 03:06:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:06:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:06:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:48 INFO - (blobuploader) - INFO - Done attempting. 03:06:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:06:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:06:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:50 INFO - (blobuploader) - INFO - Done attempting. 03:06:50 INFO - (blobuploader) - INFO - Iteration through files over. 03:06:50 INFO - Return code: 0 03:06:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:06:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:06:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8be4192a9647382505302e2f89bebe01ee333daf65dee34b19aeb0df5e7292940c82bb671db02b6d569d59e1d295dc816a79b064c3e01844a17a6f3ae10ef7c7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/178f28bdc7ba6c4312ccaeaae23e861bc22e5d57f752a7dd6ba73e978fa748458c17f4ed926bfc5e7835c4ea88ed2de9d0d36ad268decbfb307e40923aeef7f5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bed2e642317290d95accf04bc6292f158ac1b34265eae4f3730494d8ad7441fc0c8150ddf40715cd7789fbb44dca821b710369094f8da335778b3631d44f00fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4b5d060627c22603fed1d5a24dc0b5dc78fae7f2e482c672fb188a4e1743a0423582fdff797769b88ef9ce48e17daffca82eb92911da5eb89ccce379ab4c1b05"} 03:06:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:06:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:06:50 INFO - Contents: 03:06:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8be4192a9647382505302e2f89bebe01ee333daf65dee34b19aeb0df5e7292940c82bb671db02b6d569d59e1d295dc816a79b064c3e01844a17a6f3ae10ef7c7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/178f28bdc7ba6c4312ccaeaae23e861bc22e5d57f752a7dd6ba73e978fa748458c17f4ed926bfc5e7835c4ea88ed2de9d0d36ad268decbfb307e40923aeef7f5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bed2e642317290d95accf04bc6292f158ac1b34265eae4f3730494d8ad7441fc0c8150ddf40715cd7789fbb44dca821b710369094f8da335778b3631d44f00fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4b5d060627c22603fed1d5a24dc0b5dc78fae7f2e482c672fb188a4e1743a0423582fdff797769b88ef9ce48e17daffca82eb92911da5eb89ccce379ab4c1b05"} 03:06:50 INFO - Running post-run listener: copy_logs_to_upload_dir 03:06:50 INFO - Copying logs to upload dir... 03:06:50 INFO - mkdir: /builds/slave/test/build/upload/logs 03:06:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.654122 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-16 03:06:50.168861) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-16 03:06:50.172315) ========= 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.eFmIgJ125h/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.sj8kTECbH4/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8be4192a9647382505302e2f89bebe01ee333daf65dee34b19aeb0df5e7292940c82bb671db02b6d569d59e1d295dc816a79b064c3e01844a17a6f3ae10ef7c7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/178f28bdc7ba6c4312ccaeaae23e861bc22e5d57f752a7dd6ba73e978fa748458c17f4ed926bfc5e7835c4ea88ed2de9d0d36ad268decbfb307e40923aeef7f5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bed2e642317290d95accf04bc6292f158ac1b34265eae4f3730494d8ad7441fc0c8150ddf40715cd7789fbb44dca821b710369094f8da335778b3631d44f00fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4b5d060627c22603fed1d5a24dc0b5dc78fae7f2e482c672fb188a4e1743a0423582fdff797769b88ef9ce48e17daffca82eb92911da5eb89ccce379ab4c1b05"} build_url:https://queue.taskcluster.net/v1/task/XohZgmNbTZOZLcuEzLN0Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011159 build_url: 'https://queue.taskcluster.net/v1/task/XohZgmNbTZOZLcuEzLN0Zg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8be4192a9647382505302e2f89bebe01ee333daf65dee34b19aeb0df5e7292940c82bb671db02b6d569d59e1d295dc816a79b064c3e01844a17a6f3ae10ef7c7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/178f28bdc7ba6c4312ccaeaae23e861bc22e5d57f752a7dd6ba73e978fa748458c17f4ed926bfc5e7835c4ea88ed2de9d0d36ad268decbfb307e40923aeef7f5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bed2e642317290d95accf04bc6292f158ac1b34265eae4f3730494d8ad7441fc0c8150ddf40715cd7789fbb44dca821b710369094f8da335778b3631d44f00fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4b5d060627c22603fed1d5a24dc0b5dc78fae7f2e482c672fb188a4e1743a0423582fdff797769b88ef9ce48e17daffca82eb92911da5eb89ccce379ab4c1b05"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-16 03:06:50.207123) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 03:06:50.207454) ========= 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.eFmIgJ125h/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.sj8kTECbH4/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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.005160 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 03:06:50.255791) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-16 03:06:50.256122) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-16 03:06:50.256499) ========= ========= Total master_lag: 0.66 =========