builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0190 starttime: 1481701881.03 results: success (0) buildid: 20161213224300 builduid: 61996c948c9d460dae5804d397a5e33a revision: 2299de9e58d7e1f615ecbcfed041052f91cf8e07 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-13 23:51:21.028060) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-13 23:51:21.028500) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-13 23:51:21.028828) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-13 23:51:21.055036) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 23:51:21.055451) ========= 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.ZFTnPWGBHg/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.aqBlkXj72W/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-13 23:51:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 117M=0s 2016-12-13 23:51:21 (117 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124619 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 23:51:21.203975) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 23:51:21.207312) ========= 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.ZFTnPWGBHg/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.aqBlkXj72W/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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.027921 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 23:51:21.256794) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 23:51:21.257163) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 2299de9e58d7e1f615ecbcfed041052f91cf8e07 --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 2299de9e58d7e1f615ecbcfed041052f91cf8e07 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZFTnPWGBHg/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.aqBlkXj72W/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-13 23:51:21,354 truncating revision to first 12 chars 2016-12-13 23:51:21,354 Setting DEBUG logging. 2016-12-13 23:51:21,354 attempt 1/10 2016-12-13 23:51:21,354 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/2299de9e58d7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-13 23:51:21,985 unpacking tar archive at: graphics-2299de9e58d7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.920899 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 23:51:22.204929) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-13 23:51:22.205253) ========= script_repo_revision: 2299de9e58d7e1f615ecbcfed041052f91cf8e07 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-13 23:51:22.208684) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-13 23:51:22.208957) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-13 23:51:22.228737) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-12-13 23:51:22.229257) ========= /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.ZFTnPWGBHg/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.aqBlkXj72W/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 23:51:22 INFO - MultiFileLogger online at 20161213 23:51:22 in /builds/slave/test 23:51:22 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 23:51:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:51:22 INFO - {'append_to_log': False, 23:51:22 INFO - 'base_work_dir': '/builds/slave/test', 23:51:22 INFO - 'blob_upload_branch': 'Graphics', 23:51:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:51:22 INFO - 'branch': 'Graphics', 23:51:22 INFO - 'buildbot_json_path': 'buildprops.json', 23:51:22 INFO - 'config_files': ('talos/mac_config.py',), 23:51:22 INFO - 'default_actions': ('clobber', 23:51:22 INFO - 'read-buildbot-config', 23:51:22 INFO - 'download-and-extract', 23:51:22 INFO - 'populate-webroot', 23:51:22 INFO - 'create-virtualenv', 23:51:22 INFO - 'install', 23:51:22 INFO - 'run-tests'), 23:51:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:51:22 INFO - 'download_minidump_stackwalk': True, 23:51:22 INFO - 'download_symbols': 'ondemand', 23:51:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:51:22 INFO - 'tooltool.py': '/tools/tooltool.py', 23:51:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:51:22 INFO - '/tools/misc-python/virtualenv.py')}, 23:51:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:51:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:51:22 INFO - 'installer_path': 'installer.exe', 23:51:22 INFO - 'log_level': 'info', 23:51:22 INFO - 'log_name': 'talos', 23:51:22 INFO - 'log_to_console': True, 23:51:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:51:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:51:22 INFO - 'opt_config_files': (), 23:51:22 INFO - 'pip_index': False, 23:51:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:51:22 INFO - 'cmd': ('bash', 23:51:22 INFO - '-c', 23:51:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:51:22 INFO - 'enabled': True, 23:51:22 INFO - 'halt_on_failure': False, 23:51:22 INFO - 'name': 'check_screen_resolution'},), 23:51:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:51:22 INFO - 'cmd': ('bash', 23:51:22 INFO - '-c', 23:51:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:51:22 INFO - 'enabled': True, 23:51:22 INFO - 'halt_on_failure': False, 23:51:22 INFO - 'name': 'check_screen_resolution'},), 23:51:22 INFO - 'run_cmd_checks_enabled': True, 23:51:22 INFO - 'sps_profile': False, 23:51:22 INFO - 'sps_profile_interval': 0, 23:51:22 INFO - 'suite': 'dromaeojs', 23:51:22 INFO - 'system_bits': '32', 23:51:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:51:22 INFO - 'title': 't-yosemite-r7-0190', 23:51:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:51:22 INFO - 'use_talos_json': True, 23:51:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:51:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:51:22 INFO - 'work_dir': 'build'} 23:51:22 INFO - [mozharness: 2016-12-14 07:51:22.438540Z] Running clobber step. 23:51:22 INFO - Running pre-action listener: _resource_record_pre_action 23:51:22 INFO - Running main action method: clobber 23:51:22 INFO - rmtree: /builds/slave/test/build 23:51:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:51:24 INFO - Running post-action listener: _resource_record_post_action 23:51:24 INFO - [mozharness: 2016-12-14 07:51:24.933900Z] Finished clobber step (success) 23:51:24 INFO - [mozharness: 2016-12-14 07:51:24.934053Z] Running read-buildbot-config step. 23:51:24 INFO - Running pre-action listener: _resource_record_pre_action 23:51:24 INFO - Running main action method: read_buildbot_config 23:51:24 INFO - Using buildbot properties: 23:51:24 INFO - { 23:51:24 INFO - "project": "", 23:51:24 INFO - "product": "firefox", 23:51:24 INFO - "script_repo_revision": "default", 23:51:24 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 23:51:24 INFO - "repository": "", 23:51:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 23:51:24 INFO - "buildid": "20161213224300", 23:51:24 INFO - "pgo_build": "False", 23:51:24 INFO - "basedir": "/builds/slave/test", 23:51:24 INFO - "buildnumber": 2, 23:51:24 INFO - "slavename": "t-yosemite-r7-0190", 23:51:24 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 23:51:24 INFO - "platform": "yosemite_r7", 23:51:24 INFO - "scheduler": "tests-graphics-macosx64-talos", 23:51:24 INFO - "branch": "graphics", 23:51:24 INFO - "repo_path": "projects/graphics", 23:51:24 INFO - "revision": "2299de9e58d7e1f615ecbcfed041052f91cf8e07", 23:51:24 INFO - "stage_platform": "macosx64", 23:51:24 INFO - "builduid": "61996c948c9d460dae5804d397a5e33a", 23:51:24 INFO - "slavebuilddir": "test" 23:51:24 INFO - } 23:51:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/Get9xO1OSOewX46E8ZVKQg/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg. 23:51:24 INFO - Running post-action listener: _resource_record_post_action 23:51:24 INFO - [mozharness: 2016-12-14 07:51:24.937349Z] Finished read-buildbot-config step (success) 23:51:24 INFO - [mozharness: 2016-12-14 07:51:24.937464Z] Running download-and-extract step. 23:51:24 INFO - Running pre-action listener: _resource_record_pre_action 23:51:24 INFO - Running main action method: download_and_extract 23:51:24 INFO - mkdir: /builds/slave/test/build/tests 23:51: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')]} 23:51:24 INFO - trying https://queue.taskcluster.net/v1/task/Get9xO1OSOewX46E8ZVKQg/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json 23:51:24 INFO - Downloading https://queue.taskcluster.net/v1/task/Get9xO1OSOewX46E8ZVKQg/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json 23:51:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Get9xO1OSOewX46E8ZVKQg/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json'}, attempt #1 23:51:25 INFO - Downloaded 1235 bytes. 23:51:25 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json 23:51:25 INFO - Using the following test package requirements: 23:51:25 INFO - {u'common': [u'firefox-53.0a1.en-US.mac64.common.tests.zip'], 23:51:25 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 23:51:25 INFO - u'firefox-53.0a1.en-US.mac64.cppunittest.tests.zip'], 23:51:25 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 23:51:25 INFO - u'firefox-53.0a1.en-US.mac64.gtest.tests.zip'], 23:51:25 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 23:51:25 INFO - u'jsshell-mac64.zip'], 23:51:25 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 23:51:25 INFO - u'firefox-53.0a1.en-US.mac64.mochitest.tests.zip'], 23:51:25 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac64.common.tests.zip'], 23:51:25 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 23:51:25 INFO - u'firefox-53.0a1.en-US.mac64.reftest.tests.zip'], 23:51:25 INFO - u'talos': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 23:51:25 INFO - u'firefox-53.0a1.en-US.mac64.talos.tests.zip'], 23:51:25 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 23:51:25 INFO - u'firefox-53.0a1.en-US.mac64.web-platform.tests.zip'], 23:51:25 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 23:51:25 INFO - u'firefox-53.0a1.en-US.mac64.xpcshell.tests.zip']} 23:51:25 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac64.common.tests.zip'] for test suite category: common 23:51:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Get9xO1OSOewX46E8ZVKQg/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip 23:51:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Get9xO1OSOewX46E8ZVKQg/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip'}, attempt #1 23:51:25 INFO - Fetch https://queue.taskcluster.net/v1/task/Get9xO1OSOewX46E8ZVKQg/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip into memory 23:51:26 INFO - Expected file size: 16276147 23:51:26 INFO - Obtained file size: 16276147 23:51:33 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac64.common.tests.zip', u'firefox-53.0a1.en-US.mac64.talos.tests.zip'] for test suite category: talos 23:51:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Get9xO1OSOewX46E8ZVKQg/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip 23:51:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Get9xO1OSOewX46E8ZVKQg/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip'}, attempt #1 23:51:33 INFO - Fetch https://queue.taskcluster.net/v1/task/Get9xO1OSOewX46E8ZVKQg/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip into memory 23:51:34 INFO - Expected file size: 16276147 23:51:34 INFO - Obtained file size: 16276147 23:51:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Get9xO1OSOewX46E8ZVKQg/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip 23:51:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Get9xO1OSOewX46E8ZVKQg/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip'}, attempt #1 23:51:40 INFO - Fetch https://queue.taskcluster.net/v1/task/Get9xO1OSOewX46E8ZVKQg/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip into memory 23:51:41 INFO - Expected file size: 14409734 23:51:41 INFO - Obtained file size: 14409734 23:51:41 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')]} 23:51:41 INFO - trying https://queue.taskcluster.net/v1/task/Get9xO1OSOewX46E8ZVKQg/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 23:51:41 INFO - Downloading https://queue.taskcluster.net/v1/task/Get9xO1OSOewX46E8ZVKQg/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg 23:51:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Get9xO1OSOewX46E8ZVKQg/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg'}, attempt #1 23:51:44 INFO - Downloaded 69754696 bytes. 23:51:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Get9xO1OSOewX46E8ZVKQg/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 23:51:44 INFO - mkdir: /builds/slave/test/properties 23:51:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:51:44 INFO - Writing to file /builds/slave/test/properties/build_url 23:51:44 INFO - Contents: 23:51:44 INFO - build_url:https://queue.taskcluster.net/v1/task/Get9xO1OSOewX46E8ZVKQg/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 23:51:44 INFO - Running post-action listener: _resource_record_post_action 23:51:44 INFO - Running post-action listener: set_extra_try_arguments 23:51:44 INFO - [mozharness: 2016-12-14 07:51:44.708957Z] Finished download-and-extract step (success) 23:51:44 INFO - [mozharness: 2016-12-14 07:51:44.709078Z] Running populate-webroot step. 23:51:44 INFO - Running pre-action listener: _resource_record_pre_action 23:51:44 INFO - Running main action method: populate_webroot 23:51:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:51:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:51:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:51:44 INFO - '--tppagecycles', 23:51:44 INFO - '7'], 23:51:44 INFO - 'tests': ['tsvgm']}}, 23:51:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:51:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:51:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:51:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:51:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:51:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:51:44 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 23:51:44 INFO - 'talos_options': ['--disable-e10s'], 23:51:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:51:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 23:51:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:51:44 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 23:51:44 INFO - 'talos_options': ['--disable-e10s'], 23:51:44 INFO - 'tests': ['damp', 'tps']}, 23:51:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 23:51:44 INFO - 'tests': ['damp', 'tps']}, 23:51:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:51:44 INFO - 'tests': ['dromaeo_dom']}, 23:51:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:51:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:51:44 INFO - 'tests': ['basic_compositor_video']}, 23:51:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:51:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:51:44 INFO - 'tests': ['a11yr', 23:51:44 INFO - 'ts_paint', 23:51:44 INFO - 'tpaint', 23:51:44 INFO - 'sessionrestore', 23:51:44 INFO - 'sessionrestore_no_auto_restore', 23:51:44 INFO - 'tabpaint']}, 23:51:44 INFO - 'other-e10s': {'tests': ['a11yr', 23:51:44 INFO - 'ts_paint', 23:51:44 INFO - 'tpaint', 23:51:44 INFO - 'sessionrestore', 23:51:44 INFO - 'sessionrestore_no_auto_restore', 23:51:44 INFO - 'tabpaint']}, 23:51:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:51:44 INFO - 'ts_paint', 23:51:44 INFO - 'tpaint', 23:51:44 INFO - 'sessionrestore', 23:51:44 INFO - 'sessionrestore_no_auto_restore', 23:51:44 INFO - 'tabpaint']}, 23:51:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:51:44 INFO - 'ts_paint', 23:51:44 INFO - 'tpaint', 23:51:44 INFO - 'sessionrestore', 23:51:44 INFO - 'sessionrestore_no_auto_restore', 23:51:44 INFO - 'tabpaint']}, 23:51:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:51:44 INFO - 'tests': ['a11yr', 23:51:44 INFO - 'ts_paint', 23:51:44 INFO - 'tpaint', 23:51:44 INFO - 'sessionrestore', 23:51:44 INFO - 'sessionrestore_no_auto_restore', 23:51:44 INFO - 'tabpaint']}, 23:51:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:51:44 INFO - 'tests': ['a11yr', 23:51:44 INFO - 'ts_paint', 23:51:44 INFO - 'tpaint', 23:51:44 INFO - 'sessionrestore', 23:51:44 INFO - 'sessionrestore_no_auto_restore', 23:51:44 INFO - 'tabpaint']}, 23:51:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:51:44 INFO - 'tests': ['tsvgx', 23:51:44 INFO - 'tsvgr_opacity', 23:51:44 INFO - 'tart', 23:51:44 INFO - 'tscrollx', 23:51:44 INFO - 'cart', 23:51:44 INFO - 'tsvg_static']}, 23:51:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:51:44 INFO - 'tsvgr_opacity', 23:51:44 INFO - 'tart', 23:51:44 INFO - 'tscrollx', 23:51:44 INFO - 'cart', 23:51:44 INFO - 'tsvg_static']}, 23:51:44 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 23:51:44 INFO - 'talos_options': ['--disable-e10s'], 23:51:44 INFO - 'tests': ['tp5o']}, 23:51:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 23:51:44 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 23:51:44 INFO - 'talos_options': ['--disable-e10s', 23:51:44 INFO - '--xperf_path', 23:51:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:51:44 INFO - 'tests': ['tp5n']}, 23:51:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 23:51:44 INFO - 'talos_options': ['--xperf_path', 23:51:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:51:44 INFO - 'tests': ['tp5n']}}, 23:51:44 INFO - 'talos.zip': {'path': '', 23:51:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:51:44 INFO - Running post-action listener: _resource_record_post_action 23:51:44 INFO - [mozharness: 2016-12-14 07:51:44.726978Z] Finished populate-webroot step (success) 23:51:44 INFO - [mozharness: 2016-12-14 07:51:44.727119Z] Running create-virtualenv step. 23:51:44 INFO - Running pre-action listener: _resource_record_pre_action 23:51:44 INFO - Running main action method: create_virtualenv 23:51:44 INFO - Creating virtualenv /builds/slave/test/build/venv 23:51:44 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 23:51:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:51:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:51:44 INFO - Using real prefix '/tools/python27' 23:51:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:51:45 INFO - Installing distribute.............................................................................................................................................................................................done. 23:51:48 INFO - Installing pip.................done. 23:51:48 INFO - Return code: 0 23:51:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:51:48 INFO - Reading from file tmpfile_stdout 23:51:48 INFO - Output received: 23:51:48 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) 23:51:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:51:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:51:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:51:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:48 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 0x108f853f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108efb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc31570a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d9ad30>, '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 0x108c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d92b20>, '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.ZFTnPWGBHg/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.aqBlkXj72W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 23:51:48 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 23:51:48 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 23:51:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZFTnPWGBHg/Render', 23:51:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:51:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:51:48 INFO - 'HOME': '/Users/cltbld', 23:51:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:51:48 INFO - 'LOGNAME': 'cltbld', 23:51:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:51:48 INFO - 'MOZ_NO_REMOTE': '1', 23:51:48 INFO - 'NO_EM_RESTART': '1', 23:51:48 INFO - 'PAGER': '/bin/cat', 23:51:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:51:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:51:48 INFO - 'PWD': '/builds/slave/test', 23:51:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:51:48 INFO - 'SHELL': '/bin/bash', 23:51:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aqBlkXj72W/Listeners', 23:51:48 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 23:51:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:51:48 INFO - 'USER': 'cltbld', 23:51:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:51:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:51:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:51:48 INFO - 'XPC_FLAGS': '0x0', 23:51:48 INFO - 'XPC_SERVICE_NAME': '0', 23:51:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:51:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:51:48 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 23:51:48 INFO - Cleaning up... 23:51:48 INFO - Return code: 0 23:51:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:51:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:51:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:51:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:48 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 0x108f853f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108efb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc31570a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d9ad30>, '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 0x108c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d92b20>, '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.ZFTnPWGBHg/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.aqBlkXj72W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 23:51:48 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 23:51:48 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 23:51:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZFTnPWGBHg/Render', 23:51:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:51:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:51:48 INFO - 'HOME': '/Users/cltbld', 23:51:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:51:48 INFO - 'LOGNAME': 'cltbld', 23:51:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:51:48 INFO - 'MOZ_NO_REMOTE': '1', 23:51:48 INFO - 'NO_EM_RESTART': '1', 23:51:48 INFO - 'PAGER': '/bin/cat', 23:51:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:51:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:51:48 INFO - 'PWD': '/builds/slave/test', 23:51:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:51:48 INFO - 'SHELL': '/bin/bash', 23:51:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aqBlkXj72W/Listeners', 23:51:48 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 23:51:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:51:48 INFO - 'USER': 'cltbld', 23:51:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:51:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:51:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:51:48 INFO - 'XPC_FLAGS': '0x0', 23:51:48 INFO - 'XPC_SERVICE_NAME': '0', 23:51:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:51:49 INFO - Downloading/unpacking psutil>=3.1.1 23:51:49 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 23:51:49 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 23:51:49 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 23:51:49 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 23:51:49 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 23:51:49 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 23:51:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:51:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:51:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:51:52 INFO - Installing collected packages: psutil 23:51:52 INFO - Running setup.py install for psutil 23:51:52 INFO - building 'psutil._psutil_osx' extension 23:51:52 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 23:51:53 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 23:51:53 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 23:51:53 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 23:51:53 INFO - building 'psutil._psutil_posix' extension 23:51:53 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 23:51:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:51:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:51:53 INFO - ^ 23:51:53 INFO - 1 warning generated. 23:51:53 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 23:51:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:51:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:51:53 INFO - Successfully installed psutil 23:51:53 INFO - Cleaning up... 23:51:53 INFO - Return code: 0 23:51:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:51:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:51:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108f853f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108efb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc31570a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d9ad30>, '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 0x108c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d92b20>, '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.ZFTnPWGBHg/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.aqBlkXj72W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 23:51:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:51:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:51:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZFTnPWGBHg/Render', 23:51:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:51:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:51:53 INFO - 'HOME': '/Users/cltbld', 23:51:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:51:53 INFO - 'LOGNAME': 'cltbld', 23:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:51:53 INFO - 'MOZ_NO_REMOTE': '1', 23:51:53 INFO - 'NO_EM_RESTART': '1', 23:51:53 INFO - 'PAGER': '/bin/cat', 23:51:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:51:53 INFO - 'PWD': '/builds/slave/test', 23:51:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:51:53 INFO - 'SHELL': '/bin/bash', 23:51:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aqBlkXj72W/Listeners', 23:51:53 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 23:51:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:51:53 INFO - 'USER': 'cltbld', 23:51:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:51:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:51:53 INFO - 'XPC_FLAGS': '0x0', 23:51:53 INFO - 'XPC_SERVICE_NAME': '0', 23:51:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:51:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:51:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:51:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:51:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:51:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:51:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:51:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:51:56 INFO - Installing collected packages: mozsystemmonitor 23:51:56 INFO - Running setup.py install for mozsystemmonitor 23:51:56 INFO - Successfully installed mozsystemmonitor 23:51:56 INFO - Cleaning up... 23:51:56 INFO - Return code: 0 23:51:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:51:56 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')]} 23:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:51:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:56 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')]} 23:51:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:51:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:56 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 0x108f853f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108efb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc31570a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d9ad30>, '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 0x108c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d92b20>, '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.ZFTnPWGBHg/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.aqBlkXj72W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 23:51:56 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 23:51:56 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 23:51:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZFTnPWGBHg/Render', 23:51:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:51:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:51:56 INFO - 'HOME': '/Users/cltbld', 23:51:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:51:56 INFO - 'LOGNAME': 'cltbld', 23:51:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:51:56 INFO - 'MOZ_NO_REMOTE': '1', 23:51:56 INFO - 'NO_EM_RESTART': '1', 23:51:56 INFO - 'PAGER': '/bin/cat', 23:51:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:51:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:51:56 INFO - 'PWD': '/builds/slave/test', 23:51:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:51:56 INFO - 'SHELL': '/bin/bash', 23:51:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aqBlkXj72W/Listeners', 23:51:56 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 23:51:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:51:56 INFO - 'USER': 'cltbld', 23:51:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:51:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:51:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:51:56 INFO - 'XPC_FLAGS': '0x0', 23:51:56 INFO - 'XPC_SERVICE_NAME': '0', 23:51:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:51:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:51:57 INFO - Downloading/unpacking jsonschema==2.5.1 23:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:51:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:51:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:51:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:51:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:51:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:51:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:51:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:51:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:00 INFO - Downloading functools32-3.2.3-2.tar.gz 23:52:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:52:00 INFO - warning: no files found matching '*.txt' 23:52:00 INFO - no previously-included directories found matching 'build' 23:52:00 INFO - no previously-included directories found matching 'dist' 23:52:00 INFO - no previously-included directories found matching '.git*' 23:52:00 INFO - Installing collected packages: jsonschema, functools32 23:52:00 INFO - Running setup.py install for functools32 23:52:00 INFO - warning: no files found matching '*.txt' 23:52:00 INFO - no previously-included directories found matching 'build' 23:52:00 INFO - no previously-included directories found matching 'dist' 23:52:00 INFO - no previously-included directories found matching '.git*' 23:52:00 INFO - Successfully installed jsonschema functools32 23:52:00 INFO - Cleaning up... 23:52:00 INFO - Return code: 0 23:52:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:52:00 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')]} 23:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:00 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')]} 23:52:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:00 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 0x108f853f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108efb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc31570a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d9ad30>, '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 0x108c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d92b20>, '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.ZFTnPWGBHg/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.aqBlkXj72W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 23:52:00 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 23:52:00 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 23:52:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZFTnPWGBHg/Render', 23:52:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:52:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:52:00 INFO - 'HOME': '/Users/cltbld', 23:52:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:52:00 INFO - 'LOGNAME': 'cltbld', 23:52:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:00 INFO - 'MOZ_NO_REMOTE': '1', 23:52:00 INFO - 'NO_EM_RESTART': '1', 23:52:00 INFO - 'PAGER': '/bin/cat', 23:52:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:52:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:00 INFO - 'PWD': '/builds/slave/test', 23:52:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:52:00 INFO - 'SHELL': '/bin/bash', 23:52:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aqBlkXj72W/Listeners', 23:52:00 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 23:52:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:52:00 INFO - 'USER': 'cltbld', 23:52:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:52:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:52:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:00 INFO - 'XPC_FLAGS': '0x0', 23:52:00 INFO - 'XPC_SERVICE_NAME': '0', 23:52:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:52:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:52:00 INFO - Cleaning up... 23:52:00 INFO - Return code: 0 23:52:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:52:00 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')]} 23:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:00 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')]} 23:52:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:00 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 0x108f853f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108efb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc31570a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d9ad30>, '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 0x108c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d92b20>, '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.ZFTnPWGBHg/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.aqBlkXj72W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 23:52:00 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 23:52:00 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 23:52:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZFTnPWGBHg/Render', 23:52:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:52:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:52:00 INFO - 'HOME': '/Users/cltbld', 23:52:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:52:00 INFO - 'LOGNAME': 'cltbld', 23:52:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:00 INFO - 'MOZ_NO_REMOTE': '1', 23:52:00 INFO - 'NO_EM_RESTART': '1', 23:52:00 INFO - 'PAGER': '/bin/cat', 23:52:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:52:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:00 INFO - 'PWD': '/builds/slave/test', 23:52:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:52:00 INFO - 'SHELL': '/bin/bash', 23:52:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aqBlkXj72W/Listeners', 23:52:00 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 23:52:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:52:00 INFO - 'USER': 'cltbld', 23:52:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:52:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:52:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:00 INFO - 'XPC_FLAGS': '0x0', 23:52:00 INFO - 'XPC_SERVICE_NAME': '0', 23:52:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:52:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:01 INFO - Downloading/unpacking blobuploader==1.2.4 23:52:01 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 23:52:01 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 23:52:01 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 23:52:01 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 23:52:01 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 23:52:01 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 23:52:03 INFO - Downloading blobuploader-1.2.4.tar.gz 23:52:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:52:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:52:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:52:04 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 23:52:04 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 23:52:04 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 23:52:04 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 23:52:04 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 23:52:04 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 23:52:04 INFO - Downloading docopt-0.6.1.tar.gz 23:52:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:52:04 INFO - Installing collected packages: blobuploader, requests, docopt 23:52:04 INFO - Running setup.py install for blobuploader 23:52:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:52:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:52:05 INFO - Running setup.py install for requests 23:52:05 INFO - Running setup.py install for docopt 23:52:05 INFO - Successfully installed blobuploader requests docopt 23:52:05 INFO - Cleaning up... 23:52:05 INFO - Return code: 0 23:52:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:52:05 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')]} 23:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:05 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')]} 23:52:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:05 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 0x108f853f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108efb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc31570a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d9ad30>, '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 0x108c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d92b20>, '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.ZFTnPWGBHg/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.aqBlkXj72W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 23:52:05 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 23:52:05 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 23:52:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZFTnPWGBHg/Render', 23:52:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:52:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:52:05 INFO - 'HOME': '/Users/cltbld', 23:52:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:52:05 INFO - 'LOGNAME': 'cltbld', 23:52:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:05 INFO - 'MOZ_NO_REMOTE': '1', 23:52:05 INFO - 'NO_EM_RESTART': '1', 23:52:05 INFO - 'PAGER': '/bin/cat', 23:52:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:52:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:05 INFO - 'PWD': '/builds/slave/test', 23:52:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:52:05 INFO - 'SHELL': '/bin/bash', 23:52:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aqBlkXj72W/Listeners', 23:52:05 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 23:52:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:52:05 INFO - 'USER': 'cltbld', 23:52:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:52:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:52:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:05 INFO - 'XPC_FLAGS': '0x0', 23:52:05 INFO - 'XPC_SERVICE_NAME': '0', 23:52:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:52:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:52:06 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-Mh7yYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:52:06 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-i68ZX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:52:06 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-stYuYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:52:06 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-5XNXJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:52:06 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-vNO7EU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:52:06 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-h3vlRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:52:06 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-O9RNMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:52:06 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-_Atoxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:52:06 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-6EOWgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:52:07 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-dZ63ic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:52:07 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-nPU3N8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:52:07 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-kzynQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:52:07 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-jWGYRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:52:07 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-by4gPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:52:07 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-xwA7_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:52:07 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-MF6MOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:52:07 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-2WkQnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:52:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:52:07 INFO - Running setup.py install for manifestparser 23:52:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:52:08 INFO - Running setup.py install for mozcrash 23:52:08 INFO - Running setup.py install for mozdebug 23:52:08 INFO - Running setup.py install for mozdevice 23:52:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:52:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:52:08 INFO - Running setup.py install for mozfile 23:52:08 INFO - Running setup.py install for mozhttpd 23:52:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:52:08 INFO - Running setup.py install for mozinfo 23:52:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:52:08 INFO - Running setup.py install for mozInstall 23:52:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:52:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:52:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:52:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:52:09 INFO - Running setup.py install for mozleak 23:52:09 INFO - Running setup.py install for mozlog 23:52:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:52:09 INFO - Running setup.py install for moznetwork 23:52:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:52:09 INFO - Running setup.py install for mozprocess 23:52:09 INFO - Running setup.py install for mozprofile 23:52:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:52:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:52:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:52:09 INFO - Running setup.py install for mozrunner 23:52:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:52:09 INFO - Running setup.py install for mozscreenshot 23:52:10 INFO - Running setup.py install for moztest 23:52:10 INFO - Running setup.py install for mozversion 23:52:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:52:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:52:10 INFO - Cleaning up... 23:52:10 INFO - Return code: 0 23:52:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:52:10 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')]} 23:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:10 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')]} 23:52:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:10 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 0x108f853f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108efb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc31570a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d9ad30>, '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 0x108c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d92b20>, '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.ZFTnPWGBHg/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.aqBlkXj72W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 23:52:10 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 23:52:10 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 23:52:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZFTnPWGBHg/Render', 23:52:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:52:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:52:10 INFO - 'HOME': '/Users/cltbld', 23:52:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:52:10 INFO - 'LOGNAME': 'cltbld', 23:52:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:10 INFO - 'MOZ_NO_REMOTE': '1', 23:52:10 INFO - 'NO_EM_RESTART': '1', 23:52:10 INFO - 'PAGER': '/bin/cat', 23:52:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:52:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:10 INFO - 'PWD': '/builds/slave/test', 23:52:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:52:10 INFO - 'SHELL': '/bin/bash', 23:52:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aqBlkXj72W/Listeners', 23:52:10 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 23:52:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:52:10 INFO - 'USER': 'cltbld', 23:52:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:52:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:52:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:10 INFO - 'XPC_FLAGS': '0x0', 23:52:10 INFO - 'XPC_SERVICE_NAME': '0', 23:52:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:52:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:52:10 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-nKSujC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:52:10 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)) 23:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:52:10 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-yeD0uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:52:10 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)) 23:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:52:10 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-2lptDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:52:11 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)) 23:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:52:11 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-Q2Q_Xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:52:11 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)) 23:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:52:11 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-ZWKAvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:52:11 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)) 23:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:52:11 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-TgZpt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:52:11 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)) 23:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:52:11 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-H71PAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:52:11 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)) 23:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:52:11 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-vpueGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:52:11 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)) 23:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:52:11 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-b85AFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:52:11 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)) 23:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:52:11 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-USANjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:52:11 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)) 23:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:52:11 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-OqMZU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:52:11 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)) 23:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:52:11 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-y70LeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:52:11 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-_6QQ2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:52:12 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)) 23:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:52:12 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-0e1uiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:52:12 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)) 23:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:52:12 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-b6bXxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:52:12 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)) 23:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:52:12 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-p3kLuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:52:12 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-lF77Ub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:52:12 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)) 23:52:12 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)) 23:52:12 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)) 23:52:12 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)) 23:52:12 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)) 23:52:12 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)) 23:52:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:52:12 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 23:52:12 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 23:52:12 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 23:52:12 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 23:52:12 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 23:52:12 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 23:52:15 INFO - Downloading blessings-1.6.tar.gz 23:52:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:52:15 INFO - Installing collected packages: blessings 23:52:15 INFO - Running setup.py install for blessings 23:52:15 INFO - Successfully installed blessings 23:52:15 INFO - Cleaning up... 23:52:15 INFO - Return code: 0 23:52:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:52:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:52:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:52:15 INFO - Reading from file tmpfile_stdout 23:52:15 INFO - Current package versions: 23:52:15 INFO - blessings == 1.6 23:52:15 INFO - blobuploader == 1.2.4 23:52:15 INFO - docopt == 0.6.1 23:52:15 INFO - functools32 == 3.2.3-2 23:52:15 INFO - jsonschema == 2.5.1 23:52:15 INFO - manifestparser == 1.1 23:52:15 INFO - mozInstall == 1.12 23:52:15 INFO - mozcrash == 1.0 23:52:15 INFO - mozdebug == 0.1 23:52:15 INFO - mozdevice == 0.49 23:52:15 INFO - mozfile == 1.2 23:52:15 INFO - mozhttpd == 0.7 23:52:15 INFO - mozinfo == 0.9 23:52:15 INFO - mozleak == 0.1 23:52:15 INFO - mozlog == 3.4 23:52:15 INFO - moznetwork == 0.27 23:52:15 INFO - mozprocess == 0.23 23:52:15 INFO - mozprofile == 0.28 23:52:15 INFO - mozrunner == 6.13 23:52:15 INFO - mozscreenshot == 0.1 23:52:15 INFO - mozsystemmonitor == 0.3 23:52:15 INFO - moztest == 0.7 23:52:15 INFO - mozversion == 1.4 23:52:15 INFO - psutil == 3.1.1 23:52:15 INFO - requests == 1.2.3 23:52:15 INFO - wsgiref == 0.1.2 23:52:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:52:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:16 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 0x108f853f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108efb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc31570a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d9ad30>, '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 0x108c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d92b20>, '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.ZFTnPWGBHg/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.aqBlkXj72W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 23:52:16 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 23:52:16 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 23:52:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZFTnPWGBHg/Render', 23:52:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:52:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:52:16 INFO - 'HOME': '/Users/cltbld', 23:52:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:52:16 INFO - 'LOGNAME': 'cltbld', 23:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:16 INFO - 'MOZ_NO_REMOTE': '1', 23:52:16 INFO - 'NO_EM_RESTART': '1', 23:52:16 INFO - 'PAGER': '/bin/cat', 23:52:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:16 INFO - 'PWD': '/builds/slave/test', 23:52:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:52:16 INFO - 'SHELL': '/bin/bash', 23:52:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aqBlkXj72W/Listeners', 23:52:16 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 23:52:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:52:16 INFO - 'USER': 'cltbld', 23:52:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:52:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:16 INFO - 'XPC_FLAGS': '0x0', 23:52:16 INFO - 'XPC_SERVICE_NAME': '0', 23:52:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:52:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:16 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)) 23:52:16 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)) 23:52:16 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)) 23:52:16 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)) 23:52:16 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)) 23:52:16 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)) 23:52:16 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)) 23:52:16 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)) 23:52:16 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)) 23:52:16 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)) 23:52:16 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)) 23:52:16 INFO - Cleaning up... 23:52:16 INFO - Return code: 0 23:52:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:52:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:16 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 0x108f853f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108efb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc31570a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d9ad30>, '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 0x108c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d92b20>, '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.ZFTnPWGBHg/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.aqBlkXj72W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 23:52:16 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 23:52:16 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 23:52:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZFTnPWGBHg/Render', 23:52:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:52:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:52:16 INFO - 'HOME': '/Users/cltbld', 23:52:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:52:16 INFO - 'LOGNAME': 'cltbld', 23:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:16 INFO - 'MOZ_NO_REMOTE': '1', 23:52:16 INFO - 'NO_EM_RESTART': '1', 23:52:16 INFO - 'PAGER': '/bin/cat', 23:52:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:16 INFO - 'PWD': '/builds/slave/test', 23:52:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:52:16 INFO - 'SHELL': '/bin/bash', 23:52:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aqBlkXj72W/Listeners', 23:52:16 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 23:52:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:52:16 INFO - 'USER': 'cltbld', 23:52:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:52:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:16 INFO - 'XPC_FLAGS': '0x0', 23:52:16 INFO - 'XPC_SERVICE_NAME': '0', 23:52:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:52:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:52:16 INFO - Cleaning up... 23:52:16 INFO - Return code: 0 23:52:16 INFO - Running post-action listener: _resource_record_post_action 23:52:16 INFO - Running post-action listener: _start_resource_monitoring 23:52:16 INFO - Starting resource monitoring. 23:52:16 INFO - [mozharness: 2016-12-14 07:52:16.897137Z] Finished create-virtualenv step (success) 23:52:16 INFO - [mozharness: 2016-12-14 07:52:16.897954Z] Running install step. 23:52:16 INFO - Running pre-action listener: _resource_record_pre_action 23:52:16 INFO - Running main action method: install 23:52:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:52:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:52:17 INFO - Reading from file tmpfile_stdout 23:52:17 INFO - Detecting whether we're running mozinstall >=1.0... 23:52:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:52:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:52:17 INFO - Reading from file tmpfile_stdout 23:52:17 INFO - Output received: 23:52:17 INFO - Usage: mozinstall [options] installer 23:52:17 INFO - Options: 23:52:17 INFO - -h, --help show this help message and exit 23:52:17 INFO - -d DEST, --destination=DEST 23:52:17 INFO - Directory to install application into. [default: 23:52:17 INFO - "/builds/slave/test"] 23:52:17 INFO - --app=APP Application being installed. [default: firefox] 23:52:17 INFO - mkdir: /builds/slave/test/build/application 23:52:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg', '--destination', '/builds/slave/test/build/application'] 23:52:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg --destination /builds/slave/test/build/application 23:52:38 INFO - Reading from file tmpfile_stdout 23:52:38 INFO - Output received: 23:52:38 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 23:52:38 INFO - Running post-action listener: _resource_record_post_action 23:52:38 INFO - [mozharness: 2016-12-14 07:52:38.862672Z] Finished install step (success) 23:52:38 INFO - [mozharness: 2016-12-14 07:52:38.862812Z] Running run-tests step. 23:52:38 INFO - Running pre-action listener: _resource_record_pre_action 23:52:38 INFO - Running main action method: run_tests 23:52:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:52:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:52:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:52:38 INFO - 2016-12-13 23:52:38.877 screenresolution[1625:7372] starting screenresolution argv=screenresolution get 23:52:38 INFO - 2016-12-13 23:52:38.879 screenresolution[1625:7372] Display 0: 1600x1200x32@60 23:52:38 INFO - 2016-12-13 23:52:38.885 screenresolution[1626:7375] starting screenresolution argv=screenresolution list 23:52:38 INFO - Available Modes on Display 0 23:52:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:52:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:52:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:52:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:52:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:52:39 INFO - Intel Iris: 23:52:39 INFO - Chipset Model: Intel Iris 23:52:39 INFO - Type: GPU 23:52:39 INFO - Bus: Built-In 23:52:39 INFO - VRAM (Dynamic, Max): 1536 MB 23:52:39 INFO - Vendor: Intel (0x8086) 23:52:39 INFO - Device ID: 0x0a2e 23:52:39 INFO - Revision ID: 0x0009 23:52:39 INFO - Displays: 23:52:39 INFO - Display: 23:52:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:52:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:52:39 INFO - Display Serial Number: 1600x1200 60 23:52:39 INFO - Main Display: Yes 23:52:39 INFO - Mirror: Off 23:52:39 INFO - Online: Yes 23:52:39 INFO - Rotation: Supported 23:52:39 INFO - Return code: 0 23:52:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:52:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:52:39 INFO - Python 2.7.3 23:52:39 INFO - Return code: 0 23:52:39 INFO - grabbing minidump binary from tooltool 23:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:52:39 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d9ad30>, '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 0x108c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d92b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:52:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:52:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 23:52:39 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 23:52:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:52:39 INFO - Return code: 0 23:52:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:52:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:52:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:52:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:52:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:52:39 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/Get9xO1OSOewX46E8ZVKQg/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0190', '--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 23:52:39 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/Get9xO1OSOewX46E8ZVKQg/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip --title t-yosemite-r7-0190 --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 23:52:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZFTnPWGBHg/Render', 23:52:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:52:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:52:39 INFO - 'HOME': '/Users/cltbld', 23:52:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:52:39 INFO - 'LOGNAME': 'cltbld', 23:52:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:52:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:52:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:39 INFO - 'MOZ_NO_REMOTE': '1', 23:52:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:52:39 INFO - 'NO_EM_RESTART': '1', 23:52:39 INFO - 'PAGER': '/bin/cat', 23:52:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:52:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:39 INFO - 'PWD': '/builds/slave/test', 23:52:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:52:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:52:39 INFO - 'SHELL': '/bin/bash', 23:52:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aqBlkXj72W/Listeners', 23:52:39 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 23:52:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:52:39 INFO - 'USER': 'cltbld', 23:52:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:52:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:52:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:39 INFO - 'XPC_FLAGS': '0x0', 23:52:39 INFO - 'XPC_SERVICE_NAME': '0', 23:52:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:52:39 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/Get9xO1OSOewX46E8ZVKQg/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0190', '--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 23:52:39 INFO - mozversion application_buildid: 20161213224300 23:52:39 INFO - mozversion application_changeset: 2299de9e58d7e1f615ecbcfed041052f91cf8e07 23:52:39 INFO - mozversion application_display_name: Nightly 23:52:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:52:39 INFO - mozversion application_name: Firefox 23:52:39 INFO - mozversion application_remotingname: firefox 23:52:39 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 23:52:39 INFO - mozversion application_vendor: Mozilla 23:52:39 INFO - mozversion application_version: 53.0a1 23:52:39 INFO - mozversion platform_buildid: 20161213224300 23:52:39 INFO - mozversion platform_changeset: 2299de9e58d7e1f615ecbcfed041052f91cf8e07 23:52:39 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 23:52:39 INFO - mozversion platform_version: 53.0a1 23:52:39 INFO - using testdate: 1481701959 23:52:39 INFO - actual date: 1481701959 23:52:39 INFO - starting webserver on 'localhost:49244' 23:52:39 INFO - SUITE-START | Running 2 tests 23:52:39 INFO - TEST-START | dromaeo_css 23:52:39 INFO - operating with platform_type : mac_ 23:52:39 INFO - Initialising browser for dromaeo_css test... 23:52:39 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmpfv2GqI/profile http://localhost:49244/getInfo.html) 23:52:42 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 23:52:42 INFO - PROCESS | 1636 | colorDepth:24 23:52:42 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 23:52:42 INFO - PROCESS | 1636 | __metrics 23:52:42 INFO - PROCESS | 1636 | 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" 23:52:42 INFO - PROCESS | 1636 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:52:42 INFO - TEST-INFO | 1636: exit 0 23:52:42 INFO - Browser initialized. 23:52:42 INFO - Running cycle 1/1 for dromaeo_css test... 23:52:42 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmpfv2GqI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:52:54 INFO - PROCESS | 1638 | RSS: Main: 238583808 23:52:54 INFO - PROCESS | 1638 | 23:53:45 INFO - PROCESS | 1638 | 1481702025696 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 23:55:58 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 23:56:01 INFO - PROCESS | 1638 | RSS: Main: 375865344 23:56:01 INFO - PROCESS | 1638 | 23:59:04 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 23:59:04 INFO - PROCESS | 1638 | RSS: Main: 376287232 23:59:04 INFO - PROCESS | 1638 | 00:02:07 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 00:02:08 INFO - PROCESS | 1638 | RSS: Main: 334544896 00:02:08 INFO - PROCESS | 1638 | 00:05:10 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 00:05:11 INFO - PROCESS | 1638 | RSS: Main: 347504640 00:05:11 INFO - PROCESS | 1638 | 00:08:14 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 00:08:15 INFO - PROCESS | 1638 | RSS: Main: 335384576 00:08:15 INFO - PROCESS | 1638 | 00:11:18 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 00:11:18 INFO - PROCESS | 1638 | RSS: Main: 549552128 00:11:18 INFO - PROCESS | 1638 | 00:11:18 INFO - PROCESS | 1638 | __start_tp_report 00:11:18 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 00:11:18 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 00:11:18 INFO - PROCESS | 1638 | |i|pagename|runs| 00:11:18 INFO - PROCESS | 1638 | |0;dojo.html;3314;3324.883629072983;3332.33353329334;3350.5979282486105;3388.9152771180716;5298.09932311507;5477.068898287291;5536.778528858846;5595;5603.943960560393;5551.7224138793;5556.555475561955;5647.830565083043;5652.434756524345;5655.179998900157;4963.602911767068;5028.120078986163;5033.974830125844;5035.96762663653;5143.022825663131;5121.897562048757;5180.559652429548;5219.217117432378;5232.058229518685;5279.049771041211;5166.3800343958965;5173.741312934376;5183.53348198662;5204.453532379102;5253.290805741233;3808.428735689641;5028.044671512437;5082.1360368737405;5096.05722941257;5100.642954993152;4200.4959404871615;4534;5064.3163172971545;5089.3638295213095;5187.7406129693745;5536.280283563151;5562.638428502134;5585.050541407971;5602.13166959122;5625;5942.762289508458;6045.848853778691;6074.3621919698235;6086.391360863879;6165.075238714184;6119.816953237396;6122.510199184055;6162.4453799157845;6186.700792833511;6188.164597779287;5700.315962084576;5707.971460142714;5714.79998200061;5715.342735585377;5753.309602847643;6063.666498342545;6142.416470435302;6148.907766383508;6155.753769849156;6162.414570615784;5897.056470964711;5957.731902064417;5979.372165922516;5998;6006.969965150146;6109.625269688542;6110.01202914832;6113.871604717183;6122.011845520044;6139.539534534928;5995.640261584232;6055.212822333068;6061.7575296987625;6062.818115456544;6067.453929146398;4955.934474088089;5075.568576671024;5141.974290128525;6066.939330606726;6143.692815359214;4703.811847526129;4864.708117512961;4877.6829506081995;4882.974575339147;4915.8033678652455;4353.73877567347;4363.494594365003;4382.561743825656;4413.13943780966;4417.469903611587;5580.218769372291;5657.405972372924;5691.345495268097;5727.255456790591;5746.741396637161;6093.202401193696;6112.564273424362;6113.597930965863;6117.827404800917;6120.843333897677;4754.595859351924;5712.857178570569;5713.285839270091;5719.28508936383;5721;5194.168932970707;5225.817096401608;5248.947510524922;5278.736063196825;5291.021161085211;6118.497354391948;6119.136988619962;6121.788327166048;6127.433875357673;6146.631202127886;5942.168096466412;6117;6118.296395914527;6121.081837724377;6123.8162855114415;6145.832291864532;6219.0982307566055;6219.533534984804;6238.064290356483;6240.157578726814;6029.457348838626;6045.758169673164;6047.516198704006;6054.303755068224;6065.6663883486835;6109.556495504338;6113.202667687911;6125.968084364194;6139.1098290746695;6142.447179753844;5975;5982.551308651781;5992.550558708202;5994.160817485643;6001.489873360813;5950.940490595039;5951.256092988377;5971.193888824953;5981.252343457068;5989.940100598938;5608.635438696471;5719.48524632785;5727.656340619576;5747.942520574741;5792.0443126885275;5898.64608123514;5966.164736936919;5989.3112292085225;5998.610090344114;6026.096085587197;5799.652020878592;5813.476787089182;5824.767009319579;5830.650160990354;5859.707014649165 00:11:18 INFO - PROCESS | 1638 | |1;ext.html;444.33128142146063;491.18463350837595;493.3709520361539;509.78843779831374;517.8808873958991;37257.62742372579;39386.62146824862;39424.40863387048;39433.21133577327;39473.21053578934;40242.79878600603;40634.7968260159;40665;40687.59312406875;40962.77111686654;8509.149085091503;8742.694005709769;9354.812903741938;9579.61681532738;9582.137607615314;11019.83470247943;11278;11301.547938082467;11460.598879039193;11497.42512874357;11500.884991150066;11585;11587.420628968517;11601.825972610417;11675.766484670301;7413.406927445792;8831.60257788401;11322.433878306052;11353.43232838359;11429.942850285737;11242.213045086848;11467.36929468879;11490.65528034152;11505.654830355019;11525.19323647345;39112.413313800316;39248.41127383091;39364.40953385702;39425.802870985746;39457.40813887794;3267.869285228588;3520.700740437066;3538.6461353864665;3544.91137721559;4060.553339132693;26741.732582674314;28243;28256.576151357745;28290.434191316057;28325.85837070822;2497.5878979968284;3178.666240044808;3216.372807302577;3228.418884600771;3286.2934469089023;490769;491524;491610;491845.99999999645;493568;51322.69047892854;52463;52666;52835;53071;55095.449045509835;55119.34641960748;55147.89704205893;55213.17180242299;55233;12588.496460141674;14578.562643120724;14898.627534311729;15134.848651513345;15159.317830697644;10090.2432317575;10382.844257336146;10390.168786497063;11633.825492617618;11834.88165118355;14382.208978506073;16456.366981283176;16651;16845.07352095622;16965.491035268962;6057.787977420858;6225.501959843202;6793.218779840283;7202.603856787822;7250.673719682627;859.2438653984453;924.5746956399997;1103.862017247844;1129.8926601972798;1137.2039572299423;28258;28326.716732832407;29197.85401072981;29724.7889218203;29766.553501697494;1049.454283772434;1061.7982583309147;1063.4948399510172;1065.6430095917954;1104.4422566603973;12468.688282793002;14882.627934301512;15310.693786124215;15315.770263446057;15758.369665213264;651520;652579;656346;657053;657224.7138764275;53861;57192.71403642955;58019.709901450224;58033.4196658028;59462.70268648629;1338.4512349936674;1374.1205628397834;1387.1538361599416;1387.9444822207;1399.3982587487071;27531.724682752916;28246.43507129805;29138.125856224346;29561.113166605035;29759.404811904074;62051.68974155281;62680.686596566724;62969.11092667227;66991.33008669851;67089;596615;611269;611402.9429853;611970;613958;39842.2031559373;41490.96272593209;42762.358564622176;43530;44751.77624111858;47408.762956185;48714.02571948612;48745.512544874095;48886.75556622194;49373.753131234116;39837;40079.59920400875;40194.799026004686;40497.57844491825;41864.790676046425;31561.36877262488;35565.644343557266;41052;41366.37950430686;41722.374164388166;38633.03417414587;38785.03037424087;39619;39714.801425992686;39767.80116099401;34067.4889876657;34758.9572312831;35254.82372588121;35262;35753.1061723459;20857.791422085586;20866.895665521577;24167.879160604083;24320.806173004796;26761.598576021766 00:11:18 INFO - PROCESS | 1638 | |2;jquery.html;302.1404105320363;356.43505044504457;372.7688832923587;379.7930128080196;400;13533.526326578572;14920.552383428487;15841.28714207859;19911.601767964632;20444.28445004425;18180;20248;20398;20594.279200227997;20843.687344689843;5511.917321240175;5898.351181370046;5928.940710592904;5940.316863560703;5943.138244954479;5304.469553044684;5606.159076138571;5811.767529298823;5859.355470898197;5870.471657550819;5804;5807.709614519257;5808.303003639569;5811.389804070575;5820.3597604263705;5504.284443022401;5753.338366087891;5817.621854579439;5824.417558244142;5832.88334233313;5070.949290507085;5077.822276220351;5090.440051594322;5090.669106508065;5105.617078719111;12703.428345724373;12994.805077923838;13207.67923207681;13249.933750331284;13288.136271142344;2014.8186663200383;2112.26070875194;2113.704081428601;2119.3535971528677;2803.7897157713255;7651.808704782369;8246.670133194664;9041.954790226073;9661.227101831837;10055.346402483816;1764.1708397053364;1789.6599646067205;1791.9552011199694;1838.1820090059928;1852.2380796313412;87516.6872496913;105137.94862051435;112750;120191;121228.39385803015;8877.00534759361;9563.139317461462;10080.243981701255;11331.603393881174;11488.827667584992;13367.598972030855;13376.197428154343;13378.464861405435;13383.732325353438;13414.798778018338;6755.560888542327;6938.479614028968;7025.964870175617;7189.388901943289;7193.424526037905;6412.044326480468;6425.678716064178;6563.835904102436;6569.113169722122;6632.668366581748;4329.285667864767;4456.398386217884;4456.420665313553;4538;4554.88612784683;1877.6244751049844;1901.778052722953;1930.1314408516223;1965.4496740912568;1971.6155349706955;366.62237894968223;810.6149578949952;821.4332110843499;870.7518357268275;973.1873885305707;9311.348205625676;11618.244814087057;11629.418529073682;11919.880801191877;11976.760464790656;401.13955565312244;429.24881457449465;433.2829167727416;444.88210624184615;460.51415756377344;5606.327240731139;5962.1056841473255;5965.254343207099;6154.569180157346;6159.784407545804;576470;581589;581713;583967.0801646049;588204;125309.74690253162;127976;131544;133267;136209.3189534066;956.4978386347084;963.6701352134011;988.367444835306;1021.2034613002019;1036.6734478639205;12139;17255.56861078483;19032.52418689544;19699.31052413216;19747.605047898673;32844.83577582097;51805.48194518157;52544.47455525396;53618.008308295925;54148;75089;75134.49731005459;75701;77040.61479692566;77376.2262377369;7805.86814911846;8016.7194148204535;8053;8110.797230069295;8315.916840831514;10472.424016679155;11493.712657183303;12460.87539124597;12734.299613520974;12964.935175324063;5626.634268772516;9089.863652045093;10922.672319830417;10948.124150067817;11088.168387370819;5336.839894803162;7239.819004524718;10648.680539583826;10835.49807292469;11296;11209.43952802373;11340.432978351215;11349.773004539698;11408.31550106963;11466.426678666201;6780.38976492118;7848.725294614661;7922.445428820158;7939.0870049945;8140.87788683182;7392.593407362647;8029.4379393441895;8183.918160818315;10784.357832331129;11008.559657613605 00:11:18 INFO - PROCESS | 1638 | |3;mootools.html;1238.6593686736146;1496.0425327790217;1634.182908545727;1853.3513270355386;1878.4928069421248;7816.5700886451295;8216.424850260484;8224.506529608228;8239.29965952894;8240.258376746091;7281.745138920126;7571.394288456924;7575.848483030336;7640.808979775508;7646.923530764705;2077.80260875217;2122.649762789138;2222.7332720073614;2307.7692230776956;2307.9538409231805;2339.3215967369442;2343.4844334246523;2348.0490401387465;2351.623740201568;2352.4354155002848;2151.967720484194;2209.9005544750526;2210.1822325739417;2213.269621025066;2219.2010876084596;2232.397252741767;2268.3308424014954;2307.492351682627;2311.514581937795;2313.699219101506;2284.097781376347;2287.7254729432575;2294.7705229477087;2317.5596636638984;2325.8953347099423;8035.638396272182;8183.181681831828;8243.05204901432;8252.628631711588;8253.8349233015;4441.888952776174;4936.456989731127;5110.361204849394;5114.156164232897;5132.461091585367;3228.9354212915846;3392.77946933451;3421.1789170599127;3482.5472688550326;3486.5467489226494;975.1613612293422;1019.8011387779386;1020.2959957629287;1028.588564574169;1046.8168070587617;10518.579256829718;10572.418516981563;10593.311434756793;10595.25833191677;10603.416812075257;4285.871423857289;4518.548145185521;4566.520515345907;4616.169089563844;4638.7216766993415;8876.644934202688;8968.506732129665;9036.45781253127;9075.954620226988;9087.909120908706;4449.57729015743;4984.252362145708;4988.55103040728;5090.618203634742;5100.719460429637;4517.390152329459;4573.702709323883;4667.299905014207;4669.719816810934;4674.368960190331;3223.065311059813;3303.9504407433906;3322.750793690483;3550.3254381667402;3647.3617117004947;1124.6794663520857;1126.7577470843808;1128.3850301585655;1141.5262665993519;1143.2968724234702;843.2621456225802;843.4180415513276;892.1881088209698;897.708244820436;950.8573713942964;5438.945610543844;5493.176023596492;5653.378128405872;5700.258966334433;5793.333766616809;823.3125340340882;907.4509921497531;915.2906497464518;930;962.167724917941;3762.755420897633;3803.5055442792814;3824.2351529694174;3873.8837834865;3884.7086468514976;9464.242860571276;9757.463339516253;9847.16299114569;9876.358036727734;9884.55519501624;9847.704568862946;9847.75380615476;9848.409095454295;9858.260630452745;9885.011498850201;7537.886931696029;7712.15166331703;7714.382849372037;7719.575423351657;7725.1502334744255;4733.9763301183275;5515.61390702663;5524.530414914777;5613.354464236665;5615.466530679579;9063.773405664911;9116.042815504277;9184.173424391836;9184.724458266262;9270.814583708154;9172.266218702622;9275.304352173749;9277.62889484413;9300.72097837066;9402.717918462457;6509.804705858832;6558.540902136805;6675.732970681119;6681.498887583548;6683.832904177434;7193.3166349196745;7227.349538541556;7510.625439630695;7745.380369570308;7755.146933837161;6668.83327916806;6937.7571784987285;6947.756828510978;7050.894236586353;7101.254368291462;6550.63971481554;6616.503762217949;6805.421539169226;6825.55633883796;6866.4506839453725;6416.262129854939;6545.476361890942;6546.509011824037;6558.672066396565;6564.113844630913;4559.794809233659;4787.688800227974;4809.759512024315;4825.879353016203;4934.3585333907795;3835.76985380878;4650.48844627084;4824.662273640812;4834.492378300369;4837.274408838703 00:11:18 INFO - PROCESS | 1638 | |4;prototype.html;344.81899494232255;350.9052555809931;356.37812018028535;362.4762218594133;366.8697612347618;4299.129878502849;4819.301201325806;4837.089349706864;4911.877203069925;5139.306193663854;4165.520965089008;4731.077439899213;5019.523145301199;5105.974470127653;5128.897422051566;4037.777922214277;4041.898952526181;4050.1774201609246;4073.1039171382395;4077.1234184650293;3671.751604454485;3871.825103415201;4005.6394924456795;4071.246819338417;4120.278951183546;3985.521737391517;4034.69739769517;4041.1715598302426;4046.300553767425;4076.65348445381;3302.372549215653;3998.8403363024686;4009.3585026395926;4013.4381186633896;4039.333509970851;3068.0335694256237;3158.8104713717253;3579.7494175407733;3616.6021737608844;3629.5100161478126;4154.792260386968;4971.6271279654175;4986.650934434591;4989.126902791997;5051.318072060261;3945.5659877413464;4603.146049449363;4611.700239484423;4637.304404339342;4655.115528049693;5152.330197074394;5375.973120134413;5385.434529374398;5433.972830135864;5497.45025497447;3524.365614189445;3705.5182826232417;3914.8042597869994;3971.7886044756337;3989.7606143631474;4958.702477851304;5558.833235002957;5618.690971996498;5635.464041181484;5646.955313267059;3444.0873168610337;3735.14091758897;4001.7398869074;4017.3572228443895;4048.1296521248073;4070.9592904070582;4077.3293492762286;4099.118689481776;4102.958970410317;4109.2808758467145;3541.38025845476;3752.962470375316;3809.7333186676665;4402.295632698753;4426.114777044604;4558.726476411426;4951.8266860659705;5386.757595908193;5394.352677678625;5430.864228394243;1053.931494452858;1178.9742923656302;1194.599809063956;1196.9646255988682;1216.6130611103172;829.4981536170529;843.8692152515658;844.6241422567022;853.6171402328268;857.7726902370877;4419.376111588531;4663.580277774949;4876.975615121902;4894.3147959285725;4907.435644900811;4622.745748983771;4993.4756850530175;5312.654677445954;5325.4940780625775;5372.892542149135;4215.662746980234;4458.219811533034;4755.215389460769;4821.349117869113;4871.853844384674;2347.4600841806136;2449.3876530867283;2672.465506898628;2785.8438747919386;2791.59024692533;5114.417219304228;5205.84382468519;5278.313819203479;5426.945730542723;5433.6196466247775;5055.823046193365;5193.818216362485;5350.8127215547265;5387.4073851876265;5398.379186393615;4574.6569007323915;4614.600407787864;4753.025629745894;4923.9167383175645;4955.900881982412;4895.583875370633;4959.504049595012;5174.7153906535505;5232.9738351308;5269.446708095748;5005.324281221989;5043.4956504349275;5151.896962060813;5184.096905732802;5193.3778936747085;4533.750643714628;4933.975330123327;4943.505649435027;5041.974790126026;5102.744862756773;3311.7084337108067;3487.128217945514;3520.310251079445;3530.223350862806;3598.85604575814;5579.9163012555655;5583.0180285997885;5605.0764464875565;5614.63504872182;5617.887642247214;4589.747563883885;5419.972900135474;5427.375851776938;5432.076546986943;5515.420880807618;4999.850004499871;5249.317588713443;5394.514493695429;5422.6475279106735;5459.235707001102;4634.907301853877;5042.697438153723;5195.376554813447;5206.55744261742;5230.895382092413;4720.622350211906;5019.247112933089;5428.511433970962;5442.945570544244;5467.480589344006;4279.78601069939;5299.576033917355;5301.8144364948585;5330.546903513245;5412.105762982925 00:11:18 INFO - PROCESS | 1638 | |5;yui.html;716.4877112864305;721.6644260418905;753.2429907942517;772.9111152217497;836.2807985132787;13281.402336894838;13532.729345413085;13844.930775346122;13851.307434628266;13928.582142535715;13868.791968120486;13894.861051389484;14087.450380458142;14264.786028209559;14297;851.5827244650138;876.1895246896627;885.6900084970241;885.7342797160858;888.1606881496988;860.1269711243062;881.4534988307258;885.3935054487664;886.7738726624701;888.0409158109227;908.5775114571722;915.5010519267015;923.1922068190333;926.8934072581671;927.7634203278154;920.700772249015;921.6359537982493;921.8893732752045;922.1470140120429;924.145165721708;664.5082638847218;684.852756657316;685.4961603221628;685.5715178013742;689.5931400473745;15172.165530895796;15206.467773627981;15216.771748423782;15220.010699304621;15284.694306113815;13400.463981440731;13737.381817818223;13786.310684465736;13879.653008674864;14157.362918668581;10803.729906752316;11292.717682058013;11613.76772464546;11673.824892626617;12156.270623762513;3179.4118088153764;3588.9282214355567;3655.214128962286;3750.231202603487;3804.010957151133;98572;103834.48082759538;106683;106937;111181;11088.112950963903;11112.499937502831;11621.360825154698;11641.708957275967;11747.412629368668;23301.88349058278;23336.949837257365;23549.646755298683;23684.7631523686;23938.28185154448;7547.245275472519;7595.5822429766895;7908.84182316362;7993.560354180576;8371.372147088992;3707.869099924495;4277.2942464493635;4285.571442855752;4298.183345164472;4385.912281754347;3343.314620502791;3403.1832360233366;3406.7274618030497;3407.4037043517287;3412.129906873781;529.9470052994669;615.5075939248583;631.3497097989078;646.3794757033206;646.7186773753432;537.5135502370283;590.3181824992055;619.2599843187348;622.4677900395187;623.6663385088956;8220.63007164679;9045.412048216976;9676.758081047888;9692.9030709692;9809.754756131011;592.9911051334234;619.9120543446313;670.8758879607288;672.5863593889723;674.2650510943096;3967.166894952092;4413;4548.727076375428;4650.32624226857;4924.359833221658;102574.48712756389;104962;105143.4742826281;105964.47017764862;106725;58327.70836145877;60166.39833601608;68287.31712682909;77833.61083194548;91775.54112229396;79207;80582.59708701419;81874;81976.59011705023;83054.16945830465;9503.809923801347;9742.75643108928;9747.415155090717;9757.463339516395;9775.266854986046;38147.80926095463;49557.451598603315;50348;50608.746956264986;51549.48450515447;62696.119116426584;63563.682181590644;64360.35639643544;66162.66918665376;70465.64767176131;12690.238585684889;12924.870751292367;13093.803592946304;13249.602511924657;13490.190588564717;14383.208923509308;14468.85531144675;14756.852431475549;14780.408783648534;15306.311215995083;13423.194608323533;13725.684795553712;13858.307084645929;13916.721665566834;14148.858511414754;13275.40260688252;13849;13882.51411200603;14134.222617755711;14138.293085345897;12890.871091288967;13144.671383215496;13332;13382.531611393555;14216.644583885485;11033.337999720043;11300.773984520429;11356.432178391213;11358;11395.430228488709;6795.966020170065;10437.269391142547;10976.670699879016;11249.943750281196;11310.660680179608 00:11:18 INFO - PROCESS | 1638 | __end_tp_report 00:11:18 INFO - PROCESS | 1638 | __start_cc_report 00:11:18 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,2305 00:11:18 INFO - PROCESS | 1638 | __end_cc_report 00:11:18 INFO - PROCESS | 1638 | __startTimestamp1481703078704__endTimestamp 00:11:18 INFO - PROCESS | 1638 | 00:11:18 INFO - PROCESS | 1638 | ------- Summary: start ------- 00:11:18 INFO - PROCESS | 1638 | Number of tests: 6 00:11:18 INFO - PROCESS | 1638 | 00:11:18 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5596.41 Median:5792.04 stddev:643.31 (11.1%) stddev-sans-first:619.86 00:11:18 INFO - PROCESS | 1638 | Values: 3314.0 3324.9 3332.3 3350.6 3388.9 5298.1 5477.1 5536.8 5595.0 5603.9 5551.7 5556.6 5647.8 5652.4 5655.2 4963.6 5028.1 5034.0 5036.0 5143.0 5121.9 5180.6 5219.2 5232.1 5279.0 5166.4 5173.7 5183.5 5204.5 5253.3 3808.4 5028.0 5082.1 5096.1 5100.6 4200.5 4534.0 5064.3 5089.4 5187.7 5536.3 5562.6 5585.1 5602.1 5625.0 5942.8 6045.8 6074.4 6086.4 6165.1 6119.8 6122.5 6162.4 6186.7 6188.2 5700.3 5708.0 5714.8 5715.3 5753.3 6063.7 6142.4 6148.9 6155.8 6162.4 5897.1 5957.7 5979.4 5998.0 6007.0 6109.6 6110.0 6113.9 6122.0 6139.5 5995.6 6055.2 6061.8 6062.8 6067.5 4955.9 5075.6 5142.0 6066.9 6143.7 4703.8 4864.7 4877.7 4883.0 4915.8 4353.7 4363.5 4382.6 4413.1 4417.5 5580.2 5657.4 5691.3 5727.3 5746.7 6093.2 6112.6 6113.6 6117.8 6120.8 4754.6 5712.9 5713.3 5719.3 5721.0 5194.2 5225.8 5248.9 5278.7 5291.0 6118.5 6119.1 6121.8 6127.4 6146.6 5942.2 6117.0 6118.3 6121.1 6123.8 6145.8 6219.1 6219.5 6238.1 6240.2 6029.5 6045.8 6047.5 6054.3 6065.7 6109.6 6113.2 6126.0 6139.1 6142.4 5975.0 5982.6 5992.6 5994.2 6001.5 5950.9 5951.3 5971.2 5981.3 5989.9 5608.6 5719.5 5727.7 5747.9 5792.0 5898.6 5966.2 5989.3 5998.6 6026.1 5799.7 5813.5 5824.8 5830.7 5859.7 00:11:18 INFO - PROCESS | 1638 | 00:11:18 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:71800.31 Median:39180.41 stddev:157562.16 (402.1%) stddev-sans-first:157913.08 00:11:18 INFO - PROCESS | 1638 | Values: 444.3 491.2 493.4 509.8 517.9 37257.6 39386.6 39424.4 39433.2 39473.2 40242.8 40634.8 40665.0 40687.6 40962.8 8509.1 8742.7 9354.8 9579.6 9582.1 11019.8 11278.0 11301.5 11460.6 11497.4 11500.9 11585.0 11587.4 11601.8 11675.8 7413.4 8831.6 11322.4 11353.4 11429.9 11242.2 11467.4 11490.7 11505.7 11525.2 39112.4 39248.4 39364.4 39425.8 39457.4 3267.9 3520.7 3538.6 3544.9 4060.6 26741.7 28243.0 28256.6 28290.4 28325.9 2497.6 3178.7 3216.4 3228.4 3286.3 490769.0 491524.0 491610.0 491846.0 493568.0 51322.7 52463.0 52666.0 52835.0 53071.0 55095.4 55119.3 55147.9 55213.2 55233.0 12588.5 14578.6 14898.6 15134.8 15159.3 10090.2 10382.8 10390.2 11633.8 11834.9 14382.2 16456.4 16651.0 16845.1 16965.5 6057.8 6225.5 6793.2 7202.6 7250.7 859.2 924.6 1103.9 1129.9 1137.2 28258.0 28326.7 29197.9 29724.8 29766.6 1049.5 1061.8 1063.5 1065.6 1104.4 12468.7 14882.6 15310.7 15315.8 15758.4 651520.0 652579.0 656346.0 657053.0 657224.7 53861.0 57192.7 58019.7 58033.4 59462.7 1338.5 1374.1 1387.2 1387.9 1399.4 27531.7 28246.4 29138.1 29561.1 29759.4 62051.7 62680.7 62969.1 66991.3 67089.0 596615.0 611269.0 611402.9 611970.0 613958.0 39842.2 41491.0 42762.4 43530.0 44751.8 47408.8 48714.0 48745.5 48886.8 49373.8 39837.0 40079.6 40194.8 40497.6 41864.8 31561.4 35565.6 41052.0 41366.4 41722.4 38633.0 38785.0 39619.0 39714.8 39767.8 34067.5 34759.0 35254.8 35262.0 35753.1 20857.8 20866.9 24167.9 24320.8 26761.6 00:11:18 INFO - PROCESS | 1638 | 00:11:18 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:32964.82 Median:4497.21 stddev:97488.75 (2167.8%) stddev-sans-first:97731.39 00:11:18 INFO - PROCESS | 1638 | Values: 302.1 356.4 372.8 379.8 400.0 13533.5 14920.6 15841.3 19911.6 20444.3 18180.0 20248.0 20398.0 20594.3 20843.7 5511.9 5898.4 5928.9 5940.3 5943.1 5304.5 5606.2 5811.8 5859.4 5870.5 5804.0 5807.7 5808.3 5811.4 5820.4 5504.3 5753.3 5817.6 5824.4 5832.9 5070.9 5077.8 5090.4 5090.7 5105.6 12703.4 12994.8 13207.7 13249.9 13288.1 2014.8 2112.3 2113.7 2119.4 2803.8 7651.8 8246.7 9042.0 9661.2 10055.3 1764.2 1789.7 1792.0 1838.2 1852.2 87516.7 105137.9 112750.0 120191.0 121228.4 8877.0 9563.1 10080.2 11331.6 11488.8 13367.6 13376.2 13378.5 13383.7 13414.8 6755.6 6938.5 7026.0 7189.4 7193.4 6412.0 6425.7 6563.8 6569.1 6632.7 4329.3 4456.4 4456.4 4538.0 4554.9 1877.6 1901.8 1930.1 1965.4 1971.6 366.6 810.6 821.4 870.8 973.2 9311.3 11618.2 11629.4 11919.9 11976.8 401.1 429.2 433.3 444.9 460.5 5606.3 5962.1 5965.3 6154.6 6159.8 576470.0 581589.0 581713.0 583967.1 588204.0 125309.7 127976.0 131544.0 133267.0 136209.3 956.5 963.7 988.4 1021.2 1036.7 12139.0 17255.6 19032.5 19699.3 19747.6 32844.8 51805.5 52544.5 53618.0 54148.0 75089.0 75134.5 75701.0 77040.6 77376.2 7805.9 8016.7 8053.0 8110.8 8315.9 10472.4 11493.7 12460.9 12734.3 12964.9 5626.6 9089.9 10922.7 10948.1 11088.2 5336.8 7239.8 10648.7 10835.5 11296.0 11209.4 11340.4 11349.8 11408.3 11466.4 6780.4 7848.7 7922.4 7939.1 8140.9 7392.6 8029.4 8183.9 10784.4 11008.6 00:11:18 INFO - PROCESS | 1638 | 00:11:18 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5291.55 Median:5466.06 stddev:2891.72 (52.9%) stddev-sans-first:2883.79 00:11:18 INFO - PROCESS | 1638 | Values: 1238.7 1496.0 1634.2 1853.4 1878.5 7816.6 8216.4 8224.5 8239.3 8240.3 7281.7 7571.4 7575.8 7640.8 7646.9 2077.8 2122.6 2222.7 2307.8 2308.0 2339.3 2343.5 2348.0 2351.6 2352.4 2152.0 2209.9 2210.2 2213.3 2219.2 2232.4 2268.3 2307.5 2311.5 2313.7 2284.1 2287.7 2294.8 2317.6 2325.9 8035.6 8183.2 8243.1 8252.6 8253.8 4441.9 4936.5 5110.4 5114.2 5132.5 3228.9 3392.8 3421.2 3482.5 3486.5 975.2 1019.8 1020.3 1028.6 1046.8 10518.6 10572.4 10593.3 10595.3 10603.4 4285.9 4518.5 4566.5 4616.2 4638.7 8876.6 8968.5 9036.5 9076.0 9087.9 4449.6 4984.3 4988.6 5090.6 5100.7 4517.4 4573.7 4667.3 4669.7 4674.4 3223.1 3304.0 3322.8 3550.3 3647.4 1124.7 1126.8 1128.4 1141.5 1143.3 843.3 843.4 892.2 897.7 950.9 5438.9 5493.2 5653.4 5700.3 5793.3 823.3 907.5 915.3 930.0 962.2 3762.8 3803.5 3824.2 3873.9 3884.7 9464.2 9757.5 9847.2 9876.4 9884.6 9847.7 9847.8 9848.4 9858.3 9885.0 7537.9 7712.2 7714.4 7719.6 7725.2 4734.0 5515.6 5524.5 5613.4 5615.5 9063.8 9116.0 9184.2 9184.7 9270.8 9172.3 9275.3 9277.6 9300.7 9402.7 6509.8 6558.5 6675.7 6681.5 6683.8 7193.3 7227.3 7510.6 7745.4 7755.1 6668.8 6937.8 6947.8 7050.9 7101.3 6550.6 6616.5 6805.4 6825.6 6866.5 6416.3 6545.5 6546.5 6558.7 6564.1 4559.8 4787.7 4809.8 4825.9 4934.4 3835.8 4650.5 4824.7 4834.5 4837.3 00:11:18 INFO - PROCESS | 1638 | 00:11:18 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4306.85 Median:4829.22 stddev:1284.85 (26.6%) stddev-sans-first:1253.57 00:11:18 INFO - PROCESS | 1638 | Values: 344.8 350.9 356.4 362.5 366.9 4299.1 4819.3 4837.1 4911.9 5139.3 4165.5 4731.1 5019.5 5106.0 5128.9 4037.8 4041.9 4050.2 4073.1 4077.1 3671.8 3871.8 4005.6 4071.2 4120.3 3985.5 4034.7 4041.2 4046.3 4076.7 3302.4 3998.8 4009.4 4013.4 4039.3 3068.0 3158.8 3579.7 3616.6 3629.5 4154.8 4971.6 4986.7 4989.1 5051.3 3945.6 4603.1 4611.7 4637.3 4655.1 5152.3 5376.0 5385.4 5434.0 5497.5 3524.4 3705.5 3914.8 3971.8 3989.8 4958.7 5558.8 5618.7 5635.5 5647.0 3444.1 3735.1 4001.7 4017.4 4048.1 4071.0 4077.3 4099.1 4103.0 4109.3 3541.4 3753.0 3809.7 4402.3 4426.1 4558.7 4951.8 5386.8 5394.4 5430.9 1053.9 1179.0 1194.6 1197.0 1216.6 829.5 843.9 844.6 853.6 857.8 4419.4 4663.6 4877.0 4894.3 4907.4 4622.7 4993.5 5312.7 5325.5 5372.9 4215.7 4458.2 4755.2 4821.3 4871.9 2347.5 2449.4 2672.5 2785.8 2791.6 5114.4 5205.8 5278.3 5426.9 5433.6 5055.8 5193.8 5350.8 5387.4 5398.4 4574.7 4614.6 4753.0 4923.9 4955.9 4895.6 4959.5 5174.7 5233.0 5269.4 5005.3 5043.5 5151.9 5184.1 5193.4 4533.8 4934.0 4943.5 5042.0 5102.7 3311.7 3487.1 3520.3 3530.2 3598.9 5579.9 5583.0 5605.1 5614.6 5617.9 4589.7 5420.0 5427.4 5432.1 5515.4 4999.9 5249.3 5394.5 5422.6 5459.2 4634.9 5042.7 5195.4 5206.6 5230.9 4720.6 5019.2 5428.5 5442.9 5467.5 4279.8 5299.6 5301.8 5330.5 5412.1 00:11:18 INFO - PROCESS | 1638 | 00:11:18 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:19992.11 Median:4122.23 stddev:28650.57 (695.0%) stddev-sans-first:28694.39 00:11:18 INFO - PROCESS | 1638 | Values: 716.5 721.7 753.2 772.9 836.3 13281.4 13532.7 13844.9 13851.3 13928.6 13868.8 13894.9 14087.5 14264.8 14297.0 851.6 876.2 885.7 885.7 888.2 860.1 881.5 885.4 886.8 888.0 908.6 915.5 923.2 926.9 927.8 920.7 921.6 921.9 922.1 924.1 664.5 684.9 685.5 685.6 689.6 15172.2 15206.5 15216.8 15220.0 15284.7 13400.5 13737.4 13786.3 13879.7 14157.4 10803.7 11292.7 11613.8 11673.8 12156.3 3179.4 3588.9 3655.2 3750.2 3804.0 98572.0 103834.5 106683.0 106937.0 111181.0 11088.1 11112.5 11621.4 11641.7 11747.4 23301.9 23336.9 23549.6 23684.8 23938.3 7547.2 7595.6 7908.8 7993.6 8371.4 3707.9 4277.3 4285.6 4298.2 4385.9 3343.3 3403.2 3406.7 3407.4 3412.1 529.9 615.5 631.3 646.4 646.7 537.5 590.3 619.3 622.5 623.7 8220.6 9045.4 9676.8 9692.9 9809.8 593.0 619.9 670.9 672.6 674.3 3967.2 4413.0 4548.7 4650.3 4924.4 102574.5 104962.0 105143.5 105964.5 106725.0 58327.7 60166.4 68287.3 77833.6 91775.5 79207.0 80582.6 81874.0 81976.6 83054.2 9503.8 9742.8 9747.4 9757.5 9775.3 38147.8 49557.5 50348.0 50608.7 51549.5 62696.1 63563.7 64360.4 66162.7 70465.6 12690.2 12924.9 13093.8 13249.6 13490.2 14383.2 14468.9 14756.9 14780.4 15306.3 13423.2 13725.7 13858.3 13916.7 14148.9 13275.4 13849.0 13882.5 14134.2 14138.3 12890.9 13144.7 13332.0 13382.5 14216.6 11033.3 11300.8 11356.4 11358.0 11395.4 6796.0 10437.3 10976.7 11249.9 11310.7 00:11:18 INFO - PROCESS | 1638 | -------- Summary: end -------- 00:11:18 INFO - PROCESS | 1638 | 00:11:19 INFO - TEST-INFO | 1638: exit 0 00:11:19 INFO - TEST-OK | dromaeo_css | took 1119934ms 00:11:19 INFO - TEST-START | kraken 00:11:19 INFO - operating with platform_type : mac_ 00:11:19 INFO - Initialising browser for kraken test... 00:11:19 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmpsXXdqV/profile http://localhost:49244/getInfo.html) 00:11:21 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 00:11:21 INFO - PROCESS | 1649 | colorDepth:24 00:11:21 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 00:11:21 INFO - PROCESS | 1649 | __metrics 00:11:21 INFO - PROCESS | 1649 | 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" 00:11:21 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:11:22 INFO - TEST-INFO | 1649: exit 0 00:11:22 INFO - Browser initialized. 00:11:22 INFO - Running cycle 1/1 for kraken test... 00:11:22 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmpsXXdqV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:11:34 INFO - PROCESS | 1650 | RSS: Main: 237363200 00:11:34 INFO - PROCESS | 1650 | 00:11:37 INFO - PROCESS | 1650 | 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) 00:11:38 INFO - PROCESS | 1650 | RSS: Main: 289447936 00:11:38 INFO - PROCESS | 1650 | 00:11:40 INFO - PROCESS | 1650 | 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) 00:11:41 INFO - PROCESS | 1650 | RSS: Main: 290496512 00:11:41 INFO - PROCESS | 1650 | 00:11:44 INFO - PROCESS | 1650 | 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) 00:11:45 INFO - PROCESS | 1650 | RSS: Main: 384507904 00:11:45 INFO - PROCESS | 1650 | 00:11:47 INFO - PROCESS | 1650 | 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) 00:11:47 INFO - PROCESS | 1650 | RSS: Main: 284717056 00:11:47 INFO - PROCESS | 1650 | 00:11:49 INFO - PROCESS | 1650 | 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) 00:11:50 INFO - PROCESS | 1650 | RSS: Main: 288112640 00:11:50 INFO - PROCESS | 1650 | 00:11:53 INFO - PROCESS | 1650 | 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) 00:11:54 INFO - PROCESS | 1650 | RSS: Main: 330862592 00:11:54 INFO - PROCESS | 1650 | 00:11:57 INFO - PROCESS | 1650 | 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) 00:11:57 INFO - PROCESS | 1650 | RSS: Main: 330936320 00:11:57 INFO - PROCESS | 1650 | 00:12:00 INFO - PROCESS | 1650 | 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) 00:12:01 INFO - PROCESS | 1650 | RSS: Main: 326533120 00:12:01 INFO - PROCESS | 1650 | 00:12:03 INFO - PROCESS | 1650 | 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) 00:12:03 INFO - PROCESS | 1650 | RSS: Main: 305414144 00:12:03 INFO - PROCESS | 1650 | 00:12:05 INFO - PROCESS | 1650 | 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) 00:12:06 INFO - PROCESS | 1650 | RSS: Main: 307068928 00:12:06 INFO - PROCESS | 1650 | 00:12:08 INFO - PROCESS | 1650 | 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) 00:12:09 INFO - PROCESS | 1650 | RSS: Main: 309301248 00:12:09 INFO - PROCESS | 1650 | 00:12:12 INFO - PROCESS | 1650 | 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) 00:12:13 INFO - PROCESS | 1650 | RSS: Main: 329011200 00:12:13 INFO - PROCESS | 1650 | 00:12:16 INFO - PROCESS | 1650 | 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) 00:12:16 INFO - PROCESS | 1650 | RSS: Main: 323399680 00:12:16 INFO - PROCESS | 1650 | 00:12:18 INFO - PROCESS | 1650 | 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) 00:12:18 INFO - PROCESS | 1650 | RSS: Main: 367198208 00:12:18 INFO - PROCESS | 1650 | 00:12:18 INFO - PROCESS | 1650 | __start_tp_report 00:12:18 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 00:12:18 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 00:12:18 INFO - PROCESS | 1650 | |i|pagename|runs| 00:12:18 INFO - PROCESS | 1650 | |0;ai-astar;113;115;114;116;114;115;113;115;114;113 00:12:18 INFO - PROCESS | 1650 | |1;audio-beat-detection;149;115;116;150;117;116;115;111;132;114 00:12:18 INFO - PROCESS | 1650 | |2;audio-dft;185;184;180;184;184;185;182;182;183;185 00:12:18 INFO - PROCESS | 1650 | |3;audio-fft;82;60;58;86;65;60;58;59;75;58 00:12:18 INFO - PROCESS | 1650 | |4;audio-oscillator;90;69;85;70;69;68;84;68;68;84 00:12:18 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;109;108;107;109;108;109;107;111;107;107 00:12:18 INFO - PROCESS | 1650 | |6;imaging-darkroom;93;93;94;94;98;93;87;132;148;92 00:12:18 INFO - PROCESS | 1650 | |7;imaging-desaturate;87;87;85;101;130;110;85;86;85;88 00:12:18 INFO - PROCESS | 1650 | |8;json-parse-financial;56;57;57;57;57;56;56;56;55;55 00:12:18 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;65;78;100;111;84;69;70;71;71;72 00:12:18 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;91;89;89;93;94;86;89;88;91;89 00:12:18 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;149;158;151;158;156;163;147;149;188;166 00:12:18 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;177;178;179;229;177;178;176;177;182;178 00:12:18 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;67;69;69;69;68;68;68;67;69;66 00:12:18 INFO - PROCESS | 1650 | __end_tp_report 00:12:18 INFO - PROCESS | 1650 | __start_cc_report 00:12:18 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,2012 00:12:18 INFO - PROCESS | 1650 | __end_cc_report 00:12:18 INFO - PROCESS | 1650 | __startTimestamp1481703138727__endTimestamp 00:12:18 INFO - PROCESS | 1650 | 00:12:18 INFO - PROCESS | 1650 | ------- Summary: start ------- 00:12:18 INFO - PROCESS | 1650 | Number of tests: 14 00:12:18 INFO - PROCESS | 1650 | 00:12:18 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.50 stddev:1.03 (0.9%) stddev-sans-first:1.00 00:12:18 INFO - PROCESS | 1650 | Values: 113.0 115.0 114.0 116.0 114.0 115.0 113.0 115.0 114.0 113.0 00:12:18 INFO - PROCESS | 1650 | 00:12:18 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:123.50 Median:116.50 stddev:14.80 (12.7%) stddev-sans-first:12.49 00:12:18 INFO - PROCESS | 1650 | Values: 149.0 115.0 116.0 150.0 117.0 116.0 115.0 111.0 132.0 114.0 00:12:18 INFO - PROCESS | 1650 | 00:12:18 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.00 stddev:1.65 (0.9%) stddev-sans-first:1.64 00:12:18 INFO - PROCESS | 1650 | Values: 185.0 184.0 180.0 184.0 184.0 185.0 182.0 182.0 183.0 185.0 00:12:18 INFO - PROCESS | 1650 | 00:12:18 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:66.10 Median:62.50 stddev:10.81 (17.3%) stddev-sans-first:9.81 00:12:18 INFO - PROCESS | 1650 | Values: 82.0 60.0 58.0 86.0 65.0 60.0 58.0 59.0 75.0 58.0 00:12:18 INFO - PROCESS | 1650 | 00:12:18 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:75.50 Median:77.00 stddev:9.00 (11.7%) stddev-sans-first:7.87 00:12:18 INFO - PROCESS | 1650 | Values: 90.0 69.0 85.0 70.0 69.0 68.0 84.0 68.0 68.0 84.0 00:12:18 INFO - PROCESS | 1650 | 00:12:18 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:108.20 Median:108.50 stddev:1.32 (1.2%) stddev-sans-first:1.36 00:12:18 INFO - PROCESS | 1650 | Values: 109.0 108.0 107.0 109.0 108.0 109.0 107.0 111.0 107.0 107.0 00:12:18 INFO - PROCESS | 1650 | 00:12:18 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:102.40 Median:93.00 stddev:20.35 (21.9%) stddev-sans-first:21.30 00:12:18 INFO - PROCESS | 1650 | Values: 93.0 93.0 94.0 94.0 98.0 93.0 87.0 132.0 148.0 92.0 00:12:18 INFO - PROCESS | 1650 | 00:12:18 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:85.50 stddev:15.06 (17.6%) stddev-sans-first:15.73 00:12:18 INFO - PROCESS | 1650 | Values: 87.0 87.0 85.0 101.0 130.0 110.0 85.0 86.0 85.0 88.0 00:12:18 INFO - PROCESS | 1650 | 00:12:18 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.50 stddev:0.79 (1.4%) stddev-sans-first:0.83 00:12:18 INFO - PROCESS | 1650 | Values: 56.0 57.0 57.0 57.0 57.0 56.0 56.0 56.0 55.0 55.0 00:12:18 INFO - PROCESS | 1650 | 00:12:18 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:79.10 Median:71.00 stddev:15.07 (21.2%) stddev-sans-first:15.10 00:12:18 INFO - PROCESS | 1650 | Values: 65.0 78.0 100.0 111.0 84.0 69.0 70.0 71.0 71.0 72.0 00:12:18 INFO - PROCESS | 1650 | 00:12:18 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:90.00 stddev:2.38 (2.6%) stddev-sans-first:2.49 00:12:18 INFO - PROCESS | 1650 | Values: 91.0 89.0 89.0 93.0 94.0 86.0 89.0 88.0 91.0 89.0 00:12:18 INFO - PROCESS | 1650 | 00:12:18 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:158.50 Median:158.00 stddev:12.12 (7.7%) stddev-sans-first:12.36 00:12:18 INFO - PROCESS | 1650 | Values: 149.0 158.0 151.0 158.0 156.0 163.0 147.0 149.0 188.0 166.0 00:12:18 INFO - PROCESS | 1650 | 00:12:18 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.10 Median:178.00 stddev:16.21 (9.1%) stddev-sans-first:17.04 00:12:18 INFO - PROCESS | 1650 | Values: 177.0 178.0 179.0 229.0 177.0 178.0 176.0 177.0 182.0 178.0 00:12:18 INFO - PROCESS | 1650 | 00:12:18 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.50 stddev:1.05 (1.5%) stddev-sans-first:1.05 00:12:18 INFO - PROCESS | 1650 | Values: 67.0 69.0 69.0 69.0 68.0 68.0 68.0 67.0 69.0 66.0 00:12:18 INFO - PROCESS | 1650 | -------- Summary: end -------- 00:12:18 INFO - PROCESS | 1650 | 00:12:19 INFO - TEST-INFO | 1650: exit 0 00:12:19 INFO - TEST-OK | kraken | took 60222ms 00:12:19 INFO - SUITE-END | took 1180s 00:12:19 INFO - Completed test suite (00:19:40) 00:12:19 INFO - javascript benchmark 00:12:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3314.0, 3324.883629072983, 3332.33353329334, 3350.5979282486105, 3388.9152771180716, 5298.09932311507, 5477.068898287291, 5536.778528858846, 5595.0, 5603.943960560393, 5551.7224138793, 5556.555475561955, 5647.830565083043, 5652.434756524345, 5655.179998900157, 4963.602911767068, 5028.120078986163, 5033.974830125844, 5035.96762663653, 5143.022825663131, 5121.897562048757, 5180.559652429548, 5219.217117432378, 5232.058229518685, 5279.049771041211, 5166.3800343958965, 5173.741312934376, 5183.53348198662, 5204.453532379102, 5253.290805741233, 3808.428735689641, 5028.044671512437, 5082.1360368737405, 5096.05722941257, 5100.642954993152, 4200.4959404871615, 4534.0, 5064.3163172971545, 5089.3638295213095, 5187.7406129693745, 5536.280283563151, 5562.638428502134, 5585.050541407971, 5602.13166959122, 5625.0, 5942.762289508458, 6045.848853778691, 6074.3621919698235, 6086.391360863879, 6165.075238714184, 6119.816953237396, 6122.510199184055, 6162.4453799157845, 6186.700792833511, 6188.164597779287, 5700.315962084576, 5707.971460142714, 5714.79998200061, 5715.342735585377, 5753.309602847643, 6063.666498342545, 6142.416470435302, 6148.907766383508, 6155.753769849156, 6162.414570615784, 5897.056470964711, 5957.731902064417, 5979.372165922516, 5998.0, 6006.969965150146, 6109.625269688542, 6110.01202914832, 6113.871604717183, 6122.011845520044, 6139.539534534928, 5995.640261584232, 6055.212822333068, 6061.7575296987625, 6062.818115456544, 6067.453929146398, 4955.934474088089, 5075.568576671024, 5141.974290128525, 6066.939330606726, 6143.692815359214, 4703.811847526129, 4864.708117512961, 4877.6829506081995, 4882.974575339147, 4915.8033678652455, 4353.73877567347, 4363.494594365003, 4382.561743825656, 4413.13943780966, 4417.469903611587, 5580.218769372291, 5657.405972372924, 5691.345495268097, 5727.255456790591, 5746.741396637161, 6093.202401193696, 6112.564273424362, 6113.597930965863, 6117.827404800917, 6120.843333897677, 4754.595859351924, 5712.857178570569, 5713.285839270091, 5719.28508936383, 5721.0, 5194.168932970707, 5225.817096401608, 5248.947510524922, 5278.736063196825, 5291.021161085211, 6118.497354391948, 6119.136988619962, 6121.788327166048, 6127.433875357673, 6146.631202127886, 5942.168096466412, 6117.0, 6118.296395914527, 6121.081837724377, 6123.8162855114415, 6145.832291864532, 6219.0982307566055, 6219.533534984804, 6238.064290356483, 6240.157578726814, 6029.457348838626, 6045.758169673164, 6047.516198704006, 6054.303755068224, 6065.6663883486835, 6109.556495504338, 6113.202667687911, 6125.968084364194, 6139.1098290746695, 6142.447179753844, 5975.0, 5982.551308651781, 5992.550558708202, 5994.160817485643, 6001.489873360813, 5950.940490595039, 5951.256092988377, 5971.193888824953, 5981.252343457068, 5989.940100598938, 5608.635438696471, 5719.48524632785, 5727.656340619576, 5747.942520574741, 5792.0443126885275, 5898.64608123514, 5966.164736936919, 5989.3112292085225, 5998.610090344114, 6026.096085587197, 5799.652020878592, 5813.476787089182, 5824.767009319579, 5830.650160990354, 5859.707014649165], "value": 5556.082356793814, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [444.33128142146063, 491.18463350837595, 493.3709520361539, 509.78843779831374, 517.8808873958991, 37257.62742372579, 39386.62146824862, 39424.40863387048, 39433.21133577327, 39473.21053578934, 40242.79878600603, 40634.7968260159, 40665.0, 40687.59312406875, 40962.77111686654, 8509.149085091503, 8742.694005709769, 9354.812903741938, 9579.61681532738, 9582.137607615314, 11019.83470247943, 11278.0, 11301.547938082467, 11460.598879039193, 11497.42512874357, 11500.884991150066, 11585.0, 11587.420628968517, 11601.825972610417, 11675.766484670301, 7413.406927445792, 8831.60257788401, 11322.433878306052, 11353.43232838359, 11429.942850285737, 11242.213045086848, 11467.36929468879, 11490.65528034152, 11505.654830355019, 11525.19323647345, 39112.413313800316, 39248.41127383091, 39364.40953385702, 39425.802870985746, 39457.40813887794, 3267.869285228588, 3520.700740437066, 3538.6461353864665, 3544.91137721559, 4060.553339132693, 26741.732582674314, 28243.0, 28256.576151357745, 28290.434191316057, 28325.85837070822, 2497.5878979968284, 3178.666240044808, 3216.372807302577, 3228.418884600771, 3286.2934469089023, 490769.0, 491524.0, 491610.0, 491845.99999999645, 493568.0, 51322.69047892854, 52463.0, 52666.0, 52835.0, 53071.0, 55095.449045509835, 55119.34641960748, 55147.89704205893, 55213.17180242299, 55233.0, 12588.496460141674, 14578.562643120724, 14898.627534311729, 15134.848651513345, 15159.317830697644, 10090.2432317575, 10382.844257336146, 10390.168786497063, 11633.825492617618, 11834.88165118355, 14382.208978506073, 16456.366981283176, 16651.0, 16845.07352095622, 16965.491035268962, 6057.787977420858, 6225.501959843202, 6793.218779840283, 7202.603856787822, 7250.673719682627, 859.2438653984453, 924.5746956399997, 1103.862017247844, 1129.8926601972798, 1137.2039572299423, 28258.0, 28326.716732832407, 29197.85401072981, 29724.7889218203, 29766.553501697494, 1049.454283772434, 1061.7982583309147, 1063.4948399510172, 1065.6430095917954, 1104.4422566603973, 12468.688282793002, 14882.627934301512, 15310.693786124215, 15315.770263446057, 15758.369665213264, 651520.0, 652579.0, 656346.0, 657053.0, 657224.7138764275, 53861.0, 57192.71403642955, 58019.709901450224, 58033.4196658028, 59462.70268648629, 1338.4512349936674, 1374.1205628397834, 1387.1538361599416, 1387.9444822207, 1399.3982587487071, 27531.724682752916, 28246.43507129805, 29138.125856224346, 29561.113166605035, 29759.404811904074, 62051.68974155281, 62680.686596566724, 62969.11092667227, 66991.33008669851, 67089.0, 596615.0, 611269.0, 611402.9429853, 611970.0, 613958.0, 39842.2031559373, 41490.96272593209, 42762.358564622176, 43530.0, 44751.77624111858, 47408.762956185, 48714.02571948612, 48745.512544874095, 48886.75556622194, 49373.753131234116, 39837.0, 40079.59920400875, 40194.799026004686, 40497.57844491825, 41864.790676046425, 31561.36877262488, 35565.644343557266, 41052.0, 41366.37950430686, 41722.374164388166, 38633.03417414587, 38785.03037424087, 39619.0, 39714.801425992686, 39767.80116099401, 34067.4889876657, 34758.9572312831, 35254.82372588121, 35262.0, 35753.1061723459, 20857.791422085586, 20866.895665521577, 24167.879160604083, 24320.806173004796, 26761.598576021766], "value": 20158.68655160549, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.1404105320363, 356.43505044504457, 372.7688832923587, 379.7930128080196, 400.0, 13533.526326578572, 14920.552383428487, 15841.28714207859, 19911.601767964632, 20444.28445004425, 18180.0, 20248.0, 20398.0, 20594.279200227997, 20843.687344689843, 5511.917321240175, 5898.351181370046, 5928.940710592904, 5940.316863560703, 5943.138244954479, 5304.469553044684, 5606.159076138571, 5811.767529298823, 5859.355470898197, 5870.471657550819, 5804.0, 5807.709614519257, 5808.303003639569, 5811.389804070575, 5820.3597604263705, 5504.284443022401, 5753.338366087891, 5817.621854579439, 5824.417558244142, 5832.88334233313, 5070.949290507085, 5077.822276220351, 5090.440051594322, 5090.669106508065, 5105.617078719111, 12703.428345724373, 12994.805077923838, 13207.67923207681, 13249.933750331284, 13288.136271142344, 2014.8186663200383, 2112.26070875194, 2113.704081428601, 2119.3535971528677, 2803.7897157713255, 7651.808704782369, 8246.670133194664, 9041.954790226073, 9661.227101831837, 10055.346402483816, 1764.1708397053364, 1789.6599646067205, 1791.9552011199694, 1838.1820090059928, 1852.2380796313412, 87516.6872496913, 105137.94862051435, 112750.0, 120191.0, 121228.39385803015, 8877.00534759361, 9563.139317461462, 10080.243981701255, 11331.603393881174, 11488.827667584992, 13367.598972030855, 13376.197428154343, 13378.464861405435, 13383.732325353438, 13414.798778018338, 6755.560888542327, 6938.479614028968, 7025.964870175617, 7189.388901943289, 7193.424526037905, 6412.044326480468, 6425.678716064178, 6563.835904102436, 6569.113169722122, 6632.668366581748, 4329.285667864767, 4456.398386217884, 4456.420665313553, 4538.0, 4554.88612784683, 1877.6244751049844, 1901.778052722953, 1930.1314408516223, 1965.4496740912568, 1971.6155349706955, 366.62237894968223, 810.6149578949952, 821.4332110843499, 870.7518357268275, 973.1873885305707, 9311.348205625676, 11618.244814087057, 11629.418529073682, 11919.880801191877, 11976.760464790656, 401.13955565312244, 429.24881457449465, 433.2829167727416, 444.88210624184615, 460.51415756377344, 5606.327240731139, 5962.1056841473255, 5965.254343207099, 6154.569180157346, 6159.784407545804, 576470.0, 581589.0, 581713.0, 583967.0801646049, 588204.0, 125309.74690253162, 127976.0, 131544.0, 133267.0, 136209.3189534066, 956.4978386347084, 963.6701352134011, 988.367444835306, 1021.2034613002019, 1036.6734478639205, 12139.0, 17255.56861078483, 19032.52418689544, 19699.31052413216, 19747.605047898673, 32844.83577582097, 51805.48194518157, 52544.47455525396, 53618.008308295925, 54148.0, 75089.0, 75134.49731005459, 75701.0, 77040.61479692566, 77376.2262377369, 7805.86814911846, 8016.7194148204535, 8053.0, 8110.797230069295, 8315.916840831514, 10472.424016679155, 11493.712657183303, 12460.87539124597, 12734.299613520974, 12964.935175324063, 5626.634268772516, 9089.863652045093, 10922.672319830417, 10948.124150067817, 11088.168387370819, 5336.839894803162, 7239.819004524718, 10648.680539583826, 10835.49807292469, 11296.0, 11209.43952802373, 11340.432978351215, 11349.773004539698, 11408.31550106963, 11466.426678666201, 6780.38976492118, 7848.725294614661, 7922.445428820158, 7939.0870049945, 8140.87788683182, 7392.593407362647, 8029.4379393441895, 8183.918160818315, 10784.357832331129, 11008.559657613605], "value": 8340.782946596673, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1238.6593686736146, 1496.0425327790217, 1634.182908545727, 1853.3513270355386, 1878.4928069421248, 7816.5700886451295, 8216.424850260484, 8224.506529608228, 8239.29965952894, 8240.258376746091, 7281.745138920126, 7571.394288456924, 7575.848483030336, 7640.808979775508, 7646.923530764705, 2077.80260875217, 2122.649762789138, 2222.7332720073614, 2307.7692230776956, 2307.9538409231805, 2339.3215967369442, 2343.4844334246523, 2348.0490401387465, 2351.623740201568, 2352.4354155002848, 2151.967720484194, 2209.9005544750526, 2210.1822325739417, 2213.269621025066, 2219.2010876084596, 2232.397252741767, 2268.3308424014954, 2307.492351682627, 2311.514581937795, 2313.699219101506, 2284.097781376347, 2287.7254729432575, 2294.7705229477087, 2317.5596636638984, 2325.8953347099423, 8035.638396272182, 8183.181681831828, 8243.05204901432, 8252.628631711588, 8253.8349233015, 4441.888952776174, 4936.456989731127, 5110.361204849394, 5114.156164232897, 5132.461091585367, 3228.9354212915846, 3392.77946933451, 3421.1789170599127, 3482.5472688550326, 3486.5467489226494, 975.1613612293422, 1019.8011387779386, 1020.2959957629287, 1028.588564574169, 1046.8168070587617, 10518.579256829718, 10572.418516981563, 10593.311434756793, 10595.25833191677, 10603.416812075257, 4285.871423857289, 4518.548145185521, 4566.520515345907, 4616.169089563844, 4638.7216766993415, 8876.644934202688, 8968.506732129665, 9036.45781253127, 9075.954620226988, 9087.909120908706, 4449.57729015743, 4984.252362145708, 4988.55103040728, 5090.618203634742, 5100.719460429637, 4517.390152329459, 4573.702709323883, 4667.299905014207, 4669.719816810934, 4674.368960190331, 3223.065311059813, 3303.9504407433906, 3322.750793690483, 3550.3254381667402, 3647.3617117004947, 1124.6794663520857, 1126.7577470843808, 1128.3850301585655, 1141.5262665993519, 1143.2968724234702, 843.2621456225802, 843.4180415513276, 892.1881088209698, 897.708244820436, 950.8573713942964, 5438.945610543844, 5493.176023596492, 5653.378128405872, 5700.258966334433, 5793.333766616809, 823.3125340340882, 907.4509921497531, 915.2906497464518, 930.0, 962.167724917941, 3762.755420897633, 3803.5055442792814, 3824.2351529694174, 3873.8837834865, 3884.7086468514976, 9464.242860571276, 9757.463339516253, 9847.16299114569, 9876.358036727734, 9884.55519501624, 9847.704568862946, 9847.75380615476, 9848.409095454295, 9858.260630452745, 9885.011498850201, 7537.886931696029, 7712.15166331703, 7714.382849372037, 7719.575423351657, 7725.1502334744255, 4733.9763301183275, 5515.61390702663, 5524.530414914777, 5613.354464236665, 5615.466530679579, 9063.773405664911, 9116.042815504277, 9184.173424391836, 9184.724458266262, 9270.814583708154, 9172.266218702622, 9275.304352173749, 9277.62889484413, 9300.72097837066, 9402.717918462457, 6509.804705858832, 6558.540902136805, 6675.732970681119, 6681.498887583548, 6683.832904177434, 7193.3166349196745, 7227.349538541556, 7510.625439630695, 7745.380369570308, 7755.146933837161, 6668.83327916806, 6937.7571784987285, 6947.756828510978, 7050.894236586353, 7101.254368291462, 6550.63971481554, 6616.503762217949, 6805.421539169226, 6825.55633883796, 6866.4506839453725, 6416.262129854939, 6545.476361890942, 6546.509011824037, 6558.672066396565, 6564.113844630913, 4559.794809233659, 4787.688800227974, 4809.759512024315, 4825.879353016203, 4934.3585333907795, 3835.76985380878, 4650.48844627084, 4824.662273640812, 4834.492378300369, 4837.274408838703], "value": 4297.106164595232, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.81899494232255, 350.9052555809931, 356.37812018028535, 362.4762218594133, 366.8697612347618, 4299.129878502849, 4819.301201325806, 4837.089349706864, 4911.877203069925, 5139.306193663854, 4165.520965089008, 4731.077439899213, 5019.523145301199, 5105.974470127653, 5128.897422051566, 4037.777922214277, 4041.898952526181, 4050.1774201609246, 4073.1039171382395, 4077.1234184650293, 3671.751604454485, 3871.825103415201, 4005.6394924456795, 4071.246819338417, 4120.278951183546, 3985.521737391517, 4034.69739769517, 4041.1715598302426, 4046.300553767425, 4076.65348445381, 3302.372549215653, 3998.8403363024686, 4009.3585026395926, 4013.4381186633896, 4039.333509970851, 3068.0335694256237, 3158.8104713717253, 3579.7494175407733, 3616.6021737608844, 3629.5100161478126, 4154.792260386968, 4971.6271279654175, 4986.650934434591, 4989.126902791997, 5051.318072060261, 3945.5659877413464, 4603.146049449363, 4611.700239484423, 4637.304404339342, 4655.115528049693, 5152.330197074394, 5375.973120134413, 5385.434529374398, 5433.972830135864, 5497.45025497447, 3524.365614189445, 3705.5182826232417, 3914.8042597869994, 3971.7886044756337, 3989.7606143631474, 4958.702477851304, 5558.833235002957, 5618.690971996498, 5635.464041181484, 5646.955313267059, 3444.0873168610337, 3735.14091758897, 4001.7398869074, 4017.3572228443895, 4048.1296521248073, 4070.9592904070582, 4077.3293492762286, 4099.118689481776, 4102.958970410317, 4109.2808758467145, 3541.38025845476, 3752.962470375316, 3809.7333186676665, 4402.295632698753, 4426.114777044604, 4558.726476411426, 4951.8266860659705, 5386.757595908193, 5394.352677678625, 5430.864228394243, 1053.931494452858, 1178.9742923656302, 1194.599809063956, 1196.9646255988682, 1216.6130611103172, 829.4981536170529, 843.8692152515658, 844.6241422567022, 853.6171402328268, 857.7726902370877, 4419.376111588531, 4663.580277774949, 4876.975615121902, 4894.3147959285725, 4907.435644900811, 4622.745748983771, 4993.4756850530175, 5312.654677445954, 5325.4940780625775, 5372.892542149135, 4215.662746980234, 4458.219811533034, 4755.215389460769, 4821.349117869113, 4871.853844384674, 2347.4600841806136, 2449.3876530867283, 2672.465506898628, 2785.8438747919386, 2791.59024692533, 5114.417219304228, 5205.84382468519, 5278.313819203479, 5426.945730542723, 5433.6196466247775, 5055.823046193365, 5193.818216362485, 5350.8127215547265, 5387.4073851876265, 5398.379186393615, 4574.6569007323915, 4614.600407787864, 4753.025629745894, 4923.9167383175645, 4955.900881982412, 4895.583875370633, 4959.504049595012, 5174.7153906535505, 5232.9738351308, 5269.446708095748, 5005.324281221989, 5043.4956504349275, 5151.896962060813, 5184.096905732802, 5193.3778936747085, 4533.750643714628, 4933.975330123327, 4943.505649435027, 5041.974790126026, 5102.744862756773, 3311.7084337108067, 3487.128217945514, 3520.310251079445, 3530.223350862806, 3598.85604575814, 5579.9163012555655, 5583.0180285997885, 5605.0764464875565, 5614.63504872182, 5617.887642247214, 4589.747563883885, 5419.972900135474, 5427.375851776938, 5432.076546986943, 5515.420880807618, 4999.850004499871, 5249.317588713443, 5394.514493695429, 5422.6475279106735, 5459.235707001102, 4634.907301853877, 5042.697438153723, 5195.376554813447, 5206.55744261742, 5230.895382092413, 4720.622350211906, 5019.247112933089, 5428.511433970962, 5442.945570544244, 5467.480589344006, 4279.78601069939, 5299.576033917355, 5301.8144364948585, 5330.546903513245, 5412.105762982925], "value": 3908.2063233318418, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.4877112864305, 721.6644260418905, 753.2429907942517, 772.9111152217497, 836.2807985132787, 13281.402336894838, 13532.729345413085, 13844.930775346122, 13851.307434628266, 13928.582142535715, 13868.791968120486, 13894.861051389484, 14087.450380458142, 14264.786028209559, 14297.0, 851.5827244650138, 876.1895246896627, 885.6900084970241, 885.7342797160858, 888.1606881496988, 860.1269711243062, 881.4534988307258, 885.3935054487664, 886.7738726624701, 888.0409158109227, 908.5775114571722, 915.5010519267015, 923.1922068190333, 926.8934072581671, 927.7634203278154, 920.700772249015, 921.6359537982493, 921.8893732752045, 922.1470140120429, 924.145165721708, 664.5082638847218, 684.852756657316, 685.4961603221628, 685.5715178013742, 689.5931400473745, 15172.165530895796, 15206.467773627981, 15216.771748423782, 15220.010699304621, 15284.694306113815, 13400.463981440731, 13737.381817818223, 13786.310684465736, 13879.653008674864, 14157.362918668581, 10803.729906752316, 11292.717682058013, 11613.76772464546, 11673.824892626617, 12156.270623762513, 3179.4118088153764, 3588.9282214355567, 3655.214128962286, 3750.231202603487, 3804.010957151133, 98572.0, 103834.48082759538, 106683.0, 106937.0, 111181.0, 11088.112950963903, 11112.499937502831, 11621.360825154698, 11641.708957275967, 11747.412629368668, 23301.88349058278, 23336.949837257365, 23549.646755298683, 23684.7631523686, 23938.28185154448, 7547.245275472519, 7595.5822429766895, 7908.84182316362, 7993.560354180576, 8371.372147088992, 3707.869099924495, 4277.2942464493635, 4285.571442855752, 4298.183345164472, 4385.912281754347, 3343.314620502791, 3403.1832360233366, 3406.7274618030497, 3407.4037043517287, 3412.129906873781, 529.9470052994669, 615.5075939248583, 631.3497097989078, 646.3794757033206, 646.7186773753432, 537.5135502370283, 590.3181824992055, 619.2599843187348, 622.4677900395187, 623.6663385088956, 8220.63007164679, 9045.412048216976, 9676.758081047888, 9692.9030709692, 9809.754756131011, 592.9911051334234, 619.9120543446313, 670.8758879607288, 672.5863593889723, 674.2650510943096, 3967.166894952092, 4413.0, 4548.727076375428, 4650.32624226857, 4924.359833221658, 102574.48712756389, 104962.0, 105143.4742826281, 105964.47017764862, 106725.0, 58327.70836145877, 60166.39833601608, 68287.31712682909, 77833.61083194548, 91775.54112229396, 79207.0, 80582.59708701419, 81874.0, 81976.59011705023, 83054.16945830465, 9503.809923801347, 9742.75643108928, 9747.415155090717, 9757.463339516395, 9775.266854986046, 38147.80926095463, 49557.451598603315, 50348.0, 50608.746956264986, 51549.48450515447, 62696.119116426584, 63563.682181590644, 64360.35639643544, 66162.66918665376, 70465.64767176131, 12690.238585684889, 12924.870751292367, 13093.803592946304, 13249.602511924657, 13490.190588564717, 14383.208923509308, 14468.85531144675, 14756.852431475549, 14780.408783648534, 15306.311215995083, 13423.194608323533, 13725.684795553712, 13858.307084645929, 13916.721665566834, 14148.858511414754, 13275.40260688252, 13849.0, 13882.51411200603, 14134.222617755711, 14138.293085345897, 12890.871091288967, 13144.671383215496, 13332.0, 13382.531611393555, 14216.644583885485, 11033.337999720043, 11300.773984520429, 11356.432178391213, 11358.0, 11395.430228488709, 6795.966020170065, 10437.269391142547, 10976.670699879016, 11249.943750281196, 11310.660680179608], "value": 7395.410287600994, "unit": "score"}], "name": "dromaeo_css", "value": 6983.9403734527405, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 116.0, 114.0, 115.0, 113.0, 115.0, 114.0, 113.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 115.0, 116.0, 150.0, 117.0, 116.0, 115.0, 111.0, 132.0, 114.0], "value": 123.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 180.0, 184.0, 184.0, 185.0, 182.0, 182.0, 183.0, 185.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 58.0, 86.0, 65.0, 60.0, 58.0, 59.0, 75.0, 58.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 69.0, 85.0, 70.0, 69.0, 68.0, 84.0, 68.0, 68.0, 84.0], "value": 75.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 108.0, 107.0, 109.0, 108.0, 109.0, 107.0, 111.0, 107.0, 107.0], "value": 108.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 94.0, 98.0, 93.0, 87.0, 132.0, 148.0, 92.0], "value": 102.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 85.0, 101.0, 130.0, 110.0, 85.0, 86.0, 85.0, 88.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 57.0, 57.0, 56.0, 56.0, 56.0, 55.0, 55.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 78.0, 100.0, 111.0, 84.0, 69.0, 70.0, 71.0, 71.0, 72.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 89.0, 89.0, 93.0, 94.0, 86.0, 89.0, 88.0, 91.0, 89.0], "value": 89.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 158.0, 151.0, 158.0, 156.0, 163.0, 147.0, 149.0, 188.0, 166.0], "value": 158.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 178.0, 179.0, 229.0, 177.0, 178.0, 176.0, 177.0, 182.0, 178.0], "value": 183.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 69.0, 69.0, 68.0, 68.0, 68.0, 67.0, 69.0, 66.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1502.5, "alertThreshold": 2.0}]} 00:12:19 INFO - Return code: 0 00:12:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:12:20 INFO - # TBPL SUCCESS # 00:12:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:12:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:12:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:12:20 INFO - 2016-12-14 00:12:20.043 screenresolution[1654:9869] starting screenresolution argv=screenresolution get 00:12:20 INFO - 2016-12-14 00:12:20.046 screenresolution[1654:9869] Display 0: 1600x1200x32@60 00:12:20 INFO - 2016-12-14 00:12:20.052 screenresolution[1655:9872] starting screenresolution argv=screenresolution list 00:12:20 INFO - Available Modes on Display 0 00:12:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:12:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:12:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:12:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:12:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:12:20 INFO - Intel Iris: 00:12:20 INFO - Chipset Model: Intel Iris 00:12:20 INFO - Type: GPU 00:12:20 INFO - Bus: Built-In 00:12:20 INFO - VRAM (Dynamic, Max): 1536 MB 00:12:20 INFO - Vendor: Intel (0x8086) 00:12:20 INFO - Device ID: 0x0a2e 00:12:20 INFO - Revision ID: 0x0009 00:12:20 INFO - Displays: 00:12:20 INFO - Display: 00:12:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:12:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:12:20 INFO - Display Serial Number: 1600x1200 60 00:12:20 INFO - Main Display: Yes 00:12:20 INFO - Mirror: Off 00:12:20 INFO - Online: Yes 00:12:20 INFO - Rotation: Supported 00:12:20 INFO - Return code: 0 00:12:20 INFO - Running post-action listener: _resource_record_post_action 00:12:20 INFO - [mozharness: 2016-12-14 08:12:20.287158Z] Finished run-tests step (success) 00:12:20 INFO - Running post-run listener: _resource_record_post_run 00:12:20 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 42214400; Write bytes: 556467200; Read time: 602; Write time: 2093 00:12:20 INFO - TinderboxPrint: CPU usage
53.7% 00:12:20 INFO - TinderboxPrint: I/O read bytes / time
42,214,400 / 602 00:12:20 INFO - TinderboxPrint: I/O write bytes / time
556,467,200 / 2,093 00:12:20 INFO - TinderboxPrint: CPU idle
2,226.1 (46.3%) 00:12:20 INFO - TinderboxPrint: CPU system
961.4 (20.0%) 00:12:20 INFO - TinderboxPrint: CPU user
1,622.2 (33.7%) 00:12:20 INFO - TinderboxPrint: Swap in / out
290,684,928 / 0 00:12:20 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 228954624; Write bytes: 220180480; Read time: 16365; Write time: 389 00:12:20 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 41292800; Write bytes: 305902592; Read time: 589; Write time: 1650 00:12:20 INFO - Running post-run listener: _upload_blobber_files 00:12:20 INFO - Blob upload gear active. 00:12:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:12:20 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 00:12:20 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'] 00:12:20 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 00:12:21 INFO - (blobuploader) - INFO - Open directory for files ... 00:12:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:12:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:12:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:12:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:12:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:12:25 INFO - (blobuploader) - INFO - Done attempting. 00:12:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:12:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:12:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:12:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:12:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:12:26 INFO - (blobuploader) - INFO - Done attempting. 00:12:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:12:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:12:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:12:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:12:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:12:29 INFO - (blobuploader) - INFO - Done attempting. 00:12:29 INFO - (blobuploader) - INFO - Iteration through files over. 00:12:29 INFO - Return code: 0 00:12:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:12:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:12:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d102dfd3c0451cd43fb98670125a2043661956f7a5cd0292073cd899c8f84846c2b71beb98024dd0400ecbbf66988bd44789d4f743ed942b98edc99715477b28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/cde053a66db5db259e42295239d806e876b071081e86dd2b1748ac74de8220e7345a366499ebe2480a8357e6c3f867f81a6ca5160aaedab0958c67e36c91c15f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2c33f0c9d608e4d9f28c1ee6e5ecc39e5359c56082b5d314030f3aa8969e764ece8f820e13a4dd113db733c850bc8c724b08f0b21122684db9d64059a6bb4009"} 00:12:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:12:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:12:29 INFO - Contents: 00:12:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d102dfd3c0451cd43fb98670125a2043661956f7a5cd0292073cd899c8f84846c2b71beb98024dd0400ecbbf66988bd44789d4f743ed942b98edc99715477b28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/cde053a66db5db259e42295239d806e876b071081e86dd2b1748ac74de8220e7345a366499ebe2480a8357e6c3f867f81a6ca5160aaedab0958c67e36c91c15f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2c33f0c9d608e4d9f28c1ee6e5ecc39e5359c56082b5d314030f3aa8969e764ece8f820e13a4dd113db733c850bc8c724b08f0b21122684db9d64059a6bb4009"} 00:12:29 INFO - Running post-run listener: copy_logs_to_upload_dir 00:12:29 INFO - Copying logs to upload dir... 00:12:29 INFO - mkdir: /builds/slave/test/build/upload/logs 00:12:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.875427 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-12-14 00:12:29.161744) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-14 00:12:29.166719) ========= 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.ZFTnPWGBHg/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.aqBlkXj72W/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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/d102dfd3c0451cd43fb98670125a2043661956f7a5cd0292073cd899c8f84846c2b71beb98024dd0400ecbbf66988bd44789d4f743ed942b98edc99715477b28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/cde053a66db5db259e42295239d806e876b071081e86dd2b1748ac74de8220e7345a366499ebe2480a8357e6c3f867f81a6ca5160aaedab0958c67e36c91c15f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2c33f0c9d608e4d9f28c1ee6e5ecc39e5359c56082b5d314030f3aa8969e764ece8f820e13a4dd113db733c850bc8c724b08f0b21122684db9d64059a6bb4009"} build_url:https://queue.taskcluster.net/v1/task/Get9xO1OSOewX46E8ZVKQg/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg program finished with exit code 0 elapsedTime=0.011111 build_url: 'https://queue.taskcluster.net/v1/task/Get9xO1OSOewX46E8ZVKQg/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d102dfd3c0451cd43fb98670125a2043661956f7a5cd0292073cd899c8f84846c2b71beb98024dd0400ecbbf66988bd44789d4f743ed942b98edc99715477b28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/cde053a66db5db259e42295239d806e876b071081e86dd2b1748ac74de8220e7345a366499ebe2480a8357e6c3f867f81a6ca5160aaedab0958c67e36c91c15f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2c33f0c9d608e4d9f28c1ee6e5ecc39e5359c56082b5d314030f3aa8969e764ece8f820e13a4dd113db733c850bc8c724b08f0b21122684db9d64059a6bb4009"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-14 00:12:29.203974) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 00:12:29.204312) ========= 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.ZFTnPWGBHg/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.aqBlkXj72W/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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.005014 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 00:12:29.253244) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-14 00:12:29.256616) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-14 00:12:29.256965) ========= ========= Total master_lag: 0.20 =========