builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0097 starttime: 1473272535.94 results: success (0) buildid: 20160907092117 builduid: 10ea080703f640d2b8e853724e051292 revision: db9dfcdbef4aa204aba5d9b3c384f21ee1c66c61 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-07 11:22:15.940965) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-07 11:22:15.941423) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-07 11:22:15.941695) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-07 11:22:15.967247) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 11:22:15.967642) ========= 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.JefB5dJRxd/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.FIOpZRZuS0/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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-09-07 11:22:16-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 156M=0s 2016-09-07 11:22:16 (156 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120059 ========= master_lag: 0.77 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 11:22:16.862213) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 11:22:16.862565) ========= 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.JefB5dJRxd/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.FIOpZRZuS0/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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.023372 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 11:22:16.908768) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 11:22:16.909137) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev db9dfcdbef4aa204aba5d9b3c384f21ee1c66c61 --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 db9dfcdbef4aa204aba5d9b3c384f21ee1c66c61 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JefB5dJRxd/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.FIOpZRZuS0/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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-09-07 11:22:17,135 truncating revision to first 12 chars 2016-09-07 11:22:17,135 Setting DEBUG logging. 2016-09-07 11:22:17,136 attempt 1/10 2016-09-07 11:22:17,136 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/db9dfcdbef4a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-07 11:22:17,422 unpacking tar archive at: autoland-db9dfcdbef4a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.544863 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 11:22:17.476954) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-07 11:22:17.477320) ========= script_repo_revision: db9dfcdbef4aa204aba5d9b3c384f21ee1c66c61 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-07 11:22:17.477727) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-07 11:22:17.478008) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-07 11:22:17.497045) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-09-07 11:22:17.497416) ========= /tools/buildbot/bin/python 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', '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.JefB5dJRxd/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.FIOpZRZuS0/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 11:22:17 INFO - MultiFileLogger online at 20160907 11:22:17 in /builds/slave/test 11:22:17 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 11:22:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:22:17 INFO - {'append_to_log': False, 11:22:17 INFO - 'base_work_dir': '/builds/slave/test', 11:22:17 INFO - 'blob_upload_branch': 'Autoland', 11:22:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:22:17 INFO - 'branch': 'Autoland', 11:22:17 INFO - 'buildbot_json_path': 'buildprops.json', 11:22:17 INFO - 'config_files': ('talos/mac_config.py',), 11:22:17 INFO - 'default_actions': ('clobber', 11:22:17 INFO - 'read-buildbot-config', 11:22:17 INFO - 'download-and-extract', 11:22:17 INFO - 'populate-webroot', 11:22:17 INFO - 'create-virtualenv', 11:22:17 INFO - 'install', 11:22:17 INFO - 'run-tests'), 11:22:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:22:17 INFO - 'download_minidump_stackwalk': True, 11:22:17 INFO - 'download_symbols': 'ondemand', 11:22:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:22:17 INFO - 'tooltool.py': '/tools/tooltool.py', 11:22:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:22:17 INFO - '/tools/misc-python/virtualenv.py')}, 11:22:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:22:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:22:17 INFO - 'installer_path': 'installer.exe', 11:22:17 INFO - 'log_level': 'info', 11:22:17 INFO - 'log_name': 'talos', 11:22:17 INFO - 'log_to_console': True, 11:22:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:22:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:22:17 INFO - 'opt_config_files': (), 11:22:17 INFO - 'pip_index': False, 11:22:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:22:17 INFO - 'cmd': ('bash', 11:22:17 INFO - '-c', 11:22:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:22:17 INFO - 'enabled': True, 11:22:17 INFO - 'halt_on_failure': False, 11:22:17 INFO - 'name': 'check_screen_resolution'},), 11:22:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:22:17 INFO - 'cmd': ('bash', 11:22:17 INFO - '-c', 11:22:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:22:17 INFO - 'enabled': True, 11:22:17 INFO - 'halt_on_failure': False, 11:22:17 INFO - 'name': 'check_screen_resolution'},), 11:22:17 INFO - 'run_cmd_checks_enabled': True, 11:22:17 INFO - 'sps_profile': False, 11:22:17 INFO - 'sps_profile_interval': 0, 11:22:17 INFO - 'suite': 'dromaeojs', 11:22:17 INFO - 'system_bits': '32', 11:22:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:22:17 INFO - 'title': 't-yosemite-r7-0097', 11:22:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:22:17 INFO - 'use_talos_json': True, 11:22:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:22:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:22:17 INFO - 'work_dir': 'build'} 11:22:17 INFO - [mozharness: 2016-09-07 18:22:17.841689Z] Running clobber step. 11:22:17 INFO - Running pre-action listener: _resource_record_pre_action 11:22:17 INFO - Running main action method: clobber 11:22:17 INFO - rmtree: /builds/slave/test/build 11:22:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:22:19 INFO - Running post-action listener: _resource_record_post_action 11:22:19 INFO - [mozharness: 2016-09-07 18:22:19.420865Z] Finished clobber step (success) 11:22:19 INFO - [mozharness: 2016-09-07 18:22:19.421074Z] Running read-buildbot-config step. 11:22:19 INFO - Running pre-action listener: _resource_record_pre_action 11:22:19 INFO - Running main action method: read_buildbot_config 11:22:19 INFO - Using buildbot properties: 11:22:19 INFO - { 11:22:19 INFO - "project": "", 11:22:19 INFO - "product": "firefox", 11:22:19 INFO - "script_repo_revision": "production", 11:22:19 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 11:22:19 INFO - "repository": "", 11:22:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 11:22:19 INFO - "buildid": "20160907092117", 11:22:19 INFO - "pgo_build": "False", 11:22:19 INFO - "basedir": "/builds/slave/test", 11:22:19 INFO - "buildnumber": 235, 11:22:19 INFO - "slavename": "t-yosemite-r7-0097", 11:22:19 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 11:22:19 INFO - "platform": "yosemite_r7", 11:22:19 INFO - "scheduler": "tests-autoland-macosx64-talos", 11:22:19 INFO - "branch": "autoland", 11:22:19 INFO - "repo_path": "integration/autoland", 11:22:19 INFO - "revision": "db9dfcdbef4aa204aba5d9b3c384f21ee1c66c61", 11:22:19 INFO - "stage_platform": "macosx64", 11:22:19 INFO - "builduid": "10ea080703f640d2b8e853724e051292", 11:22:19 INFO - "slavebuilddir": "test" 11:22:19 INFO - } 11:22:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/GoW39wFWQQev4h6lL4aq3w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 11:22:19 INFO - Running post-action listener: _resource_record_post_action 11:22:19 INFO - [mozharness: 2016-09-07 18:22:19.426861Z] Finished read-buildbot-config step (success) 11:22:19 INFO - [mozharness: 2016-09-07 18:22:19.427066Z] Running download-and-extract step. 11:22:19 INFO - Running pre-action listener: _resource_record_pre_action 11:22:19 INFO - Running main action method: download_and_extract 11:22:19 INFO - mkdir: /builds/slave/test/build/tests 11:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:19 INFO - trying https://queue.taskcluster.net/v1/task/GoW39wFWQQev4h6lL4aq3w/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 11:22:19 INFO - Downloading https://queue.taskcluster.net/v1/task/GoW39wFWQQev4h6lL4aq3w/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 11:22:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GoW39wFWQQev4h6lL4aq3w/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 11:22:20 INFO - Downloaded 1199 bytes. 11:22:20 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 11:22:20 INFO - Using the following test package requirements: 11:22:20 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:22:20 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:22:20 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 11:22:20 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:22:20 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 11:22:20 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:22:20 INFO - u'jsshell-mac.zip'], 11:22:20 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:22:20 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 11:22:20 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:22:20 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:22:20 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 11:22:20 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:22:20 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 11:22:20 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:22:20 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 11:22:20 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:22:20 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 11:22:20 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:22:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GoW39wFWQQev4h6lL4aq3w/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:22:22 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 11:22:29 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:22:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GoW39wFWQQev4h6lL4aq3w/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:22:30 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 11:22:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GoW39wFWQQev4h6lL4aq3w/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 11:22:37 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 11:22: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')]} 11:22:38 INFO - trying https://queue.taskcluster.net/v1/task/GoW39wFWQQev4h6lL4aq3w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:22:38 INFO - Downloading https://queue.taskcluster.net/v1/task/GoW39wFWQQev4h6lL4aq3w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 11:22:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GoW39wFWQQev4h6lL4aq3w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 11:22:41 INFO - Downloaded 111583614 bytes. 11:22:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GoW39wFWQQev4h6lL4aq3w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:22:41 INFO - mkdir: /builds/slave/test/properties 11:22:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:22:41 INFO - Writing to file /builds/slave/test/properties/build_url 11:22:41 INFO - Contents: 11:22:41 INFO - build_url:https://queue.taskcluster.net/v1/task/GoW39wFWQQev4h6lL4aq3w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:22:42 INFO - Running post-action listener: _resource_record_post_action 11:22:42 INFO - Running post-action listener: set_extra_try_arguments 11:22:42 INFO - [mozharness: 2016-09-07 18:22:42.467490Z] Finished download-and-extract step (success) 11:22:42 INFO - [mozharness: 2016-09-07 18:22:42.467643Z] Running populate-webroot step. 11:22:42 INFO - Running pre-action listener: _resource_record_pre_action 11:22:42 INFO - Running main action method: populate_webroot 11:22:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:22:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:22:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:22:42 INFO - '--tppagecycles', 11:22:42 INFO - '7'], 11:22:42 INFO - 'tests': ['tsvgm']}}, 11:22:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:22:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:22:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:22:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:22:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:22:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:22:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:42 INFO - 'talos_options': ['--disable-e10s'], 11:22:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:22:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:22:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:42 INFO - 'talos_options': ['--disable-e10s'], 11:22:42 INFO - 'tests': ['damp', 'tps']}, 11:22:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:42 INFO - 'tests': ['damp', 'tps']}, 11:22:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:22:42 INFO - 'tests': ['dromaeo_dom']}, 11:22:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:22:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:22:42 INFO - 'tests': ['basic_compositor_video']}, 11:22:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:22:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:22:42 INFO - 'tests': ['a11yr', 11:22:42 INFO - 'ts_paint', 11:22:42 INFO - 'tpaint', 11:22:42 INFO - 'sessionrestore', 11:22:42 INFO - 'sessionrestore_no_auto_restore', 11:22:42 INFO - 'tabpaint']}, 11:22:42 INFO - 'other-e10s': {'tests': ['a11yr', 11:22:42 INFO - 'ts_paint', 11:22:42 INFO - 'tpaint', 11:22:42 INFO - 'sessionrestore', 11:22:42 INFO - 'sessionrestore_no_auto_restore', 11:22:42 INFO - 'tabpaint']}, 11:22:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:22:42 INFO - 'ts_paint', 11:22:42 INFO - 'tpaint', 11:22:42 INFO - 'sessionrestore', 11:22:42 INFO - 'sessionrestore_no_auto_restore', 11:22:42 INFO - 'tabpaint']}, 11:22:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:22:42 INFO - 'ts_paint', 11:22:42 INFO - 'tpaint', 11:22:42 INFO - 'sessionrestore', 11:22:42 INFO - 'sessionrestore_no_auto_restore', 11:22:42 INFO - 'tabpaint']}, 11:22:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:22:42 INFO - 'tests': ['a11yr', 11:22:42 INFO - 'ts_paint', 11:22:42 INFO - 'tpaint', 11:22:42 INFO - 'sessionrestore', 11:22:42 INFO - 'sessionrestore_no_auto_restore', 11:22:42 INFO - 'tabpaint']}, 11:22:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:22:42 INFO - 'tests': ['a11yr', 11:22:42 INFO - 'ts_paint', 11:22:42 INFO - 'tpaint', 11:22:42 INFO - 'sessionrestore', 11:22:42 INFO - 'sessionrestore_no_auto_restore', 11:22:42 INFO - 'tabpaint']}, 11:22:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:22:42 INFO - 'tests': ['tsvgx', 11:22:42 INFO - 'tsvgr_opacity', 11:22:42 INFO - 'tart', 11:22:42 INFO - 'tscrollx', 11:22:42 INFO - 'cart']}, 11:22:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:22:42 INFO - 'tsvgr_opacity', 11:22:42 INFO - 'tart', 11:22:42 INFO - 'tscrollx', 11:22:42 INFO - 'cart']}, 11:22:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:42 INFO - 'talos_options': ['--disable-e10s'], 11:22:42 INFO - 'tests': ['tp5o']}, 11:22:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:42 INFO - 'tests': ['tp5o']}, 11:22:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:42 INFO - 'talos_options': ['--disable-e10s', 11:22:42 INFO - '--xperf_path', 11:22:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:22:42 INFO - 'tests': ['tp5n']}, 11:22:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:42 INFO - 'talos_options': ['--xperf_path', 11:22:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:22:42 INFO - 'tests': ['tp5n']}}, 11:22:42 INFO - 'talos.zip': {'path': '', 11:22:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:22:42 INFO - Running post-action listener: _resource_record_post_action 11:22:42 INFO - [mozharness: 2016-09-07 18:22:42.486663Z] Finished populate-webroot step (success) 11:22:42 INFO - [mozharness: 2016-09-07 18:22:42.486795Z] Running create-virtualenv step. 11:22:42 INFO - Running pre-action listener: _resource_record_pre_action 11:22:42 INFO - Running main action method: create_virtualenv 11:22:42 INFO - Creating virtualenv /builds/slave/test/build/venv 11:22:42 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 11:22:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:22:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:22:42 INFO - Using real prefix '/tools/python27' 11:22:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:22:43 INFO - Installing distribute.............................................................................................................................................................................................done. 11:22:46 INFO - Installing pip.................done. 11:22:46 INFO - Return code: 0 11:22:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:22:46 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')]} 11:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:46 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')]} 11:22:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:46 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 0x10af48a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afdd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabcb58a8f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeacd30>, '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 0x10ac11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aea4b20>, '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.JefB5dJRxd/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.FIOpZRZuS0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 11:22:46 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 11:22:46 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 11:22:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JefB5dJRxd/Render', 11:22:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:22:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:22:46 INFO - 'HOME': '/Users/cltbld', 11:22:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:22:46 INFO - 'LOGNAME': 'cltbld', 11:22:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:46 INFO - 'MOZ_NO_REMOTE': '1', 11:22:46 INFO - 'NO_EM_RESTART': '1', 11:22:46 INFO - 'PAGER': '/bin/cat', 11:22:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:22:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:46 INFO - 'PWD': '/builds/slave/test', 11:22:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:22:46 INFO - 'SHELL': '/bin/bash', 11:22:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FIOpZRZuS0/Listeners', 11:22:46 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 11:22:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:22:46 INFO - 'USER': 'cltbld', 11:22:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:22:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:22:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:46 INFO - 'XPC_FLAGS': '0x0', 11:22:46 INFO - 'XPC_SERVICE_NAME': '0', 11:22:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:22:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:46 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 11:22:46 INFO - Cleaning up... 11:22:46 INFO - Return code: 0 11:22:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:22:46 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')]} 11:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:46 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')]} 11:22:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:46 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 0x10af48a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afdd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabcb58a8f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeacd30>, '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 0x10ac11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aea4b20>, '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.JefB5dJRxd/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.FIOpZRZuS0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 11:22:46 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 11:22:46 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 11:22:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JefB5dJRxd/Render', 11:22:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:22:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:22:46 INFO - 'HOME': '/Users/cltbld', 11:22:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:22:46 INFO - 'LOGNAME': 'cltbld', 11:22:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:46 INFO - 'MOZ_NO_REMOTE': '1', 11:22:46 INFO - 'NO_EM_RESTART': '1', 11:22:46 INFO - 'PAGER': '/bin/cat', 11:22:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:22:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:46 INFO - 'PWD': '/builds/slave/test', 11:22:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:22:46 INFO - 'SHELL': '/bin/bash', 11:22:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FIOpZRZuS0/Listeners', 11:22:46 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 11:22:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:22:46 INFO - 'USER': 'cltbld', 11:22:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:22:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:22:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:46 INFO - 'XPC_FLAGS': '0x0', 11:22:46 INFO - 'XPC_SERVICE_NAME': '0', 11:22:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:22:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:46 INFO - Downloading/unpacking psutil>=3.1.1 11:22:46 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 11:22:46 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 11:22:46 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 11:22:46 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 11:22:46 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 11:22:46 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 11:22:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:22:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:22:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:22:49 INFO - Installing collected packages: psutil 11:22:49 INFO - Running setup.py install for psutil 11:22:49 INFO - building 'psutil._psutil_osx' extension 11:22:49 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 11:22:50 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 11:22:50 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 11:22:50 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 11:22:50 INFO - building 'psutil._psutil_posix' extension 11:22:50 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 11:22:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:22:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:22:50 INFO - ^ 11:22:50 INFO - 1 warning generated. 11:22:50 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 11:22:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:22:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:22:50 INFO - Successfully installed psutil 11:22:50 INFO - Cleaning up... 11:22:50 INFO - Return code: 0 11:22:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:22:50 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')]} 11:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:50 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')]} 11:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:50 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 0x10af48a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afdd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabcb58a8f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeacd30>, '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 0x10ac11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aea4b20>, '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.JefB5dJRxd/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.FIOpZRZuS0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 11:22:50 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 11:22:50 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 11:22:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JefB5dJRxd/Render', 11:22:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:22:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:22:50 INFO - 'HOME': '/Users/cltbld', 11:22:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:22:50 INFO - 'LOGNAME': 'cltbld', 11:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:50 INFO - 'MOZ_NO_REMOTE': '1', 11:22:50 INFO - 'NO_EM_RESTART': '1', 11:22:50 INFO - 'PAGER': '/bin/cat', 11:22:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:50 INFO - 'PWD': '/builds/slave/test', 11:22:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:22:50 INFO - 'SHELL': '/bin/bash', 11:22:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FIOpZRZuS0/Listeners', 11:22:50 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 11:22:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:22:50 INFO - 'USER': 'cltbld', 11:22:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:22:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:50 INFO - 'XPC_FLAGS': '0x0', 11:22:50 INFO - 'XPC_SERVICE_NAME': '0', 11:22:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:22:50 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 11:22:50 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 11:22:50 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 11:22:50 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 11:22:50 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 11:22:50 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 11:22:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:22:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:22:53 INFO - Installing collected packages: mozsystemmonitor 11:22:53 INFO - Running setup.py install for mozsystemmonitor 11:22:53 INFO - Successfully installed mozsystemmonitor 11:22:53 INFO - Cleaning up... 11:22:53 INFO - Return code: 0 11:22:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:22:53 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')]} 11:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:53 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')]} 11:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:53 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 0x10af48a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afdd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabcb58a8f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeacd30>, '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 0x10ac11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aea4b20>, '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.JefB5dJRxd/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.FIOpZRZuS0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 11:22:53 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 11:22:53 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 11:22:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JefB5dJRxd/Render', 11:22:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:22:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:22:53 INFO - 'HOME': '/Users/cltbld', 11:22:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:22:53 INFO - 'LOGNAME': 'cltbld', 11:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:53 INFO - 'MOZ_NO_REMOTE': '1', 11:22:53 INFO - 'NO_EM_RESTART': '1', 11:22:53 INFO - 'PAGER': '/bin/cat', 11:22:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:53 INFO - 'PWD': '/builds/slave/test', 11:22:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:22:53 INFO - 'SHELL': '/bin/bash', 11:22:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FIOpZRZuS0/Listeners', 11:22:53 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 11:22:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:22:53 INFO - 'USER': 'cltbld', 11:22:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:22:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:53 INFO - 'XPC_FLAGS': '0x0', 11:22:53 INFO - 'XPC_SERVICE_NAME': '0', 11:22:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:53 INFO - Downloading/unpacking jsonschema==2.5.1 11:22:53 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 11:22:53 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 11:22:53 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 11:22:53 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 11:22:53 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 11:22:53 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 11:22:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:22:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:22:56 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 11:22:56 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 11:22:56 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 11:22:56 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 11:22:56 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 11:22:56 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 11:22:56 INFO - Downloading functools32-3.2.3-2.tar.gz 11:22:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:22:56 INFO - warning: no files found matching '*.txt' 11:22:56 INFO - no previously-included directories found matching 'build' 11:22:56 INFO - no previously-included directories found matching 'dist' 11:22:56 INFO - no previously-included directories found matching '.git*' 11:22:56 INFO - Installing collected packages: jsonschema, functools32 11:22:56 INFO - Running setup.py install for functools32 11:22:57 INFO - warning: no files found matching '*.txt' 11:22:57 INFO - no previously-included directories found matching 'build' 11:22:57 INFO - no previously-included directories found matching 'dist' 11:22:57 INFO - no previously-included directories found matching '.git*' 11:22:57 INFO - Successfully installed jsonschema functools32 11:22:57 INFO - Cleaning up... 11:22:57 INFO - Return code: 0 11:22:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:22:57 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')]} 11:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:57 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')]} 11:22:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:57 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 0x10af48a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afdd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabcb58a8f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeacd30>, '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 0x10ac11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aea4b20>, '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.JefB5dJRxd/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.FIOpZRZuS0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 11:22:57 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 11:22:57 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 11:22:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JefB5dJRxd/Render', 11:22:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:22:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:22:57 INFO - 'HOME': '/Users/cltbld', 11:22:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:22:57 INFO - 'LOGNAME': 'cltbld', 11:22:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:57 INFO - 'MOZ_NO_REMOTE': '1', 11:22:57 INFO - 'NO_EM_RESTART': '1', 11:22:57 INFO - 'PAGER': '/bin/cat', 11:22:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:22:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:57 INFO - 'PWD': '/builds/slave/test', 11:22:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:22:57 INFO - 'SHELL': '/bin/bash', 11:22:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FIOpZRZuS0/Listeners', 11:22:57 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 11:22:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:22:57 INFO - 'USER': 'cltbld', 11:22:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:22:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:22:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:57 INFO - 'XPC_FLAGS': '0x0', 11:22:57 INFO - 'XPC_SERVICE_NAME': '0', 11:22:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:22:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:22:57 INFO - Cleaning up... 11:22:57 INFO - Return code: 0 11:22:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:22:57 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')]} 11:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:57 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')]} 11:22:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:57 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 0x10af48a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afdd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabcb58a8f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeacd30>, '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 0x10ac11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aea4b20>, '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.JefB5dJRxd/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.FIOpZRZuS0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 11:22:57 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 11:22:57 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 11:22:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JefB5dJRxd/Render', 11:22:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:22:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:22:57 INFO - 'HOME': '/Users/cltbld', 11:22:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:22:57 INFO - 'LOGNAME': 'cltbld', 11:22:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:57 INFO - 'MOZ_NO_REMOTE': '1', 11:22:57 INFO - 'NO_EM_RESTART': '1', 11:22:57 INFO - 'PAGER': '/bin/cat', 11:22:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:22:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:57 INFO - 'PWD': '/builds/slave/test', 11:22:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:22:57 INFO - 'SHELL': '/bin/bash', 11:22:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FIOpZRZuS0/Listeners', 11:22:57 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 11:22:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:22:57 INFO - 'USER': 'cltbld', 11:22:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:22:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:22:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:57 INFO - 'XPC_FLAGS': '0x0', 11:22:57 INFO - 'XPC_SERVICE_NAME': '0', 11:22:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:22:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:57 INFO - Downloading/unpacking blobuploader==1.2.4 11:22:57 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 11:22:57 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 11:22:57 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 11:22:57 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 11:22:57 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 11:22:57 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 11:23:00 INFO - Downloading blobuploader-1.2.4.tar.gz 11:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:23:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:23:00 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 11:23:00 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 11:23:00 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 11:23:00 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 11:23:00 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 11:23:00 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 11:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:23:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:23:00 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 11:23:00 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 11:23:00 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 11:23:00 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 11:23:00 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 11:23:00 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 11:23:01 INFO - Downloading docopt-0.6.1.tar.gz 11:23:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:23:01 INFO - Installing collected packages: blobuploader, requests, docopt 11:23:01 INFO - Running setup.py install for blobuploader 11:23:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:23:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:23:01 INFO - Running setup.py install for requests 11:23:02 INFO - Running setup.py install for docopt 11:23:02 INFO - Successfully installed blobuploader requests docopt 11:23:02 INFO - Cleaning up... 11:23:02 INFO - Return code: 0 11:23:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:02 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 0x10af48a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afdd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabcb58a8f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeacd30>, '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 0x10ac11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aea4b20>, '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.JefB5dJRxd/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.FIOpZRZuS0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 11:23:02 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 11:23:02 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 11:23:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JefB5dJRxd/Render', 11:23:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:02 INFO - 'HOME': '/Users/cltbld', 11:23:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:02 INFO - 'LOGNAME': 'cltbld', 11:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:02 INFO - 'MOZ_NO_REMOTE': '1', 11:23:02 INFO - 'NO_EM_RESTART': '1', 11:23:02 INFO - 'PAGER': '/bin/cat', 11:23:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:02 INFO - 'PWD': '/builds/slave/test', 11:23:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:02 INFO - 'SHELL': '/bin/bash', 11:23:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FIOpZRZuS0/Listeners', 11:23:02 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 11:23:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:02 INFO - 'USER': 'cltbld', 11:23:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:02 INFO - 'XPC_FLAGS': '0x0', 11:23:02 INFO - 'XPC_SERVICE_NAME': '0', 11:23:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:23:02 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-XP4ku3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:23:02 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-NP14WX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:23:02 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-CgUOnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:23:02 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-rzE4qT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:23:02 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-8X2uS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:23:03 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-RPv32o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:23:03 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-3YIxyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:23:03 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-pSohPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:23:03 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-1YbOZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:23:03 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-EoYM_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:23:03 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-Q4FZK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:23:03 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-eOYPP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:23:03 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-GQosz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:23:03 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-4AXhaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:23:04 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-bRM89m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:23:04 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-6JIuzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:23:04 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-QO1W4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:23:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:23:04 INFO - Running setup.py install for manifestparser 11:23:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:23:04 INFO - Running setup.py install for mozcrash 11:23:04 INFO - Running setup.py install for mozdebug 11:23:04 INFO - Running setup.py install for mozdevice 11:23:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:23:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:23:04 INFO - Running setup.py install for mozfile 11:23:05 INFO - Running setup.py install for mozhttpd 11:23:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:23:05 INFO - Running setup.py install for mozinfo 11:23:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:23:05 INFO - Running setup.py install for mozInstall 11:23:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:23:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:23:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:23:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:23:05 INFO - Running setup.py install for mozleak 11:23:05 INFO - Running setup.py install for mozlog 11:23:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:23:05 INFO - Running setup.py install for moznetwork 11:23:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:23:05 INFO - Running setup.py install for mozprocess 11:23:06 INFO - Running setup.py install for mozprofile 11:23:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:23:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:23:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:23:06 INFO - Running setup.py install for mozrunner 11:23:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:23:06 INFO - Running setup.py install for mozscreenshot 11:23:06 INFO - Running setup.py install for moztest 11:23:06 INFO - Running setup.py install for mozversion 11:23:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:23:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:23:06 INFO - Cleaning up... 11:23:06 INFO - Return code: 0 11:23:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:06 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 0x10af48a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afdd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabcb58a8f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeacd30>, '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 0x10ac11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aea4b20>, '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.JefB5dJRxd/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.FIOpZRZuS0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 11:23:06 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 11:23:06 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 11:23:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JefB5dJRxd/Render', 11:23:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:06 INFO - 'HOME': '/Users/cltbld', 11:23:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:06 INFO - 'LOGNAME': 'cltbld', 11:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:06 INFO - 'MOZ_NO_REMOTE': '1', 11:23:06 INFO - 'NO_EM_RESTART': '1', 11:23:06 INFO - 'PAGER': '/bin/cat', 11:23:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:06 INFO - 'PWD': '/builds/slave/test', 11:23:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:06 INFO - 'SHELL': '/bin/bash', 11:23:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FIOpZRZuS0/Listeners', 11:23:06 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 11:23:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:06 INFO - 'USER': 'cltbld', 11:23:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:06 INFO - 'XPC_FLAGS': '0x0', 11:23:06 INFO - 'XPC_SERVICE_NAME': '0', 11:23:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:23:07 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-tm0_IL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:23:07 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)) 11:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:23:07 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-fL2haH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:23:07 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)) 11:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:23:07 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-IK5aNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:23:07 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)) 11:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:23:07 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-7OJjuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:23:07 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)) 11:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:23:07 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-PX5IaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:23:07 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)) 11:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:23:07 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-8oWyJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:23:07 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)) 11:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:23:07 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-UZmzTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:23:07 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)) 11:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:23:07 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-CVayFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:23:08 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)) 11:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:23:08 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-tB_9V6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:23:08 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)) 11:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:23:08 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-oXNEUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:23:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 11:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:23:08 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-GULVus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:23:08 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)) 11:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:23:08 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-enVZAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:23:08 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)) 11:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:23:08 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-PE7rCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:23:08 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)) 11:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:23:08 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-jRPo9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:23:08 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)) 11:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:23:08 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-FSzWMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:23:08 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)) 11:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:23:08 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-s9WM9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:23:08 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)) 11:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:23:08 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-Axiqpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:23:08 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)) 11:23:08 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)) 11:23:08 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)) 11:23:08 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)) 11:23:08 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)) 11:23:08 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)) 11:23:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:23:08 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 11:23:08 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 11:23:08 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 11:23:08 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 11:23:08 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 11:23:08 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 11:23:11 INFO - Downloading blessings-1.6.tar.gz 11:23:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:23:11 INFO - Installing collected packages: blessings 11:23:11 INFO - Running setup.py install for blessings 11:23:11 INFO - Successfully installed blessings 11:23:11 INFO - Cleaning up... 11:23:11 INFO - Return code: 0 11:23:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:23:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:23:12 INFO - Reading from file tmpfile_stdout 11:23:12 INFO - Current package versions: 11:23:12 INFO - blessings == 1.6 11:23:12 INFO - blobuploader == 1.2.4 11:23:12 INFO - docopt == 0.6.1 11:23:12 INFO - functools32 == 3.2.3-2 11:23:12 INFO - jsonschema == 2.5.1 11:23:12 INFO - manifestparser == 1.1 11:23:12 INFO - mozInstall == 1.12 11:23:12 INFO - mozcrash == 0.17 11:23:12 INFO - mozdebug == 0.1 11:23:12 INFO - mozdevice == 0.48 11:23:12 INFO - mozfile == 1.2 11:23:12 INFO - mozhttpd == 0.7 11:23:12 INFO - mozinfo == 0.9 11:23:12 INFO - mozleak == 0.1 11:23:12 INFO - mozlog == 3.3 11:23:12 INFO - moznetwork == 0.27 11:23:12 INFO - mozprocess == 0.23 11:23:12 INFO - mozprofile == 0.28 11:23:12 INFO - mozrunner == 6.12 11:23:12 INFO - mozscreenshot == 0.1 11:23:12 INFO - mozsystemmonitor == 0.3 11:23:12 INFO - moztest == 0.7 11:23:12 INFO - mozversion == 1.4 11:23:12 INFO - psutil == 3.1.1 11:23:12 INFO - requests == 1.2.3 11:23:12 INFO - wsgiref == 0.1.2 11:23:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:23:12 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')]} 11:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:12 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')]} 11:23:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:12 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 0x10af48a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afdd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabcb58a8f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeacd30>, '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 0x10ac11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aea4b20>, '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.JefB5dJRxd/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.FIOpZRZuS0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 11:23:12 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 11:23:12 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 11:23:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JefB5dJRxd/Render', 11:23:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:12 INFO - 'HOME': '/Users/cltbld', 11:23:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:12 INFO - 'LOGNAME': 'cltbld', 11:23:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:12 INFO - 'MOZ_NO_REMOTE': '1', 11:23:12 INFO - 'NO_EM_RESTART': '1', 11:23:12 INFO - 'PAGER': '/bin/cat', 11:23:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:12 INFO - 'PWD': '/builds/slave/test', 11:23:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:12 INFO - 'SHELL': '/bin/bash', 11:23:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FIOpZRZuS0/Listeners', 11:23:12 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 11:23:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:12 INFO - 'USER': 'cltbld', 11:23:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:12 INFO - 'XPC_FLAGS': '0x0', 11:23:12 INFO - 'XPC_SERVICE_NAME': '0', 11:23:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:12 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)) 11:23:12 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)) 11:23:12 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)) 11:23:12 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)) 11:23:12 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)) 11:23:12 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)) 11:23:12 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)) 11:23:12 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)) 11:23:12 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)) 11:23:12 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)) 11:23:12 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)) 11:23:12 INFO - Cleaning up... 11:23:12 INFO - Return code: 0 11:23:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:23:12 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')]} 11:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:12 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')]} 11:23:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:12 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 0x10af48a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afdd618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabcb58a8f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeacd30>, '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 0x10ac11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aea4b20>, '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.JefB5dJRxd/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.FIOpZRZuS0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 11:23:12 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 11:23:12 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 11:23:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JefB5dJRxd/Render', 11:23:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:12 INFO - 'HOME': '/Users/cltbld', 11:23:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:12 INFO - 'LOGNAME': 'cltbld', 11:23:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:12 INFO - 'MOZ_NO_REMOTE': '1', 11:23:12 INFO - 'NO_EM_RESTART': '1', 11:23:12 INFO - 'PAGER': '/bin/cat', 11:23:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:12 INFO - 'PWD': '/builds/slave/test', 11:23:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:12 INFO - 'SHELL': '/bin/bash', 11:23:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FIOpZRZuS0/Listeners', 11:23:12 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 11:23:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:12 INFO - 'USER': 'cltbld', 11:23:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:12 INFO - 'XPC_FLAGS': '0x0', 11:23:12 INFO - 'XPC_SERVICE_NAME': '0', 11:23:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:23:12 INFO - Cleaning up... 11:23:12 INFO - Return code: 0 11:23:12 INFO - Running post-action listener: _resource_record_post_action 11:23:12 INFO - Running post-action listener: _start_resource_monitoring 11:23:12 INFO - Starting resource monitoring. 11:23:12 INFO - [mozharness: 2016-09-07 18:23:12.962882Z] Finished create-virtualenv step (success) 11:23:12 INFO - [mozharness: 2016-09-07 18:23:12.963925Z] Running install step. 11:23:12 INFO - Running pre-action listener: _resource_record_pre_action 11:23:12 INFO - Running main action method: install 11:23:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:23:13 INFO - Reading from file tmpfile_stdout 11:23:13 INFO - Detecting whether we're running mozinstall >=1.0... 11:23:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:23:13 INFO - Reading from file tmpfile_stdout 11:23:13 INFO - Output received: 11:23:13 INFO - Usage: mozinstall [options] installer 11:23:13 INFO - Options: 11:23:13 INFO - -h, --help show this help message and exit 11:23:13 INFO - -d DEST, --destination=DEST 11:23:13 INFO - Directory to install application into. [default: 11:23:13 INFO - "/builds/slave/test"] 11:23:13 INFO - --app=APP Application being installed. [default: firefox] 11:23:13 INFO - mkdir: /builds/slave/test/build/application 11:23:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:23:47 INFO - Reading from file tmpfile_stdout 11:23:47 INFO - Output received: 11:23:47 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:23:47 INFO - Running post-action listener: _resource_record_post_action 11:23:47 INFO - [mozharness: 2016-09-07 18:23:47.505759Z] Finished install step (success) 11:23:47 INFO - [mozharness: 2016-09-07 18:23:47.505931Z] Running run-tests step. 11:23:47 INFO - Running pre-action listener: _resource_record_pre_action 11:23:47 INFO - Running main action method: run_tests 11:23:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:23:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:23:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:23:47 INFO - 2016-09-07 11:23:47.520 screenresolution[2196:24201] starting screenresolution argv=screenresolution get 11:23:47 INFO - 2016-09-07 11:23:47.523 screenresolution[2196:24201] Display 0: 1600x1200x32@60 11:23:47 INFO - 2016-09-07 11:23:47.528 screenresolution[2197:24203] starting screenresolution argv=screenresolution list 11:23:47 INFO - Available Modes on Display 0 11:23:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:23:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:23:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:23:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:23:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:23:47 INFO - Intel Iris: 11:23:47 INFO - Chipset Model: Intel Iris 11:23:47 INFO - Type: GPU 11:23:47 INFO - Bus: Built-In 11:23:47 INFO - VRAM (Dynamic, Max): 1536 MB 11:23:47 INFO - Vendor: Intel (0x8086) 11:23:47 INFO - Device ID: 0x0a2e 11:23:47 INFO - Revision ID: 0x0009 11:23:47 INFO - Displays: 11:23:47 INFO - Display: 11:23:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:23:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:23:47 INFO - Display Serial Number: 1600x1200 60 11:23:47 INFO - Main Display: Yes 11:23:47 INFO - Mirror: Off 11:23:47 INFO - Online: Yes 11:23:47 INFO - Rotation: Supported 11:23:47 INFO - Return code: 0 11:23:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:23:47 INFO - Python 2.7.3 11:23:47 INFO - Return code: 0 11:23:47 INFO - grabbing minidump binary from tooltool 11:23:47 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')]} 11:23:47 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 0x10aeacd30>, '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 0x10ac11db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aea4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:23:47 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 11:23:47 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 11:23:47 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 11:23:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:23:47 INFO - Return code: 0 11:23:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:23:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:23:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:23:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:23:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:23:47 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/GoW39wFWQQev4h6lL4aq3w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0097', '--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 11:23:47 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/GoW39wFWQQev4h6lL4aq3w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0097 --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 11:23:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JefB5dJRxd/Render', 11:23:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:47 INFO - 'HOME': '/Users/cltbld', 11:23:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:47 INFO - 'LOGNAME': 'cltbld', 11:23:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:23:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:47 INFO - 'MOZ_NO_REMOTE': '1', 11:23:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:23:47 INFO - 'NO_EM_RESTART': '1', 11:23:47 INFO - 'PAGER': '/bin/cat', 11:23:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:47 INFO - 'PWD': '/builds/slave/test', 11:23:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:23:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:47 INFO - 'SHELL': '/bin/bash', 11:23:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FIOpZRZuS0/Listeners', 11:23:47 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 11:23:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:47 INFO - 'USER': 'cltbld', 11:23:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:47 INFO - 'XPC_FLAGS': '0x0', 11:23:47 INFO - 'XPC_SERVICE_NAME': '0', 11:23:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:47 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/GoW39wFWQQev4h6lL4aq3w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0097', '--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 11:23:48 INFO - mozversion application_buildid: 20160907092117 11:23:48 INFO - mozversion application_changeset: db9dfcdbef4aa204aba5d9b3c384f21ee1c66c61 11:23:48 INFO - mozversion application_display_name: Nightly 11:23:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:23:48 INFO - mozversion application_name: Firefox 11:23:48 INFO - mozversion application_remotingname: firefox 11:23:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 11:23:48 INFO - mozversion application_vendor: Mozilla 11:23:48 INFO - mozversion application_version: 51.0a1 11:23:48 INFO - mozversion platform_buildid: 20160907092117 11:23:48 INFO - mozversion platform_changeset: db9dfcdbef4aa204aba5d9b3c384f21ee1c66c61 11:23:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 11:23:48 INFO - mozversion platform_version: 51.0a1 11:23:48 INFO - using testdate: 1473272628 11:23:48 INFO - actual date: 1473272628 11:23:48 INFO - starting webserver on 'localhost:57381' 11:23:48 INFO - SUITE-START | Running 2 tests 11:23:48 INFO - TEST-START | dromaeo_css 11:23:48 INFO - operating with platform_type : mac_ 11:23:48 INFO - Initialising browser for dromaeo_css test... 11:23:48 INFO - TEST-INFO | started process 2207 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmpKvB7fP/profile http://localhost:57381/getInfo.html) 11:23:50 INFO - PROCESS | 2207 | __metrics Screen width/height:1600/1200 11:23:50 INFO - PROCESS | 2207 | colorDepth:24 11:23:50 INFO - PROCESS | 2207 | Browser inner width/height: 1024/689 11:23:50 INFO - PROCESS | 2207 | __metrics 11:23:50 INFO - PROCESS | 2207 | 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" 11:23:50 INFO - PROCESS | 2207 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:23:51 INFO - TEST-INFO | 2207: exit 0 11:23:51 INFO - Browser initialized. 11:23:51 INFO - Running cycle 1/1 for dromaeo_css test... 11:23:51 INFO - TEST-INFO | started process 2209 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmpKvB7fP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:24:03 INFO - PROCESS | 2209 | RSS: Main: 232398848 11:24:03 INFO - PROCESS | 2209 | 11:24:55 INFO - PROCESS | 2209 | 1473272695369 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] 11:27:06 INFO - PROCESS | 2209 | Cycle 1(1): loaded http://localhost:57381/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57381/tests/dromaeo/cssquery-ext.html) 11:27:07 INFO - PROCESS | 2209 | RSS: Main: 381091840 11:27:07 INFO - PROCESS | 2209 | 11:30:10 INFO - PROCESS | 2209 | Cycle 1(1): loaded http://localhost:57381/tests/dromaeo/cssquery-ext.html (next: http://localhost:57381/tests/dromaeo/cssquery-jquery.html) 11:30:11 INFO - PROCESS | 2209 | RSS: Main: 368959488 11:30:11 INFO - PROCESS | 2209 | 11:33:13 INFO - PROCESS | 2209 | Cycle 1(1): loaded http://localhost:57381/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57381/tests/dromaeo/cssquery-mootools.html) 11:33:14 INFO - PROCESS | 2209 | RSS: Main: 360099840 11:33:14 INFO - PROCESS | 2209 | 11:36:16 INFO - PROCESS | 2209 | Cycle 1(1): loaded http://localhost:57381/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57381/tests/dromaeo/cssquery-prototype.html) 11:36:17 INFO - PROCESS | 2209 | RSS: Main: 339451904 11:36:17 INFO - PROCESS | 2209 | 11:39:20 INFO - PROCESS | 2209 | Cycle 1(1): loaded http://localhost:57381/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57381/tests/dromaeo/cssquery-yui.html) 11:39:21 INFO - PROCESS | 2209 | RSS: Main: 326864896 11:39:21 INFO - PROCESS | 2209 | 11:42:24 INFO - PROCESS | 2209 | Cycle 1(1): loaded http://localhost:57381/tests/dromaeo/cssquery-yui.html (next: http://localhost:57381/tests/dromaeo/cssquery-dojo.html) 11:42:24 INFO - PROCESS | 2209 | RSS: Main: 513302528 11:42:24 INFO - PROCESS | 2209 | 11:42:24 INFO - PROCESS | 2209 | __start_tp_report 11:42:24 INFO - PROCESS | 2209 | _x_x_mozilla_page_load 11:42:24 INFO - PROCESS | 2209 | _x_x_mozilla_page_load_details 11:42:24 INFO - PROCESS | 2209 | |i|pagename|runs| 11:42:24 INFO - PROCESS | 2209 | |0;dojo.html;2786.303424143964;2997.7409488015032;3282.130235487596;3338.8664453421866;3406.40387932112;5578.944210557893;5625.83122506325;5697.088465845465;5711.286089238845;5729.455701708342;5643.887122257553;5690.487856092951;5723.227364305818;5788.71056447178;5858.941410585893;5144.190979329062;5193.662411943231;5241.79032838686;5294.602904782138;5305.363356397218;5337.306150200468;5337.653052551591;5343.465653434645;5386.138217885139;5403.729813509309;5109.310243117169;5302.840914772563;5316.202569614569;5329.626926115174;5344.625876188668;5112.130937740593;5176.741162941876;5216.556592689626;5235.057689615867;5240.082985477564;5146.794128234904;5148.716820574867;5169.353830771153;5268.130758424855;5269;5738.42615738427;5808.8838223235725;5817.50551203144;5818.330891947396;5845.649261044308;6065.150878876961;6087.847803804896;6106.114613381079;6137;6184;6269.592476489013;6289.119523266746;6311.936880631227;6316.210473690789;6326.2092238470195;5795.913061304083;5798.88402231953;5800.564957628152;5805.535557155417;5831.766729330864;6134.4978165938865;6195.783147589813;6248.937510624835;6279.403456671609;6315.400036996478;6155.199824022849;6186.876262474725;6194.473469755121;6197.101420294122;6212.223472065992;6226.25284965807;6283.120363149163;6289.622622642656;6292.4966002719675;6301.7164227609865;6076.240469941257;6134.417230363198;6135.293912123373;6176;6276.937230627726;6109.617229398918;6113.841195312599;6207.131001659771;6275.34108918557;6307.590006649553;4990.950090499048;4996.650234483552;5001.44984051754;5013.774380152902;5022.773975171126;4377.4965878923695;4477.126960242721;4477.888052798641;4483.775811209426;4531.297648864432;5630.577706671934;5644.153376993484;5653.236813030188;5673.461021202979;5722.685252311079;6026.306974697878;6239.376062393724;6243.063540468966;6251.624902505773;6258.030005349178;5694.402087780723;5698.116791897262;5701.800436984686;5703.857403564861;5711.857203569944;5299.470052994747;5346.144616861284;5414.593905457106;5430.375506816767;5451.291332126877;6396.42432181106;6419.2296924369375;6436.967815160894;6450.7097180627925;6452;6170.167027451236;6286.937130628635;6313.2424109107205;6316.526260530571;6330.335314791881;5044.621653376085;6262.279837818709;6290.654014029273;6320.905186422116;6417.679116044273;5118.360204974379;6260;6275.717592708248;6276.4351208389635;6282.3089460158435;6282.246130464374;6285.779997700059;6296.118543403835;6301.4328710416285;6310.652914089769;4902.803887844589;5971.611845230046;6082.057281121433;6112.022076467744;6143.293521245114;4610.723356598614;6033;6079.878402432015;6163.84590385244;6181.412765787243;5039.924401133912;6013.789517366871;6022.187004754477;6023.759049637965;6025.6083354581815;5936.673482958478;6024.7288872001745;6050.45545900871;6136.539759517965;6137.631742095488;5993.280806303272;6001.699915004319;6013.458788709037;6019.87960240784;6030.5778595497895 11:42:24 INFO - PROCESS | 2209 | |1;ext.html;466.95797378235955;506.8873821960797;524.5095835393906;528.363322196753;532.8348212054261;30580.388392232144;39250.2149957001;40256.59101931433;40343.59656403435;40345.19309613806;42097;42419;42511.574884251146;42539.36190957138;42577.14845703084;9623.615055397793;9811.705648830546;9818.754531136707;9828.115469607734;9834.459104749236;8764.56177191141;11779.29324240544;12006.69983250417;12035;12233.816492752616;12063.577774777885;12149.574764883231;12149.878501214964;12175.756484870297;12203.816942745865;11982.161248712593;12054.939725301405;12075.154739168262;12090.455929483194;12092.939535302312;9938.602455901755;11766.58816941403;11821.113416493712;11847.585334513336;11859;39489.80255098735;39748;39758.80120599378;39760.602393975976;39791.80104099461;3424.9657503424896;3622.42041273395;3651.7078633709507;3843.615638436162;4038.6567141792984;27050.458990820072;30343.937962171218;30539.08382748521;31507.431422443617;31634.841825790954;3200.6159260888608;3219.098652377338;3275.3776782411264;3310.2386451116377;3381.1209085637665;512604;517336;519250;519842;519909.9999999962;27266.591001135;55930.720346398004;56249.43750562524;56476.435235647936;56501;33485.82799602002;34821.47767783485;34963.65036349655;34964;34982;14505;14640.707185856223;14645.194514301817;14658.926705366404;14666.266686665624;10785.40680262593;11373.862613738725;11408.714782130513;12437.378131093408;12497.50009999608;7614.847703045908;7771.339436147878;7798;7824.569648669378;7894.763157105182;2697.905573304925;2908.4473949949443;3263.8204898730323;3273.3944220319318;3351.162209447638;942.1379437814323;962.8170647576937;975.7365511312048;1038.9116925061455;1051.8369652703843;29824.552631710543;29857;30129.397412051636;30449.391012180076;30577.929772457857;1028.5680014393822;1040.8490768838476;1057.8677665291839;1075.8386242063752;1081.6160263106642;14957.70084598302;15476.071435713893;15567.610809729847;15580.766288505454;15914.124723140107;705097;711212.443937777;711454;711620;712853;55195.44804551903;55870.441295587334;55912;55963.60090997676;55992;1210.2677879882544;1335.9779768477122;1355.9254241016642;1363.3183408295852;1371.1430356027483;26305.868470657526;29679.25801854971;30851.845740771154;30958;31643.52534712027;46862.76568617135;47174;47290.05419891514;47316.2902556455;47340.7632961833;553527;556150;557667;559037;559044;26168.691565422032;27122.050728224418;27144.592831107944;27761.305967350978;27772.722272777013;35414.64585354114;45363.092738145715;45766;46251.53748462607;47021.76489117533;37808.164387670484;38622.6137738619;38633.2391831434;39050.02374940649;40371.78884633465;37368.62631373652;37577.62422375741;37828.24343513169;39110.6088939107;39668.801655991534;36292;36664.26671466503;38045.4293185608;38069.4289585662;38357.80821095876;31286;32282;33554.66445335515;34474;34653.960381188605;24795;25183.992640294182;25308.746912530638;25573.74426255788;25701.485970280864 11:42:24 INFO - PROCESS | 2209 | |2;jquery.html;344.38527228896425;347.7513577791879;350.79829098268505;368.8008475423271;389.8131482383826;15150.848491515095;16335.18324083797;17613.647727045452;17768.378106766264;17879.10604469778;19481.415557533262;19740.40778776639;20103.497412564695;20736.688949665728;20915.895420522877;5874.353821079678;6153.077038444225;6162.414570615784;6167.969160154215;6171.783987560436;5266.789328426858;6079.878402431948;6139.38606139387;6156.322804491502;6157.907631385533;5887.175795388649;6128.3258841527395;6142.600730952474;6144.2319710036245;6146.35463276354;6101.633901965896;6196.87606247877;6206.25524937006;6209.5342849286035;6224.937750622526;5759.400374765772;6002.339742628307;6050.122732203806;6117.847053823645;6117.908231376533;13256.933715331457;13484.595462136152;13513.662158446019;18990;24742.381440463952;2131.648278034138;2276.6243569811127;2290.186983620824;2307.0195167053935;2684.74494922982;9588.90411095887;10432.843507347396;10552.419616921066;12313.322767247797;14874.553763387115;1823.6443893440785;1836.2654938024764;1861.7300491428803;1904.6381187574316;1955.9902200489048;92954;102846.48576757143;121998;123066;131820;9569.665061722946;10692.786144277072;11574.363410012531;11613.941930290464;11760.117991150526;14679;14718.748906342867;14725.190114543802;14726.116433014053;14742.18917959501;6998;7363.631818409058;8338.332933365316;8611.612477438404;8794.912050879537;8460.365472589581;8515.191056849713;8531.616077276538;8624.439411438236;8730.17063378978;4473.261911784519;4564.612007979293;4593.47175074864;4647.488776234612;4700.482946875841;1844.6402951424611;1876.6809642360831;1883.9717404238947;1886.8773529720524;1889.1769442488064;830.2278880640941;882.6954700628273;919.9632014719471;957.066859811678;996.470417908507;20859.478513036993;21592.784072159393;22467.32598022062;23189.42026449352;23628.17301394443;942.2132519346422;948.8481842905102;951.6811868024289;982.8378317577663;1028.3521381529738;11165.83251251232;11422.714432139097;11516.481758320728;11536.134789890624;11581.594644187582;492000;502096;520285;524846;536199;94204.21809931772;116527;126347;130867;142101;924.4730503612876;953.9046095390405;963.4604621412032;1034.3915211845651;1035.8290882004385;19121.248163437027;20188.697169542764;20207.595848082663;20310.390688279374;20356;50426.74786626043;52554.211686825496;54318.45681543134;55845;56219.156712648524;81590.59204703939;84947;85483;91070;92328;7912.84174316499;7988.400869934894;8250.051244106764;8263.462874913112;8420;11090.611828585961;13105.93447032797;13142.408591613592;13446.327683615584;13479.86520134786;11305;11549.01833344175;11647.534098635959;11699.649010529698;11820.113491488344;9015.909840901508;10343.793124137324;11000.724981875517;11051.281666691639;11549.942250288696;10360.740981475223;11678.357690327113;11888.227265227733;12041.939790300992;12047.518099276282;8159.83680326402;8304.750857474286;8414.915850841413;8462.534560599226;8487.236148746642;8565.614547345509;11082.667519974413;11834.171607987359;11847.407629618312;11848.466818992994 11:42:24 INFO - PROCESS | 2209 | |3;mootools.html;1535.8540938610831;1554.7356949318616;1777.8844375115616;1864.543186919205;1945.1052515842703;8614.612342444589;9165.037671044543;9168.129027742361;9171.816563668732;9178;7488.475806693534;7970.481918675282;8215.219554142363;8483.194096560832;8752.518611476366;2380.33350661815;2418.4074901649033;2418.6734790803193;2422.3338581889943;2423.3820375804144;2379.0840526397287;2405.386626410263;2419.697537807774;2422.1522467136538;2422.794062504689;2402.675638788767;2405.7113146422366;2413.095089341497;2418.7097548294228;2422.2854257993936;2375.0618505690154;2388.6894703688495;2393.1384701507445;2398.532286204182;2404.6152615581423;2368.194813763329;2389.7610238976135;2390.40239940015;2393.628987506939;2394.5450364430703;8832;8909.376343655947;8920.46477211363;9016.36885418021;9028.232600228988;5277.12927366984;5420.186971954199;5439.9936011837935;5441.129419292934;5441.972790136064;3661.560612726463;3672.8347224374966;3736.57029441615;3739.345614517476;3748.812559372048;1025.487256371814;1042.8227201375785;1086.9456527173688;1096.7861267052929;1097.226455348977;11905.107116966175;12026.15816892818;12063.276203427735;12081.57714479989;12107.697307567381;4618.422697162855;4691.7888695008805;4867.9269810952865;4882.438519570223;4929.383827021622;10162.949185254027;10173.135283500986;10187.217236983499;10191;10203.591856325813;5406.91889621656;5422.240886275925;5439.374471935778;5441.483059109379;5442.510174084351;4127.2570937231585;4260.573942605714;4611.930821037688;4917;4993.650444468925;3951.7826519541127;3977.6817854571564;4079.530853951774;4089.1580351655907;4181.184668989518;1296.3906963727034;1312.44221205989;1319.7822359310605;1327.9468821247235;1329.162238620552;816.8284660221301;886.6542048601051;910.349100393222;920.3833431600843;950.2255661635745;5603.439656034364;5752.223449834219;5954.315253745788;5997.220361352996;6132;453.1480816065841;457.80772075728277;458.39491870730984;1006.7583779892773;1027.3938376357985;3433.2790114075824;3723.515942927402;3951.92096158081;3952.9011774705286;4044.919101617951;10783.946080269548;11086.334819910831;11136.944315278533;11145.777084458265;11155.163362747826;8553.700620478377;9176.95411522938;10651.680449586525;10744.838827417596;11110.61112861046;8217.260446559838;8329.292010179202;8355.623996920032;8357.289630381485;8366;5590.748416321194;5698.230738850202;5794.971025144847;5828.737706803119;5890.970545147246;10174.186065114625;10187.490625468845;10234.181265498593;10259;10259.127974121984;9782.119609235204;10203.489825508843;10208.540615672164;10355.585776568852;10375.636852710119;6952.270011648704;7186.281371862981;7198;7506.136794268729;7655.46411751172;7888.408369372205;7986.401019923413;8089.959550202211;8276.710315138942;8561;7364.631768411451;7483.588402637907;7487.8876816846705;7576.886346704694;7618.352440042659;7197.9922810807575;7243.45674074436;7308.123025236793;7480.3641690456925;7483.476156668981;6091.695415229309;7108.253633368422;7113.82215444618;7116.46626503004;7121.465890058163;4951.3810773653295;5029.974850125726;5086.872828179326;5133.486651334837;5156.7421628917655;4746.905061898674;4966.726830024383;5128.128218202989;5178.97410512945;5233 11:42:24 INFO - PROCESS | 2209 | |4;prototype.html;297.98212107273554;301.3130063455322;310.44585415034163;312.8029341514845;313.75997362018074;4392.494863090746;4710.858674239778;4958.50414958504;5352.652077614957;5381.677099374036;4415.293553031515;4770.045990801845;4778.3549220855175;5197.922031169535;5358.892822143564;3382.424987752082;4093.3655283430967;4114.136031433402;4129.752214867102;4133.276676581586;3843.4427008083812;3922.352811786066;4152.65038862371;4161.188568229197;4164.895877603054;3988.7064937660816;4044.7370920890194;4051.230266249418;4052.4529188559463;4067.3898915162667;3889.949713577318;4037.777922214277;4043.9890027493125;4045.393191021341;4054.2904991626347;2862.4990626640256;3145.9685403145904;3484.3205574912904;3486.21560148967;3487.337405892872;4524.914020635057;4608;4852.733099679516;4919.3358896549225;5174.896502069938;4588.407549734389;4621.376114224604;4625.306204069383;4644.6052085572765;4652.116097941381;4461.776911154429;4594.471635761896;5172.810253641645;5609.102543593006;5645.8588535286535;3253.430649636328;3548.3435564420665;3596.4425514045365;3764.9435258471144;3862.24686186191;5227.353383684127;5395.676259424447;5920.348761636216;5925.614835035709;5979.671118088503;3863.459115723801;3866.729328947003;3875.534935807721;3919.432227109179;3927.3912543555793;3753.7184711146774;3892.591277915835;3899.200663863901;3913.941290880639;3923.588023257574;4541.182587134282;4562.178807814559;4562.794674239667;4601.263797792337;4628.39830821991;5619.241402410704;5645.689487078168;5654.6324488908085;5662.895735331653;5690.5447564194765;1259.106034715344;1293.7606542789615;1304.8108024336418;1306.6406738147086;1337.4716986790163;739.8890166474964;785.3206975965862;868.5396739727954;899.6356475627381;902.4765635931144;5157.355330583677;5167.870803229949;5178.197379406198;5191.195364718475;5194.506521880416;4735.313379560013;5641.407652196543;5656.5394053586;5659.943400565941;5680.687562184037;4170.83316667336;4260.318349064135;4343.739375637472;5085.160948443466;5134.820281290137;2982.388610334876;3036.2257624306103;3047.87808487658;3053.1070736143733;3064.3258483133677;5089.673777289275;5846.473817356458;5945.435183657545;5999;6044.214252147192;5305.36335639718;5830.2129212555765;5845;5934.457041169241;5963.970180149158;5254.947450525522;5669.6314739541795;5946.524278057745;5957.344692083867;5978.730957106854;5424.2134890439875;5431.538319242909;5754.223179870663;5785.508231800344;5822.970885145547;5184.9740751296;5632.690202038763;5641.717914104196;5674.290713660793;5713.771718978764;5212.921806172986;5457.890842183055;5916.67458289781;5928.614640048383;5981.940180598138;3683.937695934353;3814.446905198786;3826.3877779555137;3844.5386553613744;3874.3219936510436;5361.35663720356;5398.730063496888;5731.570132240182;5752.913706294493;5767.394423585463;5217.50433708797;5329.440408757025;5445.863853403696;5572.548078845295;5608.85977850557;4618.9145550794865;5033.899322013466;5529.944700552943;5588.273524441796;5671.347795003628;4520.59314661682;4935.728534930613;5343.11838546651;5495.939022866425;5528.75120619565;4838.282409744631;4853.538913803183;5390.649607775482;5544.3346798384455;5565.499105080562;4561.7262964222255;5175.92236116451;5231.450697676689;5244.898571299917;5517.2275881377445 11:42:24 INFO - PROCESS | 2209 | |5;yui.html;780.992519649652;804.4489524675594;816.767221341917;818.7420962396844;820.774287071055;12449.447863188047;16252.918735406322;16256.918715406406;16261.268242929067;16281.51155465338;14541.854581454183;14700.779488307684;14705.264736763173;14716.484923027696;14720.6319842004;683.7538486144983;701.3232230897183;843.9409241353108;843.9789005274887;862.9352798540103;864.191980498233;869.1829680100685;880.7401816464159;881.088073843572;881.9382643214977;778.5484419036945;938.7981583959447;940.7271891151557;941.8398872191743;949.2690628216304;710.8542748736496;879.4679219072497;931.9999999999966;933.0762545080355;934.0752654871696;684.1994866006784;688.2360579756466;689.7241103558616;689.8827199376068;691.5850489706187;15032.098074115587;15033.473828415952;15043.548693539211;15067.397304107822;15072.924635376863;13825.377857996415;13864.861351386558;14084.718305633933;14176.220307883063;14310;12696.42866071029;12830.935845320808;12901;13103.672408189776;13220.801687974688;4580.610648094916;4608.33179189019;4698.671093023489;4815.422149342101;4830.251311046758;103474.44788328181;115037.42481287624;115891;118214;121466;10660.41367724767;10771.353718776898;10983.725406864893;11042.447877606088;11447.656570302905;21792.89103554504;21922.013509392116;21925;21946.670799938012;22308.996095175757;7753.961230193813;7830.334421574116;7840.45116841827;7841.2158784122275;8043.155468675822;4254.978725106354;4293.656507479394;4362.192994296065;4398.362237475548;4559.589636932692;3642.162302670348;3806.0675134591647;3809.29528037314;3823.2162406706557;3826.4642949987024;704.5068452083563;709.5778012082802;714.9714011439485;719.5898337947319;776.3439893290274;596.2368168744015;664.6776313487954;679.4904811901968;684.4011489946297;689.1248114894056;8971.820563588692;9125.315601329794;9470.242380609534;9571.712848614552;9608;586.750630981831;646.1406329581645;673.7709178879204;673.8045966669708;674.956127851688;4479.193745125844;4515.841945531891;4525.094981003813;4599.701019433726;4601.723896566216;97592.51203743936;159441;163517;163812;170399.14800426166;132088;133363;136244;140216;140948.29525852305;110183.22709661131;113796;121072;124834.37582812028;126908.36545817212;9197.858826349155;9691.612335506501;10066.647667331608;10141.645042423479;10238.436885971343;44297.778511108525;48727.5127248723;54571;56573.43426565682;59317;72067;80776;90321;91790;102854.48572757088;13628.182309061489;13709.223356602035;13962.79055814184;13989;14248.501302454364;14880.404783808526;14954.925225373803;15044.699106017599;15085;15212.46756363522;13341.318560662696;13561.118527296088;13689.973252006339;14352.56942291733;14793.852061479247;12008.63974080779;13926.164430134224;14568.708625827212;14627.92686036563;14928.402863885323;13579.660508487366;14203.502877399242;14312.499062532761;14478.493252736103;14489.492867749577;10990.285631433931;11120.777584448104;11389.658310250707;11430;12272.140950133406;11400.600978965696;11733.296002239893;11748.941255293668;11907.880921190677;11994.76010479803 11:42:24 INFO - PROCESS | 2209 | __end_tp_report 11:42:24 INFO - PROCESS | 2209 | __start_cc_report 11:42:24 INFO - PROCESS | 2209 | _x_x_mozilla_cycle_collect,1406 11:42:24 INFO - PROCESS | 2209 | __end_cc_report 11:42:24 INFO - PROCESS | 2209 | __startTimestamp1473273744747__endTimestamp 11:42:24 INFO - PROCESS | 2209 | 11:42:24 INFO - PROCESS | 2209 | ------- Summary: start ------- 11:42:24 INFO - PROCESS | 2209 | Number of tests: 6 11:42:24 INFO - PROCESS | 2209 | 11:42:24 INFO - PROCESS | 2209 | [#0] dojo.html Cycles:165 Average:5728.66 Median:5993.28 stddev:670.78 (11.2%) stddev-sans-first:631.87 11:42:24 INFO - PROCESS | 2209 | Values: 2786.3 2997.7 3282.1 3338.9 3406.4 5578.9 5625.8 5697.1 5711.3 5729.5 5643.9 5690.5 5723.2 5788.7 5858.9 5144.2 5193.7 5241.8 5294.6 5305.4 5337.3 5337.7 5343.5 5386.1 5403.7 5109.3 5302.8 5316.2 5329.6 5344.6 5112.1 5176.7 5216.6 5235.1 5240.1 5146.8 5148.7 5169.4 5268.1 5269.0 5738.4 5808.9 5817.5 5818.3 5845.6 6065.2 6087.8 6106.1 6137.0 6184.0 6269.6 6289.1 6311.9 6316.2 6326.2 5795.9 5798.9 5800.6 5805.5 5831.8 6134.5 6195.8 6248.9 6279.4 6315.4 6155.2 6186.9 6194.5 6197.1 6212.2 6226.3 6283.1 6289.6 6292.5 6301.7 6076.2 6134.4 6135.3 6176.0 6276.9 6109.6 6113.8 6207.1 6275.3 6307.6 4991.0 4996.7 5001.4 5013.8 5022.8 4377.5 4477.1 4477.9 4483.8 4531.3 5630.6 5644.2 5653.2 5673.5 5722.7 6026.3 6239.4 6243.1 6251.6 6258.0 5694.4 5698.1 5701.8 5703.9 5711.9 5299.5 5346.1 5414.6 5430.4 5451.3 6396.4 6419.2 6437.0 6450.7 6452.0 6170.2 6286.9 6313.2 6316.5 6330.3 5044.6 6262.3 6290.7 6320.9 6417.7 5118.4 6260.0 6275.7 6276.4 6282.3 6282.2 6285.8 6296.1 6301.4 6310.7 4902.8 5971.6 6082.1 6112.0 6143.3 4610.7 6033.0 6079.9 6163.8 6181.4 5039.9 6013.8 6022.2 6023.8 6025.6 5936.7 6024.7 6050.5 6136.5 6137.6 5993.3 6001.7 6013.5 6019.9 6030.6 11:42:24 INFO - PROCESS | 2209 | 11:42:24 INFO - PROCESS | 2209 | [#1] ext.html Cycles:180 Average:70799.96 Median:34963.83 stddev:161150.85 (460.9%) stddev-sans-first:161516.40 11:42:24 INFO - PROCESS | 2209 | Values: 467.0 506.9 524.5 528.4 532.8 30580.4 39250.2 40256.6 40343.6 40345.2 42097.0 42419.0 42511.6 42539.4 42577.1 9623.6 9811.7 9818.8 9828.1 9834.5 8764.6 11779.3 12006.7 12035.0 12233.8 12063.6 12149.6 12149.9 12175.8 12203.8 11982.2 12054.9 12075.2 12090.5 12092.9 9938.6 11766.6 11821.1 11847.6 11859.0 39489.8 39748.0 39758.8 39760.6 39791.8 3425.0 3622.4 3651.7 3843.6 4038.7 27050.5 30343.9 30539.1 31507.4 31634.8 3200.6 3219.1 3275.4 3310.2 3381.1 512604.0 517336.0 519250.0 519842.0 519910.0 27266.6 55930.7 56249.4 56476.4 56501.0 33485.8 34821.5 34963.7 34964.0 34982.0 14505.0 14640.7 14645.2 14658.9 14666.3 10785.4 11373.9 11408.7 12437.4 12497.5 7614.8 7771.3 7798.0 7824.6 7894.8 2697.9 2908.4 3263.8 3273.4 3351.2 942.1 962.8 975.7 1038.9 1051.8 29824.6 29857.0 30129.4 30449.4 30577.9 1028.6 1040.8 1057.9 1075.8 1081.6 14957.7 15476.1 15567.6 15580.8 15914.1 705097.0 711212.4 711454.0 711620.0 712853.0 55195.4 55870.4 55912.0 55963.6 55992.0 1210.3 1336.0 1355.9 1363.3 1371.1 26305.9 29679.3 30851.8 30958.0 31643.5 46862.8 47174.0 47290.1 47316.3 47340.8 553527.0 556150.0 557667.0 559037.0 559044.0 26168.7 27122.1 27144.6 27761.3 27772.7 35414.6 45363.1 45766.0 46251.5 47021.8 37808.2 38622.6 38633.2 39050.0 40371.8 37368.6 37577.6 37828.2 39110.6 39668.8 36292.0 36664.3 38045.4 38069.4 38357.8 31286.0 32282.0 33554.7 34474.0 34654.0 24795.0 25184.0 25308.7 25573.7 25701.5 11:42:24 INFO - PROCESS | 2209 | 11:42:24 INFO - PROCESS | 2209 | [#2] jquery.html Cycles:180 Average:32576.60 Median:13713.56 stddev:86846.89 (633.3%) stddev-sans-first:87056.80 11:42:24 INFO - PROCESS | 2209 | Values: 344.4 347.8 350.8 368.8 389.8 15150.8 16335.2 17613.6 17768.4 17879.1 19481.4 19740.4 20103.5 20736.7 20915.9 5874.4 6153.1 6162.4 6168.0 6171.8 5266.8 6079.9 6139.4 6156.3 6157.9 5887.2 6128.3 6142.6 6144.2 6146.4 6101.6 6196.9 6206.3 6209.5 6224.9 5759.4 6002.3 6050.1 6117.8 6117.9 13256.9 13484.6 13513.7 18990.0 24742.4 2131.6 2276.6 2290.2 2307.0 2684.7 9588.9 10432.8 10552.4 12313.3 14874.6 1823.6 1836.3 1861.7 1904.6 1956.0 92954.0 102846.5 121998.0 123066.0 131820.0 9569.7 10692.8 11574.4 11613.9 11760.1 14679.0 14718.7 14725.2 14726.1 14742.2 6998.0 7363.6 8338.3 8611.6 8794.9 8460.4 8515.2 8531.6 8624.4 8730.2 4473.3 4564.6 4593.5 4647.5 4700.5 1844.6 1876.7 1884.0 1886.9 1889.2 830.2 882.7 920.0 957.1 996.5 20859.5 21592.8 22467.3 23189.4 23628.2 942.2 948.8 951.7 982.8 1028.4 11165.8 11422.7 11516.5 11536.1 11581.6 492000.0 502096.0 520285.0 524846.0 536199.0 94204.2 116527.0 126347.0 130867.0 142101.0 924.5 953.9 963.5 1034.4 1035.8 19121.2 20188.7 20207.6 20310.4 20356.0 50426.7 52554.2 54318.5 55845.0 56219.2 81590.6 84947.0 85483.0 91070.0 92328.0 7912.8 7988.4 8250.1 8263.5 8420.0 11090.6 13105.9 13142.4 13446.3 13479.9 11305.0 11549.0 11647.5 11699.6 11820.1 9015.9 10343.8 11000.7 11051.3 11549.9 10360.7 11678.4 11888.2 12041.9 12047.5 8159.8 8304.8 8414.9 8462.5 8487.2 8565.6 11082.7 11834.2 11847.4 11848.5 11:42:24 INFO - PROCESS | 2209 | 11:42:24 INFO - PROCESS | 2209 | [#3] mootools.html Cycles:180 Average:5743.16 Median:4655.11 stddev:3230.21 (69.4%) stddev-sans-first:3223.79 11:42:24 INFO - PROCESS | 2209 | Values: 1535.9 1554.7 1777.9 1864.5 1945.1 8614.6 9165.0 9168.1 9171.8 9178.0 7488.5 7970.5 8215.2 8483.2 8752.5 2380.3 2418.4 2418.7 2422.3 2423.4 2379.1 2405.4 2419.7 2422.2 2422.8 2402.7 2405.7 2413.1 2418.7 2422.3 2375.1 2388.7 2393.1 2398.5 2404.6 2368.2 2389.8 2390.4 2393.6 2394.5 8832.0 8909.4 8920.5 9016.4 9028.2 5277.1 5420.2 5440.0 5441.1 5442.0 3661.6 3672.8 3736.6 3739.3 3748.8 1025.5 1042.8 1086.9 1096.8 1097.2 11905.1 12026.2 12063.3 12081.6 12107.7 4618.4 4691.8 4867.9 4882.4 4929.4 10162.9 10173.1 10187.2 10191.0 10203.6 5406.9 5422.2 5439.4 5441.5 5442.5 4127.3 4260.6 4611.9 4917.0 4993.7 3951.8 3977.7 4079.5 4089.2 4181.2 1296.4 1312.4 1319.8 1327.9 1329.2 816.8 886.7 910.3 920.4 950.2 5603.4 5752.2 5954.3 5997.2 6132.0 453.1 457.8 458.4 1006.8 1027.4 3433.3 3723.5 3951.9 3952.9 4044.9 10783.9 11086.3 11136.9 11145.8 11155.2 8553.7 9177.0 10651.7 10744.8 11110.6 8217.3 8329.3 8355.6 8357.3 8366.0 5590.7 5698.2 5795.0 5828.7 5891.0 10174.2 10187.5 10234.2 10259.0 10259.1 9782.1 10203.5 10208.5 10355.6 10375.6 6952.3 7186.3 7198.0 7506.1 7655.5 7888.4 7986.4 8090.0 8276.7 8561.0 7364.6 7483.6 7487.9 7576.9 7618.4 7198.0 7243.5 7308.1 7480.4 7483.5 6091.7 7108.3 7113.8 7116.5 7121.5 4951.4 5030.0 5086.9 5133.5 5156.7 4746.9 4966.7 5128.1 5179.0 5233.0 11:42:24 INFO - PROCESS | 2209 | 11:42:24 INFO - PROCESS | 2209 | [#4] prototype.html Cycles:180 Average:4492.23 Median:4947.12 stddev:1376.96 (27.8%) stddev-sans-first:1344.35 11:42:24 INFO - PROCESS | 2209 | Values: 298.0 301.3 310.4 312.8 313.8 4392.5 4710.9 4958.5 5352.7 5381.7 4415.3 4770.0 4778.4 5197.9 5358.9 3382.4 4093.4 4114.1 4129.8 4133.3 3843.4 3922.4 4152.7 4161.2 4164.9 3988.7 4044.7 4051.2 4052.5 4067.4 3889.9 4037.8 4044.0 4045.4 4054.3 2862.5 3146.0 3484.3 3486.2 3487.3 4524.9 4608.0 4852.7 4919.3 5174.9 4588.4 4621.4 4625.3 4644.6 4652.1 4461.8 4594.5 5172.8 5609.1 5645.9 3253.4 3548.3 3596.4 3764.9 3862.2 5227.4 5395.7 5920.3 5925.6 5979.7 3863.5 3866.7 3875.5 3919.4 3927.4 3753.7 3892.6 3899.2 3913.9 3923.6 4541.2 4562.2 4562.8 4601.3 4628.4 5619.2 5645.7 5654.6 5662.9 5690.5 1259.1 1293.8 1304.8 1306.6 1337.5 739.9 785.3 868.5 899.6 902.5 5157.4 5167.9 5178.2 5191.2 5194.5 4735.3 5641.4 5656.5 5659.9 5680.7 4170.8 4260.3 4343.7 5085.2 5134.8 2982.4 3036.2 3047.9 3053.1 3064.3 5089.7 5846.5 5945.4 5999.0 6044.2 5305.4 5830.2 5845.0 5934.5 5964.0 5254.9 5669.6 5946.5 5957.3 5978.7 5424.2 5431.5 5754.2 5785.5 5823.0 5185.0 5632.7 5641.7 5674.3 5713.8 5212.9 5457.9 5916.7 5928.6 5981.9 3683.9 3814.4 3826.4 3844.5 3874.3 5361.4 5398.7 5731.6 5752.9 5767.4 5217.5 5329.4 5445.9 5572.5 5608.9 4618.9 5033.9 5529.9 5588.3 5671.3 4520.6 4935.7 5343.1 5495.9 5528.8 4838.3 4853.5 5390.6 5544.3 5565.5 4561.7 5175.9 5231.5 5244.9 5517.2 11:42:24 INFO - PROCESS | 2209 | 11:42:24 INFO - PROCESS | 2209 | [#5] yui.html Cycles:180 Average:25359.25 Median:21935.84 stddev:41068.05 (187.2%) stddev-sans-first:41141.79 11:42:24 INFO - PROCESS | 2209 | Values: 781.0 804.4 816.8 818.7 820.8 12449.4 16252.9 16256.9 16261.3 16281.5 14541.9 14700.8 14705.3 14716.5 14720.6 683.8 701.3 843.9 844.0 862.9 864.2 869.2 880.7 881.1 881.9 778.5 938.8 940.7 941.8 949.3 710.9 879.5 932.0 933.1 934.1 684.2 688.2 689.7 689.9 691.6 15032.1 15033.5 15043.5 15067.4 15072.9 13825.4 13864.9 14084.7 14176.2 14310.0 12696.4 12830.9 12901.0 13103.7 13220.8 4580.6 4608.3 4698.7 4815.4 4830.3 103474.4 115037.4 115891.0 118214.0 121466.0 10660.4 10771.4 10983.7 11042.4 11447.7 21792.9 21922.0 21925.0 21946.7 22309.0 7754.0 7830.3 7840.5 7841.2 8043.2 4255.0 4293.7 4362.2 4398.4 4559.6 3642.2 3806.1 3809.3 3823.2 3826.5 704.5 709.6 715.0 719.6 776.3 596.2 664.7 679.5 684.4 689.1 8971.8 9125.3 9470.2 9571.7 9608.0 586.8 646.1 673.8 673.8 675.0 4479.2 4515.8 4525.1 4599.7 4601.7 97592.5 159441.0 163517.0 163812.0 170399.1 132088.0 133363.0 136244.0 140216.0 140948.3 110183.2 113796.0 121072.0 124834.4 126908.4 9197.9 9691.6 10066.6 10141.6 10238.4 44297.8 48727.5 54571.0 56573.4 59317.0 72067.0 80776.0 90321.0 91790.0 102854.5 13628.2 13709.2 13962.8 13989.0 14248.5 14880.4 14954.9 15044.7 15085.0 15212.5 13341.3 13561.1 13690.0 14352.6 14793.9 12008.6 13926.2 14568.7 14627.9 14928.4 13579.7 14203.5 14312.5 14478.5 14489.5 10990.3 11120.8 11389.7 11430.0 12272.1 11400.6 11733.3 11748.9 11907.9 11994.8 11:42:24 INFO - PROCESS | 2209 | -------- Summary: end -------- 11:42:24 INFO - PROCESS | 2209 | 11:42:25 INFO - TEST-INFO | 2209: exit 0 11:42:25 INFO - TEST-OK | dromaeo_css | took 1117339ms 11:42:25 INFO - TEST-START | kraken 11:42:25 INFO - operating with platform_type : mac_ 11:42:25 INFO - Initialising browser for kraken test... 11:42:25 INFO - TEST-INFO | started process 2213 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmp9Q_Di9/profile http://localhost:57381/getInfo.html) 11:42:27 INFO - PROCESS | 2213 | __metrics Screen width/height:1600/1200 11:42:27 INFO - PROCESS | 2213 | colorDepth:24 11:42:27 INFO - PROCESS | 2213 | Browser inner width/height: 1024/689 11:42:27 INFO - PROCESS | 2213 | __metrics 11:42:27 INFO - PROCESS | 2213 | 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" 11:42:27 INFO - PROCESS | 2213 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:42:28 INFO - TEST-INFO | 2213: exit 0 11:42:28 INFO - Browser initialized. 11:42:28 INFO - Running cycle 1/1 for kraken test... 11:42:28 INFO - TEST-INFO | started process 2214 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmp9Q_Di9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:42:40 INFO - PROCESS | 2214 | RSS: Main: 232210432 11:42:40 INFO - PROCESS | 2214 | 11:42:43 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:57381/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57381/tests/kraken/driver.html?testName=audio-beat-detection) 11:42:44 INFO - PROCESS | 2214 | RSS: Main: 292106240 11:42:44 INFO - PROCESS | 2214 | 11:42:46 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:57381/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57381/tests/kraken/driver.html?testName=audio-dft) 11:42:47 INFO - PROCESS | 2214 | RSS: Main: 288923648 11:42:47 INFO - PROCESS | 2214 | 11:42:50 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:57381/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57381/tests/kraken/driver.html?testName=audio-fft) 11:42:51 INFO - PROCESS | 2214 | RSS: Main: 381050880 11:42:51 INFO - PROCESS | 2214 | 11:42:53 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:57381/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57381/tests/kraken/driver.html?testName=audio-oscillator) 11:42:54 INFO - PROCESS | 2214 | RSS: Main: 279670784 11:42:54 INFO - PROCESS | 2214 | 11:42:56 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:57381/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57381/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:42:56 INFO - PROCESS | 2214 | RSS: Main: 284983296 11:42:56 INFO - PROCESS | 2214 | 11:42:59 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:57381/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57381/tests/kraken/driver.html?testName=imaging-darkroom) 11:43:00 INFO - PROCESS | 2214 | RSS: Main: 323686400 11:43:00 INFO - PROCESS | 2214 | 11:43:03 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:57381/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57381/tests/kraken/driver.html?testName=imaging-desaturate) 11:43:03 INFO - PROCESS | 2214 | RSS: Main: 323395584 11:43:03 INFO - PROCESS | 2214 | 11:43:06 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:57381/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57381/tests/kraken/driver.html?testName=json-parse-financial) 11:43:06 INFO - PROCESS | 2214 | RSS: Main: 321773568 11:43:06 INFO - PROCESS | 2214 | 11:43:08 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:57381/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57381/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:43:09 INFO - PROCESS | 2214 | RSS: Main: 298676224 11:43:09 INFO - PROCESS | 2214 | 11:43:11 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:57381/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57381/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:43:11 INFO - PROCESS | 2214 | RSS: Main: 304181248 11:43:11 INFO - PROCESS | 2214 | 11:43:13 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:57381/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57381/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:43:14 INFO - PROCESS | 2214 | RSS: Main: 301031424 11:43:14 INFO - PROCESS | 2214 | 11:43:17 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:57381/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57381/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:43:18 INFO - PROCESS | 2214 | RSS: Main: 317661184 11:43:18 INFO - PROCESS | 2214 | 11:43:20 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:57381/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57381/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:43:21 INFO - PROCESS | 2214 | RSS: Main: 313737216 11:43:21 INFO - PROCESS | 2214 | 11:43:23 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:57381/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57381/tests/kraken/driver.html?testName=ai-astar) 11:43:23 INFO - PROCESS | 2214 | RSS: Main: 357584896 11:43:23 INFO - PROCESS | 2214 | 11:43:23 INFO - PROCESS | 2214 | __start_tp_report 11:43:23 INFO - PROCESS | 2214 | _x_x_mozilla_page_load 11:43:23 INFO - PROCESS | 2214 | _x_x_mozilla_page_load_details 11:43:23 INFO - PROCESS | 2214 | |i|pagename|runs| 11:43:23 INFO - PROCESS | 2214 | |0;ai-astar;112;114;115;111;113;113;111;113;112;122 11:43:23 INFO - PROCESS | 2214 | |1;audio-beat-detection;149;108;134;164;108;130;115;113;198;120 11:43:23 INFO - PROCESS | 2214 | |2;audio-dft;186;182;182;184;181;180;178;181;180;180 11:43:23 INFO - PROCESS | 2214 | |3;audio-fft;76;73;77;151;62;58;57;70;138;58 11:43:23 INFO - PROCESS | 2214 | |4;audio-oscillator;83;83;140;71;69;88;116;68;71;117 11:43:23 INFO - PROCESS | 2214 | |5;imaging-gaussian-blur;87;83;87;85;87;83;87;85;87;87 11:43:23 INFO - PROCESS | 2214 | |6;imaging-darkroom;94;95;94;95;94;94;94;95;94;94 11:43:23 INFO - PROCESS | 2214 | |7;imaging-desaturate;83;85;84;85;85;84;84;85;87;84 11:43:23 INFO - PROCESS | 2214 | |8;json-parse-financial;55;54;55;54;54;56;55;54;54;55 11:43:23 INFO - PROCESS | 2214 | |9;json-stringify-tinderbox;67;68;69;78;78;73;71;72;72;74 11:43:23 INFO - PROCESS | 2214 | |10;stanford-crypto-aes;85;88;85;84;88;86;88;84;85;85 11:43:23 INFO - PROCESS | 2214 | |11;stanford-crypto-ccm;139;139;135;137;134;137;138;157;184;147 11:43:23 INFO - PROCESS | 2214 | |12;stanford-crypto-pbkdf2;167;170;167;168;167;168;169;178;169;167 11:43:23 INFO - PROCESS | 2214 | |13;stanford-crypto-sha256-iterative;70;70;82;86;90;75;69;66;67;67 11:43:23 INFO - PROCESS | 2214 | __end_tp_report 11:43:23 INFO - PROCESS | 2214 | __start_cc_report 11:43:23 INFO - PROCESS | 2214 | _x_x_mozilla_cycle_collect,2029 11:43:23 INFO - PROCESS | 2214 | __end_cc_report 11:43:23 INFO - PROCESS | 2214 | __startTimestamp1473273803663__endTimestamp 11:43:23 INFO - PROCESS | 2214 | 11:43:23 INFO - PROCESS | 2214 | ------- Summary: start ------- 11:43:23 INFO - PROCESS | 2214 | Number of tests: 14 11:43:23 INFO - PROCESS | 2214 | 11:43:23 INFO - PROCESS | 2214 | [#0] ai-astar Cycles:10 Average:113.60 Median:113.00 stddev:3.20 (2.8%) stddev-sans-first:3.35 11:43:23 INFO - PROCESS | 2214 | Values: 112.0 114.0 115.0 111.0 113.0 113.0 111.0 113.0 112.0 122.0 11:43:23 INFO - PROCESS | 2214 | 11:43:23 INFO - PROCESS | 2214 | [#1] audio-beat-detection Cycles:10 Average:133.90 Median:132.00 stddev:29.03 (22.0%) stddev-sans-first:30.28 11:43:23 INFO - PROCESS | 2214 | Values: 149.0 108.0 134.0 164.0 108.0 130.0 115.0 113.0 198.0 120.0 11:43:23 INFO - PROCESS | 2214 | 11:43:23 INFO - PROCESS | 2214 | [#2] audio-dft Cycles:10 Average:181.40 Median:181.50 stddev:2.27 (1.3%) stddev-sans-first:1.69 11:43:23 INFO - PROCESS | 2214 | Values: 186.0 182.0 182.0 184.0 181.0 180.0 178.0 181.0 180.0 180.0 11:43:23 INFO - PROCESS | 2214 | 11:43:23 INFO - PROCESS | 2214 | [#3] audio-fft Cycles:10 Average:82.00 Median:66.00 stddev:33.93 (51.4%) stddev-sans-first:35.92 11:43:23 INFO - PROCESS | 2214 | Values: 76.0 73.0 77.0 151.0 62.0 58.0 57.0 70.0 138.0 58.0 11:43:23 INFO - PROCESS | 2214 | 11:43:23 INFO - PROCESS | 2214 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:71.00 stddev:25.06 (35.3%) stddev-sans-first:26.42 11:43:23 INFO - PROCESS | 2214 | Values: 83.0 83.0 140.0 71.0 69.0 88.0 116.0 68.0 71.0 117.0 11:43:23 INFO - PROCESS | 2214 | 11:43:23 INFO - PROCESS | 2214 | [#5] imaging-gaussian-blur Cycles:10 Average:85.80 Median:87.00 stddev:1.69 (1.9%) stddev-sans-first:1.73 11:43:23 INFO - PROCESS | 2214 | Values: 87.0 83.0 87.0 85.0 87.0 83.0 87.0 85.0 87.0 87.0 11:43:23 INFO - PROCESS | 2214 | 11:43:23 INFO - PROCESS | 2214 | [#6] imaging-darkroom Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:43:23 INFO - PROCESS | 2214 | Values: 94.0 95.0 94.0 95.0 94.0 94.0 94.0 95.0 94.0 94.0 11:43:23 INFO - PROCESS | 2214 | 11:43:23 INFO - PROCESS | 2214 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:1.07 (1.3%) stddev-sans-first:0.97 11:43:23 INFO - PROCESS | 2214 | Values: 83.0 85.0 84.0 85.0 85.0 84.0 84.0 85.0 87.0 84.0 11:43:23 INFO - PROCESS | 2214 | 11:43:23 INFO - PROCESS | 2214 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:0.70 (1.3%) stddev-sans-first:0.73 11:43:23 INFO - PROCESS | 2214 | Values: 55.0 54.0 55.0 54.0 54.0 56.0 55.0 54.0 54.0 55.0 11:43:23 INFO - PROCESS | 2214 | 11:43:23 INFO - PROCESS | 2214 | [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:72.50 stddev:3.77 (5.2%) stddev-sans-first:3.49 11:43:23 INFO - PROCESS | 2214 | Values: 67.0 68.0 69.0 78.0 78.0 73.0 71.0 72.0 72.0 74.0 11:43:23 INFO - PROCESS | 2214 | 11:43:23 INFO - PROCESS | 2214 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:85.50 stddev:1.62 (1.9%) stddev-sans-first:1.69 11:43:23 INFO - PROCESS | 2214 | Values: 85.0 88.0 85.0 84.0 88.0 86.0 88.0 84.0 85.0 85.0 11:43:23 INFO - PROCESS | 2214 | 11:43:23 INFO - PROCESS | 2214 | [#11] stanford-crypto-ccm Cycles:10 Average:144.70 Median:139.00 stddev:15.41 (11.1%) stddev-sans-first:16.21 11:43:23 INFO - PROCESS | 2214 | Values: 139.0 139.0 135.0 137.0 134.0 137.0 138.0 157.0 184.0 147.0 11:43:23 INFO - PROCESS | 2214 | 11:43:23 INFO - PROCESS | 2214 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:168.50 stddev:3.33 (2.0%) stddev-sans-first:3.46 11:43:23 INFO - PROCESS | 2214 | Values: 167.0 170.0 167.0 168.0 167.0 168.0 169.0 178.0 169.0 167.0 11:43:23 INFO - PROCESS | 2214 | 11:43:23 INFO - PROCESS | 2214 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.20 Median:72.50 stddev:8.72 (12.0%) stddev-sans-first:9.11 11:43:23 INFO - PROCESS | 2214 | Values: 70.0 70.0 82.0 86.0 90.0 75.0 69.0 66.0 67.0 67.0 11:43:23 INFO - PROCESS | 2214 | -------- Summary: end -------- 11:43:23 INFO - PROCESS | 2214 | 11:43:24 INFO - TEST-INFO | 2214: exit 0 11:43:24 INFO - TEST-OK | kraken | took 59026ms 11:43:24 INFO - SUITE-END | took 1176s 11:43:24 INFO - Completed test suite (00:19:36) 11:43:24 INFO - javascript benchmark 11:43:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2786.303424143964, 2997.7409488015032, 3282.130235487596, 3338.8664453421866, 3406.40387932112, 5578.944210557893, 5625.83122506325, 5697.088465845465, 5711.286089238845, 5729.455701708342, 5643.887122257553, 5690.487856092951, 5723.227364305818, 5788.71056447178, 5858.941410585893, 5144.190979329062, 5193.662411943231, 5241.79032838686, 5294.602904782138, 5305.363356397218, 5337.306150200468, 5337.653052551591, 5343.465653434645, 5386.138217885139, 5403.729813509309, 5109.310243117169, 5302.840914772563, 5316.202569614569, 5329.626926115174, 5344.625876188668, 5112.130937740593, 5176.741162941876, 5216.556592689626, 5235.057689615867, 5240.082985477564, 5146.794128234904, 5148.716820574867, 5169.353830771153, 5268.130758424855, 5269.0, 5738.42615738427, 5808.8838223235725, 5817.50551203144, 5818.330891947396, 5845.649261044308, 6065.150878876961, 6087.847803804896, 6106.114613381079, 6137.0, 6184.0, 6269.592476489013, 6289.119523266746, 6311.936880631227, 6316.210473690789, 6326.2092238470195, 5795.913061304083, 5798.88402231953, 5800.564957628152, 5805.535557155417, 5831.766729330864, 6134.4978165938865, 6195.783147589813, 6248.937510624835, 6279.403456671609, 6315.400036996478, 6155.199824022849, 6186.876262474725, 6194.473469755121, 6197.101420294122, 6212.223472065992, 6226.25284965807, 6283.120363149163, 6289.622622642656, 6292.4966002719675, 6301.7164227609865, 6076.240469941257, 6134.417230363198, 6135.293912123373, 6176.0, 6276.937230627726, 6109.617229398918, 6113.841195312599, 6207.131001659771, 6275.34108918557, 6307.590006649553, 4990.950090499048, 4996.650234483552, 5001.44984051754, 5013.774380152902, 5022.773975171126, 4377.4965878923695, 4477.126960242721, 4477.888052798641, 4483.775811209426, 4531.297648864432, 5630.577706671934, 5644.153376993484, 5653.236813030188, 5673.461021202979, 5722.685252311079, 6026.306974697878, 6239.376062393724, 6243.063540468966, 6251.624902505773, 6258.030005349178, 5694.402087780723, 5698.116791897262, 5701.800436984686, 5703.857403564861, 5711.857203569944, 5299.470052994747, 5346.144616861284, 5414.593905457106, 5430.375506816767, 5451.291332126877, 6396.42432181106, 6419.2296924369375, 6436.967815160894, 6450.7097180627925, 6452.0, 6170.167027451236, 6286.937130628635, 6313.2424109107205, 6316.526260530571, 6330.335314791881, 5044.621653376085, 6262.279837818709, 6290.654014029273, 6320.905186422116, 6417.679116044273, 5118.360204974379, 6260.0, 6275.717592708248, 6276.4351208389635, 6282.3089460158435, 6282.246130464374, 6285.779997700059, 6296.118543403835, 6301.4328710416285, 6310.652914089769, 4902.803887844589, 5971.611845230046, 6082.057281121433, 6112.022076467744, 6143.293521245114, 4610.723356598614, 6033.0, 6079.878402432015, 6163.84590385244, 6181.412765787243, 5039.924401133912, 6013.789517366871, 6022.187004754477, 6023.759049637965, 6025.6083354581815, 5936.673482958478, 6024.7288872001745, 6050.45545900871, 6136.539759517965, 6137.631742095488, 5993.280806303272, 6001.699915004319, 6013.458788709037, 6019.87960240784, 6030.5778595497895], "value": 5684.850187632956, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.95797378235955, 506.8873821960797, 524.5095835393906, 528.363322196753, 532.8348212054261, 30580.388392232144, 39250.2149957001, 40256.59101931433, 40343.59656403435, 40345.19309613806, 42097.0, 42419.0, 42511.574884251146, 42539.36190957138, 42577.14845703084, 9623.615055397793, 9811.705648830546, 9818.754531136707, 9828.115469607734, 9834.459104749236, 8764.56177191141, 11779.29324240544, 12006.69983250417, 12035.0, 12233.816492752616, 12063.577774777885, 12149.574764883231, 12149.878501214964, 12175.756484870297, 12203.816942745865, 11982.161248712593, 12054.939725301405, 12075.154739168262, 12090.455929483194, 12092.939535302312, 9938.602455901755, 11766.58816941403, 11821.113416493712, 11847.585334513336, 11859.0, 39489.80255098735, 39748.0, 39758.80120599378, 39760.602393975976, 39791.80104099461, 3424.9657503424896, 3622.42041273395, 3651.7078633709507, 3843.615638436162, 4038.6567141792984, 27050.458990820072, 30343.937962171218, 30539.08382748521, 31507.431422443617, 31634.841825790954, 3200.6159260888608, 3219.098652377338, 3275.3776782411264, 3310.2386451116377, 3381.1209085637665, 512604.0, 517336.0, 519250.0, 519842.0, 519909.9999999962, 27266.591001135, 55930.720346398004, 56249.43750562524, 56476.435235647936, 56501.0, 33485.82799602002, 34821.47767783485, 34963.65036349655, 34964.0, 34982.0, 14505.0, 14640.707185856223, 14645.194514301817, 14658.926705366404, 14666.266686665624, 10785.40680262593, 11373.862613738725, 11408.714782130513, 12437.378131093408, 12497.50009999608, 7614.847703045908, 7771.339436147878, 7798.0, 7824.569648669378, 7894.763157105182, 2697.905573304925, 2908.4473949949443, 3263.8204898730323, 3273.3944220319318, 3351.162209447638, 942.1379437814323, 962.8170647576937, 975.7365511312048, 1038.9116925061455, 1051.8369652703843, 29824.552631710543, 29857.0, 30129.397412051636, 30449.391012180076, 30577.929772457857, 1028.5680014393822, 1040.8490768838476, 1057.8677665291839, 1075.8386242063752, 1081.6160263106642, 14957.70084598302, 15476.071435713893, 15567.610809729847, 15580.766288505454, 15914.124723140107, 705097.0, 711212.443937777, 711454.0, 711620.0, 712853.0, 55195.44804551903, 55870.441295587334, 55912.0, 55963.60090997676, 55992.0, 1210.2677879882544, 1335.9779768477122, 1355.9254241016642, 1363.3183408295852, 1371.1430356027483, 26305.868470657526, 29679.25801854971, 30851.845740771154, 30958.0, 31643.52534712027, 46862.76568617135, 47174.0, 47290.05419891514, 47316.2902556455, 47340.7632961833, 553527.0, 556150.0, 557667.0, 559037.0, 559044.0, 26168.691565422032, 27122.050728224418, 27144.592831107944, 27761.305967350978, 27772.722272777013, 35414.64585354114, 45363.092738145715, 45766.0, 46251.53748462607, 47021.76489117533, 37808.164387670484, 38622.6137738619, 38633.2391831434, 39050.02374940649, 40371.78884633465, 37368.62631373652, 37577.62422375741, 37828.24343513169, 39110.6088939107, 39668.801655991534, 36292.0, 36664.26671466503, 38045.4293185608, 38069.4289585662, 38357.80821095876, 31286.0, 32282.0, 33554.66445335515, 34474.0, 34653.960381188605, 24795.0, 25183.992640294182, 25308.746912530638, 25573.74426255788, 25701.485970280864], "value": 18940.166499747123, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.38527228896425, 347.7513577791879, 350.79829098268505, 368.8008475423271, 389.8131482383826, 15150.848491515095, 16335.18324083797, 17613.647727045452, 17768.378106766264, 17879.10604469778, 19481.415557533262, 19740.40778776639, 20103.497412564695, 20736.688949665728, 20915.895420522877, 5874.353821079678, 6153.077038444225, 6162.414570615784, 6167.969160154215, 6171.783987560436, 5266.789328426858, 6079.878402431948, 6139.38606139387, 6156.322804491502, 6157.907631385533, 5887.175795388649, 6128.3258841527395, 6142.600730952474, 6144.2319710036245, 6146.35463276354, 6101.633901965896, 6196.87606247877, 6206.25524937006, 6209.5342849286035, 6224.937750622526, 5759.400374765772, 6002.339742628307, 6050.122732203806, 6117.847053823645, 6117.908231376533, 13256.933715331457, 13484.595462136152, 13513.662158446019, 18990.0, 24742.381440463952, 2131.648278034138, 2276.6243569811127, 2290.186983620824, 2307.0195167053935, 2684.74494922982, 9588.90411095887, 10432.843507347396, 10552.419616921066, 12313.322767247797, 14874.553763387115, 1823.6443893440785, 1836.2654938024764, 1861.7300491428803, 1904.6381187574316, 1955.9902200489048, 92954.0, 102846.48576757143, 121998.0, 123066.0, 131820.0, 9569.665061722946, 10692.786144277072, 11574.363410012531, 11613.941930290464, 11760.117991150526, 14679.0, 14718.748906342867, 14725.190114543802, 14726.116433014053, 14742.18917959501, 6998.0, 7363.631818409058, 8338.332933365316, 8611.612477438404, 8794.912050879537, 8460.365472589581, 8515.191056849713, 8531.616077276538, 8624.439411438236, 8730.17063378978, 4473.261911784519, 4564.612007979293, 4593.47175074864, 4647.488776234612, 4700.482946875841, 1844.6402951424611, 1876.6809642360831, 1883.9717404238947, 1886.8773529720524, 1889.1769442488064, 830.2278880640941, 882.6954700628273, 919.9632014719471, 957.066859811678, 996.470417908507, 20859.478513036993, 21592.784072159393, 22467.32598022062, 23189.42026449352, 23628.17301394443, 942.2132519346422, 948.8481842905102, 951.6811868024289, 982.8378317577663, 1028.3521381529738, 11165.83251251232, 11422.714432139097, 11516.481758320728, 11536.134789890624, 11581.594644187582, 492000.0, 502096.0, 520285.0, 524846.0, 536199.0, 94204.21809931772, 116527.0, 126347.0, 130867.0, 142101.0, 924.4730503612876, 953.9046095390405, 963.4604621412032, 1034.3915211845651, 1035.8290882004385, 19121.248163437027, 20188.697169542764, 20207.595848082663, 20310.390688279374, 20356.0, 50426.74786626043, 52554.211686825496, 54318.45681543134, 55845.0, 56219.156712648524, 81590.59204703939, 84947.0, 85483.0, 91070.0, 92328.0, 7912.84174316499, 7988.400869934894, 8250.051244106764, 8263.462874913112, 8420.0, 11090.611828585961, 13105.93447032797, 13142.408591613592, 13446.327683615584, 13479.86520134786, 11305.0, 11549.01833344175, 11647.534098635959, 11699.649010529698, 11820.113491488344, 9015.909840901508, 10343.793124137324, 11000.724981875517, 11051.281666691639, 11549.942250288696, 10360.740981475223, 11678.357690327113, 11888.227265227733, 12041.939790300992, 12047.518099276282, 8159.83680326402, 8304.750857474286, 8414.915850841413, 8462.534560599226, 8487.236148746642, 8565.614547345509, 11082.667519974413, 11834.171607987359, 11847.407629618312, 11848.466818992994], "value": 9528.2444122005, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1535.8540938610831, 1554.7356949318616, 1777.8844375115616, 1864.543186919205, 1945.1052515842703, 8614.612342444589, 9165.037671044543, 9168.129027742361, 9171.816563668732, 9178.0, 7488.475806693534, 7970.481918675282, 8215.219554142363, 8483.194096560832, 8752.518611476366, 2380.33350661815, 2418.4074901649033, 2418.6734790803193, 2422.3338581889943, 2423.3820375804144, 2379.0840526397287, 2405.386626410263, 2419.697537807774, 2422.1522467136538, 2422.794062504689, 2402.675638788767, 2405.7113146422366, 2413.095089341497, 2418.7097548294228, 2422.2854257993936, 2375.0618505690154, 2388.6894703688495, 2393.1384701507445, 2398.532286204182, 2404.6152615581423, 2368.194813763329, 2389.7610238976135, 2390.40239940015, 2393.628987506939, 2394.5450364430703, 8832.0, 8909.376343655947, 8920.46477211363, 9016.36885418021, 9028.232600228988, 5277.12927366984, 5420.186971954199, 5439.9936011837935, 5441.129419292934, 5441.972790136064, 3661.560612726463, 3672.8347224374966, 3736.57029441615, 3739.345614517476, 3748.812559372048, 1025.487256371814, 1042.8227201375785, 1086.9456527173688, 1096.7861267052929, 1097.226455348977, 11905.107116966175, 12026.15816892818, 12063.276203427735, 12081.57714479989, 12107.697307567381, 4618.422697162855, 4691.7888695008805, 4867.9269810952865, 4882.438519570223, 4929.383827021622, 10162.949185254027, 10173.135283500986, 10187.217236983499, 10191.0, 10203.591856325813, 5406.91889621656, 5422.240886275925, 5439.374471935778, 5441.483059109379, 5442.510174084351, 4127.2570937231585, 4260.573942605714, 4611.930821037688, 4917.0, 4993.650444468925, 3951.7826519541127, 3977.6817854571564, 4079.530853951774, 4089.1580351655907, 4181.184668989518, 1296.3906963727034, 1312.44221205989, 1319.7822359310605, 1327.9468821247235, 1329.162238620552, 816.8284660221301, 886.6542048601051, 910.349100393222, 920.3833431600843, 950.2255661635745, 5603.439656034364, 5752.223449834219, 5954.315253745788, 5997.220361352996, 6132.0, 453.1480816065841, 457.80772075728277, 458.39491870730984, 1006.7583779892773, 1027.3938376357985, 3433.2790114075824, 3723.515942927402, 3951.92096158081, 3952.9011774705286, 4044.919101617951, 10783.946080269548, 11086.334819910831, 11136.944315278533, 11145.777084458265, 11155.163362747826, 8553.700620478377, 9176.95411522938, 10651.680449586525, 10744.838827417596, 11110.61112861046, 8217.260446559838, 8329.292010179202, 8355.623996920032, 8357.289630381485, 8366.0, 5590.748416321194, 5698.230738850202, 5794.971025144847, 5828.737706803119, 5890.970545147246, 10174.186065114625, 10187.490625468845, 10234.181265498593, 10259.0, 10259.127974121984, 9782.119609235204, 10203.489825508843, 10208.540615672164, 10355.585776568852, 10375.636852710119, 6952.270011648704, 7186.281371862981, 7198.0, 7506.136794268729, 7655.46411751172, 7888.408369372205, 7986.401019923413, 8089.959550202211, 8276.710315138942, 8561.0, 7364.631768411451, 7483.588402637907, 7487.8876816846705, 7576.886346704694, 7618.352440042659, 7197.9922810807575, 7243.45674074436, 7308.123025236793, 7480.3641690456925, 7483.476156668981, 6091.695415229309, 7108.253633368422, 7113.82215444618, 7116.46626503004, 7121.465890058163, 4951.3810773653295, 5029.974850125726, 5086.872828179326, 5133.486651334837, 5156.7421628917655, 4746.905061898674, 4966.726830024383, 5128.128218202989, 5178.97410512945, 5233.0], "value": 4593.435519974067, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.98212107273554, 301.3130063455322, 310.44585415034163, 312.8029341514845, 313.75997362018074, 4392.494863090746, 4710.858674239778, 4958.50414958504, 5352.652077614957, 5381.677099374036, 4415.293553031515, 4770.045990801845, 4778.3549220855175, 5197.922031169535, 5358.892822143564, 3382.424987752082, 4093.3655283430967, 4114.136031433402, 4129.752214867102, 4133.276676581586, 3843.4427008083812, 3922.352811786066, 4152.65038862371, 4161.188568229197, 4164.895877603054, 3988.7064937660816, 4044.7370920890194, 4051.230266249418, 4052.4529188559463, 4067.3898915162667, 3889.949713577318, 4037.777922214277, 4043.9890027493125, 4045.393191021341, 4054.2904991626347, 2862.4990626640256, 3145.9685403145904, 3484.3205574912904, 3486.21560148967, 3487.337405892872, 4524.914020635057, 4608.0, 4852.733099679516, 4919.3358896549225, 5174.896502069938, 4588.407549734389, 4621.376114224604, 4625.306204069383, 4644.6052085572765, 4652.116097941381, 4461.776911154429, 4594.471635761896, 5172.810253641645, 5609.102543593006, 5645.8588535286535, 3253.430649636328, 3548.3435564420665, 3596.4425514045365, 3764.9435258471144, 3862.24686186191, 5227.353383684127, 5395.676259424447, 5920.348761636216, 5925.614835035709, 5979.671118088503, 3863.459115723801, 3866.729328947003, 3875.534935807721, 3919.432227109179, 3927.3912543555793, 3753.7184711146774, 3892.591277915835, 3899.200663863901, 3913.941290880639, 3923.588023257574, 4541.182587134282, 4562.178807814559, 4562.794674239667, 4601.263797792337, 4628.39830821991, 5619.241402410704, 5645.689487078168, 5654.6324488908085, 5662.895735331653, 5690.5447564194765, 1259.106034715344, 1293.7606542789615, 1304.8108024336418, 1306.6406738147086, 1337.4716986790163, 739.8890166474964, 785.3206975965862, 868.5396739727954, 899.6356475627381, 902.4765635931144, 5157.355330583677, 5167.870803229949, 5178.197379406198, 5191.195364718475, 5194.506521880416, 4735.313379560013, 5641.407652196543, 5656.5394053586, 5659.943400565941, 5680.687562184037, 4170.83316667336, 4260.318349064135, 4343.739375637472, 5085.160948443466, 5134.820281290137, 2982.388610334876, 3036.2257624306103, 3047.87808487658, 3053.1070736143733, 3064.3258483133677, 5089.673777289275, 5846.473817356458, 5945.435183657545, 5999.0, 6044.214252147192, 5305.36335639718, 5830.2129212555765, 5845.0, 5934.457041169241, 5963.970180149158, 5254.947450525522, 5669.6314739541795, 5946.524278057745, 5957.344692083867, 5978.730957106854, 5424.2134890439875, 5431.538319242909, 5754.223179870663, 5785.508231800344, 5822.970885145547, 5184.9740751296, 5632.690202038763, 5641.717914104196, 5674.290713660793, 5713.771718978764, 5212.921806172986, 5457.890842183055, 5916.67458289781, 5928.614640048383, 5981.940180598138, 3683.937695934353, 3814.446905198786, 3826.3877779555137, 3844.5386553613744, 3874.3219936510436, 5361.35663720356, 5398.730063496888, 5731.570132240182, 5752.913706294493, 5767.394423585463, 5217.50433708797, 5329.440408757025, 5445.863853403696, 5572.548078845295, 5608.85977850557, 4618.9145550794865, 5033.899322013466, 5529.944700552943, 5588.273524441796, 5671.347795003628, 4520.59314661682, 4935.728534930613, 5343.11838546651, 5495.939022866425, 5528.75120619565, 4838.282409744631, 4853.538913803183, 5390.649607775482, 5544.3346798384455, 5565.499105080562, 4561.7262964222255, 5175.92236116451, 5231.450697676689, 5244.898571299917, 5517.2275881377445], "value": 4051.020670071892, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [780.992519649652, 804.4489524675594, 816.767221341917, 818.7420962396844, 820.774287071055, 12449.447863188047, 16252.918735406322, 16256.918715406406, 16261.268242929067, 16281.51155465338, 14541.854581454183, 14700.779488307684, 14705.264736763173, 14716.484923027696, 14720.6319842004, 683.7538486144983, 701.3232230897183, 843.9409241353108, 843.9789005274887, 862.9352798540103, 864.191980498233, 869.1829680100685, 880.7401816464159, 881.088073843572, 881.9382643214977, 778.5484419036945, 938.7981583959447, 940.7271891151557, 941.8398872191743, 949.2690628216304, 710.8542748736496, 879.4679219072497, 931.9999999999966, 933.0762545080355, 934.0752654871696, 684.1994866006784, 688.2360579756466, 689.7241103558616, 689.8827199376068, 691.5850489706187, 15032.098074115587, 15033.473828415952, 15043.548693539211, 15067.397304107822, 15072.924635376863, 13825.377857996415, 13864.861351386558, 14084.718305633933, 14176.220307883063, 14310.0, 12696.42866071029, 12830.935845320808, 12901.0, 13103.672408189776, 13220.801687974688, 4580.610648094916, 4608.33179189019, 4698.671093023489, 4815.422149342101, 4830.251311046758, 103474.44788328181, 115037.42481287624, 115891.0, 118214.0, 121466.0, 10660.41367724767, 10771.353718776898, 10983.725406864893, 11042.447877606088, 11447.656570302905, 21792.89103554504, 21922.013509392116, 21925.0, 21946.670799938012, 22308.996095175757, 7753.961230193813, 7830.334421574116, 7840.45116841827, 7841.2158784122275, 8043.155468675822, 4254.978725106354, 4293.656507479394, 4362.192994296065, 4398.362237475548, 4559.589636932692, 3642.162302670348, 3806.0675134591647, 3809.29528037314, 3823.2162406706557, 3826.4642949987024, 704.5068452083563, 709.5778012082802, 714.9714011439485, 719.5898337947319, 776.3439893290274, 596.2368168744015, 664.6776313487954, 679.4904811901968, 684.4011489946297, 689.1248114894056, 8971.820563588692, 9125.315601329794, 9470.242380609534, 9571.712848614552, 9608.0, 586.750630981831, 646.1406329581645, 673.7709178879204, 673.8045966669708, 674.956127851688, 4479.193745125844, 4515.841945531891, 4525.094981003813, 4599.701019433726, 4601.723896566216, 97592.51203743936, 159441.0, 163517.0, 163812.0, 170399.14800426166, 132088.0, 133363.0, 136244.0, 140216.0, 140948.29525852305, 110183.22709661131, 113796.0, 121072.0, 124834.37582812028, 126908.36545817212, 9197.858826349155, 9691.612335506501, 10066.647667331608, 10141.645042423479, 10238.436885971343, 44297.778511108525, 48727.5127248723, 54571.0, 56573.43426565682, 59317.0, 72067.0, 80776.0, 90321.0, 91790.0, 102854.48572757088, 13628.182309061489, 13709.223356602035, 13962.79055814184, 13989.0, 14248.501302454364, 14880.404783808526, 14954.925225373803, 15044.699106017599, 15085.0, 15212.46756363522, 13341.318560662696, 13561.118527296088, 13689.973252006339, 14352.56942291733, 14793.852061479247, 12008.63974080779, 13926.164430134224, 14568.708625827212, 14627.92686036563, 14928.402863885323, 13579.660508487366, 14203.502877399242, 14312.499062532761, 14478.493252736103, 14489.492867749577, 10990.285631433931, 11120.777584448104, 11389.658310250707, 11430.0, 12272.140950133406, 11400.600978965696, 11733.296002239893, 11748.941255293668, 11907.880921190677, 11994.76010479803], "value": 8035.378471673346, "unit": "score"}], "name": "dromaeo_css", "value": 7316.635941308393, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 115.0, 111.0, 113.0, 113.0, 111.0, 113.0, 112.0, 122.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 108.0, 134.0, 164.0, 108.0, 130.0, 115.0, 113.0, 198.0, 120.0], "value": 133.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 182.0, 182.0, 184.0, 181.0, 180.0, 178.0, 181.0, 180.0, 180.0], "value": 181.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 77.0, 151.0, 62.0, 58.0, 57.0, 70.0, 138.0, 58.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 140.0, 71.0, 69.0, 88.0, 116.0, 68.0, 71.0, 117.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 87.0, 85.0, 87.0, 83.0, 87.0, 85.0, 87.0, 87.0], "value": 85.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 84.0, 85.0, 85.0, 84.0, 84.0, 85.0, 87.0, 84.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 54.0, 54.0, 56.0, 55.0, 54.0, 54.0, 55.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 69.0, 78.0, 78.0, 73.0, 71.0, 72.0, 72.0, 74.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 85.0, 84.0, 88.0, 86.0, 88.0, 84.0, 85.0, 85.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 139.0, 135.0, 137.0, 134.0, 137.0, 138.0, 157.0, 184.0, 147.0], "value": 144.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 170.0, 167.0, 168.0, 167.0, 168.0, 169.0, 178.0, 169.0, 167.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 82.0, 86.0, 90.0, 75.0, 69.0, 66.0, 67.0, 67.0], "value": 74.2, "unit": "score"}], "name": "kraken", "value": 1466.7, "alertThreshold": 2.0}]} 11:43:24 INFO - Return code: 0 11:43:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:43:24 INFO - # TBPL SUCCESS # 11:43:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:43:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:43:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:43:25 INFO - 2016-09-07 11:43:25.007 screenresolution[2218:26221] starting screenresolution argv=screenresolution get 11:43:25 INFO - 2016-09-07 11:43:25.010 screenresolution[2218:26221] Display 0: 1600x1200x32@60 11:43:25 INFO - 2016-09-07 11:43:25.016 screenresolution[2219:26224] starting screenresolution argv=screenresolution list 11:43:25 INFO - Available Modes on Display 0 11:43:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:43:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:43:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:43:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:43:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:43:25 INFO - Intel Iris: 11:43:25 INFO - Chipset Model: Intel Iris 11:43:25 INFO - Type: GPU 11:43:25 INFO - Bus: Built-In 11:43:25 INFO - VRAM (Dynamic, Max): 1536 MB 11:43:25 INFO - Vendor: Intel (0x8086) 11:43:25 INFO - Device ID: 0x0a2e 11:43:25 INFO - Revision ID: 0x0009 11:43:25 INFO - Displays: 11:43:25 INFO - Display: 11:43:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:43:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:43:25 INFO - Display Serial Number: 1600x1200 60 11:43:25 INFO - Main Display: Yes 11:43:25 INFO - Mirror: Off 11:43:25 INFO - Online: Yes 11:43:25 INFO - Rotation: Supported 11:43:25 INFO - Return code: 0 11:43:25 INFO - Running post-action listener: _resource_record_post_action 11:43:25 INFO - [mozharness: 2016-09-07 18:43:25.250830Z] Finished run-tests step (success) 11:43:25 INFO - Running post-run listener: _resource_record_post_run 11:43:25 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 716800; Write bytes: 704784896; Read time: 7; Write time: 1895 11:43:25 INFO - TinderboxPrint: CPU usage
53.3% 11:43:25 INFO - TinderboxPrint: I/O read bytes / time
716,800 / 7 11:43:25 INFO - TinderboxPrint: I/O write bytes / time
704,784,896 / 1,895 11:43:25 INFO - TinderboxPrint: CPU idle
2,260.7 (46.7%) 11:43:25 INFO - TinderboxPrint: CPU system
964.3 (19.9%) 11:43:25 INFO - TinderboxPrint: CPU user
1,620.6 (33.4%) 11:43:25 INFO - TinderboxPrint: Swap in / out
406,110,208 / 0 11:43:25 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 396141056; Write bytes: 390297088; Read time: 29523; Write time: 704 11:43:25 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 716800; Write bytes: 294538752; Read time: 7; Write time: 1141 11:43:25 INFO - Running post-run listener: _upload_blobber_files 11:43:25 INFO - Blob upload gear active. 11:43:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:43:25 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 11:43:25 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'] 11:43:25 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 11:43:26 INFO - (blobuploader) - INFO - Open directory for files ... 11:43:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:43:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:43:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:43:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:43:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:43:27 INFO - (blobuploader) - INFO - Done attempting. 11:43:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:43:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:43:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:43:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:43:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:43:28 INFO - (blobuploader) - INFO - Done attempting. 11:43:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:43:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:43:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:43:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:43:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:43:33 INFO - (blobuploader) - INFO - Done attempting. 11:43:33 INFO - (blobuploader) - INFO - Iteration through files over. 11:43:33 INFO - Return code: 0 11:43:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:43:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:43:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e4bc867927ff329226c3d1c790dbbe0dfad0a900ea7df7ae137e80e00d68da843e49bc32c05100894ae280b2d33cb0aa3a21947935794bae7fc3c885bbb44f89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c5d36a575458234e802ef77d7b58cd4eefdeda278bec2762cd28f31559bee60022d25d0f4d9fcb1bccae24825c806e1fa66cecac128756d49d54098ba82d03fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ad384ba314288d06946e3cdc9698ec32b4d9f25173eb9ba6b0491a4f00a58e3f830a6652ac1dbd85e309c6800b812e85eb1f5c281f3fb29e610f14221fe52812"} 11:43:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:43:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:43:33 INFO - Contents: 11:43:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e4bc867927ff329226c3d1c790dbbe0dfad0a900ea7df7ae137e80e00d68da843e49bc32c05100894ae280b2d33cb0aa3a21947935794bae7fc3c885bbb44f89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c5d36a575458234e802ef77d7b58cd4eefdeda278bec2762cd28f31559bee60022d25d0f4d9fcb1bccae24825c806e1fa66cecac128756d49d54098ba82d03fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ad384ba314288d06946e3cdc9698ec32b4d9f25173eb9ba6b0491a4f00a58e3f830a6652ac1dbd85e309c6800b812e85eb1f5c281f3fb29e610f14221fe52812"} 11:43:33 INFO - Running post-run listener: copy_logs_to_upload_dir 11:43:33 INFO - Copying logs to upload dir... 11:43:33 INFO - mkdir: /builds/slave/test/build/upload/logs 11:43:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.472791 ========= master_lag: 2.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-09-07 11:43:35.058152) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-07 11:43:35.062620) ========= 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.JefB5dJRxd/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.FIOpZRZuS0/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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/e4bc867927ff329226c3d1c790dbbe0dfad0a900ea7df7ae137e80e00d68da843e49bc32c05100894ae280b2d33cb0aa3a21947935794bae7fc3c885bbb44f89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c5d36a575458234e802ef77d7b58cd4eefdeda278bec2762cd28f31559bee60022d25d0f4d9fcb1bccae24825c806e1fa66cecac128756d49d54098ba82d03fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ad384ba314288d06946e3cdc9698ec32b4d9f25173eb9ba6b0491a4f00a58e3f830a6652ac1dbd85e309c6800b812e85eb1f5c281f3fb29e610f14221fe52812"} build_url:https://queue.taskcluster.net/v1/task/GoW39wFWQQev4h6lL4aq3w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011203 build_url: 'https://queue.taskcluster.net/v1/task/GoW39wFWQQev4h6lL4aq3w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e4bc867927ff329226c3d1c790dbbe0dfad0a900ea7df7ae137e80e00d68da843e49bc32c05100894ae280b2d33cb0aa3a21947935794bae7fc3c885bbb44f89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c5d36a575458234e802ef77d7b58cd4eefdeda278bec2762cd28f31559bee60022d25d0f4d9fcb1bccae24825c806e1fa66cecac128756d49d54098ba82d03fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ad384ba314288d06946e3cdc9698ec32b4d9f25173eb9ba6b0491a4f00a58e3f830a6652ac1dbd85e309c6800b812e85eb1f5c281f3fb29e610f14221fe52812"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-07 11:43:35.096074) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 11:43:35.096417) ========= 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.JefB5dJRxd/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.FIOpZRZuS0/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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.005330 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 11:43:35.145046) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-07 11:43:35.145356) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-07 11:43:35.145678) ========= ========= Total master_lag: 2.97 =========