builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0214 starttime: 1487781037.75 results: success (0) buildid: 20170222072826 builduid: 6fdbb0efe9d940bba6c6f351fe6fe736 revision: bb3176fecdafb5fb456a3a0454dadb1d79bbe7ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-22 08:30:37.745660) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-22 08:30:37.746098) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-22 08:30:37.746409) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-22 08:30:37.769843) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 08:30:37.770173) ========= 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.D7lYMX0696/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.WFqtHEKQh8/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-22 08:30:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2017-02-22 08:30:37 (159 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124035 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 08:30:37.915319) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 08:30:37.915621) ========= 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.D7lYMX0696/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.WFqtHEKQh8/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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.020360 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 08:30:38.002532) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-22 08:30:38.002872) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bb3176fecdafb5fb456a3a0454dadb1d79bbe7ad --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bb3176fecdafb5fb456a3a0454dadb1d79bbe7ad --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.D7lYMX0696/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.WFqtHEKQh8/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-22 08:30:39,074 truncating revision to first 12 chars 2017-02-22 08:30:39,074 Setting DEBUG logging. 2017-02-22 08:30:39,074 attempt 1/10 2017-02-22 08:30:39,074 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bb3176fecdaf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-22 08:30:40,061 unpacking tar archive at: mozilla-aurora-bb3176fecdaf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.245305 ========= master_lag: 1.57 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-22 08:30:40.823112) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-22 08:30:40.823440) ========= script_repo_revision: bb3176fecdafb5fb456a3a0454dadb1d79bbe7ad ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-22 08:30:40.823843) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-22 08:30:40.824157) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-22 08:30:41.693743) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-22 08:30:41.694040) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.D7lYMX0696/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.WFqtHEKQh8/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 08:30:41 INFO - MultiFileLogger online at 20170222 08:30:41 in /builds/slave/test 08:30:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:30:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:30:41 INFO - {'append_to_log': False, 08:30:41 INFO - 'base_work_dir': '/builds/slave/test', 08:30:41 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:30:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:30:41 INFO - 'branch': 'Mozilla-Aurora', 08:30:41 INFO - 'buildbot_json_path': 'buildprops.json', 08:30:41 INFO - 'config_files': ('talos/mac_config.py',), 08:30:41 INFO - 'default_actions': ('clobber', 08:30:41 INFO - 'read-buildbot-config', 08:30:41 INFO - 'download-and-extract', 08:30:41 INFO - 'populate-webroot', 08:30:41 INFO - 'create-virtualenv', 08:30:41 INFO - 'install', 08:30:41 INFO - 'run-tests'), 08:30:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:30:41 INFO - 'download_minidump_stackwalk': True, 08:30:41 INFO - 'download_symbols': 'ondemand', 08:30:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:30:41 INFO - 'tooltool.py': '/tools/tooltool.py', 08:30:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:30:41 INFO - '/tools/misc-python/virtualenv.py')}, 08:30:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:30:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:30:41 INFO - 'installer_path': 'installer.exe', 08:30:41 INFO - 'log_level': 'info', 08:30:41 INFO - 'log_name': 'talos', 08:30:41 INFO - 'log_to_console': True, 08:30:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:30:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:30:41 INFO - 'opt_config_files': (), 08:30:41 INFO - 'pip_index': False, 08:30:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:30:41 INFO - 'cmd': ('bash', 08:30:41 INFO - '-c', 08:30:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:30:41 INFO - 'enabled': True, 08:30:41 INFO - 'halt_on_failure': False, 08:30:41 INFO - 'name': 'check_screen_resolution'},), 08:30:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:30:41 INFO - 'cmd': ('bash', 08:30:41 INFO - '-c', 08:30:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:30:41 INFO - 'enabled': True, 08:30:41 INFO - 'halt_on_failure': False, 08:30:41 INFO - 'name': 'check_screen_resolution'},), 08:30:41 INFO - 'run_cmd_checks_enabled': True, 08:30:41 INFO - 'sps_profile': False, 08:30:41 INFO - 'sps_profile_interval': 0, 08:30:41 INFO - 'suite': 'dromaeojs', 08:30:41 INFO - 'system_bits': '32', 08:30:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:30:41 INFO - 'title': 't-yosemite-r7-0214', 08:30:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:30:41 INFO - 'use_talos_json': True, 08:30:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:30:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:30:41 INFO - 'work_dir': 'build'} 08:30:41 INFO - [mozharness: 2017-02-22 16:30:41.882487Z] Running clobber step. 08:30:41 INFO - Running pre-action listener: _resource_record_pre_action 08:30:41 INFO - Running main action method: clobber 08:30:41 INFO - rmtree: /builds/slave/test/build 08:30:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:30:43 INFO - Running post-action listener: _resource_record_post_action 08:30:43 INFO - [mozharness: 2017-02-22 16:30:43.871654Z] Finished clobber step (success) 08:30:43 INFO - [mozharness: 2017-02-22 16:30:43.871841Z] Running read-buildbot-config step. 08:30:43 INFO - Running pre-action listener: _resource_record_pre_action 08:30:43 INFO - Running main action method: read_buildbot_config 08:30:43 INFO - Using buildbot properties: 08:30:43 INFO - { 08:30:43 INFO - "project": "", 08:30:43 INFO - "product": "firefox", 08:30:43 INFO - "script_repo_revision": "production", 08:30:43 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 08:30:43 INFO - "repository": "", 08:30:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 08:30:43 INFO - "buildid": "20170222072826", 08:30:43 INFO - "pgo_build": "False", 08:30:43 INFO - "basedir": "/builds/slave/test", 08:30:43 INFO - "buildnumber": 35, 08:30:43 INFO - "slavename": "t-yosemite-r7-0214", 08:30:43 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 08:30:43 INFO - "platform": "yosemite_r7", 08:30:43 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:30:43 INFO - "branch": "mozilla-aurora", 08:30:43 INFO - "repo_path": "releases/mozilla-aurora", 08:30:43 INFO - "revision": "bb3176fecdafb5fb456a3a0454dadb1d79bbe7ad", 08:30:43 INFO - "stage_platform": "macosx64", 08:30:43 INFO - "builduid": "6fdbb0efe9d940bba6c6f351fe6fe736", 08:30:43 INFO - "slavebuilddir": "test" 08:30:43 INFO - } 08:30:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/JpncKKHIRXebxr00ViT1-g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 08:30:43 INFO - Running post-action listener: _resource_record_post_action 08:30:43 INFO - [mozharness: 2017-02-22 16:30:43.877485Z] Finished read-buildbot-config step (success) 08:30:43 INFO - [mozharness: 2017-02-22 16:30:43.877692Z] Running download-and-extract step. 08:30:43 INFO - Running pre-action listener: _resource_record_pre_action 08:30:43 INFO - Running main action method: download_and_extract 08:30:43 INFO - mkdir: /builds/slave/test/build/tests 08:30:43 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')]} 08:30:43 INFO - trying https://queue.taskcluster.net/v1/task/JpncKKHIRXebxr00ViT1-g/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 08:30:43 INFO - Downloading https://queue.taskcluster.net/v1/task/JpncKKHIRXebxr00ViT1-g/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:30:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JpncKKHIRXebxr00ViT1-g/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 08:30:44 INFO - Downloaded 1199 bytes. 08:30:44 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:30:44 INFO - Using the following test package requirements: 08:30:44 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:30:44 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:30:44 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 08:30:44 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:30:44 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 08:30:44 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:30:44 INFO - u'jsshell-mac.zip'], 08:30:44 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:30:44 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 08:30:44 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:30:44 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:30:44 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 08:30:44 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:30:44 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 08:30:44 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:30:44 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 08:30:44 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:30:44 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 08:30:44 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:30:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JpncKKHIRXebxr00ViT1-g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:30:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JpncKKHIRXebxr00ViT1-g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:30:44 INFO - Fetch https://queue.taskcluster.net/v1/task/JpncKKHIRXebxr00ViT1-g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:30:45 INFO - Expected file size: 16357454 08:30:45 INFO - Obtained file size: 16357454 08:30:52 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:30:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JpncKKHIRXebxr00ViT1-g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:30:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JpncKKHIRXebxr00ViT1-g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:30:52 INFO - Fetch https://queue.taskcluster.net/v1/task/JpncKKHIRXebxr00ViT1-g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:30:53 INFO - Expected file size: 16357454 08:30:53 INFO - Obtained file size: 16357454 08:30:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JpncKKHIRXebxr00ViT1-g/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 08:30:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JpncKKHIRXebxr00ViT1-g/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:30:59 INFO - Fetch https://queue.taskcluster.net/v1/task/JpncKKHIRXebxr00ViT1-g/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 08:31:00 INFO - Expected file size: 14403485 08:31:00 INFO - Obtained file size: 14403485 08:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:00 INFO - trying https://queue.taskcluster.net/v1/task/JpncKKHIRXebxr00ViT1-g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:31:00 INFO - Downloading https://queue.taskcluster.net/v1/task/JpncKKHIRXebxr00ViT1-g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 08:31:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JpncKKHIRXebxr00ViT1-g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 08:31:02 INFO - Downloaded 73930170 bytes. 08:31:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JpncKKHIRXebxr00ViT1-g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:31:02 INFO - mkdir: /builds/slave/test/properties 08:31:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:31:02 INFO - Writing to file /builds/slave/test/properties/build_url 08:31:02 INFO - Contents: 08:31:02 INFO - build_url:https://queue.taskcluster.net/v1/task/JpncKKHIRXebxr00ViT1-g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:31:03 INFO - Running post-action listener: _resource_record_post_action 08:31:03 INFO - Running post-action listener: set_extra_try_arguments 08:31:03 INFO - [mozharness: 2017-02-22 16:31:03.641643Z] Finished download-and-extract step (success) 08:31:03 INFO - [mozharness: 2017-02-22 16:31:03.641813Z] Running populate-webroot step. 08:31:03 INFO - Running pre-action listener: _resource_record_pre_action 08:31:03 INFO - Running main action method: populate_webroot 08:31:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:31:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:31:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:31:03 INFO - '--tppagecycles', 08:31:03 INFO - '7'], 08:31:03 INFO - 'tests': ['tsvgm']}}, 08:31:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:31:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:31:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:31:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:31:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:31:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:31:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:31:03 INFO - 'talos_options': ['--disable-e10s'], 08:31:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:31:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:31:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:31:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:31:03 INFO - 'talos_options': ['--disable-e10s'], 08:31:03 INFO - 'tests': ['damp', 'tps']}, 08:31:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:31:03 INFO - 'tests': ['damp', 'tps']}, 08:31:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:31:03 INFO - 'tests': ['dromaeo_dom']}, 08:31:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:31:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:31:03 INFO - 'tests': ['basic_compositor_video']}, 08:31:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:31:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:31:03 INFO - 'tests': ['a11yr', 08:31:03 INFO - 'ts_paint', 08:31:03 INFO - 'tpaint', 08:31:03 INFO - 'sessionrestore', 08:31:03 INFO - 'sessionrestore_no_auto_restore', 08:31:03 INFO - 'tabpaint']}, 08:31:03 INFO - 'other-e10s': {'tests': ['a11yr', 08:31:03 INFO - 'ts_paint', 08:31:03 INFO - 'tpaint', 08:31:03 INFO - 'sessionrestore', 08:31:03 INFO - 'sessionrestore_no_auto_restore', 08:31:03 INFO - 'tabpaint']}, 08:31:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:31:03 INFO - 'ts_paint', 08:31:03 INFO - 'tpaint', 08:31:03 INFO - 'sessionrestore', 08:31:03 INFO - 'sessionrestore_no_auto_restore', 08:31:03 INFO - 'tabpaint']}, 08:31:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:31:03 INFO - 'ts_paint', 08:31:03 INFO - 'tpaint', 08:31:03 INFO - 'sessionrestore', 08:31:03 INFO - 'sessionrestore_no_auto_restore', 08:31:03 INFO - 'tabpaint']}, 08:31:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:31:03 INFO - 'tests': ['a11yr', 08:31:03 INFO - 'ts_paint', 08:31:03 INFO - 'tpaint', 08:31:03 INFO - 'sessionrestore', 08:31:03 INFO - 'sessionrestore_no_auto_restore', 08:31:03 INFO - 'tabpaint']}, 08:31:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:31:03 INFO - 'tests': ['a11yr', 08:31:03 INFO - 'ts_paint', 08:31:03 INFO - 'tpaint', 08:31:03 INFO - 'sessionrestore', 08:31:03 INFO - 'sessionrestore_no_auto_restore', 08:31:03 INFO - 'tabpaint']}, 08:31:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:31:03 INFO - 'tests': ['tsvgx', 08:31:03 INFO - 'tsvgr_opacity', 08:31:03 INFO - 'tart', 08:31:03 INFO - 'tscrollx', 08:31:03 INFO - 'cart', 08:31:03 INFO - 'tsvg_static']}, 08:31:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:31:03 INFO - 'tsvgr_opacity', 08:31:03 INFO - 'tart', 08:31:03 INFO - 'tscrollx', 08:31:03 INFO - 'cart', 08:31:03 INFO - 'tsvg_static']}, 08:31:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:31:03 INFO - 'talos_options': ['--disable-e10s'], 08:31:03 INFO - 'tests': ['tp5o']}, 08:31:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:31:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:31:03 INFO - 'talos_options': ['--disable-e10s', 08:31:03 INFO - '--xperf_path', 08:31:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:31:03 INFO - 'tests': ['tp5n']}, 08:31:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:31:03 INFO - 'talos_options': ['--xperf_path', 08:31:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:31:03 INFO - 'tests': ['tp5n']}}, 08:31:03 INFO - 'talos.zip': {'path': '', 08:31:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:31:03 INFO - Running post-action listener: _resource_record_post_action 08:31:03 INFO - [mozharness: 2017-02-22 16:31:03.661036Z] Finished populate-webroot step (success) 08:31:03 INFO - [mozharness: 2017-02-22 16:31:03.661171Z] Running create-virtualenv step. 08:31:03 INFO - Running pre-action listener: _resource_record_pre_action 08:31:03 INFO - Running main action method: create_virtualenv 08:31:03 INFO - Creating virtualenv /builds/slave/test/build/venv 08:31:03 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 08:31:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:31:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:31:03 INFO - Using real prefix '/tools/python27' 08:31:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:31:04 INFO - Installing distribute.............................................................................................................................................................................................done. 08:31:07 INFO - Installing pip.................done. 08:31:07 INFO - Return code: 0 08:31:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:31:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:31:07 INFO - Reading from file tmpfile_stdout 08:31:07 INFO - Output received: 08:31:07 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) 08:31:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:31:07 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')]} 08:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:07 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')]} 08:31:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:07 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 0x1075f1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075f4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63a4971f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073cfd30>, '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 0x1072f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073c4be8>, '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.D7lYMX0696/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.WFqtHEKQh8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 08:31:07 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 08:31:07 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 08:31:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D7lYMX0696/Render', 08:31:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:31:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:31:07 INFO - 'HOME': '/Users/cltbld', 08:31:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:31:07 INFO - 'LOGNAME': 'cltbld', 08:31:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:07 INFO - 'MOZ_NO_REMOTE': '1', 08:31:07 INFO - 'NO_EM_RESTART': '1', 08:31:07 INFO - 'PAGER': '/bin/cat', 08:31:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:31:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:07 INFO - 'PWD': '/builds/slave/test', 08:31:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:31:07 INFO - 'SHELL': '/bin/bash', 08:31:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WFqtHEKQh8/Listeners', 08:31:07 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 08:31:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:31:07 INFO - 'USER': 'cltbld', 08:31:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:31:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:31:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:07 INFO - 'XPC_FLAGS': '0x0', 08:31:07 INFO - 'XPC_SERVICE_NAME': '0', 08:31:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:31:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:07 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 08:31:07 INFO - Cleaning up... 08:31:07 INFO - Return code: 0 08:31:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:31:07 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')]} 08:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:07 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')]} 08:31:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:07 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 0x1075f1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075f4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63a4971f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073cfd30>, '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 0x1072f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073c4be8>, '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.D7lYMX0696/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.WFqtHEKQh8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 08:31:07 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 08:31:07 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 08:31:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D7lYMX0696/Render', 08:31:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:31:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:31:07 INFO - 'HOME': '/Users/cltbld', 08:31:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:31:07 INFO - 'LOGNAME': 'cltbld', 08:31:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:07 INFO - 'MOZ_NO_REMOTE': '1', 08:31:07 INFO - 'NO_EM_RESTART': '1', 08:31:07 INFO - 'PAGER': '/bin/cat', 08:31:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:31:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:07 INFO - 'PWD': '/builds/slave/test', 08:31:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:31:07 INFO - 'SHELL': '/bin/bash', 08:31:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WFqtHEKQh8/Listeners', 08:31:07 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 08:31:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:31:07 INFO - 'USER': 'cltbld', 08:31:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:31:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:31:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:07 INFO - 'XPC_FLAGS': '0x0', 08:31:07 INFO - 'XPC_SERVICE_NAME': '0', 08:31:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:31:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:08 INFO - Downloading/unpacking psutil>=3.1.1 08:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:31:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:31:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:31:11 INFO - Installing collected packages: psutil 08:31:11 INFO - Running setup.py install for psutil 08:31:11 INFO - building 'psutil._psutil_osx' extension 08:31:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:31:12 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 08:31:12 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 08:31:12 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 08:31:12 INFO - building 'psutil._psutil_posix' extension 08:31:12 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 08:31:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:31:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:31:12 INFO - ^ 08:31:12 INFO - 1 warning generated. 08:31:12 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 08:31:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:31:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:31:12 INFO - Successfully installed psutil 08:31:12 INFO - Cleaning up... 08:31:12 INFO - Return code: 0 08:31:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1075f1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075f4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63a4971f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073cfd30>, '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 0x1072f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073c4be8>, '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.D7lYMX0696/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.WFqtHEKQh8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 08:31:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:31:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:31:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D7lYMX0696/Render', 08:31:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:31:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:31:12 INFO - 'HOME': '/Users/cltbld', 08:31:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:31:12 INFO - 'LOGNAME': 'cltbld', 08:31:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:12 INFO - 'MOZ_NO_REMOTE': '1', 08:31:12 INFO - 'NO_EM_RESTART': '1', 08:31:12 INFO - 'PAGER': '/bin/cat', 08:31:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:31:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:12 INFO - 'PWD': '/builds/slave/test', 08:31:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:31:12 INFO - 'SHELL': '/bin/bash', 08:31:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WFqtHEKQh8/Listeners', 08:31:12 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 08:31:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:31:12 INFO - 'USER': 'cltbld', 08:31:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:31:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:31:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:12 INFO - 'XPC_FLAGS': '0x0', 08:31:12 INFO - 'XPC_SERVICE_NAME': '0', 08:31:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:31:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:31:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:31:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:31:15 INFO - Installing collected packages: mozsystemmonitor 08:31:15 INFO - Running setup.py install for mozsystemmonitor 08:31:15 INFO - Successfully installed mozsystemmonitor 08:31:15 INFO - Cleaning up... 08:31:15 INFO - Return code: 0 08:31:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:15 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 0x1075f1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075f4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63a4971f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073cfd30>, '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 0x1072f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073c4be8>, '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.D7lYMX0696/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.WFqtHEKQh8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 08:31:15 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 08:31:15 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 08:31:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D7lYMX0696/Render', 08:31:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:31:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:31:15 INFO - 'HOME': '/Users/cltbld', 08:31:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:31:15 INFO - 'LOGNAME': 'cltbld', 08:31:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:15 INFO - 'MOZ_NO_REMOTE': '1', 08:31:15 INFO - 'NO_EM_RESTART': '1', 08:31:15 INFO - 'PAGER': '/bin/cat', 08:31:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:31:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:15 INFO - 'PWD': '/builds/slave/test', 08:31:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:31:15 INFO - 'SHELL': '/bin/bash', 08:31:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WFqtHEKQh8/Listeners', 08:31:15 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 08:31:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:31:15 INFO - 'USER': 'cltbld', 08:31:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:31:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:31:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:15 INFO - 'XPC_FLAGS': '0x0', 08:31:15 INFO - 'XPC_SERVICE_NAME': '0', 08:31:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:31:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:15 INFO - Downloading/unpacking jsonschema==2.5.1 08:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:31:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:31: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 08:31: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 08:31: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 08:31: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 08:31: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 08:31: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 08:31:18 INFO - Downloading functools32-3.2.3-2.tar.gz 08:31:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:31:19 INFO - warning: no files found matching '*.txt' 08:31:19 INFO - no previously-included directories found matching 'build' 08:31:19 INFO - no previously-included directories found matching 'dist' 08:31:19 INFO - no previously-included directories found matching '.git*' 08:31:19 INFO - Installing collected packages: jsonschema, functools32 08:31:19 INFO - Running setup.py install for functools32 08:31:19 INFO - warning: no files found matching '*.txt' 08:31:19 INFO - no previously-included directories found matching 'build' 08:31:19 INFO - no previously-included directories found matching 'dist' 08:31:19 INFO - no previously-included directories found matching '.git*' 08:31:19 INFO - Successfully installed jsonschema functools32 08:31:19 INFO - Cleaning up... 08:31:19 INFO - Return code: 0 08:31:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:19 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 0x1075f1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075f4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63a4971f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073cfd30>, '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 0x1072f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073c4be8>, '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.D7lYMX0696/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.WFqtHEKQh8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 08:31:19 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 08:31:19 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 08:31:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D7lYMX0696/Render', 08:31:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:31:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:31:19 INFO - 'HOME': '/Users/cltbld', 08:31:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:31:19 INFO - 'LOGNAME': 'cltbld', 08:31:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:19 INFO - 'MOZ_NO_REMOTE': '1', 08:31:19 INFO - 'NO_EM_RESTART': '1', 08:31:19 INFO - 'PAGER': '/bin/cat', 08:31:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:31:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:19 INFO - 'PWD': '/builds/slave/test', 08:31:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:31:19 INFO - 'SHELL': '/bin/bash', 08:31:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WFqtHEKQh8/Listeners', 08:31:19 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 08:31:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:31:19 INFO - 'USER': 'cltbld', 08:31:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:31:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:31:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:19 INFO - 'XPC_FLAGS': '0x0', 08:31:19 INFO - 'XPC_SERVICE_NAME': '0', 08:31:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:31:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:31:19 INFO - Cleaning up... 08:31:19 INFO - Return code: 0 08:31:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:19 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 0x1075f1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075f4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63a4971f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073cfd30>, '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 0x1072f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073c4be8>, '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.D7lYMX0696/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.WFqtHEKQh8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 08:31:19 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 08:31:19 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 08:31:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D7lYMX0696/Render', 08:31:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:31:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:31:19 INFO - 'HOME': '/Users/cltbld', 08:31:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:31:19 INFO - 'LOGNAME': 'cltbld', 08:31:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:19 INFO - 'MOZ_NO_REMOTE': '1', 08:31:19 INFO - 'NO_EM_RESTART': '1', 08:31:19 INFO - 'PAGER': '/bin/cat', 08:31:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:31:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:19 INFO - 'PWD': '/builds/slave/test', 08:31:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:31:19 INFO - 'SHELL': '/bin/bash', 08:31:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WFqtHEKQh8/Listeners', 08:31:19 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 08:31:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:31:19 INFO - 'USER': 'cltbld', 08:31:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:31:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:31:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:19 INFO - 'XPC_FLAGS': '0x0', 08:31:19 INFO - 'XPC_SERVICE_NAME': '0', 08:31:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:31:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:19 INFO - Downloading/unpacking blobuploader==1.2.4 08:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:22 INFO - Downloading blobuploader-1.2.4.tar.gz 08:31:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:31:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:31:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:31:23 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 08:31:23 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 08:31:23 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 08:31:23 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 08:31:23 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 08:31:23 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 08:31:23 INFO - Downloading docopt-0.6.1.tar.gz 08:31:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:31:23 INFO - Installing collected packages: blobuploader, requests, docopt 08:31:23 INFO - Running setup.py install for blobuploader 08:31:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:31:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:31:23 INFO - Running setup.py install for requests 08:31:24 INFO - Running setup.py install for docopt 08:31:24 INFO - Successfully installed blobuploader requests docopt 08:31:24 INFO - Cleaning up... 08:31:24 INFO - Return code: 0 08:31:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1075f1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075f4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63a4971f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073cfd30>, '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 0x1072f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073c4be8>, '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.D7lYMX0696/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.WFqtHEKQh8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 08:31:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:31:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:31:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D7lYMX0696/Render', 08:31:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:31:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:31:24 INFO - 'HOME': '/Users/cltbld', 08:31:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:31:24 INFO - 'LOGNAME': 'cltbld', 08:31:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:24 INFO - 'MOZ_NO_REMOTE': '1', 08:31:24 INFO - 'NO_EM_RESTART': '1', 08:31:24 INFO - 'PAGER': '/bin/cat', 08:31:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:31:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:24 INFO - 'PWD': '/builds/slave/test', 08:31:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:31:24 INFO - 'SHELL': '/bin/bash', 08:31:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WFqtHEKQh8/Listeners', 08:31:24 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 08:31:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:31:24 INFO - 'USER': 'cltbld', 08:31:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:31:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:31:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:24 INFO - 'XPC_FLAGS': '0x0', 08:31:24 INFO - 'XPC_SERVICE_NAME': '0', 08:31:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:31:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:31:24 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-MLTjh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:31:25 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-4afFBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:31:25 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-AoDlqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:31:25 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-DDO3iP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:31:25 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-7flSDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:31:25 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-7AuS0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:31:25 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-mSYTxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:31:25 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-69jWz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:31:25 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-LYWGjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:31:25 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-Kdmnuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:31:26 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-Hlz8Ha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:31:26 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-ABShFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:31:26 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-bIENep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:31:26 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-N6ovJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:31:26 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-WfjV7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:31:26 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-feMOHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:31:26 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-LSgPa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:31:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:31:26 INFO - Running setup.py install for manifestparser 08:31:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:31:26 INFO - Running setup.py install for mozcrash 08:31:27 INFO - Running setup.py install for mozdebug 08:31:27 INFO - Running setup.py install for mozdevice 08:31:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:31:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:31:27 INFO - Running setup.py install for mozfile 08:31:27 INFO - Running setup.py install for mozhttpd 08:31:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:31:27 INFO - Running setup.py install for mozinfo 08:31:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:31:27 INFO - Running setup.py install for mozInstall 08:31:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:31:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:31:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:31:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:31:27 INFO - Running setup.py install for mozleak 08:31:28 INFO - Running setup.py install for mozlog 08:31:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:31:28 INFO - Running setup.py install for moznetwork 08:31:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:31:28 INFO - Running setup.py install for mozprocess 08:31:28 INFO - Running setup.py install for mozprofile 08:31:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:31:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:31:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:31:28 INFO - Running setup.py install for mozrunner 08:31:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:31:28 INFO - Running setup.py install for mozscreenshot 08:31:29 INFO - Running setup.py install for moztest 08:31:29 INFO - Running setup.py install for mozversion 08:31:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:31:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:31:29 INFO - Cleaning up... 08:31:29 INFO - Return code: 0 08:31:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:31:29 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')]} 08:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:29 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')]} 08:31:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:29 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 0x1075f1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075f4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63a4971f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073cfd30>, '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 0x1072f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073c4be8>, '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.D7lYMX0696/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.WFqtHEKQh8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 08:31:29 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 08:31:29 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 08:31:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D7lYMX0696/Render', 08:31:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:31:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:31:29 INFO - 'HOME': '/Users/cltbld', 08:31:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:31:29 INFO - 'LOGNAME': 'cltbld', 08:31:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:29 INFO - 'MOZ_NO_REMOTE': '1', 08:31:29 INFO - 'NO_EM_RESTART': '1', 08:31:29 INFO - 'PAGER': '/bin/cat', 08:31:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:31:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:29 INFO - 'PWD': '/builds/slave/test', 08:31:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:31:29 INFO - 'SHELL': '/bin/bash', 08:31:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WFqtHEKQh8/Listeners', 08:31:29 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 08:31:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:31:29 INFO - 'USER': 'cltbld', 08:31:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:31:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:31:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:29 INFO - 'XPC_FLAGS': '0x0', 08:31:29 INFO - 'XPC_SERVICE_NAME': '0', 08:31:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:31:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:31:29 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-biqCZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:31:29 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-JxMZ74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:31:29 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-nzG5vr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:31:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:31:29 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-Fi4Gva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:31:30 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)) 08:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:31:30 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-dyEpL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:31:30 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)) 08:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:31:30 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-W4Drsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:31:30 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)) 08:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:31:30 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-ef3lTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:31:30 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)) 08:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:31:30 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-tE0IMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:31:30 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)) 08:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:31:30 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-7Gpw3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:31:30 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)) 08:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:31:30 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-WLYfK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:31:30 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-U7BXm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:31:30 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-HFoq6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:31:30 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-4qQcYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:31:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:31:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:31:31 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-syzGbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:31:31 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)) 08:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:31:31 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-a9jhjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:31:31 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)) 08:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:31:31 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-mi7PGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:31:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:31:31 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-pO5olW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:31:31 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)) 08:31:31 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)) 08:31:31 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)) 08:31:31 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)) 08:31:31 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)) 08:31:31 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)) 08:31:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:33 INFO - Downloading blessings-1.6.tar.gz 08:31:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:31:34 INFO - Installing collected packages: blessings 08:31:34 INFO - Running setup.py install for blessings 08:31:34 INFO - Successfully installed blessings 08:31:34 INFO - Cleaning up... 08:31:34 INFO - Return code: 0 08:31:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:31:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:31:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:31:34 INFO - Reading from file tmpfile_stdout 08:31:34 INFO - Current package versions: 08:31:34 INFO - blessings == 1.6 08:31:34 INFO - blobuploader == 1.2.4 08:31:34 INFO - docopt == 0.6.1 08:31:34 INFO - functools32 == 3.2.3-2 08:31:34 INFO - jsonschema == 2.5.1 08:31:34 INFO - manifestparser == 1.1 08:31:34 INFO - mozInstall == 1.12 08:31:34 INFO - mozcrash == 1.0 08:31:34 INFO - mozdebug == 0.1 08:31:34 INFO - mozdevice == 0.49 08:31:34 INFO - mozfile == 1.2 08:31:34 INFO - mozhttpd == 0.7 08:31:34 INFO - mozinfo == 0.9 08:31:34 INFO - mozleak == 0.1 08:31:34 INFO - mozlog == 3.4 08:31:34 INFO - moznetwork == 0.27 08:31:34 INFO - mozprocess == 0.24 08:31:34 INFO - mozprofile == 0.28 08:31:34 INFO - mozrunner == 6.13 08:31:34 INFO - mozscreenshot == 0.1 08:31:34 INFO - mozsystemmonitor == 0.3 08:31:34 INFO - moztest == 0.8 08:31:34 INFO - mozversion == 1.4 08:31:34 INFO - psutil == 3.1.1 08:31:34 INFO - requests == 1.2.3 08:31:34 INFO - wsgiref == 0.1.2 08:31:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:31:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31: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')]} 08:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:35 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 0x1075f1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075f4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63a4971f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073cfd30>, '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 0x1072f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073c4be8>, '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.D7lYMX0696/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.WFqtHEKQh8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 08:31:35 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 08:31:35 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 08:31:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D7lYMX0696/Render', 08:31:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:31:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:31:35 INFO - 'HOME': '/Users/cltbld', 08:31:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:31:35 INFO - 'LOGNAME': 'cltbld', 08:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:35 INFO - 'MOZ_NO_REMOTE': '1', 08:31:35 INFO - 'NO_EM_RESTART': '1', 08:31:35 INFO - 'PAGER': '/bin/cat', 08:31:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:35 INFO - 'PWD': '/builds/slave/test', 08:31:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:31:35 INFO - 'SHELL': '/bin/bash', 08:31:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WFqtHEKQh8/Listeners', 08:31:35 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 08:31:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:31:35 INFO - 'USER': 'cltbld', 08:31:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:31:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:35 INFO - 'XPC_FLAGS': '0x0', 08:31:35 INFO - 'XPC_SERVICE_NAME': '0', 08:31:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:31:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:31:35 INFO - Cleaning up... 08:31:35 INFO - Return code: 0 08:31:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:31: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')]} 08:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31: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')]} 08:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:36 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 0x1075f1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075f4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63a4971f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073cfd30>, '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 0x1072f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073c4be8>, '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.D7lYMX0696/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.WFqtHEKQh8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 08:31:36 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 08:31:36 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 08:31:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D7lYMX0696/Render', 08:31:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:31:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:31:36 INFO - 'HOME': '/Users/cltbld', 08:31:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:31:36 INFO - 'LOGNAME': 'cltbld', 08:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:36 INFO - 'MOZ_NO_REMOTE': '1', 08:31:36 INFO - 'NO_EM_RESTART': '1', 08:31:36 INFO - 'PAGER': '/bin/cat', 08:31:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:31:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:36 INFO - 'PWD': '/builds/slave/test', 08:31:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:31:36 INFO - 'SHELL': '/bin/bash', 08:31:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WFqtHEKQh8/Listeners', 08:31:36 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 08:31:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:31:36 INFO - 'USER': 'cltbld', 08:31:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:31:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:36 INFO - 'XPC_FLAGS': '0x0', 08:31:36 INFO - 'XPC_SERVICE_NAME': '0', 08:31:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:31:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:31:36 INFO - Cleaning up... 08:31:36 INFO - Return code: 0 08:31:36 INFO - Running post-action listener: _resource_record_post_action 08:31:36 INFO - Running post-action listener: _start_resource_monitoring 08:31:36 INFO - Starting resource monitoring. 08:31:36 INFO - [mozharness: 2017-02-22 16:31:36.657801Z] Finished create-virtualenv step (success) 08:31:36 INFO - [mozharness: 2017-02-22 16:31:36.658754Z] Running install step. 08:31:36 INFO - Running pre-action listener: _resource_record_pre_action 08:31:36 INFO - Running main action method: install 08:31:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:31:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:31:36 INFO - Reading from file tmpfile_stdout 08:31:36 INFO - Detecting whether we're running mozinstall >=1.0... 08:31:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:31:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:31:37 INFO - Reading from file tmpfile_stdout 08:31:37 INFO - Output received: 08:31:37 INFO - Usage: mozinstall [options] installer 08:31:37 INFO - Options: 08:31:37 INFO - -h, --help show this help message and exit 08:31:37 INFO - -d DEST, --destination=DEST 08:31:37 INFO - Directory to install application into. [default: 08:31:37 INFO - "/builds/slave/test"] 08:31:37 INFO - --app=APP Application being installed. [default: firefox] 08:31:37 INFO - mkdir: /builds/slave/test/build/application 08:31:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:31:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:31:56 INFO - Reading from file tmpfile_stdout 08:31:56 INFO - Output received: 08:31:56 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:31:56 INFO - Running post-action listener: _resource_record_post_action 08:31:56 INFO - [mozharness: 2017-02-22 16:31:56.741689Z] Finished install step (success) 08:31:56 INFO - [mozharness: 2017-02-22 16:31:56.741832Z] Running run-tests step. 08:31:56 INFO - Running pre-action listener: _resource_record_pre_action 08:31:56 INFO - Running main action method: run_tests 08:31:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:31:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:31:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:31:56 INFO - 2017-02-22 08:31:56.756 screenresolution[1898:11328] starting screenresolution argv=screenresolution get 08:31:56 INFO - 2017-02-22 08:31:56.759 screenresolution[1898:11328] Display 0: 1600x1200x32@60 08:31:56 INFO - 2017-02-22 08:31:56.764 screenresolution[1899:11331] starting screenresolution argv=screenresolution list 08:31:56 INFO - Available Modes on Display 0 08:31:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:31:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:31:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:31:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:31:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:31:56 INFO - Intel Iris: 08:31:56 INFO - Chipset Model: Intel Iris 08:31:56 INFO - Type: GPU 08:31:56 INFO - Bus: Built-In 08:31:56 INFO - VRAM (Dynamic, Max): 1536 MB 08:31:56 INFO - Vendor: Intel (0x8086) 08:31:56 INFO - Device ID: 0x0a2e 08:31:56 INFO - Revision ID: 0x0009 08:31:56 INFO - Displays: 08:31:56 INFO - Display: 08:31:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:31:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:31:56 INFO - Display Serial Number: 1600x1200 60 08:31:56 INFO - Main Display: Yes 08:31:56 INFO - Mirror: Off 08:31:56 INFO - Online: Yes 08:31:56 INFO - Rotation: Supported 08:31:56 INFO - Return code: 0 08:31:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:31:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:31:57 INFO - Python 2.7.3 08:31:57 INFO - Return code: 0 08:31:57 INFO - grabbing minidump binary from tooltool 08:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:57 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 0x1073cfd30>, '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 0x1072f6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073c4be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:31:57 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 08:31:57 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 08:31:57 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 08:31:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:31:57 INFO - Return code: 0 08:31:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:31:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:31:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:31:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:31:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:31:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JpncKKHIRXebxr00ViT1-g/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0214', '--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 08:31:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JpncKKHIRXebxr00ViT1-g/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0214 --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 08:31:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D7lYMX0696/Render', 08:31:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:31:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:31:57 INFO - 'HOME': '/Users/cltbld', 08:31:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:31:57 INFO - 'LOGNAME': 'cltbld', 08:31:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:31:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:57 INFO - 'MOZ_NO_REMOTE': '1', 08:31:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:31:57 INFO - 'NO_EM_RESTART': '1', 08:31:57 INFO - 'PAGER': '/bin/cat', 08:31:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:57 INFO - 'PWD': '/builds/slave/test', 08:31:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:31:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:31:57 INFO - 'SHELL': '/bin/bash', 08:31:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WFqtHEKQh8/Listeners', 08:31:57 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 08:31:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:31:57 INFO - 'USER': 'cltbld', 08:31:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:31:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:57 INFO - 'XPC_FLAGS': '0x0', 08:31:57 INFO - 'XPC_SERVICE_NAME': '0', 08:31:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:31:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JpncKKHIRXebxr00ViT1-g/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0214', '--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 08:31:57 INFO - mozversion application_buildid: 20170222072826 08:31:57 INFO - mozversion application_changeset: bb3176fecdafb5fb456a3a0454dadb1d79bbe7ad 08:31:57 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:31:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:31:57 INFO - mozversion application_name: Firefox 08:31:57 INFO - mozversion application_remotingname: firefox-dev 08:31:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:31:57 INFO - mozversion application_vendor: Mozilla 08:31:57 INFO - mozversion application_version: 53.0a2 08:31:57 INFO - mozversion platform_buildid: 20170222072826 08:31:57 INFO - mozversion platform_changeset: bb3176fecdafb5fb456a3a0454dadb1d79bbe7ad 08:31:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:31:57 INFO - mozversion platform_version: 53.0a2 08:31:57 INFO - using testdate: 1487781117 08:31:57 INFO - actual date: 1487781117 08:31:57 INFO - starting webserver on 'localhost:49716' 08:31:57 INFO - SUITE-START | Running 2 tests 08:31:57 INFO - TEST-START | dromaeo_css 08:31:57 INFO - operating with platform_type : mac_ 08:31:57 INFO - Initialising browser for dromaeo_css test... 08:31:57 INFO - TEST-INFO | started process 1909 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmpiE5CAj/profile http://localhost:49716/getInfo.html) 08:31:59 INFO - PROCESS | 1909 | __metrics Screen width/height:1600/1200 08:31:59 INFO - PROCESS | 1909 | colorDepth:24 08:31:59 INFO - PROCESS | 1909 | Browser inner width/height: 1024/689 08:31:59 INFO - PROCESS | 1909 | __metrics 08:31:59 INFO - PROCESS | 1909 | 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" 08:31:59 INFO - PROCESS | 1909 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:32:00 INFO - TEST-INFO | 1909: exit 0 08:32:00 INFO - Browser initialized. 08:32:00 INFO - Running cycle 1/1 for dromaeo_css test... 08:32:00 INFO - TEST-INFO | started process 1911 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmpiE5CAj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:32:13 INFO - PROCESS | 1911 | RSS: Main: 213102592 08:32:13 INFO - PROCESS | 1911 | 08:35:17 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49716/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49716/tests/dromaeo/cssquery-ext.html) 08:35:18 INFO - PROCESS | 1911 | RSS: Main: 364376064 08:35:18 INFO - PROCESS | 1911 | 08:37:02 INFO - PROCESS | 1911 | ************************* 08:37:02 INFO - PROCESS | 1911 | A coding exception was thrown and uncaught in a Task. 08:37:02 INFO - PROCESS | 1911 | 08:37:02 ERROR - PROCESS | 1911 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:37:02 INFO - PROCESS | 1911 | Full stack: 08:37:02 INFO - PROCESS | 1911 | ************************* 08:38:21 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49716/tests/dromaeo/cssquery-ext.html (next: http://localhost:49716/tests/dromaeo/cssquery-jquery.html) 08:38:22 INFO - PROCESS | 1911 | RSS: Main: 358309888 08:38:22 INFO - PROCESS | 1911 | 08:41:24 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49716/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49716/tests/dromaeo/cssquery-mootools.html) 08:41:25 INFO - PROCESS | 1911 | RSS: Main: 318283776 08:41:25 INFO - PROCESS | 1911 | 08:44:27 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49716/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49716/tests/dromaeo/cssquery-prototype.html) 08:44:28 INFO - PROCESS | 1911 | RSS: Main: 349872128 08:44:28 INFO - PROCESS | 1911 | 08:47:31 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49716/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49716/tests/dromaeo/cssquery-yui.html) 08:47:32 INFO - PROCESS | 1911 | RSS: Main: 311308288 08:47:32 INFO - PROCESS | 1911 | 08:50:36 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49716/tests/dromaeo/cssquery-yui.html (next: http://localhost:49716/tests/dromaeo/cssquery-dojo.html) 08:50:36 INFO - PROCESS | 1911 | RSS: Main: 386465792 08:50:36 INFO - PROCESS | 1911 | 08:50:36 INFO - PROCESS | 1911 | __start_tp_report 08:50:36 INFO - PROCESS | 1911 | _x_x_mozilla_page_load 08:50:36 INFO - PROCESS | 1911 | _x_x_mozilla_page_load_details 08:50:36 INFO - PROCESS | 1911 | |i|pagename|runs| 08:50:36 INFO - PROCESS | 1911 | |0;dojo.html;3311.8675252989865;3322.4351860183765;3334.6998770110686;3338.0820274424536;3376.3247350529887;5727.513161381287;5733.7993170239;5747.281589801275;5747.597668163225;5769.076947688365;5710.172025056364;5789.855253618662;5794.188813566104;5817.389174136708;5818.883622327551;5221.608379371543;5233.555147812441;5278.894422111574;5332.280142180814;5338.225957236198;5170;5171.586273098162;5183.326167598207;5345.652532585389;5349.759260833272;5201.869953251161;5242.606804489659;5249.212618107295;5274.57803375731;5324.627276090675;5273.31446911899;5275.6043296752705;5285.497877701612;5302.151655735083;5302.3637163540625;5124.769385377667;5161.200013997836;5228.215767634847;5262.368515778131;5270.051390749663;5601.103823388279;5633.985882541141;5697.230873832021;5732.77068917247;5733.598648094635;6217.56477046607;6238.719257633417;6305.0857625644485;6317.210348706411;6347;6273.059041143865;6313.273973493061;6341.460975817061;6355;6368.904466433008;5631.380548139701;5755.568332375088;5756.7121643917635;5770.538356931435;5867.090600956859;6299.338569450233;6321.146645202931;6329.367063293634;6332.113504109337;6336.619802811846;6188.4739797117745;6192.8761424771255;6215.627062376272;6217;6220.471259942865;6165.075238714139;6187.84530386735;6206.627602343874;6225.533085018642;6296.0555916612875;6191.040388739752;6234.719437625317;6255.718492667841;6295.37046295376;6297.055441683784;5206.3752349717515;5928.881422371528;6304.905426418607;6314.778982735582;6319.905201421982;4904.877378065506;4941.777620007108;4999.700017998932;5009.0482808266315;5014.247862820606;4433.933490997638;4441.244988351923;4486.573775491323;4489.6408287336935;4498.415206023196;5696.088625819849;5746.02317606008;5748.252727145445;5773.220615216976;5812.157237200582;6153.507719382439;6224.62652240867;6235.750569977241;6244.438000579969;6308.621482711052;5719.456651618089;5729.054705973551;5772.220750198753;5778.479936805707;5815.04051831443;5357.223202635674;5379.220013098157;5423.972880135574;5455.208994695826;5521.834344969658;6294.118823364733;6353.428191462791;6370.74517019314;6389.9361006389345;6403.263624683221;5463.344398672185;6261.749530018748;6283.685815709105;6312.810615681537;6326.240851097898;6224.439800417984;6263.311035785969;6317.30509643948;6385.808425747235;6386.776462823779;6154.892119418548;6242.750289988531;6246.812595622138;6251.812445626639;6262.968685156728;6267.9373206267355;6278.0896769967185;6288.434040936338;6295.464885484785;6312.621242725451;6019.578629495893;6036.215292012011;6112;6181.690915454119;6187.597806142587;6116.5106791457465;6120.816375508742;6121.940772763084;6165.075238714228;6180.351063138306;4938.678985865908;5997.640141591519;6008.849778755566;6010.639361638316;6033.0045542484995;5948.4943779779205;6166.1983942087245;6178.474829639531;6182;6183.721732521957;5872.0898260769645;5925.555583331354;5949.52403807703;5961.37405572426;6026 08:50:36 INFO - PROCESS | 1911 | |1;ext.html;432.8831215571795;446.80117347780254;486.79311292700595;512.369785164248;534.3080710479929;31400.842995785017;32924.341513169726;32929.83535082324;41981.37027944583;42865.78567107168;44429.555704442944;45014.77492612541;45148.54851451484;45317.77341113298;45318.546814531845;9244.02937691541;9477.289203309745;9478.526073696323;9479.526023698787;9492.762680932998;8350.164983501632;8568.871466928002;9164.083591640849;9321.114494123081;11141.498632561514;10901.073408760265;11118.277311974736;11134.888651113506;11168.944155279212;11174;11301.717457063598;11340.20618556693;11379.089672826154;11387.20289579734;11412.54349826006;8340.541270230135;8543.14568543147;11066.557337706483;11287.604933827359;11386.032187264009;39783;41873.95315117116;42230.155396892194;42286.36570451446;42339.57660423387;3928.332183528807;3930.921381572381;3934.350832112698;3973.6225058619384;4078.6737061035046;29761.404771904658;31089;31808.840955795305;31893.681063189302;32327.35345293081;3138.2154461384653;3173.1115287719476;3183.5861338025907;3191.763446827076;3218.09893229896;435577.99999999686;435852;436854;437275;437751;67715;67886.66056669685;68000.97998530026;68040.31959680439;68238;70264;70264.64867675629;70301;70365.64817175984;70429.64785176041;16375.508734737978;17016.65966680684;17041.573960651083;17041.7443738344;17054.14729263532;12735.426905789262;13044.086913916124;13100.803487947689;13194.274314912773;13216.207027578375;16470.258838352303;16720;16728.24722887473;17144.485665430057;17148.571285717706;6605.339466053356;6964.4428445724225;7003.299670032956;7104.68028938699;7132.286771322826;849.9745007649781;858.3390789092489;861.9827603447895;887.1040249348205;907.6278725722422;29947.70052299449;30024.399512009637;30138.24654383614;30519;30654.54018189729;1054.2567489919588;1056.4348073780643;1067.6209945469247;1099.384344766933;1160.8374827524153;14059.578212653636;14540.927295363666;15681.13753743555;15945.282462289224;15965.44120955761;474107;562428;566472;568571;568978;63308.683456582425;63479;63539.6823015882;63678.68160659167;63681;1234.4198226833373;1429.7354989327007;1445.1762495377955;1448.73922693914;1453.1499073042178;28508.85745571259;29337.413251735274;29379.706202937698;29892;29990.100296991124;53320.2001969963;53580.1962970548;53589.732051339495;53675.46324536705;53692;472588;475853;476142;476497.6175119102;476501;26897.462050758484;27153.72846271591;27383.04159354413;27403.45193096087;27430;48569;50164.749176253885;50215.497845022546;50401.99196015986;50458.990820184124;33857.15357116092;39384.01539961524;39444.01389965274;40654.79672601736;41307.58692413037;39471;39913.401298981116;40598.985025374604;40957.590424095375;41503;38466.615333846305;38606.6139338603;39237.60762392454;39318.41022384724;39560.802195988836;32156.51765223477;34209.96258674548;34455.483167752005;34791;35287.64712352843;22072.44818879541;24741.752582473946;25258.747412526376;25298.988040478176;25430.237092887244 08:50:36 INFO - PROCESS | 1911 | |2;jquery.html;337.81251405469965;361.3008827917979;372.43761919501577;383.2870860200029;402.63963752441566;14947.327370268336;15673.843261567396;16117.194140292968;20528.178872845067;21167.788322116776;20766.584668306627;21186.89406552969;21768;21820;21983.560328793414;5788.913166302509;5825.941740582603;5977.073553599199;6046.7883624073165;6050.485708714765;5756.769729210827;5884.029135192688;5915.88168236635;5974.312954010279;5985.132155837401;4169.812358443877;4303.922202923359;4406.272964960777;4412.75729834859;5942.376050514698;6603.504737144734;6604.207495100571;6605.174353205849;6612.570182938093;6705.362990515893;5089.236614507817;5320.600954928357;5388.191771234307;5422.8915421691345;5810.157527158581;13419.463221471227;13489.460421583124;13523.526676566273;13644.90840732739;13679.110857794212;2697.743714347134;2711.5932610108443;2811.5360965440677;2854.757345625624;2909.6799352071257;9171.85351831021;9526.809463810754;9982.251331150193;10125.594976200942;10491.947540262327;1702.838230368113;1742.5469377961822;1758.6746451906438;1760.0407777761152;1764.5235786337616;105825.47087264592;127407.3629631846;129492.705072949;131848;134369.3281533586;10109.443980581138;10621.575136994434;10648.627298044687;10777.676669699922;11910.940445297718;12887.677808054874;12916.806247906288;12942.288174150512;12947.093703440669;12947.482100715866;8180.345572354197;8249.711260105867;8261.215184557457;8475.618597163018;8508.957455212685;8567.629179331278;8753.29973602123;8775.956120219358;8926.152015558511;8953.194212520904;3589.94615080774;4118.464599602033;4127.5666055064385;4137.8965525861495;4212.91574168521;1738.6435780664933;2012.2454079720105;2034.8982550872397;2043.9182432702526;2050.8359331253464;817.7138001699358;853.389826274217;854.2226573817796;855.9914400855912;884.6461415433878;21453.67819482709;21742.891285543472;22747.772522274896;22767.430814229778;22822;767.731294047079;894.4409743910056;902.5848109869403;922.4741897118712;932.067932067932;11352.091832653368;11575.42122893852;11615.361155136548;11655.76688466226;11721.941390292994;764148;773707;778223;788447;796889;161186;163124;165181.17409412877;166040.5093923592;168428;317.99682003180135;458.76373667561234;461.6699060171926;464.49602181632633;464.9628029757611;10035.147012503727;10506.369617822955;11112;11415.37215453125;11515.8272625909;61100;61967.690161548904;61991.690041549504;63327.683361582895;64093.67953160204;73126;93268.53365733128;95460.61348466344;96024;98596.50701746445;5897.557683173865;6264.342244064308;8258.834823303621;8443.36674749384;8975.416597921114;12621.053420993645;13215.66960825987;13465.192088474723;13509.189448633113;13709.383077761326;11010.009099181112;11289;11368.829467557827;11410.771784564096;11530.82703759461;11555.537778488766;11567.479463424335;11698.005669518187;11875.228110172811;12036.217645852992;11604.071674266208;11689.123315751523;11876.524939002344;11925.30315602166;12061.216020958609;8401.621927013177;8521.190486903733;8723.476591404537;8991.505467199368;9001.054889236797;9945;11266.098712102848;11582.71043223926;11635.825462618237;11811.763764724485 08:50:36 INFO - PROCESS | 1911 | |3;mootools.html;1371.259519859276;1426.3866537388926;1438.1802372647594;1446.1973604649418;1459.233902201344;7510;8018.037835459746;8424.115467875878;8431.325493960483;8446.028706698738;7629.771106866789;7761.844763104735;7978.48139870908;8187.91812081879;8192.713255036075;2281.8174546036275;2332.88335583221;2334.8949297281665;2339.6841426407473;2342.7422983471806;2088.812006919377;2315.6526521021897;2367.633016882386;2383.559041577305;2384.666146739458;1800.162924240228;2145.570885822842;2254.549090181962;2325.3489023073566;2333.6032874411308;2288.771122887706;2298.839081264312;2300.804431623314;2301.2635956493928;2304.7119110111234;2263.2531264682616;2344.788968992782;2346.389938615955;2353.0352555452355;2354.482013956927;8286.337093032604;8377.916220837775;8380.120087390858;8398.160183981614;8401.873971890427;5065.240213967897;5225.294585230983;5229.529342359206;5234.398044224887;5243.842684719464;3291.522729204252;3354.3123659649714;3475.2354482013916;3546.131197856516;3564.4296912494137;1202.6271855724754;1209.9334536600484;1242.0994778785398;1250.868658790823;1272.5228039485194;8933.776655583597;10795.2443328967;10819.080378167866;10822;10837.566497340096;4425.845095421645;4643.187442197602;4714.717116972924;4724.692894961817;4725.976370118196;9488.573014214377;9507.477088760046;9513.904860951441;9521.761955951157;9549.140577348073;5234.162533994542;5258.447862974333;5259.8422047338645;5263.157894736823;5266.868328291746;4716.3868697069165;4719.787609557578;4766.142094423037;4836.733979631154;4846.636502262344;3787.8484860605818;3807.4669546263544;3845.6346647068485;3889.922201555953;3891.552471465761;1265.3862876505073;1267.4423253768311;1270.898328133747;1286.8777466140702;1288.62629837348;603.6860832367145;740.6629983357559;754.6038329876859;757.4054367321736;781.3124450483538;5403.162509810985;5433.728313584305;5550.084236101079;5563.471470210324;5636.239107720406;896.8609865470862;951.7668171297938;979.911807937289;981.1022914033722;1021.2391768132788;3725.1245957200035;3740.0649837540614;3766.1456149807636;3817.255635151119;3853.460515527828;9736.221102311798;9846.852297215548;9902.55438505269;10114.089731924161;10154.339967902062;9712.70861874145;9731.708048758548;9906.752331191778;9980.251481138943;10008.09927106564;7619.08570971487;7732.6520306586335;7738.2261773822165;7751;7774.6890124394395;5309.283246761792;5494.230807687007;5539.473749993744;5675.0636145035605;5750.568707347049;8752.51861147643;8821.161989610977;8873.955630221808;9104.271658267455;9139.497327646777;8172.632231549475;8736.08271131522;8855.468671879707;9150.862737058816;9277.814443711222;7081.858362832611;7183.676734547063;7207.459440541876;7279.199288078201;7283.308085731847;7773.37812974972;7807.960960195162;7810.843783124419;7889.881651775113;7896.526208427513;6986.441084713109;7064.222935476991;7081.114860642419;7132.215456299907;7235.023271858232;6946.097007389007;6969.825754356181;6977.447485709446;6984.615846128511;7019.894701579378;6266.624002559861;6307.400796924285;6363.268224154096;6376;6473.449756770728;4950.727709975842;4971.875703107306;4992.176290911959;5023.346964894687;5047.217681259411;4921.8523444296725;4928.310036594808;4954.727489988085;5114.514121158484;5192.844214673566 08:50:36 INFO - PROCESS | 1911 | |4;prototype.html;300.50566817585076;358.6592736899945;368.83586803872277;376.85491085931943;382.98659546915866;4686.89857883398;5175.611829112818;5284.788608455667;5310.8141215057485;5314.946850531498;4593.793279302431;4707.952920470802;5105.438401775811;5108.335916330881;5247.212918062292;2877;4076.9388459173138;4174.269502837006;4198.921533840753;4202.592131635898;3403.0471467988878;3753.2681127180213;4089.3457046872504;4152.854650087247;4155.812988415529;3324.805628285332;3387.779794313374;3799.6390342917516;4071.145059537501;4103.569125241851;3696.5748938872107;3834.7153703509357;3888.47505586745;4036.6367026967714;4138.516889866087;3221.7583681224;3256.9837150814333;3641.617630148849;3667.651573100551;3690.9815450922843;4178.2688029595;5050.500002498787;5090.592752579785;5091.414487333967;5121.7451724327775;4590.380298659705;4754.690945088558;4758.666893317469;4793.328933949215;4809.278608208761;4514.503404625489;4750.4299484061785;5023.497650234984;5507.339119305669;5564.721763911788;4041.717079804415;4050.8177132029127;4056.8843568018738;4079.5920407959266;4134.689898257643;5235.633505654606;5435.42927992563;5855.355910849803;5861.618994765369;5878.412158784087;3983.9601603983588;4055.3916912463364;4065.6340929316502;4101.2364683186515;4118.464599602033;3591.5510561179854;4198.286291330481;4200.033992181815;4211.389348544444;4235.53409124996;4009.498812648419;4078.7552746835286;4532.5694059064335;4803.879903002453;4818.494058123917;4640.6310138509225;5273.288106105703;5523.171524271392;5541.639793413416;5559.805406810742;1243.9191452555556;1275.8787915148046;1343.1598709767682;1383.9169649821042;1384.764590019699;826.9751907442786;844.7001314533252;907.668700924158;959.3907868503551;975.1175186456269;4134.979325103355;4752.904941901212;4783.234682450791;4818.4217893852265;4990.451050384528;5397.541208997279;5454.509094181463;5471.972640136853;5473.303275984457;5481.643693160012;4516.3902873112365;4801.399825021872;5092.439831618519;5095.414027386898;5146.099432599281;2696.8651567421552;2724.1827451764393;2806.719328067177;2836.8297902125937;2846.587244849485;5032.84901452957;5351.678899266057;5620.297462817148;5627.649364152574;5640.392488140942;4711.372243372584;5350.652207606571;5453.536449401845;5561.555075594024;5563.944360556343;4660.930086048712;4816.470188279286;4893.874408885976;5295.470452954673;5532.834014979557;4730.929036064531;5036.524797889445;5050.84847454577;5193.221016847352;5407.702576358338;4628.861134165981;4691.004080654093;4757.476677565396;5280.551153152025;5393.815504720595;4945.554900059012;5387.5689944803535;5628.324601047737;5886.470217680258;5922.881542369215;3507.298540292003;3644.1800594865945;3789.886303410902;3839.788811615388;3870.748401353903;5120.871978200575;5636.3799982002765;5644.096944488862;5714.742836572281;5725.828225153252;4476.9328460072475;4789.281607758864;5404.297441332602;5455.372632147195;5474.7810087597645;4237.894052648709;4624.583787459145;5482.053870875941;5495.120780675073;5536.861578460571;5158.97420512895;5361.919571206513;5396.298481197577;5396.946030539644;5423.535645375648;5149.279100925948;5450;5467.5625949923115;5493.285872836505;5504.284443022381;4875.854174268973;5174.689518628894;5247.2129180623215;5273.499017593323;5357.392782165412 08:50:36 INFO - PROCESS | 1911 | |5;yui.html;664.7075286873775;681.2166009089547;686.159454668032;708.3624737736037;804.6459557794572;14480.637984050403;15418.691626167498;15455;15465.92267038666;15483.458078967238;14106.294685265748;14216.360263788129;14249.501267455642;14262.3581938813;14378.424863005468;595.9731812068445;615.4829942848007;760.8212070163521;772.9912464234172;776.192759530088;607.7568972411027;747.9289467500579;769.5113602862167;772.2007722007695;772.8454309138167;823.8970128733908;829.7925518620345;833.2667252817512;833.3333333333339;835.6406745099636;822.268181318627;822.457178262344;823.3454403749034;825.0759149752286;825.9628316725732;472.03233371588107;477.0411472939382;593.3888095261888;614.7448808744366;615.1633778061832;14619.70760584793;15129;15149;15159.62100947474;15177.16525591092;13639.590812275648;13812.654683632889;13836.446542138303;13840.861591384159;13851.722965540734;12106.939465302705;12209.572664956684;12249.510019599205;12363.443645035995;12589.93705031469;4303.935440968388;4353.73877567347;4354.433923589945;4385.7149285296355;4394.824207031715;105963.94036059619;111389.88610113958;111663;111722.44138779335;114164.99999999917;9147.359684822131;9723.173530250007;10070.144037756727;10509.31689440184;10668.786624267472;21403.357899263046;21486;21493.355199344045;21722.891385543287;21744.130234790748;7398.3341499265325;7420.962895185489;7422.181208386715;7501.137369202612;7672.386209103258;4093.0995181060716;4113.053997580513;4202.810873510699;4207.389928460356;4339;3454.378211921878;3539.486774417695;3550.609432962372;3564.9821750891597;3741.4761933329355;702.8664553734774;707.1372925031453;712.9714811407486;724.6123324021623;727.4980263618193;653.6764301670703;660.2011566005187;674.8785218660688;675.270707635762;709.8473828126978;9397.709016210023;10168.186545076524;10375.27373083877;10435.37387756737;10494.317869338622;651.7686221391433;651.8761435327273;698.7414656577099;703.7958991892397;706.2055187913597;4576.588107070313;4748.3114948332295;4910.680805747615;4913.263010548446;4920.507949205123;87688.12311876928;90002.54998724964;90917.54541227384;106764.93235067706;111970.44014780037;83577;87106;87135;88434.11565884388;89289;77011.61494192493;79068;81478.96302592482;82268.17731822845;83095.5845220782;9924.751881203028;10071.143952764098;10533.578656853946;10724.946375268073;10791.946040269748;51028.74485627548;52617.210741838135;53127.468725312254;53540.73229633827;54149.917001658956;65638.67180664066;67335;67353.32646673471;68768.65615671889;70230;12378.381080946097;12786.68033299175;12794.232346059267;12816.295103769009;13028.739425211254;13200.14199077057;13850.030497865455;14319.57041288763;14508.1295122293;14798.408063677763;12273.631791046282;12546;13424;13445.327733613476;13573.457061717421;12632.2420654761;13220.206787592391;13484.86515134836;13939.303034848419;14027.368768405242;12500.31248281317;13241.470341186245;13254.933725331312;13592.524261650795;13725.588232353046;9192.448453092837;10361;10590.682279531626;10914.945425272823;11596.246243994114;9934.850977235203;10598.62610402359;10677.626283080055;10731.195160362848;10765.784684306427 08:50:36 INFO - PROCESS | 1911 | __end_tp_report 08:50:36 INFO - PROCESS | 1911 | __start_cc_report 08:50:36 INFO - PROCESS | 1911 | _x_x_mozilla_cycle_collect,1750 08:50:36 INFO - PROCESS | 1911 | __end_cc_report 08:50:36 INFO - PROCESS | 1911 | __startTimestamp1487782236357__endTimestamp 08:50:36 INFO - PROCESS | 1911 | 08:50:36 INFO - PROCESS | 1911 | ------- Summary: start ------- 08:50:36 INFO - PROCESS | 1911 | Number of tests: 6 08:50:36 INFO - PROCESS | 1911 | 08:50:36 INFO - PROCESS | 1911 | [#0] dojo.html Cycles:165 Average:5766.42 Median:5949.52 stddev:646.40 (10.9%) stddev-sans-first:619.04 08:50:36 INFO - PROCESS | 1911 | Values: 3311.9 3322.4 3334.7 3338.1 3376.3 5727.5 5733.8 5747.3 5747.6 5769.1 5710.2 5789.9 5794.2 5817.4 5818.9 5221.6 5233.6 5278.9 5332.3 5338.2 5170.0 5171.6 5183.3 5345.7 5349.8 5201.9 5242.6 5249.2 5274.6 5324.6 5273.3 5275.6 5285.5 5302.2 5302.4 5124.8 5161.2 5228.2 5262.4 5270.1 5601.1 5634.0 5697.2 5732.8 5733.6 6217.6 6238.7 6305.1 6317.2 6347.0 6273.1 6313.3 6341.5 6355.0 6368.9 5631.4 5755.6 5756.7 5770.5 5867.1 6299.3 6321.1 6329.4 6332.1 6336.6 6188.5 6192.9 6215.6 6217.0 6220.5 6165.1 6187.8 6206.6 6225.5 6296.1 6191.0 6234.7 6255.7 6295.4 6297.1 5206.4 5928.9 6304.9 6314.8 6319.9 4904.9 4941.8 4999.7 5009.0 5014.2 4433.9 4441.2 4486.6 4489.6 4498.4 5696.1 5746.0 5748.3 5773.2 5812.2 6153.5 6224.6 6235.8 6244.4 6308.6 5719.5 5729.1 5772.2 5778.5 5815.0 5357.2 5379.2 5424.0 5455.2 5521.8 6294.1 6353.4 6370.7 6389.9 6403.3 5463.3 6261.7 6283.7 6312.8 6326.2 6224.4 6263.3 6317.3 6385.8 6386.8 6154.9 6242.8 6246.8 6251.8 6263.0 6267.9 6278.1 6288.4 6295.5 6312.6 6019.6 6036.2 6112.0 6181.7 6187.6 6116.5 6120.8 6121.9 6165.1 6180.4 4938.7 5997.6 6008.8 6010.6 6033.0 5948.5 6166.2 6178.5 6182.0 6183.7 5872.1 5925.6 5949.5 5961.4 6026.0 08:50:36 INFO - PROCESS | 1911 | 08:50:36 INFO - PROCESS | 1911 | [#1] ext.html Cycles:180 Average:64324.17 Median:39414.01 stddev:130028.43 (329.9%) stddev-sans-first:130304.71 08:50:36 INFO - PROCESS | 1911 | Values: 432.9 446.8 486.8 512.4 534.3 31400.8 32924.3 32929.8 41981.4 42865.8 44429.6 45014.8 45148.5 45317.8 45318.5 9244.0 9477.3 9478.5 9479.5 9492.8 8350.2 8568.9 9164.1 9321.1 11141.5 10901.1 11118.3 11134.9 11168.9 11174.0 11301.7 11340.2 11379.1 11387.2 11412.5 8340.5 8543.1 11066.6 11287.6 11386.0 39783.0 41874.0 42230.2 42286.4 42339.6 3928.3 3930.9 3934.4 3973.6 4078.7 29761.4 31089.0 31808.8 31893.7 32327.4 3138.2 3173.1 3183.6 3191.8 3218.1 435578.0 435852.0 436854.0 437275.0 437751.0 67715.0 67886.7 68001.0 68040.3 68238.0 70264.0 70264.6 70301.0 70365.6 70429.6 16375.5 17016.7 17041.6 17041.7 17054.1 12735.4 13044.1 13100.8 13194.3 13216.2 16470.3 16720.0 16728.2 17144.5 17148.6 6605.3 6964.4 7003.3 7104.7 7132.3 850.0 858.3 862.0 887.1 907.6 29947.7 30024.4 30138.2 30519.0 30654.5 1054.3 1056.4 1067.6 1099.4 1160.8 14059.6 14540.9 15681.1 15945.3 15965.4 474107.0 562428.0 566472.0 568571.0 568978.0 63308.7 63479.0 63539.7 63678.7 63681.0 1234.4 1429.7 1445.2 1448.7 1453.1 28508.9 29337.4 29379.7 29892.0 29990.1 53320.2 53580.2 53589.7 53675.5 53692.0 472588.0 475853.0 476142.0 476497.6 476501.0 26897.5 27153.7 27383.0 27403.5 27430.0 48569.0 50164.7 50215.5 50402.0 50459.0 33857.2 39384.0 39444.0 40654.8 41307.6 39471.0 39913.4 40599.0 40957.6 41503.0 38466.6 38606.6 39237.6 39318.4 39560.8 32156.5 34210.0 34455.5 34791.0 35287.6 22072.4 24741.8 25258.7 25299.0 25430.2 08:50:36 INFO - PROCESS | 1911 | 08:50:36 INFO - PROCESS | 1911 | [#2] jquery.html Cycles:180 Average:41397.34 Median:1613.84 stddev:130103.55 (8061.7%) stddev-sans-first:130431.99 08:50:36 INFO - PROCESS | 1911 | Values: 337.8 361.3 372.4 383.3 402.6 14947.3 15673.8 16117.2 20528.2 21167.8 20766.6 21186.9 21768.0 21820.0 21983.6 5788.9 5825.9 5977.1 6046.8 6050.5 5756.8 5884.0 5915.9 5974.3 5985.1 4169.8 4303.9 4406.3 4412.8 5942.4 6603.5 6604.2 6605.2 6612.6 6705.4 5089.2 5320.6 5388.2 5422.9 5810.2 13419.5 13489.5 13523.5 13644.9 13679.1 2697.7 2711.6 2811.5 2854.8 2909.7 9171.9 9526.8 9982.3 10125.6 10491.9 1702.8 1742.5 1758.7 1760.0 1764.5 105825.5 127407.4 129492.7 131848.0 134369.3 10109.4 10621.6 10648.6 10777.7 11910.9 12887.7 12916.8 12942.3 12947.1 12947.5 8180.3 8249.7 8261.2 8475.6 8509.0 8567.6 8753.3 8776.0 8926.2 8953.2 3589.9 4118.5 4127.6 4137.9 4212.9 1738.6 2012.2 2034.9 2043.9 2050.8 817.7 853.4 854.2 856.0 884.6 21453.7 21742.9 22747.8 22767.4 22822.0 767.7 894.4 902.6 922.5 932.1 11352.1 11575.4 11615.4 11655.8 11721.9 764148.0 773707.0 778223.0 788447.0 796889.0 161186.0 163124.0 165181.2 166040.5 168428.0 318.0 458.8 461.7 464.5 465.0 10035.1 10506.4 11112.0 11415.4 11515.8 61100.0 61967.7 61991.7 63327.7 64093.7 73126.0 93268.5 95460.6 96024.0 98596.5 5897.6 6264.3 8258.8 8443.4 8975.4 12621.1 13215.7 13465.2 13509.2 13709.4 11010.0 11289.0 11368.8 11410.8 11530.8 11555.5 11567.5 11698.0 11875.2 12036.2 11604.1 11689.1 11876.5 11925.3 12061.2 8401.6 8521.2 8723.5 8991.5 9001.1 9945.0 11266.1 11582.7 11635.8 11811.8 08:50:36 INFO - PROCESS | 1911 | 08:50:36 INFO - PROCESS | 1911 | [#3] mootools.html Cycles:180 Average:5398.72 Median:5261.50 stddev:2907.62 (55.3%) stddev-sans-first:2900.02 08:50:36 INFO - PROCESS | 1911 | Values: 1371.3 1426.4 1438.2 1446.2 1459.2 7510.0 8018.0 8424.1 8431.3 8446.0 7629.8 7761.8 7978.5 8187.9 8192.7 2281.8 2332.9 2334.9 2339.7 2342.7 2088.8 2315.7 2367.6 2383.6 2384.7 1800.2 2145.6 2254.5 2325.3 2333.6 2288.8 2298.8 2300.8 2301.3 2304.7 2263.3 2344.8 2346.4 2353.0 2354.5 8286.3 8377.9 8380.1 8398.2 8401.9 5065.2 5225.3 5229.5 5234.4 5243.8 3291.5 3354.3 3475.2 3546.1 3564.4 1202.6 1209.9 1242.1 1250.9 1272.5 8933.8 10795.2 10819.1 10822.0 10837.6 4425.8 4643.2 4714.7 4724.7 4726.0 9488.6 9507.5 9513.9 9521.8 9549.1 5234.2 5258.4 5259.8 5263.2 5266.9 4716.4 4719.8 4766.1 4836.7 4846.6 3787.8 3807.5 3845.6 3889.9 3891.6 1265.4 1267.4 1270.9 1286.9 1288.6 603.7 740.7 754.6 757.4 781.3 5403.2 5433.7 5550.1 5563.5 5636.2 896.9 951.8 979.9 981.1 1021.2 3725.1 3740.1 3766.1 3817.3 3853.5 9736.2 9846.9 9902.6 10114.1 10154.3 9712.7 9731.7 9906.8 9980.3 10008.1 7619.1 7732.7 7738.2 7751.0 7774.7 5309.3 5494.2 5539.5 5675.1 5750.6 8752.5 8821.2 8874.0 9104.3 9139.5 8172.6 8736.1 8855.5 9150.9 9277.8 7081.9 7183.7 7207.5 7279.2 7283.3 7773.4 7808.0 7810.8 7889.9 7896.5 6986.4 7064.2 7081.1 7132.2 7235.0 6946.1 6969.8 6977.4 6984.6 7019.9 6266.6 6307.4 6363.3 6376.0 6473.4 4950.7 4971.9 4992.2 5023.3 5047.2 4921.9 4928.3 4954.7 5114.5 5192.8 08:50:36 INFO - PROCESS | 1911 | 08:50:36 INFO - PROCESS | 1911 | [#4] prototype.html Cycles:180 Average:4409.25 Median:4812.87 stddev:1304.69 (27.1%) stddev-sans-first:1271.38 08:50:36 INFO - PROCESS | 1911 | Values: 300.5 358.7 368.8 376.9 383.0 4686.9 5175.6 5284.8 5310.8 5314.9 4593.8 4708.0 5105.4 5108.3 5247.2 2877.0 4076.9 4174.3 4198.9 4202.6 3403.0 3753.3 4089.3 4152.9 4155.8 3324.8 3387.8 3799.6 4071.1 4103.6 3696.6 3834.7 3888.5 4036.6 4138.5 3221.8 3257.0 3641.6 3667.7 3691.0 4178.3 5050.5 5090.6 5091.4 5121.7 4590.4 4754.7 4758.7 4793.3 4809.3 4514.5 4750.4 5023.5 5507.3 5564.7 4041.7 4050.8 4056.9 4079.6 4134.7 5235.6 5435.4 5855.4 5861.6 5878.4 3984.0 4055.4 4065.6 4101.2 4118.5 3591.6 4198.3 4200.0 4211.4 4235.5 4009.5 4078.8 4532.6 4803.9 4818.5 4640.6 5273.3 5523.2 5541.6 5559.8 1243.9 1275.9 1343.2 1383.9 1384.8 827.0 844.7 907.7 959.4 975.1 4135.0 4752.9 4783.2 4818.4 4990.5 5397.5 5454.5 5472.0 5473.3 5481.6 4516.4 4801.4 5092.4 5095.4 5146.1 2696.9 2724.2 2806.7 2836.8 2846.6 5032.8 5351.7 5620.3 5627.6 5640.4 4711.4 5350.7 5453.5 5561.6 5563.9 4660.9 4816.5 4893.9 5295.5 5532.8 4730.9 5036.5 5050.8 5193.2 5407.7 4628.9 4691.0 4757.5 5280.6 5393.8 4945.6 5387.6 5628.3 5886.5 5922.9 3507.3 3644.2 3789.9 3839.8 3870.7 5120.9 5636.4 5644.1 5714.7 5725.8 4476.9 4789.3 5404.3 5455.4 5474.8 4237.9 4624.6 5482.1 5495.1 5536.9 5159.0 5361.9 5396.3 5396.9 5423.5 5149.3 5450.0 5467.6 5493.3 5504.3 4875.9 5174.7 5247.2 5273.5 5357.4 08:50:36 INFO - PROCESS | 1911 | 08:50:36 INFO - PROCESS | 1911 | [#5] yui.html Cycles:180 Average:20508.85 Median:4321.47 stddev:29571.96 (684.3%) stddev-sans-first:29617.37 08:50:36 INFO - PROCESS | 1911 | Values: 664.7 681.2 686.2 708.4 804.6 14480.6 15418.7 15455.0 15465.9 15483.5 14106.3 14216.4 14249.5 14262.4 14378.4 596.0 615.5 760.8 773.0 776.2 607.8 747.9 769.5 772.2 772.8 823.9 829.8 833.3 833.3 835.6 822.3 822.5 823.3 825.1 826.0 472.0 477.0 593.4 614.7 615.2 14619.7 15129.0 15149.0 15159.6 15177.2 13639.6 13812.7 13836.4 13840.9 13851.7 12106.9 12209.6 12249.5 12363.4 12589.9 4303.9 4353.7 4354.4 4385.7 4394.8 105963.9 111389.9 111663.0 111722.4 114165.0 9147.4 9723.2 10070.1 10509.3 10668.8 21403.4 21486.0 21493.4 21722.9 21744.1 7398.3 7421.0 7422.2 7501.1 7672.4 4093.1 4113.1 4202.8 4207.4 4339.0 3454.4 3539.5 3550.6 3565.0 3741.5 702.9 707.1 713.0 724.6 727.5 653.7 660.2 674.9 675.3 709.8 9397.7 10168.2 10375.3 10435.4 10494.3 651.8 651.9 698.7 703.8 706.2 4576.6 4748.3 4910.7 4913.3 4920.5 87688.1 90002.5 90917.5 106764.9 111970.4 83577.0 87106.0 87135.0 88434.1 89289.0 77011.6 79068.0 81479.0 82268.2 83095.6 9924.8 10071.1 10533.6 10724.9 10791.9 51028.7 52617.2 53127.5 53540.7 54149.9 65638.7 67335.0 67353.3 68768.7 70230.0 12378.4 12786.7 12794.2 12816.3 13028.7 13200.1 13850.0 14319.6 14508.1 14798.4 12273.6 12546.0 13424.0 13445.3 13573.5 12632.2 13220.2 13484.9 13939.3 14027.4 12500.3 13241.5 13254.9 13592.5 13725.6 9192.4 10361.0 10590.7 10914.9 11596.2 9934.9 10598.6 10677.6 10731.2 10765.8 08:50:36 INFO - PROCESS | 1911 | -------- Summary: end -------- 08:50:36 INFO - PROCESS | 1911 | 08:50:37 INFO - TEST-INFO | 1911: exit 0 08:50:37 INFO - TEST-OK | dromaeo_css | took 1119768ms 08:50:37 INFO - TEST-START | kraken 08:50:37 INFO - operating with platform_type : mac_ 08:50:37 INFO - Initialising browser for kraken test... 08:50:37 INFO - TEST-INFO | started process 1914 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmp7mQoaI/profile http://localhost:49716/getInfo.html) 08:50:39 INFO - PROCESS | 1914 | __metrics Screen width/height:1600/1200 08:50:39 INFO - PROCESS | 1914 | colorDepth:24 08:50:39 INFO - PROCESS | 1914 | Browser inner width/height: 1024/689 08:50:39 INFO - PROCESS | 1914 | __metrics 08:50:39 INFO - PROCESS | 1914 | 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" 08:50:39 INFO - PROCESS | 1914 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:50:40 INFO - TEST-INFO | 1914: exit 0 08:50:40 INFO - Browser initialized. 08:50:40 INFO - Running cycle 1/1 for kraken test... 08:50:40 INFO - TEST-INFO | started process 1915 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmp7mQoaI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:50:52 INFO - PROCESS | 1915 | RSS: Main: 213041152 08:50:52 INFO - PROCESS | 1915 | 08:50:55 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49716/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49716/tests/kraken/driver.html?testName=audio-beat-detection) 08:50:56 INFO - PROCESS | 1915 | RSS: Main: 266207232 08:50:56 INFO - PROCESS | 1915 | 08:50:58 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49716/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49716/tests/kraken/driver.html?testName=audio-dft) 08:50:59 INFO - PROCESS | 1915 | RSS: Main: 275705856 08:50:59 INFO - PROCESS | 1915 | 08:51:02 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49716/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49716/tests/kraken/driver.html?testName=audio-fft) 08:51:03 INFO - PROCESS | 1915 | RSS: Main: 372199424 08:51:03 INFO - PROCESS | 1915 | 08:51:04 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49716/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49716/tests/kraken/driver.html?testName=audio-oscillator) 08:51:05 INFO - PROCESS | 1915 | RSS: Main: 276017152 08:51:05 INFO - PROCESS | 1915 | 08:51:07 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49716/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49716/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:51:08 INFO - PROCESS | 1915 | RSS: Main: 277368832 08:51:08 INFO - PROCESS | 1915 | 08:51:11 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49716/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49716/tests/kraken/driver.html?testName=imaging-darkroom) 08:51:11 INFO - PROCESS | 1915 | RSS: Main: 318099456 08:51:11 INFO - PROCESS | 1915 | 08:51:14 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49716/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49716/tests/kraken/driver.html?testName=imaging-desaturate) 08:51:15 INFO - PROCESS | 1915 | RSS: Main: 319102976 08:51:15 INFO - PROCESS | 1915 | 08:51:18 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49716/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49716/tests/kraken/driver.html?testName=json-parse-financial) 08:51:18 INFO - PROCESS | 1915 | RSS: Main: 315514880 08:51:18 INFO - PROCESS | 1915 | 08:51:20 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49716/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49716/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:51:20 INFO - PROCESS | 1915 | RSS: Main: 295034880 08:51:20 INFO - PROCESS | 1915 | 08:51:22 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49716/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49716/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:51:23 INFO - PROCESS | 1915 | RSS: Main: 298340352 08:51:23 INFO - PROCESS | 1915 | 08:51:25 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49716/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49716/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:51:26 INFO - PROCESS | 1915 | RSS: Main: 300736512 08:51:26 INFO - PROCESS | 1915 | 08:51:29 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49716/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49716/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:51:30 INFO - PROCESS | 1915 | RSS: Main: 318836736 08:51:30 INFO - PROCESS | 1915 | 08:51:33 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49716/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49716/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:51:33 INFO - PROCESS | 1915 | RSS: Main: 311898112 08:51:33 INFO - PROCESS | 1915 | 08:51:35 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49716/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49716/tests/kraken/driver.html?testName=ai-astar) 08:51:35 INFO - PROCESS | 1915 | RSS: Main: 356401152 08:51:35 INFO - PROCESS | 1915 | 08:51:35 INFO - PROCESS | 1915 | __start_tp_report 08:51:35 INFO - PROCESS | 1915 | _x_x_mozilla_page_load 08:51:35 INFO - PROCESS | 1915 | _x_x_mozilla_page_load_details 08:51:35 INFO - PROCESS | 1915 | |i|pagename|runs| 08:51:35 INFO - PROCESS | 1915 | |0;ai-astar;117;116;116;115;115;116;115;114;115;115 08:51:35 INFO - PROCESS | 1915 | |1;audio-beat-detection;142;110;111;144;109;112;93;125;157;137 08:51:35 INFO - PROCESS | 1915 | |2;audio-dft;186;182;185;185;184;185;184;184;186;184 08:51:35 INFO - PROCESS | 1915 | |3;audio-fft;84;58;59;91;59;58;57;58;73;58 08:51:35 INFO - PROCESS | 1915 | |4;audio-oscillator;86;71;114;101;99;69;83;66;65;83 08:51:35 INFO - PROCESS | 1915 | |5;imaging-gaussian-blur;87;84;88;86;87;83;89;82;87;84 08:51:35 INFO - PROCESS | 1915 | |6;imaging-darkroom;94;94;95;95;94;103;94;94;94;93 08:51:35 INFO - PROCESS | 1915 | |7;imaging-desaturate;85;85;86;88;87;87;86;86;99;133 08:51:35 INFO - PROCESS | 1915 | |8;json-parse-financial;56;51;54;53;55;56;57;56;56;56 08:51:35 INFO - PROCESS | 1915 | |9;json-stringify-tinderbox;65;71;70;74;71;68;67;69;69;71 08:51:35 INFO - PROCESS | 1915 | |10;stanford-crypto-aes;85;84;86;83;82;85;104;101;103;101 08:51:35 INFO - PROCESS | 1915 | |11;stanford-crypto-ccm;139;137;140;160;146;143;136;143;202;154 08:51:35 INFO - PROCESS | 1915 | |12;stanford-crypto-pbkdf2;168;173;228;227;187;167;168;167;166;169 08:51:35 INFO - PROCESS | 1915 | |13;stanford-crypto-sha256-iterative;67;66;65;66;65;65;65;66;65;64 08:51:35 INFO - PROCESS | 1915 | __end_tp_report 08:51:35 INFO - PROCESS | 1915 | __start_cc_report 08:51:35 INFO - PROCESS | 1915 | _x_x_mozilla_cycle_collect,2046 08:51:35 INFO - PROCESS | 1915 | __end_cc_report 08:51:35 INFO - PROCESS | 1915 | __startTimestamp1487782295809__endTimestamp 08:51:35 INFO - PROCESS | 1915 | 08:51:35 INFO - PROCESS | 1915 | ------- Summary: start ------- 08:51:35 INFO - PROCESS | 1915 | Number of tests: 14 08:51:35 INFO - PROCESS | 1915 | 08:51:35 INFO - PROCESS | 1915 | [#0] ai-astar Cycles:10 Average:115.40 Median:115.50 stddev:0.84 (0.7%) stddev-sans-first:0.67 08:51:35 INFO - PROCESS | 1915 | Values: 117.0 116.0 116.0 115.0 115.0 116.0 115.0 114.0 115.0 115.0 08:51:35 INFO - PROCESS | 1915 | 08:51:35 INFO - PROCESS | 1915 | [#1] audio-beat-detection Cycles:10 Average:124.00 Median:139.50 stddev:20.22 (14.5%) stddev-sans-first:20.37 08:51:35 INFO - PROCESS | 1915 | Values: 142.0 110.0 111.0 144.0 109.0 112.0 93.0 125.0 157.0 137.0 08:51:35 INFO - PROCESS | 1915 | 08:51:35 INFO - PROCESS | 1915 | [#2] audio-dft Cycles:10 Average:184.50 Median:185.00 stddev:1.18 (0.6%) stddev-sans-first:1.12 08:51:35 INFO - PROCESS | 1915 | Values: 186.0 182.0 185.0 185.0 184.0 185.0 184.0 184.0 186.0 184.0 08:51:35 INFO - PROCESS | 1915 | 08:51:35 INFO - PROCESS | 1915 | [#3] audio-fft Cycles:10 Average:65.50 Median:59.00 stddev:12.61 (21.4%) stddev-sans-first:11.46 08:51:35 INFO - PROCESS | 1915 | Values: 84.0 58.0 59.0 91.0 59.0 58.0 57.0 58.0 73.0 58.0 08:51:35 INFO - PROCESS | 1915 | 08:51:35 INFO - PROCESS | 1915 | [#4] audio-oscillator Cycles:10 Average:83.70 Median:77.00 stddev:16.66 (21.6%) stddev-sans-first:17.65 08:51:35 INFO - PROCESS | 1915 | Values: 86.0 71.0 114.0 101.0 99.0 69.0 83.0 66.0 65.0 83.0 08:51:35 INFO - PROCESS | 1915 | 08:51:35 INFO - PROCESS | 1915 | [#5] imaging-gaussian-blur Cycles:10 Average:85.70 Median:87.00 stddev:2.31 (2.7%) stddev-sans-first:2.40 08:51:35 INFO - PROCESS | 1915 | Values: 87.0 84.0 88.0 86.0 87.0 83.0 89.0 82.0 87.0 84.0 08:51:35 INFO - PROCESS | 1915 | 08:51:35 INFO - PROCESS | 1915 | [#6] imaging-darkroom Cycles:10 Average:95.00 Median:94.00 stddev:2.87 (3.1%) stddev-sans-first:3.02 08:51:35 INFO - PROCESS | 1915 | Values: 94.0 94.0 95.0 95.0 94.0 103.0 94.0 94.0 94.0 93.0 08:51:35 INFO - PROCESS | 1915 | 08:51:35 INFO - PROCESS | 1915 | [#7] imaging-desaturate Cycles:10 Average:92.20 Median:86.50 stddev:14.91 (17.2%) stddev-sans-first:15.59 08:51:35 INFO - PROCESS | 1915 | Values: 85.0 85.0 86.0 88.0 87.0 87.0 86.0 86.0 99.0 133.0 08:51:35 INFO - PROCESS | 1915 | 08:51:35 INFO - PROCESS | 1915 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:56.00 stddev:1.83 (3.3%) stddev-sans-first:1.90 08:51:35 INFO - PROCESS | 1915 | Values: 56.0 51.0 54.0 53.0 55.0 56.0 57.0 56.0 56.0 56.0 08:51:35 INFO - PROCESS | 1915 | 08:51:35 INFO - PROCESS | 1915 | [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:70.50 stddev:2.51 (3.6%) stddev-sans-first:2.06 08:51:35 INFO - PROCESS | 1915 | Values: 65.0 71.0 70.0 74.0 71.0 68.0 67.0 69.0 69.0 71.0 08:51:35 INFO - PROCESS | 1915 | 08:51:35 INFO - PROCESS | 1915 | [#10] stanford-crypto-aes Cycles:10 Average:91.40 Median:83.50 stddev:9.44 (11.3%) stddev-sans-first:9.73 08:51:35 INFO - PROCESS | 1915 | Values: 85.0 84.0 86.0 83.0 82.0 85.0 104.0 101.0 103.0 101.0 08:51:35 INFO - PROCESS | 1915 | 08:51:35 INFO - PROCESS | 1915 | [#11] stanford-crypto-ccm Cycles:10 Average:150.00 Median:144.50 stddev:19.78 (13.7%) stddev-sans-first:20.57 08:51:35 INFO - PROCESS | 1915 | Values: 139.0 137.0 140.0 160.0 146.0 143.0 136.0 143.0 202.0 154.0 08:51:35 INFO - PROCESS | 1915 | 08:51:35 INFO - PROCESS | 1915 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.00 Median:171.00 stddev:24.75 (14.5%) stddev-sans-first:25.73 08:51:35 INFO - PROCESS | 1915 | Values: 168.0 173.0 228.0 227.0 187.0 167.0 168.0 167.0 166.0 169.0 08:51:35 INFO - PROCESS | 1915 | 08:51:35 INFO - PROCESS | 1915 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.50 stddev:0.84 (1.3%) stddev-sans-first:0.67 08:51:35 INFO - PROCESS | 1915 | Values: 67.0 66.0 65.0 66.0 65.0 65.0 65.0 66.0 65.0 64.0 08:51:35 INFO - PROCESS | 1915 | -------- Summary: end -------- 08:51:35 INFO - PROCESS | 1915 | 08:51:36 INFO - TEST-INFO | 1915: exit 0 08:51:36 INFO - TEST-OK | kraken | took 59581ms 08:51:36 INFO - SUITE-END | took 1179s 08:51:36 INFO - Completed test suite (00:19:39) 08:51:36 INFO - javascript benchmark 08:51:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3311.8675252989865, 3322.4351860183765, 3334.6998770110686, 3338.0820274424536, 3376.3247350529887, 5727.513161381287, 5733.7993170239, 5747.281589801275, 5747.597668163225, 5769.076947688365, 5710.172025056364, 5789.855253618662, 5794.188813566104, 5817.389174136708, 5818.883622327551, 5221.608379371543, 5233.555147812441, 5278.894422111574, 5332.280142180814, 5338.225957236198, 5170.0, 5171.586273098162, 5183.326167598207, 5345.652532585389, 5349.759260833272, 5201.869953251161, 5242.606804489659, 5249.212618107295, 5274.57803375731, 5324.627276090675, 5273.31446911899, 5275.6043296752705, 5285.497877701612, 5302.151655735083, 5302.3637163540625, 5124.769385377667, 5161.200013997836, 5228.215767634847, 5262.368515778131, 5270.051390749663, 5601.103823388279, 5633.985882541141, 5697.230873832021, 5732.77068917247, 5733.598648094635, 6217.56477046607, 6238.719257633417, 6305.0857625644485, 6317.210348706411, 6347.0, 6273.059041143865, 6313.273973493061, 6341.460975817061, 6355.0, 6368.904466433008, 5631.380548139701, 5755.568332375088, 5756.7121643917635, 5770.538356931435, 5867.090600956859, 6299.338569450233, 6321.146645202931, 6329.367063293634, 6332.113504109337, 6336.619802811846, 6188.4739797117745, 6192.8761424771255, 6215.627062376272, 6217.0, 6220.471259942865, 6165.075238714139, 6187.84530386735, 6206.627602343874, 6225.533085018642, 6296.0555916612875, 6191.040388739752, 6234.719437625317, 6255.718492667841, 6295.37046295376, 6297.055441683784, 5206.3752349717515, 5928.881422371528, 6304.905426418607, 6314.778982735582, 6319.905201421982, 4904.877378065506, 4941.777620007108, 4999.700017998932, 5009.0482808266315, 5014.247862820606, 4433.933490997638, 4441.244988351923, 4486.573775491323, 4489.6408287336935, 4498.415206023196, 5696.088625819849, 5746.02317606008, 5748.252727145445, 5773.220615216976, 5812.157237200582, 6153.507719382439, 6224.62652240867, 6235.750569977241, 6244.438000579969, 6308.621482711052, 5719.456651618089, 5729.054705973551, 5772.220750198753, 5778.479936805707, 5815.04051831443, 5357.223202635674, 5379.220013098157, 5423.972880135574, 5455.208994695826, 5521.834344969658, 6294.118823364733, 6353.428191462791, 6370.74517019314, 6389.9361006389345, 6403.263624683221, 5463.344398672185, 6261.749530018748, 6283.685815709105, 6312.810615681537, 6326.240851097898, 6224.439800417984, 6263.311035785969, 6317.30509643948, 6385.808425747235, 6386.776462823779, 6154.892119418548, 6242.750289988531, 6246.812595622138, 6251.812445626639, 6262.968685156728, 6267.9373206267355, 6278.0896769967185, 6288.434040936338, 6295.464885484785, 6312.621242725451, 6019.578629495893, 6036.215292012011, 6112.0, 6181.690915454119, 6187.597806142587, 6116.5106791457465, 6120.816375508742, 6121.940772763084, 6165.075238714228, 6180.351063138306, 4938.678985865908, 5997.640141591519, 6008.849778755566, 6010.639361638316, 6033.0045542484995, 5948.4943779779205, 6166.1983942087245, 6178.474829639531, 6182.0, 6183.721732521957, 5872.0898260769645, 5925.555583331354, 5949.52403807703, 5961.37405572426, 6026.0], "value": 5724.849533169781, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [432.8831215571795, 446.80117347780254, 486.79311292700595, 512.369785164248, 534.3080710479929, 31400.842995785017, 32924.341513169726, 32929.83535082324, 41981.37027944583, 42865.78567107168, 44429.555704442944, 45014.77492612541, 45148.54851451484, 45317.77341113298, 45318.546814531845, 9244.02937691541, 9477.289203309745, 9478.526073696323, 9479.526023698787, 9492.762680932998, 8350.164983501632, 8568.871466928002, 9164.083591640849, 9321.114494123081, 11141.498632561514, 10901.073408760265, 11118.277311974736, 11134.888651113506, 11168.944155279212, 11174.0, 11301.717457063598, 11340.20618556693, 11379.089672826154, 11387.20289579734, 11412.54349826006, 8340.541270230135, 8543.14568543147, 11066.557337706483, 11287.604933827359, 11386.032187264009, 39783.0, 41873.95315117116, 42230.155396892194, 42286.36570451446, 42339.57660423387, 3928.332183528807, 3930.921381572381, 3934.350832112698, 3973.6225058619384, 4078.6737061035046, 29761.404771904658, 31089.0, 31808.840955795305, 31893.681063189302, 32327.35345293081, 3138.2154461384653, 3173.1115287719476, 3183.5861338025907, 3191.763446827076, 3218.09893229896, 435577.99999999686, 435852.0, 436854.0, 437275.0, 437751.0, 67715.0, 67886.66056669685, 68000.97998530026, 68040.31959680439, 68238.0, 70264.0, 70264.64867675629, 70301.0, 70365.64817175984, 70429.64785176041, 16375.508734737978, 17016.65966680684, 17041.573960651083, 17041.7443738344, 17054.14729263532, 12735.426905789262, 13044.086913916124, 13100.803487947689, 13194.274314912773, 13216.207027578375, 16470.258838352303, 16720.0, 16728.24722887473, 17144.485665430057, 17148.571285717706, 6605.339466053356, 6964.4428445724225, 7003.299670032956, 7104.68028938699, 7132.286771322826, 849.9745007649781, 858.3390789092489, 861.9827603447895, 887.1040249348205, 907.6278725722422, 29947.70052299449, 30024.399512009637, 30138.24654383614, 30519.0, 30654.54018189729, 1054.2567489919588, 1056.4348073780643, 1067.6209945469247, 1099.384344766933, 1160.8374827524153, 14059.578212653636, 14540.927295363666, 15681.13753743555, 15945.282462289224, 15965.44120955761, 474107.0, 562428.0, 566472.0, 568571.0, 568978.0, 63308.683456582425, 63479.0, 63539.6823015882, 63678.68160659167, 63681.0, 1234.4198226833373, 1429.7354989327007, 1445.1762495377955, 1448.73922693914, 1453.1499073042178, 28508.85745571259, 29337.413251735274, 29379.706202937698, 29892.0, 29990.100296991124, 53320.2001969963, 53580.1962970548, 53589.732051339495, 53675.46324536705, 53692.0, 472588.0, 475853.0, 476142.0, 476497.6175119102, 476501.0, 26897.462050758484, 27153.72846271591, 27383.04159354413, 27403.45193096087, 27430.0, 48569.0, 50164.749176253885, 50215.497845022546, 50401.99196015986, 50458.990820184124, 33857.15357116092, 39384.01539961524, 39444.01389965274, 40654.79672601736, 41307.58692413037, 39471.0, 39913.401298981116, 40598.985025374604, 40957.590424095375, 41503.0, 38466.615333846305, 38606.6139338603, 39237.60762392454, 39318.41022384724, 39560.802195988836, 32156.51765223477, 34209.96258674548, 34455.483167752005, 34791.0, 35287.64712352843, 22072.44818879541, 24741.752582473946, 25258.747412526376, 25298.988040478176, 25430.237092887244], "value": 20149.17865016029, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.81251405469965, 361.3008827917979, 372.43761919501577, 383.2870860200029, 402.63963752441566, 14947.327370268336, 15673.843261567396, 16117.194140292968, 20528.178872845067, 21167.788322116776, 20766.584668306627, 21186.89406552969, 21768.0, 21820.0, 21983.560328793414, 5788.913166302509, 5825.941740582603, 5977.073553599199, 6046.7883624073165, 6050.485708714765, 5756.769729210827, 5884.029135192688, 5915.88168236635, 5974.312954010279, 5985.132155837401, 4169.812358443877, 4303.922202923359, 4406.272964960777, 4412.75729834859, 5942.376050514698, 6603.504737144734, 6604.207495100571, 6605.174353205849, 6612.570182938093, 6705.362990515893, 5089.236614507817, 5320.600954928357, 5388.191771234307, 5422.8915421691345, 5810.157527158581, 13419.463221471227, 13489.460421583124, 13523.526676566273, 13644.90840732739, 13679.110857794212, 2697.743714347134, 2711.5932610108443, 2811.5360965440677, 2854.757345625624, 2909.6799352071257, 9171.85351831021, 9526.809463810754, 9982.251331150193, 10125.594976200942, 10491.947540262327, 1702.838230368113, 1742.5469377961822, 1758.6746451906438, 1760.0407777761152, 1764.5235786337616, 105825.47087264592, 127407.3629631846, 129492.705072949, 131848.0, 134369.3281533586, 10109.443980581138, 10621.575136994434, 10648.627298044687, 10777.676669699922, 11910.940445297718, 12887.677808054874, 12916.806247906288, 12942.288174150512, 12947.093703440669, 12947.482100715866, 8180.345572354197, 8249.711260105867, 8261.215184557457, 8475.618597163018, 8508.957455212685, 8567.629179331278, 8753.29973602123, 8775.956120219358, 8926.152015558511, 8953.194212520904, 3589.94615080774, 4118.464599602033, 4127.5666055064385, 4137.8965525861495, 4212.91574168521, 1738.6435780664933, 2012.2454079720105, 2034.8982550872397, 2043.9182432702526, 2050.8359331253464, 817.7138001699358, 853.389826274217, 854.2226573817796, 855.9914400855912, 884.6461415433878, 21453.67819482709, 21742.891285543472, 22747.772522274896, 22767.430814229778, 22822.0, 767.731294047079, 894.4409743910056, 902.5848109869403, 922.4741897118712, 932.067932067932, 11352.091832653368, 11575.42122893852, 11615.361155136548, 11655.76688466226, 11721.941390292994, 764148.0, 773707.0, 778223.0, 788447.0, 796889.0, 161186.0, 163124.0, 165181.17409412877, 166040.5093923592, 168428.0, 317.99682003180135, 458.76373667561234, 461.6699060171926, 464.49602181632633, 464.9628029757611, 10035.147012503727, 10506.369617822955, 11112.0, 11415.37215453125, 11515.8272625909, 61100.0, 61967.690161548904, 61991.690041549504, 63327.683361582895, 64093.67953160204, 73126.0, 93268.53365733128, 95460.61348466344, 96024.0, 98596.50701746445, 5897.557683173865, 6264.342244064308, 8258.834823303621, 8443.36674749384, 8975.416597921114, 12621.053420993645, 13215.66960825987, 13465.192088474723, 13509.189448633113, 13709.383077761326, 11010.009099181112, 11289.0, 11368.829467557827, 11410.771784564096, 11530.82703759461, 11555.537778488766, 11567.479463424335, 11698.005669518187, 11875.228110172811, 12036.217645852992, 11604.071674266208, 11689.123315751523, 11876.524939002344, 11925.30315602166, 12061.216020958609, 8401.621927013177, 8521.190486903733, 8723.476591404537, 8991.505467199368, 9001.054889236797, 9945.0, 11266.098712102848, 11582.71043223926, 11635.825462618237, 11811.763764724485], "value": 9242.505163410113, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1371.259519859276, 1426.3866537388926, 1438.1802372647594, 1446.1973604649418, 1459.233902201344, 7510.0, 8018.037835459746, 8424.115467875878, 8431.325493960483, 8446.028706698738, 7629.771106866789, 7761.844763104735, 7978.48139870908, 8187.91812081879, 8192.713255036075, 2281.8174546036275, 2332.88335583221, 2334.8949297281665, 2339.6841426407473, 2342.7422983471806, 2088.812006919377, 2315.6526521021897, 2367.633016882386, 2383.559041577305, 2384.666146739458, 1800.162924240228, 2145.570885822842, 2254.549090181962, 2325.3489023073566, 2333.6032874411308, 2288.771122887706, 2298.839081264312, 2300.804431623314, 2301.2635956493928, 2304.7119110111234, 2263.2531264682616, 2344.788968992782, 2346.389938615955, 2353.0352555452355, 2354.482013956927, 8286.337093032604, 8377.916220837775, 8380.120087390858, 8398.160183981614, 8401.873971890427, 5065.240213967897, 5225.294585230983, 5229.529342359206, 5234.398044224887, 5243.842684719464, 3291.522729204252, 3354.3123659649714, 3475.2354482013916, 3546.131197856516, 3564.4296912494137, 1202.6271855724754, 1209.9334536600484, 1242.0994778785398, 1250.868658790823, 1272.5228039485194, 8933.776655583597, 10795.2443328967, 10819.080378167866, 10822.0, 10837.566497340096, 4425.845095421645, 4643.187442197602, 4714.717116972924, 4724.692894961817, 4725.976370118196, 9488.573014214377, 9507.477088760046, 9513.904860951441, 9521.761955951157, 9549.140577348073, 5234.162533994542, 5258.447862974333, 5259.8422047338645, 5263.157894736823, 5266.868328291746, 4716.3868697069165, 4719.787609557578, 4766.142094423037, 4836.733979631154, 4846.636502262344, 3787.8484860605818, 3807.4669546263544, 3845.6346647068485, 3889.922201555953, 3891.552471465761, 1265.3862876505073, 1267.4423253768311, 1270.898328133747, 1286.8777466140702, 1288.62629837348, 603.6860832367145, 740.6629983357559, 754.6038329876859, 757.4054367321736, 781.3124450483538, 5403.162509810985, 5433.728313584305, 5550.084236101079, 5563.471470210324, 5636.239107720406, 896.8609865470862, 951.7668171297938, 979.911807937289, 981.1022914033722, 1021.2391768132788, 3725.1245957200035, 3740.0649837540614, 3766.1456149807636, 3817.255635151119, 3853.460515527828, 9736.221102311798, 9846.852297215548, 9902.55438505269, 10114.089731924161, 10154.339967902062, 9712.70861874145, 9731.708048758548, 9906.752331191778, 9980.251481138943, 10008.09927106564, 7619.08570971487, 7732.6520306586335, 7738.2261773822165, 7751.0, 7774.6890124394395, 5309.283246761792, 5494.230807687007, 5539.473749993744, 5675.0636145035605, 5750.568707347049, 8752.51861147643, 8821.161989610977, 8873.955630221808, 9104.271658267455, 9139.497327646777, 8172.632231549475, 8736.08271131522, 8855.468671879707, 9150.862737058816, 9277.814443711222, 7081.858362832611, 7183.676734547063, 7207.459440541876, 7279.199288078201, 7283.308085731847, 7773.37812974972, 7807.960960195162, 7810.843783124419, 7889.881651775113, 7896.526208427513, 6986.441084713109, 7064.222935476991, 7081.114860642419, 7132.215456299907, 7235.023271858232, 6946.097007389007, 6969.825754356181, 6977.447485709446, 6984.615846128511, 7019.894701579378, 6266.624002559861, 6307.400796924285, 6363.268224154096, 6376.0, 6473.449756770728, 4950.727709975842, 4971.875703107306, 4992.176290911959, 5023.346964894687, 5047.217681259411, 4921.8523444296725, 4928.310036594808, 4954.727489988085, 5114.514121158484, 5192.844214673566], "value": 4389.064180847286, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.50566817585076, 358.6592736899945, 368.83586803872277, 376.85491085931943, 382.98659546915866, 4686.89857883398, 5175.611829112818, 5284.788608455667, 5310.8141215057485, 5314.946850531498, 4593.793279302431, 4707.952920470802, 5105.438401775811, 5108.335916330881, 5247.212918062292, 2877.0, 4076.9388459173138, 4174.269502837006, 4198.921533840753, 4202.592131635898, 3403.0471467988878, 3753.2681127180213, 4089.3457046872504, 4152.854650087247, 4155.812988415529, 3324.805628285332, 3387.779794313374, 3799.6390342917516, 4071.145059537501, 4103.569125241851, 3696.5748938872107, 3834.7153703509357, 3888.47505586745, 4036.6367026967714, 4138.516889866087, 3221.7583681224, 3256.9837150814333, 3641.617630148849, 3667.651573100551, 3690.9815450922843, 4178.2688029595, 5050.500002498787, 5090.592752579785, 5091.414487333967, 5121.7451724327775, 4590.380298659705, 4754.690945088558, 4758.666893317469, 4793.328933949215, 4809.278608208761, 4514.503404625489, 4750.4299484061785, 5023.497650234984, 5507.339119305669, 5564.721763911788, 4041.717079804415, 4050.8177132029127, 4056.8843568018738, 4079.5920407959266, 4134.689898257643, 5235.633505654606, 5435.42927992563, 5855.355910849803, 5861.618994765369, 5878.412158784087, 3983.9601603983588, 4055.3916912463364, 4065.6340929316502, 4101.2364683186515, 4118.464599602033, 3591.5510561179854, 4198.286291330481, 4200.033992181815, 4211.389348544444, 4235.53409124996, 4009.498812648419, 4078.7552746835286, 4532.5694059064335, 4803.879903002453, 4818.494058123917, 4640.6310138509225, 5273.288106105703, 5523.171524271392, 5541.639793413416, 5559.805406810742, 1243.9191452555556, 1275.8787915148046, 1343.1598709767682, 1383.9169649821042, 1384.764590019699, 826.9751907442786, 844.7001314533252, 907.668700924158, 959.3907868503551, 975.1175186456269, 4134.979325103355, 4752.904941901212, 4783.234682450791, 4818.4217893852265, 4990.451050384528, 5397.541208997279, 5454.509094181463, 5471.972640136853, 5473.303275984457, 5481.643693160012, 4516.3902873112365, 4801.399825021872, 5092.439831618519, 5095.414027386898, 5146.099432599281, 2696.8651567421552, 2724.1827451764393, 2806.719328067177, 2836.8297902125937, 2846.587244849485, 5032.84901452957, 5351.678899266057, 5620.297462817148, 5627.649364152574, 5640.392488140942, 4711.372243372584, 5350.652207606571, 5453.536449401845, 5561.555075594024, 5563.944360556343, 4660.930086048712, 4816.470188279286, 4893.874408885976, 5295.470452954673, 5532.834014979557, 4730.929036064531, 5036.524797889445, 5050.84847454577, 5193.221016847352, 5407.702576358338, 4628.861134165981, 4691.004080654093, 4757.476677565396, 5280.551153152025, 5393.815504720595, 4945.554900059012, 5387.5689944803535, 5628.324601047737, 5886.470217680258, 5922.881542369215, 3507.298540292003, 3644.1800594865945, 3789.886303410902, 3839.788811615388, 3870.748401353903, 5120.871978200575, 5636.3799982002765, 5644.096944488862, 5714.742836572281, 5725.828225153252, 4476.9328460072475, 4789.281607758864, 5404.297441332602, 5455.372632147195, 5474.7810087597645, 4237.894052648709, 4624.583787459145, 5482.053870875941, 5495.120780675073, 5536.861578460571, 5158.97420512895, 5361.919571206513, 5396.298481197577, 5396.946030539644, 5423.535645375648, 5149.279100925948, 5450.0, 5467.5625949923115, 5493.285872836505, 5504.284443022381, 4875.854174268973, 5174.689518628894, 5247.2129180623215, 5273.499017593323, 5357.392782165412], "value": 4013.412445218581, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.7075286873775, 681.2166009089547, 686.159454668032, 708.3624737736037, 804.6459557794572, 14480.637984050403, 15418.691626167498, 15455.0, 15465.92267038666, 15483.458078967238, 14106.294685265748, 14216.360263788129, 14249.501267455642, 14262.3581938813, 14378.424863005468, 595.9731812068445, 615.4829942848007, 760.8212070163521, 772.9912464234172, 776.192759530088, 607.7568972411027, 747.9289467500579, 769.5113602862167, 772.2007722007695, 772.8454309138167, 823.8970128733908, 829.7925518620345, 833.2667252817512, 833.3333333333339, 835.6406745099636, 822.268181318627, 822.457178262344, 823.3454403749034, 825.0759149752286, 825.9628316725732, 472.03233371588107, 477.0411472939382, 593.3888095261888, 614.7448808744366, 615.1633778061832, 14619.70760584793, 15129.0, 15149.0, 15159.62100947474, 15177.16525591092, 13639.590812275648, 13812.654683632889, 13836.446542138303, 13840.861591384159, 13851.722965540734, 12106.939465302705, 12209.572664956684, 12249.510019599205, 12363.443645035995, 12589.93705031469, 4303.935440968388, 4353.73877567347, 4354.433923589945, 4385.7149285296355, 4394.824207031715, 105963.94036059619, 111389.88610113958, 111663.0, 111722.44138779335, 114164.99999999917, 9147.359684822131, 9723.173530250007, 10070.144037756727, 10509.31689440184, 10668.786624267472, 21403.357899263046, 21486.0, 21493.355199344045, 21722.891385543287, 21744.130234790748, 7398.3341499265325, 7420.962895185489, 7422.181208386715, 7501.137369202612, 7672.386209103258, 4093.0995181060716, 4113.053997580513, 4202.810873510699, 4207.389928460356, 4339.0, 3454.378211921878, 3539.486774417695, 3550.609432962372, 3564.9821750891597, 3741.4761933329355, 702.8664553734774, 707.1372925031453, 712.9714811407486, 724.6123324021623, 727.4980263618193, 653.6764301670703, 660.2011566005187, 674.8785218660688, 675.270707635762, 709.8473828126978, 9397.709016210023, 10168.186545076524, 10375.27373083877, 10435.37387756737, 10494.317869338622, 651.7686221391433, 651.8761435327273, 698.7414656577099, 703.7958991892397, 706.2055187913597, 4576.588107070313, 4748.3114948332295, 4910.680805747615, 4913.263010548446, 4920.507949205123, 87688.12311876928, 90002.54998724964, 90917.54541227384, 106764.93235067706, 111970.44014780037, 83577.0, 87106.0, 87135.0, 88434.11565884388, 89289.0, 77011.61494192493, 79068.0, 81478.96302592482, 82268.17731822845, 83095.5845220782, 9924.751881203028, 10071.143952764098, 10533.578656853946, 10724.946375268073, 10791.946040269748, 51028.74485627548, 52617.210741838135, 53127.468725312254, 53540.73229633827, 54149.917001658956, 65638.67180664066, 67335.0, 67353.32646673471, 68768.65615671889, 70230.0, 12378.381080946097, 12786.68033299175, 12794.232346059267, 12816.295103769009, 13028.739425211254, 13200.14199077057, 13850.030497865455, 14319.57041288763, 14508.1295122293, 14798.408063677763, 12273.631791046282, 12546.0, 13424.0, 13445.327733613476, 13573.457061717421, 12632.2420654761, 13220.206787592391, 13484.86515134836, 13939.303034848419, 14027.368768405242, 12500.31248281317, 13241.470341186245, 13254.933725331312, 13592.524261650795, 13725.588232353046, 9192.448453092837, 10361.0, 10590.682279531626, 10914.945425272823, 11596.246243994114, 9934.850977235203, 10598.62610402359, 10677.626283080055, 10731.195160362848, 10765.784684306427], "value": 7377.701736910435, "unit": "score"}], "name": "dromaeo_css", "value": 7193.568014983466, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 115.0, 115.0, 116.0, 115.0, 114.0, 115.0, 115.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 110.0, 111.0, 144.0, 109.0, 112.0, 93.0, 125.0, 157.0, 137.0], "value": 124.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 182.0, 185.0, 185.0, 184.0, 185.0, 184.0, 184.0, 186.0, 184.0], "value": 184.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 58.0, 59.0, 91.0, 59.0, 58.0, 57.0, 58.0, 73.0, 58.0], "value": 65.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 114.0, 101.0, 99.0, 69.0, 83.0, 66.0, 65.0, 83.0], "value": 83.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 88.0, 86.0, 87.0, 83.0, 89.0, 82.0, 87.0, 84.0], "value": 85.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 94.0, 103.0, 94.0, 94.0, 94.0, 93.0], "value": 95.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 86.0, 88.0, 87.0, 87.0, 86.0, 86.0, 99.0, 133.0], "value": 92.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 51.0, 54.0, 53.0, 55.0, 56.0, 57.0, 56.0, 56.0, 56.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 71.0, 70.0, 74.0, 71.0, 68.0, 67.0, 69.0, 69.0, 71.0], "value": 69.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 86.0, 83.0, 82.0, 85.0, 104.0, 101.0, 103.0, 101.0], "value": 91.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 137.0, 140.0, 160.0, 146.0, 143.0, 136.0, 143.0, 202.0, 154.0], "value": 150.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 173.0, 228.0, 227.0, 187.0, 167.0, 168.0, 167.0, 166.0, 169.0], "value": 182.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 65.0, 66.0, 65.0, 65.0, 65.0, 66.0, 65.0, 64.0], "value": 65.4, "unit": "score"}], "name": "kraken", "value": 1459.3000000000002, "alertThreshold": 2.0}]} 08:51:37 INFO - Return code: 0 08:51:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:51:37 ERROR - # TBPL SUCCESS # 08:51:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:51:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:51:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:51:37 INFO - 2017-02-22 08:51:37.127 screenresolution[1919:13398] starting screenresolution argv=screenresolution get 08:51:37 INFO - 2017-02-22 08:51:37.130 screenresolution[1919:13398] Display 0: 1600x1200x32@60 08:51:37 INFO - 2017-02-22 08:51:37.136 screenresolution[1920:13401] starting screenresolution argv=screenresolution list 08:51:37 INFO - Available Modes on Display 0 08:51:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:51:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:51:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:51:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:51:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:51:37 INFO - Intel Iris: 08:51:37 INFO - Chipset Model: Intel Iris 08:51:37 INFO - Type: GPU 08:51:37 INFO - Bus: Built-In 08:51:37 INFO - VRAM (Dynamic, Max): 1536 MB 08:51:37 INFO - Vendor: Intel (0x8086) 08:51:37 INFO - Device ID: 0x0a2e 08:51:37 INFO - Revision ID: 0x0009 08:51:37 INFO - Displays: 08:51:37 INFO - Display: 08:51:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:51:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:51:37 INFO - Display Serial Number: 1600x1200 60 08:51:37 INFO - Main Display: Yes 08:51:37 INFO - Mirror: Off 08:51:37 INFO - Online: Yes 08:51:37 INFO - Rotation: Supported 08:51:37 INFO - Return code: 0 08:51:37 INFO - Running post-action listener: _resource_record_post_action 08:51:37 INFO - [mozharness: 2017-02-22 16:51:37.375432Z] Finished run-tests step (success) 08:51:37 INFO - Running post-run listener: _resource_record_post_run 08:51:37 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 229376; Write bytes: 507644928; Read time: 7; Write time: 1572 08:51:37 INFO - TinderboxPrint: CPU usage
53.7% 08:51:37 INFO - TinderboxPrint: I/O read bytes / time
229,376 / 7 08:51:37 INFO - TinderboxPrint: I/O write bytes / time
507,644,928 / 1,572 08:51:37 INFO - TinderboxPrint: CPU idle
2,225.4 (46.3%) 08:51:37 INFO - TinderboxPrint: CPU system
960.9 (20.0%) 08:51:37 INFO - TinderboxPrint: CPU user
1,615.4 (33.6%) 08:51:37 INFO - TinderboxPrint: Swap in / out
208,187,392 / 0 08:51:37 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 208777728; Write bytes: 211588608; Read time: 15972; Write time: 460 08:51:37 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 122880; Write bytes: 294528512; Read time: 5; Write time: 1103 08:51:37 INFO - Running post-run listener: _upload_blobber_files 08:51:37 INFO - Blob upload gear active. 08:51:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:51:37 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:51:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:51:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:51:38 INFO - (blobuploader) - INFO - Open directory for files ... 08:51:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:51:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:51:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:51:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:51:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:51:39 INFO - (blobuploader) - INFO - Done attempting. 08:51:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:51:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:51:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:51:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:51:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:51:40 INFO - (blobuploader) - INFO - Done attempting. 08:51:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:51:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:51:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:51:41 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:51:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:51:41 INFO - (blobuploader) - INFO - Done attempting. 08:51:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:51:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:51:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:51:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:51:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:51:43 INFO - (blobuploader) - INFO - Done attempting. 08:51:43 INFO - (blobuploader) - INFO - Iteration through files over. 08:51:43 INFO - Return code: 0 08:51:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:51:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:51:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd2703704c1bbe239e5704b3523229c744e178e1fb59bd4434648c2cd1e296301e0b68bd872bd848bb9f41011c1d360aff3972e37afdeafface6cca11926600c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd08ab8dbaf143d13042c9d269bc45b98c5df7fc0010a08047dd23e616a368f7826c3bfdf0fdb81e61883ab672d9a349f059802d5cf1be78a72b2c03472301cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40903905df249cc23809b7e55f7918b39efc89bdd71953ebe458eb1f5f5d07d22b4c329ee89effb2178ecb138b78c8e21233bcd182dbb697d92d8732e5e1c40c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6bab24cffe2d1a026e982d17845b7b7e27b10a99eacd1661f7b6b94067b9416a838b0384dac062af6d9dd0236f6ab28f39b3bfbd3325e8086daefd6399e47f9c"} 08:51:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:51:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:51:43 INFO - Contents: 08:51:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd2703704c1bbe239e5704b3523229c744e178e1fb59bd4434648c2cd1e296301e0b68bd872bd848bb9f41011c1d360aff3972e37afdeafface6cca11926600c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd08ab8dbaf143d13042c9d269bc45b98c5df7fc0010a08047dd23e616a368f7826c3bfdf0fdb81e61883ab672d9a349f059802d5cf1be78a72b2c03472301cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40903905df249cc23809b7e55f7918b39efc89bdd71953ebe458eb1f5f5d07d22b4c329ee89effb2178ecb138b78c8e21233bcd182dbb697d92d8732e5e1c40c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6bab24cffe2d1a026e982d17845b7b7e27b10a99eacd1661f7b6b94067b9416a838b0384dac062af6d9dd0236f6ab28f39b3bfbd3325e8086daefd6399e47f9c"} 08:51:43 INFO - Running post-run listener: copy_logs_to_upload_dir 08:51:43 INFO - Copying logs to upload dir... 08:51:43 INFO - mkdir: /builds/slave/test/build/upload/logs 08:51:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.691436 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-22 08:51:43.428110) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-22 08:51:43.431746) ========= 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.D7lYMX0696/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.WFqtHEKQh8/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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/Mozilla-Aurora/sha512/fd2703704c1bbe239e5704b3523229c744e178e1fb59bd4434648c2cd1e296301e0b68bd872bd848bb9f41011c1d360aff3972e37afdeafface6cca11926600c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd08ab8dbaf143d13042c9d269bc45b98c5df7fc0010a08047dd23e616a368f7826c3bfdf0fdb81e61883ab672d9a349f059802d5cf1be78a72b2c03472301cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40903905df249cc23809b7e55f7918b39efc89bdd71953ebe458eb1f5f5d07d22b4c329ee89effb2178ecb138b78c8e21233bcd182dbb697d92d8732e5e1c40c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6bab24cffe2d1a026e982d17845b7b7e27b10a99eacd1661f7b6b94067b9416a838b0384dac062af6d9dd0236f6ab28f39b3bfbd3325e8086daefd6399e47f9c"} build_url:https://queue.taskcluster.net/v1/task/JpncKKHIRXebxr00ViT1-g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011226 build_url: 'https://queue.taskcluster.net/v1/task/JpncKKHIRXebxr00ViT1-g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd2703704c1bbe239e5704b3523229c744e178e1fb59bd4434648c2cd1e296301e0b68bd872bd848bb9f41011c1d360aff3972e37afdeafface6cca11926600c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd08ab8dbaf143d13042c9d269bc45b98c5df7fc0010a08047dd23e616a368f7826c3bfdf0fdb81e61883ab672d9a349f059802d5cf1be78a72b2c03472301cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40903905df249cc23809b7e55f7918b39efc89bdd71953ebe458eb1f5f5d07d22b4c329ee89effb2178ecb138b78c8e21233bcd182dbb697d92d8732e5e1c40c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6bab24cffe2d1a026e982d17845b7b7e27b10a99eacd1661f7b6b94067b9416a838b0384dac062af6d9dd0236f6ab28f39b3bfbd3325e8086daefd6399e47f9c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-22 08:51:43.464296) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 08:51:43.464641) ========= 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.D7lYMX0696/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.WFqtHEKQh8/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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.005228 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 08:51:43.517827) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-22 08:51:43.518897) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-22 08:51:43.519962) ========= ========= Total master_lag: 1.77 =========