builder: larch_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0344 starttime: 1479343180.0 results: success (0) buildid: 20161116124710 builduid: ef9f6765b6624dc5842f8f97ad547878 revision: fbbcd82b29623828d64038b7272da2906f4bd8f5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-16 16:39:39.996027) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-16 16:39:39.996485) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 4 secs) (at 2016-11-16 16:39:39.996765) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 4 secs) (at 2016-11-16 16:39:44.481757) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 16:39:44.482213) ========= 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.TAc0rseNzb/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.j46zRnZa1x/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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-11-16 16:39:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 20.6M=0.001s 2016-11-16 16:39:44 (20.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.111678 ========= master_lag: 0.23 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 16:39:44.824202) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 16:39:44.824542) ========= 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.TAc0rseNzb/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.j46zRnZa1x/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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.033868 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 16:39:44.879022) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-16 16:39:44.882412) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev fbbcd82b29623828d64038b7272da2906f4bd8f5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev fbbcd82b29623828d64038b7272da2906f4bd8f5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TAc0rseNzb/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.j46zRnZa1x/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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-11-16 16:39:44,982 truncating revision to first 12 chars 2016-11-16 16:39:44,982 Setting DEBUG logging. 2016-11-16 16:39:44,982 attempt 1/10 2016-11-16 16:39:44,982 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/fbbcd82b2962?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-16 16:39:46,147 unpacking tar archive at: larch-fbbcd82b2962/testing/mozharness/ program finished with exit code 0 elapsedTime=1.454861 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-16 16:39:46.359375) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-16 16:39:46.359734) ========= script_repo_revision: fbbcd82b29623828d64038b7272da2906f4bd8f5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-16 16:39:46.360124) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-16 16:39:46.360407) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-16 16:39:46.378930) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-11-16 16:39:46.379345) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Larch', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TAc0rseNzb/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.j46zRnZa1x/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 16:39:46 INFO - MultiFileLogger online at 20161116 16:39:46 in /builds/slave/test 16:39:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 16:39:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:39:46 INFO - {'append_to_log': False, 16:39:46 INFO - 'base_work_dir': '/builds/slave/test', 16:39:46 INFO - 'blob_upload_branch': 'Larch', 16:39:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:39:46 INFO - 'branch': 'Larch', 16:39:46 INFO - 'buildbot_json_path': 'buildprops.json', 16:39:46 INFO - 'config_files': ('talos/mac_config.py',), 16:39:46 INFO - 'default_actions': ('clobber', 16:39:46 INFO - 'read-buildbot-config', 16:39:46 INFO - 'download-and-extract', 16:39:46 INFO - 'populate-webroot', 16:39:46 INFO - 'create-virtualenv', 16:39:46 INFO - 'install', 16:39:46 INFO - 'run-tests'), 16:39:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:39:46 INFO - 'download_minidump_stackwalk': True, 16:39:46 INFO - 'download_symbols': 'ondemand', 16:39:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:39:46 INFO - 'tooltool.py': '/tools/tooltool.py', 16:39:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:39:46 INFO - '/tools/misc-python/virtualenv.py')}, 16:39:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:39:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:39:46 INFO - 'installer_path': 'installer.exe', 16:39:46 INFO - 'log_level': 'info', 16:39:46 INFO - 'log_name': 'talos', 16:39:46 INFO - 'log_to_console': True, 16:39:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:39:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:39:46 INFO - 'opt_config_files': (), 16:39:46 INFO - 'pip_index': False, 16:39:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:39:46 INFO - 'cmd': ('bash', 16:39:46 INFO - '-c', 16:39:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:39:46 INFO - 'enabled': True, 16:39:46 INFO - 'halt_on_failure': False, 16:39:46 INFO - 'name': 'check_screen_resolution'},), 16:39:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:39:46 INFO - 'cmd': ('bash', 16:39:46 INFO - '-c', 16:39:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:39:46 INFO - 'enabled': True, 16:39:46 INFO - 'halt_on_failure': False, 16:39:46 INFO - 'name': 'check_screen_resolution'},), 16:39:46 INFO - 'run_cmd_checks_enabled': True, 16:39:46 INFO - 'sps_profile': False, 16:39:46 INFO - 'sps_profile_interval': 0, 16:39:46 INFO - 'suite': 'dromaeojs', 16:39:46 INFO - 'system_bits': '32', 16:39:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:39:46 INFO - 'title': 't-yosemite-r7-0344', 16:39:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:39:46 INFO - 'use_talos_json': True, 16:39:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:39:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:39:46 INFO - 'work_dir': 'build'} 16:39:46 INFO - [mozharness: 2016-11-17 00:39:46.586600Z] Running clobber step. 16:39:46 INFO - Running pre-action listener: _resource_record_pre_action 16:39:46 INFO - Running main action method: clobber 16:39:46 INFO - rmtree: /builds/slave/test/build 16:39:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:39:48 INFO - Running post-action listener: _resource_record_post_action 16:39:48 INFO - [mozharness: 2016-11-17 00:39:48.908761Z] Finished clobber step (success) 16:39:48 INFO - [mozharness: 2016-11-17 00:39:48.908889Z] Running read-buildbot-config step. 16:39:48 INFO - Running pre-action listener: _resource_record_pre_action 16:39:48 INFO - Running main action method: read_buildbot_config 16:39:48 INFO - Using buildbot properties: 16:39:48 INFO - { 16:39:48 INFO - "project": "", 16:39:48 INFO - "product": "firefox", 16:39:48 INFO - "script_repo_revision": "production", 16:39:48 INFO - "builddir": "larch_yosemite_r7_test-dromaeojs", 16:39:48 INFO - "repository": "", 16:39:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 larch talos dromaeojs", 16:39:48 INFO - "buildid": "20161116124710", 16:39:48 INFO - "pgo_build": "False", 16:39:48 INFO - "basedir": "/builds/slave/test", 16:39:48 INFO - "buildnumber": 1, 16:39:48 INFO - "slavename": "t-yosemite-r7-0344", 16:39:48 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 16:39:48 INFO - "platform": "yosemite_r7", 16:39:48 INFO - "scheduler": "tests-larch-macosx64-talos", 16:39:48 INFO - "branch": "larch", 16:39:48 INFO - "repo_path": "projects/larch", 16:39:48 INFO - "revision": "fbbcd82b29623828d64038b7272da2906f4bd8f5", 16:39:48 INFO - "stage_platform": "macosx64", 16:39:48 INFO - "builduid": "ef9f6765b6624dc5842f8f97ad547878", 16:39:48 INFO - "slavebuilddir": "test" 16:39:48 INFO - } 16:39:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/R9QhHUCsQU-P8cyv1cXmnw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 16:39:48 INFO - Running post-action listener: _resource_record_post_action 16:39:48 INFO - [mozharness: 2016-11-17 00:39:48.912190Z] Finished read-buildbot-config step (success) 16:39:48 INFO - [mozharness: 2016-11-17 00:39:48.912326Z] Running download-and-extract step. 16:39:48 INFO - Running pre-action listener: _resource_record_pre_action 16:39:48 INFO - Running main action method: download_and_extract 16:39:48 INFO - mkdir: /builds/slave/test/build/tests 16:39: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')]} 16:39:48 INFO - trying https://queue.taskcluster.net/v1/task/R9QhHUCsQU-P8cyv1cXmnw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 16:39:48 INFO - Downloading https://queue.taskcluster.net/v1/task/R9QhHUCsQU-P8cyv1cXmnw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 16:39:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R9QhHUCsQU-P8cyv1cXmnw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 16:39:50 INFO - Downloaded 1199 bytes. 16:39:50 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 16:39:50 INFO - Using the following test package requirements: 16:39:50 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 16:39:50 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:39:50 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 16:39:50 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:39:50 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 16:39:50 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:39:50 INFO - u'jsshell-mac.zip'], 16:39:50 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:39:50 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 16:39:50 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 16:39:50 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:39:50 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 16:39:50 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:39:50 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 16:39:50 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:39:50 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 16:39:50 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:39:50 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 16:39:50 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:39:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R9QhHUCsQU-P8cyv1cXmnw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 16:39:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R9QhHUCsQU-P8cyv1cXmnw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:39:50 INFO - Fetch https://queue.taskcluster.net/v1/task/R9QhHUCsQU-P8cyv1cXmnw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 16:39:50 INFO - Http code: 200 16:39:50 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 16:39:50 INFO - x-amz-cf-id: wq2BC9qqpESwaQzxrWS5YLJ7hD_-PNH3ExgRPwtNHLT_Nk4NhUD7SQ== 16:39:50 INFO - x-amz-version-id: tXqbINfV8G.NHaOZShoO9AS.K89lkFeb 16:39:51 INFO - Expected file size: 16268109 16:39:51 INFO - Obtained file size: 16268109 16:39:57 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:39:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R9QhHUCsQU-P8cyv1cXmnw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 16:39:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R9QhHUCsQU-P8cyv1cXmnw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:39:57 INFO - Fetch https://queue.taskcluster.net/v1/task/R9QhHUCsQU-P8cyv1cXmnw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 16:39:58 INFO - Http code: 200 16:39:58 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 16:39:58 INFO - x-amz-cf-id: 8HPuoUwWXAV7zt5BGZ7mXX3S6kSdQHV1l_fEJLWjegaqPHjzlmjTUQ== 16:39:58 INFO - x-amz-version-id: tXqbINfV8G.NHaOZShoO9AS.K89lkFeb 16:39:58 INFO - Expected file size: 16268109 16:39:58 INFO - Obtained file size: 16268109 16:40:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R9QhHUCsQU-P8cyv1cXmnw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 16:40:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R9QhHUCsQU-P8cyv1cXmnw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:40:05 INFO - Fetch https://queue.taskcluster.net/v1/task/R9QhHUCsQU-P8cyv1cXmnw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 16:40:06 INFO - Http code: 200 16:40:06 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 16:40:06 INFO - x-amz-cf-id: QcrZLlHH4L6Pujf_4CILX05pO1JGXoVwMKPZMLcODfJQwNkNLKgwQQ== 16:40:06 INFO - x-amz-version-id: 8NailMDt.6cTzlxZkdc7KMJzR.6El9ll 16:40:06 INFO - Expected file size: 14409366 16:40:06 INFO - Obtained file size: 14409366 16:40:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:40:06 INFO - trying https://queue.taskcluster.net/v1/task/R9QhHUCsQU-P8cyv1cXmnw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 16:40:06 INFO - Downloading https://queue.taskcluster.net/v1/task/R9QhHUCsQU-P8cyv1cXmnw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 16:40:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R9QhHUCsQU-P8cyv1cXmnw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 16:40:09 INFO - Downloaded 111037884 bytes. 16:40:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R9QhHUCsQU-P8cyv1cXmnw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 16:40:09 INFO - mkdir: /builds/slave/test/properties 16:40:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:40:09 INFO - Writing to file /builds/slave/test/properties/build_url 16:40:09 INFO - Contents: 16:40:09 INFO - build_url:https://queue.taskcluster.net/v1/task/R9QhHUCsQU-P8cyv1cXmnw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 16:40:10 INFO - Running post-action listener: _resource_record_post_action 16:40:10 INFO - Running post-action listener: set_extra_try_arguments 16:40:10 INFO - [mozharness: 2016-11-17 00:40:10.320679Z] Finished download-and-extract step (success) 16:40:10 INFO - [mozharness: 2016-11-17 00:40:10.320831Z] Running populate-webroot step. 16:40:10 INFO - Running pre-action listener: _resource_record_pre_action 16:40:10 INFO - Running main action method: populate_webroot 16:40:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:40:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:40:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:40:10 INFO - '--tppagecycles', 16:40:10 INFO - '7'], 16:40:10 INFO - 'tests': ['tsvgm']}}, 16:40:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:40:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:40:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:40:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:40:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:40:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:40:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:40:10 INFO - 'talos_options': ['--disable-e10s'], 16:40:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:40:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:40:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:40:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:40:10 INFO - 'talos_options': ['--disable-e10s'], 16:40:10 INFO - 'tests': ['damp', 'tps']}, 16:40:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:40:10 INFO - 'tests': ['damp', 'tps']}, 16:40:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:40:10 INFO - 'tests': ['dromaeo_dom']}, 16:40:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:40:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:40:10 INFO - 'tests': ['basic_compositor_video']}, 16:40:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:40:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:40:10 INFO - 'tests': ['a11yr', 16:40:10 INFO - 'ts_paint', 16:40:10 INFO - 'tpaint', 16:40:10 INFO - 'sessionrestore', 16:40:10 INFO - 'sessionrestore_no_auto_restore', 16:40:10 INFO - 'tabpaint']}, 16:40:10 INFO - 'other-e10s': {'tests': ['a11yr', 16:40:10 INFO - 'ts_paint', 16:40:10 INFO - 'tpaint', 16:40:10 INFO - 'sessionrestore', 16:40:10 INFO - 'sessionrestore_no_auto_restore', 16:40:10 INFO - 'tabpaint']}, 16:40:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:40:10 INFO - 'ts_paint', 16:40:10 INFO - 'tpaint', 16:40:10 INFO - 'sessionrestore', 16:40:10 INFO - 'sessionrestore_no_auto_restore', 16:40:10 INFO - 'tabpaint']}, 16:40:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:40:10 INFO - 'ts_paint', 16:40:10 INFO - 'tpaint', 16:40:10 INFO - 'sessionrestore', 16:40:10 INFO - 'sessionrestore_no_auto_restore', 16:40:10 INFO - 'tabpaint']}, 16:40:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:40:10 INFO - 'tests': ['a11yr', 16:40:10 INFO - 'ts_paint', 16:40:10 INFO - 'tpaint', 16:40:10 INFO - 'sessionrestore', 16:40:10 INFO - 'sessionrestore_no_auto_restore', 16:40:10 INFO - 'tabpaint']}, 16:40:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:40:10 INFO - 'tests': ['a11yr', 16:40:10 INFO - 'ts_paint', 16:40:10 INFO - 'tpaint', 16:40:10 INFO - 'sessionrestore', 16:40:10 INFO - 'sessionrestore_no_auto_restore', 16:40:10 INFO - 'tabpaint']}, 16:40:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:40:10 INFO - 'tests': ['tsvgx', 16:40:10 INFO - 'tsvgr_opacity', 16:40:10 INFO - 'tart', 16:40:10 INFO - 'tscrollx', 16:40:10 INFO - 'cart']}, 16:40:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:40:10 INFO - 'tsvgr_opacity', 16:40:10 INFO - 'tart', 16:40:10 INFO - 'tscrollx', 16:40:10 INFO - 'cart']}, 16:40:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:40:10 INFO - 'talos_options': ['--disable-e10s'], 16:40:10 INFO - 'tests': ['tp5o']}, 16:40:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:40:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:40:10 INFO - 'talos_options': ['--disable-e10s', 16:40:10 INFO - '--xperf_path', 16:40:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:40:10 INFO - 'tests': ['tp5n']}, 16:40:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:40:10 INFO - 'talos_options': ['--xperf_path', 16:40:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:40:10 INFO - 'tests': ['tp5n']}}, 16:40:10 INFO - 'talos.zip': {'path': '', 16:40:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:40:10 INFO - Running post-action listener: _resource_record_post_action 16:40:10 INFO - [mozharness: 2016-11-17 00:40:10.339911Z] Finished populate-webroot step (success) 16:40:10 INFO - [mozharness: 2016-11-17 00:40:10.340050Z] Running create-virtualenv step. 16:40:10 INFO - Running pre-action listener: _resource_record_pre_action 16:40:10 INFO - Running main action method: create_virtualenv 16:40:10 INFO - Creating virtualenv /builds/slave/test/build/venv 16:40:10 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 16:40:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:40:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:40:10 INFO - Using real prefix '/tools/python27' 16:40:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:40:11 INFO - Installing distribute.............................................................................................................................................................................................done. 16:40:14 INFO - Installing pip.................done. 16:40:14 INFO - Return code: 0 16:40:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:40:14 INFO - Reading from file tmpfile_stdout 16:40:14 INFO - Output received: 16:40:14 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:40:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:40:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100dea3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d60570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b9c7b4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c00d30>, '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 0x100a67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100bf8b20>, '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.TAc0rseNzb/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.j46zRnZa1x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 16:40:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:40:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TAc0rseNzb/Render', 16:40:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:40:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:40:14 INFO - 'HOME': '/Users/cltbld', 16:40:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:40:14 INFO - 'LOGNAME': 'cltbld', 16:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:14 INFO - 'MOZ_NO_REMOTE': '1', 16:40:14 INFO - 'NO_EM_RESTART': '1', 16:40:14 INFO - 'PAGER': '/bin/cat', 16:40:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:14 INFO - 'PWD': '/builds/slave/test', 16:40:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:40:14 INFO - 'SHELL': '/bin/bash', 16:40:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j46zRnZa1x/Listeners', 16:40:14 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 16:40:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:40:14 INFO - 'USER': 'cltbld', 16:40:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:40:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:14 INFO - 'XPC_FLAGS': '0x0', 16:40:14 INFO - 'XPC_SERVICE_NAME': '0', 16:40:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:40:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:14 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 16:40:14 INFO - Cleaning up... 16:40:14 INFO - Return code: 0 16:40:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:40:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100dea3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d60570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b9c7b4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c00d30>, '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 0x100a67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100bf8b20>, '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.TAc0rseNzb/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.j46zRnZa1x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 16:40:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:40:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TAc0rseNzb/Render', 16:40:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:40:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:40:14 INFO - 'HOME': '/Users/cltbld', 16:40:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:40:14 INFO - 'LOGNAME': 'cltbld', 16:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:14 INFO - 'MOZ_NO_REMOTE': '1', 16:40:14 INFO - 'NO_EM_RESTART': '1', 16:40:14 INFO - 'PAGER': '/bin/cat', 16:40:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:14 INFO - 'PWD': '/builds/slave/test', 16:40:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:40:14 INFO - 'SHELL': '/bin/bash', 16:40:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j46zRnZa1x/Listeners', 16:40:14 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 16:40:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:40:14 INFO - 'USER': 'cltbld', 16:40:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:40:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:14 INFO - 'XPC_FLAGS': '0x0', 16:40:14 INFO - 'XPC_SERVICE_NAME': '0', 16:40:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:40:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:14 INFO - Downloading/unpacking psutil>=3.1.1 16:40:14 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 16:40:14 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 16:40:14 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 16:40:14 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 16:40:14 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 16:40:14 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 16:40:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:40:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:40:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:40:18 INFO - Installing collected packages: psutil 16:40:18 INFO - Running setup.py install for psutil 16:40:18 INFO - building 'psutil._psutil_osx' extension 16:40:18 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 16:40:18 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 16:40:18 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 16:40:19 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 16:40:19 INFO - building 'psutil._psutil_posix' extension 16:40:19 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 16:40:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:40:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:40:19 INFO - ^ 16:40:19 INFO - 1 warning generated. 16:40:19 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 16:40:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:40:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:40:19 INFO - Successfully installed psutil 16:40:19 INFO - Cleaning up... 16:40:19 INFO - Return code: 0 16:40:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:40:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:40:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100dea3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d60570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b9c7b4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c00d30>, '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 0x100a67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100bf8b20>, '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.TAc0rseNzb/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.j46zRnZa1x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 16:40:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:40:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:40:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TAc0rseNzb/Render', 16:40:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:40:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:40:19 INFO - 'HOME': '/Users/cltbld', 16:40:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:40:19 INFO - 'LOGNAME': 'cltbld', 16:40:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:19 INFO - 'MOZ_NO_REMOTE': '1', 16:40:19 INFO - 'NO_EM_RESTART': '1', 16:40:19 INFO - 'PAGER': '/bin/cat', 16:40:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:40:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:19 INFO - 'PWD': '/builds/slave/test', 16:40:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:40:19 INFO - 'SHELL': '/bin/bash', 16:40:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j46zRnZa1x/Listeners', 16:40:19 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 16:40:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:40:19 INFO - 'USER': 'cltbld', 16:40:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:40:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:40:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:19 INFO - 'XPC_FLAGS': '0x0', 16:40:19 INFO - 'XPC_SERVICE_NAME': '0', 16:40:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:40:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:40:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:40:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:40:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:40:22 INFO - Installing collected packages: mozsystemmonitor 16:40:22 INFO - Running setup.py install for mozsystemmonitor 16:40:22 INFO - Successfully installed mozsystemmonitor 16:40:22 INFO - Cleaning up... 16:40:22 INFO - Return code: 0 16:40:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:40:22 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')]} 16:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:22 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')]} 16:40:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:22 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 0x100dea3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d60570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b9c7b4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c00d30>, '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 0x100a67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100bf8b20>, '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.TAc0rseNzb/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.j46zRnZa1x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 16:40:22 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 16:40:22 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 16:40:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TAc0rseNzb/Render', 16:40:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:40:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:40:22 INFO - 'HOME': '/Users/cltbld', 16:40:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:40:22 INFO - 'LOGNAME': 'cltbld', 16:40:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:22 INFO - 'MOZ_NO_REMOTE': '1', 16:40:22 INFO - 'NO_EM_RESTART': '1', 16:40:22 INFO - 'PAGER': '/bin/cat', 16:40:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:40:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:22 INFO - 'PWD': '/builds/slave/test', 16:40:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:40:22 INFO - 'SHELL': '/bin/bash', 16:40:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j46zRnZa1x/Listeners', 16:40:22 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 16:40:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:40:22 INFO - 'USER': 'cltbld', 16:40:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:40:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:40:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:22 INFO - 'XPC_FLAGS': '0x0', 16:40:22 INFO - 'XPC_SERVICE_NAME': '0', 16:40:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:40:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:22 INFO - Downloading/unpacking jsonschema==2.5.1 16:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:40:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:40:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:40:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:25 INFO - Downloading functools32-3.2.3-2.tar.gz 16:40:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:40:25 INFO - warning: no files found matching '*.txt' 16:40:25 INFO - no previously-included directories found matching 'build' 16:40:25 INFO - no previously-included directories found matching 'dist' 16:40:25 INFO - no previously-included directories found matching '.git*' 16:40:25 INFO - Installing collected packages: jsonschema, functools32 16:40:25 INFO - Running setup.py install for functools32 16:40:26 INFO - warning: no files found matching '*.txt' 16:40:26 INFO - no previously-included directories found matching 'build' 16:40:26 INFO - no previously-included directories found matching 'dist' 16:40:26 INFO - no previously-included directories found matching '.git*' 16:40:26 INFO - Successfully installed jsonschema functools32 16:40:26 INFO - Cleaning up... 16:40:26 INFO - Return code: 0 16:40:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:40:26 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')]} 16:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:26 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')]} 16:40:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:26 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 0x100dea3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d60570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b9c7b4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c00d30>, '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 0x100a67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100bf8b20>, '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.TAc0rseNzb/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.j46zRnZa1x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 16:40:26 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 16:40:26 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 16:40:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TAc0rseNzb/Render', 16:40:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:40:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:40:26 INFO - 'HOME': '/Users/cltbld', 16:40:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:40:26 INFO - 'LOGNAME': 'cltbld', 16:40:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:26 INFO - 'MOZ_NO_REMOTE': '1', 16:40:26 INFO - 'NO_EM_RESTART': '1', 16:40:26 INFO - 'PAGER': '/bin/cat', 16:40:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:40:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:26 INFO - 'PWD': '/builds/slave/test', 16:40:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:40:26 INFO - 'SHELL': '/bin/bash', 16:40:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j46zRnZa1x/Listeners', 16:40:26 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 16:40:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:40:26 INFO - 'USER': 'cltbld', 16:40:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:40:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:40:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:26 INFO - 'XPC_FLAGS': '0x0', 16:40:26 INFO - 'XPC_SERVICE_NAME': '0', 16:40:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:40:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:40:26 INFO - Cleaning up... 16:40:26 INFO - Return code: 0 16:40:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:40:26 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')]} 16:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:26 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')]} 16:40:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:26 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 0x100dea3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d60570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b9c7b4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c00d30>, '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 0x100a67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100bf8b20>, '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.TAc0rseNzb/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.j46zRnZa1x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 16:40:26 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 16:40:26 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 16:40:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TAc0rseNzb/Render', 16:40:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:40:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:40:26 INFO - 'HOME': '/Users/cltbld', 16:40:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:40:26 INFO - 'LOGNAME': 'cltbld', 16:40:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:26 INFO - 'MOZ_NO_REMOTE': '1', 16:40:26 INFO - 'NO_EM_RESTART': '1', 16:40:26 INFO - 'PAGER': '/bin/cat', 16:40:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:40:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:26 INFO - 'PWD': '/builds/slave/test', 16:40:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:40:26 INFO - 'SHELL': '/bin/bash', 16:40:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j46zRnZa1x/Listeners', 16:40:26 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 16:40:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:40:26 INFO - 'USER': 'cltbld', 16:40:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:40:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:40:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:26 INFO - 'XPC_FLAGS': '0x0', 16:40:26 INFO - 'XPC_SERVICE_NAME': '0', 16:40:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:40:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:26 INFO - Downloading/unpacking blobuploader==1.2.4 16:40:26 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 16:40:26 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 16:40:26 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 16:40:26 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 16:40:26 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 16:40:26 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 16:40:29 INFO - Downloading blobuploader-1.2.4.tar.gz 16:40:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:40:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:40:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:40:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:40:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:40:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:40:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:30 INFO - Downloading docopt-0.6.1.tar.gz 16:40:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:40:30 INFO - Installing collected packages: blobuploader, requests, docopt 16:40:30 INFO - Running setup.py install for blobuploader 16:40:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:40:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:40:30 INFO - Running setup.py install for requests 16:40:31 INFO - Running setup.py install for docopt 16:40:31 INFO - Successfully installed blobuploader requests docopt 16:40:31 INFO - Cleaning up... 16:40:31 INFO - Return code: 0 16:40:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:40:31 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')]} 16:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:31 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')]} 16:40:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:31 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 0x100dea3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d60570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b9c7b4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c00d30>, '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 0x100a67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100bf8b20>, '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.TAc0rseNzb/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.j46zRnZa1x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 16:40:31 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 16:40:31 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 16:40:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TAc0rseNzb/Render', 16:40:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:40:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:40:31 INFO - 'HOME': '/Users/cltbld', 16:40:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:40:31 INFO - 'LOGNAME': 'cltbld', 16:40:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:31 INFO - 'MOZ_NO_REMOTE': '1', 16:40:31 INFO - 'NO_EM_RESTART': '1', 16:40:31 INFO - 'PAGER': '/bin/cat', 16:40:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:40:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:31 INFO - 'PWD': '/builds/slave/test', 16:40:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:40:31 INFO - 'SHELL': '/bin/bash', 16:40:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j46zRnZa1x/Listeners', 16:40:31 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 16:40:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:40:31 INFO - 'USER': 'cltbld', 16:40:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:40:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:40:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:31 INFO - 'XPC_FLAGS': '0x0', 16:40:31 INFO - 'XPC_SERVICE_NAME': '0', 16:40:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:40:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:40:31 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-uZ70Fd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:40:31 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-Rj70n2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:40:31 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-gFZIqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:40:32 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-GOo5CJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:40:32 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-Na6ywS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:40:32 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-5UfW1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:40:32 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-lyaMqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:40:32 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-i9Boyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:40:32 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-orZs8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:40:32 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-5RSXll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:40:32 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-MTyGZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:40:32 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-XJmbd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:40:33 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-ZMscP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:40:33 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-WDak8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:40:33 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-IQiw2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:40:33 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-3mW92q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:40:33 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-nEg8gX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:40:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:40:33 INFO - Running setup.py install for manifestparser 16:40:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:40:33 INFO - Running setup.py install for mozcrash 16:40:33 INFO - Running setup.py install for mozdebug 16:40:33 INFO - Running setup.py install for mozdevice 16:40:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:40:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:40:34 INFO - Running setup.py install for mozfile 16:40:34 INFO - Running setup.py install for mozhttpd 16:40:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:40:34 INFO - Running setup.py install for mozinfo 16:40:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:40:34 INFO - Running setup.py install for mozInstall 16:40:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:40:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:40:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:40:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:40:34 INFO - Running setup.py install for mozleak 16:40:34 INFO - Running setup.py install for mozlog 16:40:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:40:35 INFO - Running setup.py install for moznetwork 16:40:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:40:35 INFO - Running setup.py install for mozprocess 16:40:35 INFO - Running setup.py install for mozprofile 16:40:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:40:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:40:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:40:35 INFO - Running setup.py install for mozrunner 16:40:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:40:35 INFO - Running setup.py install for mozscreenshot 16:40:35 INFO - Running setup.py install for moztest 16:40:35 INFO - Running setup.py install for mozversion 16:40:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:40:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:40:36 INFO - Cleaning up... 16:40:36 INFO - Return code: 0 16:40:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:40:36 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')]} 16:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:36 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')]} 16:40:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:36 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 0x100dea3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d60570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b9c7b4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c00d30>, '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 0x100a67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100bf8b20>, '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.TAc0rseNzb/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.j46zRnZa1x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 16:40:36 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 16:40:36 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 16:40:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TAc0rseNzb/Render', 16:40:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:40:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:40:36 INFO - 'HOME': '/Users/cltbld', 16:40:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:40:36 INFO - 'LOGNAME': 'cltbld', 16:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:36 INFO - 'MOZ_NO_REMOTE': '1', 16:40:36 INFO - 'NO_EM_RESTART': '1', 16:40:36 INFO - 'PAGER': '/bin/cat', 16:40:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:36 INFO - 'PWD': '/builds/slave/test', 16:40:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:40:36 INFO - 'SHELL': '/bin/bash', 16:40:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j46zRnZa1x/Listeners', 16:40:36 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 16:40:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:40:36 INFO - 'USER': 'cltbld', 16:40:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:40:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:36 INFO - 'XPC_FLAGS': '0x0', 16:40:36 INFO - 'XPC_SERVICE_NAME': '0', 16:40:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:40:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:40:37 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-UvoKmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:40:37 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)) 16:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:40:37 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-j2uvmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:40:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:40:37 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-X_qmm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:40:37 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)) 16:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:40:37 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-9fXDc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:40:37 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)) 16:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:40:37 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-AzTpjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:40:37 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)) 16:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:40:37 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-suvs0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:40:37 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)) 16:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:40:37 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-mC1ChB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:40:37 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)) 16:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:40:37 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-9XcyDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:40:37 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)) 16:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:40:37 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-VKmrxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:40:38 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)) 16:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:40:38 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-QS4OyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:40:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:40:38 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-vWlpf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:40:38 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)) 16:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:40:38 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-z5JQxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:40:38 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)) 16:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:40:38 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-Zp3tVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:40:38 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)) 16:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:40:38 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-2F_jsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:40:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:40:38 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-Bk1Tx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:40:38 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)) 16:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:40:38 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-gMu51n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:40:38 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)) 16:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:40:38 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-gbpSbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:40:38 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)) 16:40:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:40:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:40:38 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)) 16:40:38 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)) 16:40:38 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)) 16:40:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:40:38 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 16:40:38 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 16:40:38 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 16:40:38 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 16:40:38 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 16:40:38 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 16:40:41 INFO - Downloading blessings-1.6.tar.gz 16:40:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:40:42 INFO - Installing collected packages: blessings 16:40:42 INFO - Running setup.py install for blessings 16:40:42 INFO - Successfully installed blessings 16:40:42 INFO - Cleaning up... 16:40:42 INFO - Return code: 0 16:40:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:40:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:40:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:40:42 INFO - Reading from file tmpfile_stdout 16:40:42 INFO - Current package versions: 16:40:42 INFO - blessings == 1.6 16:40:42 INFO - blobuploader == 1.2.4 16:40:42 INFO - docopt == 0.6.1 16:40:42 INFO - functools32 == 3.2.3-2 16:40:42 INFO - jsonschema == 2.5.1 16:40:42 INFO - manifestparser == 1.1 16:40:42 INFO - mozInstall == 1.12 16:40:42 INFO - mozcrash == 1.0 16:40:42 INFO - mozdebug == 0.1 16:40:42 INFO - mozdevice == 0.48 16:40:42 INFO - mozfile == 1.2 16:40:42 INFO - mozhttpd == 0.7 16:40:42 INFO - mozinfo == 0.9 16:40:42 INFO - mozleak == 0.1 16:40:42 INFO - mozlog == 3.4 16:40:42 INFO - moznetwork == 0.27 16:40:42 INFO - mozprocess == 0.23 16:40:42 INFO - mozprofile == 0.28 16:40:42 INFO - mozrunner == 6.13 16:40:42 INFO - mozscreenshot == 0.1 16:40:42 INFO - mozsystemmonitor == 0.3 16:40:42 INFO - moztest == 0.7 16:40:42 INFO - mozversion == 1.4 16:40:42 INFO - psutil == 3.1.1 16:40:42 INFO - requests == 1.2.3 16:40:42 INFO - wsgiref == 0.1.2 16:40:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:40: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')]} 16:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40: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')]} 16:40:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:42 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 0x100dea3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d60570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b9c7b4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c00d30>, '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 0x100a67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100bf8b20>, '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.TAc0rseNzb/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.j46zRnZa1x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 16:40:42 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 16:40:42 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 16:40:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TAc0rseNzb/Render', 16:40:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:40:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:40:42 INFO - 'HOME': '/Users/cltbld', 16:40:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:40:42 INFO - 'LOGNAME': 'cltbld', 16:40:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:42 INFO - 'MOZ_NO_REMOTE': '1', 16:40:42 INFO - 'NO_EM_RESTART': '1', 16:40:42 INFO - 'PAGER': '/bin/cat', 16:40:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:40:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:42 INFO - 'PWD': '/builds/slave/test', 16:40:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:40:42 INFO - 'SHELL': '/bin/bash', 16:40:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j46zRnZa1x/Listeners', 16:40:42 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 16:40:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:40:42 INFO - 'USER': 'cltbld', 16:40:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:40:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:40:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:42 INFO - 'XPC_FLAGS': '0x0', 16:40:42 INFO - 'XPC_SERVICE_NAME': '0', 16:40:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:40:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:42 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)) 16:40:42 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)) 16:40:42 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)) 16:40:42 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)) 16:40:42 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)) 16:40:42 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)) 16:40:42 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)) 16:40:42 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)) 16:40:42 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)) 16:40:42 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)) 16:40:42 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)) 16:40:42 INFO - Cleaning up... 16:40:42 INFO - Return code: 0 16:40:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:40: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')]} 16:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40: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')]} 16:40:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100dea3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d60570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3b9c7b4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c00d30>, '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 0x100a67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100bf8b20>, '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.TAc0rseNzb/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.j46zRnZa1x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 16:40: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', 'jsonschema'] in /builds/slave/test/build 16:40: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 jsonschema 16:40:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TAc0rseNzb/Render', 16:40:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:40:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:40:42 INFO - 'HOME': '/Users/cltbld', 16:40:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:40:42 INFO - 'LOGNAME': 'cltbld', 16:40:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:42 INFO - 'MOZ_NO_REMOTE': '1', 16:40:42 INFO - 'NO_EM_RESTART': '1', 16:40:42 INFO - 'PAGER': '/bin/cat', 16:40:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:40:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:42 INFO - 'PWD': '/builds/slave/test', 16:40:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:40:42 INFO - 'SHELL': '/bin/bash', 16:40:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j46zRnZa1x/Listeners', 16:40:42 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 16:40:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:40:42 INFO - 'USER': 'cltbld', 16:40:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:40:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:40:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:42 INFO - 'XPC_FLAGS': '0x0', 16:40:42 INFO - 'XPC_SERVICE_NAME': '0', 16:40:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:40:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:40:43 INFO - Cleaning up... 16:40:43 INFO - Return code: 0 16:40:43 INFO - Running post-action listener: _resource_record_post_action 16:40:43 INFO - Running post-action listener: _start_resource_monitoring 16:40:43 INFO - Starting resource monitoring. 16:40:43 INFO - [mozharness: 2016-11-17 00:40:43.135680Z] Finished create-virtualenv step (success) 16:40:43 INFO - [mozharness: 2016-11-17 00:40:43.136649Z] Running install step. 16:40:43 INFO - Running pre-action listener: _resource_record_pre_action 16:40:43 INFO - Running main action method: install 16:40:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:40:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:40:43 INFO - Reading from file tmpfile_stdout 16:40:43 INFO - Detecting whether we're running mozinstall >=1.0... 16:40:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:40:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:40:43 INFO - Reading from file tmpfile_stdout 16:40:43 INFO - Output received: 16:40:43 INFO - Usage: mozinstall [options] installer 16:40:43 INFO - Options: 16:40:43 INFO - -h, --help show this help message and exit 16:40:43 INFO - -d DEST, --destination=DEST 16:40:43 INFO - Directory to install application into. [default: 16:40:43 INFO - "/builds/slave/test"] 16:40:43 INFO - --app=APP Application being installed. [default: firefox] 16:40:43 INFO - mkdir: /builds/slave/test/build/application 16:40:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:40:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:41:17 INFO - Reading from file tmpfile_stdout 16:41:17 INFO - Output received: 16:41:17 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:41:17 INFO - Running post-action listener: _resource_record_post_action 16:41:17 INFO - [mozharness: 2016-11-17 00:41:17.890349Z] Finished install step (success) 16:41:17 INFO - [mozharness: 2016-11-17 00:41:17.890509Z] Running run-tests step. 16:41:17 INFO - Running pre-action listener: _resource_record_pre_action 16:41:17 INFO - Running main action method: run_tests 16:41:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:41:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:41:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:41:17 INFO - 2016-11-16 16:41:17.905 screenresolution[1624:7484] starting screenresolution argv=screenresolution get 16:41:17 INFO - 2016-11-16 16:41:17.907 screenresolution[1624:7484] Display 0: 1600x1200x32@60 16:41:17 INFO - 2016-11-16 16:41:17.913 screenresolution[1625:7486] starting screenresolution argv=screenresolution list 16:41:17 INFO - Available Modes on Display 0 16:41:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:41:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:41:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:41:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:41:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:41:18 INFO - Intel Iris: 16:41:18 INFO - Chipset Model: Intel Iris 16:41:18 INFO - Type: GPU 16:41:18 INFO - Bus: Built-In 16:41:18 INFO - VRAM (Dynamic, Max): 1536 MB 16:41:18 INFO - Vendor: Intel (0x8086) 16:41:18 INFO - Device ID: 0x0a2e 16:41:18 INFO - Revision ID: 0x0009 16:41:18 INFO - Displays: 16:41:18 INFO - Display: 16:41:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:41:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:41:18 INFO - Display Serial Number: 1600x1200 60 16:41:18 INFO - Main Display: Yes 16:41:18 INFO - Mirror: Off 16:41:18 INFO - Online: Yes 16:41:18 INFO - Rotation: Supported 16:41:18 INFO - Return code: 0 16:41:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:41:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:41:18 INFO - Python 2.7.3 16:41:18 INFO - Return code: 0 16:41:18 INFO - grabbing minidump binary from tooltool 16:41: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')]} 16:41:18 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 0x100c00d30>, '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 0x100a67db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100bf8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:41:18 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 16:41:18 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 16:41:18 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 16:41:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:41:18 INFO - Return code: 0 16:41:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:41:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:41:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:41:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:41:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:41:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R9QhHUCsQU-P8cyv1cXmnw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0344', '--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 16:41:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/R9QhHUCsQU-P8cyv1cXmnw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0344 --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 16:41:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TAc0rseNzb/Render', 16:41:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:41:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:41:18 INFO - 'HOME': '/Users/cltbld', 16:41:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:41:18 INFO - 'LOGNAME': 'cltbld', 16:41:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:41:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:41:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:41:18 INFO - 'MOZ_NO_REMOTE': '1', 16:41:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:41:18 INFO - 'NO_EM_RESTART': '1', 16:41:18 INFO - 'PAGER': '/bin/cat', 16:41:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:41:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:41:18 INFO - 'PWD': '/builds/slave/test', 16:41:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:41:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:41:18 INFO - 'SHELL': '/bin/bash', 16:41:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j46zRnZa1x/Listeners', 16:41:18 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 16:41:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:41:18 INFO - 'USER': 'cltbld', 16:41:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:41:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:41:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:41:18 INFO - 'XPC_FLAGS': '0x0', 16:41:18 INFO - 'XPC_SERVICE_NAME': '0', 16:41:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:41:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R9QhHUCsQU-P8cyv1cXmnw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0344', '--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 16:41:18 INFO - mozversion application_buildid: 20161116124710 16:41:18 INFO - mozversion application_changeset: fbbcd82b29623828d64038b7272da2906f4bd8f5 16:41:18 INFO - mozversion application_display_name: Nightly 16:41:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:41:18 INFO - mozversion application_name: Firefox 16:41:18 INFO - mozversion application_remotingname: firefox 16:41:18 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 16:41:18 INFO - mozversion application_vendor: Mozilla 16:41:18 INFO - mozversion application_version: 53.0a1 16:41:18 INFO - mozversion platform_buildid: 20161116124710 16:41:18 INFO - mozversion platform_changeset: fbbcd82b29623828d64038b7272da2906f4bd8f5 16:41:18 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 16:41:18 INFO - mozversion platform_version: 53.0a1 16:41:18 INFO - using testdate: 1479343278 16:41:18 INFO - actual date: 1479343278 16:41:18 INFO - starting webserver on 'localhost:49241' 16:41:18 INFO - SUITE-START | Running 2 tests 16:41:18 INFO - TEST-START | dromaeo_css 16:41:18 INFO - operating with platform_type : mac_ 16:41:18 INFO - Initialising browser for dromaeo_css test... 16:41:18 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/tmpWSSSTL/profile http://localhost:49241/getInfo.html) 16:41:21 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 16:41:21 INFO - PROCESS | 1635 | colorDepth:24 16:41:21 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 16:41:21 INFO - PROCESS | 1635 | __metrics 16:41:21 INFO - PROCESS | 1635 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:41:21 INFO - PROCESS | 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:41:22 INFO - TEST-INFO | 1635: exit 0 16:41:22 INFO - Browser initialized. 16:41:22 INFO - Running cycle 1/1 for dromaeo_css test... 16:41:22 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/tmpWSSSTL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:41:34 INFO - PROCESS | 1637 | RSS: Main: 232615936 16:41:34 INFO - PROCESS | 1637 | 16:42:25 INFO - PROCESS | 1637 | 1479343345860 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] 16:44:38 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 16:44:39 INFO - PROCESS | 1637 | RSS: Main: 389115904 16:44:39 INFO - PROCESS | 1637 | 16:47:42 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 16:47:42 INFO - PROCESS | 1637 | RSS: Main: 378318848 16:47:42 INFO - PROCESS | 1637 | 16:50:45 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 16:50:46 INFO - PROCESS | 1637 | RSS: Main: 347893760 16:50:46 INFO - PROCESS | 1637 | 16:53:48 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 16:53:48 INFO - PROCESS | 1637 | RSS: Main: 359030784 16:53:48 INFO - PROCESS | 1637 | 16:56:52 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 16:56:52 INFO - PROCESS | 1637 | RSS: Main: 340004864 16:56:52 INFO - PROCESS | 1637 | 16:59:56 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 16:59:56 INFO - PROCESS | 1637 | RSS: Main: 454262784 16:59:56 INFO - PROCESS | 1637 | 16:59:56 INFO - PROCESS | 1637 | __start_tp_report 16:59:56 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 16:59:56 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 16:59:56 INFO - PROCESS | 1637 | |i|pagename|runs| 16:59:56 INFO - PROCESS | 1637 | |0;dojo.html;3086.182161727142;3243.9189020274507;3247.1882029492617;3249.2201871550833;3278.9180270493234;5318.494742999409;5400.405955344914;5415.810446634358;5466.945330546693;5499.670019798815;5373.81191658292;5455.645383050099;5461.290032295806;5462.808801691942;5473.31583552055;4957.677750946195;5017.874553136183;5026.597872170236;5028.974855125719;5042.546170844624;4938.654294199408;4948.331975183358;5011.248312753098;5071.290019397269;5072.771725272353;4217.409562661214;5001.9749901250625;5068.391792984847;5069.239614057902;5122.769475373599;4901.558859702608;5051.87370315745;5055.545000949914;5055.949440505585;5091.592672586185;4928.236123400879;4952.603791696655;4967;4969.527894849984;4983.277424773424;5312.442193569658;5423.484768946943;5434.3207099112615;5440.700761458118;5445.646033007842;5928.347881733049;5935.6438613682885;5935.643861368331;5948.97025514874;5950.0479923212515;5968.224130863004;6009.278886533601;6014.2181516403025;6029.095635654643;6042.305134909498;5542.528885044816;5553.16702494629;5556.86107847303;5561.082421400504;5573.693446860421;6077.878442431127;6122.164327060091;6133.622130947118;6143.31058958781;6144.556029333103;5791.044477661138;5818.709064546841;5821.359650438449;5890.528757699374;5899.557533185029;6027.57806953509;6031.698415079229;6038.607490513103;6046.123312119806;6050.818475445743;5718.085106382959;5810.41895810424;5811.82564523065;5814.06974884025;5950.583459157904;5926.081457374114;5978.103284507359;5986.311574169026;6027.276726792813;6030.185924900083;4702.929456058094;4727.125481785881;4737.478877323491;4746.881327966759;4771.165046116916;3532.3818331791836;4195.853145139906;4254.765987870697;4289.806958686867;4294.7852607369505;5392.514673679388;5403.486668766461;5441.918371224435;5496.560275177976;5550.417206193372;5805.796797112081;5807.651540907475;5810.622309549865;5811.186433899257;5815.82552523425;5440.972795136078;5453.863653408696;5457.945420545823;5466.644668096561;5481.725913704299;5019.698818070928;5085.288059671649;5093.312402825645;5094.923576146361;5165.845024649267;5260.736963151827;6241.429005988925;6291.370862913672;6298.212723409574;6309.463695585927;6035.094735789667;6055.485283750931;6065.72704228302;6075.513958883191;6079.635221886701;6138.541671868701;6258.561900666909;6278.6546739929745;6290.748370065329;6297.590656607306;5755.366909639853;5797.652140871562;5826;5852.648841069549;5855.94144058554;5547.611667183259;6040.1543783871175;6049.425304596057;6055.576109672457;6099.695015249308;5253.13323301651;5598.300212473441;5703.458171473703;5748;5786.450287222707;5621.747021383966;5680.602357834912;5690.402507736793;5746.626469279484;5808;5610.803621873215;5656.321241451053;5674.233978413026;5727.8854422912145;5731.426857314235;5787.710614469344;5812.418758124154;5816.970915145566;5825.330087040044;5846.210761547137;5634.661920284796;5658.179563963285;5670.546356291569;5686.2323586315315;5690.118031705092 16:59:56 INFO - PROCESS | 1637 | |1;ext.html;451.9322101684749;463.6128832424923;493.2477971094082;509.86488580526157;513.5224241455447;22222;38101.618983810185;39233.82298531041;39424.408633870444;39437.40843887344;40414.92738770718;40797;40879.79560102203;40895;41042.794786026025;9086.772830679252;9256.490893000882;9265.72202833916;9267.212286955617;9289.581968811386;9192.126747958933;9291.070892910722;9296.44221346718;9306.255499560053;9311.953440232823;9256.120668536512;9323.53382330884;9340.019297973717;9345.813083738356;9382.906170938306;9144;9260.629574817;9347.345685801996;9357.625694972194;9360.531973401303;9075.954620226856;9170.358074934757;9184.265258779282;9188.632454701803;9221.30840186982;38413.03967400809;38822;38863;38887.61112388868;39023;3066.2794243352796;3251.6585758495253;3304.8512816923294;3312.3193722765573;3327.7504187185814;28048.298792530146;28594.714052859414;29429.55855662167;30086.849565752033;30123.63207334946;3150.763692723032;3199.632042315117;3201.27971206479;3223.6453990061073;3283.9343213135603;314962;316533;318231;318598;320805.395973021;55182;55315.17027244595;55347.44652553504;55453.44546554483;55484.445155547925;33288;34007.65992340094;34153.658463415544;34691.4796278056;34967;15376.077435353915;15521.767173492406;15537.223138843012;15554.844451555566;15565.688686226213;11884.40577971098;11947.880521194851;11956.282623042645;11969;11977.64067077989;18040.819591803913;18057.63884722298;18067.72898406525;18092.833754092982;18121.818781812275;6182.454386403399;6268.655223962634;6782.966085169543;7071.116110486189;7515.8121046973165;827.9130691277329;880.1374652840252;927.7263207353847;1000.4047591682937;1023.1201166996377;28019.43961120766;28263.57604635932;29133.12600621985;29355;30077.398452030837;985.261054209343;1068.1134658233648;1077.2136340471343;1125.3135587291745;1129.7345123895877;14459.78310325346;14734.852651473348;15206.08763474195;15342.271419437242;15569.065856048674;546768;551100;551414;552764;553432;53927.730361347945;54245.72877135589;54321.45678543243;54416.72791636016;54479.72760136174;1269.45413472206;1310.344827586207;1319.7426501832051;1326.774448343784;1332.187365706918;28055.0180743673;28836;28969.56545651859;29452.705472944996;29610;43358.78320608503;43563.78218108889;43586.346204806316;43616.781916090215;43619.34570981501;412809;413658;413886.9305653452;413950;415337;25303.746962530877;25668;25694.743052569982;25704.61443078318;25786.8710656453;44609.55390446054;44737.55262447334;44863.65409037734;45182;46154.53845461637;31900.042998710076;34761.65238347584;36618.90143295706;37199.62800371962;38222;32314.83842580772;36868;36904.63095369012;37687.24625507529;38017.4297385545;25912.74087259103;32168.678313217504;37318.62681373151;37362;37861.81069094637;31809.840950795096;33401.49897751584;33528;33543.32913341768;33595;23005.65491517595;24027.51944961126;24777.008919643013;24868.600835768182;25064.874675626506 16:59:56 INFO - PROCESS | 1637 | |2;jquery.html;334.3864009542489;360.3639576148099;368.89855289795304;373.9009162571919;397.0490674833773;13760.58718238452;15175.39298428063;17874.73187902181;19776.208951641955;20929.05819238134;16385.918070409632;20240.135507177594;20447;20552.69170962433;20769.96150192488;5492.752826122814;6004.159417681528;6080.391960803929;6091.969540152293;6099.329073801879;4064.6545043671176;4209.810558524859;5929.703514824263;6064.241969753781;6067.453929146376;4884.365032545764;6615.04081908123;6620.702068406933;6677.799666010027;6682.431993280553;6400.615963042209;6599.769008084742;6654.567453115532;6668.299828517985;6672.399484046459;5535.916961245544;5723.998300297431;5770.88458230833;5770.961226979142;5776.855578610568;24908.750912491007;25272.747272527224;25321.86051627681;25461.61807572888;25636.23091307245;2184.0171922634877;2188;2188.3544354415485;2197.8021978021893;2200.207925146946;15011.24943752808;15307.61730956735;15321.387144514207;15694.843051569453;16217.432164923697;1518.8177418709824;1678.5216213379128;1847.556586419263;1885.886846789197;1920.7503024606851;92124.6968825778;98447;113684.4315778424;115093;120845.39577302057;9156.908430915739;9521.666741664008;9850.753731156778;9956.621764644507;10093.646722364681;12610.558630447891;13147;13182.802257966137;13384;14229.075110117808;6520.509895342474;8097.190280971856;8192.877106843402;8265.876011859827;8377.246047855722;7331.74338898136;8077.798055048671;8135.576274151999;8234.794130146674;8293.668253269801;3709.4435834624483;4378.387025816388;4412.823487060546;4436.6672499562665;4519.909601807945;1655.6192075822628;1823.29803025836;1886.981130188708;1887.7262796894374;1892.176903047179;818.6929901287017;824.1634740738156;906.2568693671126;916.0015583014546;925.0250714723978;20657.89671051635;21422.357329280145;21484.462888427915;21490.925453727563;21550.78449215488;820.9696830477712;852.9701460448855;898.5597057441806;947.6920000999703;961.3654987708079;10707.464626768631;11172.832407513893;11199.440027998731;11215.120705871692;11289.435528223556;554670;557754;557906;567428;572340;130945.34527327302;131405.34297328643;131822.34088829687;134036;136804.9479257812;923.4320892650971;955.5317894231777;983.6262220356361;984.6602921991902;984.945827979468;18392.356267530573;19458.513537161685;19522.707159392336;19528.707069394255;19943.102560384526;43107.353389699805;51987;54412.45587544074;55328.72335638296;55979.72010139923;76660.61669691616;77266.2273377259;77941.83087253809;78878.81681774663;80454;7033.894491582528;7295.23400043009;7437.367823735043;7454.4781865268915;7561.6597253122645;10204.591816327264;11161.44192790341;12130.090243231969;12836.935815320863;13284.867151328363;10842.457877105955;11086.279391839505;11384.829227561428;11489.03628248253;11563.248388854698;11208.383538905438;11228.719282017688;11379.374134422354;11617.477213525242;11840.230385024946;10019.348742331726;11146.888531114586;11576.826347604961;11708.590199342982;11770.941145294219;7381.594012329373;7453.366463850633;7456.925430745623;7504.8499030018;7594.6202689866395;8293.95853020731;10346.275760696679;11378.260413073123;11540.192186546861;11626.069914406997 16:59:56 INFO - PROCESS | 1637 | |3;mootools.html;1326.7479178956003;1464;1488.6799338142298;1636.4681478519476;1797.7483152358673;7426.814329641755;7815.765527034184;7977.880331795013;8300.460470069442;8309.169083091689;8163.061247956472;8229.012518497788;8239.794005149874;8250.793730156749;8255.339572834175;2272.749997500274;2324.7442781294044;2324.8023917966993;2327.2669109230537;2327.8836058197107;2285.69143165673;2330.1262026739973;2333.3233362324904;2339.4502291961376;2343.9765602344014;1946.2506934830121;2253.583087128878;2280.5894938910988;2317.8377513574055;2330.067972810872;2269.8751568663715;2275.0672224388004;2301.42464383904;2303.2169062518824;2309.6997390339316;1908.5610309628723;2288.3706980580305;2309.722833260003;2314.618088015475;2318.258157389619;8267.793305167359;8305.501669899764;8377.748667539923;8393.412461127724;8395.03457102435;4975.800967961277;5180.481951804827;5185.948140518584;5208;5208.479152084799;3022.863971121305;3351.279474912881;3480.1821571930577;3644.2711457708565;3651.2879988402274;1032.34888699886;1035.4822588705647;1068.732816795801;1076.5855145768858;1088.3034857691084;10795.784084318348;10841.67474975752;10920.399378034204;10926.071283940795;10941.671749847597;4160.979195104005;4304.612584867377;4397.428334316583;4399.5820397062225;4403.427554417905;7771.533707977539;8282.509148353354;8669.783255418664;8687.044425113232;8723.60743766532;5073.086844368049;5082.237664350377;5084.110280700863;5084.974575127175;5093.159628661229;3794.3777847445854;4262.104957958863;4378.168148051924;4408.140412619508;4696.741679207608;3565.447355659877;3598.9820050900103;3602.5676918769914;3657.2685462907525;3658.9817050914576;1125.6960620632547;1131.3890499130378;1139.2651739627893;1143.7083543696303;1143.868455127671;847.9279261262739;871.2289623683087;878.2359347367831;915.5422288855572;916.2532535983153;4333.371661109185;5118.436971933084;5556.166575013699;5666.660000399989;5735.598508104476;872.4590753732726;885.9867101993475;896.780288829228;903.7921278106072;961.6009356117133;2954.8670309836107;3565.4117070683046;3629.0020244432994;3742.139307959185;3789.886303410902;9592.520373981273;9913.900860991298;10102;10213.897861021444;10247.641332553325;10192.745181370525;10223.488825558692;10234.976502349855;10237;10275.794484110276;7474.953506509093;7746.57393843344;7771.72798952034;7848.450608457353;7857.764267071997;5411.485908838654;5452.509274165344;5510.173473978935;5521.917171242515;5651.632643878134;9195.632174712937;9296.256299496159;9352.29857760657;9381.390209636353;9482.810343792948;9306.906930930603;9519.619215231312;9565.617375305188;9626.759331016781;9633.662821801203;6553.4101930826455;6687.699053542505;6700.162479690039;6702.128723265944;6728.495362847904;7416.629168541659;7654;7661.808454788675;7704.6918123274445;7776.183500732568;6914.481413893877;7012.789616311519;7027.4729395294535;7063;7139.571625702474;6077.878442431215;6966;6994.300569942965;7023;7135.50051496411;6537.5096867736065;6640.83397915056;6652.10196623469;6653.667316634246;6689.063531105552;4314.374415709767;4561.931571026371;4586.243269860435;4795.017021510512;4818.638602104786;4705.176594095951;4722.574968252737;4819.855404337875;4884.291777692144;4903.387076615423 16:59:56 INFO - PROCESS | 1637 | |4;prototype.html;240.90123049549683;280.28107903228204;299.28023104433845;302.7109110799187;306.46827753847083;4922.93236840527;4961.9255711164315;4967.776450059756;4973.950260497394;4974.950250497494;4387.252698964359;4645.581897629213;4848.321235027099;5115.6930584164975;5168.819091331804;3249.1877030742316;3917.099067214528;3936.815067637467;3943.8816835494836;3999.860004899829;3237.96762032379;3663.9084022899374;3865.8067096645195;3973.403989401598;3996.5803590623;3754.192848537564;3801.023467796744;3876.5348158221054;3920.1771176402967;3934.8426062957446;2870.2824293926415;3247.9119494969214;3814.370628846237;3875.8643447479203;3920.7059470539825;3277.7705560610766;3395.5076513905346;3417.1627951151877;3429.0398688367295;3433.4163192257374;4768.377609014725;4949.430815456232;4958.578520825734;5011.774470148852;5056.570191533724;3745.3632882410056;4390.8024138913825;4462.085272519126;4477.350784136282;4526.3210518422175;5298.794229491179;5339.199120131972;5347.732613369355;5358.732063396815;5368.355797304349;3062.617172853393;3524.9072787435975;3653.342398368293;3715.3126671565847;3718.3307004739136;4626.930596041062;4918;5574.358948720908;5601.523870471015;5607.429919622512;3736.7668669339596;3741.7006639468777;3743.9064023399633;3751.249750049946;3777.1879046005242;3208.9679103209137;3258.6741325867224;3743.9251214976093;3798.905027374338;3819.5607505137264;4153.293940030202;4404.493483249467;4420.7126536775;4428.402165707588;4446.6220371268155;4835.057163853015;5392.519441057158;5448.30308997049;5468.398476167618;5525.364583072998;1065.898739619735;1230.4865016030153;1241.3420886929941;1247.9143145463504;1248.8876001159758;778.3306356533377;783.9686412543548;846.9449485783405;848.2026894719068;863.2691453635421;4323.935140972888;4422.992365191701;4592.67851250416;4900.901981960412;4909.950900491021;4541.321529561066;4863.416390033148;5160.483951604884;5209.4994402686925;5233.685978841206;4102.994766282221;4769.618430525549;4851.854444366674;4868.052778888402;4897.14299997499;2459.8524088554746;2531.8480891146223;2716.470288293803;2733.605861010899;2743.986280068627;5055.747212639427;5180.870478238075;5486.49121491593;5511.862203444946;5537.584681148849;4143.774145912179;4828.879278018007;5238.502342277554;5317.521423071942;5350.68257680233;4230.513490948519;4498.482674492475;5498.230247765316;5506.91739623914;5532.2531458253425;4274.27337352657;4961.975190124026;4968.602511798975;5177.948220517746;5197.518707168439;4497.325401189848;4912.140375434356;5036.597072234139;5128.743562821918;5486;4651.953480465152;4765.880852978565;5306.752913065349;5856.619319744203;5864.824055278348;3664.7068234541707;3844.4809950656304;3854.383298672199;3862.96137038626;3875.147467557133;4632.3051542267585;4859.538343857469;5542.889142217214;5600.60795744294;5678.233438485917;4880.365552478155;5140.920406714482;5469.069848719293;5486.067368547437;5525.226468294361;4999.575036121971;5456.61803673739;5467.699276539828;5504.394516603251;5531.446855314436;4800.951395863582;5182.025255754518;5264.9979023912;5387.595930305321;5391.919121213106;5454.972725136349;5461.208124821958;5461.972690136524;5470.343558772973;5474.507294343528;4667.929981050219;4849.3210950467665;5093.286939828501;5357.946420535744;5392.595555333287 16:59:56 INFO - PROCESS | 1637 | |5;yui.html;594.6016169166658;687.618371803649;699.6222040098347;745.191467258025;821.7740121466597;14206.71586568268;14801.407943682254;15066.924665376686;15085.245737713125;15093.547193584196;14080.155190688565;14737.410503579844;14888;15149.394024239045;15169.165695886722;813.9186081391858;832.1096426823301;834.3658819297317;835.5613303015934;835.6448509383519;649.730361899811;676.7665155521362;676.9323067693241;792.2671528835832;816.4937738602046;881.9029906710257;882.3779235638891;882.7528292078229;883.9469631822079;887.951162686052;878.9296856251484;879.2482427524502;880.5245167609484;881.057268722464;881.3610132653774;503.7053323805578;524.4702850121405;619.9597026193283;642.7621779941452;652.6443088516722;14363.71272574553;14431.49489767853;14443.927780361137;14444.422223111063;14450.92774536131;12541.247525148521;12605.621831345074;12843.422046007952;12848.972082233398;13039.152455090483;11919.404029798563;12189.634310970685;12212.32832194229;12239.388030598435;12643.304618245993;4355.499117601485;4368.104538569585;4446.3552784846015;4564.2240819060835;4566.246569316092;93381.59927601091;93540;93558.53220733853;93710.53144734232;95468.52265738766;10059.195264378832;10142.746431339276;10235.846462303072;10319.535620897077;10469.581216751245;19276.710849337273;19378.287039814437;19378.70931936022;19379.321723739602;19396.903015484833;7273.345398914017;7276.199618042011;7302.087239095114;7378;7548.811279718051;4164.937525937114;4247.830086796494;4249.596288352602;4251.553586873396;4251.617354438115;3200.1039708881085;3266.5263536787033;3267.18320419895;3282.8522716477814;3288.6711328866922;609.4423602403751;613.1262950295811;617.7035023188895;627.4948666323562;650.1483057195089;538.9218563308299;570.1760955419462;580.2717589425245;604.2054698072021;619.3558698953128;8427.073021967579;8503.74488765338;8552.871706924401;8635.568221588896;8888.733337999742;482.8213560982389;512.5929324005629;561.0084201086128;595.0152497616451;611.2115371171228;4075.7554546727292;4185.748855068645;4231.153769246163;4256.787160641956;4286.464191976003;73268.63365683137;74876;91461;114657;115360;82461.17538824535;95397;101263;104146.02320733212;107048;93745;94548;95952;96232;97522.51238743903;6927.68825402848;8179.222973817477;8193.50838949665;8240.564419496062;8473.66105355779;57283;58187.4181258182;58796.41203588081;59829.102563460714;60670.08994865169;53248.20127698165;53324;77892;81677.77483337873;81982.59008704919;8882.60028298741;10294.279400441897;10325.070743632808;10424.739381515523;10545.209109316986;11662.650120496399;11710.297382157098;11754.647360579196;11772.058235341323;12044.698882528008;10963.61627343071;10975.890241097486;11228.4385780709;11316.547338106384;11427.085833133495;10365.274430790074;10530.631427899987;10940;11223.943880280547;11695.239809412362;8712.607932642919;10805.567777289134;10821.621243256448;11222.158338124837;11320.09439244842;8345.874811877706;9118.95440522793;9215.354925155174;9315.814041255888;9505.904940950502;9273.119053689888;9395.671151509665;9429.387089839138;9445.102715242041;9470.668526601536 16:59:56 INFO - PROCESS | 1637 | __end_tp_report 16:59:56 INFO - PROCESS | 1637 | __start_cc_report 16:59:56 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,1425 16:59:56 INFO - PROCESS | 1637 | __end_cc_report 16:59:56 INFO - PROCESS | 1637 | __startTimestamp1479344396458__endTimestamp 16:59:56 INFO - PROCESS | 1637 | 16:59:56 INFO - PROCESS | 1637 | ------- Summary: start ------- 16:59:56 INFO - PROCESS | 1637 | Number of tests: 6 16:59:56 INFO - PROCESS | 1637 | 16:59:56 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5487.00 Median:5656.32 stddev:633.90 (11.2%) stddev-sans-first:607.23 16:59:56 INFO - PROCESS | 1637 | Values: 3086.2 3243.9 3247.2 3249.2 3278.9 5318.5 5400.4 5415.8 5466.9 5499.7 5373.8 5455.6 5461.3 5462.8 5473.3 4957.7 5017.9 5026.6 5029.0 5042.5 4938.7 4948.3 5011.2 5071.3 5072.8 4217.4 5002.0 5068.4 5069.2 5122.8 4901.6 5051.9 5055.5 5055.9 5091.6 4928.2 4952.6 4967.0 4969.5 4983.3 5312.4 5423.5 5434.3 5440.7 5445.6 5928.3 5935.6 5935.6 5949.0 5950.0 5968.2 6009.3 6014.2 6029.1 6042.3 5542.5 5553.2 5556.9 5561.1 5573.7 6077.9 6122.2 6133.6 6143.3 6144.6 5791.0 5818.7 5821.4 5890.5 5899.6 6027.6 6031.7 6038.6 6046.1 6050.8 5718.1 5810.4 5811.8 5814.1 5950.6 5926.1 5978.1 5986.3 6027.3 6030.2 4702.9 4727.1 4737.5 4746.9 4771.2 3532.4 4195.9 4254.8 4289.8 4294.8 5392.5 5403.5 5441.9 5496.6 5550.4 5805.8 5807.7 5810.6 5811.2 5815.8 5441.0 5453.9 5457.9 5466.6 5481.7 5019.7 5085.3 5093.3 5094.9 5165.8 5260.7 6241.4 6291.4 6298.2 6309.5 6035.1 6055.5 6065.7 6075.5 6079.6 6138.5 6258.6 6278.7 6290.7 6297.6 5755.4 5797.7 5826.0 5852.6 5855.9 5547.6 6040.2 6049.4 6055.6 6099.7 5253.1 5598.3 5703.5 5748.0 5786.5 5621.7 5680.6 5690.4 5746.6 5808.0 5610.8 5656.3 5674.2 5727.9 5731.4 5787.7 5812.4 5817.0 5825.3 5846.2 5634.7 5658.2 5670.5 5686.2 5690.1 16:59:56 INFO - PROCESS | 1637 | 16:59:56 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:56421.76 Median:37259.13 stddev:116655.69 (313.1%) stddev-sans-first:116907.25 16:59:56 INFO - PROCESS | 1637 | Values: 451.9 463.6 493.2 509.9 513.5 22222.0 38101.6 39233.8 39424.4 39437.4 40414.9 40797.0 40879.8 40895.0 41042.8 9086.8 9256.5 9265.7 9267.2 9289.6 9192.1 9291.1 9296.4 9306.3 9312.0 9256.1 9323.5 9340.0 9345.8 9382.9 9144.0 9260.6 9347.3 9357.6 9360.5 9076.0 9170.4 9184.3 9188.6 9221.3 38413.0 38822.0 38863.0 38887.6 39023.0 3066.3 3251.7 3304.9 3312.3 3327.8 28048.3 28594.7 29429.6 30086.8 30123.6 3150.8 3199.6 3201.3 3223.6 3283.9 314962.0 316533.0 318231.0 318598.0 320805.4 55182.0 55315.2 55347.4 55453.4 55484.4 33288.0 34007.7 34153.7 34691.5 34967.0 15376.1 15521.8 15537.2 15554.8 15565.7 11884.4 11947.9 11956.3 11969.0 11977.6 18040.8 18057.6 18067.7 18092.8 18121.8 6182.5 6268.7 6783.0 7071.1 7515.8 827.9 880.1 927.7 1000.4 1023.1 28019.4 28263.6 29133.1 29355.0 30077.4 985.3 1068.1 1077.2 1125.3 1129.7 14459.8 14734.9 15206.1 15342.3 15569.1 546768.0 551100.0 551414.0 552764.0 553432.0 53927.7 54245.7 54321.5 54416.7 54479.7 1269.5 1310.3 1319.7 1326.8 1332.2 28055.0 28836.0 28969.6 29452.7 29610.0 43358.8 43563.8 43586.3 43616.8 43619.3 412809.0 413658.0 413886.9 413950.0 415337.0 25303.7 25668.0 25694.7 25704.6 25786.9 44609.6 44737.6 44863.7 45182.0 46154.5 31900.0 34761.7 36618.9 37199.6 38222.0 32314.8 36868.0 36904.6 37687.2 38017.4 25912.7 32168.7 37318.6 37362.0 37861.8 31809.8 33401.5 33528.0 33543.3 33595.0 23005.7 24027.5 24777.0 24868.6 25064.9 16:59:56 INFO - PROCESS | 1637 | 16:59:56 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:33794.64 Median:2039.17 stddev:94107.51 (4615.0%) stddev-sans-first:94337.97 16:59:56 INFO - PROCESS | 1637 | Values: 334.4 360.4 368.9 373.9 397.0 13760.6 15175.4 17874.7 19776.2 20929.1 16385.9 20240.1 20447.0 20552.7 20770.0 5492.8 6004.2 6080.4 6092.0 6099.3 4064.7 4209.8 5929.7 6064.2 6067.5 4884.4 6615.0 6620.7 6677.8 6682.4 6400.6 6599.8 6654.6 6668.3 6672.4 5535.9 5724.0 5770.9 5771.0 5776.9 24908.8 25272.7 25321.9 25461.6 25636.2 2184.0 2188.0 2188.4 2197.8 2200.2 15011.2 15307.6 15321.4 15694.8 16217.4 1518.8 1678.5 1847.6 1885.9 1920.8 92124.7 98447.0 113684.4 115093.0 120845.4 9156.9 9521.7 9850.8 9956.6 10093.6 12610.6 13147.0 13182.8 13384.0 14229.1 6520.5 8097.2 8192.9 8265.9 8377.2 7331.7 8077.8 8135.6 8234.8 8293.7 3709.4 4378.4 4412.8 4436.7 4519.9 1655.6 1823.3 1887.0 1887.7 1892.2 818.7 824.2 906.3 916.0 925.0 20657.9 21422.4 21484.5 21490.9 21550.8 821.0 853.0 898.6 947.7 961.4 10707.5 11172.8 11199.4 11215.1 11289.4 554670.0 557754.0 557906.0 567428.0 572340.0 130945.3 131405.3 131822.3 134036.0 136804.9 923.4 955.5 983.6 984.7 984.9 18392.4 19458.5 19522.7 19528.7 19943.1 43107.4 51987.0 54412.5 55328.7 55979.7 76660.6 77266.2 77941.8 78878.8 80454.0 7033.9 7295.2 7437.4 7454.5 7561.7 10204.6 11161.4 12130.1 12836.9 13284.9 10842.5 11086.3 11384.8 11489.0 11563.2 11208.4 11228.7 11379.4 11617.5 11840.2 10019.3 11146.9 11576.8 11708.6 11770.9 7381.6 7453.4 7456.9 7504.8 7594.6 8294.0 10346.3 11378.3 11540.2 11626.1 16:59:56 INFO - PROCESS | 1637 | 16:59:56 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5336.81 Median:5077.66 stddev:2963.60 (58.4%) stddev-sans-first:2956.59 16:59:56 INFO - PROCESS | 1637 | Values: 1326.7 1464.0 1488.7 1636.5 1797.7 7426.8 7815.8 7977.9 8300.5 8309.2 8163.1 8229.0 8239.8 8250.8 8255.3 2272.7 2324.7 2324.8 2327.3 2327.9 2285.7 2330.1 2333.3 2339.5 2344.0 1946.3 2253.6 2280.6 2317.8 2330.1 2269.9 2275.1 2301.4 2303.2 2309.7 1908.6 2288.4 2309.7 2314.6 2318.3 8267.8 8305.5 8377.7 8393.4 8395.0 4975.8 5180.5 5185.9 5208.0 5208.5 3022.9 3351.3 3480.2 3644.3 3651.3 1032.3 1035.5 1068.7 1076.6 1088.3 10795.8 10841.7 10920.4 10926.1 10941.7 4161.0 4304.6 4397.4 4399.6 4403.4 7771.5 8282.5 8669.8 8687.0 8723.6 5073.1 5082.2 5084.1 5085.0 5093.2 3794.4 4262.1 4378.2 4408.1 4696.7 3565.4 3599.0 3602.6 3657.3 3659.0 1125.7 1131.4 1139.3 1143.7 1143.9 847.9 871.2 878.2 915.5 916.3 4333.4 5118.4 5556.2 5666.7 5735.6 872.5 886.0 896.8 903.8 961.6 2954.9 3565.4 3629.0 3742.1 3789.9 9592.5 9913.9 10102.0 10213.9 10247.6 10192.7 10223.5 10235.0 10237.0 10275.8 7475.0 7746.6 7771.7 7848.5 7857.8 5411.5 5452.5 5510.2 5521.9 5651.6 9195.6 9296.3 9352.3 9381.4 9482.8 9306.9 9519.6 9565.6 9626.8 9633.7 6553.4 6687.7 6700.2 6702.1 6728.5 7416.6 7654.0 7661.8 7704.7 7776.2 6914.5 7012.8 7027.5 7063.0 7139.6 6077.9 6966.0 6994.3 7023.0 7135.5 6537.5 6640.8 6652.1 6653.7 6689.1 4314.4 4561.9 4586.2 4795.0 4818.6 4705.2 4722.6 4819.9 4884.3 4903.4 16:59:56 INFO - PROCESS | 1637 | 16:59:56 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4277.22 Median:4831.97 stddev:1313.93 (27.2%) stddev-sans-first:1282.22 16:59:56 INFO - PROCESS | 1637 | Values: 240.9 280.3 299.3 302.7 306.5 4922.9 4961.9 4967.8 4974.0 4975.0 4387.3 4645.6 4848.3 5115.7 5168.8 3249.2 3917.1 3936.8 3943.9 3999.9 3238.0 3663.9 3865.8 3973.4 3996.6 3754.2 3801.0 3876.5 3920.2 3934.8 2870.3 3247.9 3814.4 3875.9 3920.7 3277.8 3395.5 3417.2 3429.0 3433.4 4768.4 4949.4 4958.6 5011.8 5056.6 3745.4 4390.8 4462.1 4477.4 4526.3 5298.8 5339.2 5347.7 5358.7 5368.4 3062.6 3524.9 3653.3 3715.3 3718.3 4626.9 4918.0 5574.4 5601.5 5607.4 3736.8 3741.7 3743.9 3751.2 3777.2 3209.0 3258.7 3743.9 3798.9 3819.6 4153.3 4404.5 4420.7 4428.4 4446.6 4835.1 5392.5 5448.3 5468.4 5525.4 1065.9 1230.5 1241.3 1247.9 1248.9 778.3 784.0 846.9 848.2 863.3 4323.9 4423.0 4592.7 4900.9 4910.0 4541.3 4863.4 5160.5 5209.5 5233.7 4103.0 4769.6 4851.9 4868.1 4897.1 2459.9 2531.8 2716.5 2733.6 2744.0 5055.7 5180.9 5486.5 5511.9 5537.6 4143.8 4828.9 5238.5 5317.5 5350.7 4230.5 4498.5 5498.2 5506.9 5532.3 4274.3 4962.0 4968.6 5177.9 5197.5 4497.3 4912.1 5036.6 5128.7 5486.0 4652.0 4765.9 5306.8 5856.6 5864.8 3664.7 3844.5 3854.4 3863.0 3875.1 4632.3 4859.5 5542.9 5600.6 5678.2 4880.4 5140.9 5469.1 5486.1 5525.2 4999.6 5456.6 5467.7 5504.4 5531.4 4801.0 5182.0 5265.0 5387.6 5391.9 5455.0 5461.2 5462.0 5470.3 5474.5 4667.9 4849.3 5093.3 5357.9 5392.6 16:59:56 INFO - PROCESS | 1637 | 16:59:56 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:20233.21 Median:565.59 stddev:30387.47 (5372.7%) stddev-sans-first:30436.94 16:59:56 INFO - PROCESS | 1637 | Values: 594.6 687.6 699.6 745.2 821.8 14206.7 14801.4 15066.9 15085.2 15093.5 14080.2 14737.4 14888.0 15149.4 15169.2 813.9 832.1 834.4 835.6 835.6 649.7 676.8 676.9 792.3 816.5 881.9 882.4 882.8 883.9 888.0 878.9 879.2 880.5 881.1 881.4 503.7 524.5 620.0 642.8 652.6 14363.7 14431.5 14443.9 14444.4 14450.9 12541.2 12605.6 12843.4 12849.0 13039.2 11919.4 12189.6 12212.3 12239.4 12643.3 4355.5 4368.1 4446.4 4564.2 4566.2 93381.6 93540.0 93558.5 93710.5 95468.5 10059.2 10142.7 10235.8 10319.5 10469.6 19276.7 19378.3 19378.7 19379.3 19396.9 7273.3 7276.2 7302.1 7378.0 7548.8 4164.9 4247.8 4249.6 4251.6 4251.6 3200.1 3266.5 3267.2 3282.9 3288.7 609.4 613.1 617.7 627.5 650.1 538.9 570.2 580.3 604.2 619.4 8427.1 8503.7 8552.9 8635.6 8888.7 482.8 512.6 561.0 595.0 611.2 4075.8 4185.7 4231.2 4256.8 4286.5 73268.6 74876.0 91461.0 114657.0 115360.0 82461.2 95397.0 101263.0 104146.0 107048.0 93745.0 94548.0 95952.0 96232.0 97522.5 6927.7 8179.2 8193.5 8240.6 8473.7 57283.0 58187.4 58796.4 59829.1 60670.1 53248.2 53324.0 77892.0 81677.8 81982.6 8882.6 10294.3 10325.1 10424.7 10545.2 11662.7 11710.3 11754.6 11772.1 12044.7 10963.6 10975.9 11228.4 11316.5 11427.1 10365.3 10530.6 10940.0 11223.9 11695.2 8712.6 10805.6 10821.6 11222.2 11320.1 8345.9 9119.0 9215.4 9315.8 9505.9 9273.1 9395.7 9429.4 9445.1 9470.7 16:59:56 INFO - PROCESS | 1637 | -------- Summary: end -------- 16:59:56 INFO - PROCESS | 1637 | 16:59:57 INFO - TEST-INFO | 1637: exit 0 16:59:57 INFO - TEST-OK | dromaeo_css | took 1118608ms 16:59:57 INFO - TEST-START | kraken 16:59:57 INFO - operating with platform_type : mac_ 16:59:57 INFO - Initialising browser for kraken test... 16:59:57 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/tmp7qGgol/profile http://localhost:49241/getInfo.html) 16:59:59 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 16:59:59 INFO - PROCESS | 1647 | colorDepth:24 16:59:59 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 16:59:59 INFO - PROCESS | 1647 | __metrics 16:59:59 INFO - PROCESS | 1647 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:59:59 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:00:00 INFO - TEST-INFO | 1647: exit 0 17:00:00 INFO - Browser initialized. 17:00:00 INFO - Running cycle 1/1 for kraken test... 17:00:00 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/tmp7qGgol/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:00:12 INFO - PROCESS | 1648 | RSS: Main: 232943616 17:00:12 INFO - PROCESS | 1648 | 17:00:15 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 17:00:16 INFO - PROCESS | 1648 | RSS: Main: 291622912 17:00:16 INFO - PROCESS | 1648 | 17:00:18 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 17:00:19 INFO - PROCESS | 1648 | RSS: Main: 294125568 17:00:19 INFO - PROCESS | 1648 | 17:00:23 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 17:00:23 INFO - PROCESS | 1648 | RSS: Main: 381882368 17:00:23 INFO - PROCESS | 1648 | 17:00:25 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 17:00:26 INFO - PROCESS | 1648 | RSS: Main: 284438528 17:00:26 INFO - PROCESS | 1648 | 17:00:28 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:00:28 INFO - PROCESS | 1648 | RSS: Main: 289144832 17:00:28 INFO - PROCESS | 1648 | 17:00:31 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 17:00:32 INFO - PROCESS | 1648 | RSS: Main: 332083200 17:00:32 INFO - PROCESS | 1648 | 17:00:35 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 17:00:36 INFO - PROCESS | 1648 | RSS: Main: 332115968 17:00:36 INFO - PROCESS | 1648 | 17:00:38 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 17:00:39 INFO - PROCESS | 1648 | RSS: Main: 331001856 17:00:39 INFO - PROCESS | 1648 | 17:00:40 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:00:41 INFO - PROCESS | 1648 | RSS: Main: 308551680 17:00:41 INFO - PROCESS | 1648 | 17:00:43 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:00:44 INFO - PROCESS | 1648 | RSS: Main: 307884032 17:00:44 INFO - PROCESS | 1648 | 17:00:46 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:00:47 INFO - PROCESS | 1648 | RSS: Main: 312340480 17:00:47 INFO - PROCESS | 1648 | 17:00:49 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:00:50 INFO - PROCESS | 1648 | RSS: Main: 319373312 17:00:50 INFO - PROCESS | 1648 | 17:00:53 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:00:54 INFO - PROCESS | 1648 | RSS: Main: 319741952 17:00:54 INFO - PROCESS | 1648 | 17:00:56 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 17:00:56 INFO - PROCESS | 1648 | RSS: Main: 363012096 17:00:56 INFO - PROCESS | 1648 | 17:00:56 INFO - PROCESS | 1648 | __start_tp_report 17:00:56 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 17:00:56 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 17:00:56 INFO - PROCESS | 1648 | |i|pagename|runs| 17:00:56 INFO - PROCESS | 1648 | |0;ai-astar;112;113;113;113;113;114;113;113;119;161 17:00:56 INFO - PROCESS | 1648 | |1;audio-beat-detection;149;111;113;155;126;145;145;117;144;112 17:00:56 INFO - PROCESS | 1648 | |2;audio-dft;186;180;184;185;187;182;184;187;178;183 17:00:56 INFO - PROCESS | 1648 | |3;audio-fft;79;68;59;87;61;58;57;59;83;58 17:00:56 INFO - PROCESS | 1648 | |4;audio-oscillator;87;69;92;72;71;69;90;67;68;93 17:00:56 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;91;86;89;88;90;87;89;88;90;85 17:00:56 INFO - PROCESS | 1648 | |6;imaging-darkroom;100;97;97;98;98;98;123;160;97;98 17:00:56 INFO - PROCESS | 1648 | |7;imaging-desaturate;85;85;84;85;87;87;88;85;85;86 17:00:56 INFO - PROCESS | 1648 | |8;json-parse-financial;54;52;53;54;53;55;55;54;54;54 17:00:56 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;66;75;81;72;72;71;72;72;72;72 17:00:56 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;87;87;86;86;89;90;85;80;85;101 17:00:56 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;150;147;153;157;146;143;145;146;186;148 17:00:56 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;181;172;172;236;181;175;176;175;174;174 17:00:56 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;68;69;68;67;82;74;67;67;68;68 17:00:56 INFO - PROCESS | 1648 | __end_tp_report 17:00:56 INFO - PROCESS | 1648 | __start_cc_report 17:00:56 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,2052 17:00:56 INFO - PROCESS | 1648 | __end_cc_report 17:00:56 INFO - PROCESS | 1648 | __startTimestamp1479344456422__endTimestamp 17:00:56 INFO - PROCESS | 1648 | 17:00:56 INFO - PROCESS | 1648 | ------- Summary: start ------- 17:00:56 INFO - PROCESS | 1648 | Number of tests: 14 17:00:56 INFO - PROCESS | 1648 | 17:00:56 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:118.40 Median:113.00 stddev:15.09 (13.4%) stddev-sans-first:15.83 17:00:56 INFO - PROCESS | 1648 | Values: 112.0 113.0 113.0 113.0 113.0 114.0 113.0 113.0 119.0 161.0 17:00:56 INFO - PROCESS | 1648 | 17:00:56 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:131.70 Median:144.50 stddev:17.52 (12.1%) stddev-sans-first:17.43 17:00:56 INFO - PROCESS | 1648 | Values: 149.0 111.0 113.0 155.0 126.0 145.0 145.0 117.0 144.0 112.0 17:00:56 INFO - PROCESS | 1648 | 17:00:56 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:183.60 Median:184.50 stddev:2.95 (1.6%) stddev-sans-first:3.00 17:00:56 INFO - PROCESS | 1648 | Values: 186.0 180.0 184.0 185.0 187.0 182.0 184.0 187.0 178.0 183.0 17:00:56 INFO - PROCESS | 1648 | 17:00:56 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:66.90 Median:64.50 stddev:11.68 (18.1%) stddev-sans-first:11.53 17:00:56 INFO - PROCESS | 1648 | Values: 79.0 68.0 59.0 87.0 61.0 58.0 57.0 59.0 83.0 58.0 17:00:56 INFO - PROCESS | 1648 | 17:00:56 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:79.50 stddev:11.12 (14.0%) stddev-sans-first:11.29 17:00:56 INFO - PROCESS | 1648 | Values: 87.0 69.0 92.0 72.0 71.0 69.0 90.0 67.0 68.0 93.0 17:00:56 INFO - PROCESS | 1648 | 17:00:56 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:88.30 Median:89.00 stddev:1.89 (2.1%) stddev-sans-first:1.73 17:00:56 INFO - PROCESS | 1648 | Values: 91.0 86.0 89.0 88.0 90.0 87.0 89.0 88.0 90.0 85.0 17:00:56 INFO - PROCESS | 1648 | 17:00:56 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:106.60 Median:97.50 stddev:20.38 (20.9%) stddev-sans-first:21.47 17:00:56 INFO - PROCESS | 1648 | Values: 100.0 97.0 97.0 98.0 98.0 98.0 123.0 160.0 97.0 98.0 17:00:56 INFO - PROCESS | 1648 | 17:00:56 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:85.50 stddev:1.25 (1.5%) stddev-sans-first:1.30 17:00:56 INFO - PROCESS | 1648 | Values: 85.0 85.0 84.0 85.0 87.0 87.0 88.0 85.0 85.0 86.0 17:00:56 INFO - PROCESS | 1648 | 17:00:56 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:0.92 (1.7%) stddev-sans-first:0.97 17:00:56 INFO - PROCESS | 1648 | Values: 54.0 52.0 53.0 54.0 53.0 55.0 55.0 54.0 54.0 54.0 17:00:56 INFO - PROCESS | 1648 | 17:00:56 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:72.50 Median:72.00 stddev:3.72 (5.2%) stddev-sans-first:3.11 17:00:56 INFO - PROCESS | 1648 | Values: 66.0 75.0 81.0 72.0 72.0 71.0 72.0 72.0 72.0 72.0 17:00:56 INFO - PROCESS | 1648 | 17:00:56 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:86.50 stddev:5.42 (6.3%) stddev-sans-first:5.74 17:00:56 INFO - PROCESS | 1648 | Values: 87.0 87.0 86.0 86.0 89.0 90.0 85.0 80.0 85.0 101.0 17:00:56 INFO - PROCESS | 1648 | 17:00:56 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:152.10 Median:149.00 stddev:12.60 (8.5%) stddev-sans-first:13.34 17:00:56 INFO - PROCESS | 1648 | Values: 150.0 147.0 153.0 157.0 146.0 143.0 145.0 146.0 186.0 148.0 17:00:56 INFO - PROCESS | 1648 | 17:00:56 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.60 Median:175.50 stddev:19.37 (11.0%) stddev-sans-first:20.55 17:00:56 INFO - PROCESS | 1648 | Values: 181.0 172.0 172.0 236.0 181.0 175.0 176.0 175.0 174.0 174.0 17:00:56 INFO - PROCESS | 1648 | 17:00:56 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:68.00 stddev:4.76 (7.0%) stddev-sans-first:5.00 17:00:56 INFO - PROCESS | 1648 | Values: 68.0 69.0 68.0 67.0 82.0 74.0 67.0 67.0 68.0 68.0 17:00:56 INFO - PROCESS | 1648 | -------- Summary: end -------- 17:00:56 INFO - PROCESS | 1648 | 17:00:57 INFO - TEST-INFO | 1648: exit 0 17:00:57 INFO - TEST-OK | kraken | took 60251ms 17:00:57 INFO - SUITE-END | took 1178s 17:00:57 INFO - Completed test suite (00:19:39) 17:00:57 INFO - javascript benchmark 17:00:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3086.182161727142, 3243.9189020274507, 3247.1882029492617, 3249.2201871550833, 3278.9180270493234, 5318.494742999409, 5400.405955344914, 5415.810446634358, 5466.945330546693, 5499.670019798815, 5373.81191658292, 5455.645383050099, 5461.290032295806, 5462.808801691942, 5473.31583552055, 4957.677750946195, 5017.874553136183, 5026.597872170236, 5028.974855125719, 5042.546170844624, 4938.654294199408, 4948.331975183358, 5011.248312753098, 5071.290019397269, 5072.771725272353, 4217.409562661214, 5001.9749901250625, 5068.391792984847, 5069.239614057902, 5122.769475373599, 4901.558859702608, 5051.87370315745, 5055.545000949914, 5055.949440505585, 5091.592672586185, 4928.236123400879, 4952.603791696655, 4967.0, 4969.527894849984, 4983.277424773424, 5312.442193569658, 5423.484768946943, 5434.3207099112615, 5440.700761458118, 5445.646033007842, 5928.347881733049, 5935.6438613682885, 5935.643861368331, 5948.97025514874, 5950.0479923212515, 5968.224130863004, 6009.278886533601, 6014.2181516403025, 6029.095635654643, 6042.305134909498, 5542.528885044816, 5553.16702494629, 5556.86107847303, 5561.082421400504, 5573.693446860421, 6077.878442431127, 6122.164327060091, 6133.622130947118, 6143.31058958781, 6144.556029333103, 5791.044477661138, 5818.709064546841, 5821.359650438449, 5890.528757699374, 5899.557533185029, 6027.57806953509, 6031.698415079229, 6038.607490513103, 6046.123312119806, 6050.818475445743, 5718.085106382959, 5810.41895810424, 5811.82564523065, 5814.06974884025, 5950.583459157904, 5926.081457374114, 5978.103284507359, 5986.311574169026, 6027.276726792813, 6030.185924900083, 4702.929456058094, 4727.125481785881, 4737.478877323491, 4746.881327966759, 4771.165046116916, 3532.3818331791836, 4195.853145139906, 4254.765987870697, 4289.806958686867, 4294.7852607369505, 5392.514673679388, 5403.486668766461, 5441.918371224435, 5496.560275177976, 5550.417206193372, 5805.796797112081, 5807.651540907475, 5810.622309549865, 5811.186433899257, 5815.82552523425, 5440.972795136078, 5453.863653408696, 5457.945420545823, 5466.644668096561, 5481.725913704299, 5019.698818070928, 5085.288059671649, 5093.312402825645, 5094.923576146361, 5165.845024649267, 5260.736963151827, 6241.429005988925, 6291.370862913672, 6298.212723409574, 6309.463695585927, 6035.094735789667, 6055.485283750931, 6065.72704228302, 6075.513958883191, 6079.635221886701, 6138.541671868701, 6258.561900666909, 6278.6546739929745, 6290.748370065329, 6297.590656607306, 5755.366909639853, 5797.652140871562, 5826.0, 5852.648841069549, 5855.94144058554, 5547.611667183259, 6040.1543783871175, 6049.425304596057, 6055.576109672457, 6099.695015249308, 5253.13323301651, 5598.300212473441, 5703.458171473703, 5748.0, 5786.450287222707, 5621.747021383966, 5680.602357834912, 5690.402507736793, 5746.626469279484, 5808.0, 5610.803621873215, 5656.321241451053, 5674.233978413026, 5727.8854422912145, 5731.426857314235, 5787.710614469344, 5812.418758124154, 5816.970915145566, 5825.330087040044, 5846.210761547137, 5634.661920284796, 5658.179563963285, 5670.546356291569, 5686.2323586315315, 5690.118031705092], "value": 5445.54333624748, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [451.9322101684749, 463.6128832424923, 493.2477971094082, 509.86488580526157, 513.5224241455447, 22222.0, 38101.618983810185, 39233.82298531041, 39424.408633870444, 39437.40843887344, 40414.92738770718, 40797.0, 40879.79560102203, 40895.0, 41042.794786026025, 9086.772830679252, 9256.490893000882, 9265.72202833916, 9267.212286955617, 9289.581968811386, 9192.126747958933, 9291.070892910722, 9296.44221346718, 9306.255499560053, 9311.953440232823, 9256.120668536512, 9323.53382330884, 9340.019297973717, 9345.813083738356, 9382.906170938306, 9144.0, 9260.629574817, 9347.345685801996, 9357.625694972194, 9360.531973401303, 9075.954620226856, 9170.358074934757, 9184.265258779282, 9188.632454701803, 9221.30840186982, 38413.03967400809, 38822.0, 38863.0, 38887.61112388868, 39023.0, 3066.2794243352796, 3251.6585758495253, 3304.8512816923294, 3312.3193722765573, 3327.7504187185814, 28048.298792530146, 28594.714052859414, 29429.55855662167, 30086.849565752033, 30123.63207334946, 3150.763692723032, 3199.632042315117, 3201.27971206479, 3223.6453990061073, 3283.9343213135603, 314962.0, 316533.0, 318231.0, 318598.0, 320805.395973021, 55182.0, 55315.17027244595, 55347.44652553504, 55453.44546554483, 55484.445155547925, 33288.0, 34007.65992340094, 34153.658463415544, 34691.4796278056, 34967.0, 15376.077435353915, 15521.767173492406, 15537.223138843012, 15554.844451555566, 15565.688686226213, 11884.40577971098, 11947.880521194851, 11956.282623042645, 11969.0, 11977.64067077989, 18040.819591803913, 18057.63884722298, 18067.72898406525, 18092.833754092982, 18121.818781812275, 6182.454386403399, 6268.655223962634, 6782.966085169543, 7071.116110486189, 7515.8121046973165, 827.9130691277329, 880.1374652840252, 927.7263207353847, 1000.4047591682937, 1023.1201166996377, 28019.43961120766, 28263.57604635932, 29133.12600621985, 29355.0, 30077.398452030837, 985.261054209343, 1068.1134658233648, 1077.2136340471343, 1125.3135587291745, 1129.7345123895877, 14459.78310325346, 14734.852651473348, 15206.08763474195, 15342.271419437242, 15569.065856048674, 546768.0, 551100.0, 551414.0, 552764.0, 553432.0, 53927.730361347945, 54245.72877135589, 54321.45678543243, 54416.72791636016, 54479.72760136174, 1269.45413472206, 1310.344827586207, 1319.7426501832051, 1326.774448343784, 1332.187365706918, 28055.0180743673, 28836.0, 28969.56545651859, 29452.705472944996, 29610.0, 43358.78320608503, 43563.78218108889, 43586.346204806316, 43616.781916090215, 43619.34570981501, 412809.0, 413658.0, 413886.9305653452, 413950.0, 415337.0, 25303.746962530877, 25668.0, 25694.743052569982, 25704.61443078318, 25786.8710656453, 44609.55390446054, 44737.55262447334, 44863.65409037734, 45182.0, 46154.53845461637, 31900.042998710076, 34761.65238347584, 36618.90143295706, 37199.62800371962, 38222.0, 32314.83842580772, 36868.0, 36904.63095369012, 37687.24625507529, 38017.4297385545, 25912.74087259103, 32168.678313217504, 37318.62681373151, 37362.0, 37861.81069094637, 31809.840950795096, 33401.49897751584, 33528.0, 33543.32913341768, 33595.0, 23005.65491517595, 24027.51944961126, 24777.008919643013, 24868.600835768182, 25064.874675626506], "value": 18319.52998102051, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.3864009542489, 360.3639576148099, 368.89855289795304, 373.9009162571919, 397.0490674833773, 13760.58718238452, 15175.39298428063, 17874.73187902181, 19776.208951641955, 20929.05819238134, 16385.918070409632, 20240.135507177594, 20447.0, 20552.69170962433, 20769.96150192488, 5492.752826122814, 6004.159417681528, 6080.391960803929, 6091.969540152293, 6099.329073801879, 4064.6545043671176, 4209.810558524859, 5929.703514824263, 6064.241969753781, 6067.453929146376, 4884.365032545764, 6615.04081908123, 6620.702068406933, 6677.799666010027, 6682.431993280553, 6400.615963042209, 6599.769008084742, 6654.567453115532, 6668.299828517985, 6672.399484046459, 5535.916961245544, 5723.998300297431, 5770.88458230833, 5770.961226979142, 5776.855578610568, 24908.750912491007, 25272.747272527224, 25321.86051627681, 25461.61807572888, 25636.23091307245, 2184.0171922634877, 2188.0, 2188.3544354415485, 2197.8021978021893, 2200.207925146946, 15011.24943752808, 15307.61730956735, 15321.387144514207, 15694.843051569453, 16217.432164923697, 1518.8177418709824, 1678.5216213379128, 1847.556586419263, 1885.886846789197, 1920.7503024606851, 92124.6968825778, 98447.0, 113684.4315778424, 115093.0, 120845.39577302057, 9156.908430915739, 9521.666741664008, 9850.753731156778, 9956.621764644507, 10093.646722364681, 12610.558630447891, 13147.0, 13182.802257966137, 13384.0, 14229.075110117808, 6520.509895342474, 8097.190280971856, 8192.877106843402, 8265.876011859827, 8377.246047855722, 7331.74338898136, 8077.798055048671, 8135.576274151999, 8234.794130146674, 8293.668253269801, 3709.4435834624483, 4378.387025816388, 4412.823487060546, 4436.6672499562665, 4519.909601807945, 1655.6192075822628, 1823.29803025836, 1886.981130188708, 1887.7262796894374, 1892.176903047179, 818.6929901287017, 824.1634740738156, 906.2568693671126, 916.0015583014546, 925.0250714723978, 20657.89671051635, 21422.357329280145, 21484.462888427915, 21490.925453727563, 21550.78449215488, 820.9696830477712, 852.9701460448855, 898.5597057441806, 947.6920000999703, 961.3654987708079, 10707.464626768631, 11172.832407513893, 11199.440027998731, 11215.120705871692, 11289.435528223556, 554670.0, 557754.0, 557906.0, 567428.0, 572340.0, 130945.34527327302, 131405.34297328643, 131822.34088829687, 134036.0, 136804.9479257812, 923.4320892650971, 955.5317894231777, 983.6262220356361, 984.6602921991902, 984.945827979468, 18392.356267530573, 19458.513537161685, 19522.707159392336, 19528.707069394255, 19943.102560384526, 43107.353389699805, 51987.0, 54412.45587544074, 55328.72335638296, 55979.72010139923, 76660.61669691616, 77266.2273377259, 77941.83087253809, 78878.81681774663, 80454.0, 7033.894491582528, 7295.23400043009, 7437.367823735043, 7454.4781865268915, 7561.6597253122645, 10204.591816327264, 11161.44192790341, 12130.090243231969, 12836.935815320863, 13284.867151328363, 10842.457877105955, 11086.279391839505, 11384.829227561428, 11489.03628248253, 11563.248388854698, 11208.383538905438, 11228.719282017688, 11379.374134422354, 11617.477213525242, 11840.230385024946, 10019.348742331726, 11146.888531114586, 11576.826347604961, 11708.590199342982, 11770.941145294219, 7381.594012329373, 7453.366463850633, 7456.925430745623, 7504.8499030018, 7594.6202689866395, 8293.95853020731, 10346.275760696679, 11378.260413073123, 11540.192186546861, 11626.069914406997], "value": 9400.626636062014, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1326.7479178956003, 1464.0, 1488.6799338142298, 1636.4681478519476, 1797.7483152358673, 7426.814329641755, 7815.765527034184, 7977.880331795013, 8300.460470069442, 8309.169083091689, 8163.061247956472, 8229.012518497788, 8239.794005149874, 8250.793730156749, 8255.339572834175, 2272.749997500274, 2324.7442781294044, 2324.8023917966993, 2327.2669109230537, 2327.8836058197107, 2285.69143165673, 2330.1262026739973, 2333.3233362324904, 2339.4502291961376, 2343.9765602344014, 1946.2506934830121, 2253.583087128878, 2280.5894938910988, 2317.8377513574055, 2330.067972810872, 2269.8751568663715, 2275.0672224388004, 2301.42464383904, 2303.2169062518824, 2309.6997390339316, 1908.5610309628723, 2288.3706980580305, 2309.722833260003, 2314.618088015475, 2318.258157389619, 8267.793305167359, 8305.501669899764, 8377.748667539923, 8393.412461127724, 8395.03457102435, 4975.800967961277, 5180.481951804827, 5185.948140518584, 5208.0, 5208.479152084799, 3022.863971121305, 3351.279474912881, 3480.1821571930577, 3644.2711457708565, 3651.2879988402274, 1032.34888699886, 1035.4822588705647, 1068.732816795801, 1076.5855145768858, 1088.3034857691084, 10795.784084318348, 10841.67474975752, 10920.399378034204, 10926.071283940795, 10941.671749847597, 4160.979195104005, 4304.612584867377, 4397.428334316583, 4399.5820397062225, 4403.427554417905, 7771.533707977539, 8282.509148353354, 8669.783255418664, 8687.044425113232, 8723.60743766532, 5073.086844368049, 5082.237664350377, 5084.110280700863, 5084.974575127175, 5093.159628661229, 3794.3777847445854, 4262.104957958863, 4378.168148051924, 4408.140412619508, 4696.741679207608, 3565.447355659877, 3598.9820050900103, 3602.5676918769914, 3657.2685462907525, 3658.9817050914576, 1125.6960620632547, 1131.3890499130378, 1139.2651739627893, 1143.7083543696303, 1143.868455127671, 847.9279261262739, 871.2289623683087, 878.2359347367831, 915.5422288855572, 916.2532535983153, 4333.371661109185, 5118.436971933084, 5556.166575013699, 5666.660000399989, 5735.598508104476, 872.4590753732726, 885.9867101993475, 896.780288829228, 903.7921278106072, 961.6009356117133, 2954.8670309836107, 3565.4117070683046, 3629.0020244432994, 3742.139307959185, 3789.886303410902, 9592.520373981273, 9913.900860991298, 10102.0, 10213.897861021444, 10247.641332553325, 10192.745181370525, 10223.488825558692, 10234.976502349855, 10237.0, 10275.794484110276, 7474.953506509093, 7746.57393843344, 7771.72798952034, 7848.450608457353, 7857.764267071997, 5411.485908838654, 5452.509274165344, 5510.173473978935, 5521.917171242515, 5651.632643878134, 9195.632174712937, 9296.256299496159, 9352.29857760657, 9381.390209636353, 9482.810343792948, 9306.906930930603, 9519.619215231312, 9565.617375305188, 9626.759331016781, 9633.662821801203, 6553.4101930826455, 6687.699053542505, 6700.162479690039, 6702.128723265944, 6728.495362847904, 7416.629168541659, 7654.0, 7661.808454788675, 7704.6918123274445, 7776.183500732568, 6914.481413893877, 7012.789616311519, 7027.4729395294535, 7063.0, 7139.571625702474, 6077.878442431215, 6966.0, 6994.300569942965, 7023.0, 7135.50051496411, 6537.5096867736065, 6640.83397915056, 6652.10196623469, 6653.667316634246, 6689.063531105552, 4314.374415709767, 4561.931571026371, 4586.243269860435, 4795.017021510512, 4818.638602104786, 4705.176594095951, 4722.574968252737, 4819.855404337875, 4884.291777692144, 4903.387076615423], "value": 4316.1444649653295, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [240.90123049549683, 280.28107903228204, 299.28023104433845, 302.7109110799187, 306.46827753847083, 4922.93236840527, 4961.9255711164315, 4967.776450059756, 4973.950260497394, 4974.950250497494, 4387.252698964359, 4645.581897629213, 4848.321235027099, 5115.6930584164975, 5168.819091331804, 3249.1877030742316, 3917.099067214528, 3936.815067637467, 3943.8816835494836, 3999.860004899829, 3237.96762032379, 3663.9084022899374, 3865.8067096645195, 3973.403989401598, 3996.5803590623, 3754.192848537564, 3801.023467796744, 3876.5348158221054, 3920.1771176402967, 3934.8426062957446, 2870.2824293926415, 3247.9119494969214, 3814.370628846237, 3875.8643447479203, 3920.7059470539825, 3277.7705560610766, 3395.5076513905346, 3417.1627951151877, 3429.0398688367295, 3433.4163192257374, 4768.377609014725, 4949.430815456232, 4958.578520825734, 5011.774470148852, 5056.570191533724, 3745.3632882410056, 4390.8024138913825, 4462.085272519126, 4477.350784136282, 4526.3210518422175, 5298.794229491179, 5339.199120131972, 5347.732613369355, 5358.732063396815, 5368.355797304349, 3062.617172853393, 3524.9072787435975, 3653.342398368293, 3715.3126671565847, 3718.3307004739136, 4626.930596041062, 4918.0, 5574.358948720908, 5601.523870471015, 5607.429919622512, 3736.7668669339596, 3741.7006639468777, 3743.9064023399633, 3751.249750049946, 3777.1879046005242, 3208.9679103209137, 3258.6741325867224, 3743.9251214976093, 3798.905027374338, 3819.5607505137264, 4153.293940030202, 4404.493483249467, 4420.7126536775, 4428.402165707588, 4446.6220371268155, 4835.057163853015, 5392.519441057158, 5448.30308997049, 5468.398476167618, 5525.364583072998, 1065.898739619735, 1230.4865016030153, 1241.3420886929941, 1247.9143145463504, 1248.8876001159758, 778.3306356533377, 783.9686412543548, 846.9449485783405, 848.2026894719068, 863.2691453635421, 4323.935140972888, 4422.992365191701, 4592.67851250416, 4900.901981960412, 4909.950900491021, 4541.321529561066, 4863.416390033148, 5160.483951604884, 5209.4994402686925, 5233.685978841206, 4102.994766282221, 4769.618430525549, 4851.854444366674, 4868.052778888402, 4897.14299997499, 2459.8524088554746, 2531.8480891146223, 2716.470288293803, 2733.605861010899, 2743.986280068627, 5055.747212639427, 5180.870478238075, 5486.49121491593, 5511.862203444946, 5537.584681148849, 4143.774145912179, 4828.879278018007, 5238.502342277554, 5317.521423071942, 5350.68257680233, 4230.513490948519, 4498.482674492475, 5498.230247765316, 5506.91739623914, 5532.2531458253425, 4274.27337352657, 4961.975190124026, 4968.602511798975, 5177.948220517746, 5197.518707168439, 4497.325401189848, 4912.140375434356, 5036.597072234139, 5128.743562821918, 5486.0, 4651.953480465152, 4765.880852978565, 5306.752913065349, 5856.619319744203, 5864.824055278348, 3664.7068234541707, 3844.4809950656304, 3854.383298672199, 3862.96137038626, 3875.147467557133, 4632.3051542267585, 4859.538343857469, 5542.889142217214, 5600.60795744294, 5678.233438485917, 4880.365552478155, 5140.920406714482, 5469.069848719293, 5486.067368547437, 5525.226468294361, 4999.575036121971, 5456.61803673739, 5467.699276539828, 5504.394516603251, 5531.446855314436, 4800.951395863582, 5182.025255754518, 5264.9979023912, 5387.595930305321, 5391.919121213106, 5454.972725136349, 5461.208124821958, 5461.972690136524, 5470.343558772973, 5474.507294343528, 4667.929981050219, 4849.3210950467665, 5093.286939828501, 5357.946420535744, 5392.595555333287], "value": 3855.2974296898988, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.6016169166658, 687.618371803649, 699.6222040098347, 745.191467258025, 821.7740121466597, 14206.71586568268, 14801.407943682254, 15066.924665376686, 15085.245737713125, 15093.547193584196, 14080.155190688565, 14737.410503579844, 14888.0, 15149.394024239045, 15169.165695886722, 813.9186081391858, 832.1096426823301, 834.3658819297317, 835.5613303015934, 835.6448509383519, 649.730361899811, 676.7665155521362, 676.9323067693241, 792.2671528835832, 816.4937738602046, 881.9029906710257, 882.3779235638891, 882.7528292078229, 883.9469631822079, 887.951162686052, 878.9296856251484, 879.2482427524502, 880.5245167609484, 881.057268722464, 881.3610132653774, 503.7053323805578, 524.4702850121405, 619.9597026193283, 642.7621779941452, 652.6443088516722, 14363.71272574553, 14431.49489767853, 14443.927780361137, 14444.422223111063, 14450.92774536131, 12541.247525148521, 12605.621831345074, 12843.422046007952, 12848.972082233398, 13039.152455090483, 11919.404029798563, 12189.634310970685, 12212.32832194229, 12239.388030598435, 12643.304618245993, 4355.499117601485, 4368.104538569585, 4446.3552784846015, 4564.2240819060835, 4566.246569316092, 93381.59927601091, 93540.0, 93558.53220733853, 93710.53144734232, 95468.52265738766, 10059.195264378832, 10142.746431339276, 10235.846462303072, 10319.535620897077, 10469.581216751245, 19276.710849337273, 19378.287039814437, 19378.70931936022, 19379.321723739602, 19396.903015484833, 7273.345398914017, 7276.199618042011, 7302.087239095114, 7378.0, 7548.811279718051, 4164.937525937114, 4247.830086796494, 4249.596288352602, 4251.553586873396, 4251.617354438115, 3200.1039708881085, 3266.5263536787033, 3267.18320419895, 3282.8522716477814, 3288.6711328866922, 609.4423602403751, 613.1262950295811, 617.7035023188895, 627.4948666323562, 650.1483057195089, 538.9218563308299, 570.1760955419462, 580.2717589425245, 604.2054698072021, 619.3558698953128, 8427.073021967579, 8503.74488765338, 8552.871706924401, 8635.568221588896, 8888.733337999742, 482.8213560982389, 512.5929324005629, 561.0084201086128, 595.0152497616451, 611.2115371171228, 4075.7554546727292, 4185.748855068645, 4231.153769246163, 4256.787160641956, 4286.464191976003, 73268.63365683137, 74876.0, 91461.0, 114657.0, 115360.0, 82461.17538824535, 95397.0, 101263.0, 104146.02320733212, 107048.0, 93745.0, 94548.0, 95952.0, 96232.0, 97522.51238743903, 6927.68825402848, 8179.222973817477, 8193.50838949665, 8240.564419496062, 8473.66105355779, 57283.0, 58187.4181258182, 58796.41203588081, 59829.102563460714, 60670.08994865169, 53248.20127698165, 53324.0, 77892.0, 81677.77483337873, 81982.59008704919, 8882.60028298741, 10294.279400441897, 10325.070743632808, 10424.739381515523, 10545.209109316986, 11662.650120496399, 11710.297382157098, 11754.647360579196, 11772.058235341323, 12044.698882528008, 10963.61627343071, 10975.890241097486, 11228.4385780709, 11316.547338106384, 11427.085833133495, 10365.274430790074, 10530.631427899987, 10940.0, 11223.943880280547, 11695.239809412362, 8712.607932642919, 10805.567777289134, 10821.621243256448, 11222.158338124837, 11320.09439244842, 8345.874811877706, 9118.95440522793, 9215.354925155174, 9315.814041255888, 9505.904940950502, 9273.119053689888, 9395.671151509665, 9429.387089839138, 9445.102715242041, 9470.668526601536], "value": 6971.176749285615, "unit": "score"}], "name": "dromaeo_css", "value": 6909.342636294294, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 113.0, 113.0, 113.0, 114.0, 113.0, 113.0, 119.0, 161.0], "value": 118.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 111.0, 113.0, 155.0, 126.0, 145.0, 145.0, 117.0, 144.0, 112.0], "value": 131.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 180.0, 184.0, 185.0, 187.0, 182.0, 184.0, 187.0, 178.0, 183.0], "value": 183.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 68.0, 59.0, 87.0, 61.0, 58.0, 57.0, 59.0, 83.0, 58.0], "value": 66.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 69.0, 92.0, 72.0, 71.0, 69.0, 90.0, 67.0, 68.0, 93.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 86.0, 89.0, 88.0, 90.0, 87.0, 89.0, 88.0, 90.0, 85.0], "value": 88.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 97.0, 97.0, 98.0, 98.0, 98.0, 123.0, 160.0, 97.0, 98.0], "value": 106.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 85.0, 87.0, 87.0, 88.0, 85.0, 85.0, 86.0], "value": 85.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 53.0, 54.0, 53.0, 55.0, 55.0, 54.0, 54.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 75.0, 81.0, 72.0, 72.0, 71.0, 72.0, 72.0, 72.0, 72.0], "value": 72.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 86.0, 86.0, 89.0, 90.0, 85.0, 80.0, 85.0, 101.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 147.0, 153.0, 157.0, 146.0, 143.0, 145.0, 146.0, 186.0, 148.0], "value": 152.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 172.0, 172.0, 236.0, 181.0, 175.0, 176.0, 175.0, 174.0, 174.0], "value": 181.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 67.0, 82.0, 74.0, 67.0, 67.0, 68.0, 68.0], "value": 69.8, "unit": "score"}], "name": "kraken", "value": 1476.3999999999996, "alertThreshold": 2.0}]} 17:00:57 INFO - Return code: 0 17:00:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:00:57 INFO - # TBPL SUCCESS # 17:00:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:00:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:00:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:00:57 INFO - 2016-11-16 17:00:57.770 screenresolution[1652:9860] starting screenresolution argv=screenresolution get 17:00:57 INFO - 2016-11-16 17:00:57.774 screenresolution[1652:9860] Display 0: 1600x1200x32@60 17:00:57 INFO - 2016-11-16 17:00:57.780 screenresolution[1653:9863] starting screenresolution argv=screenresolution list 17:00:57 INFO - Available Modes on Display 0 17:00:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:00:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:00:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:00:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:00:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:00:57 INFO - Intel Iris: 17:00:57 INFO - Chipset Model: Intel Iris 17:00:57 INFO - Type: GPU 17:00:57 INFO - Bus: Built-In 17:00:57 INFO - VRAM (Dynamic, Max): 1536 MB 17:00:57 INFO - Vendor: Intel (0x8086) 17:00:57 INFO - Device ID: 0x0a2e 17:00:58 INFO - Revision ID: 0x0009 17:00:58 INFO - Displays: 17:00:58 INFO - Display: 17:00:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:00:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:00:58 INFO - Display Serial Number: 1600x1200 60 17:00:58 INFO - Main Display: Yes 17:00:58 INFO - Mirror: Off 17:00:58 INFO - Online: Yes 17:00:58 INFO - Rotation: Supported 17:00:58 INFO - Return code: 0 17:00:58 INFO - Running post-action listener: _resource_record_post_action 17:00:58 INFO - [mozharness: 2016-11-17 01:00:58.004676Z] Finished run-tests step (success) 17:00:58 INFO - Running post-run listener: _resource_record_post_run 17:00:58 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 37458944; Write bytes: 699004928; Read time: 239; Write time: 1999 17:00:58 INFO - TinderboxPrint: CPU usage
53.7% 17:00:58 INFO - TinderboxPrint: I/O read bytes / time
37,458,944 / 239 17:00:58 INFO - TinderboxPrint: I/O write bytes / time
699,004,928 / 1,999 17:00:58 INFO - TinderboxPrint: CPU idle
2,248.2 (46.3%) 17:00:58 INFO - TinderboxPrint: CPU system
975.2 (20.1%) 17:00:58 INFO - TinderboxPrint: CPU user
1,634.3 (33.6%) 17:00:58 INFO - TinderboxPrint: Swap in / out
436,203,520 / 0 17:00:58 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 383580672; Write bytes: 377468928; Read time: 29453; Write time: 803 17:00:58 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 36508672; Write bytes: 297693184; Read time: 226; Write time: 1130 17:00:58 INFO - Running post-run listener: _upload_blobber_files 17:00:58 INFO - Blob upload gear active. 17:00:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:00:58 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 17:00:58 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', 'Larch', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:00:58 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 Larch -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:00:58 INFO - (blobuploader) - INFO - Open directory for files ... 17:00:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:00:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:00:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:01:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:01:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:01:00 INFO - (blobuploader) - INFO - Done attempting. 17:01:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:01:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:01:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:01:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:01:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:01:01 INFO - (blobuploader) - INFO - Done attempting. 17:01:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:01:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:01:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:01:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:01:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:01:03 INFO - (blobuploader) - INFO - Done attempting. 17:01:03 INFO - (blobuploader) - INFO - Iteration through files over. 17:01:03 INFO - Return code: 0 17:01:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:01:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:01:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/9842f5fec2d3ef6d64350c77348b898cdffc5dd204e6277d90deb55ab2c285aaa3e91681c81bf01c3c0eb548a93e49a17bfd36a374f18af3b912e22b082fa08d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/fce7cbcf3a9fb327ede0f7d34d6b1a712d38309900bdddeef096c88e379da8e7ba2804856c1386ba6aa40cdc2e789f5e7a6e82d246c31fa53eb59d32ee47ef39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/ec50d56315b67ee03a289d8ac507d4c84100a1d721611f9fb7114e9bee9682afdbbfef77bc65299afb9322fdc542f75f7a1449b5a0e2c12dec406a56685693fd"} 17:01:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:01:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:01:03 INFO - Contents: 17:01:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/9842f5fec2d3ef6d64350c77348b898cdffc5dd204e6277d90deb55ab2c285aaa3e91681c81bf01c3c0eb548a93e49a17bfd36a374f18af3b912e22b082fa08d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/fce7cbcf3a9fb327ede0f7d34d6b1a712d38309900bdddeef096c88e379da8e7ba2804856c1386ba6aa40cdc2e789f5e7a6e82d246c31fa53eb59d32ee47ef39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/ec50d56315b67ee03a289d8ac507d4c84100a1d721611f9fb7114e9bee9682afdbbfef77bc65299afb9322fdc542f75f7a1449b5a0e2c12dec406a56685693fd"} 17:01:03 INFO - Running post-run listener: copy_logs_to_upload_dir 17:01:03 INFO - Copying logs to upload dir... 17:01:03 INFO - mkdir: /builds/slave/test/build/upload/logs 17:01:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.067471 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-11-16 17:01:03.483556) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-16 17:01:03.486801) ========= 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.TAc0rseNzb/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.j46zRnZa1x/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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/Larch/sha512/9842f5fec2d3ef6d64350c77348b898cdffc5dd204e6277d90deb55ab2c285aaa3e91681c81bf01c3c0eb548a93e49a17bfd36a374f18af3b912e22b082fa08d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/fce7cbcf3a9fb327ede0f7d34d6b1a712d38309900bdddeef096c88e379da8e7ba2804856c1386ba6aa40cdc2e789f5e7a6e82d246c31fa53eb59d32ee47ef39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/ec50d56315b67ee03a289d8ac507d4c84100a1d721611f9fb7114e9bee9682afdbbfef77bc65299afb9322fdc542f75f7a1449b5a0e2c12dec406a56685693fd"} build_url:https://queue.taskcluster.net/v1/task/R9QhHUCsQU-P8cyv1cXmnw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010734 build_url: 'https://queue.taskcluster.net/v1/task/R9QhHUCsQU-P8cyv1cXmnw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/9842f5fec2d3ef6d64350c77348b898cdffc5dd204e6277d90deb55ab2c285aaa3e91681c81bf01c3c0eb548a93e49a17bfd36a374f18af3b912e22b082fa08d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/fce7cbcf3a9fb327ede0f7d34d6b1a712d38309900bdddeef096c88e379da8e7ba2804856c1386ba6aa40cdc2e789f5e7a6e82d246c31fa53eb59d32ee47ef39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/ec50d56315b67ee03a289d8ac507d4c84100a1d721611f9fb7114e9bee9682afdbbfef77bc65299afb9322fdc542f75f7a1449b5a0e2c12dec406a56685693fd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-16 17:01:03.518694) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 17:01:03.519021) ========= 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.TAc0rseNzb/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.j46zRnZa1x/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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.005130 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 17:01:03.567313) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-16 17:01:03.567634) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-16 17:01:03.568003) ========= ========= Total master_lag: 0.37 =========