builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0315 starttime: 1491994404.09 results: success (0) buildid: 20170412022908 builduid: e82cf8c5eae64edca7f58433d8cb4af2 revision: 584b429e5c7045cdde5efab444fcefdefbee4fe0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-12 03:53:24.086690) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-12 03:53:24.087138) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-12 03:53:24.087409) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-12 03:53:24.113694) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 03:53:24.114014) ========= 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.21VZBpRpRx/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.QklAIHXj6b/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-12 03:53:24-- 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% 164M=0s 2017-04-12 03:53:24 (164 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136656 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 03:53:24.274573) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 03:53:24.274898) ========= 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.21VZBpRpRx/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.QklAIHXj6b/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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.027783 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 03:53:24.324759) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-12 03:53:24.325120) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 584b429e5c7045cdde5efab444fcefdefbee4fe0 --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-beta --rev 584b429e5c7045cdde5efab444fcefdefbee4fe0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.21VZBpRpRx/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.QklAIHXj6b/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-12 03:53:24,462 truncating revision to first 12 chars 2017-04-12 03:53:24,462 Setting DEBUG logging. 2017-04-12 03:53:24,462 attempt 1/10 2017-04-12 03:53:24,462 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/584b429e5c70?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-12 03:53:25,423 unpacking tar archive at: mozilla-beta-584b429e5c70/testing/mozharness/ program finished with exit code 0 elapsedTime=1.254544 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-12 03:53:25.684750) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-12 03:53:25.685083) ========= script_repo_revision: 584b429e5c7045cdde5efab444fcefdefbee4fe0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-12 03:53:25.685458) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-12 03:53:25.685757) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-12 03:53:25.705698) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-04-12 03:53:25.706051) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.21VZBpRpRx/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.QklAIHXj6b/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 03:53:25 INFO - MultiFileLogger online at 20170412 03:53:25 in /builds/slave/test 03:53:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 03:53:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:53:25 INFO - {'append_to_log': False, 03:53:25 INFO - 'base_work_dir': '/builds/slave/test', 03:53:25 INFO - 'blob_upload_branch': 'Mozilla-Beta', 03:53:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:53:25 INFO - 'branch': 'Mozilla-Beta', 03:53:25 INFO - 'buildbot_json_path': 'buildprops.json', 03:53:25 INFO - 'config_files': ('talos/mac_config.py',), 03:53:25 INFO - 'default_actions': ('clobber', 03:53:25 INFO - 'read-buildbot-config', 03:53:25 INFO - 'download-and-extract', 03:53:25 INFO - 'populate-webroot', 03:53:25 INFO - 'create-virtualenv', 03:53:25 INFO - 'install', 03:53:25 INFO - 'run-tests'), 03:53:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:53:25 INFO - 'download_minidump_stackwalk': True, 03:53:25 INFO - 'download_symbols': 'ondemand', 03:53:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:53:25 INFO - 'tooltool.py': '/tools/tooltool.py', 03:53:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:53:25 INFO - '/tools/misc-python/virtualenv.py')}, 03:53:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:53:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:53:25 INFO - 'installer_path': 'installer.exe', 03:53:25 INFO - 'log_level': 'info', 03:53:25 INFO - 'log_name': 'talos', 03:53:25 INFO - 'log_to_console': True, 03:53:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:53:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:53:25 INFO - 'opt_config_files': (), 03:53:25 INFO - 'pip_index': False, 03:53:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:53:25 INFO - 'cmd': ('bash', 03:53:25 INFO - '-c', 03:53:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:53:25 INFO - 'enabled': True, 03:53:25 INFO - 'halt_on_failure': False, 03:53:25 INFO - 'name': 'check_screen_resolution'},), 03:53:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:53:25 INFO - 'cmd': ('bash', 03:53:25 INFO - '-c', 03:53:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:53:25 INFO - 'enabled': True, 03:53:25 INFO - 'halt_on_failure': False, 03:53:25 INFO - 'name': 'check_screen_resolution'},), 03:53:25 INFO - 'run_cmd_checks_enabled': True, 03:53:25 INFO - 'sps_profile': False, 03:53:25 INFO - 'sps_profile_interval': 0, 03:53:25 INFO - 'suite': 'dromaeojs-e10s', 03:53:25 INFO - 'system_bits': '32', 03:53:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:53:25 INFO - 'title': 't-yosemite-r7-0315', 03:53:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:53:25 INFO - 'use_talos_json': True, 03:53:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:53:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:53:25 INFO - 'work_dir': 'build'} 03:53:25 INFO - [mozharness: 2017-04-12 10:53:25.919416Z] Running clobber step. 03:53:25 INFO - Running pre-action listener: _resource_record_pre_action 03:53:25 INFO - Running main action method: clobber 03:53:25 INFO - rmtree: /builds/slave/test/build 03:53:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:53:30 INFO - Running post-action listener: _resource_record_post_action 03:53:30 INFO - [mozharness: 2017-04-12 10:53:30.345268Z] Finished clobber step (success) 03:53:30 INFO - [mozharness: 2017-04-12 10:53:30.345485Z] Running read-buildbot-config step. 03:53:30 INFO - Running pre-action listener: _resource_record_pre_action 03:53:30 INFO - Running main action method: read_buildbot_config 03:53:30 INFO - Using buildbot properties: 03:53:30 INFO - { 03:53:30 INFO - "project": "", 03:53:30 INFO - "product": "firefox", 03:53:30 INFO - "script_repo_revision": "production", 03:53:30 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 03:53:30 INFO - "repository": "", 03:53:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 03:53:30 INFO - "buildid": "20170412022908", 03:53:30 INFO - "pgo_build": "False", 03:53:30 INFO - "basedir": "/builds/slave/test", 03:53:30 INFO - "buildnumber": 1, 03:53:30 INFO - "slavename": "t-yosemite-r7-0315", 03:53:30 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 03:53:30 INFO - "platform": "yosemite_r7", 03:53:30 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 03:53:30 INFO - "branch": "mozilla-beta", 03:53:30 INFO - "repo_path": "releases/mozilla-beta", 03:53:30 INFO - "revision": "584b429e5c7045cdde5efab444fcefdefbee4fe0", 03:53:30 INFO - "stage_platform": "macosx64", 03:53:30 INFO - "builduid": "e82cf8c5eae64edca7f58433d8cb4af2", 03:53:30 INFO - "slavebuilddir": "test" 03:53:30 INFO - } 03:53:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/YdWBzOXrQZ-JrlsO5mictA/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 03:53:30 INFO - Running post-action listener: _resource_record_post_action 03:53:30 INFO - [mozharness: 2017-04-12 10:53:30.351049Z] Finished read-buildbot-config step (success) 03:53:30 INFO - [mozharness: 2017-04-12 10:53:30.351200Z] Running download-and-extract step. 03:53:30 INFO - Running pre-action listener: _resource_record_pre_action 03:53:30 INFO - Running main action method: download_and_extract 03:53:30 INFO - mkdir: /builds/slave/test/build/tests 03:53: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')]} 03:53:30 INFO - trying https://queue.taskcluster.net/v1/task/YdWBzOXrQZ-JrlsO5mictA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 03:53:30 INFO - Downloading https://queue.taskcluster.net/v1/task/YdWBzOXrQZ-JrlsO5mictA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 03:53:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YdWBzOXrQZ-JrlsO5mictA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 03:53:31 INFO - Downloaded 1165 bytes. 03:53:31 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 03:53:31 INFO - Using the following test package requirements: 03:53:31 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 03:53:31 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 03:53:31 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 03:53:31 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 03:53:31 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 03:53:31 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 03:53:31 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 03:53:31 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 03:53:31 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 03:53:31 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 03:53:31 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 03:53:31 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 03:53:31 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 03:53:31 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 03:53:31 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 03:53:31 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 03:53:31 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 03:53:31 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 03:53:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YdWBzOXrQZ-JrlsO5mictA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 03:53:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YdWBzOXrQZ-JrlsO5mictA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 03:53:31 INFO - Fetch https://queue.taskcluster.net/v1/task/YdWBzOXrQZ-JrlsO5mictA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 03:53:32 INFO - Expected file size: 16116600 03:53:32 INFO - Obtained file size: 16116600 03:53:39 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 03:53:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YdWBzOXrQZ-JrlsO5mictA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 03:53:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YdWBzOXrQZ-JrlsO5mictA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 03:53:39 INFO - Fetch https://queue.taskcluster.net/v1/task/YdWBzOXrQZ-JrlsO5mictA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 03:53:40 INFO - Expected file size: 16116600 03:53:40 INFO - Obtained file size: 16116600 03:53:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YdWBzOXrQZ-JrlsO5mictA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 03:53:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YdWBzOXrQZ-JrlsO5mictA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 03:53:46 INFO - Fetch https://queue.taskcluster.net/v1/task/YdWBzOXrQZ-JrlsO5mictA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 03:53:47 INFO - Expected file size: 14403650 03:53:47 INFO - Obtained file size: 14403650 03:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:48 INFO - trying https://queue.taskcluster.net/v1/task/YdWBzOXrQZ-JrlsO5mictA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 03:53:48 INFO - Downloading https://queue.taskcluster.net/v1/task/YdWBzOXrQZ-JrlsO5mictA/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 03:53:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YdWBzOXrQZ-JrlsO5mictA/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 03:53:49 INFO - Downloaded 58457915 bytes. 03:53:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YdWBzOXrQZ-JrlsO5mictA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 03:53:49 INFO - mkdir: /builds/slave/test/properties 03:53:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:53:49 INFO - Writing to file /builds/slave/test/properties/build_url 03:53:49 INFO - Contents: 03:53:49 INFO - build_url:https://queue.taskcluster.net/v1/task/YdWBzOXrQZ-JrlsO5mictA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 03:53:50 INFO - Running post-action listener: _resource_record_post_action 03:53:50 INFO - Running post-action listener: set_extra_try_arguments 03:53:50 INFO - [mozharness: 2017-04-12 10:53:50.469008Z] Finished download-and-extract step (success) 03:53:50 INFO - [mozharness: 2017-04-12 10:53:50.469103Z] Running populate-webroot step. 03:53:50 INFO - Running pre-action listener: _resource_record_pre_action 03:53:50 INFO - Running main action method: populate_webroot 03:53:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:53:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:53:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:53:50 INFO - '--tppagecycles', 03:53:50 INFO - '7'], 03:53:50 INFO - 'tests': ['tsvgm']}}, 03:53:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:53:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:53:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:53:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:53:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:53:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:53:50 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:53:50 INFO - 'talos_options': ['--disable-e10s'], 03:53:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:53:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:53:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:53:50 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:53:50 INFO - 'talos_options': ['--disable-e10s'], 03:53:50 INFO - 'tests': ['damp', 'tps']}, 03:53:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:53:50 INFO - 'tests': ['damp', 'tps']}, 03:53:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:53:50 INFO - 'tests': ['dromaeo_dom']}, 03:53:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:53:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:53:50 INFO - 'tests': ['basic_compositor_video']}, 03:53:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:53:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:53:50 INFO - 'tests': ['a11yr', 03:53:50 INFO - 'ts_paint', 03:53:50 INFO - 'tpaint', 03:53:50 INFO - 'sessionrestore', 03:53:50 INFO - 'sessionrestore_no_auto_restore', 03:53:50 INFO - 'tabpaint']}, 03:53:50 INFO - 'other-e10s': {'tests': ['a11yr', 03:53:50 INFO - 'ts_paint', 03:53:50 INFO - 'tpaint', 03:53:50 INFO - 'sessionrestore', 03:53:50 INFO - 'sessionrestore_no_auto_restore', 03:53:50 INFO - 'tabpaint']}, 03:53:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:53:50 INFO - 'ts_paint', 03:53:50 INFO - 'tpaint', 03:53:50 INFO - 'sessionrestore', 03:53:50 INFO - 'sessionrestore_no_auto_restore', 03:53:50 INFO - 'tabpaint']}, 03:53:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:53:50 INFO - 'ts_paint', 03:53:50 INFO - 'tpaint', 03:53:50 INFO - 'sessionrestore', 03:53:50 INFO - 'sessionrestore_no_auto_restore', 03:53:50 INFO - 'tabpaint']}, 03:53:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:53:50 INFO - 'tests': ['a11yr', 03:53:50 INFO - 'ts_paint', 03:53:50 INFO - 'tpaint', 03:53:50 INFO - 'sessionrestore', 03:53:50 INFO - 'sessionrestore_no_auto_restore', 03:53:50 INFO - 'tabpaint']}, 03:53:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:53:50 INFO - 'tests': ['a11yr', 03:53:50 INFO - 'ts_paint', 03:53:50 INFO - 'tpaint', 03:53:50 INFO - 'sessionrestore', 03:53:50 INFO - 'sessionrestore_no_auto_restore', 03:53:50 INFO - 'tabpaint']}, 03:53:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:53:50 INFO - 'tests': ['tsvgx', 03:53:50 INFO - 'tsvgr_opacity', 03:53:50 INFO - 'tart', 03:53:50 INFO - 'tscrollx', 03:53:50 INFO - 'cart', 03:53:50 INFO - 'tsvg_static']}, 03:53:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:53:50 INFO - 'tsvgr_opacity', 03:53:50 INFO - 'tart', 03:53:50 INFO - 'tscrollx', 03:53:50 INFO - 'cart', 03:53:50 INFO - 'tsvg_static']}, 03:53:50 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:53:50 INFO - 'talos_options': ['--disable-e10s'], 03:53:50 INFO - 'tests': ['tp5o']}, 03:53:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:53:50 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:53:50 INFO - 'talos_options': ['--disable-e10s', 03:53:50 INFO - '--xperf_path', 03:53:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:53:50 INFO - 'tests': ['tp5n']}, 03:53:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:53:50 INFO - 'talos_options': ['--xperf_path', 03:53:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:53:50 INFO - 'tests': ['tp5n']}}, 03:53:50 INFO - 'talos.zip': {'path': '', 03:53:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:53:50 INFO - Running post-action listener: _resource_record_post_action 03:53:50 INFO - [mozharness: 2017-04-12 10:53:50.487454Z] Finished populate-webroot step (success) 03:53:50 INFO - [mozharness: 2017-04-12 10:53:50.487562Z] Running create-virtualenv step. 03:53:50 INFO - Running pre-action listener: _resource_record_pre_action 03:53:50 INFO - Running main action method: create_virtualenv 03:53:50 INFO - Creating virtualenv /builds/slave/test/build/venv 03:53:50 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 03:53:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:53:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:53:50 INFO - Using real prefix '/tools/python27' 03:53:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:53:51 INFO - Installing distribute.............................................................................................................................................................................................done. 03:53:54 INFO - Installing pip.................done. 03:53:54 INFO - Return code: 0 03:53:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:53:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:53:54 INFO - Reading from file tmpfile_stdout 03:53:54 INFO - Output received: 03:53:54 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) 03:53:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10af9cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af9f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5315b8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad7ad30>, '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 0x10aca1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad6fbe8>, '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.21VZBpRpRx/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.QklAIHXj6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 03:53:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:53:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:53:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.21VZBpRpRx/Render', 03:53:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:53:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:53:54 INFO - 'HOME': '/Users/cltbld', 03:53:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:53:54 INFO - 'LOGNAME': 'cltbld', 03:53:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:54 INFO - 'MOZ_NO_REMOTE': '1', 03:53:54 INFO - 'NO_EM_RESTART': '1', 03:53:54 INFO - 'PAGER': '/bin/cat', 03:53:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:53:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:54 INFO - 'PWD': '/builds/slave/test', 03:53:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:53:54 INFO - 'SHELL': '/bin/bash', 03:53:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QklAIHXj6b/Listeners', 03:53:54 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 03:53:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:53:54 INFO - 'USER': 'cltbld', 03:53:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:53:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:53:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:54 INFO - 'XPC_FLAGS': '0x0', 03:53:54 INFO - 'XPC_SERVICE_NAME': '0', 03:53:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:53:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:54 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 03:53:54 INFO - Cleaning up... 03:53:54 INFO - Return code: 0 03:53:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10af9cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af9f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5315b8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad7ad30>, '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 0x10aca1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad6fbe8>, '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.21VZBpRpRx/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.QklAIHXj6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 03:53:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:53:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:53:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.21VZBpRpRx/Render', 03:53:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:53:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:53:54 INFO - 'HOME': '/Users/cltbld', 03:53:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:53:54 INFO - 'LOGNAME': 'cltbld', 03:53:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:54 INFO - 'MOZ_NO_REMOTE': '1', 03:53:54 INFO - 'NO_EM_RESTART': '1', 03:53:54 INFO - 'PAGER': '/bin/cat', 03:53:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:53:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:54 INFO - 'PWD': '/builds/slave/test', 03:53:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:53:54 INFO - 'SHELL': '/bin/bash', 03:53:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QklAIHXj6b/Listeners', 03:53:54 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 03:53:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:53:54 INFO - 'USER': 'cltbld', 03:53:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:53:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:53:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:54 INFO - 'XPC_FLAGS': '0x0', 03:53:54 INFO - 'XPC_SERVICE_NAME': '0', 03:53:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:53:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:54 INFO - Downloading/unpacking psutil>=3.1.1 03:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:53:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:53:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:53:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:53:58 INFO - Installing collected packages: psutil 03:53:58 INFO - Running setup.py install for psutil 03:53:58 INFO - building 'psutil._psutil_osx' extension 03:53:58 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 03:53:59 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 03:53:59 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 03:53:59 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 03:53:59 INFO - building 'psutil._psutil_posix' extension 03:53:59 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 03:53:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:53:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:53:59 INFO - ^ 03:53:59 INFO - 1 warning generated. 03:53:59 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 03:53:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:53:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:53:59 INFO - Successfully installed psutil 03:53:59 INFO - Cleaning up... 03:53:59 INFO - Return code: 0 03:53:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:53:59 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')]} 03:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:59 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')]} 03:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:59 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 0x10af9cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af9f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5315b8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad7ad30>, '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 0x10aca1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad6fbe8>, '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.21VZBpRpRx/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.QklAIHXj6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 03:53:59 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 03:53:59 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 03:53:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.21VZBpRpRx/Render', 03:53:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:53:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:53:59 INFO - 'HOME': '/Users/cltbld', 03:53:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:53:59 INFO - 'LOGNAME': 'cltbld', 03:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:59 INFO - 'MOZ_NO_REMOTE': '1', 03:53:59 INFO - 'NO_EM_RESTART': '1', 03:53:59 INFO - 'PAGER': '/bin/cat', 03:53:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:59 INFO - 'PWD': '/builds/slave/test', 03:53:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:53:59 INFO - 'SHELL': '/bin/bash', 03:53:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QklAIHXj6b/Listeners', 03:53:59 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 03:53:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:53:59 INFO - 'USER': 'cltbld', 03:53:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:53:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:59 INFO - 'XPC_FLAGS': '0x0', 03:53:59 INFO - 'XPC_SERVICE_NAME': '0', 03:53:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:53:59 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 03:53:59 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 03:53:59 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 03:53:59 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 03:53:59 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 03:53:59 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 03:54:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:54:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:54:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:54:02 INFO - Installing collected packages: mozsystemmonitor 03:54:02 INFO - Running setup.py install for mozsystemmonitor 03:54:02 INFO - Successfully installed mozsystemmonitor 03:54:02 INFO - Cleaning up... 03:54:02 INFO - Return code: 0 03:54:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:54:02 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')]} 03:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:02 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')]} 03:54:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:02 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 0x10af9cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af9f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5315b8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad7ad30>, '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 0x10aca1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad6fbe8>, '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.21VZBpRpRx/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.QklAIHXj6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 03:54:02 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 03:54:02 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 03:54:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.21VZBpRpRx/Render', 03:54:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:54:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:54:02 INFO - 'HOME': '/Users/cltbld', 03:54:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:54:02 INFO - 'LOGNAME': 'cltbld', 03:54:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:02 INFO - 'MOZ_NO_REMOTE': '1', 03:54:02 INFO - 'NO_EM_RESTART': '1', 03:54:02 INFO - 'PAGER': '/bin/cat', 03:54:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:54:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:02 INFO - 'PWD': '/builds/slave/test', 03:54:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:54:02 INFO - 'SHELL': '/bin/bash', 03:54:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QklAIHXj6b/Listeners', 03:54:02 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 03:54:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:54:02 INFO - 'USER': 'cltbld', 03:54:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:54:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:54:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:02 INFO - 'XPC_FLAGS': '0x0', 03:54:02 INFO - 'XPC_SERVICE_NAME': '0', 03:54:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:03 INFO - Downloading/unpacking jsonschema==2.5.1 03:54:03 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 03:54:03 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 03:54:03 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 03:54:03 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 03:54:03 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 03:54:03 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 03:54:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:54:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:54:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:54:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:54:06 INFO - Downloading functools32-3.2.3-2.tar.gz 03:54:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:54:06 INFO - warning: no files found matching '*.txt' 03:54:06 INFO - no previously-included directories found matching 'build' 03:54:06 INFO - no previously-included directories found matching 'dist' 03:54:06 INFO - no previously-included directories found matching '.git*' 03:54:06 INFO - Installing collected packages: jsonschema, functools32 03:54:06 INFO - Running setup.py install for functools32 03:54:06 INFO - warning: no files found matching '*.txt' 03:54:06 INFO - no previously-included directories found matching 'build' 03:54:06 INFO - no previously-included directories found matching 'dist' 03:54:06 INFO - no previously-included directories found matching '.git*' 03:54:06 INFO - Successfully installed jsonschema functools32 03:54:06 INFO - Cleaning up... 03:54:06 INFO - Return code: 0 03:54:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:06 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 0x10af9cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af9f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5315b8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad7ad30>, '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 0x10aca1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad6fbe8>, '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.21VZBpRpRx/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.QklAIHXj6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 03:54:06 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 03:54:06 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 03:54:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.21VZBpRpRx/Render', 03:54:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:54:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:54:06 INFO - 'HOME': '/Users/cltbld', 03:54:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:54:06 INFO - 'LOGNAME': 'cltbld', 03:54:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:06 INFO - 'MOZ_NO_REMOTE': '1', 03:54:06 INFO - 'NO_EM_RESTART': '1', 03:54:06 INFO - 'PAGER': '/bin/cat', 03:54:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:54:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:06 INFO - 'PWD': '/builds/slave/test', 03:54:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:54:06 INFO - 'SHELL': '/bin/bash', 03:54:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QklAIHXj6b/Listeners', 03:54:06 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 03:54:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:54:06 INFO - 'USER': 'cltbld', 03:54:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:54:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:54:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:06 INFO - 'XPC_FLAGS': '0x0', 03:54:06 INFO - 'XPC_SERVICE_NAME': '0', 03:54:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:54:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:54:06 INFO - Cleaning up... 03:54:06 INFO - Return code: 0 03:54:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:06 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 0x10af9cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af9f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5315b8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad7ad30>, '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 0x10aca1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad6fbe8>, '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.21VZBpRpRx/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.QklAIHXj6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 03:54:06 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 03:54:06 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 03:54:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.21VZBpRpRx/Render', 03:54:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:54:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:54:06 INFO - 'HOME': '/Users/cltbld', 03:54:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:54:06 INFO - 'LOGNAME': 'cltbld', 03:54:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:06 INFO - 'MOZ_NO_REMOTE': '1', 03:54:06 INFO - 'NO_EM_RESTART': '1', 03:54:06 INFO - 'PAGER': '/bin/cat', 03:54:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:54:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:06 INFO - 'PWD': '/builds/slave/test', 03:54:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:54:06 INFO - 'SHELL': '/bin/bash', 03:54:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QklAIHXj6b/Listeners', 03:54:06 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 03:54:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:54:06 INFO - 'USER': 'cltbld', 03:54:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:54:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:54:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:06 INFO - 'XPC_FLAGS': '0x0', 03:54:06 INFO - 'XPC_SERVICE_NAME': '0', 03:54:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:07 INFO - Downloading/unpacking blobuploader==1.2.4 03:54:07 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 03:54:07 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 03:54:07 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 03:54:07 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 03:54:07 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 03:54:07 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 03:54:09 INFO - Downloading blobuploader-1.2.4.tar.gz 03:54:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:54:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:54:09 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 03:54:09 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 03:54:09 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 03:54:09 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 03:54:09 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 03:54:09 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 03:54:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:54:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:54:10 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 03:54:10 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 03:54:10 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 03:54:10 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 03:54:10 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 03:54:10 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 03:54:10 INFO - Downloading docopt-0.6.1.tar.gz 03:54:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:54:11 INFO - Installing collected packages: blobuploader, requests, docopt 03:54:11 INFO - Running setup.py install for blobuploader 03:54:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:54:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:54:11 INFO - Running setup.py install for requests 03:54:11 INFO - Running setup.py install for docopt 03:54:11 INFO - Successfully installed blobuploader requests docopt 03:54:11 INFO - Cleaning up... 03:54:11 INFO - Return code: 0 03:54:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:54:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:11 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 0x10af9cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af9f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5315b8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad7ad30>, '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 0x10aca1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad6fbe8>, '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.21VZBpRpRx/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.QklAIHXj6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 03:54:11 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 03:54:11 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 03:54:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.21VZBpRpRx/Render', 03:54:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:54:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:54:11 INFO - 'HOME': '/Users/cltbld', 03:54:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:54:11 INFO - 'LOGNAME': 'cltbld', 03:54:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:11 INFO - 'MOZ_NO_REMOTE': '1', 03:54:11 INFO - 'NO_EM_RESTART': '1', 03:54:11 INFO - 'PAGER': '/bin/cat', 03:54:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:54:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:11 INFO - 'PWD': '/builds/slave/test', 03:54:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:54:11 INFO - 'SHELL': '/bin/bash', 03:54:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QklAIHXj6b/Listeners', 03:54:11 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 03:54:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:54:11 INFO - 'USER': 'cltbld', 03:54:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:54:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:54:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:11 INFO - 'XPC_FLAGS': '0x0', 03:54:11 INFO - 'XPC_SERVICE_NAME': '0', 03:54:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:54:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:54:12 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-9jx5Qt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:54:12 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-fRmi3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:54:12 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-u4UErd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:54:12 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-zMqW0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:54:12 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-BFQUeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:54:12 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-yG62EI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:54:12 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-8kkVcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:54:12 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-OXYdOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:54:13 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-9MuhZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:54:13 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-FFJD1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:54:13 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-wAACth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:54:13 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-8mBRIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:54:13 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-FrKb9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:54:13 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-5GRI2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:54:13 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-97mpav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:54:13 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-EfzWvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:54:13 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-9CP8ve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:54:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:54:13 INFO - Running setup.py install for manifestparser 03:54:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:54:14 INFO - Running setup.py install for mozcrash 03:54:14 INFO - Running setup.py install for mozdebug 03:54:14 INFO - Running setup.py install for mozdevice 03:54:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:54:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:54:14 INFO - Running setup.py install for mozfile 03:54:14 INFO - Running setup.py install for mozhttpd 03:54:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:54:14 INFO - Running setup.py install for mozinfo 03:54:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:54:15 INFO - Running setup.py install for mozInstall 03:54:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:54:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:54:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:54:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:54:15 INFO - Running setup.py install for mozleak 03:54:15 INFO - Running setup.py install for mozlog 03:54:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:54:15 INFO - Running setup.py install for moznetwork 03:54:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:54:15 INFO - Running setup.py install for mozprocess 03:54:15 INFO - Running setup.py install for mozprofile 03:54:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:54:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:54:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:54:15 INFO - Running setup.py install for mozrunner 03:54:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:54:16 INFO - Running setup.py install for mozscreenshot 03:54:16 INFO - Running setup.py install for moztest 03:54:16 INFO - Running setup.py install for mozversion 03:54:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:54:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:54:16 INFO - Cleaning up... 03:54:16 INFO - Return code: 0 03:54:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:16 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 0x10af9cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af9f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5315b8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad7ad30>, '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 0x10aca1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad6fbe8>, '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.21VZBpRpRx/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.QklAIHXj6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 03:54:16 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 03:54:16 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 03:54:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.21VZBpRpRx/Render', 03:54:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:54:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:54:16 INFO - 'HOME': '/Users/cltbld', 03:54:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:54:16 INFO - 'LOGNAME': 'cltbld', 03:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:16 INFO - 'MOZ_NO_REMOTE': '1', 03:54:16 INFO - 'NO_EM_RESTART': '1', 03:54:16 INFO - 'PAGER': '/bin/cat', 03:54:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:16 INFO - 'PWD': '/builds/slave/test', 03:54:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:54:16 INFO - 'SHELL': '/bin/bash', 03:54:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QklAIHXj6b/Listeners', 03:54:16 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 03:54:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:54:16 INFO - 'USER': 'cltbld', 03:54:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:54:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:16 INFO - 'XPC_FLAGS': '0x0', 03:54:16 INFO - 'XPC_SERVICE_NAME': '0', 03:54:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:54:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:54:16 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-tiNrYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:54:16 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)) 03:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:54:16 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-_qbyU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:54:17 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)) 03:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:54:17 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-5ZbxB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:54:17 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)) 03:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:54:17 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-5Sz8nW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:54:17 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)) 03:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:54:17 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-zmlWah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:54:17 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)) 03:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:54:17 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-o478ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:54:17 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)) 03:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:54:17 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-I0O_AU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:54:17 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)) 03:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:54:17 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-CixsCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:54:17 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)) 03:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:54:17 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-CvO6f9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:54:17 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)) 03:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:54:17 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-BtyHbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:54:17 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)) 03:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:54:17 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-iNyjQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:54:18 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)) 03:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:54:18 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-XDhJ5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:54:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:54:18 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-Ryr_xC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:54:18 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)) 03:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:54:18 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-9rqcZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:54:18 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)) 03:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:54:18 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-21ZQwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:54:18 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)) 03:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:54:18 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-1jzRna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:54:18 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)) 03:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:54:18 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-9XOmib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:54:18 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)) 03:54:18 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)) 03:54:18 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)) 03:54:18 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)) 03:54:18 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)) 03:54:18 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)) 03:54:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:54:18 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 03:54:18 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 03:54:18 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 03:54:18 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 03:54:18 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 03:54:18 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 03:54:21 INFO - Downloading blessings-1.6.tar.gz 03:54:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:54:21 INFO - Installing collected packages: blessings 03:54:21 INFO - Running setup.py install for blessings 03:54:21 INFO - Successfully installed blessings 03:54:21 INFO - Cleaning up... 03:54:21 INFO - Return code: 0 03:54:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:54:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:54:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:54:22 INFO - Reading from file tmpfile_stdout 03:54:22 INFO - Current package versions: 03:54:22 INFO - blessings == 1.6 03:54:22 INFO - blobuploader == 1.2.4 03:54:22 INFO - docopt == 0.6.1 03:54:22 INFO - functools32 == 3.2.3-2 03:54:22 INFO - jsonschema == 2.5.1 03:54:22 INFO - manifestparser == 1.1 03:54:22 INFO - mozInstall == 1.12 03:54:22 INFO - mozcrash == 1.0 03:54:22 INFO - mozdebug == 0.1 03:54:22 INFO - mozdevice == 0.49 03:54:22 INFO - mozfile == 1.2 03:54:22 INFO - mozhttpd == 0.7 03:54:22 INFO - mozinfo == 0.9 03:54:22 INFO - mozleak == 0.1 03:54:22 INFO - mozlog == 3.4 03:54:22 INFO - moznetwork == 0.27 03:54:22 INFO - mozprocess == 0.24 03:54:22 INFO - mozprofile == 0.28 03:54:22 INFO - mozrunner == 6.13 03:54:22 INFO - mozscreenshot == 0.1 03:54:22 INFO - mozsystemmonitor == 0.3 03:54:22 INFO - moztest == 0.8 03:54:22 INFO - mozversion == 1.4 03:54:22 INFO - psutil == 3.1.1 03:54:22 INFO - requests == 1.2.3 03:54:22 INFO - wsgiref == 0.1.2 03:54:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:54:22 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')]} 03:54:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:22 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')]} 03:54:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:22 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 0x10af9cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af9f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5315b8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad7ad30>, '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 0x10aca1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad6fbe8>, '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.21VZBpRpRx/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.QklAIHXj6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 03:54:22 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 03:54:22 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 03:54:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.21VZBpRpRx/Render', 03:54:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:54:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:54:22 INFO - 'HOME': '/Users/cltbld', 03:54:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:54:22 INFO - 'LOGNAME': 'cltbld', 03:54:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:22 INFO - 'MOZ_NO_REMOTE': '1', 03:54:22 INFO - 'NO_EM_RESTART': '1', 03:54:22 INFO - 'PAGER': '/bin/cat', 03:54:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:54:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:22 INFO - 'PWD': '/builds/slave/test', 03:54:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:54:22 INFO - 'SHELL': '/bin/bash', 03:54:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QklAIHXj6b/Listeners', 03:54:22 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 03:54:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:54:22 INFO - 'USER': 'cltbld', 03:54:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:54:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:54:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:22 INFO - 'XPC_FLAGS': '0x0', 03:54:22 INFO - 'XPC_SERVICE_NAME': '0', 03:54:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:54:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:23 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)) 03:54:23 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)) 03:54:23 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)) 03:54:23 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)) 03:54:23 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)) 03:54:23 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)) 03:54:23 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)) 03:54:23 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)) 03:54:23 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)) 03:54:23 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)) 03:54:23 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)) 03:54:23 INFO - Cleaning up... 03:54:23 INFO - Return code: 0 03:54:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:54: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')]} 03:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54: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')]} 03:54:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10af9cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af9f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5315b8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad7ad30>, '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 0x10aca1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad6fbe8>, '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.21VZBpRpRx/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.QklAIHXj6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 03:54: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'] in /builds/slave/test/build 03:54: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 03:54:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.21VZBpRpRx/Render', 03:54:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:54:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:54:23 INFO - 'HOME': '/Users/cltbld', 03:54:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:54:23 INFO - 'LOGNAME': 'cltbld', 03:54:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:23 INFO - 'MOZ_NO_REMOTE': '1', 03:54:23 INFO - 'NO_EM_RESTART': '1', 03:54:23 INFO - 'PAGER': '/bin/cat', 03:54:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:54:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:23 INFO - 'PWD': '/builds/slave/test', 03:54:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:54:23 INFO - 'SHELL': '/bin/bash', 03:54:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QklAIHXj6b/Listeners', 03:54:23 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 03:54:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:54:23 INFO - 'USER': 'cltbld', 03:54:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:54:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:54:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:23 INFO - 'XPC_FLAGS': '0x0', 03:54:23 INFO - 'XPC_SERVICE_NAME': '0', 03:54:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:54:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:54:23 INFO - Cleaning up... 03:54:23 INFO - Return code: 0 03:54:23 INFO - Running post-action listener: _resource_record_post_action 03:54:23 INFO - Running post-action listener: _start_resource_monitoring 03:54:23 INFO - Starting resource monitoring. 03:54:23 INFO - [mozharness: 2017-04-12 10:54:23.791595Z] Finished create-virtualenv step (success) 03:54:23 INFO - [mozharness: 2017-04-12 10:54:23.792551Z] Running install step. 03:54:23 INFO - Running pre-action listener: _resource_record_pre_action 03:54:23 INFO - Running main action method: install 03:54:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:54:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:54:24 INFO - Reading from file tmpfile_stdout 03:54:24 INFO - Detecting whether we're running mozinstall >=1.0... 03:54:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:54:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:54:24 INFO - Reading from file tmpfile_stdout 03:54:24 INFO - Output received: 03:54:24 INFO - Usage: mozinstall [options] installer 03:54:24 INFO - Options: 03:54:24 INFO - -h, --help show this help message and exit 03:54:24 INFO - -d DEST, --destination=DEST 03:54:24 INFO - Directory to install application into. [default: 03:54:24 INFO - "/builds/slave/test"] 03:54:24 INFO - --app=APP Application being installed. [default: firefox] 03:54:24 INFO - mkdir: /builds/slave/test/build/application 03:54:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:54:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 03:54:38 INFO - Reading from file tmpfile_stdout 03:54:38 INFO - Output received: 03:54:38 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 03:54:38 INFO - Running post-action listener: _resource_record_post_action 03:54:38 INFO - [mozharness: 2017-04-12 10:54:38.775608Z] Finished install step (success) 03:54:38 INFO - [mozharness: 2017-04-12 10:54:38.775752Z] Running run-tests step. 03:54:38 INFO - Running pre-action listener: _resource_record_pre_action 03:54:38 INFO - Running main action method: run_tests 03:54:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:54:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:54:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:54:38 INFO - 2017-04-12 03:54:38.790 screenresolution[1627:7322] starting screenresolution argv=screenresolution get 03:54:38 INFO - 2017-04-12 03:54:38.793 screenresolution[1627:7322] Display 0: 1600x1200x32@60 03:54:38 INFO - 2017-04-12 03:54:38.798 screenresolution[1628:7324] starting screenresolution argv=screenresolution list 03:54:38 INFO - Available Modes on Display 0 03:54:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:54:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:54:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:54:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:54:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:54:39 INFO - Intel Iris: 03:54:39 INFO - Chipset Model: Intel Iris 03:54:39 INFO - Type: GPU 03:54:39 INFO - Bus: Built-In 03:54:39 INFO - VRAM (Dynamic, Max): 1536 MB 03:54:39 INFO - Vendor: Intel (0x8086) 03:54:39 INFO - Device ID: 0x0a2e 03:54:39 INFO - Revision ID: 0x0009 03:54:39 INFO - Displays: 03:54:39 INFO - Display: 03:54:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:54:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:54:39 INFO - Display Serial Number: 1600x1200 60 03:54:39 INFO - Main Display: Yes 03:54:39 INFO - Mirror: Off 03:54:39 INFO - Online: Yes 03:54:39 INFO - Rotation: Supported 03:54:39 INFO - Return code: 0 03:54:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:54:39 INFO - Python 2.7.3 03:54:39 INFO - Return code: 0 03:54:39 INFO - grabbing minidump binary from tooltool 03:54:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:39 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 0x10ad7ad30>, '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 0x10aca1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad6fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:54:39 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 03:54:39 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 03:54:39 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 03:54:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:54:39 INFO - Return code: 0 03:54:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:54:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:54:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:54:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:54:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:54:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YdWBzOXrQZ-JrlsO5mictA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0315', '--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 03:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YdWBzOXrQZ-JrlsO5mictA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0315 --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 03:54:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.21VZBpRpRx/Render', 03:54:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:54:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:54:39 INFO - 'HOME': '/Users/cltbld', 03:54:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:54:39 INFO - 'LOGNAME': 'cltbld', 03:54:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:54:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:54:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:39 INFO - 'MOZ_NO_REMOTE': '1', 03:54:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:54:39 INFO - 'NO_EM_RESTART': '1', 03:54:39 INFO - 'PAGER': '/bin/cat', 03:54:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:54:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:39 INFO - 'PWD': '/builds/slave/test', 03:54:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:54:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:54:39 INFO - 'SHELL': '/bin/bash', 03:54:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QklAIHXj6b/Listeners', 03:54:39 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 03:54:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:54:39 INFO - 'USER': 'cltbld', 03:54:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:54:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:54:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:39 INFO - 'XPC_FLAGS': '0x0', 03:54:39 INFO - 'XPC_SERVICE_NAME': '0', 03:54:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:54:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YdWBzOXrQZ-JrlsO5mictA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0315', '--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 03:54:39 INFO - mozversion application_buildid: 20170412022908 03:54:39 INFO - mozversion application_changeset: 584b429e5c7045cdde5efab444fcefdefbee4fe0 03:54:39 INFO - mozversion application_display_name: Firefox 03:54:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:54:39 INFO - mozversion application_name: Firefox 03:54:39 INFO - mozversion application_remotingname: firefox 03:54:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 03:54:39 INFO - mozversion application_vendor: Mozilla 03:54:39 INFO - mozversion application_version: 53.0 03:54:39 INFO - mozversion platform_buildid: 20170412022908 03:54:39 INFO - mozversion platform_changeset: 584b429e5c7045cdde5efab444fcefdefbee4fe0 03:54:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 03:54:39 INFO - mozversion platform_version: 53.0 03:54:39 INFO - using testdate: 1491994479 03:54:39 INFO - actual date: 1491994479 03:54:39 INFO - starting webserver on 'localhost:49244' 03:54:39 INFO - SUITE-START | Running 2 tests 03:54:39 INFO - TEST-START | dromaeo_css 03:54:39 INFO - operating with platform_type : mac_ 03:54:39 INFO - Initialising browser for dromaeo_css test... 03:54:39 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/tmpS6I4b1/profile http://localhost:49244/getInfo.html) 03:54:42 INFO - PROCESS | 1638 | 2017-04-12 03:54:42.296 plugin-container[1641:7489] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a4f, name = 'com.apple.tsm.portname' 03:54:42 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:54:42 INFO - PROCESS | 1638 | 2017-04-12 03:54:42.296 plugin-container[1641:7489] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 03:54:42 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:54:42 INFO - PROCESS | 1638 | 2017-04-12 03:54:42.296 plugin-container[1641:7489] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:54:42 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 03:54:42 INFO - PROCESS | 1638 | colorDepth:24 03:54:42 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 03:54:42 INFO - PROCESS | 1638 | __metrics 03:54:42 ERROR - PROCESS | 1638 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 03:54:43 INFO - TEST-INFO | 1638: exit 0 03:54:43 INFO - Browser initialized. 03:54:43 INFO - Running cycle 1/1 for dromaeo_css test... 03:54:43 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/tmpS6I4b1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:54:45 INFO - PROCESS | 1642 | 2017-04-12 03:54:45.416 plugin-container[1643:7616] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 03:54:45 INFO - PROCESS | 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:54:45 INFO - PROCESS | 1642 | 2017-04-12 03:54:45.419 plugin-container[1643:7616] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c13, name = 'com.apple.CFPasteboardClient' 03:54:45 INFO - PROCESS | 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:54:45 INFO - PROCESS | 1642 | 2017-04-12 03:54:45.419 plugin-container[1643:7616] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:54:55 INFO - PROCESS | 1642 | RSS: Main: 172806144 03:54:55 INFO - PROCESS | 1642 | 03:57:56 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 03:57:58 INFO - PROCESS | 1642 | RSS: Main: 190406656 03:57:58 INFO - PROCESS | 1642 | 04:01:00 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 04:01:01 INFO - PROCESS | 1642 | RSS: Main: 205627392 04:01:01 INFO - PROCESS | 1642 | 04:04:02 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 04:04:03 INFO - PROCESS | 1642 | RSS: Main: 205254656 04:04:03 INFO - PROCESS | 1642 | 04:07:05 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 04:07:05 INFO - PROCESS | 1642 | RSS: Main: 208400384 04:07:05 INFO - PROCESS | 1642 | 04:10:08 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 04:10:09 INFO - PROCESS | 1642 | RSS: Main: 209534976 04:10:09 INFO - PROCESS | 1642 | 04:13:12 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 04:13:12 INFO - PROCESS | 1642 | RSS: Main: 210677760 04:13:12 INFO - PROCESS | 1642 | 04:13:12 INFO - PROCESS | 1642 | __start_tp_report 04:13:12 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 04:13:12 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 04:13:12 INFO - PROCESS | 1642 | |i|pagename|runs| 04:13:12 INFO - PROCESS | 1642 | |0;dojo.html;3530.894073177805;3537.5931767846705;3552.413851714468;3557.804320762357;3585.282943411317;5880.764769409224;5969.5821292509545;5977.671228082454;5994.190784244126;6013.699315034247;5964.463198312151;6050.8789824203595;6062.878742425149;6076.361981991893;6103.359147289526;5298.549623282016;5362.919556206641;5367.597430192732;5399.055165346068;5457.945420545803;4449.065696203801;5339.733013349336;5425.186222066702;5452.100403433429;5478.808241711541;5197.818076367309;5224.320838291036;5270.631055826094;5321.627486075976;5361.303030606015;5212.609054320941;5283.735813209362;5290.074237008546;5308.389535203462;5330.333708286465;5209.192575150858;5233.058049551079;5244.763985620656;5246.108161612535;5257.263983042377;5701.14482827575;5765.221695071154;5816.767329306823;5846.7368968396095;5951.137085122633;6165.815025549241;6212.751489940397;6246.219222597176;6295.464885484739;6306.0225665022;6301.968490157566;6305;6319.8104056878365;6320.051992201161;6327.8418039548915;5790.652560846363;6089.573729838913;6103.38966103395;6111.297200821918;6114.785982490636;6154.5384096192965;6327.905081423783;6353.396427339488;6373.5857169283845;6487.18910136233;6210.285817130997;6257;6268.9969604863;6270.874582508324;6280.246370435577;6261.5616906816995;6344.777932772331;6351.142595749515;6354.682265886687;6360.109584658151;6185.381461853869;6187.721552530147;6205.81382558524;6220.7511699532415;6275.090111933835;6263.498920086382;6272.278687950853;6283.937160628335;6300.117983482316;6313;5122.334096567422;5153.716545589954;5173.793048278102;5177.068127736969;5179.689218646893;3593.8023408712247;4446.110777844444;4546.840860569864;4553.977230113895;4629.537046295343;6116.920625435767;6126.120738204555;6131.193168498116;6133.662648554283;6148.770245950827;6207.81376558704;6347.904781428282;6372.2671892732005;6381.1385462962835;6384.808455746335;4771.355866957986;4957.7769000395065;5283.867903302371;5392.8674978255;6085.939140608537;5632.070708333161;5645.830625081254;5647;5661.1508273758445;5668.461496157858;6530.640814755234;6544.181977252843;6546.803595892131;6547.214334279917;6553.115329430466;5606.299212598426;5966.134910438049;6187.319394866471;6316.273628532777;6328.968355158195;6484.254310754323;6494.383033611799;6500.934990650033;6518.2504012037325;6523.902141467976;6272.153259310117;6281.403266689657;6287.654179020198;6290.433860952537;6310.905336419865;6117.602355846856;6208.689565521616;6223.813285601439;6284.402981716729;6319.3364696706185;5160.303359046481;5553.805616803393;6001.099835024606;6192.225971753531;6250.562460627712;6230.937690623035;6235.189425374853;6247.437730604267;6248.375162483715;6274.278457977209;6003.459688628044;6118.253719382578;6191.876162476815;6201.81394558164;6227.003679411272;5191.76637051326;6163.907541386972;6198.752049917953;6245.250569931637;6249;6242.375762423721;6244.937550624617;6247.094171345038;6260.311365749855;6263.311035785969 04:13:12 INFO - PROCESS | 1642 | |1;ext.html;469.39682507977244;483.9830605928793;489.4958193061147;494.6018455143608;559.583110582616;40315.59684403155;43394.56605433945;43533.782331088376;43591.56408435915;43641;44396.77801610996;44850.32724509135;44877;44976.55023449765;45026.32460513095;9451.196648284887;9677.177439917616;9695.418274903494;11470.713232169179;11886;11588.362640054793;11601.129915256348;11719.355435451047;11735.471903764308;11743.41282935854;11632.883671163265;11692.473838677237;11708.473118709679;11708.824367634492;11763.117766167528;11583.594574189947;11608.129390295719;11667.183297169202;11676.416179191006;11727.472263748152;11703.648890533297;11773.764524709457;11779;11780.764384712344;11794.05647548194;38726;39079.023024424336;39094.60905390938;39133;39219;3681.3189559931498;3879.1465877506903;3967.226390853785;3980.0845805464905;4049.8785036448953;28765.85617071922;29336.266593335124;30166;30485.932992345162;31043.534346984812;3338.7996720196866;3347.878460715663;3366.1416338833687;3387.1532116970757;3393.2365217826036;407805;409655;411711;416031;417748;59273.70363148156;59484.10773838396;59532;59539.40460595339;59807.401925980186;56434.717826410604;62009;62301.065484017774;62343;62694.37305626977;14930.477433289783;17130;17311.913440432716;17336.566585835455;17608.91195544014;12189.69525761863;12496.125271231109;13095.410706518229;13274.469021239236;13361.26513041792;15660.921695391678;19141;19142.42572722793;19146.138423770964;19216.903915480332;7047.365737083687;7145.571265723969;8045.517268963881;8096.878546821802;8105.528768081522;802.6789284286332;859.2095272349453;898.9101089890959;900.7342833864026;918.7611221082567;27109.611298587675;30352.39295214083;31165.68834311628;31258.062258132293;31662.68337316597;1047.5652604169184;1065.3820783945293;1102.873169585492;1116.179607988128;1142.9771404571861;16001.199940002953;16091.919540402223;16187.433439829785;16235.918820405823;17017;678681;699947;703014;705953;706093;49276.75361623169;55953.60115997051;57392.42607573871;57994.84010319854;58200.12699809506;1419.9290035498184;1456.5226018970654;1465.7068586282574;1483.480781726387;1501.4444655477544;28993.98521051753;30210.54684179695;30321.393572128876;30454.695453045188;30531.847340763154;50517;50927.23609145792;51267.48732512627;51365.7431712839;51387;623841;626797;627430;629576;630261.5460768001;26703.732962670903;27111.86444067767;27948;28035.299117522227;28819.135425937257;45866;46434.071318572765;47627.80930476627;47642.52357476381;47682.28476572924;31356.216094597818;31503.527447087854;31563.684363156073;32369.190770230933;32991.83504082464;31645.20886977844;31737.523937141425;31862;32233.194170144994;32404.351912961138;37168.628313716516;37888.43167352547;37922.43116353202;37967.24065518729;37983.10084495709;31163.84418077986;31608.841955790074;31755.72977080891;32236.35527289488;32657;20891.8955405222;23387.298381048597;24982.757679655602;25332.746672533038;26248.73751262463 04:13:12 INFO - PROCESS | 1642 | |2;jquery.html;384.44255829047887;391.0360960233025;397.58055251709453;399.06220382102055;405.70789031897044;17412.738808917846;20535.178592856286;20845.791542084575;21039.47401314968;21941.012654430568;21113.894430527827;21118.788812111874;21290.680639790415;21325.57348853022;21326.57346853066;4964.602831773458;5315.202719592054;6164.10620460033;6196.380361963813;6214.40963108504;5846.356900740915;6001.549883758714;6011.489023432991;6063.151158837766;6109.297430795471;5909.822705318826;5971.671558064305;6029.336772954972;6032.819015429544;6058.121572372003;5773.971130144364;5949.7025148742605;5974.163617093611;6030.728617212214;6032.27612686476;5237.952409518111;5323.467653234684;5326.92009619856;5328.120860058086;5329.600279979017;26862.5970610441;27141.1857644269;27242.863785680944;27280;27317.726822731718;2820.2385355953984;3052.4963381042103;3149.322895577439;3160.0993716790604;3192.4892017277125;7788.922110778876;15547.92226038874;16527.091009994445;16663.750043749355;16837.83162168375;1857.2756624916294;1894.7536820213284;1896.943091707251;1908.1604094198508;1910.3218357483033;108108;125708;125815.37092314572;126707;129403;11367.886321136682;11822.290662560274;11912.583059592873;11923.284602923852;11946.223495472766;12480.875191248153;14110;15125.697486050218;15185.392584296726;15207;7803.648835802403;8758.386912916034;9061.501617411106;9165.991740908496;9301;9246.352755307198;9283.860742088875;9298.256139508958;9302.53487325631;9390.85913711295;6653.178702272199;7419.332260096618;7489.28851759082;7503.362214211744;7509.249075092556;1782.4652604218682;1896.194117500057;1995.4911497568028;2002.149086638173;2015.8790472571693;852.5438890193717;896.7489103051156;1076.3918386111823;1091.3506463654114;1122.5229277557169;22544.970952614345;22992.08031678714;23115.53768924612;23538;23567.882160589088;1076.1928553584812;1086.7174534620897;1116.7878103160374;1121.7251773315427;1125.7973564758422;10562.20783441245;11854.288742675468;12175.512979480722;12359.25844449336;12574.622761317176;739374;744101;746510;766147;792242;117316.8268317323;130425;138039.30980345234;144922;148287.25856370866;1019.9643012494527;1028.4600584693096;1044.154235069596;1045.3675526306627;1048.4757621189558;17827.376041838474;19518.707219391436;20574.382768516967;20765;20770.273040443513;59275;59637.70181149067;60182;61013.77972440615;61458.69270653618;67163.66418168074;80342;83208.16791832005;87252.56373718091;88887.55556222178;8113.269805717514;8245.628946697532;8308.750737477885;8520.829583408422;8620.267277281251;10156.898431015596;12953.805692914426;13273.800892986807;13329.333533323488;13653.522126725517;9367.484788336707;11343.376114313793;11672.88327116718;11889.167758256839;11893;10235.795284094425;10467.476626168813;10485.423301718478;10547.525361358605;10870.782584348111;11497.425128743696;11615.76768464643;11896.345700986183;11913.52345906154;11930.880691192977;7311.9032145176525;7744.92255077442;7793.220677932161;7871.134175240833;8693.04376518595;10244.743881403025;10495.47522623881;11335.716607084889;11339.943300283447;11598.594049208237 04:13:12 INFO - PROCESS | 1642 | |3;mootools.html;1448.7030158817442;1480.8815294776418;1484.3617244584832;1490.9403623855046;1500.5573355860022;7647.961760191191;7883.763487095382;8124.187581241873;8590.355723320745;8606.91393086069;8106.392020598464;8380.078191398941;8429.199226073513;8510.234078932895;8512.787180320494;2391.940201494959;2416.5770990076753;2421.2978236311537;2425.1875621666763;2429.3805079704653;2407.67496387988;2413.3242692046256;2427.78149966503;2439.1584903208363;2454.8527088374667;2395.6646069550275;2400.027988664585;2416.4321384474633;2420.3828023853894;2425.126954296452;2217.5897458970144;2279.87460689662;2289.667998140277;2309.445733024079;2356.399118224842;2379.4408314046186;2382.2614989353356;2402.2793162051316;2402.6636270922086;2414.4446777241333;8477.703280385218;8499.320054395634;8543.786405339853;8545.145485451467;8581.39930204886;5169.4313625501545;5275.736213189363;5295.443978382253;5345.946540534584;5353;2993.880244790206;3314.939219449777;3375.561177046968;3554.751167418282;3603.423452247654;1235.1292338901053;1247.2329517346857;1260.823484712141;1294.411042975444;1320.1682939747993;10761.461926903623;10904.400257985808;10909.454527273605;10918.50866710992;10946.562137514411;3464.34177506273;3830.942535861964;4715.221988371949;4775.641826863;4853.684510506806;9392.34253602255;9487.810243795086;9512.667056652985;9535.094166054352;9536;5344.679319240858;5372.274742909735;5381.139017757218;5385.6230063895155;5396.055690254189;4400.44994375703;4408.625266852354;4884.8290309838985;4886.486918873467;4938.38270216223;3857.6528112470014;3931.6461518463475;3958.1094253792667;3996.2806694794635;4021.376686613521;1322.5701646964776;1330.1154732103043;1332.7867541193364;1335.692790658154;1339.5311640925597;928.8467402878449;934.1779234273796;943.1652987106323;945.7351941456403;992.6972273456665;5490.835274941758;5575.749091290902;5780.826575202751;5852.912206316909;5858.677772722541;553.4990833295874;563.0512586292111;573.5870173475091;590.0794760174142;596.5913349355706;3332.5501057357433;3339.5992480902446;3703.222323312081;3801.6008319126645;3817.408301713239;9724.611015559298;10049.598016079275;10058.994100589882;10084.394936303699;10107.241956853119;9488.430694158373;9895.65365212214;9947.303688741718;10054.145397641283;10128.746781330377;7896.565688887166;8071.394645401619;8082.232187942136;8101.8379632408205;8113.6754529818145;5820.621659592113;5885.882282354414;5905.527557795452;5927.496162826208;6066.605670631395;9181.173694367539;9188.908110918805;9294.395864268801;9347.813043738952;9374.718758437259;9365.85951210746;9377.81244375095;9396.479796575066;9456.905430945602;9495.715128546155;6281.811545653638;6440.710168042543;7056.823579410556;7201.675924583511;7325.194228634952;6660.300668429745;7996.000499937508;8038.87941680887;8072.919270807217;8079.1516890725625;6893.965530172317;7000.299970002959;7004.264552221944;7008.964955175192;7115.146182457931;6850.143732033496;6868.622225777431;6904.827379315558;6907.861842763217;6951.27011663768;6344.524160688059;6454.354564543508;6517.761625291179;6523.054157147282;6527.445167160845;5073.771680274471;5077.39071311445;5120.18077107661;5125.128728116304;5157.252198431132;4981.850544483671;5021.046001259749;5115.4884511550035;5201.985612805618;5231.529162375405 04:13:12 INFO - PROCESS | 1642 | |4;prototype.html;318.79437762643096;371.41131306878594;381.6260065136166;385.19878652403;387.519475849946;5430.945690543093;5586.329640443152;5624.240727501786;5670.950874088291;5687.175359572864;5000.524950129741;5061.772220250088;5253.896681696839;5502.449755024496;5593.133064375028;3809.657130858222;4378.802953867068;4420.513743488214;4430.136123455927;4435.467743870724;3678.889633311005;3748.800383877147;3986.760794352348;4400.44994375703;4421.778911054451;3673.412254039354;3686.3411464840797;3839.2513459875336;4119.958800412002;4167.812448439812;4173.1862286854075;4201.327787553977;4231.920860180634;4248.723832950864;4271.402003719481;3648.4892115103908;3659.505966694489;3676.6323367663285;3679.6688298053305;3690;5129.153504738291;5181.4300426953005;5372.489613486712;5398.136298192309;5426.945730542683;4867.610591152699;4882.292067650171;4908.312836202935;4911.16510193268;4931.876703082416;4499.932501012488;5043.7922175823605;5922.940770592282;5923.911141332884;5928.614640048383;3725.8882233533036;3922.7450215735885;4006.6794656427414;4010.5387880393837;4048.5344185418758;5473.753681084321;5686.658800471985;6173.117199254226;6224.782132625382;6245.687715614246;3466.532018177564;3777.471154038382;4059.7767122807936;4083.469149010669;4106.445629839934;3688.7417880748626;3828.3683192272965;4113.259613269581;4155.8337666493;4164.208800327928;4442.977785111054;4564.612007979293;4883.755812209375;4884.804607815719;4905.779239934212;5069.543741063322;5472.644278121989;5793.188953546507;6049.667268300285;6074.84343058208;1080.6217823761779;1157.766978168265;1299.2204677193797;1348.359529223611;1367.357342049255;786.622421237809;808.5552945879742;909.8498747706554;914.8307563100715;914.9679761208325;4789.425268967677;5137.6660517066275;5355.571554275649;5384.380796208487;5408.215808707715;5549.694766787866;5855.795047173328;5907.556933230025;5935.2697759031325;6014.909776353358;4532.9773351133035;5031.396232452129;5351.57187425005;5352.545033672103;5361.115415956324;2770.34896799252;3013.789034767589;3060.4491191585284;3077.3076057886797;3121.734652554558;5138.845834624967;5462.453754624506;5903.797367211994;6211.378862113753;6282.811515654537;4981.12830254704;5097.668651537638;5273.367195936512;5911.881762364728;5960.211936419057;5214.687118772886;5618.4662457066515;5902.822915312548;5908.586398952118;6161.260648722093;4476.753778542081;5786.884262314814;5874.971879921082;5880.295064270484;5904.793332233351;5638.83083507479;5666.036773748555;5756.222909907109;5852.985712358224;5882.588218824641;4982.451930287738;5000.7999680013845;5334.973325133505;5495.241522712694;6116.449519543263;3537.4163263062337;3880.3225774215703;3900.434437006675;3923.588023257631;4149.460570125864;5735.9139612905;6082.513398927987;6097.926704920348;6126.724297406538;6127.325994140552;5158.3552055993005;5600.85997850057;5706;5879.764809407576;5912.438318359749;5100.770465328995;5378.515933565998;5733.559864081518;5796.014677504919;5923.733431995657;5343.519083282523;5475.342958844964;5725.997950358754;5810.1575271586225;5815.79644712433;5896.7936122235515;6031.819045428644;6049.879002419839;6107.656315610736;6190;4630.953690463187;4924.556789888928;5692.231548740867;5865.794697185749;5926.644401335761 04:13:12 INFO - PROCESS | 1642 | |5;yui.html;739.1130643228124;743.271593838039;777.1024466740917;843.5360551696566;853.7097386888458;15161.09033457992;15474.61313467164;16030.198490075509;16164.272607732652;16168.75746863798;12670;12787.552435664753;12797;12911.612651620442;13001.349932503384;875.1598465473138;899.8920129584459;900.7883147460342;901.3104974694364;902.1339514066505;867.5662168915542;875.374107513128;878.2841983783196;901.8151278987792;908.0737647599444;822.8642274024779;951.0632027452954;951.6764300137952;951.6907005223295;953.6995846308425;925.3291363761219;943.2501161576563;946.6592026870321;947.4031360243038;951.3625870666635;705.2383425900016;705.4427002667886;705.6330708031795;705.6930235347589;707.2220557386885;15844.970076945077;15889.28498217583;16028.278727457293;16127.516174514783;16278;11393.54425822966;14433.422663093465;14582.562523124323;14636.634084147876;14711.779323310158;11904.880951190551;12043.397830108459;12107.031437485068;12114.81827772584;12635.241885486901;3755.1550901047317;3857.1321452672923;3881.9223615527812;3883.417487376888;4002.699797515169;97370;115076.27385589307;116143;119723;119850;11122.610708625321;11225;11313.717157070974;11338.206325557298;11697.064234861191;22881.855907204907;22983.310500685006;23554.7644523556;23647.881760591088;23668.408289792547;8134.186581341818;8136.064352599408;8155.021397432228;8169.0605580359015;8202.958985205156;4344.261475549164;4380.014496738208;4407.779611019436;4436.290193569013;4620.792064357112;3618.5295911531334;3678.393065144221;3686.9631303687156;3692.48305237267;3702.352088384576;666.1440049536322;669.926308106108;682.6006786030227;684.2199892122984;697.5361384679233;628.8152346136469;644.6035688051908;668.8929771236578;678.3318431345122;682;8755.518446485505;9921.206303495703;9927.106560409598;10164.847527287096;10213.948930255301;640.6060272932207;644.9484041276687;645.9257185423736;684.2712511175681;697.9127609048869;4227.894302642397;4422.84520041797;4606.930896036562;4898.289747986522;4924.162892308316;77245;107589.4620526908;109584;110638.44680776545;113741;61772.69113654493;63447.36552634415;69058;79101.60449197717;97655;73073.6346318265;74831.25168748242;75471.24528754642;76171.47657046828;77549;10893.400862952614;10967.616133435291;11266.098712103176;11312.246601776738;11388.316700997966;48732.75633621951;50970;51245;52971.73514132559;53491.6627084326;73484.63257683677;74474.62762686369;74895.25104749101;74979.25020749723;75248.87126693214;13430.93284533571;13440.865591343962;13833.515826946008;13838.515651952133;14013.5095271665;15005.403690373396;15113.06788039253;15207.695846083237;15244.466443674419;15515.069095854285;13962.511312104027;13997.720045599235;14116.435342586592;14195.929020355245;14949.85050149528;13848.09987350819;13958.58124256274;14165.150090994573;14357.56927292183;14977.550673479813;13869.653258668613;13903.235322057384;14074.944379171398;14241.430342786172;14438.133711977314;9503.988555874508;9830.164436023018;10095;10184.643537476153;10201.132903703268;9169.807924969711;9817.410955342702;10712.678619641423;11118.722031948942;11385.975262226439 04:13:12 INFO - PROCESS | 1642 | __end_tp_report 04:13:12 INFO - PROCESS | 1642 | __start_cc_report 04:13:12 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,370 04:13:12 INFO - PROCESS | 1642 | __end_cc_report 04:13:12 INFO - PROCESS | 1642 | __startTimestamp1491995592334__endTimestamp 04:13:12 INFO - PROCESS | 1642 | 04:13:12 INFO - PROCESS | 1642 | ------- Summary: start ------- 04:13:12 INFO - PROCESS | 1642 | Number of tests: 6 04:13:12 INFO - PROCESS | 1642 | 04:13:12 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5845.44 Median:6133.66 stddev:663.49 (10.8%) stddev-sans-first:640.20 04:13:12 INFO - PROCESS | 1642 | Values: 3530.9 3537.6 3552.4 3557.8 3585.3 5880.8 5969.6 5977.7 5994.2 6013.7 5964.5 6050.9 6062.9 6076.4 6103.4 5298.5 5362.9 5367.6 5399.1 5457.9 4449.1 5339.7 5425.2 5452.1 5478.8 5197.8 5224.3 5270.6 5321.6 5361.3 5212.6 5283.7 5290.1 5308.4 5330.3 5209.2 5233.1 5244.8 5246.1 5257.3 5701.1 5765.2 5816.8 5846.7 5951.1 6165.8 6212.8 6246.2 6295.5 6306.0 6302.0 6305.0 6319.8 6320.1 6327.8 5790.7 6089.6 6103.4 6111.3 6114.8 6154.5 6327.9 6353.4 6373.6 6487.2 6210.3 6257.0 6269.0 6270.9 6280.2 6261.6 6344.8 6351.1 6354.7 6360.1 6185.4 6187.7 6205.8 6220.8 6275.1 6263.5 6272.3 6283.9 6300.1 6313.0 5122.3 5153.7 5173.8 5177.1 5179.7 3593.8 4446.1 4546.8 4554.0 4629.5 6116.9 6126.1 6131.2 6133.7 6148.8 6207.8 6347.9 6372.3 6381.1 6384.8 4771.4 4957.8 5283.9 5392.9 6085.9 5632.1 5645.8 5647.0 5661.2 5668.5 6530.6 6544.2 6546.8 6547.2 6553.1 5606.3 5966.1 6187.3 6316.3 6329.0 6484.3 6494.4 6500.9 6518.3 6523.9 6272.2 6281.4 6287.7 6290.4 6310.9 6117.6 6208.7 6223.8 6284.4 6319.3 5160.3 5553.8 6001.1 6192.2 6250.6 6230.9 6235.2 6247.4 6248.4 6274.3 6003.5 6118.3 6191.9 6201.8 6227.0 5191.8 6163.9 6198.8 6245.3 6249.0 6242.4 6244.9 6247.1 6260.3 6263.3 04:13:12 INFO - PROCESS | 1642 | 04:13:12 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:71021.92 Median:32824.42 stddev:158717.86 (483.5%) stddev-sans-first:159074.71 04:13:12 INFO - PROCESS | 1642 | Values: 469.4 484.0 489.5 494.6 559.6 40315.6 43394.6 43533.8 43591.6 43641.0 44396.8 44850.3 44877.0 44976.6 45026.3 9451.2 9677.2 9695.4 11470.7 11886.0 11588.4 11601.1 11719.4 11735.5 11743.4 11632.9 11692.5 11708.5 11708.8 11763.1 11583.6 11608.1 11667.2 11676.4 11727.5 11703.6 11773.8 11779.0 11780.8 11794.1 38726.0 39079.0 39094.6 39133.0 39219.0 3681.3 3879.1 3967.2 3980.1 4049.9 28765.9 29336.3 30166.0 30485.9 31043.5 3338.8 3347.9 3366.1 3387.2 3393.2 407805.0 409655.0 411711.0 416031.0 417748.0 59273.7 59484.1 59532.0 59539.4 59807.4 56434.7 62009.0 62301.1 62343.0 62694.4 14930.5 17130.0 17311.9 17336.6 17608.9 12189.7 12496.1 13095.4 13274.5 13361.3 15660.9 19141.0 19142.4 19146.1 19216.9 7047.4 7145.6 8045.5 8096.9 8105.5 802.7 859.2 898.9 900.7 918.8 27109.6 30352.4 31165.7 31258.1 31662.7 1047.6 1065.4 1102.9 1116.2 1143.0 16001.2 16091.9 16187.4 16235.9 17017.0 678681.0 699947.0 703014.0 705953.0 706093.0 49276.8 55953.6 57392.4 57994.8 58200.1 1419.9 1456.5 1465.7 1483.5 1501.4 28994.0 30210.5 30321.4 30454.7 30531.8 50517.0 50927.2 51267.5 51365.7 51387.0 623841.0 626797.0 627430.0 629576.0 630261.5 26703.7 27111.9 27948.0 28035.3 28819.1 45866.0 46434.1 47627.8 47642.5 47682.3 31356.2 31503.5 31563.7 32369.2 32991.8 31645.2 31737.5 31862.0 32233.2 32404.4 37168.6 37888.4 37922.4 37967.2 37983.1 31163.8 31608.8 31755.7 32236.4 32657.0 20891.9 23387.3 24982.8 25332.7 26248.7 04:13:12 INFO - PROCESS | 1642 | 04:13:12 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:40591.04 Median:22242.99 stddev:125482.56 (564.1%) stddev-sans-first:125798.26 04:13:12 INFO - PROCESS | 1642 | Values: 384.4 391.0 397.6 399.1 405.7 17412.7 20535.2 20845.8 21039.5 21941.0 21113.9 21118.8 21290.7 21325.6 21326.6 4964.6 5315.2 6164.1 6196.4 6214.4 5846.4 6001.5 6011.5 6063.2 6109.3 5909.8 5971.7 6029.3 6032.8 6058.1 5774.0 5949.7 5974.2 6030.7 6032.3 5238.0 5323.5 5326.9 5328.1 5329.6 26862.6 27141.2 27242.9 27280.0 27317.7 2820.2 3052.5 3149.3 3160.1 3192.5 7788.9 15547.9 16527.1 16663.8 16837.8 1857.3 1894.8 1896.9 1908.2 1910.3 108108.0 125708.0 125815.4 126707.0 129403.0 11367.9 11822.3 11912.6 11923.3 11946.2 12480.9 14110.0 15125.7 15185.4 15207.0 7803.6 8758.4 9061.5 9166.0 9301.0 9246.4 9283.9 9298.3 9302.5 9390.9 6653.2 7419.3 7489.3 7503.4 7509.2 1782.5 1896.2 1995.5 2002.1 2015.9 852.5 896.7 1076.4 1091.4 1122.5 22545.0 22992.1 23115.5 23538.0 23567.9 1076.2 1086.7 1116.8 1121.7 1125.8 10562.2 11854.3 12175.5 12359.3 12574.6 739374.0 744101.0 746510.0 766147.0 792242.0 117316.8 130425.0 138039.3 144922.0 148287.3 1020.0 1028.5 1044.2 1045.4 1048.5 17827.4 19518.7 20574.4 20765.0 20770.3 59275.0 59637.7 60182.0 61013.8 61458.7 67163.7 80342.0 83208.2 87252.6 88887.6 8113.3 8245.6 8308.8 8520.8 8620.3 10156.9 12953.8 13273.8 13329.3 13653.5 9367.5 11343.4 11672.9 11889.2 11893.0 10235.8 10467.5 10485.4 10547.5 10870.8 11497.4 11615.8 11896.3 11913.5 11930.9 7311.9 7744.9 7793.2 7871.1 8693.0 10244.7 10495.5 11335.7 11339.9 11598.6 04:13:12 INFO - PROCESS | 1642 | 04:13:12 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:5476.49 Median:5349.47 stddev:2974.75 (55.6%) stddev-sans-first:2967.70 04:13:12 INFO - PROCESS | 1642 | Values: 1448.7 1480.9 1484.4 1490.9 1500.6 7648.0 7883.8 8124.2 8590.4 8606.9 8106.4 8380.1 8429.2 8510.2 8512.8 2391.9 2416.6 2421.3 2425.2 2429.4 2407.7 2413.3 2427.8 2439.2 2454.9 2395.7 2400.0 2416.4 2420.4 2425.1 2217.6 2279.9 2289.7 2309.4 2356.4 2379.4 2382.3 2402.3 2402.7 2414.4 8477.7 8499.3 8543.8 8545.1 8581.4 5169.4 5275.7 5295.4 5345.9 5353.0 2993.9 3314.9 3375.6 3554.8 3603.4 1235.1 1247.2 1260.8 1294.4 1320.2 10761.5 10904.4 10909.5 10918.5 10946.6 3464.3 3830.9 4715.2 4775.6 4853.7 9392.3 9487.8 9512.7 9535.1 9536.0 5344.7 5372.3 5381.1 5385.6 5396.1 4400.4 4408.6 4884.8 4886.5 4938.4 3857.7 3931.6 3958.1 3996.3 4021.4 1322.6 1330.1 1332.8 1335.7 1339.5 928.8 934.2 943.2 945.7 992.7 5490.8 5575.7 5780.8 5852.9 5858.7 553.5 563.1 573.6 590.1 596.6 3332.6 3339.6 3703.2 3801.6 3817.4 9724.6 10049.6 10059.0 10084.4 10107.2 9488.4 9895.7 9947.3 10054.1 10128.7 7896.6 8071.4 8082.2 8101.8 8113.7 5820.6 5885.9 5905.5 5927.5 6066.6 9181.2 9188.9 9294.4 9347.8 9374.7 9365.9 9377.8 9396.5 9456.9 9495.7 6281.8 6440.7 7056.8 7201.7 7325.2 6660.3 7996.0 8038.9 8072.9 8079.2 6894.0 7000.3 7004.3 7009.0 7115.1 6850.1 6868.6 6904.8 6907.9 6951.3 6344.5 6454.4 6517.8 6523.1 6527.4 5073.8 5077.4 5120.2 5125.1 5157.3 4981.9 5021.0 5115.5 5202.0 5231.5 04:13:12 INFO - PROCESS | 1642 | 04:13:12 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4682.70 Median:5198.06 stddev:1440.58 (27.7%) stddev-sans-first:1406.89 04:13:12 INFO - PROCESS | 1642 | Values: 318.8 371.4 381.6 385.2 387.5 5430.9 5586.3 5624.2 5671.0 5687.2 5000.5 5061.8 5253.9 5502.4 5593.1 3809.7 4378.8 4420.5 4430.1 4435.5 3678.9 3748.8 3986.8 4400.4 4421.8 3673.4 3686.3 3839.3 4120.0 4167.8 4173.2 4201.3 4231.9 4248.7 4271.4 3648.5 3659.5 3676.6 3679.7 3690.0 5129.2 5181.4 5372.5 5398.1 5426.9 4867.6 4882.3 4908.3 4911.2 4931.9 4499.9 5043.8 5922.9 5923.9 5928.6 3725.9 3922.7 4006.7 4010.5 4048.5 5473.8 5686.7 6173.1 6224.8 6245.7 3466.5 3777.5 4059.8 4083.5 4106.4 3688.7 3828.4 4113.3 4155.8 4164.2 4443.0 4564.6 4883.8 4884.8 4905.8 5069.5 5472.6 5793.2 6049.7 6074.8 1080.6 1157.8 1299.2 1348.4 1367.4 786.6 808.6 909.8 914.8 915.0 4789.4 5137.7 5355.6 5384.4 5408.2 5549.7 5855.8 5907.6 5935.3 6014.9 4533.0 5031.4 5351.6 5352.5 5361.1 2770.3 3013.8 3060.4 3077.3 3121.7 5138.8 5462.5 5903.8 6211.4 6282.8 4981.1 5097.7 5273.4 5911.9 5960.2 5214.7 5618.5 5902.8 5908.6 6161.3 4476.8 5786.9 5875.0 5880.3 5904.8 5638.8 5666.0 5756.2 5853.0 5882.6 4982.5 5000.8 5335.0 5495.2 6116.4 3537.4 3880.3 3900.4 3923.6 4149.5 5735.9 6082.5 6097.9 6126.7 6127.3 5158.4 5600.9 5706.0 5879.8 5912.4 5100.8 5378.5 5733.6 5796.0 5923.7 5343.5 5475.3 5726.0 5810.2 5815.8 5896.8 6031.8 6049.9 6107.7 6190.0 4631.0 4924.6 5692.2 5865.8 5926.6 04:13:12 INFO - PROCESS | 1642 | 04:13:12 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:20650.16 Median:4115.30 stddev:29642.01 (720.3%) stddev-sans-first:29687.46 04:13:12 INFO - PROCESS | 1642 | Values: 739.1 743.3 777.1 843.5 853.7 15161.1 15474.6 16030.2 16164.3 16168.8 12670.0 12787.6 12797.0 12911.6 13001.3 875.2 899.9 900.8 901.3 902.1 867.6 875.4 878.3 901.8 908.1 822.9 951.1 951.7 951.7 953.7 925.3 943.3 946.7 947.4 951.4 705.2 705.4 705.6 705.7 707.2 15845.0 15889.3 16028.3 16127.5 16278.0 11393.5 14433.4 14582.6 14636.6 14711.8 11904.9 12043.4 12107.0 12114.8 12635.2 3755.2 3857.1 3881.9 3883.4 4002.7 97370.0 115076.3 116143.0 119723.0 119850.0 11122.6 11225.0 11313.7 11338.2 11697.1 22881.9 22983.3 23554.8 23647.9 23668.4 8134.2 8136.1 8155.0 8169.1 8203.0 4344.3 4380.0 4407.8 4436.3 4620.8 3618.5 3678.4 3687.0 3692.5 3702.4 666.1 669.9 682.6 684.2 697.5 628.8 644.6 668.9 678.3 682.0 8755.5 9921.2 9927.1 10164.8 10213.9 640.6 644.9 645.9 684.3 697.9 4227.9 4422.8 4606.9 4898.3 4924.2 77245.0 107589.5 109584.0 110638.4 113741.0 61772.7 63447.4 69058.0 79101.6 97655.0 73073.6 74831.3 75471.2 76171.5 77549.0 10893.4 10967.6 11266.1 11312.2 11388.3 48732.8 50970.0 51245.0 52971.7 53491.7 73484.6 74474.6 74895.3 74979.3 75248.9 13430.9 13440.9 13833.5 13838.5 14013.5 15005.4 15113.1 15207.7 15244.5 15515.1 13962.5 13997.7 14116.4 14195.9 14949.9 13848.1 13958.6 14165.2 14357.6 14977.6 13869.7 13903.2 14074.9 14241.4 14438.1 9504.0 9830.2 10095.0 10184.6 10201.1 9169.8 9817.4 10712.7 11118.7 11386.0 04:13:12 INFO - PROCESS | 1642 | -------- Summary: end -------- 04:13:12 INFO - PROCESS | 1642 | 04:13:12 INFO - TEST-INFO | 1642: exit 0 04:13:12 INFO - TEST-OK | dromaeo_css | took 1113534ms 04:13:12 INFO - TEST-START | kraken 04:13:12 INFO - operating with platform_type : mac_ 04:13:12 INFO - Initialising browser for kraken test... 04:13:12 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/tmpNb4Ahk/profile http://localhost:49244/getInfo.html) 04:13:15 INFO - PROCESS | 1654 | 2017-04-12 04:13:15.493 plugin-container[1656:9891] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x423f, name = 'com.apple.tsm.portname' 04:13:15 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:13:15 INFO - PROCESS | 1654 | 2017-04-12 04:13:15.493 plugin-container[1656:9891] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 04:13:15 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:13:15 INFO - PROCESS | 1654 | 2017-04-12 04:13:15.494 plugin-container[1656:9891] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:13:15 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 04:13:15 INFO - PROCESS | 1654 | colorDepth:24 04:13:15 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 04:13:15 INFO - PROCESS | 1654 | __metrics 04:13:15 ERROR - PROCESS | 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 04:13:16 INFO - TEST-INFO | 1654: exit 0 04:13:16 INFO - Browser initialized. 04:13:16 INFO - Running cycle 1/1 for kraken test... 04:13:16 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/tmpNb4Ahk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:13:18 INFO - PROCESS | 1657 | 2017-04-12 04:13:18.840 plugin-container[1658:10012] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8443, name = 'com.apple.tsm.portname' 04:13:18 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:13:18 INFO - PROCESS | 1657 | 2017-04-12 04:13:18.841 plugin-container[1658:10012] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4607, name = 'com.apple.CFPasteboardClient' 04:13:18 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:13:18 INFO - PROCESS | 1657 | 2017-04-12 04:13:18.841 plugin-container[1658:10012] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:13:28 INFO - PROCESS | 1657 | RSS: Main: 173182976 04:13:28 INFO - PROCESS | 1657 | 04:13:31 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 04:13:32 INFO - PROCESS | 1657 | RSS: Main: 186245120 04:13:32 INFO - PROCESS | 1657 | 04:13:34 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 04:13:35 INFO - PROCESS | 1657 | RSS: Main: 194068480 04:13:35 INFO - PROCESS | 1657 | 04:13:38 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 04:13:39 INFO - PROCESS | 1657 | RSS: Main: 197627904 04:13:39 INFO - PROCESS | 1657 | 04:13:41 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 04:13:41 INFO - PROCESS | 1657 | RSS: Main: 199139328 04:13:41 INFO - PROCESS | 1657 | 04:13:43 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:13:44 INFO - PROCESS | 1657 | RSS: Main: 199155712 04:13:44 INFO - PROCESS | 1657 | 04:13:47 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 04:13:47 INFO - PROCESS | 1657 | RSS: Main: 202944512 04:13:47 INFO - PROCESS | 1657 | 04:13:50 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 04:13:51 INFO - PROCESS | 1657 | RSS: Main: 203509760 04:13:51 INFO - PROCESS | 1657 | 04:13:54 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 04:13:54 INFO - PROCESS | 1657 | RSS: Main: 203042816 04:13:54 INFO - PROCESS | 1657 | 04:13:56 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:13:57 INFO - PROCESS | 1657 | RSS: Main: 202579968 04:13:57 INFO - PROCESS | 1657 | 04:13:58 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:13:59 INFO - PROCESS | 1657 | RSS: Main: 202153984 04:13:59 INFO - PROCESS | 1657 | 04:14:01 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:14:02 INFO - PROCESS | 1657 | RSS: Main: 202100736 04:14:02 INFO - PROCESS | 1657 | 04:14:05 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:14:05 INFO - PROCESS | 1657 | RSS: Main: 202383360 04:14:05 INFO - PROCESS | 1657 | 04:14:08 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:14:09 INFO - PROCESS | 1657 | RSS: Main: 202731520 04:14:09 INFO - PROCESS | 1657 | 04:14:11 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 04:14:11 INFO - PROCESS | 1657 | RSS: Main: 204828672 04:14:11 INFO - PROCESS | 1657 | 04:14:11 INFO - PROCESS | 1657 | __start_tp_report 04:14:11 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 04:14:11 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 04:14:11 INFO - PROCESS | 1657 | |i|pagename|runs| 04:14:11 INFO - PROCESS | 1657 | |0;ai-astar;113;118;117;114;117;118;116;115;116;120 04:14:11 INFO - PROCESS | 1657 | |1;audio-beat-detection;134;111;108;142;108;110;105;122;160;123 04:14:11 INFO - PROCESS | 1657 | |2;audio-dft;196;199;199;192;194;193;194;195;194;196 04:14:11 INFO - PROCESS | 1657 | |3;audio-fft;81;59;59;88;63;64;83;82;62;71 04:14:11 INFO - PROCESS | 1657 | |4;audio-oscillator;73;59;93;100;57;80;103;100;102;68 04:14:11 INFO - PROCESS | 1657 | |5;imaging-gaussian-blur;89;88;89;87;88;86;88;86;97;86 04:14:11 INFO - PROCESS | 1657 | |6;imaging-darkroom;97;103;96;95;95;154;95;117;152;95 04:14:11 INFO - PROCESS | 1657 | |7;imaging-desaturate;94;95;103;93;93;99;94;93;92;92 04:14:11 INFO - PROCESS | 1657 | |8;json-parse-financial;59;57;59;60;62;64;61;62;61;60 04:14:11 INFO - PROCESS | 1657 | |9;json-stringify-tinderbox;68;70;69;81;77;75;70;69;69;70 04:14:11 INFO - PROCESS | 1657 | |10;stanford-crypto-aes;85;84;84;83;82;80;89;104;72;94 04:14:11 INFO - PROCESS | 1657 | |11;stanford-crypto-ccm;131;137;139;167;160;148;143;140;179;137 04:14:11 INFO - PROCESS | 1657 | |12;stanford-crypto-pbkdf2;168;164;165;166;164;214;169;166;164;163 04:14:11 INFO - PROCESS | 1657 | |13;stanford-crypto-sha256-iterative;68;66;66;67;64;66;67;71;87;66 04:14:11 INFO - PROCESS | 1657 | __end_tp_report 04:14:11 INFO - PROCESS | 1657 | __start_cc_report 04:14:11 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,944 04:14:11 INFO - PROCESS | 1657 | __end_cc_report 04:14:11 INFO - PROCESS | 1657 | __startTimestamp1491995651421__endTimestamp 04:14:11 INFO - PROCESS | 1657 | 04:14:11 INFO - PROCESS | 1657 | ------- Summary: start ------- 04:14:11 INFO - PROCESS | 1657 | Number of tests: 14 04:14:11 INFO - PROCESS | 1657 | 04:14:11 INFO - PROCESS | 1657 | [#0] ai-astar Cycles:10 Average:116.40 Median:117.00 stddev:2.07 (1.8%) stddev-sans-first:1.79 04:14:11 INFO - PROCESS | 1657 | Values: 113.0 118.0 117.0 114.0 117.0 118.0 116.0 115.0 116.0 120.0 04:14:11 INFO - PROCESS | 1657 | 04:14:11 INFO - PROCESS | 1657 | [#1] audio-beat-detection Cycles:10 Average:122.30 Median:122.50 stddev:18.06 (14.7%) stddev-sans-first:18.65 04:14:11 INFO - PROCESS | 1657 | Values: 134.0 111.0 108.0 142.0 108.0 110.0 105.0 122.0 160.0 123.0 04:14:11 INFO - PROCESS | 1657 | 04:14:11 INFO - PROCESS | 1657 | [#2] audio-dft Cycles:10 Average:195.20 Median:195.50 stddev:2.35 (1.2%) stddev-sans-first:2.47 04:14:11 INFO - PROCESS | 1657 | Values: 196.0 199.0 199.0 192.0 194.0 193.0 194.0 195.0 194.0 196.0 04:14:11 INFO - PROCESS | 1657 | 04:14:11 INFO - PROCESS | 1657 | [#3] audio-fft Cycles:10 Average:71.20 Median:76.00 stddev:11.23 (14.8%) stddev-sans-first:11.34 04:14:11 INFO - PROCESS | 1657 | Values: 81.0 59.0 59.0 88.0 63.0 64.0 83.0 82.0 62.0 71.0 04:14:11 INFO - PROCESS | 1657 | 04:14:11 INFO - PROCESS | 1657 | [#4] audio-oscillator Cycles:10 Average:83.50 Median:63.50 stddev:18.33 (28.9%) stddev-sans-first:19.04 04:14:11 INFO - PROCESS | 1657 | Values: 73.0 59.0 93.0 100.0 57.0 80.0 103.0 100.0 102.0 68.0 04:14:11 INFO - PROCESS | 1657 | 04:14:11 INFO - PROCESS | 1657 | [#5] imaging-gaussian-blur Cycles:10 Average:88.40 Median:88.00 stddev:3.24 (3.7%) stddev-sans-first:3.43 04:14:11 INFO - PROCESS | 1657 | Values: 89.0 88.0 89.0 87.0 88.0 86.0 88.0 86.0 97.0 86.0 04:14:11 INFO - PROCESS | 1657 | 04:14:11 INFO - PROCESS | 1657 | [#6] imaging-darkroom Cycles:10 Average:109.90 Median:95.00 stddev:23.72 (25.0%) stddev-sans-first:24.69 04:14:11 INFO - PROCESS | 1657 | Values: 97.0 103.0 96.0 95.0 95.0 154.0 95.0 117.0 152.0 95.0 04:14:11 INFO - PROCESS | 1657 | 04:14:11 INFO - PROCESS | 1657 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:93.50 stddev:3.52 (3.8%) stddev-sans-first:3.72 04:14:11 INFO - PROCESS | 1657 | Values: 94.0 95.0 103.0 93.0 93.0 99.0 94.0 93.0 92.0 92.0 04:14:11 INFO - PROCESS | 1657 | 04:14:11 INFO - PROCESS | 1657 | [#8] json-parse-financial Cycles:10 Average:60.50 Median:61.00 stddev:1.96 (3.2%) stddev-sans-first:2.00 04:14:11 INFO - PROCESS | 1657 | Values: 59.0 57.0 59.0 60.0 62.0 64.0 61.0 62.0 61.0 60.0 04:14:11 INFO - PROCESS | 1657 | 04:14:11 INFO - PROCESS | 1657 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:70.00 stddev:4.34 (6.2%) stddev-sans-first:4.38 04:14:11 INFO - PROCESS | 1657 | Values: 68.0 70.0 69.0 81.0 77.0 75.0 70.0 69.0 69.0 70.0 04:14:11 INFO - PROCESS | 1657 | 04:14:11 INFO - PROCESS | 1657 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:84.00 stddev:8.58 (10.2%) stddev-sans-first:9.09 04:14:11 INFO - PROCESS | 1657 | Values: 85.0 84.0 84.0 83.0 82.0 80.0 89.0 104.0 72.0 94.0 04:14:11 INFO - PROCESS | 1657 | 04:14:11 INFO - PROCESS | 1657 | [#11] stanford-crypto-ccm Cycles:10 Average:148.10 Median:145.50 stddev:15.52 (10.7%) stddev-sans-first:15.17 04:14:11 INFO - PROCESS | 1657 | Values: 131.0 137.0 139.0 167.0 160.0 148.0 143.0 140.0 179.0 137.0 04:14:11 INFO - PROCESS | 1657 | 04:14:11 INFO - PROCESS | 1657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.30 Median:166.00 stddev:15.47 (9.3%) stddev-sans-first:16.39 04:14:11 INFO - PROCESS | 1657 | Values: 168.0 164.0 165.0 166.0 164.0 214.0 169.0 166.0 164.0 163.0 04:14:11 INFO - PROCESS | 1657 | 04:14:11 INFO - PROCESS | 1657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:67.00 stddev:6.65 (9.9%) stddev-sans-first:7.04 04:14:11 INFO - PROCESS | 1657 | Values: 68.0 66.0 66.0 67.0 64.0 66.0 67.0 71.0 87.0 66.0 04:14:11 INFO - PROCESS | 1657 | -------- Summary: end -------- 04:14:11 INFO - PROCESS | 1657 | 04:14:12 INFO - TEST-INFO | 1657: exit 0 04:14:12 INFO - TEST-OK | kraken | took 59359ms 04:14:12 INFO - SUITE-END | took 1172s 04:14:12 INFO - Completed test suite (00:19:33) 04:14:12 INFO - javascript benchmark 04:14:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7475.408978321399, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3530.894073177805, 3537.5931767846705, 3552.413851714468, 3557.804320762357, 3585.282943411317, 5880.764769409224, 5969.5821292509545, 5977.671228082454, 5994.190784244126, 6013.699315034247, 5964.463198312151, 6050.8789824203595, 6062.878742425149, 6076.361981991893, 6103.359147289526, 5298.549623282016, 5362.919556206641, 5367.597430192732, 5399.055165346068, 5457.945420545803, 4449.065696203801, 5339.733013349336, 5425.186222066702, 5452.100403433429, 5478.808241711541, 5197.818076367309, 5224.320838291036, 5270.631055826094, 5321.627486075976, 5361.303030606015, 5212.609054320941, 5283.735813209362, 5290.074237008546, 5308.389535203462, 5330.333708286465, 5209.192575150858, 5233.058049551079, 5244.763985620656, 5246.108161612535, 5257.263983042377, 5701.14482827575, 5765.221695071154, 5816.767329306823, 5846.7368968396095, 5951.137085122633, 6165.815025549241, 6212.751489940397, 6246.219222597176, 6295.464885484739, 6306.0225665022, 6301.968490157566, 6305.0, 6319.8104056878365, 6320.051992201161, 6327.8418039548915, 5790.652560846363, 6089.573729838913, 6103.38966103395, 6111.297200821918, 6114.785982490636, 6154.5384096192965, 6327.905081423783, 6353.396427339488, 6373.5857169283845, 6487.18910136233, 6210.285817130997, 6257.0, 6268.9969604863, 6270.874582508324, 6280.246370435577, 6261.5616906816995, 6344.777932772331, 6351.142595749515, 6354.682265886687, 6360.109584658151, 6185.381461853869, 6187.721552530147, 6205.81382558524, 6220.7511699532415, 6275.090111933835, 6263.498920086382, 6272.278687950853, 6283.937160628335, 6300.117983482316, 6313.0, 5122.334096567422, 5153.716545589954, 5173.793048278102, 5177.068127736969, 5179.689218646893, 3593.8023408712247, 4446.110777844444, 4546.840860569864, 4553.977230113895, 4629.537046295343, 6116.920625435767, 6126.120738204555, 6131.193168498116, 6133.662648554283, 6148.770245950827, 6207.81376558704, 6347.904781428282, 6372.2671892732005, 6381.1385462962835, 6384.808455746335, 4771.355866957986, 4957.7769000395065, 5283.867903302371, 5392.8674978255, 6085.939140608537, 5632.070708333161, 5645.830625081254, 5647.0, 5661.1508273758445, 5668.461496157858, 6530.640814755234, 6544.181977252843, 6546.803595892131, 6547.214334279917, 6553.115329430466, 5606.299212598426, 5966.134910438049, 6187.319394866471, 6316.273628532777, 6328.968355158195, 6484.254310754323, 6494.383033611799, 6500.934990650033, 6518.2504012037325, 6523.902141467976, 6272.153259310117, 6281.403266689657, 6287.654179020198, 6290.433860952537, 6310.905336419865, 6117.602355846856, 6208.689565521616, 6223.813285601439, 6284.402981716729, 6319.3364696706185, 5160.303359046481, 5553.805616803393, 6001.099835024606, 6192.225971753531, 6250.562460627712, 6230.937690623035, 6235.189425374853, 6247.437730604267, 6248.375162483715, 6274.278457977209, 6003.459688628044, 6118.253719382578, 6191.876162476815, 6201.81394558164, 6227.003679411272, 5191.76637051326, 6163.907541386972, 6198.752049917953, 6245.250569931637, 6249.0, 6242.375762423721, 6244.937550624617, 6247.094171345038, 6260.311365749855, 6263.311035785969], "value": 5804.443078081426, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [469.39682507977244, 483.9830605928793, 489.4958193061147, 494.6018455143608, 559.583110582616, 40315.59684403155, 43394.56605433945, 43533.782331088376, 43591.56408435915, 43641.0, 44396.77801610996, 44850.32724509135, 44877.0, 44976.55023449765, 45026.32460513095, 9451.196648284887, 9677.177439917616, 9695.418274903494, 11470.713232169179, 11886.0, 11588.362640054793, 11601.129915256348, 11719.355435451047, 11735.471903764308, 11743.41282935854, 11632.883671163265, 11692.473838677237, 11708.473118709679, 11708.824367634492, 11763.117766167528, 11583.594574189947, 11608.129390295719, 11667.183297169202, 11676.416179191006, 11727.472263748152, 11703.648890533297, 11773.764524709457, 11779.0, 11780.764384712344, 11794.05647548194, 38726.0, 39079.023024424336, 39094.60905390938, 39133.0, 39219.0, 3681.3189559931498, 3879.1465877506903, 3967.226390853785, 3980.0845805464905, 4049.8785036448953, 28765.85617071922, 29336.266593335124, 30166.0, 30485.932992345162, 31043.534346984812, 3338.7996720196866, 3347.878460715663, 3366.1416338833687, 3387.1532116970757, 3393.2365217826036, 407805.0, 409655.0, 411711.0, 416031.0, 417748.0, 59273.70363148156, 59484.10773838396, 59532.0, 59539.40460595339, 59807.401925980186, 56434.717826410604, 62009.0, 62301.065484017774, 62343.0, 62694.37305626977, 14930.477433289783, 17130.0, 17311.913440432716, 17336.566585835455, 17608.91195544014, 12189.69525761863, 12496.125271231109, 13095.410706518229, 13274.469021239236, 13361.26513041792, 15660.921695391678, 19141.0, 19142.42572722793, 19146.138423770964, 19216.903915480332, 7047.365737083687, 7145.571265723969, 8045.517268963881, 8096.878546821802, 8105.528768081522, 802.6789284286332, 859.2095272349453, 898.9101089890959, 900.7342833864026, 918.7611221082567, 27109.611298587675, 30352.39295214083, 31165.68834311628, 31258.062258132293, 31662.68337316597, 1047.5652604169184, 1065.3820783945293, 1102.873169585492, 1116.179607988128, 1142.9771404571861, 16001.199940002953, 16091.919540402223, 16187.433439829785, 16235.918820405823, 17017.0, 678681.0, 699947.0, 703014.0, 705953.0, 706093.0, 49276.75361623169, 55953.60115997051, 57392.42607573871, 57994.84010319854, 58200.12699809506, 1419.9290035498184, 1456.5226018970654, 1465.7068586282574, 1483.480781726387, 1501.4444655477544, 28993.98521051753, 30210.54684179695, 30321.393572128876, 30454.695453045188, 30531.847340763154, 50517.0, 50927.23609145792, 51267.48732512627, 51365.7431712839, 51387.0, 623841.0, 626797.0, 627430.0, 629576.0, 630261.5460768001, 26703.732962670903, 27111.86444067767, 27948.0, 28035.299117522227, 28819.135425937257, 45866.0, 46434.071318572765, 47627.80930476627, 47642.52357476381, 47682.28476572924, 31356.216094597818, 31503.527447087854, 31563.684363156073, 32369.190770230933, 32991.83504082464, 31645.20886977844, 31737.523937141425, 31862.0, 32233.194170144994, 32404.351912961138, 37168.628313716516, 37888.43167352547, 37922.43116353202, 37967.24065518729, 37983.10084495709, 31163.84418077986, 31608.841955790074, 31755.72977080891, 32236.35527289488, 32657.0, 20891.8955405222, 23387.298381048597, 24982.757679655602, 25332.746672533038, 26248.73751262463], "value": 20385.05901357411, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.44255829047887, 391.0360960233025, 397.58055251709453, 399.06220382102055, 405.70789031897044, 17412.738808917846, 20535.178592856286, 20845.791542084575, 21039.47401314968, 21941.012654430568, 21113.894430527827, 21118.788812111874, 21290.680639790415, 21325.57348853022, 21326.57346853066, 4964.602831773458, 5315.202719592054, 6164.10620460033, 6196.380361963813, 6214.40963108504, 5846.356900740915, 6001.549883758714, 6011.489023432991, 6063.151158837766, 6109.297430795471, 5909.822705318826, 5971.671558064305, 6029.336772954972, 6032.819015429544, 6058.121572372003, 5773.971130144364, 5949.7025148742605, 5974.163617093611, 6030.728617212214, 6032.27612686476, 5237.952409518111, 5323.467653234684, 5326.92009619856, 5328.120860058086, 5329.600279979017, 26862.5970610441, 27141.1857644269, 27242.863785680944, 27280.0, 27317.726822731718, 2820.2385355953984, 3052.4963381042103, 3149.322895577439, 3160.0993716790604, 3192.4892017277125, 7788.922110778876, 15547.92226038874, 16527.091009994445, 16663.750043749355, 16837.83162168375, 1857.2756624916294, 1894.7536820213284, 1896.943091707251, 1908.1604094198508, 1910.3218357483033, 108108.0, 125708.0, 125815.37092314572, 126707.0, 129403.0, 11367.886321136682, 11822.290662560274, 11912.583059592873, 11923.284602923852, 11946.223495472766, 12480.875191248153, 14110.0, 15125.697486050218, 15185.392584296726, 15207.0, 7803.648835802403, 8758.386912916034, 9061.501617411106, 9165.991740908496, 9301.0, 9246.352755307198, 9283.860742088875, 9298.256139508958, 9302.53487325631, 9390.85913711295, 6653.178702272199, 7419.332260096618, 7489.28851759082, 7503.362214211744, 7509.249075092556, 1782.4652604218682, 1896.194117500057, 1995.4911497568028, 2002.149086638173, 2015.8790472571693, 852.5438890193717, 896.7489103051156, 1076.3918386111823, 1091.3506463654114, 1122.5229277557169, 22544.970952614345, 22992.08031678714, 23115.53768924612, 23538.0, 23567.882160589088, 1076.1928553584812, 1086.7174534620897, 1116.7878103160374, 1121.7251773315427, 1125.7973564758422, 10562.20783441245, 11854.288742675468, 12175.512979480722, 12359.25844449336, 12574.622761317176, 739374.0, 744101.0, 746510.0, 766147.0, 792242.0, 117316.8268317323, 130425.0, 138039.30980345234, 144922.0, 148287.25856370866, 1019.9643012494527, 1028.4600584693096, 1044.154235069596, 1045.3675526306627, 1048.4757621189558, 17827.376041838474, 19518.707219391436, 20574.382768516967, 20765.0, 20770.273040443513, 59275.0, 59637.70181149067, 60182.0, 61013.77972440615, 61458.69270653618, 67163.66418168074, 80342.0, 83208.16791832005, 87252.56373718091, 88887.55556222178, 8113.269805717514, 8245.628946697532, 8308.750737477885, 8520.829583408422, 8620.267277281251, 10156.898431015596, 12953.805692914426, 13273.800892986807, 13329.333533323488, 13653.522126725517, 9367.484788336707, 11343.376114313793, 11672.88327116718, 11889.167758256839, 11893.0, 10235.795284094425, 10467.476626168813, 10485.423301718478, 10547.525361358605, 10870.782584348111, 11497.425128743696, 11615.76768464643, 11896.345700986183, 11913.52345906154, 11930.880691192977, 7311.9032145176525, 7744.92255077442, 7793.220677932161, 7871.134175240833, 8693.04376518595, 10244.743881403025, 10495.47522623881, 11335.716607084889, 11339.943300283447, 11598.594049208237], "value": 10270.678536135807, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.7030158817442, 1480.8815294776418, 1484.3617244584832, 1490.9403623855046, 1500.5573355860022, 7647.961760191191, 7883.763487095382, 8124.187581241873, 8590.355723320745, 8606.91393086069, 8106.392020598464, 8380.078191398941, 8429.199226073513, 8510.234078932895, 8512.787180320494, 2391.940201494959, 2416.5770990076753, 2421.2978236311537, 2425.1875621666763, 2429.3805079704653, 2407.67496387988, 2413.3242692046256, 2427.78149966503, 2439.1584903208363, 2454.8527088374667, 2395.6646069550275, 2400.027988664585, 2416.4321384474633, 2420.3828023853894, 2425.126954296452, 2217.5897458970144, 2279.87460689662, 2289.667998140277, 2309.445733024079, 2356.399118224842, 2379.4408314046186, 2382.2614989353356, 2402.2793162051316, 2402.6636270922086, 2414.4446777241333, 8477.703280385218, 8499.320054395634, 8543.786405339853, 8545.145485451467, 8581.39930204886, 5169.4313625501545, 5275.736213189363, 5295.443978382253, 5345.946540534584, 5353.0, 2993.880244790206, 3314.939219449777, 3375.561177046968, 3554.751167418282, 3603.423452247654, 1235.1292338901053, 1247.2329517346857, 1260.823484712141, 1294.411042975444, 1320.1682939747993, 10761.461926903623, 10904.400257985808, 10909.454527273605, 10918.50866710992, 10946.562137514411, 3464.34177506273, 3830.942535861964, 4715.221988371949, 4775.641826863, 4853.684510506806, 9392.34253602255, 9487.810243795086, 9512.667056652985, 9535.094166054352, 9536.0, 5344.679319240858, 5372.274742909735, 5381.139017757218, 5385.6230063895155, 5396.055690254189, 4400.44994375703, 4408.625266852354, 4884.8290309838985, 4886.486918873467, 4938.38270216223, 3857.6528112470014, 3931.6461518463475, 3958.1094253792667, 3996.2806694794635, 4021.376686613521, 1322.5701646964776, 1330.1154732103043, 1332.7867541193364, 1335.692790658154, 1339.5311640925597, 928.8467402878449, 934.1779234273796, 943.1652987106323, 945.7351941456403, 992.6972273456665, 5490.835274941758, 5575.749091290902, 5780.826575202751, 5852.912206316909, 5858.677772722541, 553.4990833295874, 563.0512586292111, 573.5870173475091, 590.0794760174142, 596.5913349355706, 3332.5501057357433, 3339.5992480902446, 3703.222323312081, 3801.6008319126645, 3817.408301713239, 9724.611015559298, 10049.598016079275, 10058.994100589882, 10084.394936303699, 10107.241956853119, 9488.430694158373, 9895.65365212214, 9947.303688741718, 10054.145397641283, 10128.746781330377, 7896.565688887166, 8071.394645401619, 8082.232187942136, 8101.8379632408205, 8113.6754529818145, 5820.621659592113, 5885.882282354414, 5905.527557795452, 5927.496162826208, 6066.605670631395, 9181.173694367539, 9188.908110918805, 9294.395864268801, 9347.813043738952, 9374.718758437259, 9365.85951210746, 9377.81244375095, 9396.479796575066, 9456.905430945602, 9495.715128546155, 6281.811545653638, 6440.710168042543, 7056.823579410556, 7201.675924583511, 7325.194228634952, 6660.300668429745, 7996.000499937508, 8038.87941680887, 8072.919270807217, 8079.1516890725625, 6893.965530172317, 7000.299970002959, 7004.264552221944, 7008.964955175192, 7115.146182457931, 6850.143732033496, 6868.622225777431, 6904.827379315558, 6907.861842763217, 6951.27011663768, 6344.524160688059, 6454.354564543508, 6517.761625291179, 6523.054157147282, 6527.445167160845, 5073.771680274471, 5077.39071311445, 5120.18077107661, 5125.128728116304, 5157.252198431132, 4981.850544483671, 5021.046001259749, 5115.4884511550035, 5201.985612805618, 5231.529162375405], "value": 4428.1378519020045, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.79437762643096, 371.41131306878594, 381.6260065136166, 385.19878652403, 387.519475849946, 5430.945690543093, 5586.329640443152, 5624.240727501786, 5670.950874088291, 5687.175359572864, 5000.524950129741, 5061.772220250088, 5253.896681696839, 5502.449755024496, 5593.133064375028, 3809.657130858222, 4378.802953867068, 4420.513743488214, 4430.136123455927, 4435.467743870724, 3678.889633311005, 3748.800383877147, 3986.760794352348, 4400.44994375703, 4421.778911054451, 3673.412254039354, 3686.3411464840797, 3839.2513459875336, 4119.958800412002, 4167.812448439812, 4173.1862286854075, 4201.327787553977, 4231.920860180634, 4248.723832950864, 4271.402003719481, 3648.4892115103908, 3659.505966694489, 3676.6323367663285, 3679.6688298053305, 3690.0, 5129.153504738291, 5181.4300426953005, 5372.489613486712, 5398.136298192309, 5426.945730542683, 4867.610591152699, 4882.292067650171, 4908.312836202935, 4911.16510193268, 4931.876703082416, 4499.932501012488, 5043.7922175823605, 5922.940770592282, 5923.911141332884, 5928.614640048383, 3725.8882233533036, 3922.7450215735885, 4006.6794656427414, 4010.5387880393837, 4048.5344185418758, 5473.753681084321, 5686.658800471985, 6173.117199254226, 6224.782132625382, 6245.687715614246, 3466.532018177564, 3777.471154038382, 4059.7767122807936, 4083.469149010669, 4106.445629839934, 3688.7417880748626, 3828.3683192272965, 4113.259613269581, 4155.8337666493, 4164.208800327928, 4442.977785111054, 4564.612007979293, 4883.755812209375, 4884.804607815719, 4905.779239934212, 5069.543741063322, 5472.644278121989, 5793.188953546507, 6049.667268300285, 6074.84343058208, 1080.6217823761779, 1157.766978168265, 1299.2204677193797, 1348.359529223611, 1367.357342049255, 786.622421237809, 808.5552945879742, 909.8498747706554, 914.8307563100715, 914.9679761208325, 4789.425268967677, 5137.6660517066275, 5355.571554275649, 5384.380796208487, 5408.215808707715, 5549.694766787866, 5855.795047173328, 5907.556933230025, 5935.2697759031325, 6014.909776353358, 4532.9773351133035, 5031.396232452129, 5351.57187425005, 5352.545033672103, 5361.115415956324, 2770.34896799252, 3013.789034767589, 3060.4491191585284, 3077.3076057886797, 3121.734652554558, 5138.845834624967, 5462.453754624506, 5903.797367211994, 6211.378862113753, 6282.811515654537, 4981.12830254704, 5097.668651537638, 5273.367195936512, 5911.881762364728, 5960.211936419057, 5214.687118772886, 5618.4662457066515, 5902.822915312548, 5908.586398952118, 6161.260648722093, 4476.753778542081, 5786.884262314814, 5874.971879921082, 5880.295064270484, 5904.793332233351, 5638.83083507479, 5666.036773748555, 5756.222909907109, 5852.985712358224, 5882.588218824641, 4982.451930287738, 5000.7999680013845, 5334.973325133505, 5495.241522712694, 6116.449519543263, 3537.4163263062337, 3880.3225774215703, 3900.434437006675, 3923.588023257631, 4149.460570125864, 5735.9139612905, 6082.513398927987, 6097.926704920348, 6126.724297406538, 6127.325994140552, 5158.3552055993005, 5600.85997850057, 5706.0, 5879.764809407576, 5912.438318359749, 5100.770465328995, 5378.515933565998, 5733.559864081518, 5796.014677504919, 5923.733431995657, 5343.519083282523, 5475.342958844964, 5725.997950358754, 5810.1575271586225, 5815.79644712433, 5896.7936122235515, 6031.819045428644, 6049.879002419839, 6107.656315610736, 6190.0, 4630.953690463187, 4924.556789888928, 5692.231548740867, 5865.794697185749, 5926.644401335761], "value": 4229.820434244965, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.1130643228124, 743.271593838039, 777.1024466740917, 843.5360551696566, 853.7097386888458, 15161.09033457992, 15474.61313467164, 16030.198490075509, 16164.272607732652, 16168.75746863798, 12670.0, 12787.552435664753, 12797.0, 12911.612651620442, 13001.349932503384, 875.1598465473138, 899.8920129584459, 900.7883147460342, 901.3104974694364, 902.1339514066505, 867.5662168915542, 875.374107513128, 878.2841983783196, 901.8151278987792, 908.0737647599444, 822.8642274024779, 951.0632027452954, 951.6764300137952, 951.6907005223295, 953.6995846308425, 925.3291363761219, 943.2501161576563, 946.6592026870321, 947.4031360243038, 951.3625870666635, 705.2383425900016, 705.4427002667886, 705.6330708031795, 705.6930235347589, 707.2220557386885, 15844.970076945077, 15889.28498217583, 16028.278727457293, 16127.516174514783, 16278.0, 11393.54425822966, 14433.422663093465, 14582.562523124323, 14636.634084147876, 14711.779323310158, 11904.880951190551, 12043.397830108459, 12107.031437485068, 12114.81827772584, 12635.241885486901, 3755.1550901047317, 3857.1321452672923, 3881.9223615527812, 3883.417487376888, 4002.699797515169, 97370.0, 115076.27385589307, 116143.0, 119723.0, 119850.0, 11122.610708625321, 11225.0, 11313.717157070974, 11338.206325557298, 11697.064234861191, 22881.855907204907, 22983.310500685006, 23554.7644523556, 23647.881760591088, 23668.408289792547, 8134.186581341818, 8136.064352599408, 8155.021397432228, 8169.0605580359015, 8202.958985205156, 4344.261475549164, 4380.014496738208, 4407.779611019436, 4436.290193569013, 4620.792064357112, 3618.5295911531334, 3678.393065144221, 3686.9631303687156, 3692.48305237267, 3702.352088384576, 666.1440049536322, 669.926308106108, 682.6006786030227, 684.2199892122984, 697.5361384679233, 628.8152346136469, 644.6035688051908, 668.8929771236578, 678.3318431345122, 682.0, 8755.518446485505, 9921.206303495703, 9927.106560409598, 10164.847527287096, 10213.948930255301, 640.6060272932207, 644.9484041276687, 645.9257185423736, 684.2712511175681, 697.9127609048869, 4227.894302642397, 4422.84520041797, 4606.930896036562, 4898.289747986522, 4924.162892308316, 77245.0, 107589.4620526908, 109584.0, 110638.44680776545, 113741.0, 61772.69113654493, 63447.36552634415, 69058.0, 79101.60449197717, 97655.0, 73073.6346318265, 74831.25168748242, 75471.24528754642, 76171.47657046828, 77549.0, 10893.400862952614, 10967.616133435291, 11266.098712103176, 11312.246601776738, 11388.316700997966, 48732.75633621951, 50970.0, 51245.0, 52971.73514132559, 53491.6627084326, 73484.63257683677, 74474.62762686369, 74895.25104749101, 74979.25020749723, 75248.87126693214, 13430.93284533571, 13440.865591343962, 13833.515826946008, 13838.515651952133, 14013.5095271665, 15005.403690373396, 15113.06788039253, 15207.695846083237, 15244.466443674419, 15515.069095854285, 13962.511312104027, 13997.720045599235, 14116.435342586592, 14195.929020355245, 14949.85050149528, 13848.09987350819, 13958.58124256274, 14165.150090994573, 14357.56927292183, 14977.550673479813, 13869.653258668613, 13903.235322057384, 14074.944379171398, 14241.430342786172, 14438.133711977314, 9503.988555874508, 9830.164436023018, 10095.0, 10184.643537476153, 10201.132903703268, 9169.807924969711, 9817.410955342702, 10712.678619641423, 11118.722031948942, 11385.975262226439], "value": 7665.628936268629, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1486.8999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 118.0, 117.0, 114.0, 117.0, 118.0, 116.0, 115.0, 116.0, 120.0], "value": 116.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 111.0, 108.0, 142.0, 108.0, 110.0, 105.0, 122.0, 160.0, 123.0], "value": 122.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 199.0, 199.0, 192.0, 194.0, 193.0, 194.0, 195.0, 194.0, 196.0], "value": 195.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 88.0, 63.0, 64.0, 83.0, 82.0, 62.0, 71.0], "value": 71.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 59.0, 93.0, 100.0, 57.0, 80.0, 103.0, 100.0, 102.0, 68.0], "value": 83.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 89.0, 87.0, 88.0, 86.0, 88.0, 86.0, 97.0, 86.0], "value": 88.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 103.0, 96.0, 95.0, 95.0, 154.0, 95.0, 117.0, 152.0, 95.0], "value": 109.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 103.0, 93.0, 93.0, 99.0, 94.0, 93.0, 92.0, 92.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 59.0, 60.0, 62.0, 64.0, 61.0, 62.0, 61.0, 60.0], "value": 60.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 69.0, 81.0, 77.0, 75.0, 70.0, 69.0, 69.0, 70.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 83.0, 82.0, 80.0, 89.0, 104.0, 72.0, 94.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 137.0, 139.0, 167.0, 160.0, 148.0, 143.0, 140.0, 179.0, 137.0], "value": 148.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 164.0, 165.0, 166.0, 164.0, 214.0, 169.0, 166.0, 164.0, 163.0], "value": 170.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 66.0, 67.0, 64.0, 66.0, 67.0, 71.0, 87.0, 66.0], "value": 68.8, "unit": "score"}]}]} 04:14:12 INFO - Return code: 0 04:14:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:14:12 ERROR - # TBPL SUCCESS # 04:14:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:14:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:14:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:14:12 INFO - 2017-04-12 04:14:12.758 screenresolution[1662:10391] starting screenresolution argv=screenresolution get 04:14:12 INFO - 2017-04-12 04:14:12.761 screenresolution[1662:10391] Display 0: 1600x1200x32@60 04:14:12 INFO - 2017-04-12 04:14:12.767 screenresolution[1663:10394] starting screenresolution argv=screenresolution list 04:14:12 INFO - Available Modes on Display 0 04:14:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:14:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:14:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:14:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:14:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:14:12 INFO - Intel Iris: 04:14:12 INFO - Chipset Model: Intel Iris 04:14:12 INFO - Type: GPU 04:14:12 INFO - Bus: Built-In 04:14:12 INFO - VRAM (Dynamic, Max): 1536 MB 04:14:12 INFO - Vendor: Intel (0x8086) 04:14:12 INFO - Device ID: 0x0a2e 04:14:12 INFO - Revision ID: 0x0009 04:14:12 INFO - Displays: 04:14:12 INFO - Display: 04:14:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:14:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:14:12 INFO - Display Serial Number: 1600x1200 60 04:14:12 INFO - Main Display: Yes 04:14:12 INFO - Mirror: Off 04:14:12 INFO - Online: Yes 04:14:12 INFO - Rotation: Supported 04:14:13 INFO - Return code: 0 04:14:13 INFO - Running post-action listener: _resource_record_post_action 04:14:13 INFO - [mozharness: 2017-04-12 11:14:13.002312Z] Finished run-tests step (success) 04:14:13 INFO - Running post-run listener: _resource_record_post_run 04:14:13 INFO - Total resource usage - Wall time: 1188s; CPU: 54.0%; Read bytes: 39499776; Write bytes: 423671296; Read time: 252; Write time: 1413 04:14:13 INFO - TinderboxPrint: CPU usage
54.4% 04:14:13 INFO - TinderboxPrint: I/O read bytes / time
39,499,776 / 252 04:14:13 INFO - TinderboxPrint: I/O write bytes / time
423,671,296 / 1,413 04:14:13 INFO - TinderboxPrint: CPU idle
2,166.0 (45.6%) 04:14:13 INFO - TinderboxPrint: CPU system
956.2 (20.1%) 04:14:13 INFO - TinderboxPrint: CPU user
1,631.5 (34.3%) 04:14:13 INFO - TinderboxPrint: Swap in / out
161,185,792 / 0 04:14:13 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 109769216; Write bytes: 103208448; Read time: 9997; Write time: 221 04:14:13 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 38561792; Write bytes: 300707840; Read time: 240; Write time: 1134 04:14:13 INFO - Running post-run listener: _upload_blobber_files 04:14:13 INFO - Blob upload gear active. 04:14:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:14:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:14:13 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:14:13 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:14:19 INFO - (blobuploader) - INFO - Open directory for files ... 04:14:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:14:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:14:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:14:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:14:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:14:22 INFO - (blobuploader) - INFO - Done attempting. 04:14:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:14:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:14:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:14:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:14:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:14:25 INFO - (blobuploader) - INFO - Done attempting. 04:14:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:14:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:14:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:14:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:14:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:14:28 INFO - (blobuploader) - INFO - Done attempting. 04:14:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:14:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:14:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:14:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:14:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:14:33 INFO - (blobuploader) - INFO - Done attempting. 04:14:33 INFO - (blobuploader) - INFO - Iteration through files over. 04:14:33 INFO - Return code: 0 04:14:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:14:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:14:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8ee4b1f5af063ce34dd6bc01c9713f7763f897d54b115149360e26c4c39d315e4930dc0ca320ed630661628de0e4626f6ded6f80089882253ef4a7e07b3388e0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9e81512de8c1f9ebb84ea87ab6b5ec32e82145bf85f00f3a54fb680a560e6adbfdc83ce641c58cf484e2e579fe55867088cdfadf8052018073c051466d12a60e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a80f7057ce6362b609439e5d69cd0b2d9d2d4efab58e426b4710a01943a5a4f020534e194ed3232057aa3a7bf5820f6b6db6ebeb11cd20bd525a1aa84ec6d62b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e7f60efb339df3f54c4cfb23f5cdde1bdba823da7dadec727bd2d08852a0ca10ee36cbc26ec819eb0beee5a6cbadd92e02962bb0ad3e1798c3bf10b9ec2dbbc9"} 04:14:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:14:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:14:33 INFO - Contents: 04:14:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8ee4b1f5af063ce34dd6bc01c9713f7763f897d54b115149360e26c4c39d315e4930dc0ca320ed630661628de0e4626f6ded6f80089882253ef4a7e07b3388e0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9e81512de8c1f9ebb84ea87ab6b5ec32e82145bf85f00f3a54fb680a560e6adbfdc83ce641c58cf484e2e579fe55867088cdfadf8052018073c051466d12a60e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a80f7057ce6362b609439e5d69cd0b2d9d2d4efab58e426b4710a01943a5a4f020534e194ed3232057aa3a7bf5820f6b6db6ebeb11cd20bd525a1aa84ec6d62b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e7f60efb339df3f54c4cfb23f5cdde1bdba823da7dadec727bd2d08852a0ca10ee36cbc26ec819eb0beee5a6cbadd92e02962bb0ad3e1798c3bf10b9ec2dbbc9"} 04:14:33 INFO - Running post-run listener: copy_logs_to_upload_dir 04:14:33 INFO - Copying logs to upload dir... 04:14:33 INFO - mkdir: /builds/slave/test/build/upload/logs 04:14:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.548289 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-04-12 04:14:33.294566) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-12 04:14:33.298235) ========= 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.21VZBpRpRx/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.QklAIHXj6b/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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-Beta/sha512/8ee4b1f5af063ce34dd6bc01c9713f7763f897d54b115149360e26c4c39d315e4930dc0ca320ed630661628de0e4626f6ded6f80089882253ef4a7e07b3388e0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9e81512de8c1f9ebb84ea87ab6b5ec32e82145bf85f00f3a54fb680a560e6adbfdc83ce641c58cf484e2e579fe55867088cdfadf8052018073c051466d12a60e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a80f7057ce6362b609439e5d69cd0b2d9d2d4efab58e426b4710a01943a5a4f020534e194ed3232057aa3a7bf5820f6b6db6ebeb11cd20bd525a1aa84ec6d62b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e7f60efb339df3f54c4cfb23f5cdde1bdba823da7dadec727bd2d08852a0ca10ee36cbc26ec819eb0beee5a6cbadd92e02962bb0ad3e1798c3bf10b9ec2dbbc9"} build_url:https://queue.taskcluster.net/v1/task/YdWBzOXrQZ-JrlsO5mictA/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011052 build_url: 'https://queue.taskcluster.net/v1/task/YdWBzOXrQZ-JrlsO5mictA/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8ee4b1f5af063ce34dd6bc01c9713f7763f897d54b115149360e26c4c39d315e4930dc0ca320ed630661628de0e4626f6ded6f80089882253ef4a7e07b3388e0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9e81512de8c1f9ebb84ea87ab6b5ec32e82145bf85f00f3a54fb680a560e6adbfdc83ce641c58cf484e2e579fe55867088cdfadf8052018073c051466d12a60e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a80f7057ce6362b609439e5d69cd0b2d9d2d4efab58e426b4710a01943a5a4f020534e194ed3232057aa3a7bf5820f6b6db6ebeb11cd20bd525a1aa84ec6d62b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e7f60efb339df3f54c4cfb23f5cdde1bdba823da7dadec727bd2d08852a0ca10ee36cbc26ec819eb0beee5a6cbadd92e02962bb0ad3e1798c3bf10b9ec2dbbc9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-12 04:14:33.332563) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 04:14:33.332891) ========= 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.21VZBpRpRx/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.QklAIHXj6b/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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.005254 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 04:14:33.381726) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-12 04:14:33.382046) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-12 04:14:33.382359) ========= ========= Total master_lag: 0.26 =========