builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0038 starttime: 1476526844.53 results: success (0) buildid: 20161015021335 builduid: 7619707c9cb4476e902ac077f1dbd41d revision: 04c1662be2ba75c56a625799ebaccbe487005941 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-15 03:20:44.525965) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-15 03:20:44.526347) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-15 03:20:44.526633) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-15 03:20:44.561319) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 03:20:44.561613) ========= 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.Ck7cqgCM62/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.rVq6CUZ1kq/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 --2016-10-15 03:20:44-- 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% 59.0M=0s 2016-10-15 03:20:45 (59.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.491356 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 03:20:45.075115) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 03:20:45.075472) ========= 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.Ck7cqgCM62/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.rVq6CUZ1kq/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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.026639 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 03:20:45.124441) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-15 03:20:45.126051) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 04c1662be2ba75c56a625799ebaccbe487005941 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 04c1662be2ba75c56a625799ebaccbe487005941 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ck7cqgCM62/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.rVq6CUZ1kq/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 2016-10-15 03:20:45,212 truncating revision to first 12 chars 2016-10-15 03:20:45,212 Setting DEBUG logging. 2016-10-15 03:20:45,212 attempt 1/10 2016-10-15 03:20:45,212 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/04c1662be2ba?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-15 03:20:46,980 unpacking tar archive at: autoland-04c1662be2ba/testing/mozharness/ program finished with exit code 0 elapsedTime=2.025943 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-15 03:20:47.186900) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-15 03:20:47.187215) ========= script_repo_revision: 04c1662be2ba75c56a625799ebaccbe487005941 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-15 03:20:47.187610) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-15 03:20:47.187872) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-15 03:20:47.205641) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-15 03:20:47.205936) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ck7cqgCM62/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.rVq6CUZ1kq/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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:20:47 INFO - MultiFileLogger online at 20161015 03:20:47 in /builds/slave/test 03:20:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 03:20:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:20:47 INFO - {'append_to_log': False, 03:20:47 INFO - 'base_work_dir': '/builds/slave/test', 03:20:47 INFO - 'blob_upload_branch': 'Autoland', 03:20:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:20:47 INFO - 'branch': 'Autoland', 03:20:47 INFO - 'buildbot_json_path': 'buildprops.json', 03:20:47 INFO - 'config_files': ('talos/mac_config.py',), 03:20:47 INFO - 'default_actions': ('clobber', 03:20:47 INFO - 'read-buildbot-config', 03:20:47 INFO - 'download-and-extract', 03:20:47 INFO - 'populate-webroot', 03:20:47 INFO - 'create-virtualenv', 03:20:47 INFO - 'install', 03:20:47 INFO - 'run-tests'), 03:20:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:20:47 INFO - 'download_minidump_stackwalk': True, 03:20:47 INFO - 'download_symbols': 'ondemand', 03:20:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:20:47 INFO - 'tooltool.py': '/tools/tooltool.py', 03:20:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:20:47 INFO - '/tools/misc-python/virtualenv.py')}, 03:20:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:20:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:20:47 INFO - 'installer_path': 'installer.exe', 03:20:47 INFO - 'log_level': 'info', 03:20:47 INFO - 'log_name': 'talos', 03:20:47 INFO - 'log_to_console': True, 03:20:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:20:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:20:47 INFO - 'opt_config_files': (), 03:20:47 INFO - 'pip_index': False, 03:20:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:20:47 INFO - 'cmd': ('bash', 03:20:47 INFO - '-c', 03:20:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:20:47 INFO - 'enabled': True, 03:20:47 INFO - 'halt_on_failure': False, 03:20:47 INFO - 'name': 'check_screen_resolution'},), 03:20:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:20:47 INFO - 'cmd': ('bash', 03:20:47 INFO - '-c', 03:20:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:20:47 INFO - 'enabled': True, 03:20:47 INFO - 'halt_on_failure': False, 03:20:47 INFO - 'name': 'check_screen_resolution'},), 03:20:47 INFO - 'run_cmd_checks_enabled': True, 03:20:47 INFO - 'sps_profile': False, 03:20:47 INFO - 'sps_profile_interval': 0, 03:20:47 INFO - 'suite': 'dromaeojs', 03:20:47 INFO - 'system_bits': '32', 03:20:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:20:47 INFO - 'title': 't-yosemite-r7-0038', 03:20:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:20:47 INFO - 'use_talos_json': True, 03:20:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:20:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:20:47 INFO - 'work_dir': 'build'} 03:20:47 INFO - [mozharness: 2016-10-15 10:20:47.409842Z] Running clobber step. 03:20:47 INFO - Running pre-action listener: _resource_record_pre_action 03:20:47 INFO - Running main action method: clobber 03:20:47 INFO - rmtree: /builds/slave/test/build 03:20:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:20:49 INFO - Running post-action listener: _resource_record_post_action 03:20:49 INFO - [mozharness: 2016-10-15 10:20:49.542112Z] Finished clobber step (success) 03:20:49 INFO - [mozharness: 2016-10-15 10:20:49.542276Z] Running read-buildbot-config step. 03:20:49 INFO - Running pre-action listener: _resource_record_pre_action 03:20:49 INFO - Running main action method: read_buildbot_config 03:20:49 INFO - Using buildbot properties: 03:20:49 INFO - { 03:20:49 INFO - "project": "", 03:20:49 INFO - "product": "firefox", 03:20:49 INFO - "script_repo_revision": "production", 03:20:49 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 03:20:49 INFO - "repository": "", 03:20:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 03:20:49 INFO - "buildid": "20161015021335", 03:20:49 INFO - "pgo_build": "False", 03:20:49 INFO - "basedir": "/builds/slave/test", 03:20:49 INFO - "buildnumber": 369, 03:20:49 INFO - "slavename": "t-yosemite-r7-0038", 03:20:49 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 03:20:49 INFO - "platform": "yosemite_r7", 03:20:49 INFO - "scheduler": "tests-autoland-macosx64-talos", 03:20:49 INFO - "branch": "autoland", 03:20:49 INFO - "repo_path": "integration/autoland", 03:20:49 INFO - "revision": "04c1662be2ba75c56a625799ebaccbe487005941", 03:20:49 INFO - "stage_platform": "macosx64", 03:20:49 INFO - "builduid": "7619707c9cb4476e902ac077f1dbd41d", 03:20:49 INFO - "slavebuilddir": "test" 03:20:49 INFO - } 03:20:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ickyj82URcuAItKy8ukftQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 03:20:49 INFO - Running post-action listener: _resource_record_post_action 03:20:49 INFO - [mozharness: 2016-10-15 10:20:49.545889Z] Finished read-buildbot-config step (success) 03:20:49 INFO - [mozharness: 2016-10-15 10:20:49.545993Z] Running download-and-extract step. 03:20:49 INFO - Running pre-action listener: _resource_record_pre_action 03:20:49 INFO - Running main action method: download_and_extract 03:20:49 INFO - mkdir: /builds/slave/test/build/tests 03:20:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:49 INFO - trying https://queue.taskcluster.net/v1/task/Ickyj82URcuAItKy8ukftQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 03:20:49 INFO - Downloading https://queue.taskcluster.net/v1/task/Ickyj82URcuAItKy8ukftQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 03:20:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ickyj82URcuAItKy8ukftQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 03:20:50 INFO - Downloaded 1199 bytes. 03:20:50 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 03:20:50 INFO - Using the following test package requirements: 03:20:50 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 03:20:50 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:20:50 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 03:20:50 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:20:50 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 03:20:50 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:20:50 INFO - u'jsshell-mac.zip'], 03:20:50 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:20:50 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 03:20:50 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 03:20:50 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:20:50 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 03:20:50 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:20:50 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 03:20:50 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:20:50 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 03:20:50 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:20:50 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 03:20:50 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:20:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ickyj82URcuAItKy8ukftQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 03:20:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ickyj82URcuAItKy8ukftQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:20:50 INFO - Fetch https://queue.taskcluster.net/v1/task/Ickyj82URcuAItKy8ukftQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 03:20:51 INFO - Http code: 200 03:20:51 INFO - via: 1.1 3d3d633d266d05d90a4eea7a6a59b514.cloudfront.net (CloudFront) 03:20:51 INFO - x-amz-cf-id: 0qL7rU2jkSpJiz6tNUUnNk6-Ay6CoNIWc9qK3bCXokFUwT1oicVWIw== 03:20:51 INFO - x-amz-version-id: cAeI.PYNGOdz0c8bu.SNUmnNcBwpshI7 03:20:51 INFO - Expected file size: 16509823 03:20:51 INFO - Obtained file size: 16509823 03:20:58 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 03:20:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ickyj82URcuAItKy8ukftQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 03:20:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ickyj82URcuAItKy8ukftQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:20:58 INFO - Fetch https://queue.taskcluster.net/v1/task/Ickyj82URcuAItKy8ukftQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 03:20:58 INFO - Http code: 200 03:20:58 INFO - via: 1.1 7db492e48a5d55351dcb787a8a14e113.cloudfront.net (CloudFront) 03:20:58 INFO - x-amz-cf-id: 5BunZNo95LLDHJENua57l1bB3msCNFdefg-MhkzV06ZXKbF6bVe1Rw== 03:20:58 INFO - x-amz-version-id: cAeI.PYNGOdz0c8bu.SNUmnNcBwpshI7 03:20:59 INFO - Expected file size: 16509823 03:20:59 INFO - Obtained file size: 16509823 03:21:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ickyj82URcuAItKy8ukftQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 03:21:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ickyj82URcuAItKy8ukftQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:21:05 INFO - Fetch https://queue.taskcluster.net/v1/task/Ickyj82URcuAItKy8ukftQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 03:21:06 INFO - Http code: 200 03:21:06 INFO - via: 1.1 373880a309382d9266a9313233b86d25.cloudfront.net (CloudFront) 03:21:06 INFO - x-amz-cf-id: iB5rX8X1Zq7GTLGL54OXRxutzhBFNE5bI1s1ybgL6Kq7XJdW1GjY1w== 03:21:06 INFO - x-amz-version-id: 6Bt6l86bFXuIwAVgO9tOFSHNJQwoE9.G 03:21:07 INFO - Expected file size: 14409028 03:21:07 INFO - Obtained file size: 14409028 03:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:07 INFO - trying https://queue.taskcluster.net/v1/task/Ickyj82URcuAItKy8ukftQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 03:21:07 INFO - Downloading https://queue.taskcluster.net/v1/task/Ickyj82URcuAItKy8ukftQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 03:21:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ickyj82URcuAItKy8ukftQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 03:21:10 INFO - Downloaded 111642345 bytes. 03:21:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ickyj82URcuAItKy8ukftQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 03:21:10 INFO - mkdir: /builds/slave/test/properties 03:21:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:21:10 INFO - Writing to file /builds/slave/test/properties/build_url 03:21:10 INFO - Contents: 03:21:10 INFO - build_url:https://queue.taskcluster.net/v1/task/Ickyj82URcuAItKy8ukftQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 03:21:11 INFO - Running post-action listener: _resource_record_post_action 03:21:11 INFO - Running post-action listener: set_extra_try_arguments 03:21:11 INFO - [mozharness: 2016-10-15 10:21:11.202523Z] Finished download-and-extract step (success) 03:21:11 INFO - [mozharness: 2016-10-15 10:21:11.202648Z] Running populate-webroot step. 03:21:11 INFO - Running pre-action listener: _resource_record_pre_action 03:21:11 INFO - Running main action method: populate_webroot 03:21:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:21:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:21:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:21:11 INFO - '--tppagecycles', 03:21:11 INFO - '7'], 03:21:11 INFO - 'tests': ['tsvgm']}}, 03:21:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:21:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:21:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:21:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:21:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:21:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:21:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:11 INFO - 'talos_options': ['--disable-e10s'], 03:21:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:21:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:21:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:11 INFO - 'talos_options': ['--disable-e10s'], 03:21:11 INFO - 'tests': ['damp', 'tps']}, 03:21:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:11 INFO - 'tests': ['damp', 'tps']}, 03:21:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:21:11 INFO - 'tests': ['dromaeo_dom']}, 03:21:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:21:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:21:11 INFO - 'tests': ['basic_compositor_video']}, 03:21:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:21:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:21:11 INFO - 'tests': ['a11yr', 03:21:11 INFO - 'ts_paint', 03:21:11 INFO - 'tpaint', 03:21:11 INFO - 'sessionrestore', 03:21:11 INFO - 'sessionrestore_no_auto_restore', 03:21:11 INFO - 'tabpaint']}, 03:21:11 INFO - 'other-e10s': {'tests': ['a11yr', 03:21:11 INFO - 'ts_paint', 03:21:11 INFO - 'tpaint', 03:21:11 INFO - 'sessionrestore', 03:21:11 INFO - 'sessionrestore_no_auto_restore', 03:21:11 INFO - 'tabpaint']}, 03:21:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:21:11 INFO - 'ts_paint', 03:21:11 INFO - 'tpaint', 03:21:11 INFO - 'sessionrestore', 03:21:11 INFO - 'sessionrestore_no_auto_restore', 03:21:11 INFO - 'tabpaint']}, 03:21:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:21:11 INFO - 'ts_paint', 03:21:11 INFO - 'tpaint', 03:21:11 INFO - 'sessionrestore', 03:21:11 INFO - 'sessionrestore_no_auto_restore', 03:21:11 INFO - 'tabpaint']}, 03:21:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:21:11 INFO - 'tests': ['a11yr', 03:21:11 INFO - 'ts_paint', 03:21:11 INFO - 'tpaint', 03:21:11 INFO - 'sessionrestore', 03:21:11 INFO - 'sessionrestore_no_auto_restore', 03:21:11 INFO - 'tabpaint']}, 03:21:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:21:11 INFO - 'tests': ['a11yr', 03:21:11 INFO - 'ts_paint', 03:21:11 INFO - 'tpaint', 03:21:11 INFO - 'sessionrestore', 03:21:11 INFO - 'sessionrestore_no_auto_restore', 03:21:11 INFO - 'tabpaint']}, 03:21:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:21:11 INFO - 'tests': ['tsvgx', 03:21:11 INFO - 'tsvgr_opacity', 03:21:11 INFO - 'tart', 03:21:11 INFO - 'tscrollx', 03:21:11 INFO - 'cart']}, 03:21:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:21:11 INFO - 'tsvgr_opacity', 03:21:11 INFO - 'tart', 03:21:11 INFO - 'tscrollx', 03:21:11 INFO - 'cart']}, 03:21:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:11 INFO - 'talos_options': ['--disable-e10s'], 03:21:11 INFO - 'tests': ['tp5o']}, 03:21:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:11 INFO - 'tests': ['tp5o']}, 03:21:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:11 INFO - 'talos_options': ['--disable-e10s', 03:21:11 INFO - '--xperf_path', 03:21:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:21:11 INFO - 'tests': ['tp5n']}, 03:21:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:11 INFO - 'talos_options': ['--xperf_path', 03:21:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:21:11 INFO - 'tests': ['tp5n']}}, 03:21:11 INFO - 'talos.zip': {'path': '', 03:21:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:21:11 INFO - Running post-action listener: _resource_record_post_action 03:21:11 INFO - [mozharness: 2016-10-15 10:21:11.222043Z] Finished populate-webroot step (success) 03:21:11 INFO - [mozharness: 2016-10-15 10:21:11.222177Z] Running create-virtualenv step. 03:21:11 INFO - Running pre-action listener: _resource_record_pre_action 03:21:11 INFO - Running main action method: create_virtualenv 03:21:11 INFO - Creating virtualenv /builds/slave/test/build/venv 03:21:11 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:21:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:21:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:21:11 INFO - Using real prefix '/tools/python27' 03:21:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:21:12 INFO - Installing distribute.............................................................................................................................................................................................done. 03:21:14 INFO - Installing pip.................done. 03:21:14 INFO - Return code: 0 03:21:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:21:15 INFO - Reading from file tmpfile_stdout 03:21:15 INFO - Output received: 03:21:15 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:21:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:21:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1017ae490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101724570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca50cdcf70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015c2d30>, '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 0x1013e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015bab20>, '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.Ck7cqgCM62/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.rVq6CUZ1kq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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:21:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:21:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:21:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ck7cqgCM62/Render', 03:21:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:15 INFO - 'HOME': '/Users/cltbld', 03:21:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:15 INFO - 'LOGNAME': 'cltbld', 03:21:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:15 INFO - 'MOZ_NO_REMOTE': '1', 03:21:15 INFO - 'NO_EM_RESTART': '1', 03:21:15 INFO - 'PAGER': '/bin/cat', 03:21:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:15 INFO - 'PWD': '/builds/slave/test', 03:21:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:15 INFO - 'SHELL': '/bin/bash', 03:21:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rVq6CUZ1kq/Listeners', 03:21:15 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 03:21:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:15 INFO - 'USER': 'cltbld', 03:21:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:15 INFO - 'XPC_FLAGS': '0x0', 03:21:15 INFO - 'XPC_SERVICE_NAME': '0', 03:21:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:21:15 INFO - Cleaning up... 03:21:15 INFO - Return code: 0 03:21:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:21:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1017ae490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101724570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca50cdcf70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015c2d30>, '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 0x1013e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015bab20>, '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.Ck7cqgCM62/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.rVq6CUZ1kq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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:21:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:21:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:21:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ck7cqgCM62/Render', 03:21:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:15 INFO - 'HOME': '/Users/cltbld', 03:21:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:15 INFO - 'LOGNAME': 'cltbld', 03:21:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:15 INFO - 'MOZ_NO_REMOTE': '1', 03:21:15 INFO - 'NO_EM_RESTART': '1', 03:21:15 INFO - 'PAGER': '/bin/cat', 03:21:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:15 INFO - 'PWD': '/builds/slave/test', 03:21:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:15 INFO - 'SHELL': '/bin/bash', 03:21:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rVq6CUZ1kq/Listeners', 03:21:15 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 03:21:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:15 INFO - 'USER': 'cltbld', 03:21:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:15 INFO - 'XPC_FLAGS': '0x0', 03:21:15 INFO - 'XPC_SERVICE_NAME': '0', 03:21:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:15 INFO - Downloading/unpacking psutil>=3.1.1 03:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:21:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:21:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:21:19 INFO - Installing collected packages: psutil 03:21:19 INFO - Running setup.py install for psutil 03:21:19 INFO - building 'psutil._psutil_osx' extension 03:21:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:21:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:21:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:21:20 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:21:20 INFO - building 'psutil._psutil_posix' extension 03:21:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:21:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:21:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:21:20 INFO - ^ 03:21:20 INFO - 1 warning generated. 03:21:20 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:21:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:21:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:21:20 INFO - Successfully installed psutil 03:21:20 INFO - Cleaning up... 03:21:20 INFO - Return code: 0 03:21:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1017ae490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101724570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca50cdcf70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015c2d30>, '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 0x1013e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015bab20>, '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.Ck7cqgCM62/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.rVq6CUZ1kq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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:21:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:21:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:21:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ck7cqgCM62/Render', 03:21:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:20 INFO - 'HOME': '/Users/cltbld', 03:21:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:20 INFO - 'LOGNAME': 'cltbld', 03:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:20 INFO - 'MOZ_NO_REMOTE': '1', 03:21:20 INFO - 'NO_EM_RESTART': '1', 03:21:20 INFO - 'PAGER': '/bin/cat', 03:21:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:20 INFO - 'PWD': '/builds/slave/test', 03:21:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:20 INFO - 'SHELL': '/bin/bash', 03:21:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rVq6CUZ1kq/Listeners', 03:21:20 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 03:21:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:20 INFO - 'USER': 'cltbld', 03:21:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:20 INFO - 'XPC_FLAGS': '0x0', 03:21:20 INFO - 'XPC_SERVICE_NAME': '0', 03:21:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:21:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:21:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:21:24 INFO - Installing collected packages: mozsystemmonitor 03:21:24 INFO - Running setup.py install for mozsystemmonitor 03:21:24 INFO - Successfully installed mozsystemmonitor 03:21:24 INFO - Cleaning up... 03:21:24 INFO - Return code: 0 03:21:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:21:24 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:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:24 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:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:24 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 0x1017ae490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101724570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca50cdcf70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015c2d30>, '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 0x1013e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015bab20>, '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.Ck7cqgCM62/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.rVq6CUZ1kq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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:21:24 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:21:24 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:21:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ck7cqgCM62/Render', 03:21:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:24 INFO - 'HOME': '/Users/cltbld', 03:21:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:24 INFO - 'LOGNAME': 'cltbld', 03:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:24 INFO - 'MOZ_NO_REMOTE': '1', 03:21:24 INFO - 'NO_EM_RESTART': '1', 03:21:24 INFO - 'PAGER': '/bin/cat', 03:21:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:24 INFO - 'PWD': '/builds/slave/test', 03:21:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:24 INFO - 'SHELL': '/bin/bash', 03:21:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rVq6CUZ1kq/Listeners', 03:21:24 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 03:21:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:24 INFO - 'USER': 'cltbld', 03:21:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:24 INFO - 'XPC_FLAGS': '0x0', 03:21:24 INFO - 'XPC_SERVICE_NAME': '0', 03:21:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:25 INFO - Downloading/unpacking jsonschema==2.5.1 03:21:25 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:21:25 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:21:25 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:21:25 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:21:25 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:21:25 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:21:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:21:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:27 INFO - Downloading functools32-3.2.3-2.tar.gz 03:21:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:21:28 INFO - warning: no files found matching '*.txt' 03:21:28 INFO - no previously-included directories found matching 'build' 03:21:28 INFO - no previously-included directories found matching 'dist' 03:21:28 INFO - no previously-included directories found matching '.git*' 03:21:28 INFO - Installing collected packages: jsonschema, functools32 03:21:28 INFO - Running setup.py install for functools32 03:21:28 INFO - warning: no files found matching '*.txt' 03:21:28 INFO - no previously-included directories found matching 'build' 03:21:28 INFO - no previously-included directories found matching 'dist' 03:21:28 INFO - no previously-included directories found matching '.git*' 03:21:28 INFO - Successfully installed jsonschema functools32 03:21:28 INFO - Cleaning up... 03:21:28 INFO - Return code: 0 03:21:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1017ae490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101724570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca50cdcf70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015c2d30>, '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 0x1013e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015bab20>, '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.Ck7cqgCM62/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.rVq6CUZ1kq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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:21:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:21:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ck7cqgCM62/Render', 03:21:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:28 INFO - 'HOME': '/Users/cltbld', 03:21:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:28 INFO - 'LOGNAME': 'cltbld', 03:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:28 INFO - 'MOZ_NO_REMOTE': '1', 03:21:28 INFO - 'NO_EM_RESTART': '1', 03:21:28 INFO - 'PAGER': '/bin/cat', 03:21:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:28 INFO - 'PWD': '/builds/slave/test', 03:21:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:28 INFO - 'SHELL': '/bin/bash', 03:21:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rVq6CUZ1kq/Listeners', 03:21:28 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 03:21:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:28 INFO - 'USER': 'cltbld', 03:21:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:28 INFO - 'XPC_FLAGS': '0x0', 03:21:28 INFO - 'XPC_SERVICE_NAME': '0', 03:21:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:21:28 INFO - Cleaning up... 03:21:28 INFO - Return code: 0 03:21:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1017ae490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101724570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca50cdcf70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015c2d30>, '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 0x1013e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015bab20>, '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.Ck7cqgCM62/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.rVq6CUZ1kq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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:21:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:21:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ck7cqgCM62/Render', 03:21:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:28 INFO - 'HOME': '/Users/cltbld', 03:21:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:28 INFO - 'LOGNAME': 'cltbld', 03:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:28 INFO - 'MOZ_NO_REMOTE': '1', 03:21:28 INFO - 'NO_EM_RESTART': '1', 03:21:28 INFO - 'PAGER': '/bin/cat', 03:21:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:28 INFO - 'PWD': '/builds/slave/test', 03:21:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:28 INFO - 'SHELL': '/bin/bash', 03:21:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rVq6CUZ1kq/Listeners', 03:21:28 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 03:21:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:28 INFO - 'USER': 'cltbld', 03:21:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:28 INFO - 'XPC_FLAGS': '0x0', 03:21:28 INFO - 'XPC_SERVICE_NAME': '0', 03:21:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:28 INFO - Downloading/unpacking blobuploader==1.2.4 03:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:31 INFO - Downloading blobuploader-1.2.4.tar.gz 03:21:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:21:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:21:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:32 INFO - Downloading docopt-0.6.1.tar.gz 03:21:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:21:32 INFO - Installing collected packages: blobuploader, requests, docopt 03:21:32 INFO - Running setup.py install for blobuploader 03:21:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:21:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:21:32 INFO - Running setup.py install for requests 03:21:33 INFO - Running setup.py install for docopt 03:21:33 INFO - Successfully installed blobuploader requests docopt 03:21:33 INFO - Cleaning up... 03:21:33 INFO - Return code: 0 03:21:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21:33 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:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:33 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:21:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:33 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 0x1017ae490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101724570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca50cdcf70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015c2d30>, '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 0x1013e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015bab20>, '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.Ck7cqgCM62/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.rVq6CUZ1kq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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:21:33 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:21:33 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:21:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ck7cqgCM62/Render', 03:21:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:33 INFO - 'HOME': '/Users/cltbld', 03:21:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:33 INFO - 'LOGNAME': 'cltbld', 03:21:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:33 INFO - 'MOZ_NO_REMOTE': '1', 03:21:33 INFO - 'NO_EM_RESTART': '1', 03:21:33 INFO - 'PAGER': '/bin/cat', 03:21:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:33 INFO - 'PWD': '/builds/slave/test', 03:21:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:33 INFO - 'SHELL': '/bin/bash', 03:21:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rVq6CUZ1kq/Listeners', 03:21:33 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 03:21:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:33 INFO - 'USER': 'cltbld', 03:21:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:33 INFO - 'XPC_FLAGS': '0x0', 03:21:33 INFO - 'XPC_SERVICE_NAME': '0', 03:21:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:21:33 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-75OVsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:21:33 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-WU4mvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:21:33 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-xScDC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:21:34 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-iHWn5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:21:34 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-8DgUAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:21:34 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-06wP7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:21:34 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-lvZMTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:21:34 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-WrSzFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:21:34 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-hfTYC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:21:34 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-B31u9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:21:34 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-SEl5Ok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:21:34 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-v7MeBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:21:35 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-YC6z07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:21:35 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-rSLOKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:35 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-y6Zt_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:21:35 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-HpnJWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:21:35 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-VdUbbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:21:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:21:35 INFO - Running setup.py install for manifestparser 03:21:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:21:35 INFO - Running setup.py install for mozcrash 03:21:35 INFO - Running setup.py install for mozdebug 03:21:35 INFO - Running setup.py install for mozdevice 03:21:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:21:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:21:36 INFO - Running setup.py install for mozfile 03:21:36 INFO - Running setup.py install for mozhttpd 03:21:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:21:36 INFO - Running setup.py install for mozinfo 03:21:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:21:36 INFO - Running setup.py install for mozInstall 03:21:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:21:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:21:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:21:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:21:36 INFO - Running setup.py install for mozleak 03:21:36 INFO - Running setup.py install for mozlog 03:21:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:21:37 INFO - Running setup.py install for moznetwork 03:21:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:21:37 INFO - Running setup.py install for mozprocess 03:21:37 INFO - Running setup.py install for mozprofile 03:21:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:21:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:21:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:21:37 INFO - Running setup.py install for mozrunner 03:21:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:21:37 INFO - Running setup.py install for mozscreenshot 03:21:37 INFO - Running setup.py install for moztest 03:21:37 INFO - Running setup.py install for mozversion 03:21:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:21:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:21:38 INFO - Cleaning up... 03:21:38 INFO - Return code: 0 03:21:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21:38 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:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:38 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:21:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:38 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 0x1017ae490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101724570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca50cdcf70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015c2d30>, '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 0x1013e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015bab20>, '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.Ck7cqgCM62/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.rVq6CUZ1kq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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:21:38 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:21:38 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:21:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ck7cqgCM62/Render', 03:21:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:38 INFO - 'HOME': '/Users/cltbld', 03:21:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:38 INFO - 'LOGNAME': 'cltbld', 03:21:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:38 INFO - 'MOZ_NO_REMOTE': '1', 03:21:38 INFO - 'NO_EM_RESTART': '1', 03:21:38 INFO - 'PAGER': '/bin/cat', 03:21:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:38 INFO - 'PWD': '/builds/slave/test', 03:21:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:38 INFO - 'SHELL': '/bin/bash', 03:21:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rVq6CUZ1kq/Listeners', 03:21:38 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 03:21:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:38 INFO - 'USER': 'cltbld', 03:21:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:38 INFO - 'XPC_FLAGS': '0x0', 03:21:38 INFO - 'XPC_SERVICE_NAME': '0', 03:21:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:21:38 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-sCkwoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:21:38 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:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:21:38 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-A2snwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:21:38 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-80wDii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:21:38 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-K6_rod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:21:38 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-7h21hm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:21:38 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-jmlZKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:21:39 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:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:21:39 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-D_QMV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:21:39 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:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:21:39 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-p6qEYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:21:39 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:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:21:39 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-qzJJLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:21:39 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:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:21:39 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-avBWE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:21:39 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:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:21:39 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-H7oLqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:21:39 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:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:21:39 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-dMFKVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:21:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:21:39 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-79W_GP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:21:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:21:39 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-yOC59S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:21:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:39 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-24Nq6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:21:39 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-SuUwrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:21:40 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-XYMLPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:21:40 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:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:21:40 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:21:40 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:21:40 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:21:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:21:40 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:21:40 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:21:40 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:21:40 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:21:40 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:21:40 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:21:42 INFO - Downloading blessings-1.6.tar.gz 03:21:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:21:42 INFO - Installing collected packages: blessings 03:21:42 INFO - Running setup.py install for blessings 03:21:42 INFO - Successfully installed blessings 03:21:42 INFO - Cleaning up... 03:21:42 INFO - Return code: 0 03:21:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:21:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:21:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:21:43 INFO - Reading from file tmpfile_stdout 03:21:43 INFO - Current package versions: 03:21:43 INFO - blessings == 1.6 03:21:43 INFO - blobuploader == 1.2.4 03:21:43 INFO - docopt == 0.6.1 03:21:43 INFO - functools32 == 3.2.3-2 03:21:43 INFO - jsonschema == 2.5.1 03:21:43 INFO - manifestparser == 1.1 03:21:43 INFO - mozInstall == 1.12 03:21:43 INFO - mozcrash == 0.17 03:21:43 INFO - mozdebug == 0.1 03:21:43 INFO - mozdevice == 0.48 03:21:43 INFO - mozfile == 1.2 03:21:43 INFO - mozhttpd == 0.7 03:21:43 INFO - mozinfo == 0.9 03:21:43 INFO - mozleak == 0.1 03:21:43 INFO - mozlog == 3.4 03:21:43 INFO - moznetwork == 0.27 03:21:43 INFO - mozprocess == 0.23 03:21:43 INFO - mozprofile == 0.28 03:21:43 INFO - mozrunner == 6.12 03:21:43 INFO - mozscreenshot == 0.1 03:21:43 INFO - mozsystemmonitor == 0.3 03:21:43 INFO - moztest == 0.7 03:21:43 INFO - mozversion == 1.4 03:21:43 INFO - psutil == 3.1.1 03:21:43 INFO - requests == 1.2.3 03:21:43 INFO - wsgiref == 0.1.2 03:21:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:43 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 0x1017ae490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101724570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca50cdcf70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015c2d30>, '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 0x1013e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015bab20>, '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.Ck7cqgCM62/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.rVq6CUZ1kq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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:21:43 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:21:43 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:21:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ck7cqgCM62/Render', 03:21:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:43 INFO - 'HOME': '/Users/cltbld', 03:21:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:43 INFO - 'LOGNAME': 'cltbld', 03:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:43 INFO - 'MOZ_NO_REMOTE': '1', 03:21:43 INFO - 'NO_EM_RESTART': '1', 03:21:43 INFO - 'PAGER': '/bin/cat', 03:21:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:43 INFO - 'PWD': '/builds/slave/test', 03:21:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:43 INFO - 'SHELL': '/bin/bash', 03:21:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rVq6CUZ1kq/Listeners', 03:21:43 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 03:21:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:43 INFO - 'USER': 'cltbld', 03:21:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:43 INFO - 'XPC_FLAGS': '0x0', 03:21:43 INFO - 'XPC_SERVICE_NAME': '0', 03:21:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:21:43 INFO - Cleaning up... 03:21:43 INFO - Return code: 0 03:21:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1017ae490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101724570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca50cdcf70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015c2d30>, '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 0x1013e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015bab20>, '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.Ck7cqgCM62/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.rVq6CUZ1kq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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:21:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:21:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:21:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ck7cqgCM62/Render', 03:21:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:43 INFO - 'HOME': '/Users/cltbld', 03:21:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:43 INFO - 'LOGNAME': 'cltbld', 03:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:43 INFO - 'MOZ_NO_REMOTE': '1', 03:21:43 INFO - 'NO_EM_RESTART': '1', 03:21:43 INFO - 'PAGER': '/bin/cat', 03:21:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:43 INFO - 'PWD': '/builds/slave/test', 03:21:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:43 INFO - 'SHELL': '/bin/bash', 03:21:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rVq6CUZ1kq/Listeners', 03:21:43 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 03:21:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:43 INFO - 'USER': 'cltbld', 03:21:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:43 INFO - 'XPC_FLAGS': '0x0', 03:21:43 INFO - 'XPC_SERVICE_NAME': '0', 03:21:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:21:43 INFO - Cleaning up... 03:21:43 INFO - Return code: 0 03:21:43 INFO - Running post-action listener: _resource_record_post_action 03:21:43 INFO - Running post-action listener: _start_resource_monitoring 03:21:43 INFO - Starting resource monitoring. 03:21:43 INFO - [mozharness: 2016-10-15 10:21:43.866868Z] Finished create-virtualenv step (success) 03:21:43 INFO - [mozharness: 2016-10-15 10:21:43.867864Z] Running install step. 03:21:43 INFO - Running pre-action listener: _resource_record_pre_action 03:21:43 INFO - Running main action method: install 03:21:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:21:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:21:44 INFO - Reading from file tmpfile_stdout 03:21:44 INFO - Detecting whether we're running mozinstall >=1.0... 03:21:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:21:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:21:44 INFO - Reading from file tmpfile_stdout 03:21:44 INFO - Output received: 03:21:44 INFO - Usage: mozinstall [options] installer 03:21:44 INFO - Options: 03:21:44 INFO - -h, --help show this help message and exit 03:21:44 INFO - -d DEST, --destination=DEST 03:21:44 INFO - Directory to install application into. [default: 03:21:44 INFO - "/builds/slave/test"] 03:21:44 INFO - --app=APP Application being installed. [default: firefox] 03:21:44 INFO - mkdir: /builds/slave/test/build/application 03:21:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:21:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 03:22:18 INFO - Reading from file tmpfile_stdout 03:22:18 INFO - Output received: 03:22:18 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:22:18 INFO - Running post-action listener: _resource_record_post_action 03:22:18 INFO - [mozharness: 2016-10-15 10:22:18.153037Z] Finished install step (success) 03:22:18 INFO - [mozharness: 2016-10-15 10:22:18.153181Z] Running run-tests step. 03:22:18 INFO - Running pre-action listener: _resource_record_pre_action 03:22:18 INFO - Running main action method: run_tests 03:22:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:22:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:22:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:22:18 INFO - 2016-10-15 03:22:18.167 screenresolution[1643:7672] starting screenresolution argv=screenresolution get 03:22:18 INFO - 2016-10-15 03:22:18.170 screenresolution[1643:7672] Display 0: 1600x1200x32@60 03:22:18 INFO - 2016-10-15 03:22:18.176 screenresolution[1644:7674] starting screenresolution argv=screenresolution list 03:22:18 INFO - Available Modes on Display 0 03:22:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:22:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:22:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:22:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:22:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:22:18 INFO - Intel Iris: 03:22:18 INFO - Chipset Model: Intel Iris 03:22:18 INFO - Type: GPU 03:22:18 INFO - Bus: Built-In 03:22:18 INFO - VRAM (Dynamic, Max): 1536 MB 03:22:18 INFO - Vendor: Intel (0x8086) 03:22:18 INFO - Device ID: 0x0a2e 03:22:18 INFO - Revision ID: 0x0009 03:22:18 INFO - Displays: 03:22:18 INFO - Display: 03:22:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:22:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:22:18 INFO - Display Serial Number: 1600x1200 60 03:22:18 INFO - Main Display: Yes 03:22:18 INFO - Mirror: Off 03:22:18 INFO - Online: Yes 03:22:18 INFO - Rotation: Supported 03:22:18 INFO - Return code: 0 03:22:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:22:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:22:18 INFO - Python 2.7.3 03:22:18 INFO - Return code: 0 03:22:18 INFO - grabbing minidump binary from tooltool 03:22:18 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:22:18 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 0x1015c2d30>, '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 0x1013e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015bab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:22:18 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:22:18 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:22:18 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:22:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:22:18 INFO - Return code: 0 03:22:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:22:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:22:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:22:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:22:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:22:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ickyj82URcuAItKy8ukftQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:22:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ickyj82URcuAItKy8ukftQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:22:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ck7cqgCM62/Render', 03:22:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:18 INFO - 'HOME': '/Users/cltbld', 03:22:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:18 INFO - 'LOGNAME': 'cltbld', 03:22:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:22:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:22:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:18 INFO - 'MOZ_NO_REMOTE': '1', 03:22:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:22:18 INFO - 'NO_EM_RESTART': '1', 03:22:18 INFO - 'PAGER': '/bin/cat', 03:22:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:18 INFO - 'PWD': '/builds/slave/test', 03:22:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:22:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:18 INFO - 'SHELL': '/bin/bash', 03:22:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rVq6CUZ1kq/Listeners', 03:22:18 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 03:22:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:18 INFO - 'USER': 'cltbld', 03:22:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:18 INFO - 'XPC_FLAGS': '0x0', 03:22:18 INFO - 'XPC_SERVICE_NAME': '0', 03:22:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ickyj82URcuAItKy8ukftQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:22:18 INFO - mozversion application_buildid: 20161015021335 03:22:18 INFO - mozversion application_changeset: 04c1662be2ba75c56a625799ebaccbe487005941 03:22:18 INFO - mozversion application_display_name: Nightly 03:22:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:22:18 INFO - mozversion application_name: Firefox 03:22:18 INFO - mozversion application_remotingname: firefox 03:22:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 03:22:18 INFO - mozversion application_vendor: Mozilla 03:22:18 INFO - mozversion application_version: 52.0a1 03:22:18 INFO - mozversion platform_buildid: 20161015021335 03:22:18 INFO - mozversion platform_changeset: 04c1662be2ba75c56a625799ebaccbe487005941 03:22:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 03:22:18 INFO - mozversion platform_version: 52.0a1 03:22:18 INFO - using testdate: 1476526938 03:22:18 INFO - actual date: 1476526938 03:22:18 INFO - starting webserver on 'localhost:49273' 03:22:18 INFO - SUITE-START | Running 2 tests 03:22:18 INFO - TEST-START | dromaeo_css 03:22:18 INFO - operating with platform_type : mac_ 03:22:18 INFO - Initialising browser for dromaeo_css test... 03:22:18 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpe4wawh/profile http://localhost:49273/getInfo.html) 03:22:21 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 03:22:21 INFO - PROCESS | 1654 | colorDepth:24 03:22:21 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 03:22:21 INFO - PROCESS | 1654 | __metrics 03:22:21 INFO - PROCESS | 1654 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:22:21 INFO - PROCESS | 1654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:22:22 INFO - TEST-INFO | 1654: exit 0 03:22:22 INFO - Browser initialized. 03:22:22 INFO - Running cycle 1/1 for dromaeo_css test... 03:22:22 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpe4wawh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:22:34 INFO - PROCESS | 1656 | RSS: Main: 240336896 03:22:34 INFO - PROCESS | 1656 | 03:23:24 INFO - PROCESS | 1656 | 1476527004980 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:25:38 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 03:25:40 INFO - PROCESS | 1656 | RSS: Main: 410157056 03:25:40 INFO - PROCESS | 1656 | 03:28:43 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 03:28:43 INFO - PROCESS | 1656 | RSS: Main: 379875328 03:28:43 INFO - PROCESS | 1656 | 03:31:46 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 03:31:46 INFO - PROCESS | 1656 | RSS: Main: 332427264 03:31:46 INFO - PROCESS | 1656 | 03:34:49 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 03:34:49 INFO - PROCESS | 1656 | RSS: Main: 334024704 03:34:49 INFO - PROCESS | 1656 | 03:37:53 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 03:37:53 INFO - PROCESS | 1656 | RSS: Main: 329064448 03:37:53 INFO - PROCESS | 1656 | 03:40:57 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 03:40:57 INFO - PROCESS | 1656 | RSS: Main: 380899328 03:40:57 INFO - PROCESS | 1656 | 03:40:57 INFO - PROCESS | 1656 | __start_tp_report 03:40:57 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 03:40:57 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 03:40:57 INFO - PROCESS | 1656 | |i|pagename|runs| 03:40:57 INFO - PROCESS | 1656 | |0;dojo.html;2752.4907892039973;3299.5329154856486;3316.0714999800066;3317.319949410371;3366.6633336666337;5543.77824887005;5554.805581804638;5617.354004289508;5621.634593751403;5676.716164191785;5615.5507559395255;5644.125160600113;5725.627834190775;5754.683492407927;5766.279215098113;4438.001449673814;5030.5975521958335;5114.718690472023;5134.974325128388;5171.146760784466;5129.9230511542355;5268.8155914542995;5277.577793776489;5285.550728188108;5336.17289320156;5222.791088356461;5233.502817232395;5244.711540865251;5283.656562323436;5317.9468205317835;5091.210862316347;5126.512981266811;5156.613254005927;5159.329287192679;5175.741212939338;5101;5122.308488354099;5129.512696293846;5186;5211.739413029333;5658.321001479808;5662.886742265173;5670.971645141748;5689.288838895138;5696.658200507942;5915.556333275022;6013.067974463965;6185.103160041769;6199.504039676815;6214.036824292197;6086.330503644595;6129.423327329985;6136.723847426876;6169.321374648785;6198.163247961513;5709.0865461525955;5714.314282286152;5717.056685646905;5720.141978703145;5751.223584816038;6312.210973628296;6316.842078948063;6327.240731112204;6334.081558174131;6335.176427064544;5868.559858010666;5924.348321684612;5935.080062590306;5994.310654274815;6071.453569178795;6202.007678771465;6223.906641400383;6231.968840155861;6245.125682404467;6245.6252624842655;6069.908951365733;6090.786822461193;6105.45050945417;6150.384961503813;6157.261128664589;5991.730372133265;6070.3929607038945;6071.726772295257;6178.62928224299;6216.720247588869;4834.734089625034;4853.6602437829715;4886.60907127429;4897.902041959141;4941.234108713155;4344.869653910388;4360.956390436118;4370.847020354272;4381.7151885128005;4421.9336709949375;5631.155326700946;5648.548116150698;5653.406392328746;5659.236003139524;5661.688607126565;6090.939090609126;6119.685352982159;6125.693326622233;6130.612163469634;6165.599236049642;5637.633553818989;5639.154126880919;5648.265725455664;5657.377688454267;5661.688607126565;4678.485366609671;5321.787128514893;5339.759710813023;5341.0653135701095;5369.731513424314;6144.252464225824;6273.780417685359;6284.937150628618;6290.528210384148;6294.748210071729;6142.907856382247;6154.846128846814;6174.38256174379;6215.409536094064;6228.564000520101;6233.2208473940755;6265.592736472115;6283.088952102011;6283.842903927439;6303.243610766737;5965.880682386415;6090.786822461193;6133.080037994337;6133.662648554372;6158.414950579688;5124;5208.5312321891215;6147.954847675996;6152.046432802923;6160.969195153995;5875.559333050124;5916.26046744157;5942;5956.642601443928;6030.30651475086;5909.468147866713;5946.286445626552;5956.940430595639;5959.91060134107;5973.283206015306;5019.548240658358;5713;5767.192593036894;5782.10377391505;5801.3908539602735;5893.381194974466;5981.581289309706;6028.758849645965;6049.364816694184;6114.357992410733;5712.542996560348;5769.94230057694;5772.826815195383;5876.08920617305;5885.3820348862755 03:40:57 INFO - PROCESS | 1656 | |1;ext.html;471.26717953582175;475.7573637444902;536.1662614634242;536.3778017499701;555.2504119438761;39499.40750888739;41132.79433602832;41188.970275743086;42159;43575.56424435755;42744.3588346175;43110.78444607781;43172;43330.783346083226;43447.56552434475;8491.61787719554;8727.170918762708;9432.905670943288;9645.131938125567;9660.565274562661;11298.265612735187;11590.710232244219;11629.47667354971;11745.530178792838;11796.941015294911;11421.828672569918;11464.426778661034;11486.885131148707;11488.195826292163;11506.769864602704;11284.548618055267;11435.5425782969;11512.194146409754;11513.963743263104;11527.308361498337;9978.600855965826;11104.944475277653;11210.607628733036;11340.716482087932;11371.31772093677;39755.403668944986;40030.799846000875;40041.199176016315;40133.79933100345;40194.39708404376;3329.400707872582;3460.3598334308235;3510.420780571228;3740.513733214692;3786.129190286222;30069.39861202764;31405.52891706626;31497.480201583818;31576.210594735086;31616;2575.2789219018705;2798.734120258572;3198.424283628946;3234.822084785336;3303.8348082596012;470316.64841675916;473153;476212;477214;478797;57269;57460;57667.42332576704;57713;57767;61836.690816545626;62145;62145;62187;62197.06704399438;16203.83796162047;16367;16411;16423.507294781175;16432.342706291853;11450.427478626201;11683.591074312359;12542.561010364594;12632.115751897463;12781.360931953364;13429.529966451128;15745.763813542806;15807.13060781645;15854.365825367087;15992.360305587647;6498.772542960974;7183.820404489929;7262.709491620276;7288.234735352712;7329.340359367682;782.8121250899743;817.4604760857924;915.9450432974043;974.9951250243845;1080.2654195147375;23859.522809543712;29978;30208.09375718732;30870.228244293623;30945.381092378477;1022.2282176956351;1062.5112448273726;1069.4492336446735;1069.6042464288264;1084.5824357622373;15573;15584.142977090045;15602.29789659468;15821;16047.67904641924;636030;638819.0295242656;639602;640041;640168;58149.709251453474;58312.41687583155;58441;58458.707706461195;58510.7074464625;1261.709806744454;1303.7588046211292;1378.7035787305776;1407.90848594841;1436.3392839293833;29356.119316420543;30861.91380861896;31066.534001989538;31123.91066312668;31877.043688689377;48478.757606211744;48927.75536122439;48933.2660010093;48991;49035;527100;529724;530044;530726;530997;25549.105781297567;26257.737422626295;26369.60445593356;27195;39289;39304.80347598244;47472.76263618798;47672.76163619159;48052.27921581249;48970.26544601905;38682.8395148146;39104;39550.81347559578;40932.97667558335;40970;38892.6110738889;38922.80538597289;38957;40068.998275043356;40964.1807163861;38015.61984380121;38714.64498742531;38848.22303553857;38941.02647433837;38951.80524097361;30467;34296.48555271623;34355.65644343525;34472.310553789284;34598;24647.876760616084;25236;25301.367465812764;25767;25975 03:40:57 INFO - PROCESS | 1656 | |2;jquery.html;353.1119235123663;370.4128955605367;373.5088358808167;384.1280293733225;404.3994667918141;12898.935505322472;14761.557153285405;15662;19992.50018749532;20775.026372494587;19931.701024484646;20381.694274585894;20788.480287992807;21104;21280.4679883003;5226.90235050638;5696.8860622787415;6002.459778619924;6003.849903752397;6021.518278537728;5216.869578260555;5918.58569900105;5990.341062483123;5993.220881285427;6000.6099603525845;5623.662580245178;5844.094165404369;5926.1110833374905;5936.495397891184;5948.553858460611;5847.386024467433;5906.586538942276;5908.704564771766;5911.970440147815;5912.142739302799;4870.269459581055;5070.2141168119;5118.411382691001;5129.410117836422;5136.203888397305;25181.87409062961;25609.23172304834;25704.14437834321;25809.870950645316;25876.611850822253;2201.4606421426693;2247.5167838914713;2263.2418139923147;2350.8354415190943;2381.7022872140983;15144.697106057927;15156.696866062617;15353.232338383035;15463.690726185525;15483.838712096638;1781.3943259291773;1805.972910406345;1842.3275504440917;1883.52911772057;1915.6264528416964;98409.50795245978;100074;100718;101667;101682.49158754159;10171.7457063574;10502.947485262677;10515;10760.408177550153;10844.67465976022;13276.137051091648;13366.26485543285;13403.530876419278;13422.395992180376;13423.798643020362;8121.715739949073;8376.832463350698;8410.495370277802;8572.828543429221;8592.828143437097;8426.452280601741;8437.873431898526;8443.788905277417;8643.438176518506;8645.221930026202;6441.227052753699;6544.116544266463;6545.0182472629485;6560.080764060043;6585.407313341822;1748.2220411916828;1798.7391828185102;1814.9364772233173;1822.82683145101;1842.4012196036342;686.7870960002415;854.1251951965377;870.1342164546317;910.1353713971753;978.2663002747939;18358.908205458887;21535.892320538296;22457.88771056167;22478.32565023052;22600.434989125402;934.6401635370431;941.5527624378366;946.3091942881597;989.1938070472542;1052.7210289273348;8946.37375383717;10432.426216558162;11160.386178760245;11884.227525210834;11899.405029748477;564737;572719;572925;573780.1310993502;589695;104276.47861760642;104354.4782276099;105431.41852872213;107746;110502;1010.6715317521835;1053.5891002509027;1095.9780804383868;1100.3068067117665;1101.0640955188026;18354.174062166967;18816.96506692145;19147.851128932307;19380.4185874424;19506.512337191685;32533.837330813196;43870.34194487021;46589;47969.520304796504;48586.75706621444;63219.683901580196;63746.04380934383;63895.680521597096;65484;70932;7743.186965368781;7804.843903121792;7966.880496792437;7993.240642138988;8185.345172386314;13023.348832558524;13210.141340812816;13292.933535332262;13689.657758556115;13736.65658358509;10695.89304106949;11586.362750048827;11767.941160294144;11955.282683039046;12000.519979201083;11322.94338528302;11456.083513318748;11520.88479115198;11638.359890205782;11833.171677982458;9982.700518984442;11066.170037247399;11628.709282268012;11831.585894493652;12010.979066779422;8089.3528517719615;8183.3862460316905;8371.539565323965;8535.31717462589;8632.093630168742;9809.950950245204;11738.354390508604;11920.165588408729;11976.981956533793;12002.459889305177 03:40:57 INFO - PROCESS | 1656 | |3;mootools.html;1376.463179360049;1532.7317719399102;1560.9765853512197;1789.221688565474;1865.552267455811;8453.661853525859;8982.640694372225;8990.370674052803;8995.235404990575;9009.909900901006;7795.883061754064;8103.473274237171;8133.9186608133905;8243.422960392774;8249.29880960119;2151.3653472225733;2167.100653228908;2227.6324406472995;2289.3933107726466;2372.406898275431;2353.9293821185306;2356.375560476475;2369.1115831563166;2396.9041238350533;2397.8920948557356;2370.834041617079;2372.5492156490213;2374.596318625829;2378.1795280628157;2381.535600557892;2330.5921463743775;2380.6310021946624;2385.1771138957206;2385.4632707640817;2390.4501964548253;2343.9296821095395;2365.4204719843747;2371.833971621987;2371.976280237193;2386.642003699442;8826.911730882674;8846.5134417607;8919;8938.64245430182;8951.55242237892;5261.184516399964;5417.702026388547;5419.83740487786;5421.972890135524;5431.782728690848;3500.527428797105;3607.567091948983;3661.7802931824176;3664.3770559005034;3665.5601327840563;1031.6389263757624;1069.58820853971;1088.172988528716;1104.596822159914;1114.504045699664;11555.017823485014;11683.714791372942;11695.532178712841;11712.648620541397;11735.53057877684;3969.4641223435046;4440.4227450431235;4761.190597598347;4842.539958703917;4844.709317440965;9868.259880508847;9934.7019589411;9941.204703623693;9943.80112397748;9947.00529947014;5387.568994480511;5414.5668346532975;5420.674759514442;5424.701641409761;5426.511613954763;4417.271150260171;4829.5653391194965;4899.706017638953;4987.900241995139;4998.650094493423;3657.012606596204;3770.1140232045996;3778.6410291022307;3888.9805550972064;3902.8829135125993;1076.3219171921796;1287.1311864491618;1291.3672300572653;1295.9611211663664;1299.136074510459;796.3509739562354;895.2971917045088;903.6295119001178;924.2098006204733;927.730958022166;5795.652260864362;5803.709814509258;6004.279486461653;6029.638221706711;6191.81424557264;770.460677525723;810.4812919731377;939.793245485992;948.6395169835556;984.8227319082633;3986.8637438330516;4011.1376054147913;4028.5165780106577;4075.775832329191;4112.588741125864;10181.33821301613;10853.674389768319;10863.348199108079;10865.239433239598;10877.347359158475;10780.838287425695;10799.67600971972;10810.945945270223;10832.67501974942;10835.079018283377;8204.466709663853;8253.546054967035;8277.54473503963;8281.54451505173;8295;5084.898302033865;5458.426865179099;5783.872085540386;5926.970365148147;5998.640081595118;10040.497975101362;10198.33710808795;10216.029477199654;10220.488975551045;10244.692659220234;9912.256580756328;10174.982501749766;10306.587736490457;10330.007138257675;10414.635487757892;7321.231270716498;7420.369268612229;7518.624068796647;7519.962400187964;7524.097108347033;7469.626518673936;7771.37828973692;7950.602469876599;8245.422820402515;8290.378221633522;7256.564606123649;7339.302766237199;7339.412846972336;7411.110666720028;7615.504992175491;6325.557210995186;7403.000594919617;7438.962805185939;7464.477486575887;7467.738629148171;6980.127484064492;6984;7047;7066.399356054793;7109.502334836512;4658.650601204856;4711.175544279806;4764.190087685171;4774.641901857305;4894.657373983787;4951.133551628379;4992.850214493571;5133.6919784813035;5134.204198349262;5199.818006369759 03:40:57 INFO - PROCESS | 1656 | |4;prototype.html;300.9157435917943;307.6907707753706;315.0391306515129;322.56936989119527;323.5292649195421;5213.504717051879;5224.320838291022;5359.732013399329;5413.729313534327;5419.349678038631;4369.8033588488515;4944.096522838706;5018.136035252853;5074.847754567369;5229.8954020919555;4028.6172813582807;4053.9662386091654;4068.5524592294896;4072.429859819628;4093.1199792044704;3351.625833408303;4008.875296093075;4017.2568074906235;4045.271851066807;4099.262132816092;3519.4514413657907;3782.6595606395417;3989.800509974504;4002.779847108408;4037.9394309085387;3963.7712309183958;3998.4002399640285;4009.1981603679383;4025.859094931678;4028.509451502948;3441.2773317603333;3454.63726308739;3458.6714262145306;3462.2036931505895;3469.6877281044826;4518.638508919278;5139.974300128475;5157.4584668610005;5191.067047118404;5203.531682148625;4048.542524691109;4401.339799030139;4547.226971414867;4566.474855391606;4618.676692631517;4583.679142460029;4649.04694537619;5043.798248070073;5532.612717109804;5583.497485226349;3047.481928072233;3752.2307926874923;3794.2790869734663;3797.658210761017;3812.894260664404;5400.810971616014;5719.255627033753;5752.856178595527;5792.942070579283;5853.678047707374;3215.437298472758;3329.583802024747;3801.6008319126645;3827.3684842001317;3840.9615903840604;3559.288142371536;3899.532056153223;3918.6277303656107;3922.8626998054933;3931.744436611611;4016.196760647882;4221.366794980716;4582.289745089516;4584.908301834012;4607.58531732139;4926.285688575136;5246.63273570854;5546.944530554723;5548.889022219614;5567.387587365387;1120.092724892823;1243.5647523366931;1260.338322380739;1304.8760367765046;1329.2984979226605;837.8952630921135;851.4465597361765;852.292597144381;895.8118795053111;911.4349103555838;4640.559146881041;4982.928670335895;5137.640365174477;5141.922871156936;5207.3490813648295;4919.803207871717;5243.509333066839;5254.15933450646;5306.46935306474;5727.3699893011735;4141.64795992344;4511.774411279423;4897.510248975074;5176.8964620707375;5337.226102215157;2892.4938135826146;2974.8512574371193;3032.5906002689794;3033.393321335742;3046.512557990711;5257.6845389276;5609.5512359012;5692.612895327274;5912.438318359749;6003.549733769984;5811.4479124483105;5821.476067153892;5884.11738239259;5891.234139561915;5911.305434103685;5232.2413250078525;5629.605927585029;5904.439078287556;5917.526597872246;5968.343482216953;5014.974925125351;5389.487998640123;5715.685637289989;5759.280089988752;5770.374479611851;4768.618510519081;5682.573806964577;5729.598928075162;5735.311762588516;5770.769169233184;5803.332616748959;5960.672163031075;5984.431479009487;6004.369541198286;6004.759809607567;3792.9241415172096;3826.846926122924;3836.3094642964534;3846.3076246451474;3852.345101332724;5183.196604526304;5655.858603534944;5787.39232380594;5821.70891455417;5840.737166827418;5480.534154596904;5549.030094316459;5619.466150715675;5696.487316141402;5712.772018912544;4778.187708089564;5491.423400543045;5515.531179849758;5646.943530564642;5688.459596338341;4747.64392670558;5224.451432599522;5431;5507.476789704971;5513.338399391938;4969.850904472872;5404.297441332602;5624.85937851557;5668.258949093579;5674.177244299636;5248.580113590827;5413.215083812904;5428.07722687152;5458.4541545845095;5478.575570351658 03:40:57 INFO - PROCESS | 1656 | |5;yui.html;735.5476382025053;769.1039938471681;795.5306369242147;795.6459375577869;829.8423299573085;15396.538103856888;16201.756973645404;16206.918965405157;16226.51320460385;16249.268782904783;13417;13440.19358838468;13462.93268533656;13484.730305393887;13762.518311859087;706.3713295167305;731.3162193349209;733.9119305683325;887.6050157679836;895.2077411490828;903.3586153830788;918.5269586163131;925.5881132895864;928.3640706116298;929.6327950459564;966.0098399140867;982.8967958364376;984.3503287830033;984.4634674102596;984.8719666443352;975.858500517421;978.6379039755265;981.0091807274632;982.3712823792779;987.8221920054423;555.4806256150512;574.6982834012135;732.300652876507;733.8348871503869;736.4623824608066;12191.817122743167;12229.388530573437;12245.93877030618;14078.366473508717;14640.853591464056;14349.78475322871;14759.926200369036;14818.184999825005;14865.331060102322;15006.849931500763;11489.712757181138;11735.823962640567;11813.881861181364;11824.940875295655;12164.391780411033;3800.227397981229;3834.9233015339814;3847.942280865789;3857.1321452673205;3885.61143885612;96487;98162.50918745503;106569.46715266451;107369.92630073677;108882.45558772235;10362.689119326433;11225.550977960791;11394.544218231344;11461.713457163638;11867.76264474723;22418.99114539817;22446;22449.877506124627;22472.887635561718;22476.662850057262;8043.678252869937;8079.9192008080345;8213.630386632616;8289.544075075928;8327.541985190872;4122.896927576775;4140.3168477200925;4275.87172384829;4287.592678695519;4510.864674059783;3672.706183505313;3779.338615742234;3834.0606551395085;3834.482344883405;3834.5206849143856;624.5534442873368;678.1150598469045;687.9071325371111;701.719312275094;705.4990956420999;599.2979936979001;671.2714759494322;689.1729924091111;694.3611877073105;696.2550071423528;8039.678412863537;9156.954215228881;9426.85218503856;9575.856362154573;9576.856347154799;630.6027202862167;637.7449020391788;658.7957733102753;669.2303850571881;673.7978606418055;4465.866024019285;4661.766911654404;4681.111714233053;4730.290456431563;4761.880952976134;112797.43601281941;147028;147836.2608186952;149939;153147;131323.34338328248;134334;135095.29809403952;138046.3097684505;138651.30674346766;102250.46624300642;107053.46473267584;112116;112554.43722781334;113755;8984.371094023356;9001.504917229615;9004.54977251148;9030.819383612159;9187.081291871027;63668.36331636809;64790.35209647843;67047.66476167589;67532;68771.31228687649;61466;73159.90260146209;98099;103487.41281467723;103939.480302598;10706.822249552699;11056;11853.170278080452;11883.227590206609;11945.522179113086;11734;11980.04159667242;11995.40022998864;12028.879711202775;12173.45219465144;12049.939750301193;12066.336351500751;12201.938990304992;12232.510699571918;12579.748405031665;12038.217515861441;12278.324692142018;12339.753204935672;12510.937445313079;12644.43100060481;11729.237599556001;11980.940095299467;12012.819807703067;12203.14577979533;12386.194897331645;10539.314944528582;10549.78900421972;10635.627753028606;10753.139748820233;10852.620158294421;9817.656382026595;10474.371537707762;10480.737981550523;10499.265051446631;10522.1056210223 03:40:57 INFO - PROCESS | 1656 | __end_tp_report 03:40:57 INFO - PROCESS | 1656 | __start_cc_report 03:40:57 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,2165 03:40:57 INFO - PROCESS | 1656 | __end_cc_report 03:40:57 INFO - PROCESS | 1656 | __startTimestamp1476528057405__endTimestamp 03:40:57 INFO - PROCESS | 1656 | 03:40:57 INFO - PROCESS | 1656 | ------- Summary: start ------- 03:40:57 INFO - PROCESS | 1656 | Number of tests: 6 03:40:57 INFO - PROCESS | 1656 | 03:40:57 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:5650.85 Median:5772.83 stddev:648.64 (11.2%) stddev-sans-first:609.47 03:40:57 INFO - PROCESS | 1656 | Values: 2752.5 3299.5 3316.1 3317.3 3366.7 5543.8 5554.8 5617.4 5621.6 5676.7 5615.6 5644.1 5725.6 5754.7 5766.3 4438.0 5030.6 5114.7 5135.0 5171.1 5129.9 5268.8 5277.6 5285.6 5336.2 5222.8 5233.5 5244.7 5283.7 5317.9 5091.2 5126.5 5156.6 5159.3 5175.7 5101.0 5122.3 5129.5 5186.0 5211.7 5658.3 5662.9 5671.0 5689.3 5696.7 5915.6 6013.1 6185.1 6199.5 6214.0 6086.3 6129.4 6136.7 6169.3 6198.2 5709.1 5714.3 5717.1 5720.1 5751.2 6312.2 6316.8 6327.2 6334.1 6335.2 5868.6 5924.3 5935.1 5994.3 6071.5 6202.0 6223.9 6232.0 6245.1 6245.6 6069.9 6090.8 6105.5 6150.4 6157.3 5991.7 6070.4 6071.7 6178.6 6216.7 4834.7 4853.7 4886.6 4897.9 4941.2 4344.9 4361.0 4370.8 4381.7 4421.9 5631.2 5648.5 5653.4 5659.2 5661.7 6090.9 6119.7 6125.7 6130.6 6165.6 5637.6 5639.2 5648.3 5657.4 5661.7 4678.5 5321.8 5339.8 5341.1 5369.7 6144.3 6273.8 6284.9 6290.5 6294.7 6142.9 6154.8 6174.4 6215.4 6228.6 6233.2 6265.6 6283.1 6283.8 6303.2 5965.9 6090.8 6133.1 6133.7 6158.4 5124.0 5208.5 6148.0 6152.0 6161.0 5875.6 5916.3 5942.0 5956.6 6030.3 5909.5 5946.3 5956.9 5959.9 5973.3 5019.5 5713.0 5767.2 5782.1 5801.4 5893.4 5981.6 6028.8 6049.4 6114.4 5712.5 5769.9 5772.8 5876.1 5885.4 03:40:57 INFO - PROCESS | 1656 | 03:40:57 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:68638.67 Median:38698.74 stddev:147320.37 (380.7%) stddev-sans-first:147644.74 03:40:57 INFO - PROCESS | 1656 | Values: 471.3 475.8 536.2 536.4 555.3 39499.4 41132.8 41189.0 42159.0 43575.6 42744.4 43110.8 43172.0 43330.8 43447.6 8491.6 8727.2 9432.9 9645.1 9660.6 11298.3 11590.7 11629.5 11745.5 11796.9 11421.8 11464.4 11486.9 11488.2 11506.8 11284.5 11435.5 11512.2 11514.0 11527.3 9978.6 11104.9 11210.6 11340.7 11371.3 39755.4 40030.8 40041.2 40133.8 40194.4 3329.4 3460.4 3510.4 3740.5 3786.1 30069.4 31405.5 31497.5 31576.2 31616.0 2575.3 2798.7 3198.4 3234.8 3303.8 470316.6 473153.0 476212.0 477214.0 478797.0 57269.0 57460.0 57667.4 57713.0 57767.0 61836.7 62145.0 62145.0 62187.0 62197.1 16203.8 16367.0 16411.0 16423.5 16432.3 11450.4 11683.6 12542.6 12632.1 12781.4 13429.5 15745.8 15807.1 15854.4 15992.4 6498.8 7183.8 7262.7 7288.2 7329.3 782.8 817.5 915.9 975.0 1080.3 23859.5 29978.0 30208.1 30870.2 30945.4 1022.2 1062.5 1069.4 1069.6 1084.6 15573.0 15584.1 15602.3 15821.0 16047.7 636030.0 638819.0 639602.0 640041.0 640168.0 58149.7 58312.4 58441.0 58458.7 58510.7 1261.7 1303.8 1378.7 1407.9 1436.3 29356.1 30861.9 31066.5 31123.9 31877.0 48478.8 48927.8 48933.3 48991.0 49035.0 527100.0 529724.0 530044.0 530726.0 530997.0 25549.1 26257.7 26369.6 27195.0 39289.0 39304.8 47472.8 47672.8 48052.3 48970.3 38682.8 39104.0 39550.8 40933.0 40970.0 38892.6 38922.8 38957.0 40069.0 40964.2 38015.6 38714.6 38848.2 38941.0 38951.8 30467.0 34296.5 34355.7 34472.3 34598.0 24647.9 25236.0 25301.4 25767.0 25975.0 03:40:57 INFO - PROCESS | 1656 | 03:40:57 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:32824.31 Median:2366.27 stddev:95044.04 (4016.6%) stddev-sans-first:95279.39 03:40:57 INFO - PROCESS | 1656 | Values: 353.1 370.4 373.5 384.1 404.4 12898.9 14761.6 15662.0 19992.5 20775.0 19931.7 20381.7 20788.5 21104.0 21280.5 5226.9 5696.9 6002.5 6003.8 6021.5 5216.9 5918.6 5990.3 5993.2 6000.6 5623.7 5844.1 5926.1 5936.5 5948.6 5847.4 5906.6 5908.7 5912.0 5912.1 4870.3 5070.2 5118.4 5129.4 5136.2 25181.9 25609.2 25704.1 25809.9 25876.6 2201.5 2247.5 2263.2 2350.8 2381.7 15144.7 15156.7 15353.2 15463.7 15483.8 1781.4 1806.0 1842.3 1883.5 1915.6 98409.5 100074.0 100718.0 101667.0 101682.5 10171.7 10502.9 10515.0 10760.4 10844.7 13276.1 13366.3 13403.5 13422.4 13423.8 8121.7 8376.8 8410.5 8572.8 8592.8 8426.5 8437.9 8443.8 8643.4 8645.2 6441.2 6544.1 6545.0 6560.1 6585.4 1748.2 1798.7 1814.9 1822.8 1842.4 686.8 854.1 870.1 910.1 978.3 18358.9 21535.9 22457.9 22478.3 22600.4 934.6 941.6 946.3 989.2 1052.7 8946.4 10432.4 11160.4 11884.2 11899.4 564737.0 572719.0 572925.0 573780.1 589695.0 104276.5 104354.5 105431.4 107746.0 110502.0 1010.7 1053.6 1096.0 1100.3 1101.1 18354.2 18817.0 19147.9 19380.4 19506.5 32533.8 43870.3 46589.0 47969.5 48586.8 63219.7 63746.0 63895.7 65484.0 70932.0 7743.2 7804.8 7966.9 7993.2 8185.3 13023.3 13210.1 13292.9 13689.7 13736.7 10695.9 11586.4 11767.9 11955.3 12000.5 11322.9 11456.1 11520.9 11638.4 11833.2 9982.7 11066.2 11628.7 11831.6 12011.0 8089.4 8183.4 8371.5 8535.3 8632.1 9810.0 11738.4 11920.2 11977.0 12002.5 03:40:57 INFO - PROCESS | 1656 | 03:40:57 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:5704.38 Median:4897.18 stddev:3209.63 (65.5%) stddev-sans-first:3202.15 03:40:57 INFO - PROCESS | 1656 | Values: 1376.5 1532.7 1561.0 1789.2 1865.6 8453.7 8982.6 8990.4 8995.2 9009.9 7795.9 8103.5 8133.9 8243.4 8249.3 2151.4 2167.1 2227.6 2289.4 2372.4 2353.9 2356.4 2369.1 2396.9 2397.9 2370.8 2372.5 2374.6 2378.2 2381.5 2330.6 2380.6 2385.2 2385.5 2390.5 2343.9 2365.4 2371.8 2372.0 2386.6 8826.9 8846.5 8919.0 8938.6 8951.6 5261.2 5417.7 5419.8 5422.0 5431.8 3500.5 3607.6 3661.8 3664.4 3665.6 1031.6 1069.6 1088.2 1104.6 1114.5 11555.0 11683.7 11695.5 11712.6 11735.5 3969.5 4440.4 4761.2 4842.5 4844.7 9868.3 9934.7 9941.2 9943.8 9947.0 5387.6 5414.6 5420.7 5424.7 5426.5 4417.3 4829.6 4899.7 4987.9 4998.7 3657.0 3770.1 3778.6 3889.0 3902.9 1076.3 1287.1 1291.4 1296.0 1299.1 796.4 895.3 903.6 924.2 927.7 5795.7 5803.7 6004.3 6029.6 6191.8 770.5 810.5 939.8 948.6 984.8 3986.9 4011.1 4028.5 4075.8 4112.6 10181.3 10853.7 10863.3 10865.2 10877.3 10780.8 10799.7 10810.9 10832.7 10835.1 8204.5 8253.5 8277.5 8281.5 8295.0 5084.9 5458.4 5783.9 5927.0 5998.6 10040.5 10198.3 10216.0 10220.5 10244.7 9912.3 10175.0 10306.6 10330.0 10414.6 7321.2 7420.4 7518.6 7520.0 7524.1 7469.6 7771.4 7950.6 8245.4 8290.4 7256.6 7339.3 7339.4 7411.1 7615.5 6325.6 7403.0 7439.0 7464.5 7467.7 6980.1 6984.0 7047.0 7066.4 7109.5 4658.7 4711.2 4764.2 4774.6 4894.7 4951.1 4992.9 5133.7 5134.2 5199.8 03:40:57 INFO - PROCESS | 1656 | 03:40:57 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:4506.09 Median:5138.81 stddev:1394.62 (27.1%) stddev-sans-first:1362.35 03:40:57 INFO - PROCESS | 1656 | Values: 300.9 307.7 315.0 322.6 323.5 5213.5 5224.3 5359.7 5413.7 5419.3 4369.8 4944.1 5018.1 5074.8 5229.9 4028.6 4054.0 4068.6 4072.4 4093.1 3351.6 4008.9 4017.3 4045.3 4099.3 3519.5 3782.7 3989.8 4002.8 4037.9 3963.8 3998.4 4009.2 4025.9 4028.5 3441.3 3454.6 3458.7 3462.2 3469.7 4518.6 5140.0 5157.5 5191.1 5203.5 4048.5 4401.3 4547.2 4566.5 4618.7 4583.7 4649.0 5043.8 5532.6 5583.5 3047.5 3752.2 3794.3 3797.7 3812.9 5400.8 5719.3 5752.9 5792.9 5853.7 3215.4 3329.6 3801.6 3827.4 3841.0 3559.3 3899.5 3918.6 3922.9 3931.7 4016.2 4221.4 4582.3 4584.9 4607.6 4926.3 5246.6 5546.9 5548.9 5567.4 1120.1 1243.6 1260.3 1304.9 1329.3 837.9 851.4 852.3 895.8 911.4 4640.6 4982.9 5137.6 5141.9 5207.3 4919.8 5243.5 5254.2 5306.5 5727.4 4141.6 4511.8 4897.5 5176.9 5337.2 2892.5 2974.9 3032.6 3033.4 3046.5 5257.7 5609.6 5692.6 5912.4 6003.5 5811.4 5821.5 5884.1 5891.2 5911.3 5232.2 5629.6 5904.4 5917.5 5968.3 5015.0 5389.5 5715.7 5759.3 5770.4 4768.6 5682.6 5729.6 5735.3 5770.8 5803.3 5960.7 5984.4 6004.4 6004.8 3792.9 3826.8 3836.3 3846.3 3852.3 5183.2 5655.9 5787.4 5821.7 5840.7 5480.5 5549.0 5619.5 5696.5 5712.8 4778.2 5491.4 5515.5 5646.9 5688.5 4747.6 5224.5 5431.0 5507.5 5513.3 4969.9 5404.3 5624.9 5668.3 5674.2 5248.6 5413.2 5428.1 5458.5 5478.6 03:40:57 INFO - PROCESS | 1656 | 03:40:57 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:24423.00 Median:3789.78 stddev:39334.06 (1037.9%) stddev-sans-first:39404.20 03:40:57 INFO - PROCESS | 1656 | Values: 735.5 769.1 795.5 795.6 829.8 15396.5 16201.8 16206.9 16226.5 16249.3 13417.0 13440.2 13462.9 13484.7 13762.5 706.4 731.3 733.9 887.6 895.2 903.4 918.5 925.6 928.4 929.6 966.0 982.9 984.4 984.5 984.9 975.9 978.6 981.0 982.4 987.8 555.5 574.7 732.3 733.8 736.5 12191.8 12229.4 12245.9 14078.4 14640.9 14349.8 14759.9 14818.2 14865.3 15006.8 11489.7 11735.8 11813.9 11824.9 12164.4 3800.2 3834.9 3847.9 3857.1 3885.6 96487.0 98162.5 106569.5 107369.9 108882.5 10362.7 11225.6 11394.5 11461.7 11867.8 22419.0 22446.0 22449.9 22472.9 22476.7 8043.7 8079.9 8213.6 8289.5 8327.5 4122.9 4140.3 4275.9 4287.6 4510.9 3672.7 3779.3 3834.1 3834.5 3834.5 624.6 678.1 687.9 701.7 705.5 599.3 671.3 689.2 694.4 696.3 8039.7 9157.0 9426.9 9575.9 9576.9 630.6 637.7 658.8 669.2 673.8 4465.9 4661.8 4681.1 4730.3 4761.9 112797.4 147028.0 147836.3 149939.0 153147.0 131323.3 134334.0 135095.3 138046.3 138651.3 102250.5 107053.5 112116.0 112554.4 113755.0 8984.4 9001.5 9004.5 9030.8 9187.1 63668.4 64790.4 67047.7 67532.0 68771.3 61466.0 73159.9 98099.0 103487.4 103939.5 10706.8 11056.0 11853.2 11883.2 11945.5 11734.0 11980.0 11995.4 12028.9 12173.5 12049.9 12066.3 12201.9 12232.5 12579.7 12038.2 12278.3 12339.8 12510.9 12644.4 11729.2 11980.9 12012.8 12203.1 12386.2 10539.3 10549.8 10635.6 10753.1 10852.6 9817.7 10474.4 10480.7 10499.3 10522.1 03:40:57 INFO - PROCESS | 1656 | -------- Summary: end -------- 03:40:57 INFO - PROCESS | 1656 | 03:40:58 INFO - TEST-INFO | 1656: exit 0 03:40:58 INFO - TEST-OK | dromaeo_css | took 1119268ms 03:40:58 INFO - TEST-START | kraken 03:40:58 INFO - operating with platform_type : mac_ 03:40:58 INFO - Initialising browser for kraken test... 03:40:58 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmp6Unihi/profile http://localhost:49273/getInfo.html) 03:41:00 INFO - PROCESS | 1687 | __metrics Screen width/height:1600/1200 03:41:00 INFO - PROCESS | 1687 | colorDepth:24 03:41:00 INFO - PROCESS | 1687 | Browser inner width/height: 1024/689 03:41:00 INFO - PROCESS | 1687 | __metrics 03:41:00 INFO - PROCESS | 1687 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:41:00 INFO - PROCESS | 1687 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:41:01 INFO - TEST-INFO | 1687: exit 0 03:41:01 INFO - Browser initialized. 03:41:01 INFO - Running cycle 1/1 for kraken test... 03:41:01 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmp6Unihi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:41:13 INFO - PROCESS | 1688 | RSS: Main: 231886848 03:41:13 INFO - PROCESS | 1688 | 03:41:15 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 03:41:16 INFO - PROCESS | 1688 | RSS: Main: 292294656 03:41:16 INFO - PROCESS | 1688 | 03:41:19 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 03:41:20 INFO - PROCESS | 1688 | RSS: Main: 293457920 03:41:20 INFO - PROCESS | 1688 | 03:41:23 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 03:41:24 INFO - PROCESS | 1688 | RSS: Main: 387575808 03:41:24 INFO - PROCESS | 1688 | 03:41:26 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 03:41:26 INFO - PROCESS | 1688 | RSS: Main: 289157120 03:41:26 INFO - PROCESS | 1688 | 03:41:28 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:41:29 INFO - PROCESS | 1688 | RSS: Main: 290734080 03:41:29 INFO - PROCESS | 1688 | 03:41:32 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 03:41:32 INFO - PROCESS | 1688 | RSS: Main: 328011776 03:41:32 INFO - PROCESS | 1688 | 03:41:35 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 03:41:36 INFO - PROCESS | 1688 | RSS: Main: 328843264 03:41:36 INFO - PROCESS | 1688 | 03:41:39 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 03:41:39 INFO - PROCESS | 1688 | RSS: Main: 329936896 03:41:39 INFO - PROCESS | 1688 | 03:41:41 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:41:41 INFO - PROCESS | 1688 | RSS: Main: 303026176 03:41:41 INFO - PROCESS | 1688 | 03:41:43 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:41:44 INFO - PROCESS | 1688 | RSS: Main: 305971200 03:41:44 INFO - PROCESS | 1688 | 03:41:46 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:41:47 INFO - PROCESS | 1688 | RSS: Main: 309301248 03:41:47 INFO - PROCESS | 1688 | 03:41:50 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:41:50 INFO - PROCESS | 1688 | RSS: Main: 318046208 03:41:50 INFO - PROCESS | 1688 | 03:41:54 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:41:54 INFO - PROCESS | 1688 | RSS: Main: 317468672 03:41:54 INFO - PROCESS | 1688 | 03:41:56 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 03:41:56 INFO - PROCESS | 1688 | RSS: Main: 361893888 03:41:56 INFO - PROCESS | 1688 | 03:41:56 INFO - PROCESS | 1688 | __start_tp_report 03:41:56 INFO - PROCESS | 1688 | _x_x_mozilla_page_load 03:41:56 INFO - PROCESS | 1688 | _x_x_mozilla_page_load_details 03:41:56 INFO - PROCESS | 1688 | |i|pagename|runs| 03:41:56 INFO - PROCESS | 1688 | |0;ai-astar;103;114;114;111;116;159;165;114;114;112 03:41:56 INFO - PROCESS | 1688 | |1;audio-beat-detection;153;117;115;152;115;112;111;111;142;109 03:41:56 INFO - PROCESS | 1688 | |2;audio-dft;185;186;182;182;185;183;183;183;180;183 03:41:56 INFO - PROCESS | 1688 | |3;audio-fft;76;59;60;105;87;59;58;59;86;75 03:41:56 INFO - PROCESS | 1688 | |4;audio-oscillator;83;71;94;70;68;69;92;67;69;86 03:41:56 INFO - PROCESS | 1688 | |5;imaging-gaussian-blur;87;85;88;84;86;85;88;85;87;84 03:41:56 INFO - PROCESS | 1688 | |6;imaging-darkroom;93;95;95;96;95;94;95;96;94;93 03:41:56 INFO - PROCESS | 1688 | |7;imaging-desaturate;83;81;83;81;82;83;85;99;129;129 03:41:56 INFO - PROCESS | 1688 | |8;json-parse-financial;57;54;55;55;56;57;56;55;56;56 03:41:56 INFO - PROCESS | 1688 | |9;json-stringify-tinderbox;64;71;73;75;75;67;69;69;69;71 03:41:56 INFO - PROCESS | 1688 | |10;stanford-crypto-aes;84;89;90;86;86;86;85;89;85;89 03:41:56 INFO - PROCESS | 1688 | |11;stanford-crypto-ccm;158;143;148;143;142;145;145;142;183;132 03:41:56 INFO - PROCESS | 1688 | |12;stanford-crypto-pbkdf2;193;241;225;171;169;172;170;169;170;168 03:41:56 INFO - PROCESS | 1688 | |13;stanford-crypto-sha256-iterative;68;69;71;68;69;69;68;68;67;70 03:41:56 INFO - PROCESS | 1688 | __end_tp_report 03:41:56 INFO - PROCESS | 1688 | __start_cc_report 03:41:56 INFO - PROCESS | 1688 | _x_x_mozilla_cycle_collect,2087 03:41:56 INFO - PROCESS | 1688 | __end_cc_report 03:41:56 INFO - PROCESS | 1688 | __startTimestamp1476528116633__endTimestamp 03:41:56 INFO - PROCESS | 1688 | 03:41:56 INFO - PROCESS | 1688 | ------- Summary: start ------- 03:41:56 INFO - PROCESS | 1688 | Number of tests: 14 03:41:56 INFO - PROCESS | 1688 | 03:41:56 INFO - PROCESS | 1688 | [#0] ai-astar Cycles:10 Average:122.20 Median:114.00 stddev:21.32 (18.7%) stddev-sans-first:21.45 03:41:56 INFO - PROCESS | 1688 | Values: 103.0 114.0 114.0 111.0 116.0 159.0 165.0 114.0 114.0 112.0 03:41:56 INFO - PROCESS | 1688 | 03:41:56 INFO - PROCESS | 1688 | [#1] audio-beat-detection Cycles:10 Average:123.70 Median:116.00 stddev:17.85 (15.4%) stddev-sans-first:15.46 03:41:56 INFO - PROCESS | 1688 | Values: 153.0 117.0 115.0 152.0 115.0 112.0 111.0 111.0 142.0 109.0 03:41:56 INFO - PROCESS | 1688 | 03:41:56 INFO - PROCESS | 1688 | [#2] audio-dft Cycles:10 Average:183.20 Median:183.00 stddev:1.75 (1.0%) stddev-sans-first:1.73 03:41:56 INFO - PROCESS | 1688 | Values: 185.0 186.0 182.0 182.0 185.0 183.0 183.0 183.0 180.0 183.0 03:41:56 INFO - PROCESS | 1688 | 03:41:56 INFO - PROCESS | 1688 | [#3] audio-fft Cycles:10 Average:72.40 Median:67.50 stddev:16.26 (24.1%) stddev-sans-first:17.20 03:41:56 INFO - PROCESS | 1688 | Values: 76.0 59.0 60.0 105.0 87.0 59.0 58.0 59.0 86.0 75.0 03:41:56 INFO - PROCESS | 1688 | 03:41:56 INFO - PROCESS | 1688 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:77.00 stddev:10.67 (13.9%) stddev-sans-first:11.09 03:41:56 INFO - PROCESS | 1688 | Values: 83.0 71.0 94.0 70.0 68.0 69.0 92.0 67.0 69.0 86.0 03:41:56 INFO - PROCESS | 1688 | 03:41:56 INFO - PROCESS | 1688 | [#5] imaging-gaussian-blur Cycles:10 Average:85.90 Median:86.50 stddev:1.52 (1.8%) stddev-sans-first:1.56 03:41:56 INFO - PROCESS | 1688 | Values: 87.0 85.0 88.0 84.0 86.0 85.0 88.0 85.0 87.0 84.0 03:41:56 INFO - PROCESS | 1688 | 03:41:56 INFO - PROCESS | 1688 | [#6] imaging-darkroom Cycles:10 Average:94.60 Median:95.00 stddev:1.07 (1.1%) stddev-sans-first:0.97 03:41:56 INFO - PROCESS | 1688 | Values: 93.0 95.0 95.0 96.0 95.0 94.0 95.0 96.0 94.0 93.0 03:41:56 INFO - PROCESS | 1688 | 03:41:56 INFO - PROCESS | 1688 | [#7] imaging-desaturate Cycles:10 Average:93.50 Median:83.00 stddev:19.43 (23.4%) stddev-sans-first:20.24 03:41:56 INFO - PROCESS | 1688 | Values: 83.0 81.0 83.0 81.0 82.0 83.0 85.0 99.0 129.0 129.0 03:41:56 INFO - PROCESS | 1688 | 03:41:56 INFO - PROCESS | 1688 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:0.95 (1.7%) stddev-sans-first:0.88 03:41:56 INFO - PROCESS | 1688 | Values: 57.0 54.0 55.0 55.0 56.0 57.0 56.0 55.0 56.0 56.0 03:41:56 INFO - PROCESS | 1688 | 03:41:56 INFO - PROCESS | 1688 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:71.00 stddev:3.47 (4.9%) stddev-sans-first:2.83 03:41:56 INFO - PROCESS | 1688 | Values: 64.0 71.0 73.0 75.0 75.0 67.0 69.0 69.0 69.0 71.0 03:41:56 INFO - PROCESS | 1688 | 03:41:56 INFO - PROCESS | 1688 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:87.50 stddev:2.13 (2.4%) stddev-sans-first:1.99 03:41:56 INFO - PROCESS | 1688 | Values: 84.0 89.0 90.0 86.0 86.0 86.0 85.0 89.0 85.0 89.0 03:41:56 INFO - PROCESS | 1688 | 03:41:56 INFO - PROCESS | 1688 | [#11] stanford-crypto-ccm Cycles:10 Average:148.10 Median:145.00 stddev:13.83 (9.5%) stddev-sans-first:14.20 03:41:56 INFO - PROCESS | 1688 | Values: 158.0 143.0 148.0 143.0 142.0 145.0 145.0 142.0 183.0 132.0 03:41:56 INFO - PROCESS | 1688 | 03:41:56 INFO - PROCESS | 1688 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.80 Median:171.50 stddev:26.70 (15.6%) stddev-sans-first:28.15 03:41:56 INFO - PROCESS | 1688 | Values: 193.0 241.0 225.0 171.0 169.0 172.0 170.0 169.0 170.0 168.0 03:41:56 INFO - PROCESS | 1688 | 03:41:56 INFO - PROCESS | 1688 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.16 (1.7%) stddev-sans-first:1.20 03:41:56 INFO - PROCESS | 1688 | Values: 68.0 69.0 71.0 68.0 69.0 69.0 68.0 68.0 67.0 70.0 03:41:56 INFO - PROCESS | 1688 | -------- Summary: end -------- 03:41:56 INFO - PROCESS | 1688 | 03:41:57 INFO - TEST-INFO | 1688: exit 0 03:41:57 INFO - TEST-OK | kraken | took 59497ms 03:41:57 INFO - SUITE-END | took 1178s 03:41:57 INFO - Completed test suite (00:19:39) 03:41:57 INFO - javascript benchmark 03:41:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2752.4907892039973, 3299.5329154856486, 3316.0714999800066, 3317.319949410371, 3366.6633336666337, 5543.77824887005, 5554.805581804638, 5617.354004289508, 5621.634593751403, 5676.716164191785, 5615.5507559395255, 5644.125160600113, 5725.627834190775, 5754.683492407927, 5766.279215098113, 4438.001449673814, 5030.5975521958335, 5114.718690472023, 5134.974325128388, 5171.146760784466, 5129.9230511542355, 5268.8155914542995, 5277.577793776489, 5285.550728188108, 5336.17289320156, 5222.791088356461, 5233.502817232395, 5244.711540865251, 5283.656562323436, 5317.9468205317835, 5091.210862316347, 5126.512981266811, 5156.613254005927, 5159.329287192679, 5175.741212939338, 5101.0, 5122.308488354099, 5129.512696293846, 5186.0, 5211.739413029333, 5658.321001479808, 5662.886742265173, 5670.971645141748, 5689.288838895138, 5696.658200507942, 5915.556333275022, 6013.067974463965, 6185.103160041769, 6199.504039676815, 6214.036824292197, 6086.330503644595, 6129.423327329985, 6136.723847426876, 6169.321374648785, 6198.163247961513, 5709.0865461525955, 5714.314282286152, 5717.056685646905, 5720.141978703145, 5751.223584816038, 6312.210973628296, 6316.842078948063, 6327.240731112204, 6334.081558174131, 6335.176427064544, 5868.559858010666, 5924.348321684612, 5935.080062590306, 5994.310654274815, 6071.453569178795, 6202.007678771465, 6223.906641400383, 6231.968840155861, 6245.125682404467, 6245.6252624842655, 6069.908951365733, 6090.786822461193, 6105.45050945417, 6150.384961503813, 6157.261128664589, 5991.730372133265, 6070.3929607038945, 6071.726772295257, 6178.62928224299, 6216.720247588869, 4834.734089625034, 4853.6602437829715, 4886.60907127429, 4897.902041959141, 4941.234108713155, 4344.869653910388, 4360.956390436118, 4370.847020354272, 4381.7151885128005, 4421.9336709949375, 5631.155326700946, 5648.548116150698, 5653.406392328746, 5659.236003139524, 5661.688607126565, 6090.939090609126, 6119.685352982159, 6125.693326622233, 6130.612163469634, 6165.599236049642, 5637.633553818989, 5639.154126880919, 5648.265725455664, 5657.377688454267, 5661.688607126565, 4678.485366609671, 5321.787128514893, 5339.759710813023, 5341.0653135701095, 5369.731513424314, 6144.252464225824, 6273.780417685359, 6284.937150628618, 6290.528210384148, 6294.748210071729, 6142.907856382247, 6154.846128846814, 6174.38256174379, 6215.409536094064, 6228.564000520101, 6233.2208473940755, 6265.592736472115, 6283.088952102011, 6283.842903927439, 6303.243610766737, 5965.880682386415, 6090.786822461193, 6133.080037994337, 6133.662648554372, 6158.414950579688, 5124.0, 5208.5312321891215, 6147.954847675996, 6152.046432802923, 6160.969195153995, 5875.559333050124, 5916.26046744157, 5942.0, 5956.642601443928, 6030.30651475086, 5909.468147866713, 5946.286445626552, 5956.940430595639, 5959.91060134107, 5973.283206015306, 5019.548240658358, 5713.0, 5767.192593036894, 5782.10377391505, 5801.3908539602735, 5893.381194974466, 5981.581289309706, 6028.758849645965, 6049.364816694184, 6114.357992410733, 5712.542996560348, 5769.94230057694, 5772.826815195383, 5876.08920617305, 5885.3820348862755], "value": 5608.043915628359, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [471.26717953582175, 475.7573637444902, 536.1662614634242, 536.3778017499701, 555.2504119438761, 39499.40750888739, 41132.79433602832, 41188.970275743086, 42159.0, 43575.56424435755, 42744.3588346175, 43110.78444607781, 43172.0, 43330.783346083226, 43447.56552434475, 8491.61787719554, 8727.170918762708, 9432.905670943288, 9645.131938125567, 9660.565274562661, 11298.265612735187, 11590.710232244219, 11629.47667354971, 11745.530178792838, 11796.941015294911, 11421.828672569918, 11464.426778661034, 11486.885131148707, 11488.195826292163, 11506.769864602704, 11284.548618055267, 11435.5425782969, 11512.194146409754, 11513.963743263104, 11527.308361498337, 9978.600855965826, 11104.944475277653, 11210.607628733036, 11340.716482087932, 11371.31772093677, 39755.403668944986, 40030.799846000875, 40041.199176016315, 40133.79933100345, 40194.39708404376, 3329.400707872582, 3460.3598334308235, 3510.420780571228, 3740.513733214692, 3786.129190286222, 30069.39861202764, 31405.52891706626, 31497.480201583818, 31576.210594735086, 31616.0, 2575.2789219018705, 2798.734120258572, 3198.424283628946, 3234.822084785336, 3303.8348082596012, 470316.64841675916, 473153.0, 476212.0, 477214.0, 478797.0, 57269.0, 57460.0, 57667.42332576704, 57713.0, 57767.0, 61836.690816545626, 62145.0, 62145.0, 62187.0, 62197.06704399438, 16203.83796162047, 16367.0, 16411.0, 16423.507294781175, 16432.342706291853, 11450.427478626201, 11683.591074312359, 12542.561010364594, 12632.115751897463, 12781.360931953364, 13429.529966451128, 15745.763813542806, 15807.13060781645, 15854.365825367087, 15992.360305587647, 6498.772542960974, 7183.820404489929, 7262.709491620276, 7288.234735352712, 7329.340359367682, 782.8121250899743, 817.4604760857924, 915.9450432974043, 974.9951250243845, 1080.2654195147375, 23859.522809543712, 29978.0, 30208.09375718732, 30870.228244293623, 30945.381092378477, 1022.2282176956351, 1062.5112448273726, 1069.4492336446735, 1069.6042464288264, 1084.5824357622373, 15573.0, 15584.142977090045, 15602.29789659468, 15821.0, 16047.67904641924, 636030.0, 638819.0295242656, 639602.0, 640041.0, 640168.0, 58149.709251453474, 58312.41687583155, 58441.0, 58458.707706461195, 58510.7074464625, 1261.709806744454, 1303.7588046211292, 1378.7035787305776, 1407.90848594841, 1436.3392839293833, 29356.119316420543, 30861.91380861896, 31066.534001989538, 31123.91066312668, 31877.043688689377, 48478.757606211744, 48927.75536122439, 48933.2660010093, 48991.0, 49035.0, 527100.0, 529724.0, 530044.0, 530726.0, 530997.0, 25549.105781297567, 26257.737422626295, 26369.60445593356, 27195.0, 39289.0, 39304.80347598244, 47472.76263618798, 47672.76163619159, 48052.27921581249, 48970.26544601905, 38682.8395148146, 39104.0, 39550.81347559578, 40932.97667558335, 40970.0, 38892.6110738889, 38922.80538597289, 38957.0, 40068.998275043356, 40964.1807163861, 38015.61984380121, 38714.64498742531, 38848.22303553857, 38941.02647433837, 38951.80524097361, 30467.0, 34296.48555271623, 34355.65644343525, 34472.310553789284, 34598.0, 24647.876760616084, 25236.0, 25301.367465812764, 25767.0, 25975.0], "value": 20150.11168866236, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.1119235123663, 370.4128955605367, 373.5088358808167, 384.1280293733225, 404.3994667918141, 12898.935505322472, 14761.557153285405, 15662.0, 19992.50018749532, 20775.026372494587, 19931.701024484646, 20381.694274585894, 20788.480287992807, 21104.0, 21280.4679883003, 5226.90235050638, 5696.8860622787415, 6002.459778619924, 6003.849903752397, 6021.518278537728, 5216.869578260555, 5918.58569900105, 5990.341062483123, 5993.220881285427, 6000.6099603525845, 5623.662580245178, 5844.094165404369, 5926.1110833374905, 5936.495397891184, 5948.553858460611, 5847.386024467433, 5906.586538942276, 5908.704564771766, 5911.970440147815, 5912.142739302799, 4870.269459581055, 5070.2141168119, 5118.411382691001, 5129.410117836422, 5136.203888397305, 25181.87409062961, 25609.23172304834, 25704.14437834321, 25809.870950645316, 25876.611850822253, 2201.4606421426693, 2247.5167838914713, 2263.2418139923147, 2350.8354415190943, 2381.7022872140983, 15144.697106057927, 15156.696866062617, 15353.232338383035, 15463.690726185525, 15483.838712096638, 1781.3943259291773, 1805.972910406345, 1842.3275504440917, 1883.52911772057, 1915.6264528416964, 98409.50795245978, 100074.0, 100718.0, 101667.0, 101682.49158754159, 10171.7457063574, 10502.947485262677, 10515.0, 10760.408177550153, 10844.67465976022, 13276.137051091648, 13366.26485543285, 13403.530876419278, 13422.395992180376, 13423.798643020362, 8121.715739949073, 8376.832463350698, 8410.495370277802, 8572.828543429221, 8592.828143437097, 8426.452280601741, 8437.873431898526, 8443.788905277417, 8643.438176518506, 8645.221930026202, 6441.227052753699, 6544.116544266463, 6545.0182472629485, 6560.080764060043, 6585.407313341822, 1748.2220411916828, 1798.7391828185102, 1814.9364772233173, 1822.82683145101, 1842.4012196036342, 686.7870960002415, 854.1251951965377, 870.1342164546317, 910.1353713971753, 978.2663002747939, 18358.908205458887, 21535.892320538296, 22457.88771056167, 22478.32565023052, 22600.434989125402, 934.6401635370431, 941.5527624378366, 946.3091942881597, 989.1938070472542, 1052.7210289273348, 8946.37375383717, 10432.426216558162, 11160.386178760245, 11884.227525210834, 11899.405029748477, 564737.0, 572719.0, 572925.0, 573780.1310993502, 589695.0, 104276.47861760642, 104354.4782276099, 105431.41852872213, 107746.0, 110502.0, 1010.6715317521835, 1053.5891002509027, 1095.9780804383868, 1100.3068067117665, 1101.0640955188026, 18354.174062166967, 18816.96506692145, 19147.851128932307, 19380.4185874424, 19506.512337191685, 32533.837330813196, 43870.34194487021, 46589.0, 47969.520304796504, 48586.75706621444, 63219.683901580196, 63746.04380934383, 63895.680521597096, 65484.0, 70932.0, 7743.186965368781, 7804.843903121792, 7966.880496792437, 7993.240642138988, 8185.345172386314, 13023.348832558524, 13210.141340812816, 13292.933535332262, 13689.657758556115, 13736.65658358509, 10695.89304106949, 11586.362750048827, 11767.941160294144, 11955.282683039046, 12000.519979201083, 11322.94338528302, 11456.083513318748, 11520.88479115198, 11638.359890205782, 11833.171677982458, 9982.700518984442, 11066.170037247399, 11628.709282268012, 11831.585894493652, 12010.979066779422, 8089.3528517719615, 8183.3862460316905, 8371.539565323965, 8535.31717462589, 8632.093630168742, 9809.950950245204, 11738.354390508604, 11920.165588408729, 11976.981956533793, 12002.459889305177], "value": 9517.339894556502, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1376.463179360049, 1532.7317719399102, 1560.9765853512197, 1789.221688565474, 1865.552267455811, 8453.661853525859, 8982.640694372225, 8990.370674052803, 8995.235404990575, 9009.909900901006, 7795.883061754064, 8103.473274237171, 8133.9186608133905, 8243.422960392774, 8249.29880960119, 2151.3653472225733, 2167.100653228908, 2227.6324406472995, 2289.3933107726466, 2372.406898275431, 2353.9293821185306, 2356.375560476475, 2369.1115831563166, 2396.9041238350533, 2397.8920948557356, 2370.834041617079, 2372.5492156490213, 2374.596318625829, 2378.1795280628157, 2381.535600557892, 2330.5921463743775, 2380.6310021946624, 2385.1771138957206, 2385.4632707640817, 2390.4501964548253, 2343.9296821095395, 2365.4204719843747, 2371.833971621987, 2371.976280237193, 2386.642003699442, 8826.911730882674, 8846.5134417607, 8919.0, 8938.64245430182, 8951.55242237892, 5261.184516399964, 5417.702026388547, 5419.83740487786, 5421.972890135524, 5431.782728690848, 3500.527428797105, 3607.567091948983, 3661.7802931824176, 3664.3770559005034, 3665.5601327840563, 1031.6389263757624, 1069.58820853971, 1088.172988528716, 1104.596822159914, 1114.504045699664, 11555.017823485014, 11683.714791372942, 11695.532178712841, 11712.648620541397, 11735.53057877684, 3969.4641223435046, 4440.4227450431235, 4761.190597598347, 4842.539958703917, 4844.709317440965, 9868.259880508847, 9934.7019589411, 9941.204703623693, 9943.80112397748, 9947.00529947014, 5387.568994480511, 5414.5668346532975, 5420.674759514442, 5424.701641409761, 5426.511613954763, 4417.271150260171, 4829.5653391194965, 4899.706017638953, 4987.900241995139, 4998.650094493423, 3657.012606596204, 3770.1140232045996, 3778.6410291022307, 3888.9805550972064, 3902.8829135125993, 1076.3219171921796, 1287.1311864491618, 1291.3672300572653, 1295.9611211663664, 1299.136074510459, 796.3509739562354, 895.2971917045088, 903.6295119001178, 924.2098006204733, 927.730958022166, 5795.652260864362, 5803.709814509258, 6004.279486461653, 6029.638221706711, 6191.81424557264, 770.460677525723, 810.4812919731377, 939.793245485992, 948.6395169835556, 984.8227319082633, 3986.8637438330516, 4011.1376054147913, 4028.5165780106577, 4075.775832329191, 4112.588741125864, 10181.33821301613, 10853.674389768319, 10863.348199108079, 10865.239433239598, 10877.347359158475, 10780.838287425695, 10799.67600971972, 10810.945945270223, 10832.67501974942, 10835.079018283377, 8204.466709663853, 8253.546054967035, 8277.54473503963, 8281.54451505173, 8295.0, 5084.898302033865, 5458.426865179099, 5783.872085540386, 5926.970365148147, 5998.640081595118, 10040.497975101362, 10198.33710808795, 10216.029477199654, 10220.488975551045, 10244.692659220234, 9912.256580756328, 10174.982501749766, 10306.587736490457, 10330.007138257675, 10414.635487757892, 7321.231270716498, 7420.369268612229, 7518.624068796647, 7519.962400187964, 7524.097108347033, 7469.626518673936, 7771.37828973692, 7950.602469876599, 8245.422820402515, 8290.378221633522, 7256.564606123649, 7339.302766237199, 7339.412846972336, 7411.110666720028, 7615.504992175491, 6325.557210995186, 7403.000594919617, 7438.962805185939, 7464.477486575887, 7467.738629148171, 6980.127484064492, 6984.0, 7047.0, 7066.399356054793, 7109.502334836512, 4658.650601204856, 4711.175544279806, 4764.190087685171, 4774.641901857305, 4894.657373983787, 4951.133551628379, 4992.850214493571, 5133.6919784813035, 5134.204198349262, 5199.818006369759], "value": 4575.894047200512, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.9157435917943, 307.6907707753706, 315.0391306515129, 322.56936989119527, 323.5292649195421, 5213.504717051879, 5224.320838291022, 5359.732013399329, 5413.729313534327, 5419.349678038631, 4369.8033588488515, 4944.096522838706, 5018.136035252853, 5074.847754567369, 5229.8954020919555, 4028.6172813582807, 4053.9662386091654, 4068.5524592294896, 4072.429859819628, 4093.1199792044704, 3351.625833408303, 4008.875296093075, 4017.2568074906235, 4045.271851066807, 4099.262132816092, 3519.4514413657907, 3782.6595606395417, 3989.800509974504, 4002.779847108408, 4037.9394309085387, 3963.7712309183958, 3998.4002399640285, 4009.1981603679383, 4025.859094931678, 4028.509451502948, 3441.2773317603333, 3454.63726308739, 3458.6714262145306, 3462.2036931505895, 3469.6877281044826, 4518.638508919278, 5139.974300128475, 5157.4584668610005, 5191.067047118404, 5203.531682148625, 4048.542524691109, 4401.339799030139, 4547.226971414867, 4566.474855391606, 4618.676692631517, 4583.679142460029, 4649.04694537619, 5043.798248070073, 5532.612717109804, 5583.497485226349, 3047.481928072233, 3752.2307926874923, 3794.2790869734663, 3797.658210761017, 3812.894260664404, 5400.810971616014, 5719.255627033753, 5752.856178595527, 5792.942070579283, 5853.678047707374, 3215.437298472758, 3329.583802024747, 3801.6008319126645, 3827.3684842001317, 3840.9615903840604, 3559.288142371536, 3899.532056153223, 3918.6277303656107, 3922.8626998054933, 3931.744436611611, 4016.196760647882, 4221.366794980716, 4582.289745089516, 4584.908301834012, 4607.58531732139, 4926.285688575136, 5246.63273570854, 5546.944530554723, 5548.889022219614, 5567.387587365387, 1120.092724892823, 1243.5647523366931, 1260.338322380739, 1304.8760367765046, 1329.2984979226605, 837.8952630921135, 851.4465597361765, 852.292597144381, 895.8118795053111, 911.4349103555838, 4640.559146881041, 4982.928670335895, 5137.640365174477, 5141.922871156936, 5207.3490813648295, 4919.803207871717, 5243.509333066839, 5254.15933450646, 5306.46935306474, 5727.3699893011735, 4141.64795992344, 4511.774411279423, 4897.510248975074, 5176.8964620707375, 5337.226102215157, 2892.4938135826146, 2974.8512574371193, 3032.5906002689794, 3033.393321335742, 3046.512557990711, 5257.6845389276, 5609.5512359012, 5692.612895327274, 5912.438318359749, 6003.549733769984, 5811.4479124483105, 5821.476067153892, 5884.11738239259, 5891.234139561915, 5911.305434103685, 5232.2413250078525, 5629.605927585029, 5904.439078287556, 5917.526597872246, 5968.343482216953, 5014.974925125351, 5389.487998640123, 5715.685637289989, 5759.280089988752, 5770.374479611851, 4768.618510519081, 5682.573806964577, 5729.598928075162, 5735.311762588516, 5770.769169233184, 5803.332616748959, 5960.672163031075, 5984.431479009487, 6004.369541198286, 6004.759809607567, 3792.9241415172096, 3826.846926122924, 3836.3094642964534, 3846.3076246451474, 3852.345101332724, 5183.196604526304, 5655.858603534944, 5787.39232380594, 5821.70891455417, 5840.737166827418, 5480.534154596904, 5549.030094316459, 5619.466150715675, 5696.487316141402, 5712.772018912544, 4778.187708089564, 5491.423400543045, 5515.531179849758, 5646.943530564642, 5688.459596338341, 4747.64392670558, 5224.451432599522, 5431.0, 5507.476789704971, 5513.338399391938, 4969.850904472872, 5404.297441332602, 5624.85937851557, 5668.258949093579, 5674.177244299636, 5248.580113590827, 5413.215083812904, 5428.07722687152, 5458.4541545845095, 5478.575570351658], "value": 4060.8445612203536, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.5476382025053, 769.1039938471681, 795.5306369242147, 795.6459375577869, 829.8423299573085, 15396.538103856888, 16201.756973645404, 16206.918965405157, 16226.51320460385, 16249.268782904783, 13417.0, 13440.19358838468, 13462.93268533656, 13484.730305393887, 13762.518311859087, 706.3713295167305, 731.3162193349209, 733.9119305683325, 887.6050157679836, 895.2077411490828, 903.3586153830788, 918.5269586163131, 925.5881132895864, 928.3640706116298, 929.6327950459564, 966.0098399140867, 982.8967958364376, 984.3503287830033, 984.4634674102596, 984.8719666443352, 975.858500517421, 978.6379039755265, 981.0091807274632, 982.3712823792779, 987.8221920054423, 555.4806256150512, 574.6982834012135, 732.300652876507, 733.8348871503869, 736.4623824608066, 12191.817122743167, 12229.388530573437, 12245.93877030618, 14078.366473508717, 14640.853591464056, 14349.78475322871, 14759.926200369036, 14818.184999825005, 14865.331060102322, 15006.849931500763, 11489.712757181138, 11735.823962640567, 11813.881861181364, 11824.940875295655, 12164.391780411033, 3800.227397981229, 3834.9233015339814, 3847.942280865789, 3857.1321452673205, 3885.61143885612, 96487.0, 98162.50918745503, 106569.46715266451, 107369.92630073677, 108882.45558772235, 10362.689119326433, 11225.550977960791, 11394.544218231344, 11461.713457163638, 11867.76264474723, 22418.99114539817, 22446.0, 22449.877506124627, 22472.887635561718, 22476.662850057262, 8043.678252869937, 8079.9192008080345, 8213.630386632616, 8289.544075075928, 8327.541985190872, 4122.896927576775, 4140.3168477200925, 4275.87172384829, 4287.592678695519, 4510.864674059783, 3672.706183505313, 3779.338615742234, 3834.0606551395085, 3834.482344883405, 3834.5206849143856, 624.5534442873368, 678.1150598469045, 687.9071325371111, 701.719312275094, 705.4990956420999, 599.2979936979001, 671.2714759494322, 689.1729924091111, 694.3611877073105, 696.2550071423528, 8039.678412863537, 9156.954215228881, 9426.85218503856, 9575.856362154573, 9576.856347154799, 630.6027202862167, 637.7449020391788, 658.7957733102753, 669.2303850571881, 673.7978606418055, 4465.866024019285, 4661.766911654404, 4681.111714233053, 4730.290456431563, 4761.880952976134, 112797.43601281941, 147028.0, 147836.2608186952, 149939.0, 153147.0, 131323.34338328248, 134334.0, 135095.29809403952, 138046.3097684505, 138651.30674346766, 102250.46624300642, 107053.46473267584, 112116.0, 112554.43722781334, 113755.0, 8984.371094023356, 9001.504917229615, 9004.54977251148, 9030.819383612159, 9187.081291871027, 63668.36331636809, 64790.35209647843, 67047.66476167589, 67532.0, 68771.31228687649, 61466.0, 73159.90260146209, 98099.0, 103487.41281467723, 103939.480302598, 10706.822249552699, 11056.0, 11853.170278080452, 11883.227590206609, 11945.522179113086, 11734.0, 11980.04159667242, 11995.40022998864, 12028.879711202775, 12173.45219465144, 12049.939750301193, 12066.336351500751, 12201.938990304992, 12232.510699571918, 12579.748405031665, 12038.217515861441, 12278.324692142018, 12339.753204935672, 12510.937445313079, 12644.43100060481, 11729.237599556001, 11980.940095299467, 12012.819807703067, 12203.14577979533, 12386.194897331645, 10539.314944528582, 10549.78900421972, 10635.627753028606, 10753.139748820233, 10852.620158294421, 9817.656382026595, 10474.371537707762, 10480.737981550523, 10499.265051446631, 10522.1056210223], "value": 7733.547038643361, "unit": "score"}], "name": "dromaeo_css", "value": 7325.777738661795, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 114.0, 111.0, 116.0, 159.0, 165.0, 114.0, 114.0, 112.0], "value": 122.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 117.0, 115.0, 152.0, 115.0, 112.0, 111.0, 111.0, 142.0, 109.0], "value": 123.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 182.0, 182.0, 185.0, 183.0, 183.0, 183.0, 180.0, 183.0], "value": 183.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 59.0, 60.0, 105.0, 87.0, 59.0, 58.0, 59.0, 86.0, 75.0], "value": 72.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 71.0, 94.0, 70.0, 68.0, 69.0, 92.0, 67.0, 69.0, 86.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 88.0, 84.0, 86.0, 85.0, 88.0, 85.0, 87.0, 84.0], "value": 85.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 95.0, 96.0, 95.0, 94.0, 95.0, 96.0, 94.0, 93.0], "value": 94.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 83.0, 81.0, 82.0, 83.0, 85.0, 99.0, 129.0, 129.0], "value": 93.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 55.0, 55.0, 56.0, 57.0, 56.0, 55.0, 56.0, 56.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 71.0, 73.0, 75.0, 75.0, 67.0, 69.0, 69.0, 69.0, 71.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 89.0, 90.0, 86.0, 86.0, 86.0, 85.0, 89.0, 85.0, 89.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 143.0, 148.0, 143.0, 142.0, 145.0, 145.0, 142.0, 183.0, 132.0], "value": 148.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 241.0, 225.0, 171.0, 169.0, 172.0, 170.0, 169.0, 170.0, 168.0], "value": 184.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 71.0, 68.0, 69.0, 69.0, 68.0, 68.0, 67.0, 70.0], "value": 68.7, "unit": "score"}], "name": "kraken", "value": 1466.8999999999999, "alertThreshold": 2.0}]} 03:41:57 INFO - Return code: 0 03:41:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:41:57 INFO - # TBPL SUCCESS # 03:41:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:41:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:41:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:41:57 INFO - 2016-10-15 03:41:57.982 screenresolution[1692:10000] starting screenresolution argv=screenresolution get 03:41:57 INFO - 2016-10-15 03:41:57.985 screenresolution[1692:10000] Display 0: 1600x1200x32@60 03:41:57 INFO - 2016-10-15 03:41:57.991 screenresolution[1693:10003] starting screenresolution argv=screenresolution list 03:41:57 INFO - Available Modes on Display 0 03:41:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:41:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:41:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:41:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:41:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:41:58 INFO - Intel Iris: 03:41:58 INFO - Chipset Model: Intel Iris 03:41:58 INFO - Type: GPU 03:41:58 INFO - Bus: Built-In 03:41:58 INFO - VRAM (Dynamic, Max): 1536 MB 03:41:58 INFO - Vendor: Intel (0x8086) 03:41:58 INFO - Device ID: 0x0a2e 03:41:58 INFO - Revision ID: 0x0009 03:41:58 INFO - Displays: 03:41:58 INFO - Display: 03:41:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:41:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:41:58 INFO - Display Serial Number: 1600x1200 60 03:41:58 INFO - Main Display: Yes 03:41:58 INFO - Mirror: Off 03:41:58 INFO - Online: Yes 03:41:58 INFO - Rotation: Supported 03:41:58 INFO - Return code: 0 03:41:58 INFO - Running post-action listener: _resource_record_post_action 03:41:58 INFO - [mozharness: 2016-10-15 10:41:58.225076Z] Finished run-tests step (success) 03:41:58 INFO - Running post-run listener: _resource_record_post_run 03:41:58 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 33229824; Write bytes: 707660288; Read time: 312; Write time: 1946 03:41:58 INFO - TinderboxPrint: CPU usage
53.6% 03:41:58 INFO - TinderboxPrint: I/O read bytes / time
33,229,824 / 312 03:41:58 INFO - TinderboxPrint: I/O write bytes / time
707,660,288 / 1,946 03:41:58 INFO - TinderboxPrint: CPU idle
2,250.1 (46.4%) 03:41:58 INFO - TinderboxPrint: CPU system
974.4 (20.1%) 03:41:58 INFO - TinderboxPrint: CPU user
1,629.1 (33.6%) 03:41:58 INFO - TinderboxPrint: Swap in / out
435,871,744 / 0 03:41:58 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 403993088; Write bytes: 397858816; Read time: 29706; Write time: 748 03:41:58 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 31091712; Write bytes: 297366016; Read time: 288; Write time: 1164 03:41:58 INFO - Running post-run listener: _upload_blobber_files 03:41:58 INFO - Blob upload gear active. 03:41:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:41:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:41:58 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:41:58 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:41:59 INFO - (blobuploader) - INFO - Open directory for files ... 03:41:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:41:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:42:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:42:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:42:00 INFO - (blobuploader) - INFO - Done attempting. 03:42:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:42:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:42:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:42:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:42:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:42:01 INFO - (blobuploader) - INFO - Done attempting. 03:42:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:42:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:42:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:42:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:42:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:42:04 INFO - (blobuploader) - INFO - Done attempting. 03:42:04 INFO - (blobuploader) - INFO - Iteration through files over. 03:42:04 INFO - Return code: 0 03:42:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:42:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:42:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e479e0a1d481e1640dabd76e091173c14bc293b59f15b212b5cda1e308eed95496bf62f286dd96bbe2ec1b136b250c7aa52594935a127359bf2143ebe8da9f0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e1cb3d2c5aa5be2e7bf9a628219add4415d538f0ea30396217a6c12f9e1141f2099d57c0c1d60c394fa2d7def9efeea6ac826aa3ee1dce5cfeec6ad0381f526d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/082a3aefaaed828e2400bea9c86a6258b184acee5b1350a49d93a2a3859cc8b6efc40f0e3cd26edf5ca8f67ae1d873631497712e919194789c0d4410dd843006"} 03:42:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:42:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:42:04 INFO - Contents: 03:42:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e479e0a1d481e1640dabd76e091173c14bc293b59f15b212b5cda1e308eed95496bf62f286dd96bbe2ec1b136b250c7aa52594935a127359bf2143ebe8da9f0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e1cb3d2c5aa5be2e7bf9a628219add4415d538f0ea30396217a6c12f9e1141f2099d57c0c1d60c394fa2d7def9efeea6ac826aa3ee1dce5cfeec6ad0381f526d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/082a3aefaaed828e2400bea9c86a6258b184acee5b1350a49d93a2a3859cc8b6efc40f0e3cd26edf5ca8f67ae1d873631497712e919194789c0d4410dd843006"} 03:42:04 INFO - Running post-run listener: copy_logs_to_upload_dir 03:42:04 INFO - Copying logs to upload dir... 03:42:04 INFO - mkdir: /builds/slave/test/build/upload/logs 03:42:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.890070 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-15 03:42:04.132483) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-15 03:42:04.135976) ========= 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.Ck7cqgCM62/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.rVq6CUZ1kq/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e479e0a1d481e1640dabd76e091173c14bc293b59f15b212b5cda1e308eed95496bf62f286dd96bbe2ec1b136b250c7aa52594935a127359bf2143ebe8da9f0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e1cb3d2c5aa5be2e7bf9a628219add4415d538f0ea30396217a6c12f9e1141f2099d57c0c1d60c394fa2d7def9efeea6ac826aa3ee1dce5cfeec6ad0381f526d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/082a3aefaaed828e2400bea9c86a6258b184acee5b1350a49d93a2a3859cc8b6efc40f0e3cd26edf5ca8f67ae1d873631497712e919194789c0d4410dd843006"} build_url:https://queue.taskcluster.net/v1/task/Ickyj82URcuAItKy8ukftQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010957 build_url: 'https://queue.taskcluster.net/v1/task/Ickyj82URcuAItKy8ukftQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e479e0a1d481e1640dabd76e091173c14bc293b59f15b212b5cda1e308eed95496bf62f286dd96bbe2ec1b136b250c7aa52594935a127359bf2143ebe8da9f0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e1cb3d2c5aa5be2e7bf9a628219add4415d538f0ea30396217a6c12f9e1141f2099d57c0c1d60c394fa2d7def9efeea6ac826aa3ee1dce5cfeec6ad0381f526d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/082a3aefaaed828e2400bea9c86a6258b184acee5b1350a49d93a2a3859cc8b6efc40f0e3cd26edf5ca8f67ae1d873631497712e919194789c0d4410dd843006"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-15 03:42:04.168780) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 03:42:04.169114) ========= 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.Ck7cqgCM62/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.rVq6CUZ1kq/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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.005261 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 03:42:04.217986) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-15 03:42:04.218465) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-15 03:42:04.219035) ========= ========= Total master_lag: 0.18 =========