builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0210 starttime: 1473824834.46 results: success (0) buildid: 20160913174207 builduid: 94e8eeee052c4df98b939bc815863bbd revision: c6edbdd09f304b3c092cc58ee16e7d1901837434 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-13 20:47:14.464883) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-13 20:47:14.465379) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-13 20:47:14.465660) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-13 20:47:14.545505) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 20:47:14.545896) ========= 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.UeUPak7Ku0/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.r2Ghu0AYnV/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-13 20:47:14-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.7M=0.001s 2016-09-13 20:47:14 (13.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.146624 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 20:47:14.718921) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 20:47:14.719582) ========= 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.UeUPak7Ku0/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.r2Ghu0AYnV/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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.020676 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 20:47:14.770406) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-13 20:47:14.770881) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev c6edbdd09f304b3c092cc58ee16e7d1901837434 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev c6edbdd09f304b3c092cc58ee16e7d1901837434 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UeUPak7Ku0/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.r2Ghu0AYnV/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-13 20:47:14,854 truncating revision to first 12 chars 2016-09-13 20:47:14,854 Setting DEBUG logging. 2016-09-13 20:47:14,854 attempt 1/10 2016-09-13 20:47:14,854 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/c6edbdd09f30?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-13 20:47:16,457 unpacking tar archive at: autoland-c6edbdd09f30/testing/mozharness/ program finished with exit code 0 elapsedTime=1.869065 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-13 20:47:16.665698) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-13 20:47:16.666105) ========= script_repo_revision: c6edbdd09f304b3c092cc58ee16e7d1901837434 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-13 20:47:16.666542) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-13 20:47:16.666807) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-13 20:47:16.697180) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-09-13 20:47:16.697642) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UeUPak7Ku0/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.r2Ghu0AYnV/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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 20:47:16 INFO - MultiFileLogger online at 20160913 20:47:16 in /builds/slave/test 20:47:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 20:47:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:47:16 INFO - {'append_to_log': False, 20:47:16 INFO - 'base_work_dir': '/builds/slave/test', 20:47:16 INFO - 'blob_upload_branch': 'Autoland', 20:47:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:47:16 INFO - 'branch': 'Autoland', 20:47:16 INFO - 'buildbot_json_path': 'buildprops.json', 20:47:16 INFO - 'config_files': ('talos/mac_config.py',), 20:47:16 INFO - 'default_actions': ('clobber', 20:47:16 INFO - 'read-buildbot-config', 20:47:16 INFO - 'download-and-extract', 20:47:16 INFO - 'populate-webroot', 20:47:16 INFO - 'create-virtualenv', 20:47:16 INFO - 'install', 20:47:16 INFO - 'run-tests'), 20:47:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:47:16 INFO - 'download_minidump_stackwalk': True, 20:47:16 INFO - 'download_symbols': 'ondemand', 20:47:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:47:16 INFO - 'tooltool.py': '/tools/tooltool.py', 20:47:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:47:16 INFO - '/tools/misc-python/virtualenv.py')}, 20:47:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:47:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:47:16 INFO - 'installer_path': 'installer.exe', 20:47:16 INFO - 'log_level': 'info', 20:47:16 INFO - 'log_name': 'talos', 20:47:16 INFO - 'log_to_console': True, 20:47:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:47:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:47:16 INFO - 'opt_config_files': (), 20:47:16 INFO - 'pip_index': False, 20:47:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:47:16 INFO - 'cmd': ('bash', 20:47:16 INFO - '-c', 20:47:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:47:16 INFO - 'enabled': True, 20:47:16 INFO - 'halt_on_failure': False, 20:47:16 INFO - 'name': 'check_screen_resolution'},), 20:47:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:47:16 INFO - 'cmd': ('bash', 20:47:16 INFO - '-c', 20:47:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:47:16 INFO - 'enabled': True, 20:47:16 INFO - 'halt_on_failure': False, 20:47:16 INFO - 'name': 'check_screen_resolution'},), 20:47:16 INFO - 'run_cmd_checks_enabled': True, 20:47:16 INFO - 'sps_profile': False, 20:47:16 INFO - 'sps_profile_interval': 0, 20:47:16 INFO - 'suite': 'dromaeojs', 20:47:16 INFO - 'system_bits': '32', 20:47:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:47:16 INFO - 'title': 't-yosemite-r7-0210', 20:47:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:47:16 INFO - 'use_talos_json': True, 20:47:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:47:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:47:16 INFO - 'work_dir': 'build'} 20:47:16 INFO - [mozharness: 2016-09-14 03:47:16.894902Z] Running clobber step. 20:47:16 INFO - Running pre-action listener: _resource_record_pre_action 20:47:16 INFO - Running main action method: clobber 20:47:16 INFO - rmtree: /builds/slave/test/build 20:47:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:47:18 INFO - Running post-action listener: _resource_record_post_action 20:47:18 INFO - [mozharness: 2016-09-14 03:47:18.891389Z] Finished clobber step (success) 20:47:18 INFO - [mozharness: 2016-09-14 03:47:18.891544Z] Running read-buildbot-config step. 20:47:18 INFO - Running pre-action listener: _resource_record_pre_action 20:47:18 INFO - Running main action method: read_buildbot_config 20:47:18 INFO - Using buildbot properties: 20:47:18 INFO - { 20:47:18 INFO - "project": "", 20:47:18 INFO - "product": "firefox", 20:47:18 INFO - "script_repo_revision": "production", 20:47:18 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 20:47:18 INFO - "repository": "", 20:47:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 20:47:18 INFO - "buildid": "20160913174207", 20:47:18 INFO - "pgo_build": "False", 20:47:18 INFO - "basedir": "/builds/slave/test", 20:47:18 INFO - "buildnumber": 198, 20:47:18 INFO - "slavename": "t-yosemite-r7-0210", 20:47:18 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 20:47:18 INFO - "platform": "yosemite_r7", 20:47:18 INFO - "scheduler": "tests-autoland-macosx64-talos", 20:47:18 INFO - "branch": "autoland", 20:47:18 INFO - "repo_path": "integration/autoland", 20:47:18 INFO - "revision": "c6edbdd09f304b3c092cc58ee16e7d1901837434", 20:47:18 INFO - "stage_platform": "macosx64", 20:47:18 INFO - "builduid": "94e8eeee052c4df98b939bc815863bbd", 20:47:18 INFO - "slavebuilddir": "test" 20:47:18 INFO - } 20:47:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/FCldrswCSDuPK5_pP5PLww/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 20:47:18 INFO - Running post-action listener: _resource_record_post_action 20:47:18 INFO - [mozharness: 2016-09-14 03:47:18.895030Z] Finished read-buildbot-config step (success) 20:47:18 INFO - [mozharness: 2016-09-14 03:47:18.895136Z] Running download-and-extract step. 20:47:18 INFO - Running pre-action listener: _resource_record_pre_action 20:47:18 INFO - Running main action method: download_and_extract 20:47:18 INFO - mkdir: /builds/slave/test/build/tests 20:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:47:18 INFO - trying https://queue.taskcluster.net/v1/task/FCldrswCSDuPK5_pP5PLww/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 20:47:18 INFO - Downloading https://queue.taskcluster.net/v1/task/FCldrswCSDuPK5_pP5PLww/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 20:47:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FCldrswCSDuPK5_pP5PLww/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 20:47:20 INFO - Downloaded 1199 bytes. 20:47:20 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 20:47:20 INFO - Using the following test package requirements: 20:47:20 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 20:47:20 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:47:20 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 20:47:20 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:47:20 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 20:47:20 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:47:20 INFO - u'jsshell-mac.zip'], 20:47:20 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:47:20 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 20:47:20 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 20:47:20 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:47:20 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 20:47:20 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:47:20 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 20:47:20 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:47:20 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 20:47:20 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:47:20 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 20:47:20 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:47:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FCldrswCSDuPK5_pP5PLww/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 20:47:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FCldrswCSDuPK5_pP5PLww/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:47:20 INFO - Fetch https://queue.taskcluster.net/v1/task/FCldrswCSDuPK5_pP5PLww/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip into memory 20:47:20 INFO - Expected file size: 16424799 20:47:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 20:47:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FCldrswCSDuPK5_pP5PLww/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 20:47:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FCldrswCSDuPK5_pP5PLww/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:47:27 INFO - Fetch https://queue.taskcluster.net/v1/task/FCldrswCSDuPK5_pP5PLww/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip into memory 20:47:28 INFO - Expected file size: 16424799 20:47:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FCldrswCSDuPK5_pP5PLww/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 20:47:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FCldrswCSDuPK5_pP5PLww/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 20:47:34 INFO - Fetch https://queue.taskcluster.net/v1/task/FCldrswCSDuPK5_pP5PLww/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip into memory 20:47:35 INFO - Expected file size: 14414048 20:47: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')]} 20:47:35 INFO - trying https://queue.taskcluster.net/v1/task/FCldrswCSDuPK5_pP5PLww/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 20:47:35 INFO - Downloading https://queue.taskcluster.net/v1/task/FCldrswCSDuPK5_pP5PLww/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 20:47:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FCldrswCSDuPK5_pP5PLww/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 20:47:38 INFO - Downloaded 111436051 bytes. 20:47:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FCldrswCSDuPK5_pP5PLww/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 20:47:38 INFO - mkdir: /builds/slave/test/properties 20:47:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:47:38 INFO - Writing to file /builds/slave/test/properties/build_url 20:47:38 INFO - Contents: 20:47:38 INFO - build_url:https://queue.taskcluster.net/v1/task/FCldrswCSDuPK5_pP5PLww/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 20:47:39 INFO - Running post-action listener: _resource_record_post_action 20:47:39 INFO - Running post-action listener: set_extra_try_arguments 20:47:39 INFO - [mozharness: 2016-09-14 03:47:39.300703Z] Finished download-and-extract step (success) 20:47:39 INFO - [mozharness: 2016-09-14 03:47:39.300799Z] Running populate-webroot step. 20:47:39 INFO - Running pre-action listener: _resource_record_pre_action 20:47:39 INFO - Running main action method: populate_webroot 20:47:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:47:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:47:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:47:39 INFO - '--tppagecycles', 20:47:39 INFO - '7'], 20:47:39 INFO - 'tests': ['tsvgm']}}, 20:47:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:47:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:47:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:47:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:47:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:47:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:47:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:47:39 INFO - 'talos_options': ['--disable-e10s'], 20:47:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:47:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:47:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:47:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:47:39 INFO - 'talos_options': ['--disable-e10s'], 20:47:39 INFO - 'tests': ['damp', 'tps']}, 20:47:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:47:39 INFO - 'tests': ['damp', 'tps']}, 20:47:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:47:39 INFO - 'tests': ['dromaeo_dom']}, 20:47:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:47:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:47:39 INFO - 'tests': ['basic_compositor_video']}, 20:47:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:47:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:47:39 INFO - 'tests': ['a11yr', 20:47:39 INFO - 'ts_paint', 20:47:39 INFO - 'tpaint', 20:47:39 INFO - 'sessionrestore', 20:47:39 INFO - 'sessionrestore_no_auto_restore', 20:47:39 INFO - 'tabpaint']}, 20:47:39 INFO - 'other-e10s': {'tests': ['a11yr', 20:47:39 INFO - 'ts_paint', 20:47:39 INFO - 'tpaint', 20:47:39 INFO - 'sessionrestore', 20:47:39 INFO - 'sessionrestore_no_auto_restore', 20:47:39 INFO - 'tabpaint']}, 20:47:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:47:39 INFO - 'ts_paint', 20:47:39 INFO - 'tpaint', 20:47:39 INFO - 'sessionrestore', 20:47:39 INFO - 'sessionrestore_no_auto_restore', 20:47:39 INFO - 'tabpaint']}, 20:47:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:47:39 INFO - 'ts_paint', 20:47:39 INFO - 'tpaint', 20:47:39 INFO - 'sessionrestore', 20:47:39 INFO - 'sessionrestore_no_auto_restore', 20:47:39 INFO - 'tabpaint']}, 20:47:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:47:39 INFO - 'tests': ['a11yr', 20:47:39 INFO - 'ts_paint', 20:47:39 INFO - 'tpaint', 20:47:39 INFO - 'sessionrestore', 20:47:39 INFO - 'sessionrestore_no_auto_restore', 20:47:39 INFO - 'tabpaint']}, 20:47:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:47:39 INFO - 'tests': ['a11yr', 20:47:39 INFO - 'ts_paint', 20:47:39 INFO - 'tpaint', 20:47:39 INFO - 'sessionrestore', 20:47:39 INFO - 'sessionrestore_no_auto_restore', 20:47:39 INFO - 'tabpaint']}, 20:47:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:47:39 INFO - 'tests': ['tsvgx', 20:47:39 INFO - 'tsvgr_opacity', 20:47:39 INFO - 'tart', 20:47:39 INFO - 'tscrollx', 20:47:39 INFO - 'cart']}, 20:47:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:47:39 INFO - 'tsvgr_opacity', 20:47:39 INFO - 'tart', 20:47:39 INFO - 'tscrollx', 20:47:39 INFO - 'cart']}, 20:47:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:47:39 INFO - 'talos_options': ['--disable-e10s'], 20:47:39 INFO - 'tests': ['tp5o']}, 20:47:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:47:39 INFO - 'tests': ['tp5o']}, 20:47:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:47:39 INFO - 'talos_options': ['--disable-e10s', 20:47:39 INFO - '--xperf_path', 20:47:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:47:39 INFO - 'tests': ['tp5n']}, 20:47:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:47:39 INFO - 'talos_options': ['--xperf_path', 20:47:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:47:39 INFO - 'tests': ['tp5n']}}, 20:47:39 INFO - 'talos.zip': {'path': '', 20:47:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:47:39 INFO - Running post-action listener: _resource_record_post_action 20:47:39 INFO - [mozharness: 2016-09-14 03:47:39.319193Z] Finished populate-webroot step (success) 20:47:39 INFO - [mozharness: 2016-09-14 03:47:39.319300Z] Running create-virtualenv step. 20:47:39 INFO - Running pre-action listener: _resource_record_pre_action 20:47:39 INFO - Running main action method: create_virtualenv 20:47:39 INFO - Creating virtualenv /builds/slave/test/build/venv 20:47:39 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 20:47:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:47:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:47:39 INFO - Using real prefix '/tools/python27' 20:47:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:47:40 INFO - Installing distribute.............................................................................................................................................................................................done. 20:47:42 INFO - Installing pip.................done. 20:47:42 INFO - Return code: 0 20:47:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:47:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:47:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:47:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:47:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47:42 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 0x10ec1b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb91570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9252c7b260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea2fd30>, '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 0x10e855db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea27b20>, '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.UeUPak7Ku0/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.r2Ghu0AYnV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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 20:47:42 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 20:47:42 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 20:47:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UeUPak7Ku0/Render', 20:47:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:47:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:47:42 INFO - 'HOME': '/Users/cltbld', 20:47:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:47:42 INFO - 'LOGNAME': 'cltbld', 20:47:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:47:42 INFO - 'MOZ_NO_REMOTE': '1', 20:47:42 INFO - 'NO_EM_RESTART': '1', 20:47:42 INFO - 'PAGER': '/bin/cat', 20:47:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:47:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:47:42 INFO - 'PWD': '/builds/slave/test', 20:47:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:47:42 INFO - 'SHELL': '/bin/bash', 20:47:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r2Ghu0AYnV/Listeners', 20:47:42 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 20:47:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:47:42 INFO - 'USER': 'cltbld', 20:47:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:47:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:47:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:47:42 INFO - 'XPC_FLAGS': '0x0', 20:47:42 INFO - 'XPC_SERVICE_NAME': '0', 20:47:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:47:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:47:43 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 20:47:43 INFO - Cleaning up... 20:47:43 INFO - Return code: 0 20:47:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:47: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')]} 20:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:47:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47: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')]} 20:47:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:47:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47:43 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 0x10ec1b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb91570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9252c7b260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea2fd30>, '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 0x10e855db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea27b20>, '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.UeUPak7Ku0/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.r2Ghu0AYnV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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 20:47:43 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 20:47:43 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 20:47:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UeUPak7Ku0/Render', 20:47:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:47:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:47:43 INFO - 'HOME': '/Users/cltbld', 20:47:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:47:43 INFO - 'LOGNAME': 'cltbld', 20:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:47:43 INFO - 'MOZ_NO_REMOTE': '1', 20:47:43 INFO - 'NO_EM_RESTART': '1', 20:47:43 INFO - 'PAGER': '/bin/cat', 20:47:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:47:43 INFO - 'PWD': '/builds/slave/test', 20:47:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:47:43 INFO - 'SHELL': '/bin/bash', 20:47:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r2Ghu0AYnV/Listeners', 20:47:43 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 20:47:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:47:43 INFO - 'USER': 'cltbld', 20:47:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:47:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:47:43 INFO - 'XPC_FLAGS': '0x0', 20:47:43 INFO - 'XPC_SERVICE_NAME': '0', 20:47:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:47:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:47:43 INFO - Downloading/unpacking psutil>=3.1.1 20:47:43 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 20:47:43 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 20:47:43 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 20:47:43 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 20:47:43 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 20:47:43 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 20:47:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:47:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:47:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:47:47 INFO - Installing collected packages: psutil 20:47:47 INFO - Running setup.py install for psutil 20:47:47 INFO - building 'psutil._psutil_osx' extension 20:47:47 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 20:47:47 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 20:47:47 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 20:47:47 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 20:47:47 INFO - building 'psutil._psutil_posix' extension 20:47:47 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 20:47:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:47:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:47:47 INFO - ^ 20:47:47 INFO - 1 warning generated. 20:47:47 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 20:47:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:47:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:47:47 INFO - Successfully installed psutil 20:47:47 INFO - Cleaning up... 20:47:48 INFO - Return code: 0 20:47:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:47:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:47:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:47:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ec1b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb91570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9252c7b260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea2fd30>, '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 0x10e855db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea27b20>, '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.UeUPak7Ku0/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.r2Ghu0AYnV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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 20:47:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:47:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:47:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UeUPak7Ku0/Render', 20:47:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:47:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:47:48 INFO - 'HOME': '/Users/cltbld', 20:47:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:47:48 INFO - 'LOGNAME': 'cltbld', 20:47:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:47:48 INFO - 'MOZ_NO_REMOTE': '1', 20:47:48 INFO - 'NO_EM_RESTART': '1', 20:47:48 INFO - 'PAGER': '/bin/cat', 20:47:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:47:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:47:48 INFO - 'PWD': '/builds/slave/test', 20:47:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:47:48 INFO - 'SHELL': '/bin/bash', 20:47:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r2Ghu0AYnV/Listeners', 20:47:48 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 20:47:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:47:48 INFO - 'USER': 'cltbld', 20:47:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:47:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:47:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:47:48 INFO - 'XPC_FLAGS': '0x0', 20:47:48 INFO - 'XPC_SERVICE_NAME': '0', 20:47:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:47:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:47:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:47:48 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 20:47:48 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 20:47:48 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 20:47:48 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 20:47:48 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 20:47:48 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 20:47:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:47:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:47:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:47:50 INFO - Installing collected packages: mozsystemmonitor 20:47:50 INFO - Running setup.py install for mozsystemmonitor 20:47:50 INFO - Successfully installed mozsystemmonitor 20:47:50 INFO - Cleaning up... 20:47:51 INFO - Return code: 0 20:47:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:47:51 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')]} 20:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:47:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47:51 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')]} 20:47:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:47:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47:51 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 0x10ec1b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb91570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9252c7b260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea2fd30>, '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 0x10e855db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea27b20>, '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.UeUPak7Ku0/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.r2Ghu0AYnV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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 20:47:51 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 20:47:51 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 20:47:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UeUPak7Ku0/Render', 20:47:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:47:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:47:51 INFO - 'HOME': '/Users/cltbld', 20:47:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:47:51 INFO - 'LOGNAME': 'cltbld', 20:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:47:51 INFO - 'MOZ_NO_REMOTE': '1', 20:47:51 INFO - 'NO_EM_RESTART': '1', 20:47:51 INFO - 'PAGER': '/bin/cat', 20:47:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:47:51 INFO - 'PWD': '/builds/slave/test', 20:47:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:47:51 INFO - 'SHELL': '/bin/bash', 20:47:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r2Ghu0AYnV/Listeners', 20:47:51 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 20:47:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:47:51 INFO - 'USER': 'cltbld', 20:47:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:47:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:47:51 INFO - 'XPC_FLAGS': '0x0', 20:47:51 INFO - 'XPC_SERVICE_NAME': '0', 20:47:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:47:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:47:51 INFO - Downloading/unpacking jsonschema==2.5.1 20:47:51 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 20:47:51 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 20:47:51 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 20:47:51 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 20:47:51 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 20:47:51 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 20:47:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:47:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:47:53 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 20:47:53 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 20:47:53 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 20:47:53 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 20:47:53 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 20:47:53 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 20:47:54 INFO - Downloading functools32-3.2.3-2.tar.gz 20:47:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:47:54 INFO - warning: no files found matching '*.txt' 20:47:54 INFO - no previously-included directories found matching 'build' 20:47:54 INFO - no previously-included directories found matching 'dist' 20:47:54 INFO - no previously-included directories found matching '.git*' 20:47:54 INFO - Installing collected packages: jsonschema, functools32 20:47:54 INFO - Running setup.py install for functools32 20:47:54 INFO - warning: no files found matching '*.txt' 20:47:54 INFO - no previously-included directories found matching 'build' 20:47:54 INFO - no previously-included directories found matching 'dist' 20:47:54 INFO - no previously-included directories found matching '.git*' 20:47:54 INFO - Successfully installed jsonschema functools32 20:47:54 INFO - Cleaning up... 20:47:54 INFO - Return code: 0 20:47:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:47:54 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')]} 20:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:47:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47:54 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')]} 20:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:47:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47:54 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 0x10ec1b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb91570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9252c7b260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea2fd30>, '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 0x10e855db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea27b20>, '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.UeUPak7Ku0/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.r2Ghu0AYnV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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 20:47:54 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 20:47:54 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 20:47:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UeUPak7Ku0/Render', 20:47:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:47:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:47:54 INFO - 'HOME': '/Users/cltbld', 20:47:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:47:54 INFO - 'LOGNAME': 'cltbld', 20:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:47:54 INFO - 'MOZ_NO_REMOTE': '1', 20:47:54 INFO - 'NO_EM_RESTART': '1', 20:47:54 INFO - 'PAGER': '/bin/cat', 20:47:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:47:54 INFO - 'PWD': '/builds/slave/test', 20:47:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:47:54 INFO - 'SHELL': '/bin/bash', 20:47:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r2Ghu0AYnV/Listeners', 20:47:54 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 20:47:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:47:54 INFO - 'USER': 'cltbld', 20:47:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:47:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:47:54 INFO - 'XPC_FLAGS': '0x0', 20:47:54 INFO - 'XPC_SERVICE_NAME': '0', 20:47:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:47:54 INFO - Cleaning up... 20:47:54 INFO - Return code: 0 20:47:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:47:54 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')]} 20:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:47:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47:54 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')]} 20:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:47:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47:54 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 0x10ec1b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb91570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9252c7b260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea2fd30>, '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 0x10e855db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea27b20>, '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.UeUPak7Ku0/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.r2Ghu0AYnV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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 20:47:54 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 20:47:54 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 20:47:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UeUPak7Ku0/Render', 20:47:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:47:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:47:54 INFO - 'HOME': '/Users/cltbld', 20:47:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:47:54 INFO - 'LOGNAME': 'cltbld', 20:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:47:54 INFO - 'MOZ_NO_REMOTE': '1', 20:47:54 INFO - 'NO_EM_RESTART': '1', 20:47:54 INFO - 'PAGER': '/bin/cat', 20:47:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:47:54 INFO - 'PWD': '/builds/slave/test', 20:47:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:47:54 INFO - 'SHELL': '/bin/bash', 20:47:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r2Ghu0AYnV/Listeners', 20:47:54 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 20:47:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:47:54 INFO - 'USER': 'cltbld', 20:47:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:47:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:47:54 INFO - 'XPC_FLAGS': '0x0', 20:47:54 INFO - 'XPC_SERVICE_NAME': '0', 20:47:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:47:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:47:55 INFO - Downloading/unpacking blobuploader==1.2.4 20:47:55 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 20:47:55 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 20:47:55 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 20:47:55 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 20:47:55 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 20:47:55 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 20:47:57 INFO - Downloading blobuploader-1.2.4.tar.gz 20:47:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:47:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:47:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:47:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:47:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:47:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:47:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:47:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:47:58 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 20:47:58 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 20:47:58 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 20:47:58 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 20:47:58 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 20:47:58 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 20:47:58 INFO - Downloading docopt-0.6.1.tar.gz 20:47:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:47:58 INFO - Installing collected packages: blobuploader, requests, docopt 20:47:58 INFO - Running setup.py install for blobuploader 20:47:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:47:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:47:58 INFO - Running setup.py install for requests 20:47:59 INFO - Running setup.py install for docopt 20:47:59 INFO - Successfully installed blobuploader requests docopt 20:47:59 INFO - Cleaning up... 20:47:59 INFO - Return code: 0 20:47:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:47:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:47:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:47:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47:59 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 0x10ec1b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb91570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9252c7b260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea2fd30>, '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 0x10e855db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea27b20>, '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.UeUPak7Ku0/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.r2Ghu0AYnV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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 20:47:59 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 20:47:59 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 20:47:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UeUPak7Ku0/Render', 20:47:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:47:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:47:59 INFO - 'HOME': '/Users/cltbld', 20:47:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:47:59 INFO - 'LOGNAME': 'cltbld', 20:47:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:47:59 INFO - 'MOZ_NO_REMOTE': '1', 20:47:59 INFO - 'NO_EM_RESTART': '1', 20:47:59 INFO - 'PAGER': '/bin/cat', 20:47:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:47:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:47:59 INFO - 'PWD': '/builds/slave/test', 20:47:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:47:59 INFO - 'SHELL': '/bin/bash', 20:47:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r2Ghu0AYnV/Listeners', 20:47:59 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 20:47:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:47:59 INFO - 'USER': 'cltbld', 20:47:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:47:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:47:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:47:59 INFO - 'XPC_FLAGS': '0x0', 20:47:59 INFO - 'XPC_SERVICE_NAME': '0', 20:47:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:47:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:47:59 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-K8RUA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:47:59 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-p6jdKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:48:00 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-sWjWEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:48:00 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-JghPWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:48:00 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-gHGse6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:48:00 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-e_Pctc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:48:00 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-fa6ulO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:48:00 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-YhUpY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:48:00 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-hHEpyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:48:00 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-STfCzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:48:00 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-U0laRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:48:01 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-cdqNtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:48:01 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-tIRxcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:48:01 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-BO1ejE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:48:01 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-saf9Fv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:48:01 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-xjQyxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:48:01 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-HQT4gS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:48:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:48:01 INFO - Running setup.py install for manifestparser 20:48:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:48:01 INFO - Running setup.py install for mozcrash 20:48:01 INFO - Running setup.py install for mozdebug 20:48:02 INFO - Running setup.py install for mozdevice 20:48:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:48:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:48:02 INFO - Running setup.py install for mozfile 20:48:02 INFO - Running setup.py install for mozhttpd 20:48:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:48:02 INFO - Running setup.py install for mozinfo 20:48:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:48:02 INFO - Running setup.py install for mozInstall 20:48:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:48:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:48:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:48:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:48:02 INFO - Running setup.py install for mozleak 20:48:02 INFO - Running setup.py install for mozlog 20:48:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:48:03 INFO - Running setup.py install for moznetwork 20:48:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:48:03 INFO - Running setup.py install for mozprocess 20:48:03 INFO - Running setup.py install for mozprofile 20:48:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:48:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:48:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:48:03 INFO - Running setup.py install for mozrunner 20:48:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:48:03 INFO - Running setup.py install for mozscreenshot 20:48:03 INFO - Running setup.py install for moztest 20:48:04 INFO - Running setup.py install for mozversion 20:48:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:48:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:48:04 INFO - Cleaning up... 20:48:04 INFO - Return code: 0 20:48:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:48:04 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')]} 20:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:04 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')]} 20:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:04 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 0x10ec1b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb91570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9252c7b260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea2fd30>, '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 0x10e855db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea27b20>, '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.UeUPak7Ku0/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.r2Ghu0AYnV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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 20:48:04 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 20:48:04 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 20:48:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UeUPak7Ku0/Render', 20:48:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:48:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:48:04 INFO - 'HOME': '/Users/cltbld', 20:48:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:48:04 INFO - 'LOGNAME': 'cltbld', 20:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:04 INFO - 'MOZ_NO_REMOTE': '1', 20:48:04 INFO - 'NO_EM_RESTART': '1', 20:48:04 INFO - 'PAGER': '/bin/cat', 20:48:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:04 INFO - 'PWD': '/builds/slave/test', 20:48:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:48:04 INFO - 'SHELL': '/bin/bash', 20:48:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r2Ghu0AYnV/Listeners', 20:48:04 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 20:48:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:48:04 INFO - 'USER': 'cltbld', 20:48:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:48:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:04 INFO - 'XPC_FLAGS': '0x0', 20:48:04 INFO - 'XPC_SERVICE_NAME': '0', 20:48:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:48:04 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-mwcI5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:48:04 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)) 20:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:48:04 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-UGOw8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 20:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:48:04 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-xrHC9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:48:04 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)) 20:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:48:04 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-7hyU8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 20:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:48:04 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-bmeVPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:48:05 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)) 20:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:48:05 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-rzgx68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:48:05 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)) 20:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:48:05 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-j8SDfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:48:05 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)) 20:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:48:05 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-H0qVGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:48:05 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)) 20:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:48:05 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-IU5iHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:48:05 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)) 20:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:48:05 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-VOQv3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:48:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 20:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:48:05 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-7md5jH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:48:05 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)) 20:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:48:05 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-Z2WAG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:48:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:48:05 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-LXhomq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:48:05 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)) 20:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:48:05 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-eu5NFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:48:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 20:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:48:05 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-okI3nr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:48:06 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)) 20:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:48:06 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-SGHvmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:48:06 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-UbvYRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:48:06 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)) 20:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:48:06 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)) 20:48:06 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:48:06 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:48:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:48:06 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 20:48:06 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 20:48:06 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 20:48:06 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 20:48:06 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 20:48:06 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 20:48:08 INFO - Downloading blessings-1.6.tar.gz 20:48:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:48:08 INFO - Installing collected packages: blessings 20:48:08 INFO - Running setup.py install for blessings 20:48:09 INFO - Successfully installed blessings 20:48:09 INFO - Cleaning up... 20:48:09 INFO - Return code: 0 20:48:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:48:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:48:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:48:09 INFO - Reading from file tmpfile_stdout 20:48:09 INFO - Current package versions: 20:48:09 INFO - blessings == 1.6 20:48:09 INFO - blobuploader == 1.2.4 20:48:09 INFO - docopt == 0.6.1 20:48:09 INFO - functools32 == 3.2.3-2 20:48:09 INFO - jsonschema == 2.5.1 20:48:09 INFO - manifestparser == 1.1 20:48:09 INFO - mozInstall == 1.12 20:48:09 INFO - mozcrash == 0.17 20:48:09 INFO - mozdebug == 0.1 20:48:09 INFO - mozdevice == 0.48 20:48:09 INFO - mozfile == 1.2 20:48:09 INFO - mozhttpd == 0.7 20:48:09 INFO - mozinfo == 0.9 20:48:09 INFO - mozleak == 0.1 20:48:09 INFO - mozlog == 3.3 20:48:09 INFO - moznetwork == 0.27 20:48:09 INFO - mozprocess == 0.23 20:48:09 INFO - mozprofile == 0.28 20:48:09 INFO - mozrunner == 6.12 20:48:09 INFO - mozscreenshot == 0.1 20:48:09 INFO - mozsystemmonitor == 0.3 20:48:09 INFO - moztest == 0.7 20:48:09 INFO - mozversion == 1.4 20:48:09 INFO - psutil == 3.1.1 20:48:09 INFO - requests == 1.2.3 20:48:09 INFO - wsgiref == 0.1.2 20:48:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:48:09 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')]} 20:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:48:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:09 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')]} 20:48:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:48:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:09 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 0x10ec1b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb91570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9252c7b260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea2fd30>, '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 0x10e855db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea27b20>, '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.UeUPak7Ku0/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.r2Ghu0AYnV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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 20:48:09 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 20:48:09 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 20:48:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UeUPak7Ku0/Render', 20:48:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:48:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:48:09 INFO - 'HOME': '/Users/cltbld', 20:48:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:48:09 INFO - 'LOGNAME': 'cltbld', 20:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:09 INFO - 'MOZ_NO_REMOTE': '1', 20:48:09 INFO - 'NO_EM_RESTART': '1', 20:48:09 INFO - 'PAGER': '/bin/cat', 20:48:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:09 INFO - 'PWD': '/builds/slave/test', 20:48:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:48:09 INFO - 'SHELL': '/bin/bash', 20:48:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r2Ghu0AYnV/Listeners', 20:48:09 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 20:48:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:48:09 INFO - 'USER': 'cltbld', 20:48:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:48:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:09 INFO - 'XPC_FLAGS': '0x0', 20:48:09 INFO - 'XPC_SERVICE_NAME': '0', 20:48:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:48:09 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)) 20:48:09 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)) 20:48:09 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)) 20:48:09 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)) 20:48:09 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)) 20:48:09 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)) 20:48:09 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)) 20:48:09 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)) 20:48:09 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)) 20:48:09 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)) 20:48:09 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)) 20:48:09 INFO - Cleaning up... 20:48:09 INFO - Return code: 0 20:48:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:48:09 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')]} 20:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:48:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:09 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')]} 20:48:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:48:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:48:09 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 0x10ec1b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb91570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9252c7b260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea2fd30>, '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 0x10e855db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea27b20>, '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.UeUPak7Ku0/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.r2Ghu0AYnV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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 20:48:09 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 20:48:09 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 20:48:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UeUPak7Ku0/Render', 20:48:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:48:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:48:09 INFO - 'HOME': '/Users/cltbld', 20:48:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:48:09 INFO - 'LOGNAME': 'cltbld', 20:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:09 INFO - 'MOZ_NO_REMOTE': '1', 20:48:09 INFO - 'NO_EM_RESTART': '1', 20:48:09 INFO - 'PAGER': '/bin/cat', 20:48:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:09 INFO - 'PWD': '/builds/slave/test', 20:48:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:48:09 INFO - 'SHELL': '/bin/bash', 20:48:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r2Ghu0AYnV/Listeners', 20:48:09 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 20:48:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:48:09 INFO - 'USER': 'cltbld', 20:48:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:48:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:09 INFO - 'XPC_FLAGS': '0x0', 20:48:09 INFO - 'XPC_SERVICE_NAME': '0', 20:48:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:48:09 INFO - Cleaning up... 20:48:09 INFO - Return code: 0 20:48:09 INFO - Running post-action listener: _resource_record_post_action 20:48:09 INFO - Running post-action listener: _start_resource_monitoring 20:48:09 INFO - Starting resource monitoring. 20:48:09 INFO - [mozharness: 2016-09-14 03:48:09.972540Z] Finished create-virtualenv step (success) 20:48:09 INFO - [mozharness: 2016-09-14 03:48:09.973518Z] Running install step. 20:48:09 INFO - Running pre-action listener: _resource_record_pre_action 20:48:09 INFO - Running main action method: install 20:48:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:48:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:48:10 INFO - Reading from file tmpfile_stdout 20:48:10 INFO - Detecting whether we're running mozinstall >=1.0... 20:48:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:48:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:48:10 INFO - Reading from file tmpfile_stdout 20:48:10 INFO - Output received: 20:48:10 INFO - Usage: mozinstall [options] installer 20:48:10 INFO - Options: 20:48:10 INFO - -h, --help show this help message and exit 20:48:10 INFO - -d DEST, --destination=DEST 20:48:10 INFO - Directory to install application into. [default: 20:48:10 INFO - "/builds/slave/test"] 20:48:10 INFO - --app=APP Application being installed. [default: firefox] 20:48:10 INFO - mkdir: /builds/slave/test/build/application 20:48:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 20:48:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 20:48:44 INFO - Reading from file tmpfile_stdout 20:48:44 INFO - Output received: 20:48:44 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:48:44 INFO - Running post-action listener: _resource_record_post_action 20:48:44 INFO - [mozharness: 2016-09-14 03:48:44.263815Z] Finished install step (success) 20:48:44 INFO - [mozharness: 2016-09-14 03:48:44.263957Z] Running run-tests step. 20:48:44 INFO - Running pre-action listener: _resource_record_pre_action 20:48:44 INFO - Running main action method: run_tests 20:48:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:48:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:48:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:48:44 INFO - 2016-09-13 20:48:44.278 screenresolution[1932:17677] starting screenresolution argv=screenresolution get 20:48:44 INFO - 2016-09-13 20:48:44.281 screenresolution[1932:17677] Display 0: 1600x1200x32@60 20:48:44 INFO - 2016-09-13 20:48:44.287 screenresolution[1933:17679] starting screenresolution argv=screenresolution list 20:48:44 INFO - Available Modes on Display 0 20:48:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:48:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:48:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:48:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:48:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:48:44 INFO - Intel Iris: 20:48:44 INFO - Chipset Model: Intel Iris 20:48:44 INFO - Type: GPU 20:48:44 INFO - Bus: Built-In 20:48:44 INFO - VRAM (Dynamic, Max): 1536 MB 20:48:44 INFO - Vendor: Intel (0x8086) 20:48:44 INFO - Device ID: 0x0a2e 20:48:44 INFO - Revision ID: 0x0009 20:48:44 INFO - Displays: 20:48:44 INFO - Display: 20:48:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:48:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:48:44 INFO - Display Serial Number: 1600x1200 60 20:48:44 INFO - Main Display: Yes 20:48:44 INFO - Mirror: Off 20:48:44 INFO - Online: Yes 20:48:44 INFO - Rotation: Supported 20:48:44 INFO - Return code: 0 20:48:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:48:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:48:44 INFO - Python 2.7.3 20:48:44 INFO - Return code: 0 20:48:44 INFO - grabbing minidump binary from tooltool 20:48:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:48:44 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 0x10ea2fd30>, '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 0x10e855db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea27b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:48:44 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 20:48:44 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 20:48:44 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 20:48:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:48:44 INFO - Return code: 0 20:48:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:48:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:48:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:48:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:48:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:48:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FCldrswCSDuPK5_pP5PLww/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0210', '--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 20:48:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FCldrswCSDuPK5_pP5PLww/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0210 --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 20:48:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UeUPak7Ku0/Render', 20:48:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:48:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:48:44 INFO - 'HOME': '/Users/cltbld', 20:48:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:48:44 INFO - 'LOGNAME': 'cltbld', 20:48:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:48:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:48:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:48:44 INFO - 'MOZ_NO_REMOTE': '1', 20:48:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:48:44 INFO - 'NO_EM_RESTART': '1', 20:48:44 INFO - 'PAGER': '/bin/cat', 20:48:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:48:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:48:44 INFO - 'PWD': '/builds/slave/test', 20:48:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:48:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:48:44 INFO - 'SHELL': '/bin/bash', 20:48:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r2Ghu0AYnV/Listeners', 20:48:44 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 20:48:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:48:44 INFO - 'USER': 'cltbld', 20:48:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:48:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:48:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:48:44 INFO - 'XPC_FLAGS': '0x0', 20:48:44 INFO - 'XPC_SERVICE_NAME': '0', 20:48:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:48:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FCldrswCSDuPK5_pP5PLww/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0210', '--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 20:48:44 INFO - mozversion application_buildid: 20160913174207 20:48:44 INFO - mozversion application_changeset: c6edbdd09f304b3c092cc58ee16e7d1901837434 20:48:44 INFO - mozversion application_display_name: Nightly 20:48:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:48:44 INFO - mozversion application_name: Firefox 20:48:44 INFO - mozversion application_remotingname: firefox 20:48:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 20:48:44 INFO - mozversion application_vendor: Mozilla 20:48:44 INFO - mozversion application_version: 51.0a1 20:48:44 INFO - mozversion platform_buildid: 20160913174207 20:48:44 INFO - mozversion platform_changeset: c6edbdd09f304b3c092cc58ee16e7d1901837434 20:48:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 20:48:44 INFO - mozversion platform_version: 51.0a1 20:48:44 INFO - using testdate: 1473824924 20:48:44 INFO - actual date: 1473824924 20:48:44 INFO - starting webserver on 'localhost:56067' 20:48:44 INFO - SUITE-START | Running 2 tests 20:48:44 INFO - TEST-START | dromaeo_css 20:48:44 INFO - operating with platform_type : mac_ 20:48:44 INFO - Initialising browser for dromaeo_css test... 20:48:44 INFO - TEST-INFO | started process 1943 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/tmpIXxPdS/profile http://localhost:56067/getInfo.html) 20:48:47 INFO - PROCESS | 1943 | __metrics Screen width/height:1600/1200 20:48:47 INFO - PROCESS | 1943 | colorDepth:24 20:48:47 INFO - PROCESS | 1943 | Browser inner width/height: 1024/689 20:48:47 INFO - PROCESS | 1943 | __metrics 20:48:47 INFO - PROCESS | 1943 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:48:47 INFO - PROCESS | 1943 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:48:48 INFO - TEST-INFO | 1943: exit 0 20:48:48 INFO - Browser initialized. 20:48:48 INFO - Running cycle 1/1 for dromaeo_css test... 20:48:48 INFO - TEST-INFO | started process 1945 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/tmpIXxPdS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:49:00 INFO - PROCESS | 1945 | RSS: Main: 229015552 20:49:00 INFO - PROCESS | 1945 | 20:49:51 INFO - PROCESS | 1945 | 1473824991200 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:52:03 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:56067/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56067/tests/dromaeo/cssquery-ext.html) 20:52:04 INFO - PROCESS | 1945 | RSS: Main: 417779712 20:52:04 INFO - PROCESS | 1945 | 20:55:08 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:56067/tests/dromaeo/cssquery-ext.html (next: http://localhost:56067/tests/dromaeo/cssquery-jquery.html) 20:55:08 INFO - PROCESS | 1945 | RSS: Main: 369672192 20:55:08 INFO - PROCESS | 1945 | 20:58:10 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:56067/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56067/tests/dromaeo/cssquery-mootools.html) 20:58:11 INFO - PROCESS | 1945 | RSS: Main: 340918272 20:58:11 INFO - PROCESS | 1945 | 21:01:13 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:56067/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56067/tests/dromaeo/cssquery-prototype.html) 21:01:14 INFO - PROCESS | 1945 | RSS: Main: 336801792 21:01:14 INFO - PROCESS | 1945 | 21:04:17 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:56067/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56067/tests/dromaeo/cssquery-yui.html) 21:04:18 INFO - PROCESS | 1945 | RSS: Main: 336822272 21:04:18 INFO - PROCESS | 1945 | 21:07:21 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:56067/tests/dromaeo/cssquery-yui.html (next: http://localhost:56067/tests/dromaeo/cssquery-dojo.html) 21:07:22 INFO - PROCESS | 1945 | RSS: Main: 380764160 21:07:22 INFO - PROCESS | 1945 | 21:07:22 INFO - PROCESS | 1945 | __start_tp_report 21:07:22 INFO - PROCESS | 1945 | _x_x_mozilla_page_load 21:07:22 INFO - PROCESS | 1945 | _x_x_mozilla_page_load_details 21:07:22 INFO - PROCESS | 1945 | |i|pagename|runs| 21:07:22 INFO - PROCESS | 1945 | |0;dojo.html;3231.8222497762645;3255.0560337502125;3306.6197387300467;3332.9333413331733;3389.169653434909;5654.717264136787;5760.539156867451;5769.5672824538115;5892.3812999635065;5921.585489015771;5717.571182161344;5826.504747096502;5843.065109582479;5888.823335299948;5954.493868021213;5225.346831646044;5245.501677340647;5275.498827611371;5321.467853214686;5354.759035843396;5374.167004114369;5395.81114660987;5411.485908838654;5412.242286079952;5424.783008679648;4542.545745425431;5204.063268611649;5248.291480650101;5392.676439413628;5395.757190926379;4414.53647367025;5236.554892834114;5279.736013199325;5284.445133260991;5302.125149350352;5215.8174463893965;5235.869103272411;5245.554127899133;5248.501392367719;5293.311869456946;5806.0129777937855;5881.176635271066;5892.410758924116;5909.881802363929;5940.732667029994;6111.652512877612;6178.41305076017;6187.195664563578;6253.968730156365;6313.273973493061;6200.844978875564;6238.688065596702;6246.187995560548;6273.592216505958;6285.371462853678;5906.173135760997;5929.673867937218;5931.368873559805;5955.285365756137;5987;6172.969135154295;6177.84555386119;6245.906311405332;6251.59364641306;6288.496920246369;6183.84540386494;6225.875482490415;6232.501399887998;6239.376062393815;6259.123722678829;6191.907121393183;6211.65835879031;6298.7480500780375;6300.684965751786;6303.558750887486;6118.819280109603;6176.474999625082;6309.08518264849;6317.936820631827;6330.01884707871;6232.0963460298;6282.246130464282;6293.150424692608;6332.050192471166;6367.681615919186;5049.899002019939;5055.418626857885;5057.69653820772;5067.1639179535705;5100.234964755242;4558.726476411426;4576.702514336557;4577.931331030038;4581.450225972838;4616.722996620147;5581.6930068845795;5698.17376480408;5701.0308247598;5778.508826749689;5823.242978412779;6266.154069200691;6267.310595834455;6277.7175027123885;6291.874162516724;6320.051992201206;5845.795397161079;5864.530837532987;5867.413258674099;5870.647761134345;5923.763049478059;5319.760610772447;5459.12653975362;5487.368952570426;5519.69641669712;5524.254225679482;5662.85842853932;6091.781643671372;6268.4671802896355;6279.340669229848;6288.182536270256;6206.441420272197;6225.31521532622;6245.156903817927;6271.216097987752;6271.937280627135;6320.747170113144;6323.177986861679;6330.113784070142;6344;6350.523710721622;6234.376562343729;6268.059791031382;6275.52933529978;6281.71732272058;6282.780102696383;6120.995732433061;6221.253449586078;6284.962981108066;6292;6318;6033.42682445167;6123.648682309606;6145.446909778141;6147.262328520427;6158.507319414346;5193.662411943212;6135.294441139326;6197.225346831646;6201.224846894138;6260.998240281533;6102.145699602148;6126.479249263684;6133.018717005258;6152;6152.661603611844;6083.178770865877;6240.843978900564;6248.12526246335;6256.937430625818;6267.749290028348;5963.2844058713235;6016.669083200466;6049.3950604939155;6051.7579296827635;6065.090236464565 21:07:22 INFO - PROCESS | 1945 | |1;ext.html;492.2640652224924;495.44510148633526;525.5847880174662;528.5797790756349;531.779311585692;25616.87191564042;30524.694753052463;38546.03634909125;39689.801550992204;39955.20089598206;41277.761667149956;41676;41753.58246417535;41786.37320440188;41804.95487612811;9686.66096686616;9843.704688859345;9863.802723945517;9873.456959867204;9897.554610042529;8683.261922736576;8885.333599979995;11832.704182395466;12092.33492157931;12134.211276267059;12056.879431205707;12166;12169.634910952685;12173.147879648428;12183.32991685457;8784.341174411944;12085.818712719316;12157.392130393446;12161.391930403444;12190.512379504853;8668.8699669505;11740.88259117415;11967.341796201206;11984;12221.93889030558;39456.21087578261;40144;40173;40185;40276;2927.956080658792;3364.7812892162174;3398.915027124317;3406.3357645259184;3419.452887537982;29563.852180739173;29626;30179.849100754356;30213.395732085453;30215.848920755256;2874.2239595309356;3172.6351469581064;3207.486802111651;3221.387936292097;3313.1717070732316;492652;492965;494256;494859;495677;52403.47596523986;52599.21101183485;52629.7368513155;52654;52674.47325526696;29907.953221637137;33414;34004.80983165577;34192;35396.64603353985;16087.758683619755;16239.269232884548;16259.024458532525;16270.75593866093;16361.936474129143;11241.775164496828;11466.369349685847;12409.503619855104;12519.3740312984;12548.435320410603;17940.372086976895;18029.639407211784;18119.818801812078;18323.90838045801;18724.063796810104;6912.688928998207;7030.472714546429;7173.6771845267085;7929.405294602928;7957.681692732226;866.7616405488541;925.9305552083621;933.3886304470583;953.8378475659155;977.6431602465049;28304.15087547377;28508.85745571259;29746.702532974392;29908.76596595587;29986.85006574953;1054.3989925742408;1102.9724256893642;1105.5080489182237;1132.1961407400672;1194.6595220362155;14594;15158.696826063417;15166.165860877758;15226.886074438062;15514.456994005155;657736;665940;668829;669319;669730;55164.44835551673;55640.44359556353;55796.16305755417;55835;56023.719881400335;1239.8450193725785;1260.8865202131851;1264.607971528829;1367.1660287224786;1393.5540626999264;28656.570151448163;29931.85034074816;30669.8466507666;31413.214669633442;31825.68174318227;50747.492525074274;51352.74323628358;51396;51512.74243628908;51540.74229628828;580872.5822013974;584952;584958;585663;586105;25162.748372516042;25885.482290354463;26577.46845063049;26619.46761064729;27615.44769104647;44817.10365792731;45300.54699453095;45926.54073459356;46443.30335045045;46599;37731.11344432712;37790;37841.45489152308;39228;39253.80373098116;37315.440268395454;37441.625583744906;38356;39059;39112.413313800884;36727.26545469022;36818.26363472769;37022.074448139014;37645.435318470794;37659.11704414713;31608.36783264368;31667.20831979219;32718;33058.33883322272;33169.83415083006;23853.807309634103;24084.036638534264;25071.997120114993;25347.859346329828;25644.743552564236 21:07:22 INFO - PROCESS | 1945 | |2;jquery.html;353.1154458082506;370.85721997031135;373.34850685553715;383.0806065442937;404.6722155054406;15213.163276019828;15329.080255184697;16959.321627134916;20232.89883550584;20976.37070887872;19229.61540769184;19523.023848807537;19950.60098798027;20207.39377818664;20413.387598372035;5060.089183946888;5520.309961254843;5751.396103409144;5751.712414379285;5755.568332375088;5584.86037849053;5612.298462692163;5689.658620482764;5693.971530142344;5694.886102277952;1561.9140947247897;1562.03154044492;1562.77339785731;1563.9296231669603;1736.8176341484152;5553.694546799924;5688.516476099537;5887.558433117533;6167.537434692416;6232.376762323776;6015.157877897098;6085.330613632497;6089.878202435926;6090.8781824363705;6092.634441933498;13084.607461776162;13115.672108197372;13267.66830829237;13363.465461381533;13450.260235687034;2177.6046349016115;2260.519359819321;2279.658051292303;2340.32130682102;2899.6230490036373;9732.70801875945;10336.379817210991;10436.425996570186;12389.566365177176;15201.619959500991;1818.1182126668555;1828.7074068149032;1852.3424184414607;1862.8602854785945;1902.6670332691724;109135.45432272868;110781.23046923892;115184;118429;118879;11174.66476005721;11396.487158077907;11529.308241505536;11555.942220288845;11732;14492.710145797026;14501.419943202154;14503.709925801424;14509.782353264709;14526.418943242363;8299.709510167237;8465.068842427328;8479.321654267644;8525.062243153248;8598.097199793932;8304.252617264476;8326.542040187847;8327.292180164754;8481.321494280442;8493;4497.482789479186;4515.322701594787;4528.750918699503;4530.411046563926;4583.610393116555;1617.4015614222812;1858.5818190906937;1894.3843250943223;1903.7715474142915;1909.4367161687335;837;871.6339137562239;936.8875734911854;996.3324572536418;1049.6850944716555;16759.664806703797;21235.893820530797;21733;21744.565108697738;21787.67318490224;879.5734068976541;886.8758373827669;888.2627419242143;919.6873063158424;1002.7593377589326;10424.478776061318;11030.28303160292;11323.547058117583;11417.60038398652;11419.37193454368;563248;564796;570288.9711028946;575775;577747;76496;103006.48496757618;122859;128198.35900820437;131142.3771524564;904.380499357942;927.4018258223543;959.2613687460616;960.3853533738413;994.4928086675848;15405;18110.094495275447;18819.341323053628;19265.61468770645;19593.510162246057;53460.46539534555;53760.742299789024;54694.63263418446;55221.44778552324;56148.719256403456;74988;75314;78240.2175978233;81075.59462202652;82804.2354493912;7928.524288542706;7987.9600601998945;8203.507789532647;8218.547979861165;8405.159484051546;11424.48589813477;12267.561726243253;12664.303463309607;13198.340082995619;13302;10343;10355;11242.83135752948;11410.600628977945;11522.654320370402;10536.157107431234;11044.834327484934;11255.549778008788;11546.48040838181;11585.246958947979;11385.829212561652;11414.828777568177;11713.824292635447;11773.411329433666;11880.465379058136;7907.683692652229;8128.75613731589;8159.347252219927;8172.509649420816;8376.413651044611;8212.46618969765;10350.327228730108;11146.498407571517;11537.019353354723;11785.882141178821 21:07:22 INFO - PROCESS | 1945 | |3;mootools.html;1350.122420426723;1480.68165344451;1486.6134804950714;1506.096342194683;1875.0718394394776;7680.193579674137;8165.591720413978;8552.957235213824;8870.689525866595;8874.290056795457;8749.431286966359;8844.425112367708;8845.513496757692;8857.158569935862;8864.024957254696;2377.667126602277;2405.9518809623796;2410.4696966667393;2413.9034438622434;2414.7585241475886;2354.5761762882676;2390.4501964548076;2417.2144053182697;2418.6855708757926;2433.197044975154;2374.905003799846;2390.677258570097;2407;2411.6141417373224;2411.794997425221;2358.7995020423286;2376.5484557934024;2384.986380788158;2390.5099454611764;2391;2319.5592837360846;2353.8234632402637;2361.7874391304863;2362.1850461590725;2364.7871691547844;8841.204291613785;8904.599293031764;8977.192052715287;8984.820303593957;8995.595198216031;5161.922571161435;5370;5370.113931201347;5426.430224826376;5428.104362780136;3534.6465353464705;3697.3899306614376;3760.623937606245;3765.021094515418;3892.708046896494;1066.0938202527866;1097.3251450358052;1103.2442776697987;1123.5337335005963;1126.5493802479075;10125.392476451436;11640.941795291053;11669.416529173508;11731.53073877044;11768.823467647991;4374.5625437456;4480.843170489017;4655.092257009851;4667.953320466752;4671.672982891233;9074.727758167266;9084.18242358191;9089.590968406437;9091.681791137278;9093;5257.369115706139;5259.39516955555;5262.158054711228;5264.263003179558;5272.182811664198;4076;4248.745075295492;4397.824087036547;4515.367848501212;4909.828156014594;3724.8137593120236;3782.5650050244576;3815.1225218199415;3829.329867273216;3840.308744425974;1052.2686732720686;1171.0865524890598;1173.0439691651277;1179.1569028144745;1190.1668831817763;815.571824791989;840.260570697782;886.6719313853915;944.9952750236205;945.2107490245585;5004.899902002013;5071.39143302806;5581.413951535112;5824.970875145682;6191.907121393183;779.8730833945009;891.2869704236584;899.581694512042;917.8485549884327;954.4321128928276;3810.2189051244427;3813.466114743938;3921.431392448079;4035.878923632296;4049.250888585621;10626.14990800734;10947.56209751601;11036.834447483294;11072.058874995555;11076.446177691083;10819.56721731122;10955.233133680566;11035.558577656964;11042.668719938414;11073.224874258725;8101.513909165469;8429.662813487514;8430.156984301644;8437.704680336281;8440.366972477212;5747.74135163927;5782.681952492653;5811.27359080115;5934.406559344031;6011.489023433057;10260.639228327782;10375.94812025935;10407.791844163226;10432.956704329506;10509.054185123376;9361.719148425558;10207.89792102099;10606.992335728093;10614;10621.575136994434;6558.672066396756;6814.591124532544;6859.828504287433;6981.3367730065565;7088.2202957675645;8280.254777070093;8288.461250018729;8292.212239837207;8369.163083691825;8395.832083358177;7269.345758881726;7301.3428791406905;7340.302671246223;7386.4090872728975;7444.702211911679;7043.471739619446;7075.787726368218;7097.396721278749;7121.465890058163;7194.532355396883;7032.437405007689;7129;7136.536125151849;7141.892871606826;7145.071140751877;4916.508349165055;4933.728644924564;5052.1411360069615;5113.335266415343;5233.973830130825;5053.938672878589;5057.216131499624;5137.768800403916;5266.920996184984;5296.629235953446 21:07:22 INFO - PROCESS | 1945 | |4;prototype.html;304.83995902151366;306.5554945329272;307.82915481907537;313.9466290730576;315.4668610049017;5422.891542169159;5487.945120548793;5508.669479831213;5518;5526.253955715977;5420.620556561043;5437.809676661318;5455.699936503501;5455.8363249102495;5459;3258.9837050814713;3912.100216950103;4018.276710192164;4053.7973101344814;4085.162541678949;3290.522874183242;3769.5664998525244;4140.047789008529;4197.643200327976;4261.211675839964;3356.2616224430585;3797.6392242736897;3932.842686292545;4096.918061638766;4141.647959923395;3741.7942013189263;3774.245150969817;3872.4965754452023;4145.7719825409595;4176.60322269384;3493.930121397583;3598.442241452553;3600.7659502132537;3624.2932628137523;3644.9271014579826;4589.701669391479;5016.523430274118;5332.533553272842;5336.279602253685;5339.558319253819;3821.4458903458844;4331.805068771912;4368.301071828524;4481.753503557303;4801.927971080437;4621.445426548836;5057.5701065409485;5610.915836262459;5647.261078376984;5701.743421546041;3323.7839540429795;3538.1862171700654;3830.655241028293;4026.295398305285;4035.2131334389805;5373.1402975524115;5660.971695141498;5702.177422176008;5816.97091514544;5997.610155339889;3283.0971482841933;3725.403935370328;4068.9389659155136;4068.959310406858;4104.507459104927;3489.755717099779;4156.9792151039055;4157.792110394529;4160.438340824011;4162.771047592411;4322.995518114943;4555.794989225493;4791.544803243686;4807.18277892759;4832.855014349575;4999.600031997432;5458.235846981426;5752.913706294409;5759.942400576025;5829.8251052468495;1387.5906607550594;1408.7039923270615;1418.44680574576;1418.7375335562954;1423.288355822089;692.7886994466736;858.8234119256658;865.9610317535726;876.1676407412983;881.7707396076938;4622.907541849211;5031.345925029723;5165.431802501722;5201.921971170435;5348.786048558092;5838.591298609056;5855.716270654448;5899.498542623839;5900.557458190567;5913.733881975321;5003.424606170264;5111.539961403491;5233.502817232356;5324.866878328073;5361.678299302054;2552.3108760634523;2574.4336246025846;2688.811783175159;3077.6768439313996;3088.567600535927;4843.588294994895;5499.312585926759;5717.055231889983;6071.301800293023;6072.574919755575;4684.531546845288;5650.3219613646625;5996.1005849122985;6038.818835434944;6064.332308615166;5072.949270507248;5471.042567550663;5967.6121052131475;6055.184339282343;6087.908681369694;5175.741212939262;5300.334277425617;5839.656878917788;5869.7945571904775;5883.235179426818;5149.845504634867;5702.230198923092;5794.565407594531;5821.835632873357;5830.154627579062;4590.586847183769;5592.337019252396;6029.397060293935;6038.969805150946;6059.757609695563;3838.3091043612417;3975.960240397559;4008.6392224699916;4009.8195581199498;4022.9798851005557;4947.604191664586;5579.381979225979;5800.1299805029585;5840.182374467663;5851.824445266649;4737.952620473889;4754.169644686751;5439.864003399788;5707.1476753192255;5734.426557344399;4687.859364219079;5013.172826483589;5106.642535022661;5183.93729285488;5683.204351390726;5558.471945165203;5564.221009058654;5581.916271255853;5588.804391846266;5591.720413979366;4976.925346119739;5338.2526446298325;5515.262692251928;5550.583706221969;5557.277553917965;5584.877746456321;5588.2837912787545;5588.776448941997;5604.169894203401;5618.269624948731 21:07:22 INFO - PROCESS | 1945 | |5;yui.html;627.9748810047598;735.5880706804187;745.5042396806124;781.8905353250542;787.5432249295409;14870.553883383502;16234.350625974947;16274.349026038944;16278.91860540697;16286.42997495088;14323.427062917472;14450.927745361285;14465.78301325481;14494.5651630451;14715.926420367883;674.3155696967582;694.4479139084415;701.3547536266647;830.8421399934008;858.3004851046377;675.7769935921159;676.6379986707112;676.7123972311772;833.2667252817512;863.9222469977701;699.464909344352;887.7159309021116;900.8063266397724;901.7159594727673;905.0406569036809;891.9732408027769;893.8614514750224;895.0557162193883;895.7805337692274;898.1691934960169;534.1587000474268;554.9889002219974;657.1522735671026;661.7617657643244;663.6648492511299;14064.789028164585;14676;14707.338169782386;14746.410143594243;14756.188409637465;13990.510332138429;14652.853471465256;14863.628409289746;14864.182469964147;14910.254487275593;11796.35120068396;11936.940315298369;12007;12047.278680669235;12049.879501204963;3709.7774133552075;3730.5709843367817;3738.9439158412647;3754.8310326035394;3881.9805900970314;88120;111903.44048279787;114034;114139.99999999917;114588.42705786502;10449.111825494918;10753.193510486744;10824.78350432987;11256.606018789304;11469.770604587862;21808.34574962722;22123.115075396803;22134.114635414404;22182.334529964126;22229.555408892054;6716.194056713226;7903.047962121333;7971.163027882105;8007.2793448588745;8096.190380961974;4328.7402755834755;4336.34954756789;4393.582609652078;4517.81928722854;4548.431446069241;3468.722502199818;3598.5501812273465;3600.477930700034;3604.0809593554;3606.098475381155;549.2968999680415;660.1220376898713;668.2348710726192;668.6188872342815;669.3206395508563;523.9083160446907;532.1772927722535;622.449132517725;671.8924972004554;672.3377473189003;9330.95334523323;9971.440874691292;10168.644097456554;10267.897321026843;10465.319754215952;585.6573904266052;669.1889688225509;675.857800317462;676.2426082787211;690.7513295213719;3877.3408520551575;3971.801409929492;4230.8519201827785;4439.311906654474;4780.282957556395;140651.59348406384;141456.33392525723;143255;150420.247898762;154135;116120;117538.82461175449;119468.45581214021;122028;123292.38353808352;102271.48864255632;104717;107404.62976851282;108018;116242;8906;8937.553122343987;8989.955050224708;9000.81998360016;9132.908670913206;41942.37086443767;53625.731871340395;56101.719491403914;61030.69484652548;62380.376196237456;85519;96871.03128968902;97025.54461682939;97794.51102744725;98608;11865.110116741107;11931.343776092051;12011.579594714143;12052.879471205175;12221.511139554319;13030.348482575644;13313.622720960399;13512;13520.39158237862;13650.317484125555;11964.64106076819;12088.39558022113;12210.877891220975;12481.875181248435;12496.375181240719;11163;12277.754444910874;13394.799078014032;13520.864791352355;13936.651583710083;12149.088818338483;12169.939150304192;12171.695707607381;12325.322107284186;12694.428750706425;10610.416427096583;11208.27146235492;11292.548298068314;11292.830607540729;11861.347625880315;11274.60538881168;11382.54469821198;11410.201285910238;11510.482028308914;11609.709757256136 21:07:22 INFO - PROCESS | 1945 | __end_tp_report 21:07:22 INFO - PROCESS | 1945 | __start_cc_report 21:07:22 INFO - PROCESS | 1945 | _x_x_mozilla_cycle_collect,1649 21:07:22 INFO - PROCESS | 1945 | __end_cc_report 21:07:22 INFO - PROCESS | 1945 | __startTimestamp1473826042085__endTimestamp 21:07:22 INFO - PROCESS | 1945 | 21:07:22 INFO - PROCESS | 1945 | ------- Summary: start ------- 21:07:22 INFO - PROCESS | 1945 | Number of tests: 6 21:07:22 INFO - PROCESS | 1945 | 21:07:22 INFO - PROCESS | 1945 | [#0] dojo.html Cycles:165 Average:5799.96 Median:6065.09 stddev:645.66 (10.6%) stddev-sans-first:615.41 21:07:22 INFO - PROCESS | 1945 | Values: 3231.8 3255.1 3306.6 3332.9 3389.2 5654.7 5760.5 5769.6 5892.4 5921.6 5717.6 5826.5 5843.1 5888.8 5954.5 5225.3 5245.5 5275.5 5321.5 5354.8 5374.2 5395.8 5411.5 5412.2 5424.8 4542.5 5204.1 5248.3 5392.7 5395.8 4414.5 5236.6 5279.7 5284.4 5302.1 5215.8 5235.9 5245.6 5248.5 5293.3 5806.0 5881.2 5892.4 5909.9 5940.7 6111.7 6178.4 6187.2 6254.0 6313.3 6200.8 6238.7 6246.2 6273.6 6285.4 5906.2 5929.7 5931.4 5955.3 5987.0 6173.0 6177.8 6245.9 6251.6 6288.5 6183.8 6225.9 6232.5 6239.4 6259.1 6191.9 6211.7 6298.7 6300.7 6303.6 6118.8 6176.5 6309.1 6317.9 6330.0 6232.1 6282.2 6293.2 6332.1 6367.7 5049.9 5055.4 5057.7 5067.2 5100.2 4558.7 4576.7 4577.9 4581.5 4616.7 5581.7 5698.2 5701.0 5778.5 5823.2 6266.2 6267.3 6277.7 6291.9 6320.1 5845.8 5864.5 5867.4 5870.6 5923.8 5319.8 5459.1 5487.4 5519.7 5524.3 5662.9 6091.8 6268.5 6279.3 6288.2 6206.4 6225.3 6245.2 6271.2 6271.9 6320.7 6323.2 6330.1 6344.0 6350.5 6234.4 6268.1 6275.5 6281.7 6282.8 6121.0 6221.3 6285.0 6292.0 6318.0 6033.4 6123.6 6145.4 6147.3 6158.5 5193.7 6135.3 6197.2 6201.2 6261.0 6102.1 6126.5 6133.0 6152.0 6152.7 6083.2 6240.8 6248.1 6256.9 6267.7 5963.3 6016.7 6049.4 6051.8 6065.1 21:07:22 INFO - PROCESS | 1945 | 21:07:22 INFO - PROCESS | 1945 | [#1] ext.html Cycles:180 Average:70064.18 Median:18805.73 stddev:156818.39 (833.9%) stddev-sans-first:157171.31 21:07:22 INFO - PROCESS | 1945 | Values: 492.3 495.4 525.6 528.6 531.8 25616.9 30524.7 38546.0 39689.8 39955.2 41277.8 41676.0 41753.6 41786.4 41805.0 9686.7 9843.7 9863.8 9873.5 9897.6 8683.3 8885.3 11832.7 12092.3 12134.2 12056.9 12166.0 12169.6 12173.1 12183.3 8784.3 12085.8 12157.4 12161.4 12190.5 8668.9 11740.9 11967.3 11984.0 12221.9 39456.2 40144.0 40173.0 40185.0 40276.0 2928.0 3364.8 3398.9 3406.3 3419.5 29563.9 29626.0 30179.8 30213.4 30215.8 2874.2 3172.6 3207.5 3221.4 3313.2 492652.0 492965.0 494256.0 494859.0 495677.0 52403.5 52599.2 52629.7 52654.0 52674.5 29908.0 33414.0 34004.8 34192.0 35396.6 16087.8 16239.3 16259.0 16270.8 16361.9 11241.8 11466.4 12409.5 12519.4 12548.4 17940.4 18029.6 18119.8 18323.9 18724.1 6912.7 7030.5 7173.7 7929.4 7957.7 866.8 925.9 933.4 953.8 977.6 28304.2 28508.9 29746.7 29908.8 29986.9 1054.4 1103.0 1105.5 1132.2 1194.7 14594.0 15158.7 15166.2 15226.9 15514.5 657736.0 665940.0 668829.0 669319.0 669730.0 55164.4 55640.4 55796.2 55835.0 56023.7 1239.8 1260.9 1264.6 1367.2 1393.6 28656.6 29931.9 30669.8 31413.2 31825.7 50747.5 51352.7 51396.0 51512.7 51540.7 580872.6 584952.0 584958.0 585663.0 586105.0 25162.7 25885.5 26577.5 26619.5 27615.4 44817.1 45300.5 45926.5 46443.3 46599.0 37731.1 37790.0 37841.5 39228.0 39253.8 37315.4 37441.6 38356.0 39059.0 39112.4 36727.3 36818.3 37022.1 37645.4 37659.1 31608.4 31667.2 32718.0 33058.3 33169.8 23853.8 24084.0 25072.0 25347.9 25644.7 21:07:22 INFO - PROCESS | 1945 | 21:07:22 INFO - PROCESS | 1945 | [#2] jquery.html Cycles:180 Average:33265.19 Median:21484.45 stddev:95162.45 (442.9%) stddev-sans-first:95397.32 21:07:22 INFO - PROCESS | 1945 | Values: 353.1 370.9 373.3 383.1 404.7 15213.2 15329.1 16959.3 20232.9 20976.4 19229.6 19523.0 19950.6 20207.4 20413.4 5060.1 5520.3 5751.4 5751.7 5755.6 5584.9 5612.3 5689.7 5694.0 5694.9 1561.9 1562.0 1562.8 1563.9 1736.8 5553.7 5688.5 5887.6 6167.5 6232.4 6015.2 6085.3 6089.9 6090.9 6092.6 13084.6 13115.7 13267.7 13363.5 13450.3 2177.6 2260.5 2279.7 2340.3 2899.6 9732.7 10336.4 10436.4 12389.6 15201.6 1818.1 1828.7 1852.3 1862.9 1902.7 109135.5 110781.2 115184.0 118429.0 118879.0 11174.7 11396.5 11529.3 11555.9 11732.0 14492.7 14501.4 14503.7 14509.8 14526.4 8299.7 8465.1 8479.3 8525.1 8598.1 8304.3 8326.5 8327.3 8481.3 8493.0 4497.5 4515.3 4528.8 4530.4 4583.6 1617.4 1858.6 1894.4 1903.8 1909.4 837.0 871.6 936.9 996.3 1049.7 16759.7 21235.9 21733.0 21744.6 21787.7 879.6 886.9 888.3 919.7 1002.8 10424.5 11030.3 11323.5 11417.6 11419.4 563248.0 564796.0 570289.0 575775.0 577747.0 76496.0 103006.5 122859.0 128198.4 131142.4 904.4 927.4 959.3 960.4 994.5 15405.0 18110.1 18819.3 19265.6 19593.5 53460.5 53760.7 54694.6 55221.4 56148.7 74988.0 75314.0 78240.2 81075.6 82804.2 7928.5 7988.0 8203.5 8218.5 8405.2 11424.5 12267.6 12664.3 13198.3 13302.0 10343.0 10355.0 11242.8 11410.6 11522.7 10536.2 11044.8 11255.5 11546.5 11585.2 11385.8 11414.8 11713.8 11773.4 11880.5 7907.7 8128.8 8159.3 8172.5 8376.4 8212.5 10350.3 11146.5 11537.0 11785.9 21:07:22 INFO - PROCESS | 1945 | 21:07:22 INFO - PROCESS | 1945 | [#3] mootools.html Cycles:180 Average:5683.38 Median:4969.31 stddev:3208.12 (64.6%) stddev-sans-first:3200.59 21:07:22 INFO - PROCESS | 1945 | Values: 1350.1 1480.7 1486.6 1506.1 1875.1 7680.2 8165.6 8553.0 8870.7 8874.3 8749.4 8844.4 8845.5 8857.2 8864.0 2377.7 2406.0 2410.5 2413.9 2414.8 2354.6 2390.5 2417.2 2418.7 2433.2 2374.9 2390.7 2407.0 2411.6 2411.8 2358.8 2376.5 2385.0 2390.5 2391.0 2319.6 2353.8 2361.8 2362.2 2364.8 8841.2 8904.6 8977.2 8984.8 8995.6 5161.9 5370.0 5370.1 5426.4 5428.1 3534.6 3697.4 3760.6 3765.0 3892.7 1066.1 1097.3 1103.2 1123.5 1126.5 10125.4 11640.9 11669.4 11731.5 11768.8 4374.6 4480.8 4655.1 4668.0 4671.7 9074.7 9084.2 9089.6 9091.7 9093.0 5257.4 5259.4 5262.2 5264.3 5272.2 4076.0 4248.7 4397.8 4515.4 4909.8 3724.8 3782.6 3815.1 3829.3 3840.3 1052.3 1171.1 1173.0 1179.2 1190.2 815.6 840.3 886.7 945.0 945.2 5004.9 5071.4 5581.4 5825.0 6191.9 779.9 891.3 899.6 917.8 954.4 3810.2 3813.5 3921.4 4035.9 4049.3 10626.1 10947.6 11036.8 11072.1 11076.4 10819.6 10955.2 11035.6 11042.7 11073.2 8101.5 8429.7 8430.2 8437.7 8440.4 5747.7 5782.7 5811.3 5934.4 6011.5 10260.6 10375.9 10407.8 10433.0 10509.1 9361.7 10207.9 10607.0 10614.0 10621.6 6558.7 6814.6 6859.8 6981.3 7088.2 8280.3 8288.5 8292.2 8369.2 8395.8 7269.3 7301.3 7340.3 7386.4 7444.7 7043.5 7075.8 7097.4 7121.5 7194.5 7032.4 7129.0 7136.5 7141.9 7145.1 4916.5 4933.7 5052.1 5113.3 5234.0 5053.9 5057.2 5137.8 5266.9 5296.6 21:07:22 INFO - PROCESS | 1945 | 21:07:22 INFO - PROCESS | 1945 | [#4] prototype.html Cycles:180 Average:4571.17 Median:5157.64 stddev:1415.48 (27.4%) stddev-sans-first:1382.76 21:07:22 INFO - PROCESS | 1945 | Values: 304.8 306.6 307.8 313.9 315.5 5422.9 5487.9 5508.7 5518.0 5526.3 5420.6 5437.8 5455.7 5455.8 5459.0 3259.0 3912.1 4018.3 4053.8 4085.2 3290.5 3769.6 4140.0 4197.6 4261.2 3356.3 3797.6 3932.8 4096.9 4141.6 3741.8 3774.2 3872.5 4145.8 4176.6 3493.9 3598.4 3600.8 3624.3 3644.9 4589.7 5016.5 5332.5 5336.3 5339.6 3821.4 4331.8 4368.3 4481.8 4801.9 4621.4 5057.6 5610.9 5647.3 5701.7 3323.8 3538.2 3830.7 4026.3 4035.2 5373.1 5661.0 5702.2 5817.0 5997.6 3283.1 3725.4 4068.9 4069.0 4104.5 3489.8 4157.0 4157.8 4160.4 4162.8 4323.0 4555.8 4791.5 4807.2 4832.9 4999.6 5458.2 5752.9 5759.9 5829.8 1387.6 1408.7 1418.4 1418.7 1423.3 692.8 858.8 866.0 876.2 881.8 4622.9 5031.3 5165.4 5201.9 5348.8 5838.6 5855.7 5899.5 5900.6 5913.7 5003.4 5111.5 5233.5 5324.9 5361.7 2552.3 2574.4 2688.8 3077.7 3088.6 4843.6 5499.3 5717.1 6071.3 6072.6 4684.5 5650.3 5996.1 6038.8 6064.3 5072.9 5471.0 5967.6 6055.2 6087.9 5175.7 5300.3 5839.7 5869.8 5883.2 5149.8 5702.2 5794.6 5821.8 5830.2 4590.6 5592.3 6029.4 6039.0 6059.8 3838.3 3976.0 4008.6 4009.8 4023.0 4947.6 5579.4 5800.1 5840.2 5851.8 4738.0 4754.2 5439.9 5707.1 5734.4 4687.9 5013.2 5106.6 5183.9 5683.2 5558.5 5564.2 5581.9 5588.8 5591.7 4976.9 5338.3 5515.3 5550.6 5557.3 5584.9 5588.3 5588.8 5604.2 5618.3 21:07:22 INFO - PROCESS | 1945 | 21:07:22 INFO - PROCESS | 1945 | [#5] yui.html Cycles:180 Average:24214.07 Median:22205.94 stddev:38566.86 (173.7%) stddev-sans-first:38634.39 21:07:22 INFO - PROCESS | 1945 | Values: 628.0 735.6 745.5 781.9 787.5 14870.6 16234.4 16274.3 16278.9 16286.4 14323.4 14450.9 14465.8 14494.6 14715.9 674.3 694.4 701.4 830.8 858.3 675.8 676.6 676.7 833.3 863.9 699.5 887.7 900.8 901.7 905.0 892.0 893.9 895.1 895.8 898.2 534.2 555.0 657.2 661.8 663.7 14064.8 14676.0 14707.3 14746.4 14756.2 13990.5 14652.9 14863.6 14864.2 14910.3 11796.4 11936.9 12007.0 12047.3 12049.9 3709.8 3730.6 3738.9 3754.8 3882.0 88120.0 111903.4 114034.0 114140.0 114588.4 10449.1 10753.2 10824.8 11256.6 11469.8 21808.3 22123.1 22134.1 22182.3 22229.6 6716.2 7903.0 7971.2 8007.3 8096.2 4328.7 4336.3 4393.6 4517.8 4548.4 3468.7 3598.6 3600.5 3604.1 3606.1 549.3 660.1 668.2 668.6 669.3 523.9 532.2 622.4 671.9 672.3 9331.0 9971.4 10168.6 10267.9 10465.3 585.7 669.2 675.9 676.2 690.8 3877.3 3971.8 4230.9 4439.3 4780.3 140651.6 141456.3 143255.0 150420.2 154135.0 116120.0 117538.8 119468.5 122028.0 123292.4 102271.5 104717.0 107404.6 108018.0 116242.0 8906.0 8937.6 8990.0 9000.8 9132.9 41942.4 53625.7 56101.7 61030.7 62380.4 85519.0 96871.0 97025.5 97794.5 98608.0 11865.1 11931.3 12011.6 12052.9 12221.5 13030.3 13313.6 13512.0 13520.4 13650.3 11964.6 12088.4 12210.9 12481.9 12496.4 11163.0 12277.8 13394.8 13520.9 13936.7 12149.1 12169.9 12171.7 12325.3 12694.4 10610.4 11208.3 11292.5 11292.8 11861.3 11274.6 11382.5 11410.2 11510.5 11609.7 21:07:22 INFO - PROCESS | 1945 | -------- Summary: end -------- 21:07:22 INFO - PROCESS | 1945 | 21:07:22 INFO - TEST-INFO | 1945: exit 0 21:07:22 INFO - TEST-OK | dromaeo_css | took 1117850ms 21:07:22 INFO - TEST-START | kraken 21:07:22 INFO - operating with platform_type : mac_ 21:07:22 INFO - Initialising browser for kraken test... 21:07:22 INFO - TEST-INFO | started process 1948 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/tmpcWEWBr/profile http://localhost:56067/getInfo.html) 21:07:25 INFO - PROCESS | 1948 | __metrics Screen width/height:1600/1200 21:07:25 INFO - PROCESS | 1948 | colorDepth:24 21:07:25 INFO - PROCESS | 1948 | Browser inner width/height: 1024/689 21:07:25 INFO - PROCESS | 1948 | __metrics 21:07:25 INFO - PROCESS | 1948 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:07:25 INFO - PROCESS | 1948 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:07:25 INFO - TEST-INFO | 1948: exit 0 21:07:25 INFO - Browser initialized. 21:07:25 INFO - Running cycle 1/1 for kraken test... 21:07:25 INFO - TEST-INFO | started process 1949 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/tmpcWEWBr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:07:38 INFO - PROCESS | 1949 | RSS: Main: 229220352 21:07:38 INFO - PROCESS | 1949 | 21:07:40 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56067/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56067/tests/kraken/driver.html?testName=audio-beat-detection) 21:07:41 INFO - PROCESS | 1949 | RSS: Main: 290668544 21:07:41 INFO - PROCESS | 1949 | 21:07:44 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56067/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56067/tests/kraken/driver.html?testName=audio-dft) 21:07:45 INFO - PROCESS | 1949 | RSS: Main: 291860480 21:07:45 INFO - PROCESS | 1949 | 21:07:48 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56067/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56067/tests/kraken/driver.html?testName=audio-fft) 21:07:49 INFO - PROCESS | 1949 | RSS: Main: 380944384 21:07:49 INFO - PROCESS | 1949 | 21:07:51 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56067/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56067/tests/kraken/driver.html?testName=audio-oscillator) 21:07:51 INFO - PROCESS | 1949 | RSS: Main: 281407488 21:07:51 INFO - PROCESS | 1949 | 21:07:54 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56067/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56067/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:07:54 INFO - PROCESS | 1949 | RSS: Main: 286150656 21:07:54 INFO - PROCESS | 1949 | 21:07:57 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56067/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56067/tests/kraken/driver.html?testName=imaging-darkroom) 21:07:57 INFO - PROCESS | 1949 | RSS: Main: 322609152 21:07:57 INFO - PROCESS | 1949 | 21:08:00 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56067/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56067/tests/kraken/driver.html?testName=imaging-desaturate) 21:08:01 INFO - PROCESS | 1949 | RSS: Main: 325132288 21:08:01 INFO - PROCESS | 1949 | 21:08:04 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56067/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56067/tests/kraken/driver.html?testName=json-parse-financial) 21:08:04 INFO - PROCESS | 1949 | RSS: Main: 322527232 21:08:04 INFO - PROCESS | 1949 | 21:08:06 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56067/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56067/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:08:06 INFO - PROCESS | 1949 | RSS: Main: 298262528 21:08:06 INFO - PROCESS | 1949 | 21:08:08 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56067/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56067/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:08:09 INFO - PROCESS | 1949 | RSS: Main: 302153728 21:08:09 INFO - PROCESS | 1949 | 21:08:11 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56067/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56067/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:08:12 INFO - PROCESS | 1949 | RSS: Main: 308981760 21:08:12 INFO - PROCESS | 1949 | 21:08:15 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56067/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56067/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:08:15 INFO - PROCESS | 1949 | RSS: Main: 320544768 21:08:15 INFO - PROCESS | 1949 | 21:08:18 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56067/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56067/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:08:19 INFO - PROCESS | 1949 | RSS: Main: 316547072 21:08:19 INFO - PROCESS | 1949 | 21:08:21 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56067/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56067/tests/kraken/driver.html?testName=ai-astar) 21:08:21 INFO - PROCESS | 1949 | RSS: Main: 360480768 21:08:21 INFO - PROCESS | 1949 | 21:08:21 INFO - PROCESS | 1949 | __start_tp_report 21:08:21 INFO - PROCESS | 1949 | _x_x_mozilla_page_load 21:08:21 INFO - PROCESS | 1949 | _x_x_mozilla_page_load_details 21:08:21 INFO - PROCESS | 1949 | |i|pagename|runs| 21:08:21 INFO - PROCESS | 1949 | |0;ai-astar;106;112;112;113;111;112;113;111;112;111 21:08:21 INFO - PROCESS | 1949 | |1;audio-beat-detection;150;107;108;147;110;109;108;133;144;109 21:08:21 INFO - PROCESS | 1949 | |2;audio-dft;184;185;184;185;209;260;215;184;180;181 21:08:21 INFO - PROCESS | 1949 | |3;audio-fft;80;60;58;89;61;59;58;58;82;57 21:08:21 INFO - PROCESS | 1949 | |4;audio-oscillator;85;72;92;69;68;68;95;93;97;121 21:08:21 INFO - PROCESS | 1949 | |5;imaging-gaussian-blur;86;83;86;84;86;83;86;83;86;83 21:08:21 INFO - PROCESS | 1949 | |6;imaging-darkroom;94;92;92;93;92;93;93;92;93;93 21:08:21 INFO - PROCESS | 1949 | |7;imaging-desaturate;85;84;84;90;113;84;85;83;84;81 21:08:21 INFO - PROCESS | 1949 | |8;json-parse-financial;58;55;55;53;53;56;54;54;55;54 21:08:21 INFO - PROCESS | 1949 | |9;json-stringify-tinderbox;64;66;75;82;75;73;70;70;69;70 21:08:21 INFO - PROCESS | 1949 | |10;stanford-crypto-aes;86;87;87;84;84;87;84;87;90;90 21:08:21 INFO - PROCESS | 1949 | |11;stanford-crypto-ccm;151;143;153;148;148;129;141;150;188;127 21:08:21 INFO - PROCESS | 1949 | |12;stanford-crypto-pbkdf2;166;233;213;171;172;172;168;171;169;170 21:08:21 INFO - PROCESS | 1949 | |13;stanford-crypto-sha256-iterative;67;68;68;66;66;67;67;67;65;65 21:08:21 INFO - PROCESS | 1949 | __end_tp_report 21:08:21 INFO - PROCESS | 1949 | __start_cc_report 21:08:21 INFO - PROCESS | 1949 | _x_x_mozilla_cycle_collect,1989 21:08:21 INFO - PROCESS | 1949 | __end_cc_report 21:08:21 INFO - PROCESS | 1949 | __startTimestamp1473826101531__endTimestamp 21:08:21 INFO - PROCESS | 1949 | 21:08:21 INFO - PROCESS | 1949 | ------- Summary: start ------- 21:08:21 INFO - PROCESS | 1949 | Number of tests: 14 21:08:21 INFO - PROCESS | 1949 | 21:08:21 INFO - PROCESS | 1949 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:2.00 (1.8%) stddev-sans-first:0.78 21:08:21 INFO - PROCESS | 1949 | Values: 106.0 112.0 112.0 113.0 111.0 112.0 113.0 111.0 112.0 111.0 21:08:21 INFO - PROCESS | 1949 | 21:08:21 INFO - PROCESS | 1949 | [#1] audio-beat-detection Cycles:10 Average:122.50 Median:121.50 stddev:18.59 (15.3%) stddev-sans-first:16.85 21:08:21 INFO - PROCESS | 1949 | Values: 150.0 107.0 108.0 147.0 110.0 109.0 108.0 133.0 144.0 109.0 21:08:21 INFO - PROCESS | 1949 | 21:08:21 INFO - PROCESS | 1949 | [#2] audio-dft Cycles:10 Average:196.70 Median:185.00 stddev:25.33 (13.7%) stddev-sans-first:26.45 21:08:21 INFO - PROCESS | 1949 | Values: 184.0 185.0 184.0 185.0 209.0 260.0 215.0 184.0 180.0 181.0 21:08:21 INFO - PROCESS | 1949 | 21:08:21 INFO - PROCESS | 1949 | [#3] audio-fft Cycles:10 Average:66.20 Median:60.50 stddev:12.31 (20.3%) stddev-sans-first:12.00 21:08:21 INFO - PROCESS | 1949 | Values: 80.0 60.0 58.0 89.0 61.0 59.0 58.0 58.0 82.0 57.0 21:08:21 INFO - PROCESS | 1949 | 21:08:21 INFO - PROCESS | 1949 | [#4] audio-oscillator Cycles:10 Average:86.00 Median:88.50 stddev:17.15 (19.4%) stddev-sans-first:18.18 21:08:21 INFO - PROCESS | 1949 | Values: 85.0 72.0 92.0 69.0 68.0 68.0 95.0 93.0 97.0 121.0 21:08:21 INFO - PROCESS | 1949 | 21:08:21 INFO - PROCESS | 1949 | [#5] imaging-gaussian-blur Cycles:10 Average:84.60 Median:86.00 stddev:1.51 (1.8%) stddev-sans-first:1.51 21:08:21 INFO - PROCESS | 1949 | Values: 86.0 83.0 86.0 84.0 86.0 83.0 86.0 83.0 86.0 83.0 21:08:21 INFO - PROCESS | 1949 | 21:08:21 INFO - PROCESS | 1949 | [#6] imaging-darkroom Cycles:10 Average:92.70 Median:93.00 stddev:0.67 (0.7%) stddev-sans-first:0.53 21:08:21 INFO - PROCESS | 1949 | Values: 94.0 92.0 92.0 93.0 92.0 93.0 93.0 92.0 93.0 93.0 21:08:21 INFO - PROCESS | 1949 | 21:08:21 INFO - PROCESS | 1949 | [#7] imaging-desaturate Cycles:10 Average:87.30 Median:84.00 stddev:9.31 (11.1%) stddev-sans-first:9.84 21:08:21 INFO - PROCESS | 1949 | Values: 85.0 84.0 84.0 90.0 113.0 84.0 85.0 83.0 84.0 81.0 21:08:21 INFO - PROCESS | 1949 | 21:08:21 INFO - PROCESS | 1949 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:1.49 (2.7%) stddev-sans-first:1.00 21:08:21 INFO - PROCESS | 1949 | Values: 58.0 55.0 55.0 53.0 53.0 56.0 54.0 54.0 55.0 54.0 21:08:21 INFO - PROCESS | 1949 | 21:08:21 INFO - PROCESS | 1949 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:71.50 stddev:5.13 (7.2%) stddev-sans-first:4.68 21:08:21 INFO - PROCESS | 1949 | Values: 64.0 66.0 75.0 82.0 75.0 73.0 70.0 70.0 69.0 70.0 21:08:21 INFO - PROCESS | 1949 | 21:08:21 INFO - PROCESS | 1949 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:87.00 stddev:2.22 (2.6%) stddev-sans-first:2.35 21:08:21 INFO - PROCESS | 1949 | Values: 86.0 87.0 87.0 84.0 84.0 87.0 84.0 87.0 90.0 90.0 21:08:21 INFO - PROCESS | 1949 | 21:08:21 INFO - PROCESS | 1949 | [#11] stanford-crypto-ccm Cycles:10 Average:147.80 Median:149.00 stddev:16.71 (11.2%) stddev-sans-first:17.69 21:08:21 INFO - PROCESS | 1949 | Values: 151.0 143.0 153.0 148.0 148.0 129.0 141.0 150.0 188.0 127.0 21:08:21 INFO - PROCESS | 1949 | 21:08:21 INFO - PROCESS | 1949 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.50 Median:171.50 stddev:22.96 (13.4%) stddev-sans-first:23.75 21:08:21 INFO - PROCESS | 1949 | Values: 166.0 233.0 213.0 171.0 172.0 172.0 168.0 171.0 169.0 170.0 21:08:21 INFO - PROCESS | 1949 | 21:08:21 INFO - PROCESS | 1949 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.07 (1.6%) stddev-sans-first:1.13 21:08:21 INFO - PROCESS | 1949 | Values: 67.0 68.0 68.0 66.0 66.0 67.0 67.0 67.0 65.0 65.0 21:08:21 INFO - PROCESS | 1949 | -------- Summary: end -------- 21:08:21 INFO - PROCESS | 1949 | 21:08:22 INFO - TEST-INFO | 1949: exit 0 21:08:22 INFO - TEST-OK | kraken | took 59673ms 21:08:22 INFO - SUITE-END | took 1177s 21:08:22 INFO - Completed test suite (00:19:37) 21:08:22 INFO - javascript benchmark 21:08:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3231.8222497762645, 3255.0560337502125, 3306.6197387300467, 3332.9333413331733, 3389.169653434909, 5654.717264136787, 5760.539156867451, 5769.5672824538115, 5892.3812999635065, 5921.585489015771, 5717.571182161344, 5826.504747096502, 5843.065109582479, 5888.823335299948, 5954.493868021213, 5225.346831646044, 5245.501677340647, 5275.498827611371, 5321.467853214686, 5354.759035843396, 5374.167004114369, 5395.81114660987, 5411.485908838654, 5412.242286079952, 5424.783008679648, 4542.545745425431, 5204.063268611649, 5248.291480650101, 5392.676439413628, 5395.757190926379, 4414.53647367025, 5236.554892834114, 5279.736013199325, 5284.445133260991, 5302.125149350352, 5215.8174463893965, 5235.869103272411, 5245.554127899133, 5248.501392367719, 5293.311869456946, 5806.0129777937855, 5881.176635271066, 5892.410758924116, 5909.881802363929, 5940.732667029994, 6111.652512877612, 6178.41305076017, 6187.195664563578, 6253.968730156365, 6313.273973493061, 6200.844978875564, 6238.688065596702, 6246.187995560548, 6273.592216505958, 6285.371462853678, 5906.173135760997, 5929.673867937218, 5931.368873559805, 5955.285365756137, 5987.0, 6172.969135154295, 6177.84555386119, 6245.906311405332, 6251.59364641306, 6288.496920246369, 6183.84540386494, 6225.875482490415, 6232.501399887998, 6239.376062393815, 6259.123722678829, 6191.907121393183, 6211.65835879031, 6298.7480500780375, 6300.684965751786, 6303.558750887486, 6118.819280109603, 6176.474999625082, 6309.08518264849, 6317.936820631827, 6330.01884707871, 6232.0963460298, 6282.246130464282, 6293.150424692608, 6332.050192471166, 6367.681615919186, 5049.899002019939, 5055.418626857885, 5057.69653820772, 5067.1639179535705, 5100.234964755242, 4558.726476411426, 4576.702514336557, 4577.931331030038, 4581.450225972838, 4616.722996620147, 5581.6930068845795, 5698.17376480408, 5701.0308247598, 5778.508826749689, 5823.242978412779, 6266.154069200691, 6267.310595834455, 6277.7175027123885, 6291.874162516724, 6320.051992201206, 5845.795397161079, 5864.530837532987, 5867.413258674099, 5870.647761134345, 5923.763049478059, 5319.760610772447, 5459.12653975362, 5487.368952570426, 5519.69641669712, 5524.254225679482, 5662.85842853932, 6091.781643671372, 6268.4671802896355, 6279.340669229848, 6288.182536270256, 6206.441420272197, 6225.31521532622, 6245.156903817927, 6271.216097987752, 6271.937280627135, 6320.747170113144, 6323.177986861679, 6330.113784070142, 6344.0, 6350.523710721622, 6234.376562343729, 6268.059791031382, 6275.52933529978, 6281.71732272058, 6282.780102696383, 6120.995732433061, 6221.253449586078, 6284.962981108066, 6292.0, 6318.0, 6033.42682445167, 6123.648682309606, 6145.446909778141, 6147.262328520427, 6158.507319414346, 5193.662411943212, 6135.294441139326, 6197.225346831646, 6201.224846894138, 6260.998240281533, 6102.145699602148, 6126.479249263684, 6133.018717005258, 6152.0, 6152.661603611844, 6083.178770865877, 6240.843978900564, 6248.12526246335, 6256.937430625818, 6267.749290028348, 5963.2844058713235, 6016.669083200466, 6049.3950604939155, 6051.7579296827635, 6065.090236464565], "value": 5758.026268224201, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.2640652224924, 495.44510148633526, 525.5847880174662, 528.5797790756349, 531.779311585692, 25616.87191564042, 30524.694753052463, 38546.03634909125, 39689.801550992204, 39955.20089598206, 41277.761667149956, 41676.0, 41753.58246417535, 41786.37320440188, 41804.95487612811, 9686.66096686616, 9843.704688859345, 9863.802723945517, 9873.456959867204, 9897.554610042529, 8683.261922736576, 8885.333599979995, 11832.704182395466, 12092.33492157931, 12134.211276267059, 12056.879431205707, 12166.0, 12169.634910952685, 12173.147879648428, 12183.32991685457, 8784.341174411944, 12085.818712719316, 12157.392130393446, 12161.391930403444, 12190.512379504853, 8668.8699669505, 11740.88259117415, 11967.341796201206, 11984.0, 12221.93889030558, 39456.21087578261, 40144.0, 40173.0, 40185.0, 40276.0, 2927.956080658792, 3364.7812892162174, 3398.915027124317, 3406.3357645259184, 3419.452887537982, 29563.852180739173, 29626.0, 30179.849100754356, 30213.395732085453, 30215.848920755256, 2874.2239595309356, 3172.6351469581064, 3207.486802111651, 3221.387936292097, 3313.1717070732316, 492652.0, 492965.0, 494256.0, 494859.0, 495677.0, 52403.47596523986, 52599.21101183485, 52629.7368513155, 52654.0, 52674.47325526696, 29907.953221637137, 33414.0, 34004.80983165577, 34192.0, 35396.64603353985, 16087.758683619755, 16239.269232884548, 16259.024458532525, 16270.75593866093, 16361.936474129143, 11241.775164496828, 11466.369349685847, 12409.503619855104, 12519.3740312984, 12548.435320410603, 17940.372086976895, 18029.639407211784, 18119.818801812078, 18323.90838045801, 18724.063796810104, 6912.688928998207, 7030.472714546429, 7173.6771845267085, 7929.405294602928, 7957.681692732226, 866.7616405488541, 925.9305552083621, 933.3886304470583, 953.8378475659155, 977.6431602465049, 28304.15087547377, 28508.85745571259, 29746.702532974392, 29908.76596595587, 29986.85006574953, 1054.3989925742408, 1102.9724256893642, 1105.5080489182237, 1132.1961407400672, 1194.6595220362155, 14594.0, 15158.696826063417, 15166.165860877758, 15226.886074438062, 15514.456994005155, 657736.0, 665940.0, 668829.0, 669319.0, 669730.0, 55164.44835551673, 55640.44359556353, 55796.16305755417, 55835.0, 56023.719881400335, 1239.8450193725785, 1260.8865202131851, 1264.607971528829, 1367.1660287224786, 1393.5540626999264, 28656.570151448163, 29931.85034074816, 30669.8466507666, 31413.214669633442, 31825.68174318227, 50747.492525074274, 51352.74323628358, 51396.0, 51512.74243628908, 51540.74229628828, 580872.5822013974, 584952.0, 584958.0, 585663.0, 586105.0, 25162.748372516042, 25885.482290354463, 26577.46845063049, 26619.46761064729, 27615.44769104647, 44817.10365792731, 45300.54699453095, 45926.54073459356, 46443.30335045045, 46599.0, 37731.11344432712, 37790.0, 37841.45489152308, 39228.0, 39253.80373098116, 37315.440268395454, 37441.625583744906, 38356.0, 39059.0, 39112.413313800884, 36727.26545469022, 36818.26363472769, 37022.074448139014, 37645.435318470794, 37659.11704414713, 31608.36783264368, 31667.20831979219, 32718.0, 33058.33883322272, 33169.83415083006, 23853.807309634103, 24084.036638534264, 25071.997120114993, 25347.859346329828, 25644.743552564236], "value": 19685.504708676377, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.1154458082506, 370.85721997031135, 373.34850685553715, 383.0806065442937, 404.6722155054406, 15213.163276019828, 15329.080255184697, 16959.321627134916, 20232.89883550584, 20976.37070887872, 19229.61540769184, 19523.023848807537, 19950.60098798027, 20207.39377818664, 20413.387598372035, 5060.089183946888, 5520.309961254843, 5751.396103409144, 5751.712414379285, 5755.568332375088, 5584.86037849053, 5612.298462692163, 5689.658620482764, 5693.971530142344, 5694.886102277952, 1561.9140947247897, 1562.03154044492, 1562.77339785731, 1563.9296231669603, 1736.8176341484152, 5553.694546799924, 5688.516476099537, 5887.558433117533, 6167.537434692416, 6232.376762323776, 6015.157877897098, 6085.330613632497, 6089.878202435926, 6090.8781824363705, 6092.634441933498, 13084.607461776162, 13115.672108197372, 13267.66830829237, 13363.465461381533, 13450.260235687034, 2177.6046349016115, 2260.519359819321, 2279.658051292303, 2340.32130682102, 2899.6230490036373, 9732.70801875945, 10336.379817210991, 10436.425996570186, 12389.566365177176, 15201.619959500991, 1818.1182126668555, 1828.7074068149032, 1852.3424184414607, 1862.8602854785945, 1902.6670332691724, 109135.45432272868, 110781.23046923892, 115184.0, 118429.0, 118879.0, 11174.66476005721, 11396.487158077907, 11529.308241505536, 11555.942220288845, 11732.0, 14492.710145797026, 14501.419943202154, 14503.709925801424, 14509.782353264709, 14526.418943242363, 8299.709510167237, 8465.068842427328, 8479.321654267644, 8525.062243153248, 8598.097199793932, 8304.252617264476, 8326.542040187847, 8327.292180164754, 8481.321494280442, 8493.0, 4497.482789479186, 4515.322701594787, 4528.750918699503, 4530.411046563926, 4583.610393116555, 1617.4015614222812, 1858.5818190906937, 1894.3843250943223, 1903.7715474142915, 1909.4367161687335, 837.0, 871.6339137562239, 936.8875734911854, 996.3324572536418, 1049.6850944716555, 16759.664806703797, 21235.893820530797, 21733.0, 21744.565108697738, 21787.67318490224, 879.5734068976541, 886.8758373827669, 888.2627419242143, 919.6873063158424, 1002.7593377589326, 10424.478776061318, 11030.28303160292, 11323.547058117583, 11417.60038398652, 11419.37193454368, 563248.0, 564796.0, 570288.9711028946, 575775.0, 577747.0, 76496.0, 103006.48496757618, 122859.0, 128198.35900820437, 131142.3771524564, 904.380499357942, 927.4018258223543, 959.2613687460616, 960.3853533738413, 994.4928086675848, 15405.0, 18110.094495275447, 18819.341323053628, 19265.61468770645, 19593.510162246057, 53460.46539534555, 53760.742299789024, 54694.63263418446, 55221.44778552324, 56148.719256403456, 74988.0, 75314.0, 78240.2175978233, 81075.59462202652, 82804.2354493912, 7928.524288542706, 7987.9600601998945, 8203.507789532647, 8218.547979861165, 8405.159484051546, 11424.48589813477, 12267.561726243253, 12664.303463309607, 13198.340082995619, 13302.0, 10343.0, 10355.0, 11242.83135752948, 11410.600628977945, 11522.654320370402, 10536.157107431234, 11044.834327484934, 11255.549778008788, 11546.48040838181, 11585.246958947979, 11385.829212561652, 11414.828777568177, 11713.824292635447, 11773.411329433666, 11880.465379058136, 7907.683692652229, 8128.75613731589, 8159.347252219927, 8172.509649420816, 8376.413651044611, 8212.46618969765, 10350.327228730108, 11146.498407571517, 11537.019353354723, 11785.882141178821], "value": 8994.806021222968, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1350.122420426723, 1480.68165344451, 1486.6134804950714, 1506.096342194683, 1875.0718394394776, 7680.193579674137, 8165.591720413978, 8552.957235213824, 8870.689525866595, 8874.290056795457, 8749.431286966359, 8844.425112367708, 8845.513496757692, 8857.158569935862, 8864.024957254696, 2377.667126602277, 2405.9518809623796, 2410.4696966667393, 2413.9034438622434, 2414.7585241475886, 2354.5761762882676, 2390.4501964548076, 2417.2144053182697, 2418.6855708757926, 2433.197044975154, 2374.905003799846, 2390.677258570097, 2407.0, 2411.6141417373224, 2411.794997425221, 2358.7995020423286, 2376.5484557934024, 2384.986380788158, 2390.5099454611764, 2391.0, 2319.5592837360846, 2353.8234632402637, 2361.7874391304863, 2362.1850461590725, 2364.7871691547844, 8841.204291613785, 8904.599293031764, 8977.192052715287, 8984.820303593957, 8995.595198216031, 5161.922571161435, 5370.0, 5370.113931201347, 5426.430224826376, 5428.104362780136, 3534.6465353464705, 3697.3899306614376, 3760.623937606245, 3765.021094515418, 3892.708046896494, 1066.0938202527866, 1097.3251450358052, 1103.2442776697987, 1123.5337335005963, 1126.5493802479075, 10125.392476451436, 11640.941795291053, 11669.416529173508, 11731.53073877044, 11768.823467647991, 4374.5625437456, 4480.843170489017, 4655.092257009851, 4667.953320466752, 4671.672982891233, 9074.727758167266, 9084.18242358191, 9089.590968406437, 9091.681791137278, 9093.0, 5257.369115706139, 5259.39516955555, 5262.158054711228, 5264.263003179558, 5272.182811664198, 4076.0, 4248.745075295492, 4397.824087036547, 4515.367848501212, 4909.828156014594, 3724.8137593120236, 3782.5650050244576, 3815.1225218199415, 3829.329867273216, 3840.308744425974, 1052.2686732720686, 1171.0865524890598, 1173.0439691651277, 1179.1569028144745, 1190.1668831817763, 815.571824791989, 840.260570697782, 886.6719313853915, 944.9952750236205, 945.2107490245585, 5004.899902002013, 5071.39143302806, 5581.413951535112, 5824.970875145682, 6191.907121393183, 779.8730833945009, 891.2869704236584, 899.581694512042, 917.8485549884327, 954.4321128928276, 3810.2189051244427, 3813.466114743938, 3921.431392448079, 4035.878923632296, 4049.250888585621, 10626.14990800734, 10947.56209751601, 11036.834447483294, 11072.058874995555, 11076.446177691083, 10819.56721731122, 10955.233133680566, 11035.558577656964, 11042.668719938414, 11073.224874258725, 8101.513909165469, 8429.662813487514, 8430.156984301644, 8437.704680336281, 8440.366972477212, 5747.74135163927, 5782.681952492653, 5811.27359080115, 5934.406559344031, 6011.489023433057, 10260.639228327782, 10375.94812025935, 10407.791844163226, 10432.956704329506, 10509.054185123376, 9361.719148425558, 10207.89792102099, 10606.992335728093, 10614.0, 10621.575136994434, 6558.672066396756, 6814.591124532544, 6859.828504287433, 6981.3367730065565, 7088.2202957675645, 8280.254777070093, 8288.461250018729, 8292.212239837207, 8369.163083691825, 8395.832083358177, 7269.345758881726, 7301.3428791406905, 7340.302671246223, 7386.4090872728975, 7444.702211911679, 7043.471739619446, 7075.787726368218, 7097.396721278749, 7121.465890058163, 7194.532355396883, 7032.437405007689, 7129.0, 7136.536125151849, 7141.892871606826, 7145.071140751877, 4916.508349165055, 4933.728644924564, 5052.1411360069615, 5113.335266415343, 5233.973830130825, 5053.938672878589, 5057.216131499624, 5137.768800403916, 5266.920996184984, 5296.629235953446], "value": 4554.764891510414, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.83995902151366, 306.5554945329272, 307.82915481907537, 313.9466290730576, 315.4668610049017, 5422.891542169159, 5487.945120548793, 5508.669479831213, 5518.0, 5526.253955715977, 5420.620556561043, 5437.809676661318, 5455.699936503501, 5455.8363249102495, 5459.0, 3258.9837050814713, 3912.100216950103, 4018.276710192164, 4053.7973101344814, 4085.162541678949, 3290.522874183242, 3769.5664998525244, 4140.047789008529, 4197.643200327976, 4261.211675839964, 3356.2616224430585, 3797.6392242736897, 3932.842686292545, 4096.918061638766, 4141.647959923395, 3741.7942013189263, 3774.245150969817, 3872.4965754452023, 4145.7719825409595, 4176.60322269384, 3493.930121397583, 3598.442241452553, 3600.7659502132537, 3624.2932628137523, 3644.9271014579826, 4589.701669391479, 5016.523430274118, 5332.533553272842, 5336.279602253685, 5339.558319253819, 3821.4458903458844, 4331.805068771912, 4368.301071828524, 4481.753503557303, 4801.927971080437, 4621.445426548836, 5057.5701065409485, 5610.915836262459, 5647.261078376984, 5701.743421546041, 3323.7839540429795, 3538.1862171700654, 3830.655241028293, 4026.295398305285, 4035.2131334389805, 5373.1402975524115, 5660.971695141498, 5702.177422176008, 5816.97091514544, 5997.610155339889, 3283.0971482841933, 3725.403935370328, 4068.9389659155136, 4068.959310406858, 4104.507459104927, 3489.755717099779, 4156.9792151039055, 4157.792110394529, 4160.438340824011, 4162.771047592411, 4322.995518114943, 4555.794989225493, 4791.544803243686, 4807.18277892759, 4832.855014349575, 4999.600031997432, 5458.235846981426, 5752.913706294409, 5759.942400576025, 5829.8251052468495, 1387.5906607550594, 1408.7039923270615, 1418.44680574576, 1418.7375335562954, 1423.288355822089, 692.7886994466736, 858.8234119256658, 865.9610317535726, 876.1676407412983, 881.7707396076938, 4622.907541849211, 5031.345925029723, 5165.431802501722, 5201.921971170435, 5348.786048558092, 5838.591298609056, 5855.716270654448, 5899.498542623839, 5900.557458190567, 5913.733881975321, 5003.424606170264, 5111.539961403491, 5233.502817232356, 5324.866878328073, 5361.678299302054, 2552.3108760634523, 2574.4336246025846, 2688.811783175159, 3077.6768439313996, 3088.567600535927, 4843.588294994895, 5499.312585926759, 5717.055231889983, 6071.301800293023, 6072.574919755575, 4684.531546845288, 5650.3219613646625, 5996.1005849122985, 6038.818835434944, 6064.332308615166, 5072.949270507248, 5471.042567550663, 5967.6121052131475, 6055.184339282343, 6087.908681369694, 5175.741212939262, 5300.334277425617, 5839.656878917788, 5869.7945571904775, 5883.235179426818, 5149.845504634867, 5702.230198923092, 5794.565407594531, 5821.835632873357, 5830.154627579062, 4590.586847183769, 5592.337019252396, 6029.397060293935, 6038.969805150946, 6059.757609695563, 3838.3091043612417, 3975.960240397559, 4008.6392224699916, 4009.8195581199498, 4022.9798851005557, 4947.604191664586, 5579.381979225979, 5800.1299805029585, 5840.182374467663, 5851.824445266649, 4737.952620473889, 4754.169644686751, 5439.864003399788, 5707.1476753192255, 5734.426557344399, 4687.859364219079, 5013.172826483589, 5106.642535022661, 5183.93729285488, 5683.204351390726, 5558.471945165203, 5564.221009058654, 5581.916271255853, 5588.804391846266, 5591.720413979366, 4976.925346119739, 5338.2526446298325, 5515.262692251928, 5550.583706221969, 5557.277553917965, 5584.877746456321, 5588.2837912787545, 5588.776448941997, 5604.169894203401, 5618.269624948731], "value": 4119.275557883801, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [627.9748810047598, 735.5880706804187, 745.5042396806124, 781.8905353250542, 787.5432249295409, 14870.553883383502, 16234.350625974947, 16274.349026038944, 16278.91860540697, 16286.42997495088, 14323.427062917472, 14450.927745361285, 14465.78301325481, 14494.5651630451, 14715.926420367883, 674.3155696967582, 694.4479139084415, 701.3547536266647, 830.8421399934008, 858.3004851046377, 675.7769935921159, 676.6379986707112, 676.7123972311772, 833.2667252817512, 863.9222469977701, 699.464909344352, 887.7159309021116, 900.8063266397724, 901.7159594727673, 905.0406569036809, 891.9732408027769, 893.8614514750224, 895.0557162193883, 895.7805337692274, 898.1691934960169, 534.1587000474268, 554.9889002219974, 657.1522735671026, 661.7617657643244, 663.6648492511299, 14064.789028164585, 14676.0, 14707.338169782386, 14746.410143594243, 14756.188409637465, 13990.510332138429, 14652.853471465256, 14863.628409289746, 14864.182469964147, 14910.254487275593, 11796.35120068396, 11936.940315298369, 12007.0, 12047.278680669235, 12049.879501204963, 3709.7774133552075, 3730.5709843367817, 3738.9439158412647, 3754.8310326035394, 3881.9805900970314, 88120.0, 111903.44048279787, 114034.0, 114139.99999999917, 114588.42705786502, 10449.111825494918, 10753.193510486744, 10824.78350432987, 11256.606018789304, 11469.770604587862, 21808.34574962722, 22123.115075396803, 22134.114635414404, 22182.334529964126, 22229.555408892054, 6716.194056713226, 7903.047962121333, 7971.163027882105, 8007.2793448588745, 8096.190380961974, 4328.7402755834755, 4336.34954756789, 4393.582609652078, 4517.81928722854, 4548.431446069241, 3468.722502199818, 3598.5501812273465, 3600.477930700034, 3604.0809593554, 3606.098475381155, 549.2968999680415, 660.1220376898713, 668.2348710726192, 668.6188872342815, 669.3206395508563, 523.9083160446907, 532.1772927722535, 622.449132517725, 671.8924972004554, 672.3377473189003, 9330.95334523323, 9971.440874691292, 10168.644097456554, 10267.897321026843, 10465.319754215952, 585.6573904266052, 669.1889688225509, 675.857800317462, 676.2426082787211, 690.7513295213719, 3877.3408520551575, 3971.801409929492, 4230.8519201827785, 4439.311906654474, 4780.282957556395, 140651.59348406384, 141456.33392525723, 143255.0, 150420.247898762, 154135.0, 116120.0, 117538.82461175449, 119468.45581214021, 122028.0, 123292.38353808352, 102271.48864255632, 104717.0, 107404.62976851282, 108018.0, 116242.0, 8906.0, 8937.553122343987, 8989.955050224708, 9000.81998360016, 9132.908670913206, 41942.37086443767, 53625.731871340395, 56101.719491403914, 61030.69484652548, 62380.376196237456, 85519.0, 96871.03128968902, 97025.54461682939, 97794.51102744725, 98608.0, 11865.110116741107, 11931.343776092051, 12011.579594714143, 12052.879471205175, 12221.511139554319, 13030.348482575644, 13313.622720960399, 13512.0, 13520.39158237862, 13650.317484125555, 11964.64106076819, 12088.39558022113, 12210.877891220975, 12481.875181248435, 12496.375181240719, 11163.0, 12277.754444910874, 13394.799078014032, 13520.864791352355, 13936.651583710083, 12149.088818338483, 12169.939150304192, 12171.695707607381, 12325.322107284186, 12694.428750706425, 10610.416427096583, 11208.27146235492, 11292.548298068314, 11292.830607540729, 11861.347625880315, 11274.60538881168, 11382.54469821198, 11410.201285910238, 11510.482028308914, 11609.709757256136], "value": 7615.604312776951, "unit": "score"}], "name": "dromaeo_css", "value": 7253.950484796808, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 112.0, 113.0, 111.0, 112.0, 113.0, 111.0, 112.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 107.0, 108.0, 147.0, 110.0, 109.0, 108.0, 133.0, 144.0, 109.0], "value": 122.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 184.0, 185.0, 209.0, 260.0, 215.0, 184.0, 180.0, 181.0], "value": 196.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 58.0, 89.0, 61.0, 59.0, 58.0, 58.0, 82.0, 57.0], "value": 66.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 72.0, 92.0, 69.0, 68.0, 68.0, 95.0, 93.0, 97.0, 121.0], "value": 86.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 86.0, 84.0, 86.0, 83.0, 86.0, 83.0, 86.0, 83.0], "value": 84.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 92.0, 92.0, 93.0, 92.0, 93.0, 93.0, 92.0, 93.0, 93.0], "value": 92.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 90.0, 113.0, 84.0, 85.0, 83.0, 84.0, 81.0], "value": 87.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 55.0, 53.0, 53.0, 56.0, 54.0, 54.0, 55.0, 54.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 75.0, 82.0, 75.0, 73.0, 70.0, 70.0, 69.0, 70.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 87.0, 84.0, 84.0, 87.0, 84.0, 87.0, 90.0, 90.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 143.0, 153.0, 148.0, 148.0, 129.0, 141.0, 150.0, 188.0, 127.0], "value": 147.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 233.0, 213.0, 171.0, 172.0, 172.0, 168.0, 171.0, 169.0, 170.0], "value": 180.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 66.0, 66.0, 67.0, 67.0, 67.0, 65.0, 65.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1454.8999999999999, "alertThreshold": 2.0}]} 21:08:22 INFO - Return code: 0 21:08:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:08:22 INFO - # TBPL SUCCESS # 21:08:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:08:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:08:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:08:22 INFO - 2016-09-13 21:08:22.846 screenresolution[1953:19854] starting screenresolution argv=screenresolution get 21:08:22 INFO - 2016-09-13 21:08:22.848 screenresolution[1953:19854] Display 0: 1600x1200x32@60 21:08:22 INFO - 2016-09-13 21:08:22.854 screenresolution[1954:19857] starting screenresolution argv=screenresolution list 21:08:22 INFO - Available Modes on Display 0 21:08:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:08:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:08:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:08:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:08:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:08:23 INFO - Intel Iris: 21:08:23 INFO - Chipset Model: Intel Iris 21:08:23 INFO - Type: GPU 21:08:23 INFO - Bus: Built-In 21:08:23 INFO - VRAM (Dynamic, Max): 1536 MB 21:08:23 INFO - Vendor: Intel (0x8086) 21:08:23 INFO - Device ID: 0x0a2e 21:08:23 INFO - Revision ID: 0x0009 21:08:23 INFO - Displays: 21:08:23 INFO - Display: 21:08:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:08:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:08:23 INFO - Display Serial Number: 1600x1200 60 21:08:23 INFO - Main Display: Yes 21:08:23 INFO - Mirror: Off 21:08:23 INFO - Online: Yes 21:08:23 INFO - Rotation: Supported 21:08:23 INFO - Return code: 0 21:08:23 INFO - Running post-action listener: _resource_record_post_action 21:08:23 INFO - [mozharness: 2016-09-14 04:08:23.090207Z] Finished run-tests step (success) 21:08:23 INFO - Running post-run listener: _resource_record_post_run 21:08:23 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 8192; Write bytes: 703842304; Read time: 1; Write time: 1959 21:08:23 INFO - TinderboxPrint: CPU usage
53.6% 21:08:23 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 1 21:08:23 INFO - TinderboxPrint: I/O write bytes / time
703,842,304 / 1,959 21:08:23 INFO - TinderboxPrint: CPU idle
2,251.0 (46.4%) 21:08:23 INFO - TinderboxPrint: CPU system
965.8 (19.9%) 21:08:23 INFO - TinderboxPrint: CPU user
1,632.9 (33.7%) 21:08:23 INFO - TinderboxPrint: Swap in / out
404,299,776 / 0 21:08:23 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 401637888; Write bytes: 396322304; Read time: 29781; Write time: 809 21:08:23 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 8192; Write bytes: 294744576; Read time: 1; Write time: 1110 21:08:23 INFO - Running post-run listener: _upload_blobber_files 21:08:23 INFO - Blob upload gear active. 21:08:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:08:23 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 21:08:23 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:08:23 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:08:23 INFO - (blobuploader) - INFO - Open directory for files ... 21:08:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:08:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:08:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:08:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:08:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:08:24 INFO - (blobuploader) - INFO - Done attempting. 21:08:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:08:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:08:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:08:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:08:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:08:25 INFO - (blobuploader) - INFO - Done attempting. 21:08:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:08:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:08:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:08:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:08:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:08:28 INFO - (blobuploader) - INFO - Done attempting. 21:08:28 INFO - (blobuploader) - INFO - Iteration through files over. 21:08:28 INFO - Return code: 0 21:08:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:08:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:08:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d4ff4d0c86ff3e9d0a4ec4b1121cbd601faa82a7c2694cebf138009ed3f883b78b11b6ab24956b56b17011fbca5358eea93f1c80f9879131e3e39a3e43160757", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2b4b822912c105e092b394fab6ec6d7901976f8ecbb42e654d745f5ee6699c25054eb0519044e823c88937a5ae99c64622c01f7cc974093c0638e15278dc4436", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b0257699e9546208e755c5175bad53bd4352cfcc2a5eb0fab458d8f396d021dbb2bf856226021afe935a0edb65063d40bf05cee21179c79155d227abf65c8797"} 21:08:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:08:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:08:28 INFO - Contents: 21:08:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d4ff4d0c86ff3e9d0a4ec4b1121cbd601faa82a7c2694cebf138009ed3f883b78b11b6ab24956b56b17011fbca5358eea93f1c80f9879131e3e39a3e43160757", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2b4b822912c105e092b394fab6ec6d7901976f8ecbb42e654d745f5ee6699c25054eb0519044e823c88937a5ae99c64622c01f7cc974093c0638e15278dc4436", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b0257699e9546208e755c5175bad53bd4352cfcc2a5eb0fab458d8f396d021dbb2bf856226021afe935a0edb65063d40bf05cee21179c79155d227abf65c8797"} 21:08:28 INFO - Running post-run listener: copy_logs_to_upload_dir 21:08:28 INFO - Copying logs to upload dir... 21:08:28 INFO - mkdir: /builds/slave/test/build/upload/logs 21:08:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.784602 ========= master_lag: 0.28 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-09-13 21:08:28.762139) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-13 21:08:28.765536) ========= 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.UeUPak7Ku0/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.r2Ghu0AYnV/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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/Autoland/sha512/d4ff4d0c86ff3e9d0a4ec4b1121cbd601faa82a7c2694cebf138009ed3f883b78b11b6ab24956b56b17011fbca5358eea93f1c80f9879131e3e39a3e43160757", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2b4b822912c105e092b394fab6ec6d7901976f8ecbb42e654d745f5ee6699c25054eb0519044e823c88937a5ae99c64622c01f7cc974093c0638e15278dc4436", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b0257699e9546208e755c5175bad53bd4352cfcc2a5eb0fab458d8f396d021dbb2bf856226021afe935a0edb65063d40bf05cee21179c79155d227abf65c8797"} build_url:https://queue.taskcluster.net/v1/task/FCldrswCSDuPK5_pP5PLww/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011493 build_url: 'https://queue.taskcluster.net/v1/task/FCldrswCSDuPK5_pP5PLww/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d4ff4d0c86ff3e9d0a4ec4b1121cbd601faa82a7c2694cebf138009ed3f883b78b11b6ab24956b56b17011fbca5358eea93f1c80f9879131e3e39a3e43160757", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2b4b822912c105e092b394fab6ec6d7901976f8ecbb42e654d745f5ee6699c25054eb0519044e823c88937a5ae99c64622c01f7cc974093c0638e15278dc4436", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b0257699e9546208e755c5175bad53bd4352cfcc2a5eb0fab458d8f396d021dbb2bf856226021afe935a0edb65063d40bf05cee21179c79155d227abf65c8797"}' ========= master_lag: 0.94 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-13 21:08:29.720777) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 21:08:29.721120) ========= 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.UeUPak7Ku0/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.r2Ghu0AYnV/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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.005154 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 21:08:29.748105) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-13 21:08:29.748478) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-13 21:08:29.749133) ========= ========= Total master_lag: 1.33 =========