builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0117 starttime: 1484333377.54 results: success (0) buildid: 20170113092130 builduid: fd0fcf31c4504f78b325f2758b387be1 revision: 6cdd4bd2998db6ff874ead4bd8889a04d47a5a0a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-13 10:49:37.540283) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-13 10:49:37.540690) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-13 10:49:37.540975) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-13 10:49:37.566930) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 10:49:37.567224) ========= 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.vZ7A5qJbZO/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.qvNpzu0jCc/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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-13 10:49:37-- 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% 64.2M=0s 2017-01-13 10:49:37 (64.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.390625 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 10:49:37.981961) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 10:49:37.982316) ========= 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.vZ7A5qJbZO/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.qvNpzu0jCc/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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.027768 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 10:49:38.031305) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-13 10:49:38.031691) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 6cdd4bd2998db6ff874ead4bd8889a04d47a5a0a --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 6cdd4bd2998db6ff874ead4bd8889a04d47a5a0a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vZ7A5qJbZO/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.qvNpzu0jCc/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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-13 10:49:38,125 truncating revision to first 12 chars 2017-01-13 10:49:38,125 Setting DEBUG logging. 2017-01-13 10:49:38,125 attempt 1/10 2017-01-13 10:49:38,125 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/6cdd4bd2998d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-13 10:49:39,775 unpacking tar archive at: graphics-6cdd4bd2998d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.919122 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-13 10:49:39.974445) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-13 10:49:39.974785) ========= script_repo_revision: 6cdd4bd2998db6ff874ead4bd8889a04d47a5a0a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-13 10:49:39.975161) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-13 10:49:39.975429) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-13 10:49:39.995172) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-13 10:49:39.995546) ========= /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.vZ7A5qJbZO/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.qvNpzu0jCc/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 10:49:40 INFO - MultiFileLogger online at 20170113 10:49:40 in /builds/slave/test 10:49:40 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 10:49:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:49:40 INFO - {'append_to_log': False, 10:49:40 INFO - 'base_work_dir': '/builds/slave/test', 10:49:40 INFO - 'blob_upload_branch': 'Graphics', 10:49:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:49:40 INFO - 'branch': 'Graphics', 10:49:40 INFO - 'buildbot_json_path': 'buildprops.json', 10:49:40 INFO - 'config_files': ('talos/mac_config.py',), 10:49:40 INFO - 'default_actions': ('clobber', 10:49:40 INFO - 'read-buildbot-config', 10:49:40 INFO - 'download-and-extract', 10:49:40 INFO - 'populate-webroot', 10:49:40 INFO - 'create-virtualenv', 10:49:40 INFO - 'install', 10:49:40 INFO - 'run-tests'), 10:49:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:49:40 INFO - 'download_minidump_stackwalk': True, 10:49:40 INFO - 'download_symbols': 'ondemand', 10:49:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:49:40 INFO - 'tooltool.py': '/tools/tooltool.py', 10:49:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:49:40 INFO - '/tools/misc-python/virtualenv.py')}, 10:49:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:49:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:49:40 INFO - 'installer_path': 'installer.exe', 10:49:40 INFO - 'log_level': 'info', 10:49:40 INFO - 'log_name': 'talos', 10:49:40 INFO - 'log_to_console': True, 10:49:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:49:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:49:40 INFO - 'opt_config_files': (), 10:49:40 INFO - 'pip_index': False, 10:49:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:49:40 INFO - 'cmd': ('bash', 10:49:40 INFO - '-c', 10:49:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:49:40 INFO - 'enabled': True, 10:49:40 INFO - 'halt_on_failure': False, 10:49:40 INFO - 'name': 'check_screen_resolution'},), 10:49:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:49:40 INFO - 'cmd': ('bash', 10:49:40 INFO - '-c', 10:49:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:49:40 INFO - 'enabled': True, 10:49:40 INFO - 'halt_on_failure': False, 10:49:40 INFO - 'name': 'check_screen_resolution'},), 10:49:40 INFO - 'run_cmd_checks_enabled': True, 10:49:40 INFO - 'sps_profile': False, 10:49:40 INFO - 'sps_profile_interval': 0, 10:49:40 INFO - 'suite': 'dromaeojs', 10:49:40 INFO - 'system_bits': '32', 10:49:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:49:40 INFO - 'title': 't-yosemite-r7-0117', 10:49:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:49:40 INFO - 'use_talos_json': True, 10:49:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:49:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:49:40 INFO - 'work_dir': 'build'} 10:49:40 INFO - [mozharness: 2017-01-13 18:49:40.201609Z] Running clobber step. 10:49:40 INFO - Running pre-action listener: _resource_record_pre_action 10:49:40 INFO - Running main action method: clobber 10:49:40 INFO - rmtree: /builds/slave/test/build 10:49:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:49:42 INFO - Running post-action listener: _resource_record_post_action 10:49:42 INFO - [mozharness: 2017-01-13 18:49:42.703440Z] Finished clobber step (success) 10:49:42 INFO - [mozharness: 2017-01-13 18:49:42.703614Z] Running read-buildbot-config step. 10:49:42 INFO - Running pre-action listener: _resource_record_pre_action 10:49:42 INFO - Running main action method: read_buildbot_config 10:49:42 INFO - Using buildbot properties: 10:49:42 INFO - { 10:49:42 INFO - "project": "", 10:49:42 INFO - "product": "firefox", 10:49:42 INFO - "script_repo_revision": "default", 10:49:42 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 10:49:42 INFO - "repository": "", 10:49:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 10:49:42 INFO - "buildid": "20170113092130", 10:49:42 INFO - "pgo_build": "False", 10:49:42 INFO - "basedir": "/builds/slave/test", 10:49:42 INFO - "buildnumber": 2, 10:49:42 INFO - "slavename": "t-yosemite-r7-0117", 10:49:42 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 10:49:42 INFO - "platform": "yosemite_r7", 10:49:42 INFO - "scheduler": "tests-graphics-macosx64-talos", 10:49:42 INFO - "branch": "graphics", 10:49:42 INFO - "repo_path": "projects/graphics", 10:49:42 INFO - "revision": "6cdd4bd2998db6ff874ead4bd8889a04d47a5a0a", 10:49:42 INFO - "stage_platform": "macosx64", 10:49:42 INFO - "builduid": "fd0fcf31c4504f78b325f2758b387be1", 10:49:42 INFO - "slavebuilddir": "test" 10:49:42 INFO - } 10:49:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 10:49:42 INFO - Running post-action listener: _resource_record_post_action 10:49:42 INFO - [mozharness: 2017-01-13 18:49:42.709224Z] Finished read-buildbot-config step (success) 10:49:42 INFO - [mozharness: 2017-01-13 18:49:42.709377Z] Running download-and-extract step. 10:49:42 INFO - Running pre-action listener: _resource_record_pre_action 10:49:42 INFO - Running main action method: download_and_extract 10:49:42 INFO - mkdir: /builds/slave/test/build/tests 10:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:49:42 INFO - trying https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 10:49:42 INFO - Downloading https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/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 10:49:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/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 10:49:43 INFO - Downloaded 1199 bytes. 10:49:43 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 10:49:43 INFO - Using the following test package requirements: 10:49:43 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 10:49:43 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 10:49:43 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 10:49:43 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 10:49:43 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 10:49:43 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 10:49:43 INFO - u'jsshell-mac.zip'], 10:49:43 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 10:49:43 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 10:49:43 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 10:49:43 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 10:49:43 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 10:49:43 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 10:49:43 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 10:49:43 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 10:49:43 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 10:49:43 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 10:49:43 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 10:49:43 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:49:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 10:49:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:49:43 INFO - Fetch https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 10:49:44 INFO - Expected file size: 16316854 10:49:44 INFO - Obtained file size: 16316854 10:49:51 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 10:49:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 10:49:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:49:51 INFO - Fetch https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 10:49:52 INFO - Expected file size: 16316854 10:49:52 INFO - Obtained file size: 16316854 10:49:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 10:49:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:49:58 INFO - Fetch https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 10:49:59 INFO - Expected file size: 14403555 10:49:59 INFO - Obtained file size: 14403555 10:49:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:49:59 INFO - trying https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 10:49:59 INFO - Downloading https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 10:49:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/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 10:50:01 INFO - Downloaded 70217479 bytes. 10:50:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 10:50:01 INFO - mkdir: /builds/slave/test/properties 10:50:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:50:01 INFO - Writing to file /builds/slave/test/properties/build_url 10:50:01 INFO - Contents: 10:50:01 INFO - build_url:https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 10:50:02 INFO - Running post-action listener: _resource_record_post_action 10:50:02 INFO - Running post-action listener: set_extra_try_arguments 10:50:02 INFO - [mozharness: 2017-01-13 18:50:02.509155Z] Finished download-and-extract step (success) 10:50:02 INFO - [mozharness: 2017-01-13 18:50:02.509294Z] Running populate-webroot step. 10:50:02 INFO - Running pre-action listener: _resource_record_pre_action 10:50:02 INFO - Running main action method: populate_webroot 10:50:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:50:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:50:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:50:02 INFO - '--tppagecycles', 10:50:02 INFO - '7'], 10:50:02 INFO - 'tests': ['tsvgm']}}, 10:50:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:50:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:50:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:50:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:50:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:50:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:50:02 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:50:02 INFO - 'talos_options': ['--disable-e10s'], 10:50:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:50:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:50:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:50:02 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:50:02 INFO - 'talos_options': ['--disable-e10s'], 10:50:02 INFO - 'tests': ['damp', 'tps']}, 10:50:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:50:02 INFO - 'tests': ['damp', 'tps']}, 10:50:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:50:02 INFO - 'tests': ['dromaeo_dom']}, 10:50:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:50:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:50:02 INFO - 'tests': ['basic_compositor_video']}, 10:50:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:50:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:50:02 INFO - 'tests': ['a11yr', 10:50:02 INFO - 'ts_paint', 10:50:02 INFO - 'tpaint', 10:50:02 INFO - 'sessionrestore', 10:50:02 INFO - 'sessionrestore_no_auto_restore', 10:50:02 INFO - 'tabpaint']}, 10:50:02 INFO - 'other-e10s': {'tests': ['a11yr', 10:50:02 INFO - 'ts_paint', 10:50:02 INFO - 'tpaint', 10:50:02 INFO - 'sessionrestore', 10:50:02 INFO - 'sessionrestore_no_auto_restore', 10:50:02 INFO - 'tabpaint']}, 10:50:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:50:02 INFO - 'ts_paint', 10:50:02 INFO - 'tpaint', 10:50:02 INFO - 'sessionrestore', 10:50:02 INFO - 'sessionrestore_no_auto_restore', 10:50:02 INFO - 'tabpaint']}, 10:50:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:50:02 INFO - 'ts_paint', 10:50:02 INFO - 'tpaint', 10:50:02 INFO - 'sessionrestore', 10:50:02 INFO - 'sessionrestore_no_auto_restore', 10:50:02 INFO - 'tabpaint']}, 10:50:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:50:02 INFO - 'tests': ['a11yr', 10:50:02 INFO - 'ts_paint', 10:50:02 INFO - 'tpaint', 10:50:02 INFO - 'sessionrestore', 10:50:02 INFO - 'sessionrestore_no_auto_restore', 10:50:02 INFO - 'tabpaint']}, 10:50:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:50:02 INFO - 'tests': ['a11yr', 10:50:02 INFO - 'ts_paint', 10:50:02 INFO - 'tpaint', 10:50:02 INFO - 'sessionrestore', 10:50:02 INFO - 'sessionrestore_no_auto_restore', 10:50:02 INFO - 'tabpaint']}, 10:50:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:50:02 INFO - 'tests': ['tsvgx', 10:50:02 INFO - 'tsvgr_opacity', 10:50:02 INFO - 'tart', 10:50:02 INFO - 'tscrollx', 10:50:02 INFO - 'cart', 10:50:02 INFO - 'tsvg_static']}, 10:50:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:50:02 INFO - 'tsvgr_opacity', 10:50:02 INFO - 'tart', 10:50:02 INFO - 'tscrollx', 10:50:02 INFO - 'cart', 10:50:02 INFO - 'tsvg_static']}, 10:50:02 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:50:02 INFO - 'talos_options': ['--disable-e10s'], 10:50:02 INFO - 'tests': ['tp5o']}, 10:50:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:50:02 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:50:02 INFO - 'talos_options': ['--disable-e10s', 10:50:02 INFO - '--xperf_path', 10:50:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:50:02 INFO - 'tests': ['tp5n']}, 10:50:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:50:02 INFO - 'talos_options': ['--xperf_path', 10:50:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:50:02 INFO - 'tests': ['tp5n']}}, 10:50:02 INFO - 'talos.zip': {'path': '', 10:50:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:50:02 INFO - Running post-action listener: _resource_record_post_action 10:50:02 INFO - [mozharness: 2017-01-13 18:50:02.527455Z] Finished populate-webroot step (success) 10:50:02 INFO - [mozharness: 2017-01-13 18:50:02.527588Z] Running create-virtualenv step. 10:50:02 INFO - Running pre-action listener: _resource_record_pre_action 10:50:02 INFO - Running main action method: create_virtualenv 10:50:02 INFO - Creating virtualenv /builds/slave/test/build/venv 10:50:02 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 10:50:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:50:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:50:02 INFO - Using real prefix '/tools/python27' 10:50:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:50:03 INFO - Installing distribute.............................................................................................................................................................................................done. 10:50:06 INFO - Installing pip.................done. 10:50:06 INFO - Return code: 0 10:50:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:50:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:50:06 INFO - Reading from file tmpfile_stdout 10:50:06 INFO - Output received: 10:50:06 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) 10:50:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101656b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101659768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd02946e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101434d30>, '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 0x10135bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101429be8>, '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.vZ7A5qJbZO/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.qvNpzu0jCc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 10:50:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:50:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:50:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vZ7A5qJbZO/Render', 10:50:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:06 INFO - 'HOME': '/Users/cltbld', 10:50:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:06 INFO - 'LOGNAME': 'cltbld', 10:50:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:06 INFO - 'MOZ_NO_REMOTE': '1', 10:50:06 INFO - 'NO_EM_RESTART': '1', 10:50:06 INFO - 'PAGER': '/bin/cat', 10:50:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:06 INFO - 'PWD': '/builds/slave/test', 10:50:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:06 INFO - 'SHELL': '/bin/bash', 10:50:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qvNpzu0jCc/Listeners', 10:50:06 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 10:50:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:06 INFO - 'USER': 'cltbld', 10:50:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:06 INFO - 'XPC_FLAGS': '0x0', 10:50:06 INFO - 'XPC_SERVICE_NAME': '0', 10:50:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:06 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 10:50:06 INFO - Cleaning up... 10:50:06 INFO - Return code: 0 10:50:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101656b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101659768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd02946e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101434d30>, '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 0x10135bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101429be8>, '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.vZ7A5qJbZO/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.qvNpzu0jCc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 10:50:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:50:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:50:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vZ7A5qJbZO/Render', 10:50:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:06 INFO - 'HOME': '/Users/cltbld', 10:50:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:06 INFO - 'LOGNAME': 'cltbld', 10:50:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:06 INFO - 'MOZ_NO_REMOTE': '1', 10:50:06 INFO - 'NO_EM_RESTART': '1', 10:50:06 INFO - 'PAGER': '/bin/cat', 10:50:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:06 INFO - 'PWD': '/builds/slave/test', 10:50:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:06 INFO - 'SHELL': '/bin/bash', 10:50:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qvNpzu0jCc/Listeners', 10:50:06 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 10:50:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:06 INFO - 'USER': 'cltbld', 10:50:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:06 INFO - 'XPC_FLAGS': '0x0', 10:50:06 INFO - 'XPC_SERVICE_NAME': '0', 10:50:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:07 INFO - Downloading/unpacking psutil>=3.1.1 10:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:50:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:50:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:50:10 INFO - Installing collected packages: psutil 10:50:10 INFO - Running setup.py install for psutil 10:50:10 INFO - building 'psutil._psutil_osx' extension 10:50:10 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 10:50:11 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 10:50:11 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 10:50:11 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 10:50:11 INFO - building 'psutil._psutil_posix' extension 10:50:11 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 10:50:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:50:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:50:11 INFO - ^ 10:50:11 INFO - 1 warning generated. 10:50:11 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 10:50:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:50:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:50:11 INFO - Successfully installed psutil 10:50:11 INFO - Cleaning up... 10:50:11 INFO - Return code: 0 10:50:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:11 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 0x101656b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101659768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd02946e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101434d30>, '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 0x10135bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101429be8>, '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.vZ7A5qJbZO/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.qvNpzu0jCc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 10:50:11 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 10:50:11 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 10:50:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vZ7A5qJbZO/Render', 10:50:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:11 INFO - 'HOME': '/Users/cltbld', 10:50:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:11 INFO - 'LOGNAME': 'cltbld', 10:50:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:11 INFO - 'MOZ_NO_REMOTE': '1', 10:50:11 INFO - 'NO_EM_RESTART': '1', 10:50:11 INFO - 'PAGER': '/bin/cat', 10:50:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:11 INFO - 'PWD': '/builds/slave/test', 10:50:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:11 INFO - 'SHELL': '/bin/bash', 10:50:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qvNpzu0jCc/Listeners', 10:50:11 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 10:50:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:11 INFO - 'USER': 'cltbld', 10:50:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:11 INFO - 'XPC_FLAGS': '0x0', 10:50:11 INFO - 'XPC_SERVICE_NAME': '0', 10:50:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:50:11 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 10:50:11 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 10:50:11 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 10:50:11 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 10:50:11 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 10:50:11 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 10:50:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:50:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:50:14 INFO - Installing collected packages: mozsystemmonitor 10:50:14 INFO - Running setup.py install for mozsystemmonitor 10:50:14 INFO - Successfully installed mozsystemmonitor 10:50:14 INFO - Cleaning up... 10:50:14 INFO - Return code: 0 10:50:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:50: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')]} 10:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50: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')]} 10:50:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101656b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101659768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd02946e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101434d30>, '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 0x10135bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101429be8>, '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.vZ7A5qJbZO/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.qvNpzu0jCc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 10:50:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:50:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:50:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vZ7A5qJbZO/Render', 10:50:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:14 INFO - 'HOME': '/Users/cltbld', 10:50:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:14 INFO - 'LOGNAME': 'cltbld', 10:50:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:14 INFO - 'MOZ_NO_REMOTE': '1', 10:50:14 INFO - 'NO_EM_RESTART': '1', 10:50:14 INFO - 'PAGER': '/bin/cat', 10:50:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:14 INFO - 'PWD': '/builds/slave/test', 10:50:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:14 INFO - 'SHELL': '/bin/bash', 10:50:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qvNpzu0jCc/Listeners', 10:50:14 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 10:50:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:14 INFO - 'USER': 'cltbld', 10:50:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:14 INFO - 'XPC_FLAGS': '0x0', 10:50:14 INFO - 'XPC_SERVICE_NAME': '0', 10:50:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:15 INFO - Downloading/unpacking jsonschema==2.5.1 10:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:50:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:50:17 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 10:50:17 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 10:50:17 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 10:50:17 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 10:50:17 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 10:50:17 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 10:50:18 INFO - Downloading functools32-3.2.3-2.tar.gz 10:50:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:50:18 INFO - warning: no files found matching '*.txt' 10:50:18 INFO - no previously-included directories found matching 'build' 10:50:18 INFO - no previously-included directories found matching 'dist' 10:50:18 INFO - no previously-included directories found matching '.git*' 10:50:18 INFO - Installing collected packages: jsonschema, functools32 10:50:18 INFO - Running setup.py install for functools32 10:50:18 INFO - warning: no files found matching '*.txt' 10:50:18 INFO - no previously-included directories found matching 'build' 10:50:18 INFO - no previously-included directories found matching 'dist' 10:50:18 INFO - no previously-included directories found matching '.git*' 10:50:18 INFO - Successfully installed jsonschema functools32 10:50:18 INFO - Cleaning up... 10:50:18 INFO - Return code: 0 10:50:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:50:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:18 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 0x101656b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101659768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd02946e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101434d30>, '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 0x10135bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101429be8>, '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.vZ7A5qJbZO/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.qvNpzu0jCc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 10:50:18 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 10:50:18 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 10:50:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vZ7A5qJbZO/Render', 10:50:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:18 INFO - 'HOME': '/Users/cltbld', 10:50:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:18 INFO - 'LOGNAME': 'cltbld', 10:50:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:18 INFO - 'MOZ_NO_REMOTE': '1', 10:50:18 INFO - 'NO_EM_RESTART': '1', 10:50:18 INFO - 'PAGER': '/bin/cat', 10:50:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:18 INFO - 'PWD': '/builds/slave/test', 10:50:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:18 INFO - 'SHELL': '/bin/bash', 10:50:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qvNpzu0jCc/Listeners', 10:50:18 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 10:50:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:18 INFO - 'USER': 'cltbld', 10:50:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:18 INFO - 'XPC_FLAGS': '0x0', 10:50:18 INFO - 'XPC_SERVICE_NAME': '0', 10:50:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:50:18 INFO - Cleaning up... 10:50:18 INFO - Return code: 0 10:50:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:50:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:18 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 0x101656b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101659768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd02946e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101434d30>, '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 0x10135bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101429be8>, '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.vZ7A5qJbZO/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.qvNpzu0jCc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 10:50:18 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 10:50:18 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 10:50:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vZ7A5qJbZO/Render', 10:50:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:18 INFO - 'HOME': '/Users/cltbld', 10:50:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:18 INFO - 'LOGNAME': 'cltbld', 10:50:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:18 INFO - 'MOZ_NO_REMOTE': '1', 10:50:18 INFO - 'NO_EM_RESTART': '1', 10:50:18 INFO - 'PAGER': '/bin/cat', 10:50:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:18 INFO - 'PWD': '/builds/slave/test', 10:50:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:18 INFO - 'SHELL': '/bin/bash', 10:50:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qvNpzu0jCc/Listeners', 10:50:18 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 10:50:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:18 INFO - 'USER': 'cltbld', 10:50:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:18 INFO - 'XPC_FLAGS': '0x0', 10:50:18 INFO - 'XPC_SERVICE_NAME': '0', 10:50:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:19 INFO - Downloading/unpacking blobuploader==1.2.4 10:50:19 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 10:50:19 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 10:50:19 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 10:50:19 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 10:50:19 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 10:50:19 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 10:50:21 INFO - Downloading blobuploader-1.2.4.tar.gz 10:50:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:50:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:50:21 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 10:50:21 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 10:50:21 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 10:50:21 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 10:50:21 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 10:50:21 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 10:50:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:50:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:50: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 10:50: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 10:50: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 10:50: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 10:50: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 10:50: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 10:50:23 INFO - Downloading docopt-0.6.1.tar.gz 10:50:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:50:23 INFO - Installing collected packages: blobuploader, requests, docopt 10:50:23 INFO - Running setup.py install for blobuploader 10:50:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:50:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:50:23 INFO - Running setup.py install for requests 10:50:23 INFO - Running setup.py install for docopt 10:50:23 INFO - Successfully installed blobuploader requests docopt 10:50:23 INFO - Cleaning up... 10:50:24 INFO - Return code: 0 10:50:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:50:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:24 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 0x101656b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101659768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd02946e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101434d30>, '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 0x10135bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101429be8>, '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.vZ7A5qJbZO/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.qvNpzu0jCc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 10:50:24 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 10:50:24 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 10:50:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vZ7A5qJbZO/Render', 10:50:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:24 INFO - 'HOME': '/Users/cltbld', 10:50:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:24 INFO - 'LOGNAME': 'cltbld', 10:50:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:24 INFO - 'MOZ_NO_REMOTE': '1', 10:50:24 INFO - 'NO_EM_RESTART': '1', 10:50:24 INFO - 'PAGER': '/bin/cat', 10:50:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:24 INFO - 'PWD': '/builds/slave/test', 10:50:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:24 INFO - 'SHELL': '/bin/bash', 10:50:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qvNpzu0jCc/Listeners', 10:50:24 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 10:50:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:24 INFO - 'USER': 'cltbld', 10:50:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:24 INFO - 'XPC_FLAGS': '0x0', 10:50:24 INFO - 'XPC_SERVICE_NAME': '0', 10:50:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:50:24 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-XR254U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:50:24 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-LSBn8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:50:24 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-6YE2Nb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:50:24 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-SEIb21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:50:24 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-j1MP06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:50:24 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-SfGBFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:50:24 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-E_bppb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:50:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:50:25 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-Mcmerg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:50:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:50:25 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-xZhHDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:50:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:50:25 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-3IAZQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:50:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:50:25 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-diQRc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:50:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:50:25 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-5ocZ0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:50:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:50:25 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-bgeNiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:50:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:50:25 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-n3IqvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:50:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:50:25 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-WGI1Ht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:50:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:50:25 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-37ylZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:50:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:50:25 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-WLj_iY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:50:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:50:26 INFO - Running setup.py install for manifestparser 10:50:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:50:26 INFO - Running setup.py install for mozcrash 10:50:26 INFO - Running setup.py install for mozdebug 10:50:26 INFO - Running setup.py install for mozdevice 10:50:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:50:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:50:26 INFO - Running setup.py install for mozfile 10:50:26 INFO - Running setup.py install for mozhttpd 10:50:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:50:26 INFO - Running setup.py install for mozinfo 10:50:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:50:27 INFO - Running setup.py install for mozInstall 10:50:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:50:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:50:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:50:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:50:27 INFO - Running setup.py install for mozleak 10:50:27 INFO - Running setup.py install for mozlog 10:50:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:50:27 INFO - Running setup.py install for moznetwork 10:50:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:50:27 INFO - Running setup.py install for mozprocess 10:50:27 INFO - Running setup.py install for mozprofile 10:50:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:50:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:50:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:50:28 INFO - Running setup.py install for mozrunner 10:50:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:50:28 INFO - Running setup.py install for mozscreenshot 10:50:28 INFO - Running setup.py install for moztest 10:50:28 INFO - Running setup.py install for mozversion 10:50:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:50:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:50:28 INFO - Cleaning up... 10:50:28 INFO - Return code: 0 10:50:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:50:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:28 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 0x101656b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101659768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd02946e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101434d30>, '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 0x10135bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101429be8>, '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.vZ7A5qJbZO/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.qvNpzu0jCc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 10:50:28 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 10:50:28 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 10:50:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vZ7A5qJbZO/Render', 10:50:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:28 INFO - 'HOME': '/Users/cltbld', 10:50:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:28 INFO - 'LOGNAME': 'cltbld', 10:50:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:28 INFO - 'MOZ_NO_REMOTE': '1', 10:50:28 INFO - 'NO_EM_RESTART': '1', 10:50:28 INFO - 'PAGER': '/bin/cat', 10:50:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:28 INFO - 'PWD': '/builds/slave/test', 10:50:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:28 INFO - 'SHELL': '/bin/bash', 10:50:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qvNpzu0jCc/Listeners', 10:50:28 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 10:50:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:28 INFO - 'USER': 'cltbld', 10:50:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:28 INFO - 'XPC_FLAGS': '0x0', 10:50:28 INFO - 'XPC_SERVICE_NAME': '0', 10:50:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:50:29 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-aZSFWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:50:29 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)) 10:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:50:29 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-Zj0SAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:50:29 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)) 10:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:50:29 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-XVwHMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:50:29 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)) 10:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:50:29 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-BbDHoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:50:29 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)) 10:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:50:29 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-6FryWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:50:29 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)) 10:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:50:29 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-UiBYp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:50:29 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)) 10:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:50:29 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-Yz6qlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:50:29 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)) 10:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:50:29 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-PLQuwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:50:29 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)) 10:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:50:29 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-FMXbaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:50:29 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)) 10:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:50:29 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-m_kawX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:50:30 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)) 10:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:50:30 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-6acIBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:50:30 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)) 10:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:50:30 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-65j1M_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:50:30 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)) 10:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:50:30 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-nXYjXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:50:30 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)) 10:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:50:30 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-PJIAqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:50:30 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)) 10:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:50:30 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-LD578H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:50:30 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)) 10:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:50:30 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-Civ13R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:50:30 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)) 10:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:50:30 INFO - Running setup.py (path:/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/pip-he9VeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:50:30 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)) 10:50:30 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)) 10:50:30 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)) 10:50:30 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)) 10:50:30 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)) 10:50:30 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)) 10:50:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:33 INFO - Downloading blessings-1.6.tar.gz 10:50:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:50:33 INFO - Installing collected packages: blessings 10:50:33 INFO - Running setup.py install for blessings 10:50:33 INFO - Successfully installed blessings 10:50:33 INFO - Cleaning up... 10:50:33 INFO - Return code: 0 10:50:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:50:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:50:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:50:34 INFO - Reading from file tmpfile_stdout 10:50:34 INFO - Current package versions: 10:50:34 INFO - blessings == 1.6 10:50:34 INFO - blobuploader == 1.2.4 10:50:34 INFO - docopt == 0.6.1 10:50:34 INFO - functools32 == 3.2.3-2 10:50:34 INFO - jsonschema == 2.5.1 10:50:34 INFO - manifestparser == 1.1 10:50:34 INFO - mozInstall == 1.12 10:50:34 INFO - mozcrash == 1.0 10:50:34 INFO - mozdebug == 0.1 10:50:34 INFO - mozdevice == 0.49 10:50:34 INFO - mozfile == 1.2 10:50:34 INFO - mozhttpd == 0.7 10:50:34 INFO - mozinfo == 0.9 10:50:34 INFO - mozleak == 0.1 10:50:34 INFO - mozlog == 3.4 10:50:34 INFO - moznetwork == 0.27 10:50:34 INFO - mozprocess == 0.24 10:50:34 INFO - mozprofile == 0.28 10:50:34 INFO - mozrunner == 6.13 10:50:34 INFO - mozscreenshot == 0.1 10:50:34 INFO - mozsystemmonitor == 0.3 10:50:34 INFO - moztest == 0.8 10:50:34 INFO - mozversion == 1.4 10:50:34 INFO - psutil == 3.1.1 10:50:34 INFO - requests == 1.2.3 10:50:34 INFO - wsgiref == 0.1.2 10:50:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:50: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')]} 10:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50: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')]} 10:50:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:34 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 0x101656b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101659768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd02946e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101434d30>, '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 0x10135bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101429be8>, '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.vZ7A5qJbZO/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.qvNpzu0jCc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 10:50:34 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 10:50:34 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 10:50:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vZ7A5qJbZO/Render', 10:50:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:34 INFO - 'HOME': '/Users/cltbld', 10:50:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:34 INFO - 'LOGNAME': 'cltbld', 10:50:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:34 INFO - 'MOZ_NO_REMOTE': '1', 10:50:34 INFO - 'NO_EM_RESTART': '1', 10:50:34 INFO - 'PAGER': '/bin/cat', 10:50:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:34 INFO - 'PWD': '/builds/slave/test', 10:50:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:34 INFO - 'SHELL': '/bin/bash', 10:50:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qvNpzu0jCc/Listeners', 10:50:34 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 10:50:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:34 INFO - 'USER': 'cltbld', 10:50:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:34 INFO - 'XPC_FLAGS': '0x0', 10:50:34 INFO - 'XPC_SERVICE_NAME': '0', 10:50:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:35 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)) 10:50:35 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)) 10:50:35 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)) 10:50:35 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)) 10:50:35 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)) 10:50:35 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)) 10:50:35 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)) 10:50:35 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)) 10:50:35 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)) 10:50:35 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)) 10:50:35 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)) 10:50:35 INFO - Cleaning up... 10:50:35 INFO - Return code: 0 10:50:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:50:35 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')]} 10:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:35 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')]} 10:50:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:35 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 0x101656b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101659768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd02946e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101434d30>, '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 0x10135bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101429be8>, '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.vZ7A5qJbZO/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.qvNpzu0jCc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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 10:50:35 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 10:50:35 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 10:50:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vZ7A5qJbZO/Render', 10:50:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:35 INFO - 'HOME': '/Users/cltbld', 10:50:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:35 INFO - 'LOGNAME': 'cltbld', 10:50:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:35 INFO - 'MOZ_NO_REMOTE': '1', 10:50:35 INFO - 'NO_EM_RESTART': '1', 10:50:35 INFO - 'PAGER': '/bin/cat', 10:50:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:35 INFO - 'PWD': '/builds/slave/test', 10:50:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:35 INFO - 'SHELL': '/bin/bash', 10:50:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qvNpzu0jCc/Listeners', 10:50:35 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 10:50:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:35 INFO - 'USER': 'cltbld', 10:50:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:35 INFO - 'XPC_FLAGS': '0x0', 10:50:35 INFO - 'XPC_SERVICE_NAME': '0', 10:50:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:50:35 INFO - Cleaning up... 10:50:35 INFO - Return code: 0 10:50:35 INFO - Running post-action listener: _resource_record_post_action 10:50:35 INFO - Running post-action listener: _start_resource_monitoring 10:50:35 INFO - Starting resource monitoring. 10:50:35 INFO - [mozharness: 2017-01-13 18:50:35.783788Z] Finished create-virtualenv step (success) 10:50:35 INFO - [mozharness: 2017-01-13 18:50:35.784738Z] Running install step. 10:50:35 INFO - Running pre-action listener: _resource_record_pre_action 10:50:35 INFO - Running main action method: install 10:50:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:50:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:50:36 INFO - Reading from file tmpfile_stdout 10:50:36 INFO - Detecting whether we're running mozinstall >=1.0... 10:50:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:50:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:50:36 INFO - Reading from file tmpfile_stdout 10:50:36 INFO - Output received: 10:50:36 INFO - Usage: mozinstall [options] installer 10:50:36 INFO - Options: 10:50:36 INFO - -h, --help show this help message and exit 10:50:36 INFO - -d DEST, --destination=DEST 10:50:36 INFO - Directory to install application into. [default: 10:50:36 INFO - "/builds/slave/test"] 10:50:36 INFO - --app=APP Application being installed. [default: firefox] 10:50:36 INFO - mkdir: /builds/slave/test/build/application 10:50:36 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'] 10:50:36 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 10:50:57 INFO - Reading from file tmpfile_stdout 10:50:57 INFO - Output received: 10:50:57 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:50:57 INFO - Running post-action listener: _resource_record_post_action 10:50:57 INFO - [mozharness: 2017-01-13 18:50:57.996497Z] Finished install step (success) 10:50:57 INFO - [mozharness: 2017-01-13 18:50:57.996627Z] Running run-tests step. 10:50:57 INFO - Running pre-action listener: _resource_record_pre_action 10:50:57 INFO - Running main action method: run_tests 10:50:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:50:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:50:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:50:58 INFO - 2017-01-13 10:50:58.011 screenresolution[1628:7385] starting screenresolution argv=screenresolution get 10:50:58 INFO - 2017-01-13 10:50:58.014 screenresolution[1628:7385] Display 0: 1600x1200x32@60 10:50:58 INFO - 2017-01-13 10:50:58.020 screenresolution[1629:7387] starting screenresolution argv=screenresolution list 10:50:58 INFO - Available Modes on Display 0 10:50:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:50:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:50:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:50:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:50:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:50:58 INFO - Intel Iris: 10:50:58 INFO - Chipset Model: Intel Iris 10:50:58 INFO - Type: GPU 10:50:58 INFO - Bus: Built-In 10:50:58 INFO - VRAM (Dynamic, Max): 1536 MB 10:50:58 INFO - Vendor: Intel (0x8086) 10:50:58 INFO - Device ID: 0x0a2e 10:50:58 INFO - Revision ID: 0x0009 10:50:58 INFO - Displays: 10:50:58 INFO - Display: 10:50:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:50:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:50:58 INFO - Display Serial Number: 1600x1200 60 10:50:58 INFO - Main Display: Yes 10:50:58 INFO - Mirror: Off 10:50:58 INFO - Online: Yes 10:50:58 INFO - Rotation: Supported 10:50:58 INFO - Return code: 0 10:50:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:50:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:50:58 INFO - Python 2.7.3 10:50:58 INFO - Return code: 0 10:50:58 INFO - grabbing minidump binary from tooltool 10:50:58 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')]} 10:50:58 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 0x101434d30>, '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 0x10135bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101429be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:50:58 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 10:50:58 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 10:50:58 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 10:50:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:50:58 INFO - Return code: 0 10:50:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:50:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:50:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:50:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:50:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:50:58 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/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0117', '--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 10:50:58 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/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0117 --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 10:50:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vZ7A5qJbZO/Render', 10:50:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:50:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:50:58 INFO - 'HOME': '/Users/cltbld', 10:50:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:50:58 INFO - 'LOGNAME': 'cltbld', 10:50:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:50:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:50:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:58 INFO - 'MOZ_NO_REMOTE': '1', 10:50:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:50:58 INFO - 'NO_EM_RESTART': '1', 10:50:58 INFO - 'PAGER': '/bin/cat', 10:50:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:50:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:58 INFO - 'PWD': '/builds/slave/test', 10:50:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:50:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:50:58 INFO - 'SHELL': '/bin/bash', 10:50:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qvNpzu0jCc/Listeners', 10:50:58 INFO - 'TMPDIR': '/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/', 10:50:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:50:58 INFO - 'USER': 'cltbld', 10:50:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:50:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:50:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:58 INFO - 'XPC_FLAGS': '0x0', 10:50:58 INFO - 'XPC_SERVICE_NAME': '0', 10:50:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:50:58 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/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0117', '--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 10:50:58 INFO - mozversion application_buildid: 20170113092130 10:50:58 INFO - mozversion application_changeset: 6cdd4bd2998db6ff874ead4bd8889a04d47a5a0a 10:50:58 INFO - mozversion application_display_name: Nightly 10:50:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:50:58 INFO - mozversion application_name: Firefox 10:50:58 INFO - mozversion application_remotingname: firefox 10:50:58 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 10:50:58 INFO - mozversion application_vendor: Mozilla 10:50:58 INFO - mozversion application_version: 53.0a1 10:50:58 INFO - mozversion platform_buildid: 20170113092130 10:50:58 INFO - mozversion platform_changeset: 6cdd4bd2998db6ff874ead4bd8889a04d47a5a0a 10:50:58 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 10:50:58 INFO - mozversion platform_version: 53.0a1 10:50:58 INFO - using testdate: 1484333458 10:50:58 INFO - actual date: 1484333458 10:50:58 INFO - starting webserver on 'localhost:49244' 10:50:58 INFO - SUITE-START | Running 2 tests 10:50:58 INFO - TEST-START | dromaeo_css 10:50:58 INFO - operating with platform_type : mac_ 10:50:58 INFO - Initialising browser for dromaeo_css test... 10:50:58 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/tmp1COLM9/profile http://localhost:49244/getInfo.html) 10:51:01 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 10:51:01 INFO - PROCESS | 1639 | colorDepth:24 10:51:01 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 10:51:01 INFO - PROCESS | 1639 | __metrics 10:51:01 INFO - PROCESS | 1639 | 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:51:01 INFO - PROCESS | 1639 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:51:01 INFO - TEST-INFO | 1639: exit 0 10:51:01 INFO - Browser initialized. 10:51:01 INFO - Running cycle 1/1 for dromaeo_css test... 10:51:01 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/tmp1COLM9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:51:13 INFO - PROCESS | 1641 | RSS: Main: 235311104 10:51:13 INFO - PROCESS | 1641 | 10:54:18 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 10:54:19 INFO - PROCESS | 1641 | RSS: Main: 330391552 10:54:19 INFO - PROCESS | 1641 | 10:56:03 INFO - PROCESS | 1641 | ************************* 10:56:03 INFO - PROCESS | 1641 | A coding exception was thrown and uncaught in a Task. 10:56:03 INFO - PROCESS | 1641 | 10:56:03 ERROR - PROCESS | 1641 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:56:03 INFO - PROCESS | 1641 | Full stack: 10:56:03 INFO - PROCESS | 1641 | ************************* 10:57:22 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 10:57:23 INFO - PROCESS | 1641 | RSS: Main: 368373760 10:57:23 INFO - PROCESS | 1641 | 11:00:25 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 11:00:25 INFO - PROCESS | 1641 | RSS: Main: 335773696 11:00:25 INFO - PROCESS | 1641 | 11:03:28 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 11:03:28 INFO - PROCESS | 1641 | RSS: Main: 348000256 11:03:28 INFO - PROCESS | 1641 | 11:06:32 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 11:06:33 INFO - PROCESS | 1641 | RSS: Main: 326426624 11:06:33 INFO - PROCESS | 1641 | 11:09:36 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 11:09:36 INFO - PROCESS | 1641 | RSS: Main: 428863488 11:09:36 INFO - PROCESS | 1641 | 11:09:36 INFO - PROCESS | 1641 | __start_tp_report 11:09:36 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 11:09:36 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 11:09:36 INFO - PROCESS | 1641 | |i|pagename|runs| 11:09:36 INFO - PROCESS | 1641 | |0;dojo.html;3155.3689262147573;3353.5305057291976;3353.564036675232;3378.1554611347165;3414.778039427437;5507.008738427082;5511.5039646431815;5638.605297629168;5688.175214593882;5712.8857422851515;4110.28070087735;4768.594669453092;5600.6079574429805;5606.831795046145;5698.316202055759;5072.365954255718;5136.820211292606;5157.5616072633875;5202.895942081156;5214.139666954967;5097.5667068299235;5132.717700526469;5194.013137503862;5235.633505654606;5245.842624721246;5226.216067589854;5254.2644029835665;5262.4474430184855;5276.182191760283;5296.867578310535;5079.23811428285;5109.667871588372;5124.205748109049;5127.359080114986;5225.216217567396;5138.075146473633;5228.215767634847;5228.529432351069;5238.764255608468;5248.422673505911;5623.465770751772;5630.183623374629;5649.378568357477;5674.886502269931;5693.089105743061;6173.475254603364;6197.194364732556;6203.689815509207;6205.379462053804;6212.285587157445;6101.633901965852;6106.855059071331;6150.2927163376335;6150.66171360575;6171.6297022178815;5700.945325114867;5711.314642242957;5712.485876271156;5714.428557144335;5758.683272420015;6130.325664176937;6246.875062498724;6252.062190671436;6267.749290028348;6284.214473190851;5050.696958182521;5997.430244126801;6027.60820546663;6049.727762250709;6063.181470501514;6141.192460674321;6156.29202641702;6158.568900176944;6177.2587289524645;6254.437100660963;5259.710715910585;5962.135490353874;6023.759049637965;6035.939640603626;6109.20580324555;5053.646244762831;6102.633841969496;6187.257529096447;6269.65516896566;6279.717412716439;5023.924641130386;5025.195968644999;5033.521815427529;5035.597152227813;5050.772715227824;4327.891802704958;4401.493828209796;4416.84541041062;4477.485089214717;4519.615832654261;5811.506021988093;5822.039363505059;5883.17635531026;5937.495312898365;5960.135780311831;6254.312025677172;6255.12428260044;6256.718447669866;6258.843528911813;6271.686415679198;5853.180554722342;5872.618279811799;5888;5891.793787217427;5905.4685078343155;5311.3095297611835;5313.07021271276;5350.27771250884;5402.216678581583;5426.9185962210595;6272.18461599989;6423.743050277936;6435.806925792233;6438.678066096582;6444.194475690539;6246.46905013079;6261.7182226799;6268.623882567061;6271.3728627136925;6284.214473190851;6211.192544969125;6345.143405640364;6418.19772528434;6426.164598602152;6426.228852537725;6075.088736689532;6124.991279909774;6141.271221159771;6171.506279497719;6250.249970003447;6240;6244.812655620339;6252.749890004531;6264.874702505833;6266.749330026748;6031.698415079316;6110.083487476736;6137.785177518944;6141.785037523665;6142.907856382247;5865.14955331466;5974.850628734316;6066.757329706762;6090.847728806815;6126.264848218242;5829.970850145722;5982.551308651781;5989.311229208697;6008.068749343859;6059.3637668045985;5826.970865145647;5891.3224979127945;5903.26209223847;5909.468147866541;5977.103434484862;4901.803927842846;5852.561057920588;5935.970320148372;5947.286325640951;5951.464368206882 11:09:36 INFO - PROCESS | 1641 | |1;ext.html;448.7599134463063;456.4864527406668;492.23703259947087;499.54382973631886;510.98211562595293;30629.693703062963;38853.22293554127;40769;40881.18237635245;42409.36385954213;34322;42350.7882460588;42531;42604.36093458601;42635.147297054114;8259.710910118147;9127.908720912772;9320.906790932071;9334.53327333634;9362.578683959238;8260.380471464634;10937.890621093806;11170.441477926111;11187.49656265466;11390.25963312382;11108.944455277713;11197.552097916074;11200.663980080612;11205.159613029015;11219.60731374402;8293.21214484623;11093.778124437506;11167.83248251277;11176.161787865862;11194.440277986108;8263.628136733862;10795.2443328967;11010.724731881686;11052.723681908017;11268.042216411615;39593;40034;40040.79979600113;40077.398839017435;40079.39880901789;4025.031437822422;4034.8587799427173;4058.2492238935893;4074.8777536673947;4079.877603671865;29852.55221171684;30161.944331948496;30327.545086823717;30949.0715278542;31084;3088.232356525036;3197.9360412791616;3200.3439294944483;3216.179874132105;3291.374638818617;456350;460406;461392.69303653267;461517;462773.68613157055;57589.424105759244;57989.42010579925;58005.70997144987;58079;58095;60509.39490605037;60734.78530429455;60736.69631651814;60842.391576084556;60885.391146087975;15333.616659583377;15820.683586328209;15822.841771582367;15842.207889605474;15850;10973.122150227962;11258.549658013588;12179.756404871852;12235.510579576718;12247.816282755766;13696.863031369758;14993.32530036151;15178;15226.771598426032;15406.768898466533;6363.840903977345;6870.20992585859;6879.628981798883;6925.6190909499455;6949.93050069503;874.3617159473492;876.785651872149;877.8946526416871;887.1040249348205;905.4612505559313;29590.11763059071;29690.960816371324;29778.55332170019;30241;30422.93519726799;971.1114330387758;1042.6924057403085;1044.1333693034915;1075.8224892892586;1174.448009435564;13711.451541938211;15393.153376564396;15476.613084672974;15711.21443927822;15744.134072625886;609099;610790;610885;610991;611668;51860.70348241324;54586;58051;58361.124583131284;58432.4156758427;1412.131539103444;1456.3592019511593;1457.4097490516358;1461.3204859740272;1464.1581090872578;27919.581206282328;28115.859420702767;28448.857755711088;29214.853925730236;29541.694366274554;49720;50185.74907125441;50187.49812501828;50345.74135646638;50439.74780126076;562524;567439;568002;568276;569859;21776.891115544953;22274.767794119067;24088.63867041961;24350.26949191527;24483;35422.46866296956;42751.358729618456;42843.143137137704;43880.122397552506;44557;25961.740382596687;32771.672283276865;33589.824356147416;35190.12024699403;36280.81859590685;35224.11939701528;35370.93887183389;35980.28039439144;36422.8178859104;36790.8160459196;34064.65935340714;34361.82819085888;35062.47406288959;35275.64724352724;35555.46666800052;26107;30226.84886575641;30452.543211851396;32271.031869043967;32528.83735581307;21462.678059829428;21599;23430.414239644146;23632.818359081633;24162 11:09:36 INFO - PROCESS | 1641 | |2;jquery.html;334.7797278918342;392.9980350098249;399.8843471741016;403.16745919675867;425.4320482156321;13540.932295338509;20134.295299664496;20521.384358469233;21445.356639300826;21468.463288417777;21037.68443473345;21195.788042119573;21231;21619.45951351217;21636.026378812952;5858.941410585893;6187.4431301182885;6189;6194.597351172182;6208.751649933997;5814.24414826072;5979.402059794029;6006.639601623895;6079.118527813464;6101.481374083208;5906.497947674431;6010.8797824043495;6019.759209631609;6022.488088512459;6036.275646922353;5760.567957403212;5964.314103878044;5997.070454079625;6012.96993515034;6027.306859711145;5258.789648414059;5264.92102618461;5270.446603106657;5275.683458992435;5284.180951952453;24704.876475617686;25548.744512554822;25595.488090238276;25631.615525767127;26046.609300860502;2347.6009078456705;2759.986200069007;2776.9444611107865;2778.2359851040924;2785.373291009527;15323.387064517407;15765.290561924741;15825.971311864692;16178.948368356138;16573.585660358465;1806.9909650451796;1816.2008716164846;1840.5766673665132;1854;1901.847852171823;125726.37136814257;127602;129078.3546082273;131180;131369;9743.756406089762;10062.647807326855;10442.68671939843;10444.529996150191;10606.57573697059;12681.809772853414;12757.681057973625;12776.936115319364;14091.718165636836;14673.77989330161;6197.628142311386;8048.637811298506;8462.957685211657;8730.646749753798;8869.778255543662;8440.83118337642;8477;8519.233269005696;8608.268297194683;8641.395102342902;4730.314104454835;4829.541193586604;4847.297141914402;4923.384576927884;4924.926126108111;1656.8757343199309;2031.1570698160394;2043.9080241389174;2048.1704909511673;2051.8768873867316;860.776198188463;869.3219288954625;1030.3251370352432;1031.8091153136693;1040.328987802863;20154;20627.896860515903;21565;21610.45973850635;21670.13319467235;1028.7376718936623;1043.6921108272925;1047.9790404191874;1057.8095942730229;1076.3703233608271;8923.509206993547;10844.945775271073;10956.726081848017;11240.775184496264;11313.377764222882;396891;527773.3611331919;652115;657074.4292557109;660022;153569;158741;163416;163718.18140909218;164865;1072.1476426241156;1082.5074591061048;1130.581684776638;1130.8021096307948;1132.3602164776876;19286.13212405417;19627.70558441653;19820.70268945938;19914.402567922985;20387.18451261933;50528.74735626298;53511.1271105525;58914;58986.705066474395;60182;60500.697496513996;85881.57059214664;87804;88194.55902720445;88492.5575372119;8219.630116644646;8219.738753263204;8220;8651.95674021626;8673.219410253107;9451.763705907133;13000.674983125498;13558.593242202749;13622.455101795817;14255.572332830032;11290.43547822622;11743.530258789895;12097.939510302393;12129.393530323625;12144.210626309261;10165.13596344319;11613.419329033684;11813.586524471602;11864.940675296568;12093.03255739521;10515.316504427188;11803.691192058966;11932;12095.455704493495;12193.817092743438;8489.830203395773;8557.700480483401;8609.91390086091;8659.263962563253;8699.695510657097;10384.636537721144;11471.770564588829;11828.994535464237;11927.343996079951;12047.096467765128 11:09:36 INFO - PROCESS | 1641 | |3;mootools.html;1385.7852032934895;1464.39227720496;1473.1897456398979;1492.8731057860082;1500.0624609618988;7836.72571459999;8194.139615340378;8195.71315003975;8205.261526462617;8215.50706957583;7475.887861682079;7695.230476952302;8057.435979481439;8085.595720213981;8302.08677045526;1956.2175129947993;2302.7697230277004;2339.6724458575814;2339.6841426407473;2344.0858065354523;2339.5905716499547;2359.1153317505937;2363.267387109993;2367.242482405631;2370.63255195445;2313.7339205991275;2313.8958746856347;2335.3577766114367;2335.5795956727784;2337.263761915;2261.547690461906;2280.669302951063;2292.2206449807145;2294.541091781642;2310.4223944013997;1923.2595450751421;2285.8399912006166;2316.0851463671925;2316.7335756387893;2317.119494592061;8025.95987020067;8201.015878094608;8215.09633940266;8216.424850260484;8217.465864718773;4968.254761785725;5127.051495473312;5127.410347810012;5128.435872054071;5136.306598609177;3235.272063785653;3314.96685033149;3433.6738009889023;3473.11435583927;3484.5121682964404;897.4929165021807;1168.450828110795;1168.8480497535352;1211.0432758121074;1214.5506162719762;10752.354858708424;10864.130869530418;10884.51019704123;10886.183536234736;10906.345619262791;4269.978650106729;4532.274836026286;4623.514530974267;4695.43654761424;4713.29300604912;9178.632854685871;9183.540822958825;9187.586558604879;9197.034311397341;9198.402103863227;5169.844904652867;5173.844784656466;5176.663516871391;5181.093308670967;5184.688918664892;4342.500612429548;4453.888652783641;4543.182227199136;4728.338032675429;4805.447373552086;3165.8733650654176;3759.4247940161076;3881.165549406891;3919.9608003919598;3922.764634121962;1261.2594619425136;1268.0806415348798;1269.9047571431995;1280.417410078412;1282.4485471247267;776.425445170581;852.2415050604967;894.1773568317163;896.3770179725028;931.6273490603812;5290.788368465295;5311.150215965427;5448.286184702921;5564.10974244119;5581;967.1585720423277;979.1139019187647;990.1732053735068;1015.918726501878;1024.9231307651955;3554.733394995386;3708.42519409492;3822.2546603412625;3830.3105441020325;3841.2125514269505;9879.75300617476;10107.393556386492;10214.285000049926;10238.385696858213;10238.846417303746;9457.38526995743;10134.442605656612;10136.239782016379;10146.644867429604;10147.441890695934;7577.280158384945;7874.842503149905;7877.881831772528;7881.802954926058;7894.092179399443;5257.78968841242;5428.484293992223;5617.269754931833;5658.886822263614;5673.06394444912;8748.69379571712;9137.360384773268;9154.725358239264;9160.908390916005;9254.907450925404;7630.672644843154;9302.581218958896;9324.347295689236;9332.580033898626;9468.431894086378;5568.638038527482;6845.315468453115;6918.7232510699005;7238.963805180941;7389.187189409268;7315.085614298213;7403.481756277009;7490.775276741707;8073.555954422563;8173.18268173178;7144.4998850082075;7232.240614735377;7268.854622907406;7294.379977701955;7380.372668323253;5834.94165058344;7052.294770522906;7071.292870712888;7227.457940654367;7296.963515182602;6377.585456945284;6410.326915673973;6456.063870738811;6483.643399613066;6496.155499785186;4478.79845406964;4728.290756386569;4936.3089167515855;4974.7512624369365;5046.293518907282;4884.291777692286;4896.6572339935865;4996.2505624156665;5053.772580233972;5088.720120393414 11:09:36 INFO - PROCESS | 1641 | |4;prototype.html;346.1709206450551;359.29936623584;361.08645127826605;379.43085371942107;379.93351163546373;4053.5946405359523;4135.524414692311;5164.6384753067305;5246.947530524693;5434.646747961385;4554.2713165893465;4701.918558731494;5163;5197.584193264539;5303;4142.275101857178;4148.605882441163;4148.605882441178;4152.6055024772595;4166.812493437795;3449.9132773176493;3742.5696044954907;4143.564925682806;4172.70791044627;4189.329707246841;4042.9797851010703;4072.1448495815916;4092.9386059209137;4108.28105081611;4169.72896761711;3914.706397020206;4081.2449696806184;4091.365838295069;4101.610347017028;4112.3625837995005;3403.9319213615836;3451.516787649731;3598.442241452553;3656.3053019926397;3688.428293614494;4488.454121244213;4781.976090119562;4816.301636262758;5142.3829140503;5207.687538747649;4108.637533418267;4620.930686039678;4739.724932032644;4780.498047704976;4791.976040119777;4413.668974826901;4650.697804614713;5200;5443.564514838803;5562.916556251619;3873.2447172801317;3912.18561902146;3945.993771588255;3960.1683646434285;4006.419069234945;4952.504749525055;5804.680742559158;5836.789765628887;5879.353271140171;5888.793892213795;4024.396340548941;4065.8576949806616;4087.734297270668;4088.141490287073;4093.4269202311702;3498.8950331490096;3588.0132963435262;4098.262312783728;4113.424120623115;4133.689973251958;4089.91820163601;4143.544210136883;4229.175310814423;4538.549183440971;4600.4479462464715;5138.019948429902;5143.3570803649545;5649.3337861324035;5675.871548169436;5684.8294551163535;1099.4722533184117;1188.8395066666062;1198.5864876617552;1216.2425295447993;1220.6277085488834;786.5398741736034;830.7881490220076;835.0522157351328;836.7573403712855;838.379599096664;4713.481517033124;4840.2255639097575;4875.122477953932;4880.341153944243;4969.527894849984;4661.26230457439;5096.694198348111;5366.248725178478;5414.751149310461;5493.340799104053;3986.7009974252046;4977.8302099006705;4991.105159007767;4993.101241776515;5003.3495645565845;2588.479667651992;2644.0349272515778;2845.331347133422;2876.6404199475064;2881.9567706484418;4812.590929770939;4889.63327750413;5308.010470158039;5690.748035432198;5737.827865164052;4386.017508094463;4923.803047878117;5032.144535428986;5221.973890130525;5582.54853738031;5272.103742363731;5496.862578435491;5536.176549959549;5642.71786410686;5676.858078547987;5346.572274217975;5396.21754845553;5458.670211171262;5469.960707465569;5768.711564421846;5054.570361519312;5744.569157313302;5745.626534275259;5745.741441635053;5764.250647415809;5147.830257491444;5826.854328641818;5957.851053723518;6022.397760223943;6042.516598672184;2903.2596687844466;3551.698105661048;3791.1659434924272;3821.808909554567;3826.234753049457;5735;5754.482096611325;5780.104083867007;5788;5828.271466066742;4594.402727645384;4748.92876606858;5598.656322482656;5620.688449415264;5641.717914104361;5009.774560144875;5153.871153221199;5232.947670523246;5627.746751396279;5647.3505546861;4536.298887917031;4547.840825571089;5382.138857782736;5398.379186393615;5490.890182196414;4483.484399294123;4483.775811209362;4742.549457801503;5466.01611709896;5503.3120859892515;5043.638217681132;5484.369297530835;5506.256655351476;5506.944930550643;5514.255575497256 11:09:36 INFO - PROCESS | 1641 | |5;yui.html;715.642178910545;731.04233454175;756.8183635927377;773.8993930788996;820.6758330459469;14996.175210363426;15811.84188158118;15839.762403563956;15846.762298565516;15862.603434914134;14579.37571237177;14766.483173088944;14772.556823295292;14774.335154918028;14774.778378324334;681.2506243132564;703.1281211297979;706.6819931031031;867.3278209387712;880.102295658428;826.2233500509502;855.6577369052397;880.4101252161036;888.7467071884514;890.8262888736699;937.8499440089587;941.1012483078644;941.6986564299427;941.9717408477723;943.8489841625342;932.673564252513;933.6358820060148;933.7385532051037;933.9766505837408;935.1583574782682;534.3747815056394;553.8947599955995;672.4889084295921;685.9314068593101;696.554205308603;14894.180820054893;15310.234488275542;15367.308471118826;15387.307571159212;15392.846071539365;11819.586314478953;13468.461261549526;13551.932240338736;13640.522581709592;13720.519781807589;12460.376981150906;12536.233332666985;12539;12577.182483138567;12661.556845510362;4430.9556904430865;4474.619657329098;4485.820567177309;4529.275315949432;4684.765761711935;96941.03058969391;96948.51525742326;100532.49733751357;100912.49543752235;101100;8925.910740892637;10780.51487683056;10804.297720648132;10912.618058368078;11257.380844053656;21183.714277229352;21350.35948921535;21392.358229253146;21523.784762152492;21585.24451644185;7352.485326027127;7503.7748867534065;7536.434767392468;7581.469297149257;7655.540667559964;3617.366960781853;4067.1255680028935;4201.243776120327;4241.321388577812;4251.532331443539;3403.7957722536726;3475.600305964796;3496.0910163357203;3514.648535146465;3519.454484554898;637.346719612401;638.658317799984;643.9935600644027;652.1587152573128;655.6525041727892;640.1358166475314;643.5527308520627;645.0743183531647;654.2737561306946;656.701200953565;8299.419040667095;9006.81305068826;9471.526423678788;9724.513774311255;9759.316847820726;612.1888497740512;613.9079138129316;670.6646676661669;672.3008071605573;680.6358598149966;4534.161180181677;4632.351470794091;4639.976800115978;4642.65180111493;4699.2481203007355;82546;105258;106107.87784244271;106896.46551767191;108203;64739.35260647333;74238.25761742314;74510;80707.59646201848;95247;69659.65170174219;72193.55612887818;72875.63562182155;73022;74964.25035749681;10284.588616455558;10389.324693894872;11107.056265153404;11178.776424471627;11397.316161030365;40318.39522407225;47688.52311476841;49511.50488495213;51554;51571.22643160431;63702;64391.390215244995;65221.673891630235;68347.31652683609;70675.29324706687;13123.803142952673;13266.270355130175;13407.463701452223;13654.180749155083;13794.65513362174;14458.638534036732;15015.474458393905;15112.773308400603;15264.847351526787;15791;11030.28303160292;13660.521881734092;13873.930630346784;14029.789553156916;14574.125552466461;13629.454821807016;14038.719225615634;14051.227182505061;14092.436302547783;14092.647683807987;13621;13669.863301366859;13830.446782128602;13865.86134138686;14413.13521188732;7920.683172673029;10583.206259530412;10681.946590266998;11098.50056747432;11458.312501249951;10035.397876127456;10333.896661033294;10394.948025259826;10396.948015259875;10452.216083793593 11:09:36 INFO - PROCESS | 1641 | __end_tp_report 11:09:36 INFO - PROCESS | 1641 | __start_cc_report 11:09:36 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,1065 11:09:36 INFO - PROCESS | 1641 | __end_cc_report 11:09:36 INFO - PROCESS | 1641 | __startTimestamp1484334576406__endTimestamp 11:09:36 INFO - PROCESS | 1641 | 11:09:36 INFO - PROCESS | 1641 | ------- Summary: start ------- 11:09:36 INFO - PROCESS | 1641 | Number of tests: 6 11:09:36 INFO - PROCESS | 1641 | 11:09:36 INFO - PROCESS | 1641 | [#0] dojo.html Cycles:165 Average:5693.54 Median:5905.47 stddev:656.31 (11.1%) stddev-sans-first:627.39 11:09:36 INFO - PROCESS | 1641 | Values: 3155.4 3353.5 3353.6 3378.2 3414.8 5507.0 5511.5 5638.6 5688.2 5712.9 4110.3 4768.6 5600.6 5606.8 5698.3 5072.4 5136.8 5157.6 5202.9 5214.1 5097.6 5132.7 5194.0 5235.6 5245.8 5226.2 5254.3 5262.4 5276.2 5296.9 5079.2 5109.7 5124.2 5127.4 5225.2 5138.1 5228.2 5228.5 5238.8 5248.4 5623.5 5630.2 5649.4 5674.9 5693.1 6173.5 6197.2 6203.7 6205.4 6212.3 6101.6 6106.9 6150.3 6150.7 6171.6 5700.9 5711.3 5712.5 5714.4 5758.7 6130.3 6246.9 6252.1 6267.7 6284.2 5050.7 5997.4 6027.6 6049.7 6063.2 6141.2 6156.3 6158.6 6177.3 6254.4 5259.7 5962.1 6023.8 6035.9 6109.2 5053.6 6102.6 6187.3 6269.7 6279.7 5023.9 5025.2 5033.5 5035.6 5050.8 4327.9 4401.5 4416.8 4477.5 4519.6 5811.5 5822.0 5883.2 5937.5 5960.1 6254.3 6255.1 6256.7 6258.8 6271.7 5853.2 5872.6 5888.0 5891.8 5905.5 5311.3 5313.1 5350.3 5402.2 5426.9 6272.2 6423.7 6435.8 6438.7 6444.2 6246.5 6261.7 6268.6 6271.4 6284.2 6211.2 6345.1 6418.2 6426.2 6426.2 6075.1 6125.0 6141.3 6171.5 6250.2 6240.0 6244.8 6252.7 6264.9 6266.7 6031.7 6110.1 6137.8 6141.8 6142.9 5865.1 5974.9 6066.8 6090.8 6126.3 5830.0 5982.6 5989.3 6008.1 6059.4 5827.0 5891.3 5903.3 5909.5 5977.1 4901.8 5852.6 5936.0 5947.3 5951.5 11:09:36 INFO - PROCESS | 1641 | 11:09:36 INFO - PROCESS | 1641 | [#1] ext.html Cycles:180 Average:67268.40 Median:35249.88 stddev:146927.37 (416.8%) stddev-sans-first:147253.89 11:09:36 INFO - PROCESS | 1641 | Values: 448.8 456.5 492.2 499.5 511.0 30629.7 38853.2 40769.0 40881.2 42409.4 34322.0 42350.8 42531.0 42604.4 42635.1 8259.7 9127.9 9320.9 9334.5 9362.6 8260.4 10937.9 11170.4 11187.5 11390.3 11108.9 11197.6 11200.7 11205.2 11219.6 8293.2 11093.8 11167.8 11176.2 11194.4 8263.6 10795.2 11010.7 11052.7 11268.0 39593.0 40034.0 40040.8 40077.4 40079.4 4025.0 4034.9 4058.2 4074.9 4079.9 29852.6 30161.9 30327.5 30949.1 31084.0 3088.2 3197.9 3200.3 3216.2 3291.4 456350.0 460406.0 461392.7 461517.0 462773.7 57589.4 57989.4 58005.7 58079.0 58095.0 60509.4 60734.8 60736.7 60842.4 60885.4 15333.6 15820.7 15822.8 15842.2 15850.0 10973.1 11258.5 12179.8 12235.5 12247.8 13696.9 14993.3 15178.0 15226.8 15406.8 6363.8 6870.2 6879.6 6925.6 6949.9 874.4 876.8 877.9 887.1 905.5 29590.1 29691.0 29778.6 30241.0 30422.9 971.1 1042.7 1044.1 1075.8 1174.4 13711.5 15393.2 15476.6 15711.2 15744.1 609099.0 610790.0 610885.0 610991.0 611668.0 51860.7 54586.0 58051.0 58361.1 58432.4 1412.1 1456.4 1457.4 1461.3 1464.2 27919.6 28115.9 28448.9 29214.9 29541.7 49720.0 50185.7 50187.5 50345.7 50439.7 562524.0 567439.0 568002.0 568276.0 569859.0 21776.9 22274.8 24088.6 24350.3 24483.0 35422.5 42751.4 42843.1 43880.1 44557.0 25961.7 32771.7 33589.8 35190.1 36280.8 35224.1 35370.9 35980.3 36422.8 36790.8 34064.7 34361.8 35062.5 35275.6 35555.5 26107.0 30226.8 30452.5 32271.0 32528.8 21462.7 21599.0 23430.4 23632.8 24162.0 11:09:36 INFO - PROCESS | 1641 | 11:09:36 INFO - PROCESS | 1641 | [#2] jquery.html Cycles:180 Average:36163.93 Median:21587.73 stddev:99644.36 (461.6%) stddev-sans-first:99887.57 11:09:36 INFO - PROCESS | 1641 | Values: 334.8 393.0 399.9 403.2 425.4 13540.9 20134.3 20521.4 21445.4 21468.5 21037.7 21195.8 21231.0 21619.5 21636.0 5858.9 6187.4 6189.0 6194.6 6208.8 5814.2 5979.4 6006.6 6079.1 6101.5 5906.5 6010.9 6019.8 6022.5 6036.3 5760.6 5964.3 5997.1 6013.0 6027.3 5258.8 5264.9 5270.4 5275.7 5284.2 24704.9 25548.7 25595.5 25631.6 26046.6 2347.6 2760.0 2776.9 2778.2 2785.4 15323.4 15765.3 15826.0 16178.9 16573.6 1807.0 1816.2 1840.6 1854.0 1901.8 125726.4 127602.0 129078.4 131180.0 131369.0 9743.8 10062.6 10442.7 10444.5 10606.6 12681.8 12757.7 12776.9 14091.7 14673.8 6197.6 8048.6 8463.0 8730.6 8869.8 8440.8 8477.0 8519.2 8608.3 8641.4 4730.3 4829.5 4847.3 4923.4 4924.9 1656.9 2031.2 2043.9 2048.2 2051.9 860.8 869.3 1030.3 1031.8 1040.3 20154.0 20627.9 21565.0 21610.5 21670.1 1028.7 1043.7 1048.0 1057.8 1076.4 8923.5 10844.9 10956.7 11240.8 11313.4 396891.0 527773.4 652115.0 657074.4 660022.0 153569.0 158741.0 163416.0 163718.2 164865.0 1072.1 1082.5 1130.6 1130.8 1132.4 19286.1 19627.7 19820.7 19914.4 20387.2 50528.7 53511.1 58914.0 58986.7 60182.0 60500.7 85881.6 87804.0 88194.6 88492.6 8219.6 8219.7 8220.0 8652.0 8673.2 9451.8 13000.7 13558.6 13622.5 14255.6 11290.4 11743.5 12097.9 12129.4 12144.2 10165.1 11613.4 11813.6 11864.9 12093.0 10515.3 11803.7 11932.0 12095.5 12193.8 8489.8 8557.7 8609.9 8659.3 8699.7 10384.6 11471.8 11829.0 11927.3 12047.1 11:09:36 INFO - PROCESS | 1641 | 11:09:36 INFO - PROCESS | 1641 | [#3] mootools.html Cycles:180 Average:5380.40 Median:5127.23 stddev:2934.35 (57.2%) stddev-sans-first:2927.23 11:09:36 INFO - PROCESS | 1641 | Values: 1385.8 1464.4 1473.2 1492.9 1500.1 7836.7 8194.1 8195.7 8205.3 8215.5 7475.9 7695.2 8057.4 8085.6 8302.1 1956.2 2302.8 2339.7 2339.7 2344.1 2339.6 2359.1 2363.3 2367.2 2370.6 2313.7 2313.9 2335.4 2335.6 2337.3 2261.5 2280.7 2292.2 2294.5 2310.4 1923.3 2285.8 2316.1 2316.7 2317.1 8026.0 8201.0 8215.1 8216.4 8217.5 4968.3 5127.1 5127.4 5128.4 5136.3 3235.3 3315.0 3433.7 3473.1 3484.5 897.5 1168.5 1168.8 1211.0 1214.6 10752.4 10864.1 10884.5 10886.2 10906.3 4270.0 4532.3 4623.5 4695.4 4713.3 9178.6 9183.5 9187.6 9197.0 9198.4 5169.8 5173.8 5176.7 5181.1 5184.7 4342.5 4453.9 4543.2 4728.3 4805.4 3165.9 3759.4 3881.2 3920.0 3922.8 1261.3 1268.1 1269.9 1280.4 1282.4 776.4 852.2 894.2 896.4 931.6 5290.8 5311.2 5448.3 5564.1 5581.0 967.2 979.1 990.2 1015.9 1024.9 3554.7 3708.4 3822.3 3830.3 3841.2 9879.8 10107.4 10214.3 10238.4 10238.8 9457.4 10134.4 10136.2 10146.6 10147.4 7577.3 7874.8 7877.9 7881.8 7894.1 5257.8 5428.5 5617.3 5658.9 5673.1 8748.7 9137.4 9154.7 9160.9 9254.9 7630.7 9302.6 9324.3 9332.6 9468.4 5568.6 6845.3 6918.7 7239.0 7389.2 7315.1 7403.5 7490.8 8073.6 8173.2 7144.5 7232.2 7268.9 7294.4 7380.4 5834.9 7052.3 7071.3 7227.5 7297.0 6377.6 6410.3 6456.1 6483.6 6496.2 4478.8 4728.3 4936.3 4974.8 5046.3 4884.3 4896.7 4996.3 5053.8 5088.7 11:09:36 INFO - PROCESS | 1641 | 11:09:36 INFO - PROCESS | 1641 | [#4] prototype.html Cycles:180 Average:4432.88 Median:4828.26 stddev:1343.20 (27.8%) stddev-sans-first:1311.48 11:09:36 INFO - PROCESS | 1641 | Values: 346.2 359.3 361.1 379.4 379.9 4053.6 4135.5 5164.6 5246.9 5434.6 4554.3 4701.9 5163.0 5197.6 5303.0 4142.3 4148.6 4148.6 4152.6 4166.8 3449.9 3742.6 4143.6 4172.7 4189.3 4043.0 4072.1 4092.9 4108.3 4169.7 3914.7 4081.2 4091.4 4101.6 4112.4 3403.9 3451.5 3598.4 3656.3 3688.4 4488.5 4782.0 4816.3 5142.4 5207.7 4108.6 4620.9 4739.7 4780.5 4792.0 4413.7 4650.7 5200.0 5443.6 5562.9 3873.2 3912.2 3946.0 3960.2 4006.4 4952.5 5804.7 5836.8 5879.4 5888.8 4024.4 4065.9 4087.7 4088.1 4093.4 3498.9 3588.0 4098.3 4113.4 4133.7 4089.9 4143.5 4229.2 4538.5 4600.4 5138.0 5143.4 5649.3 5675.9 5684.8 1099.5 1188.8 1198.6 1216.2 1220.6 786.5 830.8 835.1 836.8 838.4 4713.5 4840.2 4875.1 4880.3 4969.5 4661.3 5096.7 5366.2 5414.8 5493.3 3986.7 4977.8 4991.1 4993.1 5003.3 2588.5 2644.0 2845.3 2876.6 2882.0 4812.6 4889.6 5308.0 5690.7 5737.8 4386.0 4923.8 5032.1 5222.0 5582.5 5272.1 5496.9 5536.2 5642.7 5676.9 5346.6 5396.2 5458.7 5470.0 5768.7 5054.6 5744.6 5745.6 5745.7 5764.3 5147.8 5826.9 5957.9 6022.4 6042.5 2903.3 3551.7 3791.2 3821.8 3826.2 5735.0 5754.5 5780.1 5788.0 5828.3 4594.4 4748.9 5598.7 5620.7 5641.7 5009.8 5153.9 5232.9 5627.7 5647.4 4536.3 4547.8 5382.1 5398.4 5490.9 4483.5 4483.8 4742.5 5466.0 5503.3 5043.6 5484.4 5506.3 5506.9 5514.3 11:09:36 INFO - PROCESS | 1641 | 11:09:36 INFO - PROCESS | 1641 | [#5] yui.html Cycles:180 Average:19757.65 Median:4341.24 stddev:27760.79 (639.5%) stddev-sans-first:27801.84 11:09:36 INFO - PROCESS | 1641 | Values: 715.6 731.0 756.8 773.9 820.7 14996.2 15811.8 15839.8 15846.8 15862.6 14579.4 14766.5 14772.6 14774.3 14774.8 681.3 703.1 706.7 867.3 880.1 826.2 855.7 880.4 888.7 890.8 937.8 941.1 941.7 942.0 943.8 932.7 933.6 933.7 934.0 935.2 534.4 553.9 672.5 685.9 696.6 14894.2 15310.2 15367.3 15387.3 15392.8 11819.6 13468.5 13551.9 13640.5 13720.5 12460.4 12536.2 12539.0 12577.2 12661.6 4431.0 4474.6 4485.8 4529.3 4684.8 96941.0 96948.5 100532.5 100912.5 101100.0 8925.9 10780.5 10804.3 10912.6 11257.4 21183.7 21350.4 21392.4 21523.8 21585.2 7352.5 7503.8 7536.4 7581.5 7655.5 3617.4 4067.1 4201.2 4241.3 4251.5 3403.8 3475.6 3496.1 3514.6 3519.5 637.3 638.7 644.0 652.2 655.7 640.1 643.6 645.1 654.3 656.7 8299.4 9006.8 9471.5 9724.5 9759.3 612.2 613.9 670.7 672.3 680.6 4534.2 4632.4 4640.0 4642.7 4699.2 82546.0 105258.0 106107.9 106896.5 108203.0 64739.4 74238.3 74510.0 80707.6 95247.0 69659.7 72193.6 72875.6 73022.0 74964.3 10284.6 10389.3 11107.1 11178.8 11397.3 40318.4 47688.5 49511.5 51554.0 51571.2 63702.0 64391.4 65221.7 68347.3 70675.3 13123.8 13266.3 13407.5 13654.2 13794.7 14458.6 15015.5 15112.8 15264.8 15791.0 11030.3 13660.5 13873.9 14029.8 14574.1 13629.5 14038.7 14051.2 14092.4 14092.6 13621.0 13669.9 13830.4 13865.9 14413.1 7920.7 10583.2 10681.9 11098.5 11458.3 10035.4 10333.9 10394.9 10396.9 10452.2 11:09:36 INFO - PROCESS | 1641 | -------- Summary: end -------- 11:09:36 INFO - PROCESS | 1641 | 11:09:37 INFO - TEST-INFO | 1641: exit 0 11:09:37 INFO - TEST-OK | dromaeo_css | took 1118442ms 11:09:37 INFO - TEST-START | kraken 11:09:37 INFO - operating with platform_type : mac_ 11:09:37 INFO - Initialising browser for kraken test... 11:09:37 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/tmpUeEXAc/profile http://localhost:49244/getInfo.html) 11:09:39 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 11:09:39 INFO - PROCESS | 1652 | colorDepth:24 11:09:39 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 11:09:39 INFO - PROCESS | 1652 | __metrics 11:09:39 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" 11:09:39 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] 11:09:40 INFO - TEST-INFO | 1652: exit 0 11:09:40 INFO - Browser initialized. 11:09:40 INFO - Running cycle 1/1 for kraken test... 11:09:40 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/T/tmpUeEXAc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:09:52 INFO - PROCESS | 1653 | RSS: Main: 235737088 11:09:52 INFO - PROCESS | 1653 | 11:09:54 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 11:09:55 INFO - PROCESS | 1653 | RSS: Main: 287162368 11:09:55 INFO - PROCESS | 1653 | 11:09:58 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 11:09:58 INFO - PROCESS | 1653 | RSS: Main: 287019008 11:09:58 INFO - PROCESS | 1653 | 11:10:02 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 11:10:02 INFO - PROCESS | 1653 | RSS: Main: 378466304 11:10:02 INFO - PROCESS | 1653 | 11:10:04 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 11:10:05 INFO - PROCESS | 1653 | RSS: Main: 282075136 11:10:05 INFO - PROCESS | 1653 | 11:10:07 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:10:08 INFO - PROCESS | 1653 | RSS: Main: 286814208 11:10:08 INFO - PROCESS | 1653 | 11:10:10 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 11:10:11 INFO - PROCESS | 1653 | RSS: Main: 329891840 11:10:11 INFO - PROCESS | 1653 | 11:10:14 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 11:10:15 INFO - PROCESS | 1653 | RSS: Main: 330780672 11:10:15 INFO - PROCESS | 1653 | 11:10:17 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 11:10:18 INFO - PROCESS | 1653 | RSS: Main: 329551872 11:10:18 INFO - PROCESS | 1653 | 11:10:20 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:10:20 INFO - PROCESS | 1653 | RSS: Main: 304037888 11:10:20 INFO - PROCESS | 1653 | 11:10:22 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:10:23 INFO - PROCESS | 1653 | RSS: Main: 304922624 11:10:23 INFO - PROCESS | 1653 | 11:10:25 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:10:26 INFO - PROCESS | 1653 | RSS: Main: 307658752 11:10:26 INFO - PROCESS | 1653 | 11:10:29 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:10:29 INFO - PROCESS | 1653 | RSS: Main: 325074944 11:10:29 INFO - PROCESS | 1653 | 11:10:33 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:10:33 INFO - PROCESS | 1653 | RSS: Main: 318476288 11:10:33 INFO - PROCESS | 1653 | 11:10:35 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 11:10:35 INFO - PROCESS | 1653 | RSS: Main: 363065344 11:10:35 INFO - PROCESS | 1653 | 11:10:35 INFO - PROCESS | 1653 | __start_tp_report 11:10:35 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 11:10:35 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 11:10:35 INFO - PROCESS | 1653 | |i|pagename|runs| 11:10:35 INFO - PROCESS | 1653 | |0;ai-astar;111;111;113;113;113;113;113;113;114;114 11:10:35 INFO - PROCESS | 1653 | |1;audio-beat-detection;138;110;109;145;111;143;144;140;130;111 11:10:35 INFO - PROCESS | 1653 | |2;audio-dft;186;187;183;186;182;185;180;194;261;184 11:10:35 INFO - PROCESS | 1653 | |3;audio-fft;81;59;59;86;61;61;74;49;75;48 11:10:35 INFO - PROCESS | 1653 | |4;audio-oscillator;90;71;85;69;67;70;83;68;69;83 11:10:35 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;89;118;87;86;85;85;87;84;86;84 11:10:35 INFO - PROCESS | 1653 | |6;imaging-darkroom;94;93;97;97;89;131;95;97;93;93 11:10:35 INFO - PROCESS | 1653 | |7;imaging-desaturate;86;86;85;86;86;85;84;85;88;85 11:10:35 INFO - PROCESS | 1653 | |8;json-parse-financial;56;56;53;55;77;87;87;81;56;55 11:10:35 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;65;73;73;77;72;71;71;71;70;70 11:10:35 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;89;89;86;102;108;107;82;85;85;105 11:10:35 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;142;141;137;140;141;140;141;141;181;139 11:10:35 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;224;249;189;172;172;171;173;173;181;171 11:10:35 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;67;68;68;68;67;67;67;67;66;67 11:10:35 INFO - PROCESS | 1653 | __end_tp_report 11:10:35 INFO - PROCESS | 1653 | __start_cc_report 11:10:35 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1987 11:10:35 INFO - PROCESS | 1653 | __end_cc_report 11:10:35 INFO - PROCESS | 1653 | __startTimestamp1484334635631__endTimestamp 11:10:35 INFO - PROCESS | 1653 | 11:10:35 INFO - PROCESS | 1653 | ------- Summary: start ------- 11:10:35 INFO - PROCESS | 1653 | Number of tests: 14 11:10:35 INFO - PROCESS | 1653 | 11:10:35 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.00 stddev:1.03 (0.9%) stddev-sans-first:0.87 11:10:35 INFO - PROCESS | 1653 | Values: 111.0 111.0 113.0 113.0 113.0 113.0 113.0 113.0 114.0 114.0 11:10:35 INFO - PROCESS | 1653 | 11:10:35 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:128.10 Median:139.00 stddev:15.92 (11.5%) stddev-sans-first:16.48 11:10:35 INFO - PROCESS | 1653 | Values: 138.0 110.0 109.0 145.0 111.0 143.0 144.0 140.0 130.0 111.0 11:10:35 INFO - PROCESS | 1653 | 11:10:35 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:192.80 Median:186.00 stddev:24.25 (13.0%) stddev-sans-first:25.60 11:10:35 INFO - PROCESS | 1653 | Values: 186.0 187.0 183.0 186.0 182.0 185.0 180.0 194.0 261.0 184.0 11:10:35 INFO - PROCESS | 1653 | 11:10:35 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:65.30 Median:67.50 stddev:13.02 (19.3%) stddev-sans-first:12.51 11:10:35 INFO - PROCESS | 1653 | Values: 81.0 59.0 59.0 86.0 61.0 61.0 74.0 49.0 75.0 48.0 11:10:35 INFO - PROCESS | 1653 | 11:10:35 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:75.50 Median:77.00 stddev:8.67 (11.3%) stddev-sans-first:7.44 11:10:35 INFO - PROCESS | 1653 | Values: 90.0 71.0 85.0 69.0 67.0 70.0 83.0 68.0 69.0 83.0 11:10:35 INFO - PROCESS | 1653 | 11:10:35 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:89.10 Median:86.00 stddev:10.27 (11.9%) stddev-sans-first:10.89 11:10:35 INFO - PROCESS | 1653 | Values: 89.0 118.0 87.0 86.0 85.0 85.0 87.0 84.0 86.0 84.0 11:10:35 INFO - PROCESS | 1653 | 11:10:35 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:97.90 Median:94.50 stddev:11.89 (12.6%) stddev-sans-first:12.53 11:10:35 INFO - PROCESS | 1653 | Values: 94.0 93.0 97.0 97.0 89.0 131.0 95.0 97.0 93.0 93.0 11:10:35 INFO - PROCESS | 1653 | 11:10:35 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:86.00 stddev:1.07 (1.2%) stddev-sans-first:1.13 11:10:35 INFO - PROCESS | 1653 | Values: 86.0 86.0 85.0 86.0 86.0 85.0 84.0 85.0 88.0 85.0 11:10:35 INFO - PROCESS | 1653 | 11:10:35 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:66.50 stddev:14.67 (22.1%) stddev-sans-first:15.08 11:10:35 INFO - PROCESS | 1653 | Values: 56.0 56.0 53.0 55.0 77.0 87.0 87.0 81.0 56.0 55.0 11:10:35 INFO - PROCESS | 1653 | 11:10:35 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:71.50 stddev:3.02 (4.2%) stddev-sans-first:2.18 11:10:35 INFO - PROCESS | 1653 | Values: 65.0 73.0 73.0 77.0 72.0 71.0 71.0 71.0 70.0 70.0 11:10:35 INFO - PROCESS | 1653 | 11:10:35 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:93.80 Median:85.00 stddev:10.38 (12.2%) stddev-sans-first:10.86 11:10:35 INFO - PROCESS | 1653 | Values: 89.0 89.0 86.0 102.0 108.0 107.0 82.0 85.0 85.0 105.0 11:10:35 INFO - PROCESS | 1653 | 11:10:35 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:144.30 Median:141.00 stddev:12.97 (9.2%) stddev-sans-first:13.73 11:10:35 INFO - PROCESS | 1653 | Values: 142.0 141.0 137.0 140.0 141.0 140.0 141.0 141.0 181.0 139.0 11:10:35 INFO - PROCESS | 1653 | 11:10:35 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.50 Median:177.00 stddev:27.09 (15.3%) stddev-sans-first:25.31 11:10:35 INFO - PROCESS | 1653 | Values: 224.0 249.0 189.0 172.0 172.0 171.0 173.0 173.0 181.0 171.0 11:10:35 INFO - PROCESS | 1653 | 11:10:35 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 11:10:35 INFO - PROCESS | 1653 | Values: 67.0 68.0 68.0 68.0 67.0 67.0 67.0 67.0 66.0 67.0 11:10:35 INFO - PROCESS | 1653 | -------- Summary: end -------- 11:10:35 INFO - PROCESS | 1653 | 11:10:36 INFO - TEST-INFO | 1653: exit 0 11:10:36 INFO - TEST-OK | kraken | took 59534ms 11:10:36 INFO - SUITE-END | took 1177s 11:10:36 INFO - Completed test suite (00:19:38) 11:10:36 INFO - javascript benchmark 11:10:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3155.3689262147573, 3353.5305057291976, 3353.564036675232, 3378.1554611347165, 3414.778039427437, 5507.008738427082, 5511.5039646431815, 5638.605297629168, 5688.175214593882, 5712.8857422851515, 4110.28070087735, 4768.594669453092, 5600.6079574429805, 5606.831795046145, 5698.316202055759, 5072.365954255718, 5136.820211292606, 5157.5616072633875, 5202.895942081156, 5214.139666954967, 5097.5667068299235, 5132.717700526469, 5194.013137503862, 5235.633505654606, 5245.842624721246, 5226.216067589854, 5254.2644029835665, 5262.4474430184855, 5276.182191760283, 5296.867578310535, 5079.23811428285, 5109.667871588372, 5124.205748109049, 5127.359080114986, 5225.216217567396, 5138.075146473633, 5228.215767634847, 5228.529432351069, 5238.764255608468, 5248.422673505911, 5623.465770751772, 5630.183623374629, 5649.378568357477, 5674.886502269931, 5693.089105743061, 6173.475254603364, 6197.194364732556, 6203.689815509207, 6205.379462053804, 6212.285587157445, 6101.633901965852, 6106.855059071331, 6150.2927163376335, 6150.66171360575, 6171.6297022178815, 5700.945325114867, 5711.314642242957, 5712.485876271156, 5714.428557144335, 5758.683272420015, 6130.325664176937, 6246.875062498724, 6252.062190671436, 6267.749290028348, 6284.214473190851, 5050.696958182521, 5997.430244126801, 6027.60820546663, 6049.727762250709, 6063.181470501514, 6141.192460674321, 6156.29202641702, 6158.568900176944, 6177.2587289524645, 6254.437100660963, 5259.710715910585, 5962.135490353874, 6023.759049637965, 6035.939640603626, 6109.20580324555, 5053.646244762831, 6102.633841969496, 6187.257529096447, 6269.65516896566, 6279.717412716439, 5023.924641130386, 5025.195968644999, 5033.521815427529, 5035.597152227813, 5050.772715227824, 4327.891802704958, 4401.493828209796, 4416.84541041062, 4477.485089214717, 4519.615832654261, 5811.506021988093, 5822.039363505059, 5883.17635531026, 5937.495312898365, 5960.135780311831, 6254.312025677172, 6255.12428260044, 6256.718447669866, 6258.843528911813, 6271.686415679198, 5853.180554722342, 5872.618279811799, 5888.0, 5891.793787217427, 5905.4685078343155, 5311.3095297611835, 5313.07021271276, 5350.27771250884, 5402.216678581583, 5426.9185962210595, 6272.18461599989, 6423.743050277936, 6435.806925792233, 6438.678066096582, 6444.194475690539, 6246.46905013079, 6261.7182226799, 6268.623882567061, 6271.3728627136925, 6284.214473190851, 6211.192544969125, 6345.143405640364, 6418.19772528434, 6426.164598602152, 6426.228852537725, 6075.088736689532, 6124.991279909774, 6141.271221159771, 6171.506279497719, 6250.249970003447, 6240.0, 6244.812655620339, 6252.749890004531, 6264.874702505833, 6266.749330026748, 6031.698415079316, 6110.083487476736, 6137.785177518944, 6141.785037523665, 6142.907856382247, 5865.14955331466, 5974.850628734316, 6066.757329706762, 6090.847728806815, 6126.264848218242, 5829.970850145722, 5982.551308651781, 5989.311229208697, 6008.068749343859, 6059.3637668045985, 5826.970865145647, 5891.3224979127945, 5903.26209223847, 5909.468147866541, 5977.103434484862, 4901.803927842846, 5852.561057920588, 5935.970320148372, 5947.286325640951, 5951.464368206882], "value": 5652.429466519328, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [448.7599134463063, 456.4864527406668, 492.23703259947087, 499.54382973631886, 510.98211562595293, 30629.693703062963, 38853.22293554127, 40769.0, 40881.18237635245, 42409.36385954213, 34322.0, 42350.7882460588, 42531.0, 42604.36093458601, 42635.147297054114, 8259.710910118147, 9127.908720912772, 9320.906790932071, 9334.53327333634, 9362.578683959238, 8260.380471464634, 10937.890621093806, 11170.441477926111, 11187.49656265466, 11390.25963312382, 11108.944455277713, 11197.552097916074, 11200.663980080612, 11205.159613029015, 11219.60731374402, 8293.21214484623, 11093.778124437506, 11167.83248251277, 11176.161787865862, 11194.440277986108, 8263.628136733862, 10795.2443328967, 11010.724731881686, 11052.723681908017, 11268.042216411615, 39593.0, 40034.0, 40040.79979600113, 40077.398839017435, 40079.39880901789, 4025.031437822422, 4034.8587799427173, 4058.2492238935893, 4074.8777536673947, 4079.877603671865, 29852.55221171684, 30161.944331948496, 30327.545086823717, 30949.0715278542, 31084.0, 3088.232356525036, 3197.9360412791616, 3200.3439294944483, 3216.179874132105, 3291.374638818617, 456350.0, 460406.0, 461392.69303653267, 461517.0, 462773.68613157055, 57589.424105759244, 57989.42010579925, 58005.70997144987, 58079.0, 58095.0, 60509.39490605037, 60734.78530429455, 60736.69631651814, 60842.391576084556, 60885.391146087975, 15333.616659583377, 15820.683586328209, 15822.841771582367, 15842.207889605474, 15850.0, 10973.122150227962, 11258.549658013588, 12179.756404871852, 12235.510579576718, 12247.816282755766, 13696.863031369758, 14993.32530036151, 15178.0, 15226.771598426032, 15406.768898466533, 6363.840903977345, 6870.20992585859, 6879.628981798883, 6925.6190909499455, 6949.93050069503, 874.3617159473492, 876.785651872149, 877.8946526416871, 887.1040249348205, 905.4612505559313, 29590.11763059071, 29690.960816371324, 29778.55332170019, 30241.0, 30422.93519726799, 971.1114330387758, 1042.6924057403085, 1044.1333693034915, 1075.8224892892586, 1174.448009435564, 13711.451541938211, 15393.153376564396, 15476.613084672974, 15711.21443927822, 15744.134072625886, 609099.0, 610790.0, 610885.0, 610991.0, 611668.0, 51860.70348241324, 54586.0, 58051.0, 58361.124583131284, 58432.4156758427, 1412.131539103444, 1456.3592019511593, 1457.4097490516358, 1461.3204859740272, 1464.1581090872578, 27919.581206282328, 28115.859420702767, 28448.857755711088, 29214.853925730236, 29541.694366274554, 49720.0, 50185.74907125441, 50187.49812501828, 50345.74135646638, 50439.74780126076, 562524.0, 567439.0, 568002.0, 568276.0, 569859.0, 21776.891115544953, 22274.767794119067, 24088.63867041961, 24350.26949191527, 24483.0, 35422.46866296956, 42751.358729618456, 42843.143137137704, 43880.122397552506, 44557.0, 25961.740382596687, 32771.672283276865, 33589.824356147416, 35190.12024699403, 36280.81859590685, 35224.11939701528, 35370.93887183389, 35980.28039439144, 36422.8178859104, 36790.8160459196, 34064.65935340714, 34361.82819085888, 35062.47406288959, 35275.64724352724, 35555.46666800052, 26107.0, 30226.84886575641, 30452.543211851396, 32271.031869043967, 32528.83735581307, 21462.678059829428, 21599.0, 23430.414239644146, 23632.818359081633, 24162.0], "value": 19359.216736435857, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.7797278918342, 392.9980350098249, 399.8843471741016, 403.16745919675867, 425.4320482156321, 13540.932295338509, 20134.295299664496, 20521.384358469233, 21445.356639300826, 21468.463288417777, 21037.68443473345, 21195.788042119573, 21231.0, 21619.45951351217, 21636.026378812952, 5858.941410585893, 6187.4431301182885, 6189.0, 6194.597351172182, 6208.751649933997, 5814.24414826072, 5979.402059794029, 6006.639601623895, 6079.118527813464, 6101.481374083208, 5906.497947674431, 6010.8797824043495, 6019.759209631609, 6022.488088512459, 6036.275646922353, 5760.567957403212, 5964.314103878044, 5997.070454079625, 6012.96993515034, 6027.306859711145, 5258.789648414059, 5264.92102618461, 5270.446603106657, 5275.683458992435, 5284.180951952453, 24704.876475617686, 25548.744512554822, 25595.488090238276, 25631.615525767127, 26046.609300860502, 2347.6009078456705, 2759.986200069007, 2776.9444611107865, 2778.2359851040924, 2785.373291009527, 15323.387064517407, 15765.290561924741, 15825.971311864692, 16178.948368356138, 16573.585660358465, 1806.9909650451796, 1816.2008716164846, 1840.5766673665132, 1854.0, 1901.847852171823, 125726.37136814257, 127602.0, 129078.3546082273, 131180.0, 131369.0, 9743.756406089762, 10062.647807326855, 10442.68671939843, 10444.529996150191, 10606.57573697059, 12681.809772853414, 12757.681057973625, 12776.936115319364, 14091.718165636836, 14673.77989330161, 6197.628142311386, 8048.637811298506, 8462.957685211657, 8730.646749753798, 8869.778255543662, 8440.83118337642, 8477.0, 8519.233269005696, 8608.268297194683, 8641.395102342902, 4730.314104454835, 4829.541193586604, 4847.297141914402, 4923.384576927884, 4924.926126108111, 1656.8757343199309, 2031.1570698160394, 2043.9080241389174, 2048.1704909511673, 2051.8768873867316, 860.776198188463, 869.3219288954625, 1030.3251370352432, 1031.8091153136693, 1040.328987802863, 20154.0, 20627.896860515903, 21565.0, 21610.45973850635, 21670.13319467235, 1028.7376718936623, 1043.6921108272925, 1047.9790404191874, 1057.8095942730229, 1076.3703233608271, 8923.509206993547, 10844.945775271073, 10956.726081848017, 11240.775184496264, 11313.377764222882, 396891.0, 527773.3611331919, 652115.0, 657074.4292557109, 660022.0, 153569.0, 158741.0, 163416.0, 163718.18140909218, 164865.0, 1072.1476426241156, 1082.5074591061048, 1130.581684776638, 1130.8021096307948, 1132.3602164776876, 19286.13212405417, 19627.70558441653, 19820.70268945938, 19914.402567922985, 20387.18451261933, 50528.74735626298, 53511.1271105525, 58914.0, 58986.705066474395, 60182.0, 60500.697496513996, 85881.57059214664, 87804.0, 88194.55902720445, 88492.5575372119, 8219.630116644646, 8219.738753263204, 8220.0, 8651.95674021626, 8673.219410253107, 9451.763705907133, 13000.674983125498, 13558.593242202749, 13622.455101795817, 14255.572332830032, 11290.43547822622, 11743.530258789895, 12097.939510302393, 12129.393530323625, 12144.210626309261, 10165.13596344319, 11613.419329033684, 11813.586524471602, 11864.940675296568, 12093.03255739521, 10515.316504427188, 11803.691192058966, 11932.0, 12095.455704493495, 12193.817092743438, 8489.830203395773, 8557.700480483401, 8609.91390086091, 8659.263962563253, 8699.695510657097, 10384.636537721144, 11471.770564588829, 11828.994535464237, 11927.343996079951, 12047.096467765128], "value": 9994.0334935207, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1385.7852032934895, 1464.39227720496, 1473.1897456398979, 1492.8731057860082, 1500.0624609618988, 7836.72571459999, 8194.139615340378, 8195.71315003975, 8205.261526462617, 8215.50706957583, 7475.887861682079, 7695.230476952302, 8057.435979481439, 8085.595720213981, 8302.08677045526, 1956.2175129947993, 2302.7697230277004, 2339.6724458575814, 2339.6841426407473, 2344.0858065354523, 2339.5905716499547, 2359.1153317505937, 2363.267387109993, 2367.242482405631, 2370.63255195445, 2313.7339205991275, 2313.8958746856347, 2335.3577766114367, 2335.5795956727784, 2337.263761915, 2261.547690461906, 2280.669302951063, 2292.2206449807145, 2294.541091781642, 2310.4223944013997, 1923.2595450751421, 2285.8399912006166, 2316.0851463671925, 2316.7335756387893, 2317.119494592061, 8025.95987020067, 8201.015878094608, 8215.09633940266, 8216.424850260484, 8217.465864718773, 4968.254761785725, 5127.051495473312, 5127.410347810012, 5128.435872054071, 5136.306598609177, 3235.272063785653, 3314.96685033149, 3433.6738009889023, 3473.11435583927, 3484.5121682964404, 897.4929165021807, 1168.450828110795, 1168.8480497535352, 1211.0432758121074, 1214.5506162719762, 10752.354858708424, 10864.130869530418, 10884.51019704123, 10886.183536234736, 10906.345619262791, 4269.978650106729, 4532.274836026286, 4623.514530974267, 4695.43654761424, 4713.29300604912, 9178.632854685871, 9183.540822958825, 9187.586558604879, 9197.034311397341, 9198.402103863227, 5169.844904652867, 5173.844784656466, 5176.663516871391, 5181.093308670967, 5184.688918664892, 4342.500612429548, 4453.888652783641, 4543.182227199136, 4728.338032675429, 4805.447373552086, 3165.8733650654176, 3759.4247940161076, 3881.165549406891, 3919.9608003919598, 3922.764634121962, 1261.2594619425136, 1268.0806415348798, 1269.9047571431995, 1280.417410078412, 1282.4485471247267, 776.425445170581, 852.2415050604967, 894.1773568317163, 896.3770179725028, 931.6273490603812, 5290.788368465295, 5311.150215965427, 5448.286184702921, 5564.10974244119, 5581.0, 967.1585720423277, 979.1139019187647, 990.1732053735068, 1015.918726501878, 1024.9231307651955, 3554.733394995386, 3708.42519409492, 3822.2546603412625, 3830.3105441020325, 3841.2125514269505, 9879.75300617476, 10107.393556386492, 10214.285000049926, 10238.385696858213, 10238.846417303746, 9457.38526995743, 10134.442605656612, 10136.239782016379, 10146.644867429604, 10147.441890695934, 7577.280158384945, 7874.842503149905, 7877.881831772528, 7881.802954926058, 7894.092179399443, 5257.78968841242, 5428.484293992223, 5617.269754931833, 5658.886822263614, 5673.06394444912, 8748.69379571712, 9137.360384773268, 9154.725358239264, 9160.908390916005, 9254.907450925404, 7630.672644843154, 9302.581218958896, 9324.347295689236, 9332.580033898626, 9468.431894086378, 5568.638038527482, 6845.315468453115, 6918.7232510699005, 7238.963805180941, 7389.187189409268, 7315.085614298213, 7403.481756277009, 7490.775276741707, 8073.555954422563, 8173.18268173178, 7144.4998850082075, 7232.240614735377, 7268.854622907406, 7294.379977701955, 7380.372668323253, 5834.94165058344, 7052.294770522906, 7071.292870712888, 7227.457940654367, 7296.963515182602, 6377.585456945284, 6410.326915673973, 6456.063870738811, 6483.643399613066, 6496.155499785186, 4478.79845406964, 4728.290756386569, 4936.3089167515855, 4974.7512624369365, 5046.293518907282, 4884.291777692286, 4896.6572339935865, 4996.2505624156665, 5053.772580233972, 5088.720120393414], "value": 4382.304300556364, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.1709206450551, 359.29936623584, 361.08645127826605, 379.43085371942107, 379.93351163546373, 4053.5946405359523, 4135.524414692311, 5164.6384753067305, 5246.947530524693, 5434.646747961385, 4554.2713165893465, 4701.918558731494, 5163.0, 5197.584193264539, 5303.0, 4142.275101857178, 4148.605882441163, 4148.605882441178, 4152.6055024772595, 4166.812493437795, 3449.9132773176493, 3742.5696044954907, 4143.564925682806, 4172.70791044627, 4189.329707246841, 4042.9797851010703, 4072.1448495815916, 4092.9386059209137, 4108.28105081611, 4169.72896761711, 3914.706397020206, 4081.2449696806184, 4091.365838295069, 4101.610347017028, 4112.3625837995005, 3403.9319213615836, 3451.516787649731, 3598.442241452553, 3656.3053019926397, 3688.428293614494, 4488.454121244213, 4781.976090119562, 4816.301636262758, 5142.3829140503, 5207.687538747649, 4108.637533418267, 4620.930686039678, 4739.724932032644, 4780.498047704976, 4791.976040119777, 4413.668974826901, 4650.697804614713, 5200.0, 5443.564514838803, 5562.916556251619, 3873.2447172801317, 3912.18561902146, 3945.993771588255, 3960.1683646434285, 4006.419069234945, 4952.504749525055, 5804.680742559158, 5836.789765628887, 5879.353271140171, 5888.793892213795, 4024.396340548941, 4065.8576949806616, 4087.734297270668, 4088.141490287073, 4093.4269202311702, 3498.8950331490096, 3588.0132963435262, 4098.262312783728, 4113.424120623115, 4133.689973251958, 4089.91820163601, 4143.544210136883, 4229.175310814423, 4538.549183440971, 4600.4479462464715, 5138.019948429902, 5143.3570803649545, 5649.3337861324035, 5675.871548169436, 5684.8294551163535, 1099.4722533184117, 1188.8395066666062, 1198.5864876617552, 1216.2425295447993, 1220.6277085488834, 786.5398741736034, 830.7881490220076, 835.0522157351328, 836.7573403712855, 838.379599096664, 4713.481517033124, 4840.2255639097575, 4875.122477953932, 4880.341153944243, 4969.527894849984, 4661.26230457439, 5096.694198348111, 5366.248725178478, 5414.751149310461, 5493.340799104053, 3986.7009974252046, 4977.8302099006705, 4991.105159007767, 4993.101241776515, 5003.3495645565845, 2588.479667651992, 2644.0349272515778, 2845.331347133422, 2876.6404199475064, 2881.9567706484418, 4812.590929770939, 4889.63327750413, 5308.010470158039, 5690.748035432198, 5737.827865164052, 4386.017508094463, 4923.803047878117, 5032.144535428986, 5221.973890130525, 5582.54853738031, 5272.103742363731, 5496.862578435491, 5536.176549959549, 5642.71786410686, 5676.858078547987, 5346.572274217975, 5396.21754845553, 5458.670211171262, 5469.960707465569, 5768.711564421846, 5054.570361519312, 5744.569157313302, 5745.626534275259, 5745.741441635053, 5764.250647415809, 5147.830257491444, 5826.854328641818, 5957.851053723518, 6022.397760223943, 6042.516598672184, 2903.2596687844466, 3551.698105661048, 3791.1659434924272, 3821.808909554567, 3826.234753049457, 5735.0, 5754.482096611325, 5780.104083867007, 5788.0, 5828.271466066742, 4594.402727645384, 4748.92876606858, 5598.656322482656, 5620.688449415264, 5641.717914104361, 5009.774560144875, 5153.871153221199, 5232.947670523246, 5627.746751396279, 5647.3505546861, 4536.298887917031, 4547.840825571089, 5382.138857782736, 5398.379186393615, 5490.890182196414, 4483.484399294123, 4483.775811209362, 4742.549457801503, 5466.01611709896, 5503.3120859892515, 5043.638217681132, 5484.369297530835, 5506.256655351476, 5506.944930550643, 5514.255575497256], "value": 4015.6018129704285, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.642178910545, 731.04233454175, 756.8183635927377, 773.8993930788996, 820.6758330459469, 14996.175210363426, 15811.84188158118, 15839.762403563956, 15846.762298565516, 15862.603434914134, 14579.37571237177, 14766.483173088944, 14772.556823295292, 14774.335154918028, 14774.778378324334, 681.2506243132564, 703.1281211297979, 706.6819931031031, 867.3278209387712, 880.102295658428, 826.2233500509502, 855.6577369052397, 880.4101252161036, 888.7467071884514, 890.8262888736699, 937.8499440089587, 941.1012483078644, 941.6986564299427, 941.9717408477723, 943.8489841625342, 932.673564252513, 933.6358820060148, 933.7385532051037, 933.9766505837408, 935.1583574782682, 534.3747815056394, 553.8947599955995, 672.4889084295921, 685.9314068593101, 696.554205308603, 14894.180820054893, 15310.234488275542, 15367.308471118826, 15387.307571159212, 15392.846071539365, 11819.586314478953, 13468.461261549526, 13551.932240338736, 13640.522581709592, 13720.519781807589, 12460.376981150906, 12536.233332666985, 12539.0, 12577.182483138567, 12661.556845510362, 4430.9556904430865, 4474.619657329098, 4485.820567177309, 4529.275315949432, 4684.765761711935, 96941.03058969391, 96948.51525742326, 100532.49733751357, 100912.49543752235, 101100.0, 8925.910740892637, 10780.51487683056, 10804.297720648132, 10912.618058368078, 11257.380844053656, 21183.714277229352, 21350.35948921535, 21392.358229253146, 21523.784762152492, 21585.24451644185, 7352.485326027127, 7503.7748867534065, 7536.434767392468, 7581.469297149257, 7655.540667559964, 3617.366960781853, 4067.1255680028935, 4201.243776120327, 4241.321388577812, 4251.532331443539, 3403.7957722536726, 3475.600305964796, 3496.0910163357203, 3514.648535146465, 3519.454484554898, 637.346719612401, 638.658317799984, 643.9935600644027, 652.1587152573128, 655.6525041727892, 640.1358166475314, 643.5527308520627, 645.0743183531647, 654.2737561306946, 656.701200953565, 8299.419040667095, 9006.81305068826, 9471.526423678788, 9724.513774311255, 9759.316847820726, 612.1888497740512, 613.9079138129316, 670.6646676661669, 672.3008071605573, 680.6358598149966, 4534.161180181677, 4632.351470794091, 4639.976800115978, 4642.65180111493, 4699.2481203007355, 82546.0, 105258.0, 106107.87784244271, 106896.46551767191, 108203.0, 64739.35260647333, 74238.25761742314, 74510.0, 80707.59646201848, 95247.0, 69659.65170174219, 72193.55612887818, 72875.63562182155, 73022.0, 74964.25035749681, 10284.588616455558, 10389.324693894872, 11107.056265153404, 11178.776424471627, 11397.316161030365, 40318.39522407225, 47688.52311476841, 49511.50488495213, 51554.0, 51571.22643160431, 63702.0, 64391.390215244995, 65221.673891630235, 68347.31652683609, 70675.29324706687, 13123.803142952673, 13266.270355130175, 13407.463701452223, 13654.180749155083, 13794.65513362174, 14458.638534036732, 15015.474458393905, 15112.773308400603, 15264.847351526787, 15791.0, 11030.28303160292, 13660.521881734092, 13873.930630346784, 14029.789553156916, 14574.125552466461, 13629.454821807016, 14038.719225615634, 14051.227182505061, 14092.436302547783, 14092.647683807987, 13621.0, 13669.863301366859, 13830.446782128602, 13865.86134138686, 14413.13521188732, 7920.683172673029, 10583.206259530412, 10681.946590266998, 11098.50056747432, 11458.312501249951, 10035.397876127456, 10333.896661033294, 10394.948025259826, 10396.948015259875, 10452.216083793593], "value": 7438.564558929509, "unit": "score"}], "name": "dromaeo_css", "value": 7232.842701357467, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0, 114.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 110.0, 109.0, 145.0, 111.0, 143.0, 144.0, 140.0, 130.0, 111.0], "value": 128.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 187.0, 183.0, 186.0, 182.0, 185.0, 180.0, 194.0, 261.0, 184.0], "value": 192.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 86.0, 61.0, 61.0, 74.0, 49.0, 75.0, 48.0], "value": 65.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 85.0, 69.0, 67.0, 70.0, 83.0, 68.0, 69.0, 83.0], "value": 75.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 118.0, 87.0, 86.0, 85.0, 85.0, 87.0, 84.0, 86.0, 84.0], "value": 89.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 97.0, 97.0, 89.0, 131.0, 95.0, 97.0, 93.0, 93.0], "value": 97.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 85.0, 86.0, 86.0, 85.0, 84.0, 85.0, 88.0, 85.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 53.0, 55.0, 77.0, 87.0, 87.0, 81.0, 56.0, 55.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 73.0, 77.0, 72.0, 71.0, 71.0, 71.0, 70.0, 70.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 86.0, 102.0, 108.0, 107.0, 82.0, 85.0, 85.0, 105.0], "value": 93.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 141.0, 137.0, 140.0, 141.0, 140.0, 141.0, 141.0, 181.0, 139.0], "value": 144.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [224.0, 249.0, 189.0, 172.0, 172.0, 171.0, 173.0, 173.0, 181.0, 171.0], "value": 187.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 68.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1477.5, "alertThreshold": 2.0}]} 11:10:36 INFO - Return code: 0 11:10:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:10:36 ERROR - # TBPL SUCCESS # 11:10:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:10:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:10:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:10:36 INFO - 2017-01-13 11:10:36.936 screenresolution[1657:9775] starting screenresolution argv=screenresolution get 11:10:36 INFO - 2017-01-13 11:10:36.939 screenresolution[1657:9775] Display 0: 1600x1200x32@60 11:10:36 INFO - 2017-01-13 11:10:36.945 screenresolution[1658:9778] starting screenresolution argv=screenresolution list 11:10:36 INFO - Available Modes on Display 0 11:10:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:10:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:10:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:10:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:10:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:10:37 INFO - Intel Iris: 11:10:37 INFO - Chipset Model: Intel Iris 11:10:37 INFO - Type: GPU 11:10:37 INFO - Bus: Built-In 11:10:37 INFO - VRAM (Dynamic, Max): 1536 MB 11:10:37 INFO - Vendor: Intel (0x8086) 11:10:37 INFO - Device ID: 0x0a2e 11:10:37 INFO - Revision ID: 0x0009 11:10:37 INFO - Displays: 11:10:37 INFO - Display: 11:10:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:10:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:10:37 INFO - Display Serial Number: 1600x1200 60 11:10:37 INFO - Main Display: Yes 11:10:37 INFO - Mirror: Off 11:10:37 INFO - Online: Yes 11:10:37 INFO - Rotation: Supported 11:10:37 INFO - Return code: 0 11:10:37 INFO - Running post-action listener: _resource_record_post_action 11:10:37 INFO - [mozharness: 2017-01-13 19:10:37.181399Z] Finished run-tests step (success) 11:10:37 INFO - Running post-run listener: _resource_record_post_run 11:10:37 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 39736320; Write bytes: 550816256; Read time: 393; Write time: 1966 11:10:37 INFO - TinderboxPrint: CPU usage
53.6% 11:10:37 INFO - TinderboxPrint: I/O read bytes / time
39,736,320 / 393 11:10:37 INFO - TinderboxPrint: I/O write bytes / time
550,816,256 / 1,966 11:10:37 INFO - TinderboxPrint: CPU idle
2,228.0 (46.4%) 11:10:37 INFO - TinderboxPrint: CPU system
960.3 (20.0%) 11:10:37 INFO - TinderboxPrint: CPU user
1,613.3 (33.6%) 11:10:37 INFO - TinderboxPrint: Swap in / out
290,369,536 / 0 11:10:37 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 250040832; Write bytes: 242331648; Read time: 18032; Write time: 430 11:10:37 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 35275776; Write bytes: 294827008; Read time: 360; Write time: 1481 11:10:37 INFO - Running post-run listener: _upload_blobber_files 11:10:37 INFO - Blob upload gear active. 11:10:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:10:37 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:10:37 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'] 11:10:37 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 11:10:38 INFO - (blobuploader) - INFO - Open directory for files ... 11:10:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:10:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:10:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:10:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:10:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:10:39 INFO - (blobuploader) - INFO - Done attempting. 11:10:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:10:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:10:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:10:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:10:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:10:40 INFO - (blobuploader) - INFO - Done attempting. 11:10:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:10:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:10:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:10:41 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:10:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:10:41 INFO - (blobuploader) - INFO - Done attempting. 11:10:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:10:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:10:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:10:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:10:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:10:43 INFO - (blobuploader) - INFO - Done attempting. 11:10:43 INFO - (blobuploader) - INFO - Iteration through files over. 11:10:43 INFO - Return code: 0 11:10:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:10:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:10:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4c3211d6b7911f27c77993e5e19639272edd9b6964798199aa1552e3e7edc9ed6ce7f8c1cd2d2956e710112ec940eb401e37925e9e900922a388091eee2cb599", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/26ac8c6d82fa19b61220d6371865ed07643273d03d5e92b665f2b1eed448494a0634447bef0477afbdb1f5c430aaaa0503669d3afdefa4c8fe9aea647e20a139", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/745fbf908b6d58eb46fcfb8e88918d94a224159b883af8287840306e65899900d0baccac586dd7e9e6be852e5049f055b151e5ffa4227940347fe1ec8cebf1f4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7858e0f65293dfe3c5529b14c54bbcaf254c36234c237065bc3fe3274c945ce1db6ded5c7cc99f94fa3506aba491d3d5e683f2217566482c8dd902832dc1349c"} 11:10:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:10:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:10:43 INFO - Contents: 11:10:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4c3211d6b7911f27c77993e5e19639272edd9b6964798199aa1552e3e7edc9ed6ce7f8c1cd2d2956e710112ec940eb401e37925e9e900922a388091eee2cb599", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/26ac8c6d82fa19b61220d6371865ed07643273d03d5e92b665f2b1eed448494a0634447bef0477afbdb1f5c430aaaa0503669d3afdefa4c8fe9aea647e20a139", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/745fbf908b6d58eb46fcfb8e88918d94a224159b883af8287840306e65899900d0baccac586dd7e9e6be852e5049f055b151e5ffa4227940347fe1ec8cebf1f4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7858e0f65293dfe3c5529b14c54bbcaf254c36234c237065bc3fe3274c945ce1db6ded5c7cc99f94fa3506aba491d3d5e683f2217566482c8dd902832dc1349c"} 11:10:43 INFO - Running post-run listener: copy_logs_to_upload_dir 11:10:43 INFO - Copying logs to upload dir... 11:10:43 INFO - mkdir: /builds/slave/test/build/upload/logs 11:10:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.556684 ========= master_lag: 1.21 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-13 11:10:44.766920) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-13 11:10:44.770178) ========= 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.vZ7A5qJbZO/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.qvNpzu0jCc/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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/4c3211d6b7911f27c77993e5e19639272edd9b6964798199aa1552e3e7edc9ed6ce7f8c1cd2d2956e710112ec940eb401e37925e9e900922a388091eee2cb599", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/26ac8c6d82fa19b61220d6371865ed07643273d03d5e92b665f2b1eed448494a0634447bef0477afbdb1f5c430aaaa0503669d3afdefa4c8fe9aea647e20a139", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/745fbf908b6d58eb46fcfb8e88918d94a224159b883af8287840306e65899900d0baccac586dd7e9e6be852e5049f055b151e5ffa4227940347fe1ec8cebf1f4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7858e0f65293dfe3c5529b14c54bbcaf254c36234c237065bc3fe3274c945ce1db6ded5c7cc99f94fa3506aba491d3d5e683f2217566482c8dd902832dc1349c"} build_url:https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010596 build_url: 'https://queue.taskcluster.net/v1/task/ebpzXVwERKavorHPOmsROg/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/4c3211d6b7911f27c77993e5e19639272edd9b6964798199aa1552e3e7edc9ed6ce7f8c1cd2d2956e710112ec940eb401e37925e9e900922a388091eee2cb599", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/26ac8c6d82fa19b61220d6371865ed07643273d03d5e92b665f2b1eed448494a0634447bef0477afbdb1f5c430aaaa0503669d3afdefa4c8fe9aea647e20a139", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/745fbf908b6d58eb46fcfb8e88918d94a224159b883af8287840306e65899900d0baccac586dd7e9e6be852e5049f055b151e5ffa4227940347fe1ec8cebf1f4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7858e0f65293dfe3c5529b14c54bbcaf254c36234c237065bc3fe3274c945ce1db6ded5c7cc99f94fa3506aba491d3d5e683f2217566482c8dd902832dc1349c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-13 11:10:44.805106) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 11:10:44.805430) ========= 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.vZ7A5qJbZO/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.qvNpzu0jCc/Listeners TMPDIR=/var/folders/2d/l2dyrh5107v305_74qp5tzp400000w/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.004401 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 11:10:44.853667) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-13 11:10:44.853989) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-13 11:10:44.854309) ========= ========= Total master_lag: 1.35 =========