builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0118 starttime: 1484848072.21 results: success (0) buildid: 20170119081728 builduid: be157f0f622f49209baf4c1f4a2fa063 revision: b55c1f67df7bf76c3e5e6b57f82eb5786f112168 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-19 09:47:52.207588) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-19 09:47:52.208310) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-19 09:47:52.208815) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-19 09:47:52.333424) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 09:47:52.333706) ========= 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.5AP92DAZrl/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.duzGqLguY5/Listeners TMPDIR=/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-19 09:47:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.9M=0.001s 2017-01-19 09:47:52 (14.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.507527 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 09:47:52.872688) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 09:47:52.873059) ========= 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.5AP92DAZrl/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.duzGqLguY5/Listeners TMPDIR=/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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.025589 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 09:47:52.933175) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-19 09:47:52.933510) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev b55c1f67df7bf76c3e5e6b57f82eb5786f112168 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev b55c1f67df7bf76c3e5e6b57f82eb5786f112168 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5AP92DAZrl/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.duzGqLguY5/Listeners TMPDIR=/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-19 09:47:53,036 truncating revision to first 12 chars 2017-01-19 09:47:53,037 Setting DEBUG logging. 2017-01-19 09:47:53,037 attempt 1/10 2017-01-19 09:47:53,037 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/b55c1f67df7b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-19 09:47:54,635 unpacking tar archive at: graphics-b55c1f67df7b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.850971 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-19 09:47:54.811772) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-19 09:47:54.812108) ========= script_repo_revision: b55c1f67df7bf76c3e5e6b57f82eb5786f112168 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-19 09:47:54.812496) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-19 09:47:54.812757) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-19 09:47:54.831767) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-19 09:47:54.832035) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Graphics', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5AP92DAZrl/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.duzGqLguY5/Listeners TMPDIR=/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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 09:47:55 INFO - MultiFileLogger online at 20170119 09:47:55 in /builds/slave/test 09:47:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 09:47:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:47:55 INFO - {'append_to_log': False, 09:47:55 INFO - 'base_work_dir': '/builds/slave/test', 09:47:55 INFO - 'blob_upload_branch': 'Graphics', 09:47:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:47:55 INFO - 'branch': 'Graphics', 09:47:55 INFO - 'buildbot_json_path': 'buildprops.json', 09:47:55 INFO - 'config_files': ('talos/mac_config.py',), 09:47:55 INFO - 'default_actions': ('clobber', 09:47:55 INFO - 'read-buildbot-config', 09:47:55 INFO - 'download-and-extract', 09:47:55 INFO - 'populate-webroot', 09:47:55 INFO - 'create-virtualenv', 09:47:55 INFO - 'install', 09:47:55 INFO - 'run-tests'), 09:47:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:47:55 INFO - 'download_minidump_stackwalk': True, 09:47:55 INFO - 'download_symbols': 'ondemand', 09:47:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:47:55 INFO - 'tooltool.py': '/tools/tooltool.py', 09:47:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:47:55 INFO - '/tools/misc-python/virtualenv.py')}, 09:47:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:47:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:47:55 INFO - 'installer_path': 'installer.exe', 09:47:55 INFO - 'log_level': 'info', 09:47:55 INFO - 'log_name': 'talos', 09:47:55 INFO - 'log_to_console': True, 09:47:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:47:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:47:55 INFO - 'opt_config_files': (), 09:47:55 INFO - 'pip_index': False, 09:47:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:47:55 INFO - 'cmd': ('bash', 09:47:55 INFO - '-c', 09:47:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:47:55 INFO - 'enabled': True, 09:47:55 INFO - 'halt_on_failure': False, 09:47:55 INFO - 'name': 'check_screen_resolution'},), 09:47:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:47:55 INFO - 'cmd': ('bash', 09:47:55 INFO - '-c', 09:47:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:47:55 INFO - 'enabled': True, 09:47:55 INFO - 'halt_on_failure': False, 09:47:55 INFO - 'name': 'check_screen_resolution'},), 09:47:55 INFO - 'run_cmd_checks_enabled': True, 09:47:55 INFO - 'sps_profile': False, 09:47:55 INFO - 'sps_profile_interval': 0, 09:47:55 INFO - 'suite': 'dromaeojs', 09:47:55 INFO - 'system_bits': '32', 09:47:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:47:55 INFO - 'title': 't-yosemite-r7-0118', 09:47:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:47:55 INFO - 'use_talos_json': True, 09:47:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:47:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:47:55 INFO - 'work_dir': 'build'} 09:47:55 INFO - [mozharness: 2017-01-19 17:47:55.041642Z] Running clobber step. 09:47:55 INFO - Running pre-action listener: _resource_record_pre_action 09:47:55 INFO - Running main action method: clobber 09:47:55 INFO - rmtree: /builds/slave/test/build 09:47:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:47:57 INFO - Running post-action listener: _resource_record_post_action 09:47:57 INFO - [mozharness: 2017-01-19 17:47:57.392016Z] Finished clobber step (success) 09:47:57 INFO - [mozharness: 2017-01-19 17:47:57.392154Z] Running read-buildbot-config step. 09:47:57 INFO - Running pre-action listener: _resource_record_pre_action 09:47:57 INFO - Running main action method: read_buildbot_config 09:47:57 INFO - Using buildbot properties: 09:47:57 INFO - { 09:47:57 INFO - "project": "", 09:47:57 INFO - "product": "firefox", 09:47:57 INFO - "script_repo_revision": "default", 09:47:57 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 09:47:57 INFO - "repository": "", 09:47:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 09:47:57 INFO - "buildid": "20170119081728", 09:47:57 INFO - "pgo_build": "False", 09:47:57 INFO - "basedir": "/builds/slave/test", 09:47:57 INFO - "buildnumber": 26, 09:47:57 INFO - "slavename": "t-yosemite-r7-0118", 09:47:57 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 09:47:57 INFO - "platform": "yosemite_r7", 09:47:57 INFO - "scheduler": "tests-graphics-macosx64-talos", 09:47:57 INFO - "branch": "graphics", 09:47:57 INFO - "repo_path": "projects/graphics", 09:47:57 INFO - "revision": "b55c1f67df7bf76c3e5e6b57f82eb5786f112168", 09:47:57 INFO - "stage_platform": "macosx64", 09:47:57 INFO - "builduid": "be157f0f622f49209baf4c1f4a2fa063", 09:47:57 INFO - "slavebuilddir": "test" 09:47:57 INFO - } 09:47:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/MY-MybImRrCEhLBRgkpbpg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 09:47:57 INFO - Running post-action listener: _resource_record_post_action 09:47:57 INFO - [mozharness: 2017-01-19 17:47:57.395485Z] Finished read-buildbot-config step (success) 09:47:57 INFO - [mozharness: 2017-01-19 17:47:57.395618Z] Running download-and-extract step. 09:47:57 INFO - Running pre-action listener: _resource_record_pre_action 09:47:57 INFO - Running main action method: download_and_extract 09:47:57 INFO - mkdir: /builds/slave/test/build/tests 09:47: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')]} 09:47:57 INFO - trying https://queue.taskcluster.net/v1/task/MY-MybImRrCEhLBRgkpbpg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 09:47:57 INFO - Downloading https://queue.taskcluster.net/v1/task/MY-MybImRrCEhLBRgkpbpg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 09:47:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MY-MybImRrCEhLBRgkpbpg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 09:47:58 INFO - Downloaded 1199 bytes. 09:47:58 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 09:47:58 INFO - Using the following test package requirements: 09:47:58 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 09:47:58 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:47:58 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 09:47:58 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:47:58 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 09:47:58 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:47:58 INFO - u'jsshell-mac.zip'], 09:47:58 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:47:58 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 09:47:58 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 09:47:58 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:47:58 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 09:47:58 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:47:58 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 09:47:58 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:47:58 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 09:47:58 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:47:58 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 09:47:58 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:47:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MY-MybImRrCEhLBRgkpbpg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 09:47:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MY-MybImRrCEhLBRgkpbpg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:47:58 INFO - Fetch https://queue.taskcluster.net/v1/task/MY-MybImRrCEhLBRgkpbpg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 09:47:59 INFO - Expected file size: 16340612 09:47:59 INFO - Obtained file size: 16340612 09:48:06 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:48:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MY-MybImRrCEhLBRgkpbpg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 09:48:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MY-MybImRrCEhLBRgkpbpg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:48:06 INFO - Fetch https://queue.taskcluster.net/v1/task/MY-MybImRrCEhLBRgkpbpg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 09:48:07 INFO - Expected file size: 16340612 09:48:07 INFO - Obtained file size: 16340612 09:48:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MY-MybImRrCEhLBRgkpbpg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 09:48:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MY-MybImRrCEhLBRgkpbpg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:48:13 INFO - Fetch https://queue.taskcluster.net/v1/task/MY-MybImRrCEhLBRgkpbpg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 09:48:14 INFO - Expected file size: 14403463 09:48:14 INFO - Obtained file size: 14403463 09:48:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:14 INFO - trying https://queue.taskcluster.net/v1/task/MY-MybImRrCEhLBRgkpbpg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:48:14 INFO - Downloading https://queue.taskcluster.net/v1/task/MY-MybImRrCEhLBRgkpbpg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 09:48:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MY-MybImRrCEhLBRgkpbpg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 09:48:16 INFO - Downloaded 69944791 bytes. 09:48:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MY-MybImRrCEhLBRgkpbpg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:48:16 INFO - mkdir: /builds/slave/test/properties 09:48:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:48:16 INFO - Writing to file /builds/slave/test/properties/build_url 09:48:16 INFO - Contents: 09:48:16 INFO - build_url:https://queue.taskcluster.net/v1/task/MY-MybImRrCEhLBRgkpbpg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:48:17 INFO - Running post-action listener: _resource_record_post_action 09:48:17 INFO - Running post-action listener: set_extra_try_arguments 09:48:17 INFO - [mozharness: 2017-01-19 17:48:17.817321Z] Finished download-and-extract step (success) 09:48:17 INFO - [mozharness: 2017-01-19 17:48:17.817433Z] Running populate-webroot step. 09:48:17 INFO - Running pre-action listener: _resource_record_pre_action 09:48:17 INFO - Running main action method: populate_webroot 09:48:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:48:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:48:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:48:17 INFO - '--tppagecycles', 09:48:17 INFO - '7'], 09:48:17 INFO - 'tests': ['tsvgm']}}, 09:48:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:48:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:48:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:48:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:48:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:48:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:48:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:48:17 INFO - 'talos_options': ['--disable-e10s'], 09:48:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:48:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:48:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:48:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:48:17 INFO - 'talos_options': ['--disable-e10s'], 09:48:17 INFO - 'tests': ['damp', 'tps']}, 09:48:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:48:17 INFO - 'tests': ['damp', 'tps']}, 09:48:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:48:17 INFO - 'tests': ['dromaeo_dom']}, 09:48:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:48:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:48:17 INFO - 'tests': ['basic_compositor_video']}, 09:48:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:48:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:48:17 INFO - 'tests': ['a11yr', 09:48:17 INFO - 'ts_paint', 09:48:17 INFO - 'tpaint', 09:48:17 INFO - 'sessionrestore', 09:48:17 INFO - 'sessionrestore_no_auto_restore', 09:48:17 INFO - 'tabpaint']}, 09:48:17 INFO - 'other-e10s': {'tests': ['a11yr', 09:48:17 INFO - 'ts_paint', 09:48:17 INFO - 'tpaint', 09:48:17 INFO - 'sessionrestore', 09:48:17 INFO - 'sessionrestore_no_auto_restore', 09:48:17 INFO - 'tabpaint']}, 09:48:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:48:17 INFO - 'ts_paint', 09:48:17 INFO - 'tpaint', 09:48:17 INFO - 'sessionrestore', 09:48:17 INFO - 'sessionrestore_no_auto_restore', 09:48:17 INFO - 'tabpaint']}, 09:48:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:48:17 INFO - 'ts_paint', 09:48:17 INFO - 'tpaint', 09:48:17 INFO - 'sessionrestore', 09:48:17 INFO - 'sessionrestore_no_auto_restore', 09:48:17 INFO - 'tabpaint']}, 09:48:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:48:17 INFO - 'tests': ['a11yr', 09:48:17 INFO - 'ts_paint', 09:48:17 INFO - 'tpaint', 09:48:17 INFO - 'sessionrestore', 09:48:17 INFO - 'sessionrestore_no_auto_restore', 09:48:17 INFO - 'tabpaint']}, 09:48:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:48:17 INFO - 'tests': ['a11yr', 09:48:17 INFO - 'ts_paint', 09:48:17 INFO - 'tpaint', 09:48:17 INFO - 'sessionrestore', 09:48:17 INFO - 'sessionrestore_no_auto_restore', 09:48:17 INFO - 'tabpaint']}, 09:48:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:48:17 INFO - 'tests': ['tsvgx', 09:48:17 INFO - 'tsvgr_opacity', 09:48:17 INFO - 'tart', 09:48:17 INFO - 'tscrollx', 09:48:17 INFO - 'cart', 09:48:17 INFO - 'tsvg_static']}, 09:48:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:48:17 INFO - 'tsvgr_opacity', 09:48:17 INFO - 'tart', 09:48:17 INFO - 'tscrollx', 09:48:17 INFO - 'cart', 09:48:17 INFO - 'tsvg_static']}, 09:48:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:48:17 INFO - 'talos_options': ['--disable-e10s'], 09:48:17 INFO - 'tests': ['tp5o']}, 09:48:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:48:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:48:17 INFO - 'talos_options': ['--disable-e10s', 09:48:17 INFO - '--xperf_path', 09:48:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:48:17 INFO - 'tests': ['tp5n']}, 09:48:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:48:17 INFO - 'talos_options': ['--xperf_path', 09:48:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:48:17 INFO - 'tests': ['tp5n']}}, 09:48:17 INFO - 'talos.zip': {'path': '', 09:48:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:48:17 INFO - Running post-action listener: _resource_record_post_action 09:48:17 INFO - [mozharness: 2017-01-19 17:48:17.835735Z] Finished populate-webroot step (success) 09:48:17 INFO - [mozharness: 2017-01-19 17:48:17.835846Z] Running create-virtualenv step. 09:48:17 INFO - Running pre-action listener: _resource_record_pre_action 09:48:17 INFO - Running main action method: create_virtualenv 09:48:17 INFO - Creating virtualenv /builds/slave/test/build/venv 09:48:17 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 09:48:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:48:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:48:17 INFO - Using real prefix '/tools/python27' 09:48:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:48:18 INFO - Installing distribute.............................................................................................................................................................................................done. 09:48:21 INFO - Installing pip.................done. 09:48:21 INFO - Return code: 0 09:48:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:48:21 INFO - Reading from file tmpfile_stdout 09:48:21 INFO - Output received: 09:48:21 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:48:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:48:21 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')]} 09:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:21 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')]} 09:48:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:21 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 0x1078dab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078dd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb61594bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076b8d30>, '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 0x1075dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1076adbe8>, '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.5AP92DAZrl/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.duzGqLguY5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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 09:48:21 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 09:48:21 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 09:48:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AP92DAZrl/Render', 09:48:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:21 INFO - 'HOME': '/Users/cltbld', 09:48:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:21 INFO - 'LOGNAME': 'cltbld', 09:48:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:21 INFO - 'MOZ_NO_REMOTE': '1', 09:48:21 INFO - 'NO_EM_RESTART': '1', 09:48:21 INFO - 'PAGER': '/bin/cat', 09:48:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:21 INFO - 'PWD': '/builds/slave/test', 09:48:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:21 INFO - 'SHELL': '/bin/bash', 09:48:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.duzGqLguY5/Listeners', 09:48:21 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 09:48:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:21 INFO - 'USER': 'cltbld', 09:48:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:21 INFO - 'XPC_FLAGS': '0x0', 09:48:21 INFO - 'XPC_SERVICE_NAME': '0', 09:48:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:22 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 09:48:22 INFO - Cleaning up... 09:48:22 INFO - Return code: 0 09:48:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:22 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 0x1078dab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078dd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb61594bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076b8d30>, '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 0x1075dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1076adbe8>, '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.5AP92DAZrl/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.duzGqLguY5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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 09:48:22 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 09:48:22 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 09:48:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AP92DAZrl/Render', 09:48:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:22 INFO - 'HOME': '/Users/cltbld', 09:48:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:22 INFO - 'LOGNAME': 'cltbld', 09:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:22 INFO - 'MOZ_NO_REMOTE': '1', 09:48:22 INFO - 'NO_EM_RESTART': '1', 09:48:22 INFO - 'PAGER': '/bin/cat', 09:48:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:22 INFO - 'PWD': '/builds/slave/test', 09:48:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:22 INFO - 'SHELL': '/bin/bash', 09:48:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.duzGqLguY5/Listeners', 09:48:22 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 09:48:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:22 INFO - 'USER': 'cltbld', 09:48:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:22 INFO - 'XPC_FLAGS': '0x0', 09:48:22 INFO - 'XPC_SERVICE_NAME': '0', 09:48:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:22 INFO - Downloading/unpacking psutil>=3.1.1 09:48:22 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 09:48:22 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 09:48:22 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 09:48:22 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 09:48:22 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 09:48:22 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 09:48:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:48:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:48:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:48:26 INFO - Installing collected packages: psutil 09:48:26 INFO - Running setup.py install for psutil 09:48:26 INFO - building 'psutil._psutil_osx' extension 09:48:26 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 09:48:26 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 09:48:26 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 09:48:27 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 09:48:27 INFO - building 'psutil._psutil_posix' extension 09:48:27 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 09:48:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:48:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:48:27 INFO - ^ 09:48:27 INFO - 1 warning generated. 09:48:27 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 09:48:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:48:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:48:27 INFO - Successfully installed psutil 09:48:27 INFO - Cleaning up... 09:48:27 INFO - Return code: 0 09:48:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1078dab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078dd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb61594bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076b8d30>, '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 0x1075dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1076adbe8>, '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.5AP92DAZrl/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.duzGqLguY5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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 09:48:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:48:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:48:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AP92DAZrl/Render', 09:48:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:27 INFO - 'HOME': '/Users/cltbld', 09:48:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:27 INFO - 'LOGNAME': 'cltbld', 09:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:27 INFO - 'MOZ_NO_REMOTE': '1', 09:48:27 INFO - 'NO_EM_RESTART': '1', 09:48:27 INFO - 'PAGER': '/bin/cat', 09:48:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:27 INFO - 'PWD': '/builds/slave/test', 09:48:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:27 INFO - 'SHELL': '/bin/bash', 09:48:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.duzGqLguY5/Listeners', 09:48:27 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 09:48:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:27 INFO - 'USER': 'cltbld', 09:48:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:27 INFO - 'XPC_FLAGS': '0x0', 09:48:27 INFO - 'XPC_SERVICE_NAME': '0', 09:48:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:48:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:48:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:48:30 INFO - Installing collected packages: mozsystemmonitor 09:48:30 INFO - Running setup.py install for mozsystemmonitor 09:48:30 INFO - Successfully installed mozsystemmonitor 09:48:30 INFO - Cleaning up... 09:48:30 INFO - Return code: 0 09:48:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:30 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 0x1078dab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078dd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb61594bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076b8d30>, '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 0x1075dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1076adbe8>, '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.5AP92DAZrl/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.duzGqLguY5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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 09:48:30 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 09:48:30 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 09:48:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AP92DAZrl/Render', 09:48:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:30 INFO - 'HOME': '/Users/cltbld', 09:48:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:30 INFO - 'LOGNAME': 'cltbld', 09:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:30 INFO - 'MOZ_NO_REMOTE': '1', 09:48:30 INFO - 'NO_EM_RESTART': '1', 09:48:30 INFO - 'PAGER': '/bin/cat', 09:48:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:30 INFO - 'PWD': '/builds/slave/test', 09:48:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:30 INFO - 'SHELL': '/bin/bash', 09:48:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.duzGqLguY5/Listeners', 09:48:30 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 09:48:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:30 INFO - 'USER': 'cltbld', 09:48:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:30 INFO - 'XPC_FLAGS': '0x0', 09:48:30 INFO - 'XPC_SERVICE_NAME': '0', 09:48:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:31 INFO - Downloading/unpacking jsonschema==2.5.1 09:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:48:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:48:33 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 09:48:33 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 09:48:33 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 09:48:33 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 09:48:33 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 09:48:33 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 09:48:34 INFO - Downloading functools32-3.2.3-2.tar.gz 09:48:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:48:34 INFO - warning: no files found matching '*.txt' 09:48:34 INFO - no previously-included directories found matching 'build' 09:48:34 INFO - no previously-included directories found matching 'dist' 09:48:34 INFO - no previously-included directories found matching '.git*' 09:48:34 INFO - Installing collected packages: jsonschema, functools32 09:48:34 INFO - Running setup.py install for functools32 09:48:34 INFO - warning: no files found matching '*.txt' 09:48:34 INFO - no previously-included directories found matching 'build' 09:48:34 INFO - no previously-included directories found matching 'dist' 09:48:34 INFO - no previously-included directories found matching '.git*' 09:48:34 INFO - Successfully installed jsonschema functools32 09:48:34 INFO - Cleaning up... 09:48:34 INFO - Return code: 0 09:48:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:48:34 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')]} 09:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:34 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')]} 09:48:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:34 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 0x1078dab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078dd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb61594bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076b8d30>, '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 0x1075dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1076adbe8>, '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.5AP92DAZrl/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.duzGqLguY5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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 09:48:34 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 09:48:34 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 09:48:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AP92DAZrl/Render', 09:48:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:34 INFO - 'HOME': '/Users/cltbld', 09:48:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:34 INFO - 'LOGNAME': 'cltbld', 09:48:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:34 INFO - 'MOZ_NO_REMOTE': '1', 09:48:34 INFO - 'NO_EM_RESTART': '1', 09:48:34 INFO - 'PAGER': '/bin/cat', 09:48:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:34 INFO - 'PWD': '/builds/slave/test', 09:48:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:34 INFO - 'SHELL': '/bin/bash', 09:48:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.duzGqLguY5/Listeners', 09:48:34 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 09:48:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:34 INFO - 'USER': 'cltbld', 09:48:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:34 INFO - 'XPC_FLAGS': '0x0', 09:48:34 INFO - 'XPC_SERVICE_NAME': '0', 09:48:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:48:34 INFO - Cleaning up... 09:48:34 INFO - Return code: 0 09:48:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:48:34 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')]} 09:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:34 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')]} 09:48:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:34 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 0x1078dab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078dd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb61594bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076b8d30>, '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 0x1075dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1076adbe8>, '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.5AP92DAZrl/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.duzGqLguY5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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 09:48:34 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 09:48:34 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 09:48:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AP92DAZrl/Render', 09:48:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:34 INFO - 'HOME': '/Users/cltbld', 09:48:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:34 INFO - 'LOGNAME': 'cltbld', 09:48:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:34 INFO - 'MOZ_NO_REMOTE': '1', 09:48:34 INFO - 'NO_EM_RESTART': '1', 09:48:34 INFO - 'PAGER': '/bin/cat', 09:48:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:34 INFO - 'PWD': '/builds/slave/test', 09:48:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:34 INFO - 'SHELL': '/bin/bash', 09:48:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.duzGqLguY5/Listeners', 09:48:34 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 09:48:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:34 INFO - 'USER': 'cltbld', 09:48:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:34 INFO - 'XPC_FLAGS': '0x0', 09:48:34 INFO - 'XPC_SERVICE_NAME': '0', 09:48:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:35 INFO - Downloading/unpacking blobuploader==1.2.4 09:48:35 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 09:48:35 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 09:48:35 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 09:48:35 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 09:48:35 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 09:48:35 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 09:48:37 INFO - Downloading blobuploader-1.2.4.tar.gz 09:48:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:48:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:48:37 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 09:48:37 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 09:48:37 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 09:48:37 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 09:48:37 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 09:48:37 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 09:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:48:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:48:38 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 09:48:38 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 09:48:38 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 09:48:38 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 09:48:38 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 09:48:38 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 09:48:39 INFO - Downloading docopt-0.6.1.tar.gz 09:48:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:48:39 INFO - Installing collected packages: blobuploader, requests, docopt 09:48:39 INFO - Running setup.py install for blobuploader 09:48:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:48:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:48:39 INFO - Running setup.py install for requests 09:48:39 INFO - Running setup.py install for docopt 09:48:40 INFO - Successfully installed blobuploader requests docopt 09:48:40 INFO - Cleaning up... 09:48:40 INFO - Return code: 0 09:48:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48:40 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')]} 09:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:40 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')]} 09:48:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:40 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 0x1078dab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078dd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb61594bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076b8d30>, '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 0x1075dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1076adbe8>, '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.5AP92DAZrl/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.duzGqLguY5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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 09:48:40 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 09:48:40 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 09:48:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AP92DAZrl/Render', 09:48:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:40 INFO - 'HOME': '/Users/cltbld', 09:48:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:40 INFO - 'LOGNAME': 'cltbld', 09:48:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:40 INFO - 'MOZ_NO_REMOTE': '1', 09:48:40 INFO - 'NO_EM_RESTART': '1', 09:48:40 INFO - 'PAGER': '/bin/cat', 09:48:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:40 INFO - 'PWD': '/builds/slave/test', 09:48:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:40 INFO - 'SHELL': '/bin/bash', 09:48:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.duzGqLguY5/Listeners', 09:48:40 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 09:48:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:40 INFO - 'USER': 'cltbld', 09:48:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:40 INFO - 'XPC_FLAGS': '0x0', 09:48:40 INFO - 'XPC_SERVICE_NAME': '0', 09:48:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:48:40 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-m1LIVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:48:40 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-0NzKIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:48:40 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-tYk1TC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:48:40 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-GZKyK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:48:40 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-e0iTwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:48:40 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-Lh75Kv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:48:41 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-eRMiq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:48:41 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-It_3uR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:48:41 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-MUdalx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:48:41 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-YUxvMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:48:41 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-wOj_r6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:48:41 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-YnAOWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:48:41 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-9k43YW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:48:41 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-RNJOIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:41 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-B39RRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:48:41 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-cFwDrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:48:42 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-zlYWN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:48:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:48:42 INFO - Running setup.py install for manifestparser 09:48:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:48:42 INFO - Running setup.py install for mozcrash 09:48:42 INFO - Running setup.py install for mozdebug 09:48:42 INFO - Running setup.py install for mozdevice 09:48:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:48:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:48:42 INFO - Running setup.py install for mozfile 09:48:42 INFO - Running setup.py install for mozhttpd 09:48:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:48:43 INFO - Running setup.py install for mozinfo 09:48:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:48:43 INFO - Running setup.py install for mozInstall 09:48:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:48:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:48:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:48:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:48:43 INFO - Running setup.py install for mozleak 09:48:43 INFO - Running setup.py install for mozlog 09:48:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:48:43 INFO - Running setup.py install for moznetwork 09:48:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:48:43 INFO - Running setup.py install for mozprocess 09:48:43 INFO - Running setup.py install for mozprofile 09:48:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:48:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:48:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:48:44 INFO - Running setup.py install for mozrunner 09:48:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:48:44 INFO - Running setup.py install for mozscreenshot 09:48:44 INFO - Running setup.py install for moztest 09:48:44 INFO - Running setup.py install for mozversion 09:48:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:48:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:48:44 INFO - Cleaning up... 09:48:44 INFO - Return code: 0 09:48:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48:44 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')]} 09:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:44 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')]} 09:48:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:44 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 0x1078dab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078dd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb61594bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076b8d30>, '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 0x1075dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1076adbe8>, '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.5AP92DAZrl/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.duzGqLguY5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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 09:48:44 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 09:48:44 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 09:48:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AP92DAZrl/Render', 09:48:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:44 INFO - 'HOME': '/Users/cltbld', 09:48:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:44 INFO - 'LOGNAME': 'cltbld', 09:48:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:44 INFO - 'MOZ_NO_REMOTE': '1', 09:48:44 INFO - 'NO_EM_RESTART': '1', 09:48:44 INFO - 'PAGER': '/bin/cat', 09:48:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:44 INFO - 'PWD': '/builds/slave/test', 09:48:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:44 INFO - 'SHELL': '/bin/bash', 09:48:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.duzGqLguY5/Listeners', 09:48:44 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 09:48:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:44 INFO - 'USER': 'cltbld', 09:48:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:44 INFO - 'XPC_FLAGS': '0x0', 09:48:44 INFO - 'XPC_SERVICE_NAME': '0', 09:48:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:48:45 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-ia9iaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:48:45 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)) 09:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:48:45 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-GZM5PK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:48:45 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-SW_DXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:48:45 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)) 09:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:48:45 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-u01S_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:48:45 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-afkal2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:48:45 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)) 09:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:48:45 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-3RiMBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:48:45 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)) 09:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:48:45 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-vLd0f_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:48:45 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)) 09:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:48:45 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-XmZrsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:48:45 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)) 09:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:48:45 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-uqP3cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:48:45 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)) 09:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:48:45 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-2XhiyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:48:46 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-BzaRIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:48:46 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)) 09:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:48:46 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-2rRWzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:48:46 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-G467mr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:48:46 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)) 09:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:48:46 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-z15Oh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:46 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-t4_dZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:46 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)) 09:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:48:46 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-R2XQaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:48:46 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-EkfWIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:48:46 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)) 09:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:48:46 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)) 09:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:48:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48:49 INFO - Downloading blessings-1.6.tar.gz 09:48:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:48:49 INFO - Installing collected packages: blessings 09:48:49 INFO - Running setup.py install for blessings 09:48:49 INFO - Successfully installed blessings 09:48:49 INFO - Cleaning up... 09:48:49 INFO - Return code: 0 09:48:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:48:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:48:50 INFO - Reading from file tmpfile_stdout 09:48:50 INFO - Current package versions: 09:48:50 INFO - blessings == 1.6 09:48:50 INFO - blobuploader == 1.2.4 09:48:50 INFO - docopt == 0.6.1 09:48:50 INFO - functools32 == 3.2.3-2 09:48:50 INFO - jsonschema == 2.5.1 09:48:50 INFO - manifestparser == 1.1 09:48:50 INFO - mozInstall == 1.12 09:48:50 INFO - mozcrash == 1.0 09:48:50 INFO - mozdebug == 0.1 09:48:50 INFO - mozdevice == 0.49 09:48:50 INFO - mozfile == 1.2 09:48:50 INFO - mozhttpd == 0.7 09:48:50 INFO - mozinfo == 0.9 09:48:50 INFO - mozleak == 0.1 09:48:50 INFO - mozlog == 3.4 09:48:50 INFO - moznetwork == 0.27 09:48:50 INFO - mozprocess == 0.24 09:48:50 INFO - mozprofile == 0.28 09:48:50 INFO - mozrunner == 6.13 09:48:50 INFO - mozscreenshot == 0.1 09:48:50 INFO - mozsystemmonitor == 0.3 09:48:50 INFO - moztest == 0.8 09:48:50 INFO - mozversion == 1.4 09:48:50 INFO - psutil == 3.1.1 09:48:50 INFO - requests == 1.2.3 09:48:50 INFO - wsgiref == 0.1.2 09:48:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48: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')]} 09:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48: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')]} 09:48:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:50 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 0x1078dab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078dd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb61594bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076b8d30>, '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 0x1075dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1076adbe8>, '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.5AP92DAZrl/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.duzGqLguY5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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 09:48:50 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 09:48:50 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 09:48:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AP92DAZrl/Render', 09:48:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:50 INFO - 'HOME': '/Users/cltbld', 09:48:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:50 INFO - 'LOGNAME': 'cltbld', 09:48:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:50 INFO - 'MOZ_NO_REMOTE': '1', 09:48:50 INFO - 'NO_EM_RESTART': '1', 09:48:50 INFO - 'PAGER': '/bin/cat', 09:48:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:50 INFO - 'PWD': '/builds/slave/test', 09:48:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:50 INFO - 'SHELL': '/bin/bash', 09:48:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.duzGqLguY5/Listeners', 09:48:50 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 09:48:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:50 INFO - 'USER': 'cltbld', 09:48:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:50 INFO - 'XPC_FLAGS': '0x0', 09:48:50 INFO - 'XPC_SERVICE_NAME': '0', 09:48:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:50 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)) 09:48:50 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)) 09:48:50 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)) 09:48:50 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)) 09:48:50 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)) 09:48:50 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)) 09:48:50 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)) 09:48:50 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)) 09:48:50 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)) 09:48:50 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)) 09:48:50 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)) 09:48:50 INFO - Cleaning up... 09:48:50 INFO - Return code: 0 09:48:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:48: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')]} 09:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48: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')]} 09:48:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1078dab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078dd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb61594bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076b8d30>, '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 0x1075dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1076adbe8>, '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.5AP92DAZrl/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.duzGqLguY5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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 09:48: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', 'jsonschema'] in /builds/slave/test/build 09:48: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 jsonschema 09:48:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AP92DAZrl/Render', 09:48:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:50 INFO - 'HOME': '/Users/cltbld', 09:48:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:50 INFO - 'LOGNAME': 'cltbld', 09:48:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:50 INFO - 'MOZ_NO_REMOTE': '1', 09:48:50 INFO - 'NO_EM_RESTART': '1', 09:48:50 INFO - 'PAGER': '/bin/cat', 09:48:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:50 INFO - 'PWD': '/builds/slave/test', 09:48:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:50 INFO - 'SHELL': '/bin/bash', 09:48:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.duzGqLguY5/Listeners', 09:48:50 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 09:48:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:50 INFO - 'USER': 'cltbld', 09:48:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:50 INFO - 'XPC_FLAGS': '0x0', 09:48:50 INFO - 'XPC_SERVICE_NAME': '0', 09:48:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:48:50 INFO - Cleaning up... 09:48:50 INFO - Return code: 0 09:48:50 INFO - Running post-action listener: _resource_record_post_action 09:48:50 INFO - Running post-action listener: _start_resource_monitoring 09:48:50 INFO - Starting resource monitoring. 09:48:50 INFO - [mozharness: 2017-01-19 17:48:50.656749Z] Finished create-virtualenv step (success) 09:48:50 INFO - [mozharness: 2017-01-19 17:48:50.657767Z] Running install step. 09:48:50 INFO - Running pre-action listener: _resource_record_pre_action 09:48:50 INFO - Running main action method: install 09:48:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:48:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:48:50 INFO - Reading from file tmpfile_stdout 09:48:50 INFO - Detecting whether we're running mozinstall >=1.0... 09:48:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:48:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:48:51 INFO - Reading from file tmpfile_stdout 09:48:51 INFO - Output received: 09:48:51 INFO - Usage: mozinstall [options] installer 09:48:51 INFO - Options: 09:48:51 INFO - -h, --help show this help message and exit 09:48:51 INFO - -d DEST, --destination=DEST 09:48:51 INFO - Directory to install application into. [default: 09:48:51 INFO - "/builds/slave/test"] 09:48:51 INFO - --app=APP Application being installed. [default: firefox] 09:48:51 INFO - mkdir: /builds/slave/test/build/application 09:48:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:49:12 INFO - Reading from file tmpfile_stdout 09:49:12 INFO - Output received: 09:49:12 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:49:12 INFO - Running post-action listener: _resource_record_post_action 09:49:12 INFO - [mozharness: 2017-01-19 17:49:12.636780Z] Finished install step (success) 09:49:12 INFO - [mozharness: 2017-01-19 17:49:12.636912Z] Running run-tests step. 09:49:12 INFO - Running pre-action listener: _resource_record_pre_action 09:49:12 INFO - Running main action method: run_tests 09:49:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:49:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:49:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:49:12 INFO - 2017-01-19 09:49:12.650 screenresolution[1634:7802] starting screenresolution argv=screenresolution get 09:49:12 INFO - 2017-01-19 09:49:12.652 screenresolution[1634:7802] Display 0: 1600x1200x32@60 09:49:12 INFO - 2017-01-19 09:49:12.657 screenresolution[1635:7804] starting screenresolution argv=screenresolution list 09:49:12 INFO - Available Modes on Display 0 09:49:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:49:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:49:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:49:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:49:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:49:12 INFO - Intel Iris: 09:49:12 INFO - Chipset Model: Intel Iris 09:49:12 INFO - Type: GPU 09:49:12 INFO - Bus: Built-In 09:49:12 INFO - VRAM (Dynamic, Max): 1536 MB 09:49:12 INFO - Vendor: Intel (0x8086) 09:49:12 INFO - Device ID: 0x0a2e 09:49:12 INFO - Revision ID: 0x0009 09:49:12 INFO - Displays: 09:49:12 INFO - Display: 09:49:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:49:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:49:12 INFO - Display Serial Number: 1600x1200 60 09:49:12 INFO - Main Display: Yes 09:49:12 INFO - Mirror: Off 09:49:12 INFO - Online: Yes 09:49:12 INFO - Rotation: Supported 09:49:12 INFO - Return code: 0 09:49:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:49:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:49:12 INFO - Python 2.7.3 09:49:12 INFO - Return code: 0 09:49:12 INFO - grabbing minidump binary from tooltool 09:49: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')]} 09:49:12 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 0x1076b8d30>, '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 0x1075dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1076adbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:49:12 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 09:49:12 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 09:49:12 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 09:49:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:49:13 INFO - Return code: 0 09:49:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:49:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:49:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:49:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:49:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:49:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MY-MybImRrCEhLBRgkpbpg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0118', '--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 09:49:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MY-MybImRrCEhLBRgkpbpg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0118 --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 09:49:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5AP92DAZrl/Render', 09:49:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:13 INFO - 'HOME': '/Users/cltbld', 09:49:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:13 INFO - 'LOGNAME': 'cltbld', 09:49:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:49:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:49:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:13 INFO - 'MOZ_NO_REMOTE': '1', 09:49:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:49:13 INFO - 'NO_EM_RESTART': '1', 09:49:13 INFO - 'PAGER': '/bin/cat', 09:49:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:13 INFO - 'PWD': '/builds/slave/test', 09:49:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:49:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:13 INFO - 'SHELL': '/bin/bash', 09:49:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.duzGqLguY5/Listeners', 09:49:13 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 09:49:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:13 INFO - 'USER': 'cltbld', 09:49:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:13 INFO - 'XPC_FLAGS': '0x0', 09:49:13 INFO - 'XPC_SERVICE_NAME': '0', 09:49:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MY-MybImRrCEhLBRgkpbpg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0118', '--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 09:49:13 INFO - mozversion application_buildid: 20170119081728 09:49:13 INFO - mozversion application_changeset: b55c1f67df7bf76c3e5e6b57f82eb5786f112168 09:49:13 INFO - mozversion application_display_name: Nightly 09:49:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:49:13 INFO - mozversion application_name: Firefox 09:49:13 INFO - mozversion application_remotingname: firefox 09:49:13 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 09:49:13 INFO - mozversion application_vendor: Mozilla 09:49:13 INFO - mozversion application_version: 53.0a1 09:49:13 INFO - mozversion platform_buildid: 20170119081728 09:49:13 INFO - mozversion platform_changeset: b55c1f67df7bf76c3e5e6b57f82eb5786f112168 09:49:13 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 09:49:13 INFO - mozversion platform_version: 53.0a1 09:49:13 INFO - using testdate: 1484848153 09:49:13 INFO - actual date: 1484848153 09:49:13 INFO - starting webserver on 'localhost:49241' 09:49:13 INFO - SUITE-START | Running 2 tests 09:49:13 INFO - TEST-START | dromaeo_css 09:49:13 INFO - operating with platform_type : mac_ 09:49:13 INFO - Initialising browser for dromaeo_css test... 09:49:13 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/tmpLNuR3S/profile http://localhost:49241/getInfo.html) 09:49:15 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 09:49:15 INFO - PROCESS | 1645 | colorDepth:24 09:49:15 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 09:49:15 INFO - PROCESS | 1645 | __metrics 09:49:15 INFO - PROCESS | 1645 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:49:15 INFO - PROCESS | 1645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:49:16 INFO - TEST-INFO | 1645: exit 0 09:49:16 INFO - Browser initialized. 09:49:16 INFO - Running cycle 1/1 for dromaeo_css test... 09:49:16 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/tmpLNuR3S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:49:28 INFO - PROCESS | 1647 | RSS: Main: 235401216 09:49:28 INFO - PROCESS | 1647 | 09:52:32 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 09:52:34 INFO - PROCESS | 1647 | RSS: Main: 393388032 09:52:34 INFO - PROCESS | 1647 | 09:54:17 INFO - PROCESS | 1647 | ************************* 09:54:17 INFO - PROCESS | 1647 | A coding exception was thrown and uncaught in a Task. 09:54:17 INFO - PROCESS | 1647 | 09:54:17 ERROR - PROCESS | 1647 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:54:17 INFO - PROCESS | 1647 | Full stack: 09:54:17 INFO - PROCESS | 1647 | ************************* 09:55:37 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 09:55:37 INFO - PROCESS | 1647 | RSS: Main: 367333376 09:55:37 INFO - PROCESS | 1647 | 09:58:40 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 09:58:40 INFO - PROCESS | 1647 | RSS: Main: 363413504 09:58:40 INFO - PROCESS | 1647 | 10:01:43 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 10:01:43 INFO - PROCESS | 1647 | RSS: Main: 329347072 10:01:43 INFO - PROCESS | 1647 | 10:04:47 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 10:04:48 INFO - PROCESS | 1647 | RSS: Main: 327897088 10:04:48 INFO - PROCESS | 1647 | 10:07:51 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 10:07:52 INFO - PROCESS | 1647 | RSS: Main: 406491136 10:07:52 INFO - PROCESS | 1647 | 10:07:52 INFO - PROCESS | 1647 | __start_tp_report 10:07:52 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 10:07:52 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 10:07:52 INFO - PROCESS | 1647 | |i|pagename|runs| 10:07:52 INFO - PROCESS | 1647 | |0;dojo.html;3338.5492958450604;3342.398368293706;3359.781614195077;3366.4781958796393;3401.183715908183;5656.462636049569;5696.430356964302;5730.025895597748;5735.1970724098655;5778.942210577893;5688.744006519706;5689.943100568993;5754.424557544244;5771.076627739562;5799.159121927329;5151.45909679482;5172.431032586432;5179.611529135311;5222.791088356461;5289.074411977907;5320.068987927117;5321.281626980347;5338.733063346836;5350.732463376835;5412.972935135338;5161;5282.445343238962;5283.815066472655;5292.047431462335;5330.1205301125465;5186.5332120109;5211.088059589594;5230.137027390476;5233.345831771028;5252.57979361654;5203.453637368059;5226.764795584208;5235.869103272411;5256.763445644955;5267.762950667229;5728.656280623134;5730.914036289459;5739.397363276879;5741.913871291892;5775.27809023872;6156.015037593964;6200.162977997958;6201.503879689659;6300.905486417708;6302.243730752293;5509.421510741355;6317.968410157966;6351.555391122623;6358.1416508771645;6360.840978975516;5871.2073870027425;5878.823635290991;5886.1465087562065;5895.970520147414;5899.938011157947;6242;6247.04259166094;6260.906086408708;6322.209723784527;6357.300696923335;5314.707691077027;6100.005955098595;6165.537584681167;6172.722227499773;6248.156498872594;5161.4322424533275;6150.862090513269;6307.432331090132;6320.336364681642;6333.2716737575765;6150.7847225346895;6163.599366041193;6203.534734894811;6211.875762484725;6219.875602487925;6292.937070629327;6310.9368906311265;6319;6324.841878952971;6327.651979141099;4942.233953737176;4992.650514463952;5001.624878134155;5005.27423523587;5007.624428167829;4424.491183513937;4432.933505997413;4466.888327791831;4468.262736648417;4550.317452382169;4824.34871292371;5817.011108111631;5821.388754180834;5851.1515830205235;5871.2073870027;5689.800856969986;6338.112664227012;6346.555741098079;6368.872622547523;6385.744570217233;5635.1828984796975;5755.3381361143165;5795.478406943395;5831.562632802556;5847.883042339129;5458.099413596712;5469.507744303032;5487.780488780484;5494.230807686927;5515.145152501369;6315.527083281475;6356.650384228912;6359.841003974938;6373.553851230462;6386.584871983307;6259.499240060693;6309;6360.332165122781;6363.96818015907;6380.234371875405;6247.094171345038;6267.937320626917;6276.748930042747;6288.151099601679;6306.779262725782;6242.219722534684;6291.370862913672;6296.6851657417865;6299.055141728594;6299.937000629935;6110.755569777337;6281.654509001866;6295.276043254901;6316.494680425463;6337.8732425352155;5985.551083668829;6081.878362432638;6117.510599152146;6133.662648554194;6142.345304543789;6189.783357582463;6198.256209254918;6199.814005579839;6200.875982480235;6218.253809542703;5842.444967728059;5909.940900590939;6036.275646922221;6052.364501727256;6064.422620386406;6096.390360963868;6100.914243738686;6104.004449388181;6117.12715980571;6138.109974053827;6009.429104235091;6012.518998480198;6026.487748541423;6027.849303767441;6075.696215189135 10:07:52 INFO - PROCESS | 1647 | |1;ext.html;453.98638040858765;489.92705973917117;492.85953503251574;508.6795318949063;512.7410657617902;31551.21121971952;41053.17893642129;42797;42805.78597107014;43183;37594.62405375946;43221.56778432215;43991.56008439915;44504.55495445045;44619.77690111553;9299.907000929988;9503.524823758818;9514;9550.617975281015;9573.282003849705;8545.23092921637;8766.824663506726;11229.775404491906;11487.253328533661;11508.021818145426;11443.256188347772;11487.942560287187;11524.135689823297;11526.596569120082;11527;8567.057623661392;11428.371439570821;11509.654710358702;11517.539298428095;11577.421128943519;8547.444416112932;11069.667909962714;11372.658820235407;11374.14693897961;11567.76864462706;41300;41744.582554174674;42181.57818421807;42205.944851378656;42277.78861105675;4059.391091336294;4066.0648050948153;4066.146109317047;4073.5926407359325;4213.073123912734;30377.088687339194;30690.846545767352;31672.683273167433;31708.841455792804;31809;3148.763842711806;3291.0291464018173;3296.934061318784;3337.6161741399806;3337.766356355056;329074.9999999976;350947;351097;352140;354154;63210.36789632137;63436.36563634305;63643.4089147775;63670.0449493258;63736.68131659312;65504.67247663827;68206;68246.63506729838;68269.31730682729;68271;15830.76253856193;15854.60363490922;15980.76028859568;16463.012219266882;16469.505914822574;11408.486618102206;11786.58746943853;12649.177803442746;12684.985201184069;12729.55446559366;16071;17838.84047536906;18139.54651133732;18204.180811863498;18320.816791832178;5915.349311575723;7022.54353467023;7086.50394472382;7109.466789990772;7132.572045677276;846.2468403121227;871.4466313890725;889.3241136736127;904.3624244907325;914.0356923445696;28801;29022.709772902424;30199.641016154324;30386.088417347513;31160.84419577933;1042;1069.5240617925103;1107.5735841701003;1118.8489553910117;1185.9800571508497;15350.385984560717;15883;15898.76151857723;16054.334989361243;16070.187717149685;570458;571729;573253;573900;574360;61807.38192618016;62104.689476552325;62113.378866211664;62348.688256558424;62580.68709656422;1416.2989320286524;1448.8840892728767;1456.90004046946;1462.5466105507326;1463.8316593591874;23223.419414514774;27527;27644.308892277855;28643.705973812444;31217.219569510944;53261.34233220847;53466.11872694078;53682.73158634182;53692.19461708156;53746.46253537414;513493;513805;515096;515256;515571;22460.66309005399;24850.627240591042;25268.747312527375;25466.236012919642;41449.37825932553;35511.82244088763;43733.56266437295;43948.780256098515;44173.11653766842;44306.77846610746;34212.31575368528;34463.483047753805;36305.45541816822;37513.624863751014;37533.81233093817;35575.64424355723;35790;36098.27803443864;36969.44545831761;37064.44403333898;28139.859300704185;35485.46771798374;35634.46548301829;36191.457128142574;36304.63695363118;29873.551896721132;31743;31825;32001.519977199896;32589.837050814593;23233.76766232316;24017.194411816577;24134.87932560326;24518.264452066465;24522.264332070066 10:07:52 INFO - PROCESS | 1647 | |2;jquery.html;381.83771896943796;384.50590990577115;390.6952576989945;391.2351353104681;418.9099343641117;13528.391222394992;19601.313954011614;20268.493287667814;20835.687464688042;20869.37391878246;15729.820263480227;16920.546520754484;18907.905460472677;20832.895835520838;21244.787552124475;5587.552995760349;5799.971000144993;5852.209951656536;5855.121731740231;5859.267591551056;5583.664980101207;5744.16709577111;5789.565782566303;5804.216430781833;5866.44268794466;5663.688497132656;5678.119891416816;5683.658980461165;5778.913316300259;5789.565782566303;5069.847904562869;5504.422035686235;5507.642003269794;5758.856028599298;5775.075987841946;4991.625628077909;5052.014857102867;5060.089183946888;5061.898762024739;5067.822626208065;19089.522761930923;24315.02739890402;24362.390940226458;24727.25818225438;24855.751442485525;2692.8384296942245;2761.1854502921688;2763.1296141715297;2766.529689952713;2772.542530482488;15081.170535620537;15403.845961540464;15404;15474.613134671723;16136.435224767078;1758.604314029346;1825.9360922367787;1829.2682926829375;1832.9633407331778;1843;108847.46915185114;116779;117272;130842.34578827045;131158.3442082793;11684.941575292069;11690.240134391408;11693.298402095732;11828.408579570987;11850.101451226228;15359.61600959985;15395.46115885961;15409.075455472708;15409.922950385177;15433.228338583025;7656;7982.600869956479;7995;8395.832083358298;8613.181747733955;8045.718399855977;8312.8337433251;8415.621297041647;8417.410781245255;8527;4387.14450682114;4502.5141703238505;4648.1865673507;4654.488006319302;4720.976395118002;1794.9282028718967;1990.5819777846525;2002.1980217804094;2003.4390370696228;2012.5471768852185;850.3154960257052;998.8901220865699;1011.6206422591529;1019.4749703902496;1063.9413783285527;17261.39585114515;20993.127577158564;21033.36899893006;21052.894735526224;21153.576928461345;1032.896710328961;1034.6689059500889;1074.2104553153426;1074.414444127952;1076.8761592416972;10188.388696678223;10996.0653344465;10998.12015038795;11024.889751102386;11071.889281107247;706617;713013.4349328324;713156;715897.9896909785;740139.7818283589;110657.1270005546;130763.34618327038;137394;144416;155636;979.6718099436627;982.4792859784326;1000.4947501511836;1004.7287232447198;1006.5872992073362;13916.58250252494;18127.00301483431;18130.728039079688;18450.81549184491;18516.0741962904;48581.514184859116;60725.39274607197;60981;61219.693901530205;62341;83913;88110;89438.10561894558;89489;90074.54962725144;7757.301842834172;8008.27925486709;8203.908003459079;8276;8276.172382761675;12373.505059797508;12402.81395779082;12764.74470510566;12780.360981951051;12983.480660773463;10698.572057117628;11185.944070279596;11288.98399144081;11356.716082097682;11419.486123124314;8514.829703405774;10578.994995475417;10840.132789376989;10976.902309768959;11196.94401527987;11036.779264414827;11176.16178786578;11226.270292430965;11324.547018119183;11366.886331136582;7899.368050555827;8055.355571554144;8094.231048050426;8103.108658047728;8356.665733370597;8226.876596850932;10288.691339259834;10719.196060295664;11117.16621253393;11135.888641113484 10:07:52 INFO - PROCESS | 1647 | |3;mootools.html;1382.9308534573272;1430.1705011093566;1464.0191071981772;1464.465470103412;1476.1659662290806;7925.445218834684;8331.333493320535;8364.12176721444;8377.204165604258;8388.664453421863;7388.593627350494;7635.618219089051;7640.7325743598985;7965.800854978628;8174.9781277340335;2280.2589158523506;2314.2941402872116;2316.664083707861;2318.675385446039;2322.8954697038675;2281.6007198740235;2315.7452680205165;2327.0691723310642;2329.219711396684;2333.183385814968;2030.289398710447;2109.4620871677703;2234.754177040524;2275.101334972685;2308.35366097493;1890.9432717018512;2250.24616753387;2264.535770167112;2264.7169103862016;2267.7958983691547;2237.44063984004;2299.9310020699404;2299.988500057489;2300.378897697612;2309.364924645719;8228.094909559944;8301.46040507365;8305.750827475185;8312.916870831275;8323.12607176244;5012.548870601663;5182.222666600002;5188.11801993662;5196.558292545138;5200.635955483118;3351.7821341612716;3501.1772233525103;3527.224010717638;3585.982070089633;3587.8206089695673;1158.7161145519317;1211.1642966353277;1216.4221994552606;1265.1966001588964;1266.3858028855998;10709.839352409721;10836;10860.294080884718;10868.836967445495;10878.347299161996;3616.674499295076;4576.748278844696;4655.767211639404;4664.626829853603;4680.227762419231;9408.529573521297;9412.152906238334;9413.670521531714;9418.481983490974;9428.952855235817;5196.870078247998;5211.2443695663915;5223.895522089537;5224.529792318634;5226.97386513065;4252.87241382759;4399.230408820372;4423.712458690175;4677.812887484531;4753.120672675566;3180.8568614412407;3680.742348035612;3749.456328832304;3808.7143464240294;3835.1562656215588;1259.420666493405;1260.5840072776145;1266.4237771813803;1276.5340650662627;1278.2202856257675;898.9775255618662;912.8174365127002;915.6840889893109;936.8851067229974;942.2038377570941;5566.916496252559;5585.162225666182;5741.511971482387;5791.739371728282;5926.111083337534;922.1976880114344;934.9766255843522;965.1120968708805;984.5667906121283;992.6128809764198;3059.709327613873;3111.5954925859946;3311;3582.140286331262;3884.553276373253;9495.287853411022;9698.272629552812;9733.02669733021;9967.700968970943;10090.899091009143;9862.852057219148;9980.600775969026;9992.00079991995;10003.899961000297;10030.247731420026;7505.136909255505;7649.464537482434;7735.922640773632;7802.960985195038;7823.804404889924;5472.343318801769;5531.751071201886;5533.087040638249;5621.634593751393;5646.736713781069;9060.818783624423;9110.498922559058;9119.817603648022;9239.491827949527;9387.10822471864;9213.907860921574;9374.203192728422;9401.153896149379;9503.524823758922;9508.524573771421;5477.507024367826;6311.305756366704;6491.707873145625;6497.837554061186;6850.486213533905;7660.119086304923;7961.681532738626;7969.920300796918;8048.87926681112;8062.55655938929;7035;7105.32499412555;7161.892571611325;7213.495055346285;7301.561906285639;6814.625195614289;6975.320013343395;7028.051213086373;7097.148342198762;7157.355837974607;6303.05454181858;6342.809715708536;6420.101185834081;6427.678616069272;6449.516286278642;4906.828261010847;4963.950360496348;5007.048660754445;5007.84976450707;5056.140456122542;4194.559571245098;4729.385179926588;4908.969116485578;5169;5190.688558686491 10:07:52 INFO - PROCESS | 1647 | |4;prototype.html;342.86970951038603;355.3142435100256;366.98532058717643;369.136221242293;374.5393166405323;5299.576033917282;5331.200319952004;5340.946590534093;5359.204666436739;5371.985505435462;3924.607539246074;4532.229520981433;5252.973735131329;5264.684118952866;5338.757721756861;3495.1999720144017;3628.8548458061646;3969.9007524811823;4024.25551273014;4179.958200418003;3986.9601303987024;4146.564610715876;4149.605787450188;4183.477065366829;4210.915781684364;4058.6753059755297;4153.501579810427;4156.91686166278;4174.269502837006;4175.538561503465;3396.9490457643155;3515.2442224921765;3631.8741190231112;4042.9595704042877;4173.39485774564;2927.4291513154944;3220.3076338587084;3262.8368581571062;3663.9633603664156;3678.926421471582;5140.691558506502;5147.639665223436;5148.845534633967;5169.81905633301;5206.76569554371;4264.850730224458;4503.414556107685;4716.599089077433;4725.314829349725;4759.785809638574;4609.654275929319;5393.9730301348245;5512.862178445531;5584.162375643646;5585.8603534911545;3043.269615292336;3062.7090426409454;3792.317382871082;3801.2777572261184;3824.6749026332795;4415.741513668589;4559.635229181657;4894.5105489451125;5087.465816089294;5787.392323806024;3397.286569820316;3466.6493550594346;3827.975899039727;3842.8462861485787;3877.5265399148707;3869.5163104611925;3888.8250028748776;3891.6497515223764;3896.3960586109197;3903.33643280643;4342.6742994275555;4521.299198624153;4552.248878934939;4558.931616025762;4572.565606267399;5588.888222235532;5595;5597.692126933058;5637.689927054052;5658.179563963202;1194.6714653470365;1235.975280494385;1245.6325384011739;1251.4055823483773;1264.6079715288106;686.9107016087877;733.4645708632621;802.2899733735686;864.5849992003748;871.2811930157645;4795.496472870368;4890.804367825247;4917.729524876167;4928.852134435972;4935.284383764334;4866.31871537985;4951.975240123848;5208.921866172011;5284.550813180846;5422.48486393792;4842.394700662418;4881.389826271716;4924.852254432372;4930.433000204951;4992.078049950723;2519.4961007798515;2600.4019075612714;2855.571664250379;2900.2894290898444;2903.462859370981;4925;5069.923951140736;5202.346803130431;5244.659097158673;5592.468715472105;4663.556962088596;5344.743985163484;5359.678419294854;5478.45215478449;5602.526433611106;4843.854684359475;5077.695338279715;5610.27066481363;5654.381196034459;5663.461971112738;5407.188921661782;5421.40364559906;5461.399246083007;5486.780528778804;5487.6981766003255;5364.865878353073;5415.5938304626525;5654.7842213924205;5723.02555618311;5757.136429535603;5621.020858944766;5821.883562328814;5827.397465696968;5894.911576326444;5985.7078606765235;3094.4894092474487;3531.947020794639;3928.9017774555864;4013.8795836124964;4163.875083747493;5033.546980771748;5273.945210957901;5309.761060752198;5721.570882183936;5722.5421966241765;5159.819406320761;5307;5369.812056578001;5544.556435485232;5612.7754889803955;5519.668819870821;5541.639793413416;5544.972275138599;5546;5570.6657600544095;5360.014293371338;5407.540359069523;5450.100733379107;5454.481824226692;5513.972430137824;5395.70323632204;5498.890022199614;5560.555155587463;5565.276514053147;5597.80407685729;4974.676646017997;5276.34045744282;5379.946200537945;5432.2123292123215;5452.26394436746 10:07:52 INFO - PROCESS | 1647 | |5;yui.html;718.8167017410559;735.0481126940612;772.0465225446573;820.4748960665175;820.6225136437237;13041.41313640886;13852.307384630778;14798.186099764509;15678.294476748546;15686.607834804136;12927;13269.800952985714;15340.46308379207;15976.760348594751;16115.91942040288;880.1286726141107;906.8685040669098;911.6262332443699;912.7489940266413;918.7703074231442;697.898804673322;720.0818955831331;891.242443922667;893.0622846011694;893.5710858787786;832.7085520067989;907.5734404829719;941.9591351556534;944.6457578408097;945.333539854401;925.8240934222476;929.6095639831287;930.1721467893581;930.8696782450462;933.3233405780823;698.1726653915076;698.2389195776577;698.3051863395903;698.3156506623486;698.3749544157951;15206.467773627981;15565.37738490459;15611.921940390339;15625.843741562552;15691.293891774898;14066.507672231422;14394.496192633207;14405.92797036008;14442.277886105758;14460.493882714054;11959.701007474796;11998.220115692453;12047.03623710101;12090.516379344816;12111.333876636781;3673.3938900081453;3732.757370770891;3732.8133593320226;3754.4743735877;3876.4379165021196;102533;105278.94721052768;105313;105379;106226;10202.285839991278;10593.894061059445;10918.235723499438;11201.43992800373;11211.215214934877;21536.246231381825;21914.342569722932;22243.555128897657;22326.665100023514;22792.2022729207;6561.3438656134;7705.679604375865;7721.613919304013;7983.281504664608;8069.193080691884;4332.761698106571;4347.130573885235;4423.181711383404;4439.334099884978;4530.320451932236;3616.9819150904605;3743.8502459901842;3748.83130259139;3754.511913451234;3761.285355782393;676.3811112831802;686.9622170780555;687.7867860963117;688.5042769206264;694.6318451220861;662.6587307536622;682.6996121706434;705.8306006558491;737.4137560639305;751.8383547537305;10062.446565438971;10275;10436.217283703752;10691;10721.83917241242;677.9830504237434;719.9712011519481;730.4558104212396;737.1117803047315;740.4927624577182;4970.204767237225;5016.54851063406;5056.241563765465;5089.3638295213095;5117.692938423706;100823;103848;105772;106784;107511.46244268885;57186;88551.55724221337;90139.43675350831;90181;92781;63457;63554.68222658857;71442.99999999897;71484.64257678678;72784.27215727775;9777.266704997295;9780.510974451392;9827.459489728133;9831.754206144618;9851.802963940825;36387.63612363948;45402.54597453983;45648.77175614101;46271.76864115658;49258.50741492539;61562.38437615566;62097.37902620916;62305;62321;62613.68693156505;12749.745005100032;13102.410391532214;13104.803427948778;13236.735265294832;13684.794728078889;14363.56909292723;14386.640333991734;14519.78220326717;15033.699326013637;15154;13544.255065971467;13844.930775346058;13898.791518127438;13914.373853176834;13962.371693273624;13550.661233469242;13706.109102908278;13970;14144;14291.142531448146;13419.530316439268;13751.931240343734;13933.372998215307;14015.299235038412;14177;9315;10197.847032294374;10591.364518128938;10607.363558186533;11214.55141794319;11152.275102118336;11247.437628118398;11425.257358271685;11687.590934317259;11688.532458701897 10:07:52 INFO - PROCESS | 1647 | __end_tp_report 10:07:52 INFO - PROCESS | 1647 | __start_cc_report 10:07:52 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,1755 10:07:52 INFO - PROCESS | 1647 | __end_cc_report 10:07:52 INFO - PROCESS | 1647 | __startTimestamp1484849272009__endTimestamp 10:07:52 INFO - PROCESS | 1647 | 10:07:52 INFO - PROCESS | 1647 | ------- Summary: start ------- 10:07:52 INFO - PROCESS | 1647 | Number of tests: 6 10:07:52 INFO - PROCESS | 1647 | 10:07:52 INFO - PROCESS | 1647 | [#0] dojo.html Cycles:165 Average:5773.09 Median:6009.43 stddev:646.09 (10.8%) stddev-sans-first:619.20 10:07:52 INFO - PROCESS | 1647 | Values: 3338.5 3342.4 3359.8 3366.5 3401.2 5656.5 5696.4 5730.0 5735.2 5778.9 5688.7 5689.9 5754.4 5771.1 5799.2 5151.5 5172.4 5179.6 5222.8 5289.1 5320.1 5321.3 5338.7 5350.7 5413.0 5161.0 5282.4 5283.8 5292.0 5330.1 5186.5 5211.1 5230.1 5233.3 5252.6 5203.5 5226.8 5235.9 5256.8 5267.8 5728.7 5730.9 5739.4 5741.9 5775.3 6156.0 6200.2 6201.5 6300.9 6302.2 5509.4 6318.0 6351.6 6358.1 6360.8 5871.2 5878.8 5886.1 5896.0 5899.9 6242.0 6247.0 6260.9 6322.2 6357.3 5314.7 6100.0 6165.5 6172.7 6248.2 5161.4 6150.9 6307.4 6320.3 6333.3 6150.8 6163.6 6203.5 6211.9 6219.9 6292.9 6310.9 6319.0 6324.8 6327.7 4942.2 4992.7 5001.6 5005.3 5007.6 4424.5 4432.9 4466.9 4468.3 4550.3 4824.3 5817.0 5821.4 5851.2 5871.2 5689.8 6338.1 6346.6 6368.9 6385.7 5635.2 5755.3 5795.5 5831.6 5847.9 5458.1 5469.5 5487.8 5494.2 5515.1 6315.5 6356.7 6359.8 6373.6 6386.6 6259.5 6309.0 6360.3 6364.0 6380.2 6247.1 6267.9 6276.7 6288.2 6306.8 6242.2 6291.4 6296.7 6299.1 6299.9 6110.8 6281.7 6295.3 6316.5 6337.9 5985.6 6081.9 6117.5 6133.7 6142.3 6189.8 6198.3 6199.8 6200.9 6218.3 5842.4 5909.9 6036.3 6052.4 6064.4 6096.4 6100.9 6104.0 6117.1 6138.1 6009.4 6012.5 6026.5 6027.8 6075.7 10:07:52 INFO - PROCESS | 1647 | 10:07:52 INFO - PROCESS | 1647 | [#1] ext.html Cycles:180 Average:62816.00 Median:35543.73 stddev:129949.90 (365.6%) stddev-sans-first:130230.09 10:07:52 INFO - PROCESS | 1647 | Values: 454.0 489.9 492.9 508.7 512.7 31551.2 41053.2 42797.0 42805.8 43183.0 37594.6 43221.6 43991.6 44504.6 44619.8 9299.9 9503.5 9514.0 9550.6 9573.3 8545.2 8766.8 11229.8 11487.3 11508.0 11443.3 11487.9 11524.1 11526.6 11527.0 8567.1 11428.4 11509.7 11517.5 11577.4 8547.4 11069.7 11372.7 11374.1 11567.8 41300.0 41744.6 42181.6 42205.9 42277.8 4059.4 4066.1 4066.1 4073.6 4213.1 30377.1 30690.8 31672.7 31708.8 31809.0 3148.8 3291.0 3296.9 3337.6 3337.8 329075.0 350947.0 351097.0 352140.0 354154.0 63210.4 63436.4 63643.4 63670.0 63736.7 65504.7 68206.0 68246.6 68269.3 68271.0 15830.8 15854.6 15980.8 16463.0 16469.5 11408.5 11786.6 12649.2 12685.0 12729.6 16071.0 17838.8 18139.5 18204.2 18320.8 5915.3 7022.5 7086.5 7109.5 7132.6 846.2 871.4 889.3 904.4 914.0 28801.0 29022.7 30199.6 30386.1 31160.8 1042.0 1069.5 1107.6 1118.8 1186.0 15350.4 15883.0 15898.8 16054.3 16070.2 570458.0 571729.0 573253.0 573900.0 574360.0 61807.4 62104.7 62113.4 62348.7 62580.7 1416.3 1448.9 1456.9 1462.5 1463.8 23223.4 27527.0 27644.3 28643.7 31217.2 53261.3 53466.1 53682.7 53692.2 53746.5 513493.0 513805.0 515096.0 515256.0 515571.0 22460.7 24850.6 25268.7 25466.2 41449.4 35511.8 43733.6 43948.8 44173.1 44306.8 34212.3 34463.5 36305.5 37513.6 37533.8 35575.6 35790.0 36098.3 36969.4 37064.4 28139.9 35485.5 35634.5 36191.5 36304.6 29873.6 31743.0 31825.0 32001.5 32589.8 23233.8 24017.2 24134.9 24518.3 24522.3 10:07:52 INFO - PROCESS | 1647 | 10:07:52 INFO - PROCESS | 1647 | [#2] jquery.html Cycles:180 Average:39022.34 Median:21013.25 stddev:119234.61 (567.4%) stddev-sans-first:119533.79 10:07:52 INFO - PROCESS | 1647 | Values: 381.8 384.5 390.7 391.2 418.9 13528.4 19601.3 20268.5 20835.7 20869.4 15729.8 16920.5 18907.9 20832.9 21244.8 5587.6 5800.0 5852.2 5855.1 5859.3 5583.7 5744.2 5789.6 5804.2 5866.4 5663.7 5678.1 5683.7 5778.9 5789.6 5069.8 5504.4 5507.6 5758.9 5775.1 4991.6 5052.0 5060.1 5061.9 5067.8 19089.5 24315.0 24362.4 24727.3 24855.8 2692.8 2761.2 2763.1 2766.5 2772.5 15081.2 15403.8 15404.0 15474.6 16136.4 1758.6 1825.9 1829.3 1833.0 1843.0 108847.5 116779.0 117272.0 130842.3 131158.3 11684.9 11690.2 11693.3 11828.4 11850.1 15359.6 15395.5 15409.1 15409.9 15433.2 7656.0 7982.6 7995.0 8395.8 8613.2 8045.7 8312.8 8415.6 8417.4 8527.0 4387.1 4502.5 4648.2 4654.5 4721.0 1794.9 1990.6 2002.2 2003.4 2012.5 850.3 998.9 1011.6 1019.5 1063.9 17261.4 20993.1 21033.4 21052.9 21153.6 1032.9 1034.7 1074.2 1074.4 1076.9 10188.4 10996.1 10998.1 11024.9 11071.9 706617.0 713013.4 713156.0 715898.0 740139.8 110657.1 130763.3 137394.0 144416.0 155636.0 979.7 982.5 1000.5 1004.7 1006.6 13916.6 18127.0 18130.7 18450.8 18516.1 48581.5 60725.4 60981.0 61219.7 62341.0 83913.0 88110.0 89438.1 89489.0 90074.5 7757.3 8008.3 8203.9 8276.0 8276.2 12373.5 12402.8 12764.7 12780.4 12983.5 10698.6 11185.9 11289.0 11356.7 11419.5 8514.8 10579.0 10840.1 10976.9 11196.9 11036.8 11176.2 11226.3 11324.5 11366.9 7899.4 8055.4 8094.2 8103.1 8356.7 8226.9 10288.7 10719.2 11117.2 11135.9 10:07:52 INFO - PROCESS | 1647 | 10:07:52 INFO - PROCESS | 1647 | [#3] mootools.html Cycles:180 Average:5376.64 Median:5224.21 stddev:2947.99 (56.4%) stddev-sans-first:2940.98 10:07:52 INFO - PROCESS | 1647 | Values: 1382.9 1430.2 1464.0 1464.5 1476.2 7925.4 8331.3 8364.1 8377.2 8388.7 7388.6 7635.6 7640.7 7965.8 8175.0 2280.3 2314.3 2316.7 2318.7 2322.9 2281.6 2315.7 2327.1 2329.2 2333.2 2030.3 2109.5 2234.8 2275.1 2308.4 1890.9 2250.2 2264.5 2264.7 2267.8 2237.4 2299.9 2300.0 2300.4 2309.4 8228.1 8301.5 8305.8 8312.9 8323.1 5012.5 5182.2 5188.1 5196.6 5200.6 3351.8 3501.2 3527.2 3586.0 3587.8 1158.7 1211.2 1216.4 1265.2 1266.4 10709.8 10836.0 10860.3 10868.8 10878.3 3616.7 4576.7 4655.8 4664.6 4680.2 9408.5 9412.2 9413.7 9418.5 9429.0 5196.9 5211.2 5223.9 5224.5 5227.0 4252.9 4399.2 4423.7 4677.8 4753.1 3180.9 3680.7 3749.5 3808.7 3835.2 1259.4 1260.6 1266.4 1276.5 1278.2 899.0 912.8 915.7 936.9 942.2 5566.9 5585.2 5741.5 5791.7 5926.1 922.2 935.0 965.1 984.6 992.6 3059.7 3111.6 3311.0 3582.1 3884.6 9495.3 9698.3 9733.0 9967.7 10090.9 9862.9 9980.6 9992.0 10003.9 10030.2 7505.1 7649.5 7735.9 7803.0 7823.8 5472.3 5531.8 5533.1 5621.6 5646.7 9060.8 9110.5 9119.8 9239.5 9387.1 9213.9 9374.2 9401.2 9503.5 9508.5 5477.5 6311.3 6491.7 6497.8 6850.5 7660.1 7961.7 7969.9 8048.9 8062.6 7035.0 7105.3 7161.9 7213.5 7301.6 6814.6 6975.3 7028.1 7097.1 7157.4 6303.1 6342.8 6420.1 6427.7 6449.5 4906.8 4964.0 5007.0 5007.8 5056.1 4194.6 4729.4 4909.0 5169.0 5190.7 10:07:52 INFO - PROCESS | 1647 | 10:07:52 INFO - PROCESS | 1647 | [#4] prototype.html Cycles:180 Average:4441.44 Median:4983.38 stddev:1364.18 (27.4%) stddev-sans-first:1332.87 10:07:52 INFO - PROCESS | 1647 | Values: 342.9 355.3 367.0 369.1 374.5 5299.6 5331.2 5340.9 5359.2 5372.0 3924.6 4532.2 5253.0 5264.7 5338.8 3495.2 3628.9 3969.9 4024.3 4180.0 3987.0 4146.6 4149.6 4183.5 4210.9 4058.7 4153.5 4156.9 4174.3 4175.5 3396.9 3515.2 3631.9 4043.0 4173.4 2927.4 3220.3 3262.8 3664.0 3678.9 5140.7 5147.6 5148.8 5169.8 5206.8 4264.9 4503.4 4716.6 4725.3 4759.8 4609.7 5394.0 5512.9 5584.2 5585.9 3043.3 3062.7 3792.3 3801.3 3824.7 4415.7 4559.6 4894.5 5087.5 5787.4 3397.3 3466.6 3828.0 3842.8 3877.5 3869.5 3888.8 3891.6 3896.4 3903.3 4342.7 4521.3 4552.2 4558.9 4572.6 5588.9 5595.0 5597.7 5637.7 5658.2 1194.7 1236.0 1245.6 1251.4 1264.6 686.9 733.5 802.3 864.6 871.3 4795.5 4890.8 4917.7 4928.9 4935.3 4866.3 4952.0 5208.9 5284.6 5422.5 4842.4 4881.4 4924.9 4930.4 4992.1 2519.5 2600.4 2855.6 2900.3 2903.5 4925.0 5069.9 5202.3 5244.7 5592.5 4663.6 5344.7 5359.7 5478.5 5602.5 4843.9 5077.7 5610.3 5654.4 5663.5 5407.2 5421.4 5461.4 5486.8 5487.7 5364.9 5415.6 5654.8 5723.0 5757.1 5621.0 5821.9 5827.4 5894.9 5985.7 3094.5 3531.9 3928.9 4013.9 4163.9 5033.5 5273.9 5309.8 5721.6 5722.5 5159.8 5307.0 5369.8 5544.6 5612.8 5519.7 5541.6 5545.0 5546.0 5570.7 5360.0 5407.5 5450.1 5454.5 5514.0 5395.7 5498.9 5560.6 5565.3 5597.8 4974.7 5276.3 5379.9 5432.2 5452.3 10:07:52 INFO - PROCESS | 1647 | 10:07:52 INFO - PROCESS | 1647 | [#5] yui.html Cycles:180 Average:19903.29 Median:3751.65 stddev:28334.67 (755.3%) stddev-sans-first:28377.53 10:07:52 INFO - PROCESS | 1647 | Values: 718.8 735.0 772.0 820.5 820.6 13041.4 13852.3 14798.2 15678.3 15686.6 12927.0 13269.8 15340.5 15976.8 16115.9 880.1 906.9 911.6 912.7 918.8 697.9 720.1 891.2 893.1 893.6 832.7 907.6 942.0 944.6 945.3 925.8 929.6 930.2 930.9 933.3 698.2 698.2 698.3 698.3 698.4 15206.5 15565.4 15611.9 15625.8 15691.3 14066.5 14394.5 14405.9 14442.3 14460.5 11959.7 11998.2 12047.0 12090.5 12111.3 3673.4 3732.8 3732.8 3754.5 3876.4 102533.0 105278.9 105313.0 105379.0 106226.0 10202.3 10593.9 10918.2 11201.4 11211.2 21536.2 21914.3 22243.6 22326.7 22792.2 6561.3 7705.7 7721.6 7983.3 8069.2 4332.8 4347.1 4423.2 4439.3 4530.3 3617.0 3743.9 3748.8 3754.5 3761.3 676.4 687.0 687.8 688.5 694.6 662.7 682.7 705.8 737.4 751.8 10062.4 10275.0 10436.2 10691.0 10721.8 678.0 720.0 730.5 737.1 740.5 4970.2 5016.5 5056.2 5089.4 5117.7 100823.0 103848.0 105772.0 106784.0 107511.5 57186.0 88551.6 90139.4 90181.0 92781.0 63457.0 63554.7 71443.0 71484.6 72784.3 9777.3 9780.5 9827.5 9831.8 9851.8 36387.6 45402.5 45648.8 46271.8 49258.5 61562.4 62097.4 62305.0 62321.0 62613.7 12749.7 13102.4 13104.8 13236.7 13684.8 14363.6 14386.6 14519.8 15033.7 15154.0 13544.3 13844.9 13898.8 13914.4 13962.4 13550.7 13706.1 13970.0 14144.0 14291.1 13419.5 13751.9 13933.4 14015.3 14177.0 9315.0 10197.8 10591.4 10607.4 11214.6 11152.3 11247.4 11425.3 11687.6 11688.5 10:07:52 INFO - PROCESS | 1647 | -------- Summary: end -------- 10:07:52 INFO - PROCESS | 1647 | 10:07:52 INFO - TEST-INFO | 1647: exit 0 10:07:52 INFO - TEST-OK | dromaeo_css | took 1119411ms 10:07:52 INFO - TEST-START | kraken 10:07:52 INFO - operating with platform_type : mac_ 10:07:52 INFO - Initialising browser for kraken test... 10:07:52 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/tmpTgK9qj/profile http://localhost:49241/getInfo.html) 10:07:54 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 10:07:54 INFO - PROCESS | 1652 | colorDepth:24 10:07:54 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 10:07:54 INFO - PROCESS | 1652 | __metrics 10:07:54 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:07:54 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:07:55 INFO - TEST-INFO | 1652: exit 0 10:07:55 INFO - Browser initialized. 10:07:55 INFO - Running cycle 1/1 for kraken test... 10:07:55 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/tmpTgK9qj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:08:07 INFO - PROCESS | 1653 | RSS: Main: 226701312 10:08:07 INFO - PROCESS | 1653 | 10:08:10 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 10:08:11 INFO - PROCESS | 1653 | RSS: Main: 286928896 10:08:11 INFO - PROCESS | 1653 | 10:08:13 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 10:08:14 INFO - PROCESS | 1653 | RSS: Main: 288800768 10:08:14 INFO - PROCESS | 1653 | 10:08:17 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 10:08:18 INFO - PROCESS | 1653 | RSS: Main: 381050880 10:08:18 INFO - PROCESS | 1653 | 10:08:20 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 10:08:21 INFO - PROCESS | 1653 | RSS: Main: 282177536 10:08:21 INFO - PROCESS | 1653 | 10:08:23 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:08:23 INFO - PROCESS | 1653 | RSS: Main: 285863936 10:08:23 INFO - PROCESS | 1653 | 10:08:26 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 10:08:27 INFO - PROCESS | 1653 | RSS: Main: 327004160 10:08:27 INFO - PROCESS | 1653 | 10:08:30 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 10:08:30 INFO - PROCESS | 1653 | RSS: Main: 328822784 10:08:30 INFO - PROCESS | 1653 | 10:08:33 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 10:08:34 INFO - PROCESS | 1653 | RSS: Main: 327909376 10:08:34 INFO - PROCESS | 1653 | 10:08:35 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:08:36 INFO - PROCESS | 1653 | RSS: Main: 303673344 10:08:36 INFO - PROCESS | 1653 | 10:08:38 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:08:38 INFO - PROCESS | 1653 | RSS: Main: 305799168 10:08:38 INFO - PROCESS | 1653 | 10:08:41 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:08:41 INFO - PROCESS | 1653 | RSS: Main: 307720192 10:08:41 INFO - PROCESS | 1653 | 10:08:44 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:08:45 INFO - PROCESS | 1653 | RSS: Main: 324194304 10:08:45 INFO - PROCESS | 1653 | 10:08:48 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:08:48 INFO - PROCESS | 1653 | RSS: Main: 318734336 10:08:48 INFO - PROCESS | 1653 | 10:08:50 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 10:08:50 INFO - PROCESS | 1653 | RSS: Main: 362741760 10:08:50 INFO - PROCESS | 1653 | 10:08:50 INFO - PROCESS | 1653 | __start_tp_report 10:08:50 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 10:08:50 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 10:08:50 INFO - PROCESS | 1653 | |i|pagename|runs| 10:08:50 INFO - PROCESS | 1653 | |0;ai-astar;111;113;113;113;113;113;113;113;113;112 10:08:50 INFO - PROCESS | 1653 | |1;audio-beat-detection;146;110;109;160;112;111;110;108;132;114 10:08:50 INFO - PROCESS | 1653 | |2;audio-dft;183;180;182;182;184;182;182;182;196;244 10:08:50 INFO - PROCESS | 1653 | |3;audio-fft;79;59;58;87;60;59;59;59;72;58 10:08:50 INFO - PROCESS | 1653 | |4;audio-oscillator;82;71;85;69;68;69;81;68;69;81 10:08:50 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;86;85;86;84;88;85;87;85;88;83 10:08:50 INFO - PROCESS | 1653 | |6;imaging-darkroom;95;96;97;97;95;110;162;127;97;97 10:08:50 INFO - PROCESS | 1653 | |7;imaging-desaturate;93;86;87;87;87;86;85;87;127;133 10:08:50 INFO - PROCESS | 1653 | |8;json-parse-financial;58;58;56;54;55;54;54;55;54;54 10:08:50 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;60;67;70;79;72;70;71;71;71;73 10:08:50 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;89;86;87;82;87;80;89;86;91;98 10:08:50 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;138;140;138;139;138;144;141;147;172;150 10:08:50 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;173;173;172;171;171;171;174;169;168;172 10:08:50 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;67;65;67;67;70;78;89;68;67;68 10:08:50 INFO - PROCESS | 1653 | __end_tp_report 10:08:50 INFO - PROCESS | 1653 | __start_cc_report 10:08:50 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1948 10:08:50 INFO - PROCESS | 1653 | __end_cc_report 10:08:50 INFO - PROCESS | 1653 | __startTimestamp1484849330914__endTimestamp 10:08:50 INFO - PROCESS | 1653 | 10:08:50 INFO - PROCESS | 1653 | ------- Summary: start ------- 10:08:50 INFO - PROCESS | 1653 | Number of tests: 14 10:08:50 INFO - PROCESS | 1653 | 10:08:50 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.00 stddev:0.67 (0.6%) stddev-sans-first:0.33 10:08:50 INFO - PROCESS | 1653 | Values: 111.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 112.0 10:08:50 INFO - PROCESS | 1653 | 10:08:50 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:121.20 Median:113.00 stddev:18.41 (16.3%) stddev-sans-first:17.21 10:08:50 INFO - PROCESS | 1653 | Values: 146.0 110.0 109.0 160.0 112.0 111.0 110.0 108.0 132.0 114.0 10:08:50 INFO - PROCESS | 1653 | 10:08:50 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:189.70 Median:182.50 stddev:19.60 (10.7%) stddev-sans-first:20.63 10:08:50 INFO - PROCESS | 1653 | Values: 183.0 180.0 182.0 182.0 184.0 182.0 182.0 182.0 196.0 244.0 10:08:50 INFO - PROCESS | 1653 | 10:08:50 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:65.00 Median:59.50 stddev:10.52 (17.7%) stddev-sans-first:9.86 10:08:50 INFO - PROCESS | 1653 | Values: 79.0 59.0 58.0 87.0 60.0 59.0 59.0 59.0 72.0 58.0 10:08:50 INFO - PROCESS | 1653 | 10:08:50 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:74.30 Median:76.00 stddev:6.98 (9.2%) stddev-sans-first:6.82 10:08:50 INFO - PROCESS | 1653 | Values: 82.0 71.0 85.0 69.0 68.0 69.0 81.0 68.0 69.0 81.0 10:08:50 INFO - PROCESS | 1653 | 10:08:50 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:85.70 Median:86.00 stddev:1.64 (1.9%) stddev-sans-first:1.73 10:08:50 INFO - PROCESS | 1653 | Values: 86.0 85.0 86.0 84.0 88.0 85.0 87.0 85.0 88.0 83.0 10:08:50 INFO - PROCESS | 1653 | 10:08:50 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:107.30 Median:96.50 stddev:21.71 (22.5%) stddev-sans-first:22.57 10:08:50 INFO - PROCESS | 1653 | Values: 95.0 96.0 97.0 97.0 95.0 110.0 162.0 127.0 97.0 97.0 10:08:50 INFO - PROCESS | 1653 | 10:08:50 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:87.00 stddev:18.21 (20.9%) stddev-sans-first:19.28 10:08:50 INFO - PROCESS | 1653 | Values: 93.0 86.0 87.0 87.0 87.0 86.0 85.0 87.0 127.0 133.0 10:08:50 INFO - PROCESS | 1653 | 10:08:50 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:1.62 (2.9%) stddev-sans-first:1.36 10:08:50 INFO - PROCESS | 1653 | Values: 58.0 58.0 56.0 54.0 55.0 54.0 54.0 55.0 54.0 54.0 10:08:50 INFO - PROCESS | 1653 | 10:08:50 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:71.00 stddev:4.77 (6.7%) stddev-sans-first:3.24 10:08:50 INFO - PROCESS | 1653 | Values: 60.0 67.0 70.0 79.0 72.0 70.0 71.0 71.0 71.0 73.0 10:08:50 INFO - PROCESS | 1653 | 10:08:50 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:88.00 stddev:4.93 (5.6%) stddev-sans-first:5.20 10:08:50 INFO - PROCESS | 1653 | Values: 89.0 86.0 87.0 82.0 87.0 80.0 89.0 86.0 91.0 98.0 10:08:50 INFO - PROCESS | 1653 | 10:08:50 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:144.70 Median:142.50 stddev:10.45 (7.3%) stddev-sans-first:10.79 10:08:50 INFO - PROCESS | 1653 | Values: 138.0 140.0 138.0 139.0 138.0 144.0 141.0 147.0 172.0 150.0 10:08:50 INFO - PROCESS | 1653 | 10:08:50 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:172.00 stddev:1.84 (1.1%) stddev-sans-first:1.86 10:08:50 INFO - PROCESS | 1653 | Values: 173.0 173.0 172.0 171.0 171.0 171.0 174.0 169.0 168.0 172.0 10:08:50 INFO - PROCESS | 1653 | 10:08:50 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:68.00 stddev:7.38 (10.9%) stddev-sans-first:7.71 10:08:50 INFO - PROCESS | 1653 | Values: 67.0 65.0 67.0 67.0 70.0 78.0 89.0 68.0 67.0 68.0 10:08:50 INFO - PROCESS | 1653 | -------- Summary: end -------- 10:08:50 INFO - PROCESS | 1653 | 10:08:51 INFO - TEST-INFO | 1653: exit 0 10:08:51 INFO - TEST-OK | kraken | took 59132ms 10:08:51 INFO - SUITE-END | took 1178s 10:08:52 INFO - Completed test suite (00:19:38) 10:08:52 INFO - javascript benchmark 10:08:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3338.5492958450604, 3342.398368293706, 3359.781614195077, 3366.4781958796393, 3401.183715908183, 5656.462636049569, 5696.430356964302, 5730.025895597748, 5735.1970724098655, 5778.942210577893, 5688.744006519706, 5689.943100568993, 5754.424557544244, 5771.076627739562, 5799.159121927329, 5151.45909679482, 5172.431032586432, 5179.611529135311, 5222.791088356461, 5289.074411977907, 5320.068987927117, 5321.281626980347, 5338.733063346836, 5350.732463376835, 5412.972935135338, 5161.0, 5282.445343238962, 5283.815066472655, 5292.047431462335, 5330.1205301125465, 5186.5332120109, 5211.088059589594, 5230.137027390476, 5233.345831771028, 5252.57979361654, 5203.453637368059, 5226.764795584208, 5235.869103272411, 5256.763445644955, 5267.762950667229, 5728.656280623134, 5730.914036289459, 5739.397363276879, 5741.913871291892, 5775.27809023872, 6156.015037593964, 6200.162977997958, 6201.503879689659, 6300.905486417708, 6302.243730752293, 5509.421510741355, 6317.968410157966, 6351.555391122623, 6358.1416508771645, 6360.840978975516, 5871.2073870027425, 5878.823635290991, 5886.1465087562065, 5895.970520147414, 5899.938011157947, 6242.0, 6247.04259166094, 6260.906086408708, 6322.209723784527, 6357.300696923335, 5314.707691077027, 6100.005955098595, 6165.537584681167, 6172.722227499773, 6248.156498872594, 5161.4322424533275, 6150.862090513269, 6307.432331090132, 6320.336364681642, 6333.2716737575765, 6150.7847225346895, 6163.599366041193, 6203.534734894811, 6211.875762484725, 6219.875602487925, 6292.937070629327, 6310.9368906311265, 6319.0, 6324.841878952971, 6327.651979141099, 4942.233953737176, 4992.650514463952, 5001.624878134155, 5005.27423523587, 5007.624428167829, 4424.491183513937, 4432.933505997413, 4466.888327791831, 4468.262736648417, 4550.317452382169, 4824.34871292371, 5817.011108111631, 5821.388754180834, 5851.1515830205235, 5871.2073870027, 5689.800856969986, 6338.112664227012, 6346.555741098079, 6368.872622547523, 6385.744570217233, 5635.1828984796975, 5755.3381361143165, 5795.478406943395, 5831.562632802556, 5847.883042339129, 5458.099413596712, 5469.507744303032, 5487.780488780484, 5494.230807686927, 5515.145152501369, 6315.527083281475, 6356.650384228912, 6359.841003974938, 6373.553851230462, 6386.584871983307, 6259.499240060693, 6309.0, 6360.332165122781, 6363.96818015907, 6380.234371875405, 6247.094171345038, 6267.937320626917, 6276.748930042747, 6288.151099601679, 6306.779262725782, 6242.219722534684, 6291.370862913672, 6296.6851657417865, 6299.055141728594, 6299.937000629935, 6110.755569777337, 6281.654509001866, 6295.276043254901, 6316.494680425463, 6337.8732425352155, 5985.551083668829, 6081.878362432638, 6117.510599152146, 6133.662648554194, 6142.345304543789, 6189.783357582463, 6198.256209254918, 6199.814005579839, 6200.875982480235, 6218.253809542703, 5842.444967728059, 5909.940900590939, 6036.275646922221, 6052.364501727256, 6064.422620386406, 6096.390360963868, 6100.914243738686, 6104.004449388181, 6117.12715980571, 6138.109974053827, 6009.429104235091, 6012.518998480198, 6026.487748541423, 6027.849303767441, 6075.696215189135], "value": 5732.179313626369, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [453.98638040858765, 489.92705973917117, 492.85953503251574, 508.6795318949063, 512.7410657617902, 31551.21121971952, 41053.17893642129, 42797.0, 42805.78597107014, 43183.0, 37594.62405375946, 43221.56778432215, 43991.56008439915, 44504.55495445045, 44619.77690111553, 9299.907000929988, 9503.524823758818, 9514.0, 9550.617975281015, 9573.282003849705, 8545.23092921637, 8766.824663506726, 11229.775404491906, 11487.253328533661, 11508.021818145426, 11443.256188347772, 11487.942560287187, 11524.135689823297, 11526.596569120082, 11527.0, 8567.057623661392, 11428.371439570821, 11509.654710358702, 11517.539298428095, 11577.421128943519, 8547.444416112932, 11069.667909962714, 11372.658820235407, 11374.14693897961, 11567.76864462706, 41300.0, 41744.582554174674, 42181.57818421807, 42205.944851378656, 42277.78861105675, 4059.391091336294, 4066.0648050948153, 4066.146109317047, 4073.5926407359325, 4213.073123912734, 30377.088687339194, 30690.846545767352, 31672.683273167433, 31708.841455792804, 31809.0, 3148.763842711806, 3291.0291464018173, 3296.934061318784, 3337.6161741399806, 3337.766356355056, 329074.9999999976, 350947.0, 351097.0, 352140.0, 354154.0, 63210.36789632137, 63436.36563634305, 63643.4089147775, 63670.0449493258, 63736.68131659312, 65504.67247663827, 68206.0, 68246.63506729838, 68269.31730682729, 68271.0, 15830.76253856193, 15854.60363490922, 15980.76028859568, 16463.012219266882, 16469.505914822574, 11408.486618102206, 11786.58746943853, 12649.177803442746, 12684.985201184069, 12729.55446559366, 16071.0, 17838.84047536906, 18139.54651133732, 18204.180811863498, 18320.816791832178, 5915.349311575723, 7022.54353467023, 7086.50394472382, 7109.466789990772, 7132.572045677276, 846.2468403121227, 871.4466313890725, 889.3241136736127, 904.3624244907325, 914.0356923445696, 28801.0, 29022.709772902424, 30199.641016154324, 30386.088417347513, 31160.84419577933, 1042.0, 1069.5240617925103, 1107.5735841701003, 1118.8489553910117, 1185.9800571508497, 15350.385984560717, 15883.0, 15898.76151857723, 16054.334989361243, 16070.187717149685, 570458.0, 571729.0, 573253.0, 573900.0, 574360.0, 61807.38192618016, 62104.689476552325, 62113.378866211664, 62348.688256558424, 62580.68709656422, 1416.2989320286524, 1448.8840892728767, 1456.90004046946, 1462.5466105507326, 1463.8316593591874, 23223.419414514774, 27527.0, 27644.308892277855, 28643.705973812444, 31217.219569510944, 53261.34233220847, 53466.11872694078, 53682.73158634182, 53692.19461708156, 53746.46253537414, 513493.0, 513805.0, 515096.0, 515256.0, 515571.0, 22460.66309005399, 24850.627240591042, 25268.747312527375, 25466.236012919642, 41449.37825932553, 35511.82244088763, 43733.56266437295, 43948.780256098515, 44173.11653766842, 44306.77846610746, 34212.31575368528, 34463.483047753805, 36305.45541816822, 37513.624863751014, 37533.81233093817, 35575.64424355723, 35790.0, 36098.27803443864, 36969.44545831761, 37064.44403333898, 28139.859300704185, 35485.46771798374, 35634.46548301829, 36191.457128142574, 36304.63695363118, 29873.551896721132, 31743.0, 31825.0, 32001.519977199896, 32589.837050814593, 23233.76766232316, 24017.194411816577, 24134.87932560326, 24518.264452066465, 24522.264332070066], "value": 19850.85296666756, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.83771896943796, 384.50590990577115, 390.6952576989945, 391.2351353104681, 418.9099343641117, 13528.391222394992, 19601.313954011614, 20268.493287667814, 20835.687464688042, 20869.37391878246, 15729.820263480227, 16920.546520754484, 18907.905460472677, 20832.895835520838, 21244.787552124475, 5587.552995760349, 5799.971000144993, 5852.209951656536, 5855.121731740231, 5859.267591551056, 5583.664980101207, 5744.16709577111, 5789.565782566303, 5804.216430781833, 5866.44268794466, 5663.688497132656, 5678.119891416816, 5683.658980461165, 5778.913316300259, 5789.565782566303, 5069.847904562869, 5504.422035686235, 5507.642003269794, 5758.856028599298, 5775.075987841946, 4991.625628077909, 5052.014857102867, 5060.089183946888, 5061.898762024739, 5067.822626208065, 19089.522761930923, 24315.02739890402, 24362.390940226458, 24727.25818225438, 24855.751442485525, 2692.8384296942245, 2761.1854502921688, 2763.1296141715297, 2766.529689952713, 2772.542530482488, 15081.170535620537, 15403.845961540464, 15404.0, 15474.613134671723, 16136.435224767078, 1758.604314029346, 1825.9360922367787, 1829.2682926829375, 1832.9633407331778, 1843.0, 108847.46915185114, 116779.0, 117272.0, 130842.34578827045, 131158.3442082793, 11684.941575292069, 11690.240134391408, 11693.298402095732, 11828.408579570987, 11850.101451226228, 15359.61600959985, 15395.46115885961, 15409.075455472708, 15409.922950385177, 15433.228338583025, 7656.0, 7982.600869956479, 7995.0, 8395.832083358298, 8613.181747733955, 8045.718399855977, 8312.8337433251, 8415.621297041647, 8417.410781245255, 8527.0, 4387.14450682114, 4502.5141703238505, 4648.1865673507, 4654.488006319302, 4720.976395118002, 1794.9282028718967, 1990.5819777846525, 2002.1980217804094, 2003.4390370696228, 2012.5471768852185, 850.3154960257052, 998.8901220865699, 1011.6206422591529, 1019.4749703902496, 1063.9413783285527, 17261.39585114515, 20993.127577158564, 21033.36899893006, 21052.894735526224, 21153.576928461345, 1032.896710328961, 1034.6689059500889, 1074.2104553153426, 1074.414444127952, 1076.8761592416972, 10188.388696678223, 10996.0653344465, 10998.12015038795, 11024.889751102386, 11071.889281107247, 706617.0, 713013.4349328324, 713156.0, 715897.9896909785, 740139.7818283589, 110657.1270005546, 130763.34618327038, 137394.0, 144416.0, 155636.0, 979.6718099436627, 982.4792859784326, 1000.4947501511836, 1004.7287232447198, 1006.5872992073362, 13916.58250252494, 18127.00301483431, 18130.728039079688, 18450.81549184491, 18516.0741962904, 48581.514184859116, 60725.39274607197, 60981.0, 61219.693901530205, 62341.0, 83913.0, 88110.0, 89438.10561894558, 89489.0, 90074.54962725144, 7757.301842834172, 8008.27925486709, 8203.908003459079, 8276.0, 8276.172382761675, 12373.505059797508, 12402.81395779082, 12764.74470510566, 12780.360981951051, 12983.480660773463, 10698.572057117628, 11185.944070279596, 11288.98399144081, 11356.716082097682, 11419.486123124314, 8514.829703405774, 10578.994995475417, 10840.132789376989, 10976.902309768959, 11196.94401527987, 11036.779264414827, 11176.16178786578, 11226.270292430965, 11324.547018119183, 11366.886331136582, 7899.368050555827, 8055.355571554144, 8094.231048050426, 8103.108658047728, 8356.665733370597, 8226.876596850932, 10288.691339259834, 10719.196060295664, 11117.16621253393, 11135.888641113484], "value": 9756.567349976163, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1382.9308534573272, 1430.1705011093566, 1464.0191071981772, 1464.465470103412, 1476.1659662290806, 7925.445218834684, 8331.333493320535, 8364.12176721444, 8377.204165604258, 8388.664453421863, 7388.593627350494, 7635.618219089051, 7640.7325743598985, 7965.800854978628, 8174.9781277340335, 2280.2589158523506, 2314.2941402872116, 2316.664083707861, 2318.675385446039, 2322.8954697038675, 2281.6007198740235, 2315.7452680205165, 2327.0691723310642, 2329.219711396684, 2333.183385814968, 2030.289398710447, 2109.4620871677703, 2234.754177040524, 2275.101334972685, 2308.35366097493, 1890.9432717018512, 2250.24616753387, 2264.535770167112, 2264.7169103862016, 2267.7958983691547, 2237.44063984004, 2299.9310020699404, 2299.988500057489, 2300.378897697612, 2309.364924645719, 8228.094909559944, 8301.46040507365, 8305.750827475185, 8312.916870831275, 8323.12607176244, 5012.548870601663, 5182.222666600002, 5188.11801993662, 5196.558292545138, 5200.635955483118, 3351.7821341612716, 3501.1772233525103, 3527.224010717638, 3585.982070089633, 3587.8206089695673, 1158.7161145519317, 1211.1642966353277, 1216.4221994552606, 1265.1966001588964, 1266.3858028855998, 10709.839352409721, 10836.0, 10860.294080884718, 10868.836967445495, 10878.347299161996, 3616.674499295076, 4576.748278844696, 4655.767211639404, 4664.626829853603, 4680.227762419231, 9408.529573521297, 9412.152906238334, 9413.670521531714, 9418.481983490974, 9428.952855235817, 5196.870078247998, 5211.2443695663915, 5223.895522089537, 5224.529792318634, 5226.97386513065, 4252.87241382759, 4399.230408820372, 4423.712458690175, 4677.812887484531, 4753.120672675566, 3180.8568614412407, 3680.742348035612, 3749.456328832304, 3808.7143464240294, 3835.1562656215588, 1259.420666493405, 1260.5840072776145, 1266.4237771813803, 1276.5340650662627, 1278.2202856257675, 898.9775255618662, 912.8174365127002, 915.6840889893109, 936.8851067229974, 942.2038377570941, 5566.916496252559, 5585.162225666182, 5741.511971482387, 5791.739371728282, 5926.111083337534, 922.1976880114344, 934.9766255843522, 965.1120968708805, 984.5667906121283, 992.6128809764198, 3059.709327613873, 3111.5954925859946, 3311.0, 3582.140286331262, 3884.553276373253, 9495.287853411022, 9698.272629552812, 9733.02669733021, 9967.700968970943, 10090.899091009143, 9862.852057219148, 9980.600775969026, 9992.00079991995, 10003.899961000297, 10030.247731420026, 7505.136909255505, 7649.464537482434, 7735.922640773632, 7802.960985195038, 7823.804404889924, 5472.343318801769, 5531.751071201886, 5533.087040638249, 5621.634593751393, 5646.736713781069, 9060.818783624423, 9110.498922559058, 9119.817603648022, 9239.491827949527, 9387.10822471864, 9213.907860921574, 9374.203192728422, 9401.153896149379, 9503.524823758922, 9508.524573771421, 5477.507024367826, 6311.305756366704, 6491.707873145625, 6497.837554061186, 6850.486213533905, 7660.119086304923, 7961.681532738626, 7969.920300796918, 8048.87926681112, 8062.55655938929, 7035.0, 7105.32499412555, 7161.892571611325, 7213.495055346285, 7301.561906285639, 6814.625195614289, 6975.320013343395, 7028.051213086373, 7097.148342198762, 7157.355837974607, 6303.05454181858, 6342.809715708536, 6420.101185834081, 6427.678616069272, 6449.516286278642, 4906.828261010847, 4963.950360496348, 5007.048660754445, 5007.84976450707, 5056.140456122542, 4194.559571245098, 4729.385179926588, 4908.969116485578, 5169.0, 5190.688558686491], "value": 4375.326391557467, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.86970951038603, 355.3142435100256, 366.98532058717643, 369.136221242293, 374.5393166405323, 5299.576033917282, 5331.200319952004, 5340.946590534093, 5359.204666436739, 5371.985505435462, 3924.607539246074, 4532.229520981433, 5252.973735131329, 5264.684118952866, 5338.757721756861, 3495.1999720144017, 3628.8548458061646, 3969.9007524811823, 4024.25551273014, 4179.958200418003, 3986.9601303987024, 4146.564610715876, 4149.605787450188, 4183.477065366829, 4210.915781684364, 4058.6753059755297, 4153.501579810427, 4156.91686166278, 4174.269502837006, 4175.538561503465, 3396.9490457643155, 3515.2442224921765, 3631.8741190231112, 4042.9595704042877, 4173.39485774564, 2927.4291513154944, 3220.3076338587084, 3262.8368581571062, 3663.9633603664156, 3678.926421471582, 5140.691558506502, 5147.639665223436, 5148.845534633967, 5169.81905633301, 5206.76569554371, 4264.850730224458, 4503.414556107685, 4716.599089077433, 4725.314829349725, 4759.785809638574, 4609.654275929319, 5393.9730301348245, 5512.862178445531, 5584.162375643646, 5585.8603534911545, 3043.269615292336, 3062.7090426409454, 3792.317382871082, 3801.2777572261184, 3824.6749026332795, 4415.741513668589, 4559.635229181657, 4894.5105489451125, 5087.465816089294, 5787.392323806024, 3397.286569820316, 3466.6493550594346, 3827.975899039727, 3842.8462861485787, 3877.5265399148707, 3869.5163104611925, 3888.8250028748776, 3891.6497515223764, 3896.3960586109197, 3903.33643280643, 4342.6742994275555, 4521.299198624153, 4552.248878934939, 4558.931616025762, 4572.565606267399, 5588.888222235532, 5595.0, 5597.692126933058, 5637.689927054052, 5658.179563963202, 1194.6714653470365, 1235.975280494385, 1245.6325384011739, 1251.4055823483773, 1264.6079715288106, 686.9107016087877, 733.4645708632621, 802.2899733735686, 864.5849992003748, 871.2811930157645, 4795.496472870368, 4890.804367825247, 4917.729524876167, 4928.852134435972, 4935.284383764334, 4866.31871537985, 4951.975240123848, 5208.921866172011, 5284.550813180846, 5422.48486393792, 4842.394700662418, 4881.389826271716, 4924.852254432372, 4930.433000204951, 4992.078049950723, 2519.4961007798515, 2600.4019075612714, 2855.571664250379, 2900.2894290898444, 2903.462859370981, 4925.0, 5069.923951140736, 5202.346803130431, 5244.659097158673, 5592.468715472105, 4663.556962088596, 5344.743985163484, 5359.678419294854, 5478.45215478449, 5602.526433611106, 4843.854684359475, 5077.695338279715, 5610.27066481363, 5654.381196034459, 5663.461971112738, 5407.188921661782, 5421.40364559906, 5461.399246083007, 5486.780528778804, 5487.6981766003255, 5364.865878353073, 5415.5938304626525, 5654.7842213924205, 5723.02555618311, 5757.136429535603, 5621.020858944766, 5821.883562328814, 5827.397465696968, 5894.911576326444, 5985.7078606765235, 3094.4894092474487, 3531.947020794639, 3928.9017774555864, 4013.8795836124964, 4163.875083747493, 5033.546980771748, 5273.945210957901, 5309.761060752198, 5721.570882183936, 5722.5421966241765, 5159.819406320761, 5307.0, 5369.812056578001, 5544.556435485232, 5612.7754889803955, 5519.668819870821, 5541.639793413416, 5544.972275138599, 5546.0, 5570.6657600544095, 5360.014293371338, 5407.540359069523, 5450.100733379107, 5454.481824226692, 5513.972430137824, 5395.70323632204, 5498.890022199614, 5560.555155587463, 5565.276514053147, 5597.80407685729, 4974.676646017997, 5276.34045744282, 5379.946200537945, 5432.2123292123215, 5452.26394436746], "value": 4012.7896188875247, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.8167017410559, 735.0481126940612, 772.0465225446573, 820.4748960665175, 820.6225136437237, 13041.41313640886, 13852.307384630778, 14798.186099764509, 15678.294476748546, 15686.607834804136, 12927.0, 13269.800952985714, 15340.46308379207, 15976.760348594751, 16115.91942040288, 880.1286726141107, 906.8685040669098, 911.6262332443699, 912.7489940266413, 918.7703074231442, 697.898804673322, 720.0818955831331, 891.242443922667, 893.0622846011694, 893.5710858787786, 832.7085520067989, 907.5734404829719, 941.9591351556534, 944.6457578408097, 945.333539854401, 925.8240934222476, 929.6095639831287, 930.1721467893581, 930.8696782450462, 933.3233405780823, 698.1726653915076, 698.2389195776577, 698.3051863395903, 698.3156506623486, 698.3749544157951, 15206.467773627981, 15565.37738490459, 15611.921940390339, 15625.843741562552, 15691.293891774898, 14066.507672231422, 14394.496192633207, 14405.92797036008, 14442.277886105758, 14460.493882714054, 11959.701007474796, 11998.220115692453, 12047.03623710101, 12090.516379344816, 12111.333876636781, 3673.3938900081453, 3732.757370770891, 3732.8133593320226, 3754.4743735877, 3876.4379165021196, 102533.0, 105278.94721052768, 105313.0, 105379.0, 106226.0, 10202.285839991278, 10593.894061059445, 10918.235723499438, 11201.43992800373, 11211.215214934877, 21536.246231381825, 21914.342569722932, 22243.555128897657, 22326.665100023514, 22792.2022729207, 6561.3438656134, 7705.679604375865, 7721.613919304013, 7983.281504664608, 8069.193080691884, 4332.761698106571, 4347.130573885235, 4423.181711383404, 4439.334099884978, 4530.320451932236, 3616.9819150904605, 3743.8502459901842, 3748.83130259139, 3754.511913451234, 3761.285355782393, 676.3811112831802, 686.9622170780555, 687.7867860963117, 688.5042769206264, 694.6318451220861, 662.6587307536622, 682.6996121706434, 705.8306006558491, 737.4137560639305, 751.8383547537305, 10062.446565438971, 10275.0, 10436.217283703752, 10691.0, 10721.83917241242, 677.9830504237434, 719.9712011519481, 730.4558104212396, 737.1117803047315, 740.4927624577182, 4970.204767237225, 5016.54851063406, 5056.241563765465, 5089.3638295213095, 5117.692938423706, 100823.0, 103848.0, 105772.0, 106784.0, 107511.46244268885, 57186.0, 88551.55724221337, 90139.43675350831, 90181.0, 92781.0, 63457.0, 63554.68222658857, 71442.99999999897, 71484.64257678678, 72784.27215727775, 9777.266704997295, 9780.510974451392, 9827.459489728133, 9831.754206144618, 9851.802963940825, 36387.63612363948, 45402.54597453983, 45648.77175614101, 46271.76864115658, 49258.50741492539, 61562.38437615566, 62097.37902620916, 62305.0, 62321.0, 62613.68693156505, 12749.745005100032, 13102.410391532214, 13104.803427948778, 13236.735265294832, 13684.794728078889, 14363.56909292723, 14386.640333991734, 14519.78220326717, 15033.699326013637, 15154.0, 13544.255065971467, 13844.930775346058, 13898.791518127438, 13914.373853176834, 13962.371693273624, 13550.661233469242, 13706.109102908278, 13970.0, 14144.0, 14291.142531448146, 13419.530316439268, 13751.931240343734, 13933.372998215307, 14015.299235038412, 14177.0, 9315.0, 10197.847032294374, 10591.364518128938, 10607.363558186533, 11214.55141794319, 11152.275102118336, 11247.437628118398, 11425.257358271685, 11687.590934317259, 11688.532458701897], "value": 7567.016853555156, "unit": "score"}], "name": "dromaeo_css", "value": 7268.938811336765, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 112.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 110.0, 109.0, 160.0, 112.0, 111.0, 110.0, 108.0, 132.0, 114.0], "value": 121.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 180.0, 182.0, 182.0, 184.0, 182.0, 182.0, 182.0, 196.0, 244.0], "value": 189.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 58.0, 87.0, 60.0, 59.0, 59.0, 59.0, 72.0, 58.0], "value": 65.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 71.0, 85.0, 69.0, 68.0, 69.0, 81.0, 68.0, 69.0, 81.0], "value": 74.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 84.0, 88.0, 85.0, 87.0, 85.0, 88.0, 83.0], "value": 85.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 97.0, 95.0, 110.0, 162.0, 127.0, 97.0, 97.0], "value": 107.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 86.0, 87.0, 87.0, 87.0, 86.0, 85.0, 87.0, 127.0, 133.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 56.0, 54.0, 55.0, 54.0, 54.0, 55.0, 54.0, 54.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 67.0, 70.0, 79.0, 72.0, 70.0, 71.0, 71.0, 71.0, 73.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 87.0, 82.0, 87.0, 80.0, 89.0, 86.0, 91.0, 98.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 140.0, 138.0, 139.0, 138.0, 144.0, 141.0, 147.0, 172.0, 150.0], "value": 144.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 173.0, 172.0, 171.0, 171.0, 171.0, 174.0, 169.0, 168.0, 172.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 67.0, 67.0, 70.0, 78.0, 89.0, 68.0, 67.0, 68.0], "value": 70.6, "unit": "score"}], "name": "kraken", "value": 1451.5, "alertThreshold": 2.0}]} 10:08:52 INFO - Return code: 0 10:08:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:08:52 ERROR - # TBPL SUCCESS # 10:08:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:08:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:08:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:08:52 INFO - 2017-01-19 10:08:52.217 screenresolution[1657:10028] starting screenresolution argv=screenresolution get 10:08:52 INFO - 2017-01-19 10:08:52.219 screenresolution[1657:10028] Display 0: 1600x1200x32@60 10:08:52 INFO - 2017-01-19 10:08:52.225 screenresolution[1658:10032] starting screenresolution argv=screenresolution list 10:08:52 INFO - Available Modes on Display 0 10:08:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:08:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:08:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:08:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:08:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:08:52 INFO - Intel Iris: 10:08:52 INFO - Chipset Model: Intel Iris 10:08:52 INFO - Type: GPU 10:08:52 INFO - Bus: Built-In 10:08:52 INFO - VRAM (Dynamic, Max): 1536 MB 10:08:52 INFO - Vendor: Intel (0x8086) 10:08:52 INFO - Device ID: 0x0a2e 10:08:52 INFO - Revision ID: 0x0009 10:08:52 INFO - Displays: 10:08:52 INFO - Display: 10:08:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:08:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:08:52 INFO - Display Serial Number: 1600x1200 60 10:08:52 INFO - Main Display: Yes 10:08:52 INFO - Mirror: Off 10:08:52 INFO - Online: Yes 10:08:52 INFO - Rotation: Supported 10:08:52 INFO - Return code: 0 10:08:52 INFO - Running post-action listener: _resource_record_post_action 10:08:52 INFO - [mozharness: 2017-01-19 18:08:52.462442Z] Finished run-tests step (success) 10:08:52 INFO - Running post-run listener: _resource_record_post_run 10:08:52 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 35257344; Write bytes: 551073280; Read time: 327; Write time: 1641 10:08:52 INFO - TinderboxPrint: CPU usage
53.7% 10:08:52 INFO - TinderboxPrint: I/O read bytes / time
35,257,344 / 327 10:08:52 INFO - TinderboxPrint: I/O write bytes / time
551,073,280 / 1,641 10:08:52 INFO - TinderboxPrint: CPU idle
2,222.8 (46.3%) 10:08:52 INFO - TinderboxPrint: CPU system
961.6 (20.0%) 10:08:52 INFO - TinderboxPrint: CPU user
1,621.4 (33.7%) 10:08:52 INFO - TinderboxPrint: Swap in / out
279,470,080 / 0 10:08:52 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 228790784; Write bytes: 222035968; Read time: 16243; Write time: 405 10:08:52 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 33602560; Write bytes: 298821120; Read time: 305; Write time: 1179 10:08:52 INFO - Running post-run listener: _upload_blobber_files 10:08:52 INFO - Blob upload gear active. 10:08:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:08:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:08:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:08:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:08:53 INFO - (blobuploader) - INFO - Open directory for files ... 10:08:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:08:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:08:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:54 INFO - (blobuploader) - INFO - Done attempting. 10:08:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:08:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:08:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:55 INFO - (blobuploader) - INFO - Done attempting. 10:08:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:08:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:08:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:56 INFO - (blobuploader) - INFO - Done attempting. 10:08:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:08:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:08:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:59 INFO - (blobuploader) - INFO - Done attempting. 10:08:59 INFO - (blobuploader) - INFO - Iteration through files over. 10:08:59 INFO - Return code: 0 10:08:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:08:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:08:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5ce524f71672dd4a46b8fcbd5c7a743350846414b656e703e4b5cb839fdd562e8d6d5d9f94e33bbd42dfabae704f05238954b166ec4fb43a582e27b0d5c341b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/79b7172f84ed33aa24d5d6ab1e5a69b37b4e0740a77ad484e26b44723bad5fda4a763f0480bd85d936a743234cd2717c5bc505d59900b3434fb4e5f3e1b10dfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5ca0f5870915e22aeb4a43c3b66a807cd41614b17d32a46281e237d4880559e9abfe66e5bc61483993b86d7197b3ee35bbda689c491263dbc9ba8dc17c7523e0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/05f03db399cc5c326aa7380bef019b0931130d0e931931249c8af2139ab97486a474773931849927f9093df9824a7c6a6f0f086b05680c55e3e544e40c88bad0"} 10:08:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:08:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:08:59 INFO - Contents: 10:08:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5ce524f71672dd4a46b8fcbd5c7a743350846414b656e703e4b5cb839fdd562e8d6d5d9f94e33bbd42dfabae704f05238954b166ec4fb43a582e27b0d5c341b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/79b7172f84ed33aa24d5d6ab1e5a69b37b4e0740a77ad484e26b44723bad5fda4a763f0480bd85d936a743234cd2717c5bc505d59900b3434fb4e5f3e1b10dfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5ca0f5870915e22aeb4a43c3b66a807cd41614b17d32a46281e237d4880559e9abfe66e5bc61483993b86d7197b3ee35bbda689c491263dbc9ba8dc17c7523e0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/05f03db399cc5c326aa7380bef019b0931130d0e931931249c8af2139ab97486a474773931849927f9093df9824a7c6a6f0f086b05680c55e3e544e40c88bad0"} 10:08:59 INFO - Running post-run listener: copy_logs_to_upload_dir 10:08:59 INFO - Copying logs to upload dir... 10:08:59 INFO - mkdir: /builds/slave/test/build/upload/logs 10:08:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.449558 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-19 10:08:59.318244) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-19 10:08:59.321730) ========= 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.5AP92DAZrl/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.duzGqLguY5/Listeners TMPDIR=/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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/Graphics/sha512/5ce524f71672dd4a46b8fcbd5c7a743350846414b656e703e4b5cb839fdd562e8d6d5d9f94e33bbd42dfabae704f05238954b166ec4fb43a582e27b0d5c341b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/79b7172f84ed33aa24d5d6ab1e5a69b37b4e0740a77ad484e26b44723bad5fda4a763f0480bd85d936a743234cd2717c5bc505d59900b3434fb4e5f3e1b10dfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5ca0f5870915e22aeb4a43c3b66a807cd41614b17d32a46281e237d4880559e9abfe66e5bc61483993b86d7197b3ee35bbda689c491263dbc9ba8dc17c7523e0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/05f03db399cc5c326aa7380bef019b0931130d0e931931249c8af2139ab97486a474773931849927f9093df9824a7c6a6f0f086b05680c55e3e544e40c88bad0"} build_url:https://queue.taskcluster.net/v1/task/MY-MybImRrCEhLBRgkpbpg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011374 build_url: 'https://queue.taskcluster.net/v1/task/MY-MybImRrCEhLBRgkpbpg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5ce524f71672dd4a46b8fcbd5c7a743350846414b656e703e4b5cb839fdd562e8d6d5d9f94e33bbd42dfabae704f05238954b166ec4fb43a582e27b0d5c341b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/79b7172f84ed33aa24d5d6ab1e5a69b37b4e0740a77ad484e26b44723bad5fda4a763f0480bd85d936a743234cd2717c5bc505d59900b3434fb4e5f3e1b10dfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5ca0f5870915e22aeb4a43c3b66a807cd41614b17d32a46281e237d4880559e9abfe66e5bc61483993b86d7197b3ee35bbda689c491263dbc9ba8dc17c7523e0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/05f03db399cc5c326aa7380bef019b0931130d0e931931249c8af2139ab97486a474773931849927f9093df9824a7c6a6f0f086b05680c55e3e544e40c88bad0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-19 10:08:59.355761) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 10:08:59.356061) ========= 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.5AP92DAZrl/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.duzGqLguY5/Listeners TMPDIR=/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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.004574 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 10:08:59.404242) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-19 10:08:59.404585) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-19 10:08:59.405005) ========= ========= Total master_lag: 0.20 =========