builder: cedar_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0028 starttime: 1481314963.77 results: success (0) buildid: 20161209110352 builduid: 66c4702f7f4247a2aed5fe32efc47a91 revision: 36427ea97e874176d72778553b0f1eae8d119058 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-09 12:22:43.771114) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-09 12:22:43.771585) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-09 12:22:43.771907) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-09 12:22:43.840167) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 12:22:43.840843) ========= 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.PoiJilgLyh/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.rwt8XB5FOm/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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-09 12:22:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.18M=0.001s 2016-12-09 12:22:44 (8.18 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.471559 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 12:22:44.336833) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 12:22:44.337215) ========= 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.PoiJilgLyh/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.rwt8XB5FOm/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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.019785 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 12:22:44.386759) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-09 12:22:44.387243) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev 36427ea97e874176d72778553b0f1eae8d119058 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/cedar --rev 36427ea97e874176d72778553b0f1eae8d119058 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PoiJilgLyh/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.rwt8XB5FOm/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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-09 12:22:44,464 truncating revision to first 12 chars 2016-12-09 12:22:44,464 Setting DEBUG logging. 2016-12-09 12:22:44,464 attempt 1/10 2016-12-09 12:22:44,464 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/36427ea97e87?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-09 12:22:45,826 unpacking tar archive at: cedar-36427ea97e87/testing/mozharness/ program finished with exit code 0 elapsedTime=1.614329 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-09 12:22:46.025050) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-09 12:22:46.025377) ========= script_repo_revision: 36427ea97e874176d72778553b0f1eae8d119058 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-09 12:22:46.025791) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-09 12:22:46.026057) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-09 12:22:46.045920) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-12-09 12:22:46.046291) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 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', 'Cedar', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PoiJilgLyh/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.rwt8XB5FOm/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 12:22:46 INFO - MultiFileLogger online at 20161209 12:22:46 in /builds/slave/test 12:22:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 12:22:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:22:46 INFO - {'append_to_log': False, 12:22:46 INFO - 'base_work_dir': '/builds/slave/test', 12:22:46 INFO - 'blob_upload_branch': 'Cedar', 12:22:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:22:46 INFO - 'branch': 'Cedar', 12:22:46 INFO - 'buildbot_json_path': 'buildprops.json', 12:22:46 INFO - 'config_files': ('talos/mac_config.py',), 12:22:46 INFO - 'default_actions': ('clobber', 12:22:46 INFO - 'read-buildbot-config', 12:22:46 INFO - 'download-and-extract', 12:22:46 INFO - 'populate-webroot', 12:22:46 INFO - 'create-virtualenv', 12:22:46 INFO - 'install', 12:22:46 INFO - 'run-tests'), 12:22:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:22:46 INFO - 'download_minidump_stackwalk': True, 12:22:46 INFO - 'download_symbols': 'ondemand', 12:22:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:22:46 INFO - 'tooltool.py': '/tools/tooltool.py', 12:22:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:22:46 INFO - '/tools/misc-python/virtualenv.py')}, 12:22:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:22:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:22:46 INFO - 'installer_path': 'installer.exe', 12:22:46 INFO - 'log_level': 'info', 12:22:46 INFO - 'log_name': 'talos', 12:22:46 INFO - 'log_to_console': True, 12:22:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:22:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:22:46 INFO - 'opt_config_files': (), 12:22:46 INFO - 'pip_index': False, 12:22:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:22:46 INFO - 'cmd': ('bash', 12:22:46 INFO - '-c', 12:22:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:22:46 INFO - 'enabled': True, 12:22:46 INFO - 'halt_on_failure': False, 12:22:46 INFO - 'name': 'check_screen_resolution'},), 12:22:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:22:46 INFO - 'cmd': ('bash', 12:22:46 INFO - '-c', 12:22:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:22:46 INFO - 'enabled': True, 12:22:46 INFO - 'halt_on_failure': False, 12:22:46 INFO - 'name': 'check_screen_resolution'},), 12:22:46 INFO - 'run_cmd_checks_enabled': True, 12:22:46 INFO - 'sps_profile': False, 12:22:46 INFO - 'sps_profile_interval': 0, 12:22:46 INFO - 'suite': 'dromaeojs', 12:22:46 INFO - 'system_bits': '32', 12:22:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:22:46 INFO - 'title': 't-yosemite-r7-0028', 12:22:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:22:46 INFO - 'use_talos_json': True, 12:22:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:22:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:22:46 INFO - 'work_dir': 'build'} 12:22:46 INFO - [mozharness: 2016-12-09 20:22:46.248313Z] Running clobber step. 12:22:46 INFO - Running pre-action listener: _resource_record_pre_action 12:22:46 INFO - Running main action method: clobber 12:22:46 INFO - rmtree: /builds/slave/test/build 12:22:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:22:47 INFO - Running post-action listener: _resource_record_post_action 12:22:47 INFO - [mozharness: 2016-12-09 20:22:47.164781Z] Finished clobber step (success) 12:22:47 INFO - [mozharness: 2016-12-09 20:22:47.164903Z] Running read-buildbot-config step. 12:22:47 INFO - Running pre-action listener: _resource_record_pre_action 12:22:47 INFO - Running main action method: read_buildbot_config 12:22:47 INFO - Using buildbot properties: 12:22:47 INFO - { 12:22:47 INFO - "project": "", 12:22:47 INFO - "product": "firefox", 12:22:47 INFO - "script_repo_revision": "default", 12:22:47 INFO - "builddir": "cedar_yosemite_r7_test-dromaeojs", 12:22:47 INFO - "repository": "", 12:22:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 cedar talos dromaeojs", 12:22:47 INFO - "buildid": "20161209110352", 12:22:47 INFO - "pgo_build": "False", 12:22:47 INFO - "basedir": "/builds/slave/test", 12:22:47 INFO - "buildnumber": 4, 12:22:47 INFO - "slavename": "t-yosemite-r7-0028", 12:22:47 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 12:22:47 INFO - "platform": "yosemite_r7", 12:22:47 INFO - "scheduler": "tests-cedar-macosx64-talos", 12:22:47 INFO - "branch": "cedar", 12:22:47 INFO - "repo_path": "projects/cedar", 12:22:47 INFO - "revision": "36427ea97e874176d72778553b0f1eae8d119058", 12:22:47 INFO - "stage_platform": "macosx64", 12:22:47 INFO - "builduid": "66c4702f7f4247a2aed5fe32efc47a91", 12:22:47 INFO - "slavebuilddir": "test" 12:22:47 INFO - } 12:22:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/JkFdjCmgSI2uA_Giuo0Dog/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg. 12:22:47 INFO - Running post-action listener: _resource_record_post_action 12:22:47 INFO - [mozharness: 2016-12-09 20:22:47.168174Z] Finished read-buildbot-config step (success) 12:22:47 INFO - [mozharness: 2016-12-09 20:22:47.168320Z] Running download-and-extract step. 12:22:47 INFO - Running pre-action listener: _resource_record_pre_action 12:22:47 INFO - Running main action method: download_and_extract 12:22:47 INFO - mkdir: /builds/slave/test/build/tests 12:22:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:47 INFO - trying https://queue.taskcluster.net/v1/task/JkFdjCmgSI2uA_Giuo0Dog/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json 12:22:47 INFO - Downloading https://queue.taskcluster.net/v1/task/JkFdjCmgSI2uA_Giuo0Dog/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 12:22:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JkFdjCmgSI2uA_Giuo0Dog/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 12:22:48 INFO - Downloaded 1235 bytes. 12:22:48 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json 12:22:48 INFO - Using the following test package requirements: 12:22:48 INFO - {u'common': [u'firefox-53.0a1.en-US.mac64.common.tests.zip'], 12:22:48 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 12:22:48 INFO - u'firefox-53.0a1.en-US.mac64.cppunittest.tests.zip'], 12:22:48 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 12:22:48 INFO - u'firefox-53.0a1.en-US.mac64.gtest.tests.zip'], 12:22:48 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 12:22:48 INFO - u'jsshell-mac64.zip'], 12:22:48 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 12:22:48 INFO - u'firefox-53.0a1.en-US.mac64.mochitest.tests.zip'], 12:22:48 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac64.common.tests.zip'], 12:22:48 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 12:22:48 INFO - u'firefox-53.0a1.en-US.mac64.reftest.tests.zip'], 12:22:48 INFO - u'talos': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 12:22:48 INFO - u'firefox-53.0a1.en-US.mac64.talos.tests.zip'], 12:22:48 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 12:22:48 INFO - u'firefox-53.0a1.en-US.mac64.web-platform.tests.zip'], 12:22:48 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 12:22:48 INFO - u'firefox-53.0a1.en-US.mac64.xpcshell.tests.zip']} 12:22:48 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac64.common.tests.zip'] for test suite category: common 12:22:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JkFdjCmgSI2uA_Giuo0Dog/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip 12:22:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JkFdjCmgSI2uA_Giuo0Dog/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip'}, attempt #1 12:22:48 INFO - Fetch https://queue.taskcluster.net/v1/task/JkFdjCmgSI2uA_Giuo0Dog/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip into memory 12:22:49 INFO - Expected file size: 16287254 12:22:49 INFO - Obtained file size: 16287254 12:22:56 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 12:22:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JkFdjCmgSI2uA_Giuo0Dog/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip 12:22:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JkFdjCmgSI2uA_Giuo0Dog/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip'}, attempt #1 12:22:56 INFO - Fetch https://queue.taskcluster.net/v1/task/JkFdjCmgSI2uA_Giuo0Dog/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip into memory 12:22:57 INFO - Expected file size: 16287254 12:22:57 INFO - Obtained file size: 16287254 12:23:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JkFdjCmgSI2uA_Giuo0Dog/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip 12:23:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JkFdjCmgSI2uA_Giuo0Dog/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip'}, attempt #1 12:23:03 INFO - Fetch https://queue.taskcluster.net/v1/task/JkFdjCmgSI2uA_Giuo0Dog/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip into memory 12:23:05 INFO - Expected file size: 14409734 12:23:05 INFO - Obtained file size: 14409734 12:23: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')]} 12:23:05 INFO - trying https://queue.taskcluster.net/v1/task/JkFdjCmgSI2uA_Giuo0Dog/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 12:23:05 INFO - Downloading https://queue.taskcluster.net/v1/task/JkFdjCmgSI2uA_Giuo0Dog/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg 12:23:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JkFdjCmgSI2uA_Giuo0Dog/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 12:23:08 INFO - Downloaded 69681227 bytes. 12:23:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JkFdjCmgSI2uA_Giuo0Dog/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 12:23:08 INFO - mkdir: /builds/slave/test/properties 12:23:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:23:08 INFO - Writing to file /builds/slave/test/properties/build_url 12:23:08 INFO - Contents: 12:23:08 INFO - build_url:https://queue.taskcluster.net/v1/task/JkFdjCmgSI2uA_Giuo0Dog/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 12:23:09 INFO - Running post-action listener: _resource_record_post_action 12:23:09 INFO - Running post-action listener: set_extra_try_arguments 12:23:09 INFO - [mozharness: 2016-12-09 20:23:09.087876Z] Finished download-and-extract step (success) 12:23:09 INFO - [mozharness: 2016-12-09 20:23:09.088010Z] Running populate-webroot step. 12:23:09 INFO - Running pre-action listener: _resource_record_pre_action 12:23:09 INFO - Running main action method: populate_webroot 12:23:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:23:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:23:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:23:09 INFO - '--tppagecycles', 12:23:09 INFO - '7'], 12:23:09 INFO - 'tests': ['tsvgm']}}, 12:23:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:23:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:23:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:23:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:23:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:23:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:23:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:23:09 INFO - 'talos_options': ['--disable-e10s'], 12:23:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:23:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:23:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:23:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:23:09 INFO - 'talos_options': ['--disable-e10s'], 12:23:09 INFO - 'tests': ['damp', 'tps']}, 12:23:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:23:09 INFO - 'tests': ['damp', 'tps']}, 12:23:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:23:09 INFO - 'tests': ['dromaeo_dom']}, 12:23:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:23:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:23:09 INFO - 'tests': ['basic_compositor_video']}, 12:23:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:23:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:23:09 INFO - 'tests': ['a11yr', 12:23:09 INFO - 'ts_paint', 12:23:09 INFO - 'tpaint', 12:23:09 INFO - 'sessionrestore', 12:23:09 INFO - 'sessionrestore_no_auto_restore', 12:23:09 INFO - 'tabpaint']}, 12:23:09 INFO - 'other-e10s': {'tests': ['a11yr', 12:23:09 INFO - 'ts_paint', 12:23:09 INFO - 'tpaint', 12:23:09 INFO - 'sessionrestore', 12:23:09 INFO - 'sessionrestore_no_auto_restore', 12:23:09 INFO - 'tabpaint']}, 12:23:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:23:09 INFO - 'ts_paint', 12:23:09 INFO - 'tpaint', 12:23:09 INFO - 'sessionrestore', 12:23:09 INFO - 'sessionrestore_no_auto_restore', 12:23:09 INFO - 'tabpaint']}, 12:23:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:23:09 INFO - 'ts_paint', 12:23:09 INFO - 'tpaint', 12:23:09 INFO - 'sessionrestore', 12:23:09 INFO - 'sessionrestore_no_auto_restore', 12:23:09 INFO - 'tabpaint']}, 12:23:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:23:09 INFO - 'tests': ['a11yr', 12:23:09 INFO - 'ts_paint', 12:23:09 INFO - 'tpaint', 12:23:09 INFO - 'sessionrestore', 12:23:09 INFO - 'sessionrestore_no_auto_restore', 12:23:09 INFO - 'tabpaint']}, 12:23:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:23:09 INFO - 'tests': ['a11yr', 12:23:09 INFO - 'ts_paint', 12:23:09 INFO - 'tpaint', 12:23:09 INFO - 'sessionrestore', 12:23:09 INFO - 'sessionrestore_no_auto_restore', 12:23:09 INFO - 'tabpaint']}, 12:23:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:23:09 INFO - 'tests': ['tsvgx', 12:23:09 INFO - 'tsvgr_opacity', 12:23:09 INFO - 'tart', 12:23:09 INFO - 'tscrollx', 12:23:09 INFO - 'cart', 12:23:09 INFO - 'tsvg_static']}, 12:23:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:23:09 INFO - 'tsvgr_opacity', 12:23:09 INFO - 'tart', 12:23:09 INFO - 'tscrollx', 12:23:09 INFO - 'cart', 12:23:09 INFO - 'tsvg_static']}, 12:23:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:23:09 INFO - 'talos_options': ['--disable-e10s'], 12:23:09 INFO - 'tests': ['tp5o']}, 12:23:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:23:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:23:09 INFO - 'talos_options': ['--disable-e10s', 12:23:09 INFO - '--xperf_path', 12:23:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:23:09 INFO - 'tests': ['tp5n']}, 12:23:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:23:09 INFO - 'talos_options': ['--xperf_path', 12:23:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:23:09 INFO - 'tests': ['tp5n']}}, 12:23:09 INFO - 'talos.zip': {'path': '', 12:23:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:23:09 INFO - Running post-action listener: _resource_record_post_action 12:23:09 INFO - [mozharness: 2016-12-09 20:23:09.106799Z] Finished populate-webroot step (success) 12:23:09 INFO - [mozharness: 2016-12-09 20:23:09.106909Z] Running create-virtualenv step. 12:23:09 INFO - Running pre-action listener: _resource_record_pre_action 12:23:09 INFO - Running main action method: create_virtualenv 12:23:09 INFO - Creating virtualenv /builds/slave/test/build/venv 12:23:09 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 12:23:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:23:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:23:09 INFO - Using real prefix '/tools/python27' 12:23:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:23:09 INFO - Installing distribute.............................................................................................................................................................................................done. 12:23:12 INFO - Installing pip.................done. 12:23:12 INFO - Return code: 0 12:23:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:23:13 INFO - Reading from file tmpfile_stdout 12:23:13 INFO - Output received: 12:23:13 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) 12:23:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:23:13 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')]} 12:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:13 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')]} 12:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:13 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 0x10adb23f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad28570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb92d6c4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abc7d30>, '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 0x10aa2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10abbfb20>, '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.PoiJilgLyh/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.rwt8XB5FOm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 12:23:13 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 12:23:13 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 12:23:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PoiJilgLyh/Render', 12:23:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:23:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:23:13 INFO - 'HOME': '/Users/cltbld', 12:23:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:23:13 INFO - 'LOGNAME': 'cltbld', 12:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:13 INFO - 'MOZ_NO_REMOTE': '1', 12:23:13 INFO - 'NO_EM_RESTART': '1', 12:23:13 INFO - 'PAGER': '/bin/cat', 12:23:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:13 INFO - 'PWD': '/builds/slave/test', 12:23:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:23:13 INFO - 'SHELL': '/bin/bash', 12:23:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rwt8XB5FOm/Listeners', 12:23:13 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 12:23:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:23:13 INFO - 'USER': 'cltbld', 12:23:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:23:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:13 INFO - 'XPC_FLAGS': '0x0', 12:23:13 INFO - 'XPC_SERVICE_NAME': '0', 12:23:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:13 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 12:23:13 INFO - Cleaning up... 12:23:13 INFO - Return code: 0 12:23:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:23:13 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')]} 12:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:13 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')]} 12:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:13 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 0x10adb23f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad28570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb92d6c4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abc7d30>, '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 0x10aa2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10abbfb20>, '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.PoiJilgLyh/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.rwt8XB5FOm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 12:23:13 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 12:23:13 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 12:23:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PoiJilgLyh/Render', 12:23:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:23:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:23:13 INFO - 'HOME': '/Users/cltbld', 12:23:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:23:13 INFO - 'LOGNAME': 'cltbld', 12:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:13 INFO - 'MOZ_NO_REMOTE': '1', 12:23:13 INFO - 'NO_EM_RESTART': '1', 12:23:13 INFO - 'PAGER': '/bin/cat', 12:23:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:13 INFO - 'PWD': '/builds/slave/test', 12:23:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:23:13 INFO - 'SHELL': '/bin/bash', 12:23:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rwt8XB5FOm/Listeners', 12:23:13 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 12:23:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:23:13 INFO - 'USER': 'cltbld', 12:23:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:23:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:13 INFO - 'XPC_FLAGS': '0x0', 12:23:13 INFO - 'XPC_SERVICE_NAME': '0', 12:23:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:13 INFO - Downloading/unpacking psutil>=3.1.1 12:23:13 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 12:23:13 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 12:23:13 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 12:23:13 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 12:23:13 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 12:23:13 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 12:23:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:23:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:23:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:23:17 INFO - Installing collected packages: psutil 12:23:17 INFO - Running setup.py install for psutil 12:23:17 INFO - building 'psutil._psutil_osx' extension 12:23:17 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 12:23:17 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 12:23:17 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 12:23:18 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 12:23:18 INFO - building 'psutil._psutil_posix' extension 12:23:18 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 12:23:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:23:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:23:18 INFO - ^ 12:23:18 INFO - 1 warning generated. 12:23:18 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 12:23:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:23:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:23:18 INFO - Successfully installed psutil 12:23:18 INFO - Cleaning up... 12:23:18 INFO - Return code: 0 12:23:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10adb23f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad28570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb92d6c4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abc7d30>, '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 0x10aa2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10abbfb20>, '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.PoiJilgLyh/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.rwt8XB5FOm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 12:23:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:23:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:23:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PoiJilgLyh/Render', 12:23:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:23:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:23:18 INFO - 'HOME': '/Users/cltbld', 12:23:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:23:18 INFO - 'LOGNAME': 'cltbld', 12:23:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:18 INFO - 'MOZ_NO_REMOTE': '1', 12:23:18 INFO - 'NO_EM_RESTART': '1', 12:23:18 INFO - 'PAGER': '/bin/cat', 12:23:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:23:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:18 INFO - 'PWD': '/builds/slave/test', 12:23:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:23:18 INFO - 'SHELL': '/bin/bash', 12:23:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rwt8XB5FOm/Listeners', 12:23:18 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 12:23:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:23:18 INFO - 'USER': 'cltbld', 12:23:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:23:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:23:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:18 INFO - 'XPC_FLAGS': '0x0', 12:23:18 INFO - 'XPC_SERVICE_NAME': '0', 12:23:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:23:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:23:18 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 12:23:18 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 12:23:18 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 12:23:18 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 12:23:18 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 12:23:18 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 12:23:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:23:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:23:21 INFO - Installing collected packages: mozsystemmonitor 12:23:21 INFO - Running setup.py install for mozsystemmonitor 12:23:21 INFO - Successfully installed mozsystemmonitor 12:23:21 INFO - Cleaning up... 12:23:21 INFO - Return code: 0 12:23:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10adb23f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad28570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb92d6c4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abc7d30>, '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 0x10aa2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10abbfb20>, '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.PoiJilgLyh/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.rwt8XB5FOm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 12:23:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:23:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:23:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PoiJilgLyh/Render', 12:23:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:23:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:23:21 INFO - 'HOME': '/Users/cltbld', 12:23:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:23:21 INFO - 'LOGNAME': 'cltbld', 12:23:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:21 INFO - 'MOZ_NO_REMOTE': '1', 12:23:21 INFO - 'NO_EM_RESTART': '1', 12:23:21 INFO - 'PAGER': '/bin/cat', 12:23:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:23:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:21 INFO - 'PWD': '/builds/slave/test', 12:23:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:23:21 INFO - 'SHELL': '/bin/bash', 12:23:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rwt8XB5FOm/Listeners', 12:23:21 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 12:23:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:23:21 INFO - 'USER': 'cltbld', 12:23:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:23:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:23:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:21 INFO - 'XPC_FLAGS': '0x0', 12:23:21 INFO - 'XPC_SERVICE_NAME': '0', 12:23:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:23:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:21 INFO - Downloading/unpacking jsonschema==2.5.1 12:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:23:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:23:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:23:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:23:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:23:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:23:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:23:24 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 12:23:24 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 12:23:24 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 12:23:24 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 12:23:24 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 12:23:24 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 12:23:24 INFO - Downloading functools32-3.2.3-2.tar.gz 12:23:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:23:24 INFO - warning: no files found matching '*.txt' 12:23:24 INFO - no previously-included directories found matching 'build' 12:23:24 INFO - no previously-included directories found matching 'dist' 12:23:24 INFO - no previously-included directories found matching '.git*' 12:23:24 INFO - Installing collected packages: jsonschema, functools32 12:23:25 INFO - Running setup.py install for functools32 12:23:25 INFO - warning: no files found matching '*.txt' 12:23:25 INFO - no previously-included directories found matching 'build' 12:23:25 INFO - no previously-included directories found matching 'dist' 12:23:25 INFO - no previously-included directories found matching '.git*' 12:23:25 INFO - Successfully installed jsonschema functools32 12:23:25 INFO - Cleaning up... 12:23:25 INFO - Return code: 0 12:23:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:23:25 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')]} 12:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:25 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')]} 12:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:25 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 0x10adb23f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad28570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb92d6c4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abc7d30>, '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 0x10aa2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10abbfb20>, '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.PoiJilgLyh/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.rwt8XB5FOm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 12:23:25 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 12:23:25 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 12:23:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PoiJilgLyh/Render', 12:23:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:23:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:23:25 INFO - 'HOME': '/Users/cltbld', 12:23:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:23:25 INFO - 'LOGNAME': 'cltbld', 12:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:25 INFO - 'MOZ_NO_REMOTE': '1', 12:23:25 INFO - 'NO_EM_RESTART': '1', 12:23:25 INFO - 'PAGER': '/bin/cat', 12:23:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:25 INFO - 'PWD': '/builds/slave/test', 12:23:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:23:25 INFO - 'SHELL': '/bin/bash', 12:23:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rwt8XB5FOm/Listeners', 12:23:25 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 12:23:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:23:25 INFO - 'USER': 'cltbld', 12:23:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:23:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:25 INFO - 'XPC_FLAGS': '0x0', 12:23:25 INFO - 'XPC_SERVICE_NAME': '0', 12:23:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:23:25 INFO - Cleaning up... 12:23:25 INFO - Return code: 0 12:23:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:23:25 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')]} 12:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:25 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')]} 12:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:25 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 0x10adb23f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad28570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb92d6c4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abc7d30>, '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 0x10aa2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10abbfb20>, '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.PoiJilgLyh/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.rwt8XB5FOm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 12:23:25 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 12:23:25 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 12:23:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PoiJilgLyh/Render', 12:23:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:23:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:23:25 INFO - 'HOME': '/Users/cltbld', 12:23:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:23:25 INFO - 'LOGNAME': 'cltbld', 12:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:25 INFO - 'MOZ_NO_REMOTE': '1', 12:23:25 INFO - 'NO_EM_RESTART': '1', 12:23:25 INFO - 'PAGER': '/bin/cat', 12:23:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:25 INFO - 'PWD': '/builds/slave/test', 12:23:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:23:25 INFO - 'SHELL': '/bin/bash', 12:23:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rwt8XB5FOm/Listeners', 12:23:25 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 12:23:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:23:25 INFO - 'USER': 'cltbld', 12:23:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:23:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:25 INFO - 'XPC_FLAGS': '0x0', 12:23:25 INFO - 'XPC_SERVICE_NAME': '0', 12:23:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:25 INFO - Downloading/unpacking blobuploader==1.2.4 12:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:23:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:23:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:23:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:23:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:23:28 INFO - Downloading blobuploader-1.2.4.tar.gz 12:23:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:23:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:23:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:23:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:23:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:23:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:23:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:23:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:23:29 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 12:23:29 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 12:23:29 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 12:23:29 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 12:23:29 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 12:23:29 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 12:23:29 INFO - Downloading docopt-0.6.1.tar.gz 12:23:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:23:29 INFO - Installing collected packages: blobuploader, requests, docopt 12:23:29 INFO - Running setup.py install for blobuploader 12:23:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:23:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:23:29 INFO - Running setup.py install for requests 12:23:30 INFO - Running setup.py install for docopt 12:23:30 INFO - Successfully installed blobuploader requests docopt 12:23:30 INFO - Cleaning up... 12:23:30 INFO - Return code: 0 12:23:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:23:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:30 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 0x10adb23f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad28570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb92d6c4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abc7d30>, '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 0x10aa2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10abbfb20>, '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.PoiJilgLyh/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.rwt8XB5FOm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 12:23:30 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 12:23:30 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 12:23:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PoiJilgLyh/Render', 12:23:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:23:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:23:30 INFO - 'HOME': '/Users/cltbld', 12:23:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:23:30 INFO - 'LOGNAME': 'cltbld', 12:23:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:30 INFO - 'MOZ_NO_REMOTE': '1', 12:23:30 INFO - 'NO_EM_RESTART': '1', 12:23:30 INFO - 'PAGER': '/bin/cat', 12:23:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:23:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:30 INFO - 'PWD': '/builds/slave/test', 12:23:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:23:30 INFO - 'SHELL': '/bin/bash', 12:23:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rwt8XB5FOm/Listeners', 12:23:30 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 12:23:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:23:30 INFO - 'USER': 'cltbld', 12:23:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:23:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:23:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:30 INFO - 'XPC_FLAGS': '0x0', 12:23:30 INFO - 'XPC_SERVICE_NAME': '0', 12:23:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:23:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:23:30 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-LFOA03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:23:30 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-LIpX1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:23:31 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-DGKYU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:23:31 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-OUkbux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:23:31 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-iFCVFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:23:31 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-TJZ8wm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:23:31 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-v06MPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:23:31 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-R6f3ah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:23:31 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-ZeCHyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:23:31 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-h2NjTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:23:31 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-zQAqIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:23:31 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-wEpeTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:23:32 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-qhpOMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:23:32 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-UeudSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:23:32 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-TG7cBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:23:32 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-8tNkDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:23:32 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-swVBm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:23:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:23:32 INFO - Running setup.py install for manifestparser 12:23:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:23:32 INFO - Running setup.py install for mozcrash 12:23:32 INFO - Running setup.py install for mozdebug 12:23:32 INFO - Running setup.py install for mozdevice 12:23:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:23:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:23:33 INFO - Running setup.py install for mozfile 12:23:33 INFO - Running setup.py install for mozhttpd 12:23:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:23:33 INFO - Running setup.py install for mozinfo 12:23:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:23:33 INFO - Running setup.py install for mozInstall 12:23:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:23:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:23:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:23:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:23:33 INFO - Running setup.py install for mozleak 12:23:33 INFO - Running setup.py install for mozlog 12:23:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:23:34 INFO - Running setup.py install for moznetwork 12:23:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:23:34 INFO - Running setup.py install for mozprocess 12:23:34 INFO - Running setup.py install for mozprofile 12:23:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:23:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:23:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:23:34 INFO - Running setup.py install for mozrunner 12:23:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:23:34 INFO - Running setup.py install for mozscreenshot 12:23:34 INFO - Running setup.py install for moztest 12:23:34 INFO - Running setup.py install for mozversion 12:23:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:23:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:23:35 INFO - Cleaning up... 12:23:35 INFO - Return code: 0 12:23:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:35 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 0x10adb23f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad28570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb92d6c4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abc7d30>, '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 0x10aa2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10abbfb20>, '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.PoiJilgLyh/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.rwt8XB5FOm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 12:23:35 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 12:23:35 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 12:23:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PoiJilgLyh/Render', 12:23:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:23:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:23:35 INFO - 'HOME': '/Users/cltbld', 12:23:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:23:35 INFO - 'LOGNAME': 'cltbld', 12:23:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:35 INFO - 'MOZ_NO_REMOTE': '1', 12:23:35 INFO - 'NO_EM_RESTART': '1', 12:23:35 INFO - 'PAGER': '/bin/cat', 12:23:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:23:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:35 INFO - 'PWD': '/builds/slave/test', 12:23:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:23:35 INFO - 'SHELL': '/bin/bash', 12:23:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rwt8XB5FOm/Listeners', 12:23:35 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 12:23:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:23:35 INFO - 'USER': 'cltbld', 12:23:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:23:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:23:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:35 INFO - 'XPC_FLAGS': '0x0', 12:23:35 INFO - 'XPC_SERVICE_NAME': '0', 12:23:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:23:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:23:35 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-C2qOAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:23:35 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)) 12:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:23:35 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-DVRAYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:23:35 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)) 12:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:23:35 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-mH1Fad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:23:35 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)) 12:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:23:35 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-6gco10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:23:35 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)) 12:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:23:35 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-ZeifiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:23:35 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)) 12:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:23:35 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-jjOfPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:23:36 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)) 12:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:23:36 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-e3XDz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:23:36 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)) 12:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:23:36 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-muf8eH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:23:36 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)) 12:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:23:36 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-z3GOBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:23:36 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)) 12:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:23:36 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-PivEyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:23:36 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)) 12:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:23:36 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-IvHqah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:23:36 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)) 12:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:23:36 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-lSRV62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:23:36 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)) 12:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:23:36 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-GZZqQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:23:36 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)) 12:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:23:36 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-Uw3rJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:23:36 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)) 12:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:23:36 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-re6Guk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:23:36 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)) 12:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:23:37 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-m7vrVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:23:37 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)) 12:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:23:37 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-BlbHFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:23:37 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)) 12:23:37 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)) 12:23:37 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)) 12:23:37 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)) 12:23:37 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)) 12:23:37 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)) 12:23:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:23:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:23:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:23:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:23:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:23:39 INFO - Downloading blessings-1.6.tar.gz 12:23:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:23:39 INFO - Installing collected packages: blessings 12:23:39 INFO - Running setup.py install for blessings 12:23:40 INFO - Successfully installed blessings 12:23:40 INFO - Cleaning up... 12:23:40 INFO - Return code: 0 12:23:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:23:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:23:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:23:40 INFO - Reading from file tmpfile_stdout 12:23:40 INFO - Current package versions: 12:23:40 INFO - blessings == 1.6 12:23:40 INFO - blobuploader == 1.2.4 12:23:40 INFO - docopt == 0.6.1 12:23:40 INFO - functools32 == 3.2.3-2 12:23:40 INFO - jsonschema == 2.5.1 12:23:40 INFO - manifestparser == 1.1 12:23:40 INFO - mozInstall == 1.12 12:23:40 INFO - mozcrash == 1.0 12:23:40 INFO - mozdebug == 0.1 12:23:40 INFO - mozdevice == 0.49 12:23:40 INFO - mozfile == 1.2 12:23:40 INFO - mozhttpd == 0.7 12:23:40 INFO - mozinfo == 0.9 12:23:40 INFO - mozleak == 0.1 12:23:40 INFO - mozlog == 3.4 12:23:40 INFO - moznetwork == 0.27 12:23:40 INFO - mozprocess == 0.23 12:23:40 INFO - mozprofile == 0.28 12:23:40 INFO - mozrunner == 6.13 12:23:40 INFO - mozscreenshot == 0.1 12:23:40 INFO - mozsystemmonitor == 0.3 12:23:40 INFO - moztest == 0.7 12:23:40 INFO - mozversion == 1.4 12:23:40 INFO - psutil == 3.1.1 12:23:40 INFO - requests == 1.2.3 12:23:40 INFO - wsgiref == 0.1.2 12:23:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:40 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 0x10adb23f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad28570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb92d6c4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abc7d30>, '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 0x10aa2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10abbfb20>, '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.PoiJilgLyh/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.rwt8XB5FOm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 12:23:40 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 12:23:40 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 12:23:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PoiJilgLyh/Render', 12:23:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:23:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:23:40 INFO - 'HOME': '/Users/cltbld', 12:23:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:23:40 INFO - 'LOGNAME': 'cltbld', 12:23:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:40 INFO - 'MOZ_NO_REMOTE': '1', 12:23:40 INFO - 'NO_EM_RESTART': '1', 12:23:40 INFO - 'PAGER': '/bin/cat', 12:23:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:23:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:40 INFO - 'PWD': '/builds/slave/test', 12:23:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:23:40 INFO - 'SHELL': '/bin/bash', 12:23:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rwt8XB5FOm/Listeners', 12:23:40 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 12:23:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:23:40 INFO - 'USER': 'cltbld', 12:23:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:23:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:23:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:40 INFO - 'XPC_FLAGS': '0x0', 12:23:40 INFO - 'XPC_SERVICE_NAME': '0', 12:23:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:23:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:40 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)) 12:23:40 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)) 12:23:40 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)) 12:23:40 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)) 12:23:40 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)) 12:23:40 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)) 12:23:40 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)) 12:23:40 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)) 12:23:40 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)) 12:23:40 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)) 12:23:40 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)) 12:23:40 INFO - Cleaning up... 12:23:40 INFO - Return code: 0 12:23:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:40 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 0x10adb23f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad28570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb92d6c4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abc7d30>, '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 0x10aa2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10abbfb20>, '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.PoiJilgLyh/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.rwt8XB5FOm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 12:23:40 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 12:23:40 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 12:23:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PoiJilgLyh/Render', 12:23:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:23:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:23:40 INFO - 'HOME': '/Users/cltbld', 12:23:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:23:40 INFO - 'LOGNAME': 'cltbld', 12:23:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:40 INFO - 'MOZ_NO_REMOTE': '1', 12:23:40 INFO - 'NO_EM_RESTART': '1', 12:23:40 INFO - 'PAGER': '/bin/cat', 12:23:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:23:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:40 INFO - 'PWD': '/builds/slave/test', 12:23:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:23:40 INFO - 'SHELL': '/bin/bash', 12:23:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rwt8XB5FOm/Listeners', 12:23:40 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 12:23:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:23:40 INFO - 'USER': 'cltbld', 12:23:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:23:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:23:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:40 INFO - 'XPC_FLAGS': '0x0', 12:23:40 INFO - 'XPC_SERVICE_NAME': '0', 12:23:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:23:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:23:40 INFO - Cleaning up... 12:23:40 INFO - Return code: 0 12:23:40 INFO - Running post-action listener: _resource_record_post_action 12:23:40 INFO - Running post-action listener: _start_resource_monitoring 12:23:40 INFO - Starting resource monitoring. 12:23:40 INFO - [mozharness: 2016-12-09 20:23:40.983441Z] Finished create-virtualenv step (success) 12:23:40 INFO - [mozharness: 2016-12-09 20:23:40.984488Z] Running install step. 12:23:40 INFO - Running pre-action listener: _resource_record_pre_action 12:23:40 INFO - Running main action method: install 12:23:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:23:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:23:41 INFO - Reading from file tmpfile_stdout 12:23:41 INFO - Detecting whether we're running mozinstall >=1.0... 12:23:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:23:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:23:41 INFO - Reading from file tmpfile_stdout 12:23:41 INFO - Output received: 12:23:41 INFO - Usage: mozinstall [options] installer 12:23:41 INFO - Options: 12:23:41 INFO - -h, --help show this help message and exit 12:23:41 INFO - -d DEST, --destination=DEST 12:23:41 INFO - Directory to install application into. [default: 12:23:41 INFO - "/builds/slave/test"] 12:23:41 INFO - --app=APP Application being installed. [default: firefox] 12:23:41 INFO - mkdir: /builds/slave/test/build/application 12:23:41 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'] 12:23:41 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 12:24:03 INFO - Reading from file tmpfile_stdout 12:24:03 INFO - Output received: 12:24:03 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:24:03 INFO - Running post-action listener: _resource_record_post_action 12:24:03 INFO - [mozharness: 2016-12-09 20:24:03.030682Z] Finished install step (success) 12:24:03 INFO - [mozharness: 2016-12-09 20:24:03.030834Z] Running run-tests step. 12:24:03 INFO - Running pre-action listener: _resource_record_pre_action 12:24:03 INFO - Running main action method: run_tests 12:24:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:24:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:24:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:24:03 INFO - 2016-12-09 12:24:03.045 screenresolution[1899:11032] starting screenresolution argv=screenresolution get 12:24:03 INFO - 2016-12-09 12:24:03.047 screenresolution[1899:11032] Display 0: 1600x1200x32@60 12:24:03 INFO - 2016-12-09 12:24:03.053 screenresolution[1900:11035] starting screenresolution argv=screenresolution list 12:24:03 INFO - Available Modes on Display 0 12:24:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:24:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:24:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:24:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:24:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:24:03 INFO - Intel Iris: 12:24:03 INFO - Chipset Model: Intel Iris 12:24:03 INFO - Type: GPU 12:24:03 INFO - Bus: Built-In 12:24:03 INFO - VRAM (Dynamic, Max): 1536 MB 12:24:03 INFO - Vendor: Intel (0x8086) 12:24:03 INFO - Device ID: 0x0a2e 12:24:03 INFO - Revision ID: 0x0009 12:24:03 INFO - Displays: 12:24:03 INFO - Display: 12:24:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:24:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:24:03 INFO - Display Serial Number: 1600x1200 60 12:24:03 INFO - Main Display: Yes 12:24:03 INFO - Mirror: Off 12:24:03 INFO - Online: Yes 12:24:03 INFO - Rotation: Supported 12:24:03 INFO - Return code: 0 12:24:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:24:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:24:03 INFO - Python 2.7.3 12:24:03 INFO - Return code: 0 12:24:03 INFO - grabbing minidump binary from tooltool 12:24:03 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')]} 12:24:03 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 0x10abc7d30>, '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 0x10aa2edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10abbfb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:24:03 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 12:24:03 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 12:24:03 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 12:24:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:24:03 INFO - Return code: 0 12:24:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:24:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:24:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:24:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:24:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:24:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JkFdjCmgSI2uA_Giuo0Dog/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0028', '--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 12:24:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JkFdjCmgSI2uA_Giuo0Dog/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip --title t-yosemite-r7-0028 --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 12:24:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PoiJilgLyh/Render', 12:24:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:24:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:24:03 INFO - 'HOME': '/Users/cltbld', 12:24:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:24:03 INFO - 'LOGNAME': 'cltbld', 12:24:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:24:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:03 INFO - 'MOZ_NO_REMOTE': '1', 12:24:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:24:03 INFO - 'NO_EM_RESTART': '1', 12:24:03 INFO - 'PAGER': '/bin/cat', 12:24:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:03 INFO - 'PWD': '/builds/slave/test', 12:24:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:24:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:24:03 INFO - 'SHELL': '/bin/bash', 12:24:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rwt8XB5FOm/Listeners', 12:24:03 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 12:24:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:24:03 INFO - 'USER': 'cltbld', 12:24:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:24:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:03 INFO - 'XPC_FLAGS': '0x0', 12:24:03 INFO - 'XPC_SERVICE_NAME': '0', 12:24:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:24:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JkFdjCmgSI2uA_Giuo0Dog/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0028', '--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 12:24:03 INFO - mozversion application_buildid: 20161209110352 12:24:03 INFO - mozversion application_changeset: 36427ea97e874176d72778553b0f1eae8d119058 12:24:03 INFO - mozversion application_display_name: Nightly 12:24:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:24:03 INFO - mozversion application_name: Firefox 12:24:03 INFO - mozversion application_remotingname: firefox 12:24:03 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 12:24:03 INFO - mozversion application_vendor: Mozilla 12:24:03 INFO - mozversion application_version: 53.0a1 12:24:03 INFO - mozversion platform_buildid: 20161209110352 12:24:03 INFO - mozversion platform_changeset: 36427ea97e874176d72778553b0f1eae8d119058 12:24:03 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 12:24:03 INFO - mozversion platform_version: 53.0a1 12:24:03 INFO - using testdate: 1481315043 12:24:03 INFO - actual date: 1481315043 12:24:03 INFO - starting webserver on 'localhost:49706' 12:24:03 INFO - SUITE-START | Running 2 tests 12:24:03 INFO - TEST-START | dromaeo_css 12:24:03 INFO - operating with platform_type : mac_ 12:24:03 INFO - Initialising browser for dromaeo_css test... 12:24:03 INFO - TEST-INFO | started process 1910 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpzg732m/profile http://localhost:49706/getInfo.html) 12:24:05 INFO - PROCESS | 1910 | __metrics Screen width/height:1600/1200 12:24:05 INFO - PROCESS | 1910 | colorDepth:24 12:24:05 INFO - PROCESS | 1910 | Browser inner width/height: 1024/689 12:24:05 INFO - PROCESS | 1910 | __metrics 12:24:05 INFO - PROCESS | 1910 | 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" 12:24:05 INFO - PROCESS | 1910 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:24:06 INFO - TEST-INFO | 1910: exit 0 12:24:06 INFO - Browser initialized. 12:24:06 INFO - Running cycle 1/1 for dromaeo_css test... 12:24:06 INFO - TEST-INFO | started process 1912 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpzg732m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:24:18 INFO - PROCESS | 1912 | RSS: Main: 236871680 12:24:18 INFO - PROCESS | 1912 | 12:25:10 INFO - PROCESS | 1912 | 1481315110250 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] 12:27:24 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:49706/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49706/tests/dromaeo/cssquery-ext.html) 12:27:26 INFO - PROCESS | 1912 | RSS: Main: 419840000 12:27:26 INFO - PROCESS | 1912 | 12:30:29 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:49706/tests/dromaeo/cssquery-ext.html (next: http://localhost:49706/tests/dromaeo/cssquery-jquery.html) 12:30:30 INFO - PROCESS | 1912 | RSS: Main: 373407744 12:30:30 INFO - PROCESS | 1912 | 12:33:32 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:49706/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49706/tests/dromaeo/cssquery-mootools.html) 12:33:33 INFO - PROCESS | 1912 | RSS: Main: 352661504 12:33:33 INFO - PROCESS | 1912 | 12:36:35 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:49706/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49706/tests/dromaeo/cssquery-prototype.html) 12:36:36 INFO - PROCESS | 1912 | RSS: Main: 352227328 12:36:36 INFO - PROCESS | 1912 | 12:39:40 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:49706/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49706/tests/dromaeo/cssquery-yui.html) 12:39:40 INFO - PROCESS | 1912 | RSS: Main: 341225472 12:39:40 INFO - PROCESS | 1912 | 12:42:44 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:49706/tests/dromaeo/cssquery-yui.html (next: http://localhost:49706/tests/dromaeo/cssquery-dojo.html) 12:42:44 INFO - PROCESS | 1912 | RSS: Main: 396328960 12:42:44 INFO - PROCESS | 1912 | 12:42:44 INFO - PROCESS | 1912 | __start_tp_report 12:42:44 INFO - PROCESS | 1912 | _x_x_mozilla_page_load 12:42:44 INFO - PROCESS | 1912 | _x_x_mozilla_page_load_details 12:42:44 INFO - PROCESS | 1912 | |i|pagename|runs| 12:42:44 INFO - PROCESS | 1912 | |0;dojo.html;2740;3229.2411283348415;3250.1062207892833;3276.459384201607;3294.9011529654117;5530.557555395569;5597.356304025033;5644.350899646547;5650.63270887392;5670.659760414373;5593.440655934404;5657.151427285909;5732.742026608802;5739.655620662763;5769.451902069297;4130.772807495587;5071.746412679369;5075;5139.537441630253;5140.383154021522;4587.103750497973;5182.8704282393055;5274.182501712241;5283.735813209343;5338.572914166877;5071.2139618359215;5100.821471248526;5210.973945130288;5261.368635763713;5294.629375943686;5166.638335316529;5172.61205409592;5177.974110129425;5178.404483484373;5178.637495375326;5094.694318340911;5129.9743501282255;5134.4095429025765;5151.819686310999;5171.482851714836;5611.270534830487;5621.831345059655;5634.239377684001;5646.520045796112;5656.321241451011;6118.436443820604;6125.052321061979;6128.483736330591;6130.724117414682;6130.837764763411;6165.32181460039;6239.188905442309;6242.282137554194;6257.78097766576;6273.654948977804;5227.764750586232;5330.493603107699;5703.486686198262;5766.163906233573;5775.220345253421;6171.475424588871;6254.15568898202;6254.3745625438005;6272.090546870678;6276.717547710364;6070.332263451017;6070.605410648293;6143.293521245025;6157.6613286269685;6164.845878852975;6227.719752611143;6240.375962403723;6251.437370636573;6259.499240060784;6265.561410701298;6212.502999760009;6216.595921265103;6219;6221;6223.657698826518;4889.462159162489;6018.608790428608;6080.817575472743;6092.964196086676;6208.782692605737;4387.561243875587;4906.730129842822;4921.409430868319;4929.162042452792;4935.679180853233;4212.0331197576415;4294.613484786321;4397.988462653544;4458.9331160032625;4471.731696098244;5601.691906945157;5649.548036157097;5650.604457688005;5661.915071273934;5679.034564124109;5511.43883531857;6169.660668663177;6170.074488826712;6172.4136207060255;6179.907301390393;5639.971800141055;5667.376588575254;5668.659880407106;5670.5463562914865;5678.290213723285;5329.600279978939;5383.892322153535;5384.273123128406;5396.811111611075;5429.15848043546;6308.873822523524;6318.494520438446;6322.620642761449;6327.936720632827;6343.555951083472;6115.1794953435965;6119.510439164945;6146.477549408171;6231.3145553988115;6240.500759939285;6133.793750436688;6147.801178770097;6213.59611625261;6231.40801623845;6251.937480625135;6002.369751176238;6016.909746353721;6021.036634138692;6022.384525263674;6057.242844644419;5126.6923984561045;5996.340402555803;5997.250343707036;6022.307434645072;6024.638521688713;5831.883362332815;5878.2064421304285;5900.29196496406;5927.377625349449;5976.701164941823;5817.185594016925;5958.880822383615;5976;6016.87966240664;6017.398260173947;5741.45456181662;5839.766409343749;5848.2689663792025;5853.560982926383;5862.618929769722;5861.677607731615;5915.970420147872;5927.436893495111;6025.457708806229;6030.517558595389;5791.594588378773;5828.0966450200285;5853.268341457318;5929.288485381781;5943.613665111754 12:42:44 INFO - PROCESS | 1912 | |1;ext.html;416.981235844387;449.4247363374881;468.6110528261541;500.74211780932814;505.55006044620296;22094.668579971312;31820.04539863802;38958.441662333506;40401.39397909034;40719.59280407195;41744.165116697644;42060.36909446361;42154;42256.57743422565;42312.365314520306;9157.542122893861;9372.625094996192;9377.390469619453;9378.249740020816;9384.061593840595;8393.664253429855;8610.87083693745;9356.298277629205;11092.611758588451;11369.374684392355;11292.717682057932;11314.208005439623;11314.547418103266;11337.14971377146;11344.43277836109;11281.943590282037;11351.148663850203;11362.034227090624;11364.31814091149;11386.373749443777;8313.293370063551;8548.529830859301;10947.671569852917;11170.27393219438;11214.327140371604;39713.40429893554;39987.80006099951;40023.19953600912;40082.99792505211;40395;3384.8815291464925;3495.877644282438;3503.1242189452637;3747.2880152770886;3856.5950575189763;29359.18330617006;30136.397272054655;30181.09456716302;30215;30308.696913030806;3035.2715348316465;3162.478191098466;3164.193130751644;3206.3266713990092;3261.266215101607;464945;480638;483689;485066;485581.99999999645;59681.701591491765;60145;60172.69913650491;60189.69905150446;60252.096218556755;63337;63437;63488.68255658692;63537;63559.68220158962;14931.805455563528;15443.918925675094;15687.764683529756;15730.764038539432;15754;10708.518116684612;10998.560057597606;11380.658580242605;11432.714182145513;11933.582324618597;14733.631659208391;15163.317650705745;16315.868413158549;20678.862662553704;20850;8249.463784853966;8307.709230176915;8353.916460835435;8365.874511882326;8404.747857564284;819.7417813388763;838.9958050209832;917.1195652173988;958.4872093429982;1100.4112799652307;29240.90627312178;29673.961411350498;29719.554206686917;30559.08322750321;30574.84712576423;977.4330888084894;1043.4678314059731;1053.5891002509027;1055.1084333737979;1108.955641774336;13491.595252142255;15295.082295062331;15473.5357939262;15669.843301566838;15971.920140399223;611670;612937;614876;616821;618038;58498.41501585015;59271.11093333604;59294.703526482954;59353.10970335449;59418.70290648519;1180.3095189314176;1261.7098067444356;1274.7259339241923;1276.0110914041506;1330.328184266939;29050.983215587352;30496;30602;30718.232044199074;31203.531947020358;49834.75082624564;50338.7483062597;50363.74818125886;50444.99110017706;50501;514673;515388;515677;516168.51494455227;516745;21233.89383053075;25207.11775087863;25437.60093194892;26081.869590651924;26562.86718566472;41426.96432589209;41657.58342416537;41989.79005105077;42157.367639486045;42588.148237035704;34613;34620.61517539371;34632.48051279182;35482.82258588794;35562.93311200668;34461.65538344585;34502.96491105271;35206.82396588001;35410.645893540735;35510.46734298936;34204.48693269653;34283;34465.96602101941;34974.47538286979;35078;29608;31244.375112497168;31295.687043129277;31350;31423.05730828079;23489.412764680335;23623.763762362843;23872.88063559671;23941;24158.75841241565 12:42:44 INFO - PROCESS | 1912 | |2;jquery.html;347.3591224191369;364.64447164015104;366.3405869435017;370.77012252403506;396.928552860485;13774.931125344372;14872.851271487296;16908.915455422706;19113.23547058116;20578.0739866706;20028.29900953467;20163.39509814704;20354.287599933967;20375.694364584542;20462;5317.574594032468;5859.238299021121;5923;5924.58527903047;5943.524518038568;4081.1429599784083;4320.740755554661;5771.682557459338;6228.159198508211;6647.036179753933;6113.144159817629;6306.936930630681;6635.734570617169;6686.1642294713165;6693.933060669379;7240.963795181016;7632.961835190844;7688.077430708351;7778.299953004257;7795.22047795216;7085.468589855782;7434.145073316529;7512.511686740344;7536.057992750906;7536.133344665379;22573.435664108365;25613.871930640413;26354.604680929802;27813.721862781316;28564.285892852637;2005.1277694203068;2319.8632669991753;2393.80849532037;2710.0921191400903;2992.521196608532;16089.839101608952;16358.591035224095;16405.753913691304;16462.917685411496;17344.826551734448;1984.7618285805652;2039.775624681284;2060.5569802492537;2073.4712648274594;2101.71626830379;127350.36324818409;130808.34595827055;139463.30268348593;140859.29570352184;142818.71678340874;19280.61438771217;21036.368908932756;21073.367798966057;21084.894575527025;21282.255121070997;28659.996900108395;29880.85059574688;29946.700532994826;31576.684233157834;33365.666343336256;10188.643397481053;10244.948775256076;10487.580496780196;10642.627508037182;10857.837132443019;7158.8210294742;8591.914080859236;8704.956475217583;8757.824843503095;8960.551972401354;7782.416318776001;9550.808983820285;9661.275404344702;9700.126988571063;9732.805343893082;3280.573525441725;3716.4659115878585;3728.5525736911745;3739.9252014959548;3782.2624588205585;831.8419500294924;836.9079401265856;921.1295325916944;930.0188301342149;1035.7928414317166;20076.498087547636;20595.279165229145;20777.79222207789;20835.79164208369;20956.637818541745;918.0544039639183;922.2161163011386;955.3121752338305;973.454865275448;1013.2350075692805;9957.352772069793;10375.27373083877;10752.354858708502;10798.568057277778;10858.511366988505;534335;534572;545747;568941;571979;125358;125988.85027874193;126796.36601816931;128354.71645283427;131252.3437382826;947.8104379124203;971.1065819446127;1015.1523477896039;1019.8266294729765;1025.4257615735212;14047.508337208557;18485.63028739391;19067.523311917314;19169.52076198106;19257.441481540558;43072.78463607662;53373;56967.86064278774;57694;58719.11921321098;76272.61863690647;76980;77715;77726.6113669428;79647.60176199082;7570.129435115033;7806.141324454419;7935.285824275843;7980.201979801974;8111.716089936824;9934.354266972623;12270.202436841577;12409.503619855104;12612.369381530703;12710;10648.414337211529;10935.83596246041;10944.288621239593;11031.39327336972;11129.610463633733;10435.843462348223;10588.41763702973;10843.349399036084;10993.010629043425;11083.113350931744;10738.892611073788;11171.273867198606;11226.719332016764;11264.380459074502;11346.829797553208;7871.803204919923;7939.2060793920145;7948.0859701132795;8068.556229407439;8233.46482478637;9152.725418237464;10447.791044179226;10673.679789606014;11085.667429977113;11115.277506962022 12:42:44 INFO - PROCESS | 1912 | |3;mootools.html;1451.8693317601414;1484.013131267707;1639.5163426789095;1788.830061144191;1813.9002354870477;7899.565523896191;8309.127541608135;8312.002559692837;8329.833403331937;8338.416310858242;7302.233265507125;7568.243175682429;7859.724909628164;8077.91922080779;8091.676332946689;2246.3710161154822;2289.9656505152434;2291.2897001929373;2296.4488522754586;2297.908083676651;2289.175896677195;2308.7806658367513;2330.067972810872;2334.673145759595;2341.344423561397;2235.899384527692;2251.977480225193;2267.7958983691465;2273.30664147435;2273.897674604647;2292.541491701658;2292.7248730152487;2320.8375413721046;2321.5937210988177;2321.8258630602772;2274.977250227493;2317.5944209763393;2318.6058370076958;2322.1175953137868;2323.7211534615785;8202.26179643829;8300.70947516834;8306.667733290662;8309.00291964968;8333.374996875198;5004.424491183524;5179.559737422323;5180.559652429548;5181.81863634771;5201.817936372247;3221.597300337458;3304.5373647689344;3526.188976535386;3531.5938667053106;3534.6465353464705;896.8340856941421;1046.7540128069897;1054.5781687325054;1056.7094049136472;1090.7654854206385;10511.52698128586;10598.152147828156;10638.202134839918;10655.893441065567;10694.839577406423;4335.588119128678;4475.373447717322;4551.451187335103;4557.908841823145;4601.378813860153;9150.40522366044;9157.587908544132;9163.633454661738;9166.22087122602;9187.402818816756;5063.240513922868;5091.159958606789;5126.512981266774;5131.846044618667;5133.589312854962;4108.465899433055;4238.385434112037;4405.515393306734;4608.838690645878;4627.8843028923875;3640.416418857805;3696.2053158571034;3737.4206997915367;3791.431285307226;3797.468354430382;1233.6730766346925;1239.9938000309942;1241.472374240944;1250.8999280057574;1253.7805883970268;773.3503856760349;780.8633489139378;880.2825697056878;894.6913314906346;902.1700035966926;5328.200769884548;5395.757190926339;5405.648632838853;5576.637518561281;5655.406182350876;429.9187543328531;431.95896389842915;440.35927725159814;897.4121950122681;973.6300205921846;3611.205534782344;3749.718771092179;3871.109644781716;3881.146147847469;3956.3669812830385;7990.720324788605;9926.702198934043;9938.354006989523;9951.25365597583;9960.80078398428;8313.210245026834;9265.907340926504;9705.12653861156;9734;9821.80356392868;7548.131964824115;7759.262870027338;7768.844623107506;7777.961110194413;7781.922180778233;5005.449400565862;5631.2960879890015;5639.746211420578;5666.858328541819;5976.731047102978;7583.924160758322;8811.867821982547;9089.727308180765;9260.194262118823;9271.67549135777;9052.50211238362;9176.036516165974;9248.21390181842;9316.534173291173;9336.159745622926;6532.314107018695;6533.836654083496;7019.192792828686;7045.718171273092;7186.10173728284;7648.847023059619;7866.881996769938;7870.212978702313;7873.09459412175;7879.724209652634;6895.862082758216;6935.410490108397;7017.649117544001;7026.543274687129;7045;6805.421539169226;6931.44548436134;6954.443644508528;6982.930170698228;6993.160820701549;6436.517261205335;6558.573692709959;6663.600183988976;6665.400113989765;6683.131192944886;4565.246734288805;4776.331313616027;4818.253170758538;4886.169351210232;4966.938720431125;4787.664863459524;4830.613550915848;4896.36347274852;4951;4996.925046124238 12:42:44 INFO - PROCESS | 1912 | |4;prototype.html;343.4590519931109;345.69924165975596;354.7636486843351;361.4433771991134;363.4475597092421;4870.759450652699;5140.637731001283;5250.894982100355;5289.41317604719;5366;4965.4538000819975;5051.737065733567;5108.540231379176;5136.791179792687;5274.683518988863;3607.639236076391;3638.5269914911155;4038.5961403859674;4087;4162.271602469571;3354.681305275995;3577.910552236189;4037.273290807668;4097.467329247209;4116.691248156385;3436.725061995047;3861.6331448512346;4052.169305292408;4087.201631282226;4090.795460226977;3988.142549351874;4063.8171282292074;4089.652379547742;4089.8568550100754;4123.948278274071;3581.856725730968;3585.30086633104;3601.243738814852;3603.855845766166;3620.8189590520633;4207.537170911197;5053.418856831475;5054.721990290533;5061.772220250097;5091.287219789232;4023.8994025149314;4371.519132895379;4373.497047839475;4582.495925448198;4723.5829251224495;4711.811527538895;4858.740685581186;4887.535684110004;5297.496737809902;5466.316710411199;4019.7588144711117;4043.555208927016;4074.4295798588223;4075.3886916962397;4087.427760113557;5121.924395876833;5611.66330020196;5675.432456754333;5719.4852463277675;5724.79963201286;3345.6654334566347;3473;3602.585702644177;3741.6343034792103;3760.2103558252525;3597.4783656370205;3965.3457179565626;3974.5826688197903;3979.980100099539;3981.5023122109737;3693.538307711536;4042.838286468508;4251.404803327537;4578.610818080434;4600.35595016698;4357.1482120098835;4488.528704486047;5545.722713864371;5548.9722551386985;5601.6358936668985;1337.6388375138658;1360.421910583718;1364.7134101838726;1370.390176371525;1382.2950295349244;819.38136706786;838.2916435611899;850.4394436209625;878.0911756332293;897.1790811407619;4318.52496225415;4640.675152739276;4874.4150701916;4960.882467551995;4962.776675049631;4616.053708989649;5281.366236051698;5410.810621628303;5420.566354691615;5424.972875135599;4244.448221731155;4781.665283430127;4837.605385334282;5209.869753256123;5268.420473747961;2642.4715056988293;2706.3369474478486;2730.8731502429605;2744.547149720314;2762.530369837092;4789.137955168103;4898.779554920037;4911.323328785749;5168.8449346519665;5598.524125449301;5000.374953130859;5391.3660225064905;5393.946060539422;5543.61194716366;5598.58010649203;4944.777485013183;5216.9305292414965;5516.641418307958;5563.693996830213;5608.578766952156;4966.112877106676;5265.288376486036;5357.276767636319;5386.569074474111;5397.27136836522;4420.971634430425;5288.735563221747;5302.098643230583;5359.222912677562;5382.174358461839;4740.283417999113;4979.9004019918675;4981.750912454435;5040.127127537268;5643;3051.7406020488506;3097.7212050915527;3266.5263536786556;3385.984204738519;3595.29223618779;4698.882527936692;4988.750562471934;5207.719136943852;5360.7341940184115;5384.57308813157;4349.847755328548;4500.459944806644;4852.927206091841;5171.810483588721;5242;4689.077478234044;5019.974900125476;5134.255532947776;5146.6911985281;5205.687658740488;4798.088363210979;4944.826931057396;5229.346331708536;5519.227308176778;5544;4765.7617119143215;5396.010428424524;5468;5600.523955463831;5623.044082505902;4864.343313652612;5404.59465540094;5438.265834112344;5441.238226648194;5465.398806131402 12:42:44 INFO - PROCESS | 1912 | |5;yui.html;705.4603228530175;716.6058667732748;719.9640017999099;755.176857225624;766.2452484302961;14715.264236788158;15693.764593531107;15707.92146039271;15731.685366292668;15773.053616782987;12595.370231488412;12597.244165350085;12667.93666031671;12703.237805731662;12756.808647870266;674.0529555973865;694.7394726977384;696.1715558485412;701.5264696329982;826.8222332198576;760.2625453310308;864.5849992003842;876.9914598212075;881.2289246908955;882.2721254964648;895.4403497813867;910.6038873090193;929.8512238041915;931.9347645664806;936.8360536906048;714.5141303913337;739.6264886232472;740.1118657610889;929.9116583924516;932.3566738950103;554.9528290095346;555.7943560882459;657.283560918601;677.1197443323659;678.108287601807;14252.287385630782;14704.26478676062;14751.852481475154;14801.481948131765;14806;12294.323812190327;12556.246625202426;12652.873471265262;13010.154339967872;13620.114692544952;12390.21532442645;12705.872941270562;12724.554640587628;13018.804717929239;13214.008949328743;4417.712848664859;4421.5040893676505;4489.393931819195;4542.091581683643;4632.536746325341;78667.6066619669;103534;104220.47889760579;106432;107122;9260.907390926004;9736.707898763048;10392.168626509861;10419.739506512398;10485.68542943713;20291.8985405072;20422.69365959512;20565.38303850887;20643.27748528794;20653.17387304521;7500.399968002546;7554;7555.357794587411;7629.3133617973535;7671.53970761756;4193.517745459311;4261.360795880642;4277.657787377002;4364.323529852878;4399.73601583906;3367.326534693071;3463.0303515015835;3465.497502862071;3466.0468371197617;3468.063622821824;550.1637510983282;639.3606393606393;643.3245092652696;648.8410339466766;664.0404615330897;546.97265136743;557.0446683936987;593.0155941137691;600.8497875531117;629.1380808292669;7695.846083078307;7958.283754462126;8491.405601607952;8801.251893589117;8847.778805529784;478.289739736491;538.4400223767238;592.1591340296789;617.3116974573319;626.4643729611117;4082.8565003372873;4302.7633480158265;4314.89212769677;4323.697341186087;4458.375827384169;99522;99986;100744.49627751815;102638;105532.47233763782;89446.55276723574;92207;93904;94424;95739;75310;78140.82788758173;78322;79399;79745.60127199326;7726.3818894487185;8921.330900182642;9394.530273486434;9396.577154028222;9442.622295108393;42776.7166984991;47638;48439;51009.744951275;51245.743771280904;44448.77775611231;55496;63825.680871595345;66871.66564167148;67682;12532.436040378023;12784.936075319563;13042.217466952014;13322;13331.66670833237;14651.413943442143;14672.486462973744;14748.557543273719;14832.480863169738;15031.924840375728;11541.134414918746;13348.93325533366;13373.331333433094;13755.931220344235;13927.303634818016;13461.663458413617;13761.655958600715;13907.37416816266;13936.930315348358;13997.790033149307;12996.285204313854;13226.801597975846;13418.871959369446;13565.050446468653;13574;9311.813763724553;9966.50167491637;11172.664820055412;11252.437378131224;11560.47977841016;8605.95697021511;11138.777224455627;11457.770844582896;11590.71023224426;11591.826122608 12:42:44 INFO - PROCESS | 1912 | __end_tp_report 12:42:44 INFO - PROCESS | 1912 | __start_cc_report 12:42:44 INFO - PROCESS | 1912 | _x_x_mozilla_cycle_collect,1897 12:42:44 INFO - PROCESS | 1912 | __end_cc_report 12:42:44 INFO - PROCESS | 1912 | __startTimestamp1481316164329__endTimestamp 12:42:44 INFO - PROCESS | 1912 | 12:42:44 INFO - PROCESS | 1912 | ------- Summary: start ------- 12:42:44 INFO - PROCESS | 1912 | Number of tests: 6 12:42:44 INFO - PROCESS | 1912 | 12:42:44 INFO - PROCESS | 1912 | [#0] dojo.html Cycles:165 Average:5643.93 Median:5831.88 stddev:666.32 (11.4%) stddev-sans-first:628.22 12:42:44 INFO - PROCESS | 1912 | Values: 2740.0 3229.2 3250.1 3276.5 3294.9 5530.6 5597.4 5644.4 5650.6 5670.7 5593.4 5657.2 5732.7 5739.7 5769.5 4130.8 5071.7 5075.0 5139.5 5140.4 4587.1 5182.9 5274.2 5283.7 5338.6 5071.2 5100.8 5211.0 5261.4 5294.6 5166.6 5172.6 5178.0 5178.4 5178.6 5094.7 5130.0 5134.4 5151.8 5171.5 5611.3 5621.8 5634.2 5646.5 5656.3 6118.4 6125.1 6128.5 6130.7 6130.8 6165.3 6239.2 6242.3 6257.8 6273.7 5227.8 5330.5 5703.5 5766.2 5775.2 6171.5 6254.2 6254.4 6272.1 6276.7 6070.3 6070.6 6143.3 6157.7 6164.8 6227.7 6240.4 6251.4 6259.5 6265.6 6212.5 6216.6 6219.0 6221.0 6223.7 4889.5 6018.6 6080.8 6093.0 6208.8 4387.6 4906.7 4921.4 4929.2 4935.7 4212.0 4294.6 4398.0 4458.9 4471.7 5601.7 5649.5 5650.6 5661.9 5679.0 5511.4 6169.7 6170.1 6172.4 6179.9 5640.0 5667.4 5668.7 5670.5 5678.3 5329.6 5383.9 5384.3 5396.8 5429.2 6308.9 6318.5 6322.6 6327.9 6343.6 6115.2 6119.5 6146.5 6231.3 6240.5 6133.8 6147.8 6213.6 6231.4 6251.9 6002.4 6016.9 6021.0 6022.4 6057.2 5126.7 5996.3 5997.3 6022.3 6024.6 5831.9 5878.2 5900.3 5927.4 5976.7 5817.2 5958.9 5976.0 6016.9 6017.4 5741.5 5839.8 5848.3 5853.6 5862.6 5861.7 5916.0 5927.4 6025.5 6030.5 5791.6 5828.1 5853.3 5929.3 5943.6 12:42:44 INFO - PROCESS | 1912 | 12:42:44 INFO - PROCESS | 1912 | [#1] ext.html Cycles:180 Average:66871.53 Median:19064.18 stddev:144126.61 (756.0%) stddev-sans-first:144444.56 12:42:44 INFO - PROCESS | 1912 | Values: 417.0 449.4 468.6 500.7 505.6 22094.7 31820.0 38958.4 40401.4 40719.6 41744.2 42060.4 42154.0 42256.6 42312.4 9157.5 9372.6 9377.4 9378.2 9384.1 8393.7 8610.9 9356.3 11092.6 11369.4 11292.7 11314.2 11314.5 11337.1 11344.4 11281.9 11351.1 11362.0 11364.3 11386.4 8313.3 8548.5 10947.7 11170.3 11214.3 39713.4 39987.8 40023.2 40083.0 40395.0 3384.9 3495.9 3503.1 3747.3 3856.6 29359.2 30136.4 30181.1 30215.0 30308.7 3035.3 3162.5 3164.2 3206.3 3261.3 464945.0 480638.0 483689.0 485066.0 485582.0 59681.7 60145.0 60172.7 60189.7 60252.1 63337.0 63437.0 63488.7 63537.0 63559.7 14931.8 15443.9 15687.8 15730.8 15754.0 10708.5 10998.6 11380.7 11432.7 11933.6 14733.6 15163.3 16315.9 20678.9 20850.0 8249.5 8307.7 8353.9 8365.9 8404.7 819.7 839.0 917.1 958.5 1100.4 29240.9 29674.0 29719.6 30559.1 30574.8 977.4 1043.5 1053.6 1055.1 1109.0 13491.6 15295.1 15473.5 15669.8 15971.9 611670.0 612937.0 614876.0 616821.0 618038.0 58498.4 59271.1 59294.7 59353.1 59418.7 1180.3 1261.7 1274.7 1276.0 1330.3 29051.0 30496.0 30602.0 30718.2 31203.5 49834.8 50338.7 50363.7 50445.0 50501.0 514673.0 515388.0 515677.0 516168.5 516745.0 21233.9 25207.1 25437.6 26081.9 26562.9 41427.0 41657.6 41989.8 42157.4 42588.1 34613.0 34620.6 34632.5 35482.8 35562.9 34461.7 34503.0 35206.8 35410.6 35510.5 34204.5 34283.0 34466.0 34974.5 35078.0 29608.0 31244.4 31295.7 31350.0 31423.1 23489.4 23623.8 23872.9 23941.0 24158.8 12:42:44 INFO - PROCESS | 1912 | 12:42:44 INFO - PROCESS | 1912 | [#2] jquery.html Cycles:180 Average:35301.51 Median:28612.14 stddev:92777.98 (324.3%) stddev-sans-first:93001.13 12:42:44 INFO - PROCESS | 1912 | Values: 347.4 364.6 366.3 370.8 396.9 13774.9 14872.9 16908.9 19113.2 20578.1 20028.3 20163.4 20354.3 20375.7 20462.0 5317.6 5859.2 5923.0 5924.6 5943.5 4081.1 4320.7 5771.7 6228.2 6647.0 6113.1 6306.9 6635.7 6686.2 6693.9 7241.0 7633.0 7688.1 7778.3 7795.2 7085.5 7434.1 7512.5 7536.1 7536.1 22573.4 25613.9 26354.6 27813.7 28564.3 2005.1 2319.9 2393.8 2710.1 2992.5 16089.8 16358.6 16405.8 16462.9 17344.8 1984.8 2039.8 2060.6 2073.5 2101.7 127350.4 130808.3 139463.3 140859.3 142818.7 19280.6 21036.4 21073.4 21084.9 21282.3 28660.0 29880.9 29946.7 31576.7 33365.7 10188.6 10244.9 10487.6 10642.6 10857.8 7158.8 8591.9 8705.0 8757.8 8960.6 7782.4 9550.8 9661.3 9700.1 9732.8 3280.6 3716.5 3728.6 3739.9 3782.3 831.8 836.9 921.1 930.0 1035.8 20076.5 20595.3 20777.8 20835.8 20956.6 918.1 922.2 955.3 973.5 1013.2 9957.4 10375.3 10752.4 10798.6 10858.5 534335.0 534572.0 545747.0 568941.0 571979.0 125358.0 125988.9 126796.4 128354.7 131252.3 947.8 971.1 1015.2 1019.8 1025.4 14047.5 18485.6 19067.5 19169.5 19257.4 43072.8 53373.0 56967.9 57694.0 58719.1 76272.6 76980.0 77715.0 77726.6 79647.6 7570.1 7806.1 7935.3 7980.2 8111.7 9934.4 12270.2 12409.5 12612.4 12710.0 10648.4 10935.8 10944.3 11031.4 11129.6 10435.8 10588.4 10843.3 10993.0 11083.1 10738.9 11171.3 11226.7 11264.4 11346.8 7871.8 7939.2 7948.1 8068.6 8233.5 9152.7 10447.8 10673.7 11085.7 11115.3 12:42:44 INFO - PROCESS | 1912 | 12:42:44 INFO - PROCESS | 1912 | [#3] mootools.html Cycles:180 Average:5326.13 Median:5181.19 stddev:2885.63 (55.7%) stddev-sans-first:2879.04 12:42:44 INFO - PROCESS | 1912 | Values: 1451.9 1484.0 1639.5 1788.8 1813.9 7899.6 8309.1 8312.0 8329.8 8338.4 7302.2 7568.2 7859.7 8077.9 8091.7 2246.4 2290.0 2291.3 2296.4 2297.9 2289.2 2308.8 2330.1 2334.7 2341.3 2235.9 2252.0 2267.8 2273.3 2273.9 2292.5 2292.7 2320.8 2321.6 2321.8 2275.0 2317.6 2318.6 2322.1 2323.7 8202.3 8300.7 8306.7 8309.0 8333.4 5004.4 5179.6 5180.6 5181.8 5201.8 3221.6 3304.5 3526.2 3531.6 3534.6 896.8 1046.8 1054.6 1056.7 1090.8 10511.5 10598.2 10638.2 10655.9 10694.8 4335.6 4475.4 4551.5 4557.9 4601.4 9150.4 9157.6 9163.6 9166.2 9187.4 5063.2 5091.2 5126.5 5131.8 5133.6 4108.5 4238.4 4405.5 4608.8 4627.9 3640.4 3696.2 3737.4 3791.4 3797.5 1233.7 1240.0 1241.5 1250.9 1253.8 773.4 780.9 880.3 894.7 902.2 5328.2 5395.8 5405.6 5576.6 5655.4 429.9 432.0 440.4 897.4 973.6 3611.2 3749.7 3871.1 3881.1 3956.4 7990.7 9926.7 9938.4 9951.3 9960.8 8313.2 9265.9 9705.1 9734.0 9821.8 7548.1 7759.3 7768.8 7778.0 7781.9 5005.4 5631.3 5639.7 5666.9 5976.7 7583.9 8811.9 9089.7 9260.2 9271.7 9052.5 9176.0 9248.2 9316.5 9336.2 6532.3 6533.8 7019.2 7045.7 7186.1 7648.8 7866.9 7870.2 7873.1 7879.7 6895.9 6935.4 7017.6 7026.5 7045.0 6805.4 6931.4 6954.4 6982.9 6993.2 6436.5 6558.6 6663.6 6665.4 6683.1 4565.2 4776.3 4818.3 4886.2 4966.9 4787.7 4830.6 4896.4 4951.0 4996.9 12:42:44 INFO - PROCESS | 1912 | 12:42:44 INFO - PROCESS | 1912 | [#4] prototype.html Cycles:180 Average:4335.09 Median:4861.54 stddev:1287.93 (26.5%) stddev-sans-first:1256.21 12:42:44 INFO - PROCESS | 1912 | Values: 343.5 345.7 354.8 361.4 363.4 4870.8 5140.6 5250.9 5289.4 5366.0 4965.5 5051.7 5108.5 5136.8 5274.7 3607.6 3638.5 4038.6 4087.0 4162.3 3354.7 3577.9 4037.3 4097.5 4116.7 3436.7 3861.6 4052.2 4087.2 4090.8 3988.1 4063.8 4089.7 4089.9 4123.9 3581.9 3585.3 3601.2 3603.9 3620.8 4207.5 5053.4 5054.7 5061.8 5091.3 4023.9 4371.5 4373.5 4582.5 4723.6 4711.8 4858.7 4887.5 5297.5 5466.3 4019.8 4043.6 4074.4 4075.4 4087.4 5121.9 5611.7 5675.4 5719.5 5724.8 3345.7 3473.0 3602.6 3741.6 3760.2 3597.5 3965.3 3974.6 3980.0 3981.5 3693.5 4042.8 4251.4 4578.6 4600.4 4357.1 4488.5 5545.7 5549.0 5601.6 1337.6 1360.4 1364.7 1370.4 1382.3 819.4 838.3 850.4 878.1 897.2 4318.5 4640.7 4874.4 4960.9 4962.8 4616.1 5281.4 5410.8 5420.6 5425.0 4244.4 4781.7 4837.6 5209.9 5268.4 2642.5 2706.3 2730.9 2744.5 2762.5 4789.1 4898.8 4911.3 5168.8 5598.5 5000.4 5391.4 5393.9 5543.6 5598.6 4944.8 5216.9 5516.6 5563.7 5608.6 4966.1 5265.3 5357.3 5386.6 5397.3 4421.0 5288.7 5302.1 5359.2 5382.2 4740.3 4979.9 4981.8 5040.1 5643.0 3051.7 3097.7 3266.5 3386.0 3595.3 4698.9 4988.8 5207.7 5360.7 5384.6 4349.8 4500.5 4852.9 5171.8 5242.0 4689.1 5020.0 5134.3 5146.7 5205.7 4798.1 4944.8 5229.3 5519.2 5544.0 4765.8 5396.0 5468.0 5600.5 5623.0 4864.3 5404.6 5438.3 5441.2 5465.4 12:42:44 INFO - PROCESS | 1912 | 12:42:44 INFO - PROCESS | 1912 | [#5] yui.html Cycles:180 Average:19931.72 Median:4473.88 stddev:28870.72 (645.3%) stddev-sans-first:28915.62 12:42:44 INFO - PROCESS | 1912 | Values: 705.5 716.6 720.0 755.2 766.2 14715.3 15693.8 15707.9 15731.7 15773.1 12595.4 12597.2 12667.9 12703.2 12756.8 674.1 694.7 696.2 701.5 826.8 760.3 864.6 877.0 881.2 882.3 895.4 910.6 929.9 931.9 936.8 714.5 739.6 740.1 929.9 932.4 555.0 555.8 657.3 677.1 678.1 14252.3 14704.3 14751.9 14801.5 14806.0 12294.3 12556.2 12652.9 13010.2 13620.1 12390.2 12705.9 12724.6 13018.8 13214.0 4417.7 4421.5 4489.4 4542.1 4632.5 78667.6 103534.0 104220.5 106432.0 107122.0 9260.9 9736.7 10392.2 10419.7 10485.7 20291.9 20422.7 20565.4 20643.3 20653.2 7500.4 7554.0 7555.4 7629.3 7671.5 4193.5 4261.4 4277.7 4364.3 4399.7 3367.3 3463.0 3465.5 3466.0 3468.1 550.2 639.4 643.3 648.8 664.0 547.0 557.0 593.0 600.8 629.1 7695.8 7958.3 8491.4 8801.3 8847.8 478.3 538.4 592.2 617.3 626.5 4082.9 4302.8 4314.9 4323.7 4458.4 99522.0 99986.0 100744.5 102638.0 105532.5 89446.6 92207.0 93904.0 94424.0 95739.0 75310.0 78140.8 78322.0 79399.0 79745.6 7726.4 8921.3 9394.5 9396.6 9442.6 42776.7 47638.0 48439.0 51009.7 51245.7 44448.8 55496.0 63825.7 66871.7 67682.0 12532.4 12784.9 13042.2 13322.0 13331.7 14651.4 14672.5 14748.6 14832.5 15031.9 11541.1 13348.9 13373.3 13755.9 13927.3 13461.7 13761.7 13907.4 13936.9 13997.8 12996.3 13226.8 13418.9 13565.1 13574.0 9311.8 9966.5 11172.7 11252.4 11560.5 8606.0 11138.8 11457.8 11590.7 11591.8 12:42:44 INFO - PROCESS | 1912 | -------- Summary: end -------- 12:42:44 INFO - PROCESS | 1912 | 12:42:44 INFO - TEST-INFO | 1912: exit 0 12:42:44 INFO - TEST-OK | dromaeo_css | took 1121329ms 12:42:44 INFO - TEST-START | kraken 12:42:44 INFO - operating with platform_type : mac_ 12:42:44 INFO - Initialising browser for kraken test... 12:42:44 INFO - TEST-INFO | started process 1915 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpy5vWvw/profile http://localhost:49706/getInfo.html) 12:42:47 INFO - PROCESS | 1915 | __metrics Screen width/height:1600/1200 12:42:47 INFO - PROCESS | 1915 | colorDepth:24 12:42:47 INFO - PROCESS | 1915 | Browser inner width/height: 1024/689 12:42:47 INFO - PROCESS | 1915 | __metrics 12:42:47 INFO - PROCESS | 1915 | 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" 12:42:47 INFO - PROCESS | 1915 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:42:48 INFO - TEST-INFO | 1915: exit 0 12:42:48 INFO - Browser initialized. 12:42:48 INFO - Running cycle 1/1 for kraken test... 12:42:48 INFO - TEST-INFO | started process 1916 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpy5vWvw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:43:00 INFO - PROCESS | 1916 | RSS: Main: 230129664 12:43:00 INFO - PROCESS | 1916 | 12:43:02 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49706/tests/kraken/driver.html?testName=audio-beat-detection) 12:43:03 INFO - PROCESS | 1916 | RSS: Main: 289255424 12:43:03 INFO - PROCESS | 1916 | 12:43:06 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49706/tests/kraken/driver.html?testName=audio-dft) 12:43:06 INFO - PROCESS | 1916 | RSS: Main: 291487744 12:43:06 INFO - PROCESS | 1916 | 12:43:10 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49706/tests/kraken/driver.html?testName=audio-fft) 12:43:10 INFO - PROCESS | 1916 | RSS: Main: 380010496 12:43:10 INFO - PROCESS | 1916 | 12:43:12 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49706/tests/kraken/driver.html?testName=audio-oscillator) 12:43:13 INFO - PROCESS | 1916 | RSS: Main: 285491200 12:43:13 INFO - PROCESS | 1916 | 12:43:15 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49706/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:43:16 INFO - PROCESS | 1916 | RSS: Main: 289660928 12:43:16 INFO - PROCESS | 1916 | 12:43:19 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49706/tests/kraken/driver.html?testName=imaging-darkroom) 12:43:19 INFO - PROCESS | 1916 | RSS: Main: 332312576 12:43:19 INFO - PROCESS | 1916 | 12:43:22 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49706/tests/kraken/driver.html?testName=imaging-desaturate) 12:43:23 INFO - PROCESS | 1916 | RSS: Main: 334233600 12:43:23 INFO - PROCESS | 1916 | 12:43:26 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49706/tests/kraken/driver.html?testName=json-parse-financial) 12:43:26 INFO - PROCESS | 1916 | RSS: Main: 329355264 12:43:26 INFO - PROCESS | 1916 | 12:43:28 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49706/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:43:29 INFO - PROCESS | 1916 | RSS: Main: 305926144 12:43:29 INFO - PROCESS | 1916 | 12:43:30 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49706/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:43:31 INFO - PROCESS | 1916 | RSS: Main: 312807424 12:43:31 INFO - PROCESS | 1916 | 12:43:33 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49706/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:43:34 INFO - PROCESS | 1916 | RSS: Main: 315863040 12:43:34 INFO - PROCESS | 1916 | 12:43:37 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49706/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:43:38 INFO - PROCESS | 1916 | RSS: Main: 321462272 12:43:38 INFO - PROCESS | 1916 | 12:43:41 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49706/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:43:41 INFO - PROCESS | 1916 | RSS: Main: 322109440 12:43:41 INFO - PROCESS | 1916 | 12:43:43 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49706/tests/kraken/driver.html?testName=ai-astar) 12:43:43 INFO - PROCESS | 1916 | RSS: Main: 366919680 12:43:43 INFO - PROCESS | 1916 | 12:43:43 INFO - PROCESS | 1916 | __start_tp_report 12:43:43 INFO - PROCESS | 1916 | _x_x_mozilla_page_load 12:43:43 INFO - PROCESS | 1916 | _x_x_mozilla_page_load_details 12:43:43 INFO - PROCESS | 1916 | |i|pagename|runs| 12:43:43 INFO - PROCESS | 1916 | |0;ai-astar;105;114;114;112;113;114;113;114;114;113 12:43:43 INFO - PROCESS | 1916 | |1;audio-beat-detection;147;118;113;152;116;114;115;115;132;116 12:43:43 INFO - PROCESS | 1916 | |2;audio-dft;183;186;183;184;186;185;182;183;184;183 12:43:43 INFO - PROCESS | 1916 | |3;audio-fft;80;61;59;88;60;59;58;60;75;58 12:43:43 INFO - PROCESS | 1916 | |4;audio-oscillator;87;93;116;98;75;69;83;68;69;84 12:43:43 INFO - PROCESS | 1916 | |5;imaging-gaussian-blur;108;111;110;112;113;169;114;111;108;110 12:43:43 INFO - PROCESS | 1916 | |6;imaging-darkroom;93;94;96;94;93;94;107;88;92;130 12:43:43 INFO - PROCESS | 1916 | |7;imaging-desaturate;87;84;86;88;84;85;85;85;86;85 12:43:43 INFO - PROCESS | 1916 | |8;json-parse-financial;56;55;53;54;55;54;55;55;54;56 12:43:43 INFO - PROCESS | 1916 | |9;json-stringify-tinderbox;62;66;85;76;75;71;72;71;73;73 12:43:43 INFO - PROCESS | 1916 | |10;stanford-crypto-aes;93;90;92;92;90;92;93;93;125;91 12:43:43 INFO - PROCESS | 1916 | |11;stanford-crypto-ccm;149;148;146;145;149;154;171;151;160;153 12:43:43 INFO - PROCESS | 1916 | |12;stanford-crypto-pbkdf2;180;180;179;178;236;232;179;181;176;180 12:43:43 INFO - PROCESS | 1916 | |13;stanford-crypto-sha256-iterative;69;68;68;67;69;69;68;67;67;68 12:43:43 INFO - PROCESS | 1916 | __end_tp_report 12:43:43 INFO - PROCESS | 1916 | __start_cc_report 12:43:43 INFO - PROCESS | 1916 | _x_x_mozilla_cycle_collect,2025 12:43:43 INFO - PROCESS | 1916 | __end_cc_report 12:43:43 INFO - PROCESS | 1916 | __startTimestamp1481316223971__endTimestamp 12:43:43 INFO - PROCESS | 1916 | 12:43:43 INFO - PROCESS | 1916 | ------- Summary: start ------- 12:43:43 INFO - PROCESS | 1916 | Number of tests: 14 12:43:43 INFO - PROCESS | 1916 | 12:43:43 INFO - PROCESS | 1916 | [#0] ai-astar Cycles:10 Average:112.60 Median:114.00 stddev:2.76 (2.4%) stddev-sans-first:0.73 12:43:43 INFO - PROCESS | 1916 | Values: 105.0 114.0 114.0 112.0 113.0 114.0 113.0 114.0 114.0 113.0 12:43:43 INFO - PROCESS | 1916 | 12:43:43 INFO - PROCESS | 1916 | [#1] audio-beat-detection Cycles:10 Average:123.80 Median:117.00 stddev:14.62 (12.5%) stddev-sans-first:12.87 12:43:43 INFO - PROCESS | 1916 | Values: 147.0 118.0 113.0 152.0 116.0 114.0 115.0 115.0 132.0 116.0 12:43:43 INFO - PROCESS | 1916 | 12:43:43 INFO - PROCESS | 1916 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.00 stddev:1.37 (0.7%) stddev-sans-first:1.41 12:43:43 INFO - PROCESS | 1916 | Values: 183.0 186.0 183.0 184.0 186.0 185.0 182.0 183.0 184.0 183.0 12:43:43 INFO - PROCESS | 1916 | 12:43:43 INFO - PROCESS | 1916 | [#3] audio-fft Cycles:10 Average:65.80 Median:60.50 stddev:10.97 (18.1%) stddev-sans-first:10.37 12:43:43 INFO - PROCESS | 1916 | Values: 80.0 61.0 59.0 88.0 60.0 59.0 58.0 60.0 75.0 58.0 12:43:43 INFO - PROCESS | 1916 | 12:43:43 INFO - PROCESS | 1916 | [#4] audio-oscillator Cycles:10 Average:84.20 Median:83.50 stddev:15.27 (18.3%) stddev-sans-first:16.16 12:43:43 INFO - PROCESS | 1916 | Values: 87.0 93.0 116.0 98.0 75.0 69.0 83.0 68.0 69.0 84.0 12:43:43 INFO - PROCESS | 1916 | 12:43:43 INFO - PROCESS | 1916 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:111.50 stddev:18.51 (16.6%) stddev-sans-first:19.37 12:43:43 INFO - PROCESS | 1916 | Values: 108.0 111.0 110.0 112.0 113.0 169.0 114.0 111.0 108.0 110.0 12:43:43 INFO - PROCESS | 1916 | 12:43:43 INFO - PROCESS | 1916 | [#6] imaging-darkroom Cycles:10 Average:98.10 Median:93.50 stddev:12.22 (13.1%) stddev-sans-first:12.82 12:43:43 INFO - PROCESS | 1916 | Values: 93.0 94.0 96.0 94.0 93.0 94.0 107.0 88.0 92.0 130.0 12:43:43 INFO - PROCESS | 1916 | 12:43:43 INFO - PROCESS | 1916 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:85.50 stddev:1.27 (1.5%) stddev-sans-first:1.22 12:43:43 INFO - PROCESS | 1916 | Values: 87.0 84.0 86.0 88.0 84.0 85.0 85.0 85.0 86.0 85.0 12:43:43 INFO - PROCESS | 1916 | 12:43:43 INFO - PROCESS | 1916 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:0.95 (1.7%) stddev-sans-first:0.88 12:43:43 INFO - PROCESS | 1916 | Values: 56.0 55.0 53.0 54.0 55.0 54.0 55.0 55.0 54.0 56.0 12:43:43 INFO - PROCESS | 1916 | 12:43:43 INFO - PROCESS | 1916 | [#9] json-stringify-tinderbox Cycles:10 Average:72.40 Median:73.00 stddev:6.08 (8.3%) stddev-sans-first:5.15 12:43:43 INFO - PROCESS | 1916 | Values: 62.0 66.0 85.0 76.0 75.0 71.0 72.0 71.0 73.0 73.0 12:43:43 INFO - PROCESS | 1916 | 12:43:43 INFO - PROCESS | 1916 | [#10] stanford-crypto-aes Cycles:10 Average:95.10 Median:92.00 stddev:10.57 (11.5%) stddev-sans-first:11.18 12:43:43 INFO - PROCESS | 1916 | Values: 93.0 90.0 92.0 92.0 90.0 92.0 93.0 93.0 125.0 91.0 12:43:43 INFO - PROCESS | 1916 | 12:43:43 INFO - PROCESS | 1916 | [#11] stanford-crypto-ccm Cycles:10 Average:152.60 Median:152.00 stddev:7.79 (5.1%) stddev-sans-first:8.15 12:43:43 INFO - PROCESS | 1916 | Values: 149.0 148.0 146.0 145.0 149.0 154.0 171.0 151.0 160.0 153.0 12:43:43 INFO - PROCESS | 1916 | 12:43:43 INFO - PROCESS | 1916 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.10 Median:180.00 stddev:23.20 (12.9%) stddev-sans-first:24.31 12:43:43 INFO - PROCESS | 1916 | Values: 180.0 180.0 179.0 178.0 236.0 232.0 179.0 181.0 176.0 180.0 12:43:43 INFO - PROCESS | 1916 | 12:43:43 INFO - PROCESS | 1916 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 12:43:43 INFO - PROCESS | 1916 | Values: 69.0 68.0 68.0 67.0 69.0 69.0 68.0 67.0 67.0 68.0 12:43:43 INFO - PROCESS | 1916 | -------- Summary: end -------- 12:43:43 INFO - PROCESS | 1916 | 12:43:44 INFO - TEST-INFO | 1916: exit 0 12:43:44 INFO - TEST-OK | kraken | took 59876ms 12:43:44 INFO - SUITE-END | took 1181s 12:43:45 INFO - Completed test suite (00:19:41) 12:43:45 INFO - javascript benchmark 12:43:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2740.0, 3229.2411283348415, 3250.1062207892833, 3276.459384201607, 3294.9011529654117, 5530.557555395569, 5597.356304025033, 5644.350899646547, 5650.63270887392, 5670.659760414373, 5593.440655934404, 5657.151427285909, 5732.742026608802, 5739.655620662763, 5769.451902069297, 4130.772807495587, 5071.746412679369, 5075.0, 5139.537441630253, 5140.383154021522, 4587.103750497973, 5182.8704282393055, 5274.182501712241, 5283.735813209343, 5338.572914166877, 5071.2139618359215, 5100.821471248526, 5210.973945130288, 5261.368635763713, 5294.629375943686, 5166.638335316529, 5172.61205409592, 5177.974110129425, 5178.404483484373, 5178.637495375326, 5094.694318340911, 5129.9743501282255, 5134.4095429025765, 5151.819686310999, 5171.482851714836, 5611.270534830487, 5621.831345059655, 5634.239377684001, 5646.520045796112, 5656.321241451011, 6118.436443820604, 6125.052321061979, 6128.483736330591, 6130.724117414682, 6130.837764763411, 6165.32181460039, 6239.188905442309, 6242.282137554194, 6257.78097766576, 6273.654948977804, 5227.764750586232, 5330.493603107699, 5703.486686198262, 5766.163906233573, 5775.220345253421, 6171.475424588871, 6254.15568898202, 6254.3745625438005, 6272.090546870678, 6276.717547710364, 6070.332263451017, 6070.605410648293, 6143.293521245025, 6157.6613286269685, 6164.845878852975, 6227.719752611143, 6240.375962403723, 6251.437370636573, 6259.499240060784, 6265.561410701298, 6212.502999760009, 6216.595921265103, 6219.0, 6221.0, 6223.657698826518, 4889.462159162489, 6018.608790428608, 6080.817575472743, 6092.964196086676, 6208.782692605737, 4387.561243875587, 4906.730129842822, 4921.409430868319, 4929.162042452792, 4935.679180853233, 4212.0331197576415, 4294.613484786321, 4397.988462653544, 4458.9331160032625, 4471.731696098244, 5601.691906945157, 5649.548036157097, 5650.604457688005, 5661.915071273934, 5679.034564124109, 5511.43883531857, 6169.660668663177, 6170.074488826712, 6172.4136207060255, 6179.907301390393, 5639.971800141055, 5667.376588575254, 5668.659880407106, 5670.5463562914865, 5678.290213723285, 5329.600279978939, 5383.892322153535, 5384.273123128406, 5396.811111611075, 5429.15848043546, 6308.873822523524, 6318.494520438446, 6322.620642761449, 6327.936720632827, 6343.555951083472, 6115.1794953435965, 6119.510439164945, 6146.477549408171, 6231.3145553988115, 6240.500759939285, 6133.793750436688, 6147.801178770097, 6213.59611625261, 6231.40801623845, 6251.937480625135, 6002.369751176238, 6016.909746353721, 6021.036634138692, 6022.384525263674, 6057.242844644419, 5126.6923984561045, 5996.340402555803, 5997.250343707036, 6022.307434645072, 6024.638521688713, 5831.883362332815, 5878.2064421304285, 5900.29196496406, 5927.377625349449, 5976.701164941823, 5817.185594016925, 5958.880822383615, 5976.0, 6016.87966240664, 6017.398260173947, 5741.45456181662, 5839.766409343749, 5848.2689663792025, 5853.560982926383, 5862.618929769722, 5861.677607731615, 5915.970420147872, 5927.436893495111, 6025.457708806229, 6030.517558595389, 5791.594588378773, 5828.0966450200285, 5853.268341457318, 5929.288485381781, 5943.613665111754], "value": 5599.2286814282925, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.981235844387, 449.4247363374881, 468.6110528261541, 500.74211780932814, 505.55006044620296, 22094.668579971312, 31820.04539863802, 38958.441662333506, 40401.39397909034, 40719.59280407195, 41744.165116697644, 42060.36909446361, 42154.0, 42256.57743422565, 42312.365314520306, 9157.542122893861, 9372.625094996192, 9377.390469619453, 9378.249740020816, 9384.061593840595, 8393.664253429855, 8610.87083693745, 9356.298277629205, 11092.611758588451, 11369.374684392355, 11292.717682057932, 11314.208005439623, 11314.547418103266, 11337.14971377146, 11344.43277836109, 11281.943590282037, 11351.148663850203, 11362.034227090624, 11364.31814091149, 11386.373749443777, 8313.293370063551, 8548.529830859301, 10947.671569852917, 11170.27393219438, 11214.327140371604, 39713.40429893554, 39987.80006099951, 40023.19953600912, 40082.99792505211, 40395.0, 3384.8815291464925, 3495.877644282438, 3503.1242189452637, 3747.2880152770886, 3856.5950575189763, 29359.18330617006, 30136.397272054655, 30181.09456716302, 30215.0, 30308.696913030806, 3035.2715348316465, 3162.478191098466, 3164.193130751644, 3206.3266713990092, 3261.266215101607, 464945.0, 480638.0, 483689.0, 485066.0, 485581.99999999645, 59681.701591491765, 60145.0, 60172.69913650491, 60189.69905150446, 60252.096218556755, 63337.0, 63437.0, 63488.68255658692, 63537.0, 63559.68220158962, 14931.805455563528, 15443.918925675094, 15687.764683529756, 15730.764038539432, 15754.0, 10708.518116684612, 10998.560057597606, 11380.658580242605, 11432.714182145513, 11933.582324618597, 14733.631659208391, 15163.317650705745, 16315.868413158549, 20678.862662553704, 20850.0, 8249.463784853966, 8307.709230176915, 8353.916460835435, 8365.874511882326, 8404.747857564284, 819.7417813388763, 838.9958050209832, 917.1195652173988, 958.4872093429982, 1100.4112799652307, 29240.90627312178, 29673.961411350498, 29719.554206686917, 30559.08322750321, 30574.84712576423, 977.4330888084894, 1043.4678314059731, 1053.5891002509027, 1055.1084333737979, 1108.955641774336, 13491.595252142255, 15295.082295062331, 15473.5357939262, 15669.843301566838, 15971.920140399223, 611670.0, 612937.0, 614876.0, 616821.0, 618038.0, 58498.41501585015, 59271.11093333604, 59294.703526482954, 59353.10970335449, 59418.70290648519, 1180.3095189314176, 1261.7098067444356, 1274.7259339241923, 1276.0110914041506, 1330.328184266939, 29050.983215587352, 30496.0, 30602.0, 30718.232044199074, 31203.531947020358, 49834.75082624564, 50338.7483062597, 50363.74818125886, 50444.99110017706, 50501.0, 514673.0, 515388.0, 515677.0, 516168.51494455227, 516745.0, 21233.89383053075, 25207.11775087863, 25437.60093194892, 26081.869590651924, 26562.86718566472, 41426.96432589209, 41657.58342416537, 41989.79005105077, 42157.367639486045, 42588.148237035704, 34613.0, 34620.61517539371, 34632.48051279182, 35482.82258588794, 35562.93311200668, 34461.65538344585, 34502.96491105271, 35206.82396588001, 35410.645893540735, 35510.46734298936, 34204.48693269653, 34283.0, 34465.96602101941, 34974.47538286979, 35078.0, 29608.0, 31244.375112497168, 31295.687043129277, 31350.0, 31423.05730828079, 23489.412764680335, 23623.763762362843, 23872.88063559671, 23941.0, 24158.75841241565], "value": 19493.43858565315, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.3591224191369, 364.64447164015104, 366.3405869435017, 370.77012252403506, 396.928552860485, 13774.931125344372, 14872.851271487296, 16908.915455422706, 19113.23547058116, 20578.0739866706, 20028.29900953467, 20163.39509814704, 20354.287599933967, 20375.694364584542, 20462.0, 5317.574594032468, 5859.238299021121, 5923.0, 5924.58527903047, 5943.524518038568, 4081.1429599784083, 4320.740755554661, 5771.682557459338, 6228.159198508211, 6647.036179753933, 6113.144159817629, 6306.936930630681, 6635.734570617169, 6686.1642294713165, 6693.933060669379, 7240.963795181016, 7632.961835190844, 7688.077430708351, 7778.299953004257, 7795.22047795216, 7085.468589855782, 7434.145073316529, 7512.511686740344, 7536.057992750906, 7536.133344665379, 22573.435664108365, 25613.871930640413, 26354.604680929802, 27813.721862781316, 28564.285892852637, 2005.1277694203068, 2319.8632669991753, 2393.80849532037, 2710.0921191400903, 2992.521196608532, 16089.839101608952, 16358.591035224095, 16405.753913691304, 16462.917685411496, 17344.826551734448, 1984.7618285805652, 2039.775624681284, 2060.5569802492537, 2073.4712648274594, 2101.71626830379, 127350.36324818409, 130808.34595827055, 139463.30268348593, 140859.29570352184, 142818.71678340874, 19280.61438771217, 21036.368908932756, 21073.367798966057, 21084.894575527025, 21282.255121070997, 28659.996900108395, 29880.85059574688, 29946.700532994826, 31576.684233157834, 33365.666343336256, 10188.643397481053, 10244.948775256076, 10487.580496780196, 10642.627508037182, 10857.837132443019, 7158.8210294742, 8591.914080859236, 8704.956475217583, 8757.824843503095, 8960.551972401354, 7782.416318776001, 9550.808983820285, 9661.275404344702, 9700.126988571063, 9732.805343893082, 3280.573525441725, 3716.4659115878585, 3728.5525736911745, 3739.9252014959548, 3782.2624588205585, 831.8419500294924, 836.9079401265856, 921.1295325916944, 930.0188301342149, 1035.7928414317166, 20076.498087547636, 20595.279165229145, 20777.79222207789, 20835.79164208369, 20956.637818541745, 918.0544039639183, 922.2161163011386, 955.3121752338305, 973.454865275448, 1013.2350075692805, 9957.352772069793, 10375.27373083877, 10752.354858708502, 10798.568057277778, 10858.511366988505, 534335.0, 534572.0, 545747.0, 568941.0, 571979.0, 125358.0, 125988.85027874193, 126796.36601816931, 128354.71645283427, 131252.3437382826, 947.8104379124203, 971.1065819446127, 1015.1523477896039, 1019.8266294729765, 1025.4257615735212, 14047.508337208557, 18485.63028739391, 19067.523311917314, 19169.52076198106, 19257.441481540558, 43072.78463607662, 53373.0, 56967.86064278774, 57694.0, 58719.11921321098, 76272.61863690647, 76980.0, 77715.0, 77726.6113669428, 79647.60176199082, 7570.129435115033, 7806.141324454419, 7935.285824275843, 7980.201979801974, 8111.716089936824, 9934.354266972623, 12270.202436841577, 12409.503619855104, 12612.369381530703, 12710.0, 10648.414337211529, 10935.83596246041, 10944.288621239593, 11031.39327336972, 11129.610463633733, 10435.843462348223, 10588.41763702973, 10843.349399036084, 10993.010629043425, 11083.113350931744, 10738.892611073788, 11171.273867198606, 11226.719332016764, 11264.380459074502, 11346.829797553208, 7871.803204919923, 7939.2060793920145, 7948.0859701132795, 8068.556229407439, 8233.46482478637, 9152.725418237464, 10447.791044179226, 10673.679789606014, 11085.667429977113, 11115.277506962022], "value": 10625.614937193232, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1451.8693317601414, 1484.013131267707, 1639.5163426789095, 1788.830061144191, 1813.9002354870477, 7899.565523896191, 8309.127541608135, 8312.002559692837, 8329.833403331937, 8338.416310858242, 7302.233265507125, 7568.243175682429, 7859.724909628164, 8077.91922080779, 8091.676332946689, 2246.3710161154822, 2289.9656505152434, 2291.2897001929373, 2296.4488522754586, 2297.908083676651, 2289.175896677195, 2308.7806658367513, 2330.067972810872, 2334.673145759595, 2341.344423561397, 2235.899384527692, 2251.977480225193, 2267.7958983691465, 2273.30664147435, 2273.897674604647, 2292.541491701658, 2292.7248730152487, 2320.8375413721046, 2321.5937210988177, 2321.8258630602772, 2274.977250227493, 2317.5944209763393, 2318.6058370076958, 2322.1175953137868, 2323.7211534615785, 8202.26179643829, 8300.70947516834, 8306.667733290662, 8309.00291964968, 8333.374996875198, 5004.424491183524, 5179.559737422323, 5180.559652429548, 5181.81863634771, 5201.817936372247, 3221.597300337458, 3304.5373647689344, 3526.188976535386, 3531.5938667053106, 3534.6465353464705, 896.8340856941421, 1046.7540128069897, 1054.5781687325054, 1056.7094049136472, 1090.7654854206385, 10511.52698128586, 10598.152147828156, 10638.202134839918, 10655.893441065567, 10694.839577406423, 4335.588119128678, 4475.373447717322, 4551.451187335103, 4557.908841823145, 4601.378813860153, 9150.40522366044, 9157.587908544132, 9163.633454661738, 9166.22087122602, 9187.402818816756, 5063.240513922868, 5091.159958606789, 5126.512981266774, 5131.846044618667, 5133.589312854962, 4108.465899433055, 4238.385434112037, 4405.515393306734, 4608.838690645878, 4627.8843028923875, 3640.416418857805, 3696.2053158571034, 3737.4206997915367, 3791.431285307226, 3797.468354430382, 1233.6730766346925, 1239.9938000309942, 1241.472374240944, 1250.8999280057574, 1253.7805883970268, 773.3503856760349, 780.8633489139378, 880.2825697056878, 894.6913314906346, 902.1700035966926, 5328.200769884548, 5395.757190926339, 5405.648632838853, 5576.637518561281, 5655.406182350876, 429.9187543328531, 431.95896389842915, 440.35927725159814, 897.4121950122681, 973.6300205921846, 3611.205534782344, 3749.718771092179, 3871.109644781716, 3881.146147847469, 3956.3669812830385, 7990.720324788605, 9926.702198934043, 9938.354006989523, 9951.25365597583, 9960.80078398428, 8313.210245026834, 9265.907340926504, 9705.12653861156, 9734.0, 9821.80356392868, 7548.131964824115, 7759.262870027338, 7768.844623107506, 7777.961110194413, 7781.922180778233, 5005.449400565862, 5631.2960879890015, 5639.746211420578, 5666.858328541819, 5976.731047102978, 7583.924160758322, 8811.867821982547, 9089.727308180765, 9260.194262118823, 9271.67549135777, 9052.50211238362, 9176.036516165974, 9248.21390181842, 9316.534173291173, 9336.159745622926, 6532.314107018695, 6533.836654083496, 7019.192792828686, 7045.718171273092, 7186.10173728284, 7648.847023059619, 7866.881996769938, 7870.212978702313, 7873.09459412175, 7879.724209652634, 6895.862082758216, 6935.410490108397, 7017.649117544001, 7026.543274687129, 7045.0, 6805.421539169226, 6931.44548436134, 6954.443644508528, 6982.930170698228, 6993.160820701549, 6436.517261205335, 6558.573692709959, 6663.600183988976, 6665.400113989765, 6683.131192944886, 4565.246734288805, 4776.331313616027, 4818.253170758538, 4886.169351210232, 4966.938720431125, 4787.664863459524, 4830.613550915848, 4896.36347274852, 4951.0, 4996.925046124238], "value": 4303.479919268107, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.4590519931109, 345.69924165975596, 354.7636486843351, 361.4433771991134, 363.4475597092421, 4870.759450652699, 5140.637731001283, 5250.894982100355, 5289.41317604719, 5366.0, 4965.4538000819975, 5051.737065733567, 5108.540231379176, 5136.791179792687, 5274.683518988863, 3607.639236076391, 3638.5269914911155, 4038.5961403859674, 4087.0, 4162.271602469571, 3354.681305275995, 3577.910552236189, 4037.273290807668, 4097.467329247209, 4116.691248156385, 3436.725061995047, 3861.6331448512346, 4052.169305292408, 4087.201631282226, 4090.795460226977, 3988.142549351874, 4063.8171282292074, 4089.652379547742, 4089.8568550100754, 4123.948278274071, 3581.856725730968, 3585.30086633104, 3601.243738814852, 3603.855845766166, 3620.8189590520633, 4207.537170911197, 5053.418856831475, 5054.721990290533, 5061.772220250097, 5091.287219789232, 4023.8994025149314, 4371.519132895379, 4373.497047839475, 4582.495925448198, 4723.5829251224495, 4711.811527538895, 4858.740685581186, 4887.535684110004, 5297.496737809902, 5466.316710411199, 4019.7588144711117, 4043.555208927016, 4074.4295798588223, 4075.3886916962397, 4087.427760113557, 5121.924395876833, 5611.66330020196, 5675.432456754333, 5719.4852463277675, 5724.79963201286, 3345.6654334566347, 3473.0, 3602.585702644177, 3741.6343034792103, 3760.2103558252525, 3597.4783656370205, 3965.3457179565626, 3974.5826688197903, 3979.980100099539, 3981.5023122109737, 3693.538307711536, 4042.838286468508, 4251.404803327537, 4578.610818080434, 4600.35595016698, 4357.1482120098835, 4488.528704486047, 5545.722713864371, 5548.9722551386985, 5601.6358936668985, 1337.6388375138658, 1360.421910583718, 1364.7134101838726, 1370.390176371525, 1382.2950295349244, 819.38136706786, 838.2916435611899, 850.4394436209625, 878.0911756332293, 897.1790811407619, 4318.52496225415, 4640.675152739276, 4874.4150701916, 4960.882467551995, 4962.776675049631, 4616.053708989649, 5281.366236051698, 5410.810621628303, 5420.566354691615, 5424.972875135599, 4244.448221731155, 4781.665283430127, 4837.605385334282, 5209.869753256123, 5268.420473747961, 2642.4715056988293, 2706.3369474478486, 2730.8731502429605, 2744.547149720314, 2762.530369837092, 4789.137955168103, 4898.779554920037, 4911.323328785749, 5168.8449346519665, 5598.524125449301, 5000.374953130859, 5391.3660225064905, 5393.946060539422, 5543.61194716366, 5598.58010649203, 4944.777485013183, 5216.9305292414965, 5516.641418307958, 5563.693996830213, 5608.578766952156, 4966.112877106676, 5265.288376486036, 5357.276767636319, 5386.569074474111, 5397.27136836522, 4420.971634430425, 5288.735563221747, 5302.098643230583, 5359.222912677562, 5382.174358461839, 4740.283417999113, 4979.9004019918675, 4981.750912454435, 5040.127127537268, 5643.0, 3051.7406020488506, 3097.7212050915527, 3266.5263536786556, 3385.984204738519, 3595.29223618779, 4698.882527936692, 4988.750562471934, 5207.719136943852, 5360.7341940184115, 5384.57308813157, 4349.847755328548, 4500.459944806644, 4852.927206091841, 5171.810483588721, 5242.0, 4689.077478234044, 5019.974900125476, 5134.255532947776, 5146.6911985281, 5205.687658740488, 4798.088363210979, 4944.826931057396, 5229.346331708536, 5519.227308176778, 5544.0, 4765.7617119143215, 5396.010428424524, 5468.0, 5600.523955463831, 5623.044082505902, 4864.343313652612, 5404.59465540094, 5438.265834112344, 5441.238226648194, 5465.398806131402], "value": 3943.834251213193, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.4603228530175, 716.6058667732748, 719.9640017999099, 755.176857225624, 766.2452484302961, 14715.264236788158, 15693.764593531107, 15707.92146039271, 15731.685366292668, 15773.053616782987, 12595.370231488412, 12597.244165350085, 12667.93666031671, 12703.237805731662, 12756.808647870266, 674.0529555973865, 694.7394726977384, 696.1715558485412, 701.5264696329982, 826.8222332198576, 760.2625453310308, 864.5849992003842, 876.9914598212075, 881.2289246908955, 882.2721254964648, 895.4403497813867, 910.6038873090193, 929.8512238041915, 931.9347645664806, 936.8360536906048, 714.5141303913337, 739.6264886232472, 740.1118657610889, 929.9116583924516, 932.3566738950103, 554.9528290095346, 555.7943560882459, 657.283560918601, 677.1197443323659, 678.108287601807, 14252.287385630782, 14704.26478676062, 14751.852481475154, 14801.481948131765, 14806.0, 12294.323812190327, 12556.246625202426, 12652.873471265262, 13010.154339967872, 13620.114692544952, 12390.21532442645, 12705.872941270562, 12724.554640587628, 13018.804717929239, 13214.008949328743, 4417.712848664859, 4421.5040893676505, 4489.393931819195, 4542.091581683643, 4632.536746325341, 78667.6066619669, 103534.0, 104220.47889760579, 106432.0, 107122.0, 9260.907390926004, 9736.707898763048, 10392.168626509861, 10419.739506512398, 10485.68542943713, 20291.8985405072, 20422.69365959512, 20565.38303850887, 20643.27748528794, 20653.17387304521, 7500.399968002546, 7554.0, 7555.357794587411, 7629.3133617973535, 7671.53970761756, 4193.517745459311, 4261.360795880642, 4277.657787377002, 4364.323529852878, 4399.73601583906, 3367.326534693071, 3463.0303515015835, 3465.497502862071, 3466.0468371197617, 3468.063622821824, 550.1637510983282, 639.3606393606393, 643.3245092652696, 648.8410339466766, 664.0404615330897, 546.97265136743, 557.0446683936987, 593.0155941137691, 600.8497875531117, 629.1380808292669, 7695.846083078307, 7958.283754462126, 8491.405601607952, 8801.251893589117, 8847.778805529784, 478.289739736491, 538.4400223767238, 592.1591340296789, 617.3116974573319, 626.4643729611117, 4082.8565003372873, 4302.7633480158265, 4314.89212769677, 4323.697341186087, 4458.375827384169, 99522.0, 99986.0, 100744.49627751815, 102638.0, 105532.47233763782, 89446.55276723574, 92207.0, 93904.0, 94424.0, 95739.0, 75310.0, 78140.82788758173, 78322.0, 79399.0, 79745.60127199326, 7726.3818894487185, 8921.330900182642, 9394.530273486434, 9396.577154028222, 9442.622295108393, 42776.7166984991, 47638.0, 48439.0, 51009.744951275, 51245.743771280904, 44448.77775611231, 55496.0, 63825.680871595345, 66871.66564167148, 67682.0, 12532.436040378023, 12784.936075319563, 13042.217466952014, 13322.0, 13331.66670833237, 14651.413943442143, 14672.486462973744, 14748.557543273719, 14832.480863169738, 15031.924840375728, 11541.134414918746, 13348.93325533366, 13373.331333433094, 13755.931220344235, 13927.303634818016, 13461.663458413617, 13761.655958600715, 13907.37416816266, 13936.930315348358, 13997.790033149307, 12996.285204313854, 13226.801597975846, 13418.871959369446, 13565.050446468653, 13574.0, 9311.813763724553, 9966.50167491637, 11172.664820055412, 11252.437378131224, 11560.47977841016, 8605.95697021511, 11138.777224455627, 11457.770844582896, 11590.71023224426, 11591.826122608], "value": 7222.7636911002855, "unit": "score"}], "name": "dromaeo_css", "value": 7224.547091562025, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 114.0, 112.0, 113.0, 114.0, 113.0, 114.0, 114.0, 113.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 118.0, 113.0, 152.0, 116.0, 114.0, 115.0, 115.0, 132.0, 116.0], "value": 123.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 186.0, 183.0, 184.0, 186.0, 185.0, 182.0, 183.0, 184.0, 183.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 61.0, 59.0, 88.0, 60.0, 59.0, 58.0, 60.0, 75.0, 58.0], "value": 65.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 93.0, 116.0, 98.0, 75.0, 69.0, 83.0, 68.0, 69.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 110.0, 112.0, 113.0, 169.0, 114.0, 111.0, 108.0, 110.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 96.0, 94.0, 93.0, 94.0, 107.0, 88.0, 92.0, 130.0], "value": 98.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 86.0, 88.0, 84.0, 85.0, 85.0, 85.0, 86.0, 85.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 53.0, 54.0, 55.0, 54.0, 55.0, 55.0, 54.0, 56.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 66.0, 85.0, 76.0, 75.0, 71.0, 72.0, 71.0, 73.0, 73.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 90.0, 92.0, 92.0, 90.0, 92.0, 93.0, 93.0, 125.0, 91.0], "value": 95.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 146.0, 145.0, 149.0, 154.0, 171.0, 151.0, 160.0, 153.0], "value": 152.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 180.0, 179.0, 178.0, 236.0, 232.0, 179.0, 181.0, 176.0, 180.0], "value": 190.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 67.0, 69.0, 69.0, 68.0, 67.0, 67.0, 68.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1503.3999999999999, "alertThreshold": 2.0}]} 12:43:45 INFO - Return code: 0 12:43:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:43:45 INFO - # TBPL SUCCESS # 12:43:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:43:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:43:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:43:45 INFO - 2016-12-09 12:43:45.316 screenresolution[1920:13096] starting screenresolution argv=screenresolution get 12:43:45 INFO - 2016-12-09 12:43:45.320 screenresolution[1920:13096] Display 0: 1600x1200x32@60 12:43:45 INFO - 2016-12-09 12:43:45.327 screenresolution[1921:13099] starting screenresolution argv=screenresolution list 12:43:45 INFO - Available Modes on Display 0 12:43:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:43:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:43:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:43:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:43:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:43:45 INFO - Intel Iris: 12:43:45 INFO - Chipset Model: Intel Iris 12:43:45 INFO - Type: GPU 12:43:45 INFO - Bus: Built-In 12:43:45 INFO - VRAM (Dynamic, Max): 1536 MB 12:43:45 INFO - Vendor: Intel (0x8086) 12:43:45 INFO - Device ID: 0x0a2e 12:43:45 INFO - Revision ID: 0x0009 12:43:45 INFO - Displays: 12:43:45 INFO - Display: 12:43:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:43:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:43:45 INFO - Display Serial Number: 1600x1200 60 12:43:45 INFO - Main Display: Yes 12:43:45 INFO - Mirror: Off 12:43:45 INFO - Online: Yes 12:43:45 INFO - Rotation: Supported 12:43:45 INFO - Return code: 0 12:43:45 INFO - Running post-action listener: _resource_record_post_action 12:43:45 INFO - [mozharness: 2016-12-09 20:43:45.560019Z] Finished run-tests step (success) 12:43:45 INFO - Running post-run listener: _resource_record_post_run 12:43:45 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 40960; Write bytes: 551500288; Read time: 1; Write time: 2059 12:43:45 INFO - TinderboxPrint: CPU usage
53.8% 12:43:45 INFO - TinderboxPrint: I/O read bytes / time
40,960 / 1 12:43:45 INFO - TinderboxPrint: I/O write bytes / time
551,500,288 / 2,059 12:43:45 INFO - TinderboxPrint: CPU idle
2,227.3 (46.2%) 12:43:45 INFO - TinderboxPrint: CPU system
961.5 (20.0%) 12:43:45 INFO - TinderboxPrint: CPU user
1,628.8 (33.8%) 12:43:45 INFO - TinderboxPrint: Swap in / out
248,729,600 / 0 12:43:45 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 250239488; Write bytes: 253429760; Read time: 18127; Write time: 546 12:43:45 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 40960; Write bytes: 296575488; Read time: 1; Write time: 1506 12:43:46 INFO - Running post-run listener: _upload_blobber_files 12:43:46 INFO - Blob upload gear active. 12:43:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:43:46 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 12:43:46 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', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:43:46 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 Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:43:46 INFO - (blobuploader) - INFO - Open directory for files ... 12:43:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:43:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:43:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:43:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:43:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:43:47 INFO - (blobuploader) - INFO - Done attempting. 12:43:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:43:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:43:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:43:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:43:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:43:48 INFO - (blobuploader) - INFO - Done attempting. 12:43:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:43:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:43:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:43:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:43:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:43:50 INFO - (blobuploader) - INFO - Done attempting. 12:43:50 INFO - (blobuploader) - INFO - Iteration through files over. 12:43:50 INFO - Return code: 0 12:43:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:43:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:43:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/c6aca1a1cf404081d957ac7cb6bfd46d084acdaf953ddff491fd41e22e9090ae289edd402bebda732cf07af2c482738895df22e2f9796d0fa74aecf1ed7725c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/672f787db41fce62cedd2265edab771455bc9ce32b26c92ac2d93d74b16788a3fc0858f935c56b77eeebb2c13d9803886714778fecc9291d27553ff6e2e698b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/a877acd3a2d1beb33147a36857766901719425694c0b8c22ebb34ab2a2ff4e2e08a4f435624642e57a348c43ba59bbacab08dd341dc48f905887032d053d6893"} 12:43:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:43:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:43:50 INFO - Contents: 12:43:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/c6aca1a1cf404081d957ac7cb6bfd46d084acdaf953ddff491fd41e22e9090ae289edd402bebda732cf07af2c482738895df22e2f9796d0fa74aecf1ed7725c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/672f787db41fce62cedd2265edab771455bc9ce32b26c92ac2d93d74b16788a3fc0858f935c56b77eeebb2c13d9803886714778fecc9291d27553ff6e2e698b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/a877acd3a2d1beb33147a36857766901719425694c0b8c22ebb34ab2a2ff4e2e08a4f435624642e57a348c43ba59bbacab08dd341dc48f905887032d053d6893"} 12:43:50 INFO - Running post-run listener: copy_logs_to_upload_dir 12:43:50 INFO - Copying logs to upload dir... 12:43:50 INFO - mkdir: /builds/slave/test/build/upload/logs 12:43:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.386855 ========= master_lag: 1.43 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-12-09 12:43:51.867875) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-09 12:43:51.873840) ========= 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.PoiJilgLyh/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.rwt8XB5FOm/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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/Cedar/sha512/c6aca1a1cf404081d957ac7cb6bfd46d084acdaf953ddff491fd41e22e9090ae289edd402bebda732cf07af2c482738895df22e2f9796d0fa74aecf1ed7725c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/672f787db41fce62cedd2265edab771455bc9ce32b26c92ac2d93d74b16788a3fc0858f935c56b77eeebb2c13d9803886714778fecc9291d27553ff6e2e698b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/a877acd3a2d1beb33147a36857766901719425694c0b8c22ebb34ab2a2ff4e2e08a4f435624642e57a348c43ba59bbacab08dd341dc48f905887032d053d6893"} build_url:https://queue.taskcluster.net/v1/task/JkFdjCmgSI2uA_Giuo0Dog/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg program finished with exit code 0 elapsedTime=0.010970 build_url: 'https://queue.taskcluster.net/v1/task/JkFdjCmgSI2uA_Giuo0Dog/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/c6aca1a1cf404081d957ac7cb6bfd46d084acdaf953ddff491fd41e22e9090ae289edd402bebda732cf07af2c482738895df22e2f9796d0fa74aecf1ed7725c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/672f787db41fce62cedd2265edab771455bc9ce32b26c92ac2d93d74b16788a3fc0858f935c56b77eeebb2c13d9803886714778fecc9291d27553ff6e2e698b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/a877acd3a2d1beb33147a36857766901719425694c0b8c22ebb34ab2a2ff4e2e08a4f435624642e57a348c43ba59bbacab08dd341dc48f905887032d053d6893"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-09 12:43:51.907909) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 12:43:51.908242) ========= 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.PoiJilgLyh/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.rwt8XB5FOm/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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.005107 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 12:43:51.957264) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-09 12:43:51.957596) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-09 12:43:51.957931) ========= ========= Total master_lag: 1.58 =========