builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0210 starttime: 1487933658.54 results: success (0) buildid: 20170224013658 builduid: 3842dac89d09400d9ba4f05370b2a6c3 revision: 1c202d2bb24197c9f31d96998477f485acc85be4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-24 02:54:18.540804) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-24 02:54:18.541270) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-24 02:54:18.541565) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-24 02:54:18.567684) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 02:54:18.568077) ========= 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.knUqtxD9Wq/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.NhniYQq4TZ/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-24 02:54:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.0M=0.001s 2017-02-24 02:54:18 (19.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115479 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 02:54:18.706114) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 02:54:18.706582) ========= 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.knUqtxD9Wq/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.NhniYQq4TZ/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.026326 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 02:54:18.756172) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-24 02:54:18.756608) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1c202d2bb24197c9f31d96998477f485acc85be4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1c202d2bb24197c9f31d96998477f485acc85be4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.knUqtxD9Wq/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.NhniYQq4TZ/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-24 02:54:18,863 truncating revision to first 12 chars 2017-02-24 02:54:18,863 Setting DEBUG logging. 2017-02-24 02:54:18,863 attempt 1/10 2017-02-24 02:54:18,863 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1c202d2bb241?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-24 02:54:19,954 unpacking tar archive at: mozilla-aurora-1c202d2bb241/testing/mozharness/ program finished with exit code 0 elapsedTime=1.352655 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-24 02:54:20.132130) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-24 02:54:20.132455) ========= script_repo_revision: 1c202d2bb24197c9f31d96998477f485acc85be4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-24 02:54:20.132857) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-24 02:54:20.133127) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-24 02:54:20.152198) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-24 02:54:20.152612) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.knUqtxD9Wq/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.NhniYQq4TZ/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 02:54:20 INFO - MultiFileLogger online at 20170224 02:54:20 in /builds/slave/test 02:54:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:54:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:54:20 INFO - {'append_to_log': False, 02:54:20 INFO - 'base_work_dir': '/builds/slave/test', 02:54:20 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:54:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:54:20 INFO - 'branch': 'Mozilla-Aurora', 02:54:20 INFO - 'buildbot_json_path': 'buildprops.json', 02:54:20 INFO - 'config_files': ('talos/mac_config.py',), 02:54:20 INFO - 'default_actions': ('clobber', 02:54:20 INFO - 'read-buildbot-config', 02:54:20 INFO - 'download-and-extract', 02:54:20 INFO - 'populate-webroot', 02:54:20 INFO - 'create-virtualenv', 02:54:20 INFO - 'install', 02:54:20 INFO - 'run-tests'), 02:54:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:54:20 INFO - 'download_minidump_stackwalk': True, 02:54:20 INFO - 'download_symbols': 'ondemand', 02:54:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:54:20 INFO - 'tooltool.py': '/tools/tooltool.py', 02:54:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:54:20 INFO - '/tools/misc-python/virtualenv.py')}, 02:54:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:54:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:54:20 INFO - 'installer_path': 'installer.exe', 02:54:20 INFO - 'log_level': 'info', 02:54:20 INFO - 'log_name': 'talos', 02:54:20 INFO - 'log_to_console': True, 02:54:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:54:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:54:20 INFO - 'opt_config_files': (), 02:54:20 INFO - 'pip_index': False, 02:54:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:54:20 INFO - 'cmd': ('bash', 02:54:20 INFO - '-c', 02:54:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:54:20 INFO - 'enabled': True, 02:54:20 INFO - 'halt_on_failure': False, 02:54:20 INFO - 'name': 'check_screen_resolution'},), 02:54:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:54:20 INFO - 'cmd': ('bash', 02:54:20 INFO - '-c', 02:54:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:54:20 INFO - 'enabled': True, 02:54:20 INFO - 'halt_on_failure': False, 02:54:20 INFO - 'name': 'check_screen_resolution'},), 02:54:20 INFO - 'run_cmd_checks_enabled': True, 02:54:20 INFO - 'sps_profile': False, 02:54:20 INFO - 'sps_profile_interval': 0, 02:54:20 INFO - 'suite': 'dromaeojs', 02:54:20 INFO - 'system_bits': '32', 02:54:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:54:20 INFO - 'title': 't-yosemite-r7-0210', 02:54:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:54:20 INFO - 'use_talos_json': True, 02:54:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:54:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:54:20 INFO - 'work_dir': 'build'} 02:54:20 INFO - [mozharness: 2017-02-24 10:54:20.368341Z] Running clobber step. 02:54:20 INFO - Running pre-action listener: _resource_record_pre_action 02:54:20 INFO - Running main action method: clobber 02:54:20 INFO - rmtree: /builds/slave/test/build 02:54:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:54:22 INFO - Running post-action listener: _resource_record_post_action 02:54:22 INFO - [mozharness: 2017-02-24 10:54:22.755031Z] Finished clobber step (success) 02:54:22 INFO - [mozharness: 2017-02-24 10:54:22.755176Z] Running read-buildbot-config step. 02:54:22 INFO - Running pre-action listener: _resource_record_pre_action 02:54:22 INFO - Running main action method: read_buildbot_config 02:54:22 INFO - Using buildbot properties: 02:54:22 INFO - { 02:54:22 INFO - "project": "", 02:54:22 INFO - "product": "firefox", 02:54:22 INFO - "script_repo_revision": "production", 02:54:22 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:54:22 INFO - "repository": "", 02:54:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:54:22 INFO - "buildid": "20170224013658", 02:54:22 INFO - "pgo_build": "False", 02:54:22 INFO - "basedir": "/builds/slave/test", 02:54:22 INFO - "buildnumber": 11, 02:54:22 INFO - "slavename": "t-yosemite-r7-0210", 02:54:22 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 02:54:22 INFO - "platform": "yosemite_r7", 02:54:22 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:54:22 INFO - "branch": "mozilla-aurora", 02:54:22 INFO - "repo_path": "releases/mozilla-aurora", 02:54:22 INFO - "revision": "1c202d2bb24197c9f31d96998477f485acc85be4", 02:54:22 INFO - "stage_platform": "macosx64", 02:54:22 INFO - "builduid": "3842dac89d09400d9ba4f05370b2a6c3", 02:54:22 INFO - "slavebuilddir": "test" 02:54:22 INFO - } 02:54:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/czFwyfV5TNSXYTFyfdQ94w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 02:54:22 INFO - Running post-action listener: _resource_record_post_action 02:54:22 INFO - [mozharness: 2017-02-24 10:54:22.759320Z] Finished read-buildbot-config step (success) 02:54:22 INFO - [mozharness: 2017-02-24 10:54:22.759442Z] Running download-and-extract step. 02:54:22 INFO - Running pre-action listener: _resource_record_pre_action 02:54:22 INFO - Running main action method: download_and_extract 02:54:22 INFO - mkdir: /builds/slave/test/build/tests 02:54: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')]} 02:54:22 INFO - trying https://queue.taskcluster.net/v1/task/czFwyfV5TNSXYTFyfdQ94w/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 02:54:22 INFO - Downloading https://queue.taskcluster.net/v1/task/czFwyfV5TNSXYTFyfdQ94w/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 02:54:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/czFwyfV5TNSXYTFyfdQ94w/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 02:54:24 INFO - Downloaded 1199 bytes. 02:54:24 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 02:54:24 INFO - Using the following test package requirements: 02:54:24 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 02:54:24 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:54:24 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 02:54:24 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:54:24 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 02:54:24 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:54:24 INFO - u'jsshell-mac.zip'], 02:54:24 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:54:24 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 02:54:24 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 02:54:24 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:54:24 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 02:54:24 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:54:24 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 02:54:24 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:54:24 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 02:54:24 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:54:24 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 02:54:24 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:54:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/czFwyfV5TNSXYTFyfdQ94w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 02:54:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/czFwyfV5TNSXYTFyfdQ94w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:54:24 INFO - Fetch https://queue.taskcluster.net/v1/task/czFwyfV5TNSXYTFyfdQ94w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 02:54:25 INFO - Expected file size: 16357795 02:54:25 INFO - Obtained file size: 16357795 02:54:31 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:54:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/czFwyfV5TNSXYTFyfdQ94w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 02:54:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/czFwyfV5TNSXYTFyfdQ94w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:54:31 INFO - Fetch https://queue.taskcluster.net/v1/task/czFwyfV5TNSXYTFyfdQ94w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 02:54:32 INFO - Expected file size: 16357795 02:54:32 INFO - Obtained file size: 16357795 02:54:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/czFwyfV5TNSXYTFyfdQ94w/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 02:54:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/czFwyfV5TNSXYTFyfdQ94w/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:54:38 INFO - Fetch https://queue.taskcluster.net/v1/task/czFwyfV5TNSXYTFyfdQ94w/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 02:54:39 INFO - Expected file size: 14403472 02:54:39 INFO - Obtained file size: 14403472 02:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:54:40 INFO - trying https://queue.taskcluster.net/v1/task/czFwyfV5TNSXYTFyfdQ94w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:54:40 INFO - Downloading https://queue.taskcluster.net/v1/task/czFwyfV5TNSXYTFyfdQ94w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 02:54:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/czFwyfV5TNSXYTFyfdQ94w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 02:54:42 INFO - Downloaded 73926794 bytes. 02:54:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/czFwyfV5TNSXYTFyfdQ94w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:54:42 INFO - mkdir: /builds/slave/test/properties 02:54:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:54:42 INFO - Writing to file /builds/slave/test/properties/build_url 02:54:42 INFO - Contents: 02:54:42 INFO - build_url:https://queue.taskcluster.net/v1/task/czFwyfV5TNSXYTFyfdQ94w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:54:42 INFO - Running post-action listener: _resource_record_post_action 02:54:42 INFO - Running post-action listener: set_extra_try_arguments 02:54:42 INFO - [mozharness: 2017-02-24 10:54:42.905071Z] Finished download-and-extract step (success) 02:54:42 INFO - [mozharness: 2017-02-24 10:54:42.905235Z] Running populate-webroot step. 02:54:42 INFO - Running pre-action listener: _resource_record_pre_action 02:54:42 INFO - Running main action method: populate_webroot 02:54:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:54:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:54:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:54:42 INFO - '--tppagecycles', 02:54:42 INFO - '7'], 02:54:42 INFO - 'tests': ['tsvgm']}}, 02:54:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:54:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:54:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:54:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:54:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:54:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:54:42 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:54:42 INFO - 'talos_options': ['--disable-e10s'], 02:54:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:54:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:54:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:54:42 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:54:42 INFO - 'talos_options': ['--disable-e10s'], 02:54:42 INFO - 'tests': ['damp', 'tps']}, 02:54:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:54:42 INFO - 'tests': ['damp', 'tps']}, 02:54:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:54:42 INFO - 'tests': ['dromaeo_dom']}, 02:54:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:54:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:54:42 INFO - 'tests': ['basic_compositor_video']}, 02:54:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:54:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:54:42 INFO - 'tests': ['a11yr', 02:54:42 INFO - 'ts_paint', 02:54:42 INFO - 'tpaint', 02:54:42 INFO - 'sessionrestore', 02:54:42 INFO - 'sessionrestore_no_auto_restore', 02:54:42 INFO - 'tabpaint']}, 02:54:42 INFO - 'other-e10s': {'tests': ['a11yr', 02:54:42 INFO - 'ts_paint', 02:54:42 INFO - 'tpaint', 02:54:42 INFO - 'sessionrestore', 02:54:42 INFO - 'sessionrestore_no_auto_restore', 02:54:42 INFO - 'tabpaint']}, 02:54:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:54:42 INFO - 'ts_paint', 02:54:42 INFO - 'tpaint', 02:54:42 INFO - 'sessionrestore', 02:54:42 INFO - 'sessionrestore_no_auto_restore', 02:54:42 INFO - 'tabpaint']}, 02:54:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:54:42 INFO - 'ts_paint', 02:54:42 INFO - 'tpaint', 02:54:42 INFO - 'sessionrestore', 02:54:42 INFO - 'sessionrestore_no_auto_restore', 02:54:42 INFO - 'tabpaint']}, 02:54:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:54:42 INFO - 'tests': ['a11yr', 02:54:42 INFO - 'ts_paint', 02:54:42 INFO - 'tpaint', 02:54:42 INFO - 'sessionrestore', 02:54:42 INFO - 'sessionrestore_no_auto_restore', 02:54:42 INFO - 'tabpaint']}, 02:54:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:54:42 INFO - 'tests': ['a11yr', 02:54:42 INFO - 'ts_paint', 02:54:42 INFO - 'tpaint', 02:54:42 INFO - 'sessionrestore', 02:54:42 INFO - 'sessionrestore_no_auto_restore', 02:54:42 INFO - 'tabpaint']}, 02:54:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:54:42 INFO - 'tests': ['tsvgx', 02:54:42 INFO - 'tsvgr_opacity', 02:54:42 INFO - 'tart', 02:54:42 INFO - 'tscrollx', 02:54:42 INFO - 'cart', 02:54:42 INFO - 'tsvg_static']}, 02:54:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:54:42 INFO - 'tsvgr_opacity', 02:54:42 INFO - 'tart', 02:54:42 INFO - 'tscrollx', 02:54:42 INFO - 'cart', 02:54:42 INFO - 'tsvg_static']}, 02:54:42 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:54:42 INFO - 'talos_options': ['--disable-e10s'], 02:54:42 INFO - 'tests': ['tp5o']}, 02:54:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:54:42 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:54:42 INFO - 'talos_options': ['--disable-e10s', 02:54:42 INFO - '--xperf_path', 02:54:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:54:42 INFO - 'tests': ['tp5n']}, 02:54:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:54:42 INFO - 'talos_options': ['--xperf_path', 02:54:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:54:42 INFO - 'tests': ['tp5n']}}, 02:54:42 INFO - 'talos.zip': {'path': '', 02:54:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:54:42 INFO - Running post-action listener: _resource_record_post_action 02:54:42 INFO - [mozharness: 2017-02-24 10:54:42.924138Z] Finished populate-webroot step (success) 02:54:42 INFO - [mozharness: 2017-02-24 10:54:42.924276Z] Running create-virtualenv step. 02:54:42 INFO - Running pre-action listener: _resource_record_pre_action 02:54:42 INFO - Running main action method: create_virtualenv 02:54:42 INFO - Creating virtualenv /builds/slave/test/build/venv 02:54:42 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 02:54:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:54:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:54:43 INFO - Using real prefix '/tools/python27' 02:54:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:54:43 INFO - Installing distribute.............................................................................................................................................................................................done. 02:54:46 INFO - Installing pip.................done. 02:54:46 INFO - Return code: 0 02:54:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:54:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:54:46 INFO - Reading from file tmpfile_stdout 02:54:46 INFO - Output received: 02:54:46 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) 02:54:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:54:46 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')]} 02:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:46 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')]} 02:54:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:46 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 0x106ddfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106de2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff622d8c710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bbdd30>, '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 0x106ae4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bb2be8>, '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.knUqtxD9Wq/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.NhniYQq4TZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:54:46 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 02:54:46 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 02:54:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.knUqtxD9Wq/Render', 02:54:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:54:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:54:46 INFO - 'HOME': '/Users/cltbld', 02:54:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:54:46 INFO - 'LOGNAME': 'cltbld', 02:54:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:46 INFO - 'MOZ_NO_REMOTE': '1', 02:54:46 INFO - 'NO_EM_RESTART': '1', 02:54:46 INFO - 'PAGER': '/bin/cat', 02:54:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:54:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:46 INFO - 'PWD': '/builds/slave/test', 02:54:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:54:46 INFO - 'SHELL': '/bin/bash', 02:54:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NhniYQq4TZ/Listeners', 02:54:46 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 02:54:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:54:46 INFO - 'USER': 'cltbld', 02:54:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:54:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:54:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:46 INFO - 'XPC_FLAGS': '0x0', 02:54:46 INFO - 'XPC_SERVICE_NAME': '0', 02:54:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:54:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:47 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 02:54:47 INFO - Cleaning up... 02:54:47 INFO - Return code: 0 02:54:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:47 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 0x106ddfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106de2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff622d8c710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bbdd30>, '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 0x106ae4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bb2be8>, '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.knUqtxD9Wq/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.NhniYQq4TZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:54:47 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 02:54:47 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 02:54:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.knUqtxD9Wq/Render', 02:54:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:54:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:54:47 INFO - 'HOME': '/Users/cltbld', 02:54:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:54:47 INFO - 'LOGNAME': 'cltbld', 02:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:47 INFO - 'MOZ_NO_REMOTE': '1', 02:54:47 INFO - 'NO_EM_RESTART': '1', 02:54:47 INFO - 'PAGER': '/bin/cat', 02:54:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:47 INFO - 'PWD': '/builds/slave/test', 02:54:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:54:47 INFO - 'SHELL': '/bin/bash', 02:54:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NhniYQq4TZ/Listeners', 02:54:47 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 02:54:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:54:47 INFO - 'USER': 'cltbld', 02:54:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:54:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:47 INFO - 'XPC_FLAGS': '0x0', 02:54:47 INFO - 'XPC_SERVICE_NAME': '0', 02:54:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:54:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:47 INFO - Downloading/unpacking psutil>=3.1.1 02:54:47 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 02:54:47 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 02:54:47 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 02:54:47 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 02:54:47 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 02:54:47 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 02:54:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:54:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:54:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:54:50 INFO - Installing collected packages: psutil 02:54:50 INFO - Running setup.py install for psutil 02:54:50 INFO - building 'psutil._psutil_osx' extension 02:54:50 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 02:54:51 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 02:54:51 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 02:54:51 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 02:54:51 INFO - building 'psutil._psutil_posix' extension 02:54:51 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 02:54:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:54:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:54:51 INFO - ^ 02:54:51 INFO - 1 warning generated. 02:54:51 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 02:54:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:54:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:54:51 INFO - Successfully installed psutil 02:54:52 INFO - Cleaning up... 02:54:52 INFO - Return code: 0 02:54:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:54:52 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')]} 02:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:52 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')]} 02:54:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:52 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 0x106ddfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106de2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff622d8c710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bbdd30>, '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 0x106ae4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bb2be8>, '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.knUqtxD9Wq/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.NhniYQq4TZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:54:52 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 02:54:52 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 02:54:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.knUqtxD9Wq/Render', 02:54:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:54:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:54:52 INFO - 'HOME': '/Users/cltbld', 02:54:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:54:52 INFO - 'LOGNAME': 'cltbld', 02:54:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:52 INFO - 'MOZ_NO_REMOTE': '1', 02:54:52 INFO - 'NO_EM_RESTART': '1', 02:54:52 INFO - 'PAGER': '/bin/cat', 02:54:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:54:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:52 INFO - 'PWD': '/builds/slave/test', 02:54:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:54:52 INFO - 'SHELL': '/bin/bash', 02:54:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NhniYQq4TZ/Listeners', 02:54:52 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 02:54:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:54:52 INFO - 'USER': 'cltbld', 02:54:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:54:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:54:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:52 INFO - 'XPC_FLAGS': '0x0', 02:54:52 INFO - 'XPC_SERVICE_NAME': '0', 02:54:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:54:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:54:52 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 02:54:52 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 02:54:52 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 02:54:52 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 02:54:52 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 02:54:52 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 02:54:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:54:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:54:55 INFO - Installing collected packages: mozsystemmonitor 02:54:55 INFO - Running setup.py install for mozsystemmonitor 02:54:55 INFO - Successfully installed mozsystemmonitor 02:54:55 INFO - Cleaning up... 02:54:55 INFO - Return code: 0 02:54:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:54:55 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')]} 02:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:55 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')]} 02:54:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:55 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 0x106ddfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106de2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff622d8c710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bbdd30>, '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 0x106ae4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bb2be8>, '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.knUqtxD9Wq/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.NhniYQq4TZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:54:55 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 02:54:55 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 02:54:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.knUqtxD9Wq/Render', 02:54:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:54:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:54:55 INFO - 'HOME': '/Users/cltbld', 02:54:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:54:55 INFO - 'LOGNAME': 'cltbld', 02:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:55 INFO - 'MOZ_NO_REMOTE': '1', 02:54:55 INFO - 'NO_EM_RESTART': '1', 02:54:55 INFO - 'PAGER': '/bin/cat', 02:54:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:55 INFO - 'PWD': '/builds/slave/test', 02:54:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:54:55 INFO - 'SHELL': '/bin/bash', 02:54:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NhniYQq4TZ/Listeners', 02:54:55 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 02:54:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:54:55 INFO - 'USER': 'cltbld', 02:54:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:54:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:55 INFO - 'XPC_FLAGS': '0x0', 02:54:55 INFO - 'XPC_SERVICE_NAME': '0', 02:54:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:54:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:55 INFO - Downloading/unpacking jsonschema==2.5.1 02:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:54:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:58 INFO - Downloading functools32-3.2.3-2.tar.gz 02:54:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:54:58 INFO - warning: no files found matching '*.txt' 02:54:58 INFO - no previously-included directories found matching 'build' 02:54:58 INFO - no previously-included directories found matching 'dist' 02:54:58 INFO - no previously-included directories found matching '.git*' 02:54:58 INFO - Installing collected packages: jsonschema, functools32 02:54:58 INFO - Running setup.py install for functools32 02:54:58 INFO - warning: no files found matching '*.txt' 02:54:58 INFO - no previously-included directories found matching 'build' 02:54:58 INFO - no previously-included directories found matching 'dist' 02:54:58 INFO - no previously-included directories found matching '.git*' 02:54:58 INFO - Successfully installed jsonschema functools32 02:54:58 INFO - Cleaning up... 02:54:58 INFO - Return code: 0 02:54:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:54:58 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')]} 02:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:58 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')]} 02:54:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:58 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 0x106ddfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106de2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff622d8c710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bbdd30>, '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 0x106ae4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bb2be8>, '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.knUqtxD9Wq/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.NhniYQq4TZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:54:58 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 02:54:58 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 02:54:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.knUqtxD9Wq/Render', 02:54:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:54:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:54:58 INFO - 'HOME': '/Users/cltbld', 02:54:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:54:58 INFO - 'LOGNAME': 'cltbld', 02:54:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:58 INFO - 'MOZ_NO_REMOTE': '1', 02:54:58 INFO - 'NO_EM_RESTART': '1', 02:54:58 INFO - 'PAGER': '/bin/cat', 02:54:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:54:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:58 INFO - 'PWD': '/builds/slave/test', 02:54:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:54:58 INFO - 'SHELL': '/bin/bash', 02:54:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NhniYQq4TZ/Listeners', 02:54:58 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 02:54:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:54:58 INFO - 'USER': 'cltbld', 02:54:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:54:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:54:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:58 INFO - 'XPC_FLAGS': '0x0', 02:54:58 INFO - 'XPC_SERVICE_NAME': '0', 02:54:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:54:59 INFO - Cleaning up... 02:54:59 INFO - Return code: 0 02:54:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:54:59 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 0x106ddfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106de2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff622d8c710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bbdd30>, '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 0x106ae4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bb2be8>, '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.knUqtxD9Wq/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.NhniYQq4TZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:54:59 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 02:54:59 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 02:54:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.knUqtxD9Wq/Render', 02:54:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:54:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:54:59 INFO - 'HOME': '/Users/cltbld', 02:54:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:54:59 INFO - 'LOGNAME': 'cltbld', 02:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:59 INFO - 'MOZ_NO_REMOTE': '1', 02:54:59 INFO - 'NO_EM_RESTART': '1', 02:54:59 INFO - 'PAGER': '/bin/cat', 02:54:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:59 INFO - 'PWD': '/builds/slave/test', 02:54:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:54:59 INFO - 'SHELL': '/bin/bash', 02:54:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NhniYQq4TZ/Listeners', 02:54:59 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 02:54:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:54:59 INFO - 'USER': 'cltbld', 02:54:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:54:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:59 INFO - 'XPC_FLAGS': '0x0', 02:54:59 INFO - 'XPC_SERVICE_NAME': '0', 02:54:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:59 INFO - Downloading/unpacking blobuploader==1.2.4 02:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:54:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:01 INFO - Downloading blobuploader-1.2.4.tar.gz 02:55:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:55:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:55:02 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 02:55:02 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 02:55:02 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 02:55:02 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 02:55:02 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 02:55:02 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 02:55:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:55:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:55:02 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 02:55:02 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 02:55:02 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 02:55:02 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 02:55:02 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 02:55:02 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 02:55:03 INFO - Downloading docopt-0.6.1.tar.gz 02:55:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:55:03 INFO - Installing collected packages: blobuploader, requests, docopt 02:55:03 INFO - Running setup.py install for blobuploader 02:55:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:55:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:55:03 INFO - Running setup.py install for requests 02:55:03 INFO - Running setup.py install for docopt 02:55:04 INFO - Successfully installed blobuploader requests docopt 02:55:04 INFO - Cleaning up... 02:55:04 INFO - Return code: 0 02:55:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:04 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 0x106ddfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106de2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff622d8c710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bbdd30>, '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 0x106ae4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bb2be8>, '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.knUqtxD9Wq/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.NhniYQq4TZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:55:04 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 02:55:04 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 02:55:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.knUqtxD9Wq/Render', 02:55:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:04 INFO - 'HOME': '/Users/cltbld', 02:55:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:04 INFO - 'LOGNAME': 'cltbld', 02:55:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:04 INFO - 'MOZ_NO_REMOTE': '1', 02:55:04 INFO - 'NO_EM_RESTART': '1', 02:55:04 INFO - 'PAGER': '/bin/cat', 02:55:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:04 INFO - 'PWD': '/builds/slave/test', 02:55:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:04 INFO - 'SHELL': '/bin/bash', 02:55:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NhniYQq4TZ/Listeners', 02:55:04 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 02:55:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:04 INFO - 'USER': 'cltbld', 02:55:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:04 INFO - 'XPC_FLAGS': '0x0', 02:55:04 INFO - 'XPC_SERVICE_NAME': '0', 02:55:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:55:04 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-4JKFDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:55:04 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-HO2BiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:55:04 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-uPsPCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:55:04 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-oiNjc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:55:04 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-px6lrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:55:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:55:04 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-0199cF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:55:05 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-hS4bTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:55:05 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-iXmHo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:55:05 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-gHekzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:55:05 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-WGxTEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:55:05 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-uiQ44p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:55:05 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-NMW8Ok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:55:05 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-NkdH2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:55:05 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-fwXMfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:55:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:55:05 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-AmyqIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:55:06 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-xkc2g3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:55:06 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-oegNdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:55:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:55:06 INFO - Running setup.py install for manifestparser 02:55:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:55:06 INFO - Running setup.py install for mozcrash 02:55:06 INFO - Running setup.py install for mozdebug 02:55:06 INFO - Running setup.py install for mozdevice 02:55:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:55:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:55:06 INFO - Running setup.py install for mozfile 02:55:06 INFO - Running setup.py install for mozhttpd 02:55:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:55:07 INFO - Running setup.py install for mozinfo 02:55:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:55:07 INFO - Running setup.py install for mozInstall 02:55:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:55:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:55:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:55:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:55:07 INFO - Running setup.py install for mozleak 02:55:07 INFO - Running setup.py install for mozlog 02:55:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:55:07 INFO - Running setup.py install for moznetwork 02:55:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:55:07 INFO - Running setup.py install for mozprocess 02:55:08 INFO - Running setup.py install for mozprofile 02:55:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:55:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:55:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:55:08 INFO - Running setup.py install for mozrunner 02:55:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:55:08 INFO - Running setup.py install for mozscreenshot 02:55:08 INFO - Running setup.py install for moztest 02:55:08 INFO - Running setup.py install for mozversion 02:55:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:55:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:55:08 INFO - Cleaning up... 02:55:08 INFO - Return code: 0 02:55:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:55:08 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')]} 02:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:08 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')]} 02:55:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:08 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 0x106ddfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106de2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff622d8c710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bbdd30>, '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 0x106ae4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bb2be8>, '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.knUqtxD9Wq/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.NhniYQq4TZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:55:08 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 02:55:08 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 02:55:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.knUqtxD9Wq/Render', 02:55:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:08 INFO - 'HOME': '/Users/cltbld', 02:55:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:08 INFO - 'LOGNAME': 'cltbld', 02:55:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:08 INFO - 'MOZ_NO_REMOTE': '1', 02:55:08 INFO - 'NO_EM_RESTART': '1', 02:55:08 INFO - 'PAGER': '/bin/cat', 02:55:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:08 INFO - 'PWD': '/builds/slave/test', 02:55:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:08 INFO - 'SHELL': '/bin/bash', 02:55:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NhniYQq4TZ/Listeners', 02:55:08 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 02:55:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:08 INFO - 'USER': 'cltbld', 02:55:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:08 INFO - 'XPC_FLAGS': '0x0', 02:55:08 INFO - 'XPC_SERVICE_NAME': '0', 02:55:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:55:09 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-IhbOmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:55:09 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)) 02:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:55:09 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-K_iTXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:55:09 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)) 02:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:55:09 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-oeXAh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:55:09 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)) 02:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:55:09 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-d3_Va0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:55:09 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-5GRGTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:55:09 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)) 02:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:55:09 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-oZNogD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:55:09 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)) 02:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:55:09 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-Q4ZZML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:55:09 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)) 02:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:55:09 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-JrRRP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:55:09 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)) 02:55:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:55:09 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-84tb2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:55:10 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)) 02:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:55:10 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-cRYbY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:55:10 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)) 02:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:55:10 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-C3HWdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:55:10 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)) 02:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:55:10 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-m8UJoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:55:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:55:10 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-88TFCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:55:10 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)) 02:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:55:10 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-54sVbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:55:10 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)) 02:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:55:10 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-4fz7h7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:55:10 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)) 02:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:55:10 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-DkJJbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:55:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:55:10 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-0cC4jS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:55:10 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)) 02:55:10 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)) 02:55:10 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)) 02:55:10 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)) 02:55:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:55:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:55:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:55:10 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 02:55:10 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 02:55:10 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 02:55:10 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 02:55:10 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 02:55:10 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 02:55:13 INFO - Downloading blessings-1.6.tar.gz 02:55:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:55:13 INFO - Installing collected packages: blessings 02:55:13 INFO - Running setup.py install for blessings 02:55:13 INFO - Successfully installed blessings 02:55:13 INFO - Cleaning up... 02:55:13 INFO - Return code: 0 02:55:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:55:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:55:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:55:14 INFO - Reading from file tmpfile_stdout 02:55:14 INFO - Current package versions: 02:55:14 INFO - blessings == 1.6 02:55:14 INFO - blobuploader == 1.2.4 02:55:14 INFO - docopt == 0.6.1 02:55:14 INFO - functools32 == 3.2.3-2 02:55:14 INFO - jsonschema == 2.5.1 02:55:14 INFO - manifestparser == 1.1 02:55:14 INFO - mozInstall == 1.12 02:55:14 INFO - mozcrash == 1.0 02:55:14 INFO - mozdebug == 0.1 02:55:14 INFO - mozdevice == 0.49 02:55:14 INFO - mozfile == 1.2 02:55:14 INFO - mozhttpd == 0.7 02:55:14 INFO - mozinfo == 0.9 02:55:14 INFO - mozleak == 0.1 02:55:14 INFO - mozlog == 3.4 02:55:14 INFO - moznetwork == 0.27 02:55:14 INFO - mozprocess == 0.24 02:55:14 INFO - mozprofile == 0.28 02:55:14 INFO - mozrunner == 6.13 02:55:14 INFO - mozscreenshot == 0.1 02:55:14 INFO - mozsystemmonitor == 0.3 02:55:14 INFO - moztest == 0.8 02:55:14 INFO - mozversion == 1.4 02:55:14 INFO - psutil == 3.1.1 02:55:14 INFO - requests == 1.2.3 02:55:14 INFO - wsgiref == 0.1.2 02:55:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:55: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')]} 02:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55: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')]} 02:55:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:14 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 0x106ddfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106de2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff622d8c710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bbdd30>, '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 0x106ae4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bb2be8>, '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.knUqtxD9Wq/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.NhniYQq4TZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:55:14 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 02:55:14 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 02:55:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.knUqtxD9Wq/Render', 02:55:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:14 INFO - 'HOME': '/Users/cltbld', 02:55:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:14 INFO - 'LOGNAME': 'cltbld', 02:55:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:14 INFO - 'MOZ_NO_REMOTE': '1', 02:55:14 INFO - 'NO_EM_RESTART': '1', 02:55:14 INFO - 'PAGER': '/bin/cat', 02:55:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:14 INFO - 'PWD': '/builds/slave/test', 02:55:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:14 INFO - 'SHELL': '/bin/bash', 02:55:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NhniYQq4TZ/Listeners', 02:55:14 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 02:55:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:14 INFO - 'USER': 'cltbld', 02:55:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:14 INFO - 'XPC_FLAGS': '0x0', 02:55:14 INFO - 'XPC_SERVICE_NAME': '0', 02:55:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:14 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)) 02:55:14 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)) 02:55:14 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)) 02:55:14 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)) 02:55:14 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)) 02:55:14 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)) 02:55:14 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)) 02:55:14 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)) 02:55:14 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)) 02:55:14 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)) 02:55:14 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)) 02:55:14 INFO - Cleaning up... 02:55:14 INFO - Return code: 0 02:55:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:55: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')]} 02:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55: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')]} 02:55:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106ddfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106de2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff622d8c710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bbdd30>, '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 0x106ae4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bb2be8>, '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.knUqtxD9Wq/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.NhniYQq4TZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:55: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', 'jsonschema'] in /builds/slave/test/build 02:55: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 jsonschema 02:55:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.knUqtxD9Wq/Render', 02:55:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:14 INFO - 'HOME': '/Users/cltbld', 02:55:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:14 INFO - 'LOGNAME': 'cltbld', 02:55:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:14 INFO - 'MOZ_NO_REMOTE': '1', 02:55:14 INFO - 'NO_EM_RESTART': '1', 02:55:14 INFO - 'PAGER': '/bin/cat', 02:55:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:14 INFO - 'PWD': '/builds/slave/test', 02:55:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:14 INFO - 'SHELL': '/bin/bash', 02:55:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NhniYQq4TZ/Listeners', 02:55:14 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 02:55:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:14 INFO - 'USER': 'cltbld', 02:55:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:14 INFO - 'XPC_FLAGS': '0x0', 02:55:14 INFO - 'XPC_SERVICE_NAME': '0', 02:55:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:55:14 INFO - Cleaning up... 02:55:14 INFO - Return code: 0 02:55:14 INFO - Running post-action listener: _resource_record_post_action 02:55:14 INFO - Running post-action listener: _start_resource_monitoring 02:55:14 INFO - Starting resource monitoring. 02:55:14 INFO - [mozharness: 2017-02-24 10:55:14.795974Z] Finished create-virtualenv step (success) 02:55:14 INFO - [mozharness: 2017-02-24 10:55:14.796976Z] Running install step. 02:55:14 INFO - Running pre-action listener: _resource_record_pre_action 02:55:14 INFO - Running main action method: install 02:55:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:55:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:55:15 INFO - Reading from file tmpfile_stdout 02:55:15 INFO - Detecting whether we're running mozinstall >=1.0... 02:55:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:55:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:55:15 INFO - Reading from file tmpfile_stdout 02:55:15 INFO - Output received: 02:55:15 INFO - Usage: mozinstall [options] installer 02:55:15 INFO - Options: 02:55:15 INFO - -h, --help show this help message and exit 02:55:15 INFO - -d DEST, --destination=DEST 02:55:15 INFO - Directory to install application into. [default: 02:55:15 INFO - "/builds/slave/test"] 02:55:15 INFO - --app=APP Application being installed. [default: firefox] 02:55:15 INFO - mkdir: /builds/slave/test/build/application 02:55:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:55:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:55:34 INFO - Reading from file tmpfile_stdout 02:55:34 INFO - Output received: 02:55:34 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:55:34 INFO - Running post-action listener: _resource_record_post_action 02:55:34 INFO - [mozharness: 2017-02-24 10:55:34.978377Z] Finished install step (success) 02:55:34 INFO - [mozharness: 2017-02-24 10:55:34.978506Z] Running run-tests step. 02:55:34 INFO - Running pre-action listener: _resource_record_pre_action 02:55:34 INFO - Running main action method: run_tests 02:55:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:55:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:55:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:55:34 INFO - 2017-02-24 02:55:34.990 screenresolution[1624:7321] starting screenresolution argv=screenresolution get 02:55:34 INFO - 2017-02-24 02:55:34.993 screenresolution[1624:7321] Display 0: 1600x1200x32@60 02:55:34 INFO - 2017-02-24 02:55:34.998 screenresolution[1625:7324] starting screenresolution argv=screenresolution list 02:55:35 INFO - Available Modes on Display 0 02:55:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:55:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:55:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:55:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:55:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:55:35 INFO - Intel Iris: 02:55:35 INFO - Chipset Model: Intel Iris 02:55:35 INFO - Type: GPU 02:55:35 INFO - Bus: Built-In 02:55:35 INFO - VRAM (Dynamic, Max): 1536 MB 02:55:35 INFO - Vendor: Intel (0x8086) 02:55:35 INFO - Device ID: 0x0a2e 02:55:35 INFO - Revision ID: 0x0009 02:55:35 INFO - Displays: 02:55:35 INFO - Display: 02:55:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:55:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:55:35 INFO - Display Serial Number: 1600x1200 60 02:55:35 INFO - Main Display: Yes 02:55:35 INFO - Mirror: Off 02:55:35 INFO - Online: Yes 02:55:35 INFO - Rotation: Supported 02:55:35 INFO - Return code: 0 02:55:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:55:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:55:35 INFO - Python 2.7.3 02:55:35 INFO - Return code: 0 02:55:35 INFO - grabbing minidump binary from tooltool 02:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:35 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 0x106bbdd30>, '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 0x106ae4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bb2be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:55:35 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 02:55:35 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 02:55:35 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 02:55:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:55:35 INFO - Return code: 0 02:55:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:55:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:55:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:55:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:55:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:55:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/czFwyfV5TNSXYTFyfdQ94w/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0210', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:55:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/czFwyfV5TNSXYTFyfdQ94w/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0210 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:55:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.knUqtxD9Wq/Render', 02:55:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:35 INFO - 'HOME': '/Users/cltbld', 02:55:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:35 INFO - 'LOGNAME': 'cltbld', 02:55:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:55:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:55:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:35 INFO - 'MOZ_NO_REMOTE': '1', 02:55:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:55:35 INFO - 'NO_EM_RESTART': '1', 02:55:35 INFO - 'PAGER': '/bin/cat', 02:55:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:35 INFO - 'PWD': '/builds/slave/test', 02:55:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:55:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:35 INFO - 'SHELL': '/bin/bash', 02:55:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NhniYQq4TZ/Listeners', 02:55:35 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 02:55:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:35 INFO - 'USER': 'cltbld', 02:55:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:35 INFO - 'XPC_FLAGS': '0x0', 02:55:35 INFO - 'XPC_SERVICE_NAME': '0', 02:55:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/czFwyfV5TNSXYTFyfdQ94w/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0210', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:55:35 INFO - mozversion application_buildid: 20170224013658 02:55:35 INFO - mozversion application_changeset: 1c202d2bb24197c9f31d96998477f485acc85be4 02:55:35 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:55:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:55:35 INFO - mozversion application_name: Firefox 02:55:35 INFO - mozversion application_remotingname: firefox-dev 02:55:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:55:35 INFO - mozversion application_vendor: Mozilla 02:55:35 INFO - mozversion application_version: 53.0a2 02:55:35 INFO - mozversion platform_buildid: 20170224013658 02:55:35 INFO - mozversion platform_changeset: 1c202d2bb24197c9f31d96998477f485acc85be4 02:55:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:55:35 INFO - mozversion platform_version: 53.0a2 02:55:35 INFO - using testdate: 1487933735 02:55:35 INFO - actual date: 1487933735 02:55:35 INFO - starting webserver on 'localhost:49247' 02:55:35 INFO - SUITE-START | Running 2 tests 02:55:35 INFO - TEST-START | dromaeo_css 02:55:35 INFO - operating with platform_type : mac_ 02:55:35 INFO - Initialising browser for dromaeo_css test... 02:55:35 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/tmpb6NUpK/profile http://localhost:49247/getInfo.html) 02:55:37 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 02:55:37 INFO - PROCESS | 1635 | colorDepth:24 02:55:37 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 02:55:37 INFO - PROCESS | 1635 | __metrics 02:55:37 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" 02:55:37 INFO - PROCESS | 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:55:38 INFO - TEST-INFO | 1635: exit 0 02:55:38 INFO - Browser initialized. 02:55:38 INFO - Running cycle 1/1 for dromaeo_css test... 02:55:38 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/tmpb6NUpK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:55:50 INFO - PROCESS | 1637 | RSS: Main: 212983808 02:55:50 INFO - PROCESS | 1637 | 02:58:54 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49247/tests/dromaeo/cssquery-ext.html) 02:58:56 INFO - PROCESS | 1637 | RSS: Main: 377921536 02:58:56 INFO - PROCESS | 1637 | 03:00:40 INFO - PROCESS | 1637 | ************************* 03:00:40 INFO - PROCESS | 1637 | A coding exception was thrown and uncaught in a Task. 03:00:40 INFO - PROCESS | 1637 | 03:00:40 ERROR - PROCESS | 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:00:40 INFO - PROCESS | 1637 | Full stack: 03:00:40 INFO - PROCESS | 1637 | ************************* 03:01:59 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-ext.html (next: http://localhost:49247/tests/dromaeo/cssquery-jquery.html) 03:02:00 INFO - PROCESS | 1637 | RSS: Main: 356483072 03:02:00 INFO - PROCESS | 1637 | 03:05:02 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49247/tests/dromaeo/cssquery-mootools.html) 03:05:02 INFO - PROCESS | 1637 | RSS: Main: 330788864 03:05:02 INFO - PROCESS | 1637 | 03:08:05 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49247/tests/dromaeo/cssquery-prototype.html) 03:08:05 INFO - PROCESS | 1637 | RSS: Main: 327757824 03:08:05 INFO - PROCESS | 1637 | 03:11:09 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49247/tests/dromaeo/cssquery-yui.html) 03:11:09 INFO - PROCESS | 1637 | RSS: Main: 313569280 03:11:09 INFO - PROCESS | 1637 | 03:14:13 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-yui.html (next: http://localhost:49247/tests/dromaeo/cssquery-dojo.html) 03:14:13 INFO - PROCESS | 1637 | RSS: Main: 383516672 03:14:13 INFO - PROCESS | 1637 | 03:14:13 INFO - PROCESS | 1637 | __start_tp_report 03:14:13 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 03:14:13 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 03:14:13 INFO - PROCESS | 1637 | |i|pagename|runs| 03:14:13 INFO - PROCESS | 1637 | |0;dojo.html;3300.801951882887;3318.1704573856537;3340.832958352083;3352.2122301259215;3383.5432216650743;5641.097424412095;5644.379118296989;5659.915101273484;5660.773569057243;5663.065594176961;5538.224648549196;5575.107982722765;5587.106063029916;5667.829965101054;5709.371969083398;5133.922991155136;5139.997700448414;5167.483251674821;5191.0656081905245;5240.528352448298;4786.282057691339;5078.847634570969;5094.184930411135;5250.05499010178;5300.966311569246;5168.2764412982215;5177.741112944356;5199.818006369778;5207.973960130194;5218.034663587248;5217.843464696065;5220.712860792674;5221.451747566489;5224.92162617561;5227.294315267428;4986.227134794112;5114.028334616448;5140.563052140536;5174.3790745110455;5175.120229560984;5707.714614269312;5738.540916726652;5747.683877386742;5754.597178197528;5769.451902069297;5757.856053598652;6118.990366589507;6226.283977342573;6243.250809902841;6261.217347831521;4950.653454258203;6143.170671959273;6184.412480814315;6188.659623720693;6285.842853928642;5806.796762113306;5848.239728835224;5854.590178687451;5868.530517558585;5894.115882617599;6281.59169653971;6282.2147231596055;6290.150829638032;6291.307956124822;6294.213223347082;6002.309734380515;6064.848378790477;6137.754489820357;6144.78493252734;6154.076888466676;6109.694515274218;6124.2588809726185;6131.877781547492;6140.486742244447;6141.823559979257;6109.321562077401;6116.040548005192;6125.766718196725;6129.614667185397;6148.661823599745;6087.6956152192215;6118.5982485574605;6123;6124.816255512342;6150.892839288881;4814.470408255089;4871.561559459666;4872.19608764557;4913.87715307113;4947.406311242674;4445.5776701213335;4449.466064072332;4463.977680111579;4484.148011877733;4485.237509623372;5755.65466072037;5764.106563482667;5769.07694768835;5772.797952071657;5773.711314434346;5128.897422051538;6087.482563982023;6130.540209484307;6141.631502109798;6174.166487524217;5596.97201513998;5598.300212473441;5669.951059054089;5683;5719.685417302088;5287.154055351125;5306.8407947761625;5315.069862773999;5369;5447.428020057916;6268.059791031291;6278;6311.400416960473;6324.2410910691015;6325.5255855811;6223.626582405071;6321.620702757849;6340.1440805490665;6351.174347334817;6352.491800656029;6195.380461953769;6215.223097112861;6235.282942461494;6250.687465626791;6274.8431289216305;6153.138560601609;6166.969165154145;6171.783987560414;6180.289266734383;6194.349593292639;6192.907106393498;6220.875582488416;6228.159198508143;6231.688415579112;6239.563230573816;5871.383504731942;5897.498712609477;5994.220751302303;6073.180120683651;6084.726187321493;5897.351291357862;5933;6049.334573197033;6082.878342433038;6133.325334213144;5931.555133365101;5962.9105563415715;5985.341612422717;6003.459688628044;6004.279486461653;5169.147090729987;5904.763809447746;5962.880742385215;5991.970040149771;6100.481459076028;5910.290765108042;5927.496162826035;5943.821685349447;5944.405559444021;5966.910496342472 03:14:13 INFO - PROCESS | 1637 | |1;ext.html;428.66992415839803;451.05954085731247;468.84429880344965;484.80850064224654;512.7205672908266;31389.529157062632;40756;41874.58125418745;41969.58030419695;42095.579044209546;36634.633653663455;38124.80937595308;42662.7866860666;44351.55648443515;44849.77575112128;9165.862512062324;9362.953185234099;9384.483853388061;9394.389364691307;9396.295277854155;8397.83204335916;8620.396572239946;11133;11387.316760994367;11394.373309467976;11315.943420282887;11450.770984580304;11498;11505.942470287679;11515.30908145514;11346;11409.315441073479;11412.372319522465;11414.258073225214;11442.485088171052;8322.126176751475;8532.402731808776;10984.340939543574;11215.38315392653;11249.212555121145;41653;42043.36934945978;42107;42134.78932605348;42190;3976.9581805939943;4003.919921601552;4014.3777714454304;4017.638412542856;4038.7980600970127;29512.55731164013;29536.8523157385;29618.851905740332;30314.393712125635;30330.090097297118;3039.270575061991;3233.401820663185;3333.399988002159;3351.3632409842053;3357.1607098225445;462469;464109;464460;466460.9999999966;467453;63470.143843527156;63601.36398636047;66088;66405.33594664089;66598;67369.66315168393;70849.64575177194;71020;71102.64448677724;71137;16813.07528085967;17046.74429883553;17057.829421705625;17070.829291706923;17114.572135696457;11735.647930562096;12971.481140754453;13005;13014.804777928339;13027.283499407624;16087.919560402357;16606.916965415097;17817.673902262402;21626.918654067547;21936.903154842195;8712;8870.689525866565;8892.555372231363;8897.510636914902;8908.7728067983;881.8633111867671;891.1979218703219;897.3359713811863;904.2856143646577;920.9309301802392;30026.69973300239;30874.845625771726;31014.534781978287;31307.373852522822;31673.36653266968;1064.4571268652887;1066.802641511323;1107.2083460325905;1116.3469370418395;1185.2355230876037;16012.594847471712;16082.919585401998;16157.838421615868;16250.593735156479;16639.833601663828;541145;663412;665666;666860;668554;52274.73862630662;62673;63244.36755632385;63444;63571.68214158899;1420.2898550724638;1462.627030107316;1479.32690625765;1485.18314926792;1486.5317425011087;28402.43195136127;30366.544501832934;30494.196649395788;30796.692033079384;30981;54424.45575544352;54837.725811370685;54862.72568637131;54921.90156196934;55011.72494137504;592510;592597;593800;594000;596190;36491.63508364883;44261.77869110634;44633.88415289644;45092.77453612711;45217.773911130236;39755;45951.3107303384;45977.850553736425;47199.29201062056;48716.78208044827;38085.809570953075;39084.80457597694;39206.80396597999;39611.60388396079;40443.39334910038;38420.807895960344;38917.80541097277;39624.80187599159;39654.40518392284;39953.801385957304;36715.44926826046;37264.813675931444;37690;37738.62261377461;38097;32081;32969.67030329666;34494.62021519111;34508;34593.82703086468;21422.892885536097;24410.87794561016;24824.627630585193;25122.74877251204;25383.36541586475 03:14:13 INFO - PROCESS | 1637 | |2;jquery.html;376.4879763521612;395.45229856648535;398.2453251089186;405.49110865863344;427.0349011234609;13720.134814629884;15843.287052082655;17873.82126178738;20310.390688279338;20837.853918034503;20768.169273229054;20871.37385878426;21195;21272.255471058477;21425.785742142572;5606.383297837245;5654.971725141369;5728.513076388512;5826.242588463494;5922.230110085683;5830.591858569902;5879.911801322984;5887.8528036799;5888.02847530157;5900.498457631106;3812.2756676231566;4002.4596679448337;5382;5629.549636029108;5656.604037717361;4855.68438051529;5568.916466253009;5707.42925707428;5726.255586773714;5758.157389635318;5671.234383358235;5730.997075511768;5737.88524229513;5742.368339482654;5743.310802703702;13034;13038.739225215442;13050.869491305155;13202.4058917348;13240.337983100806;2546.6052761821948;2564.666593342872;2592.2612055564073;2604.2838219489604;2604.5181641396402;9165.220956218729;9314.580843862042;9607.56765945534;9674.129328360412;11469.827952580717;1750.483607335839;1754.3158168314367;1757.1302205408276;1765.523308706642;1789.6689112514227;125553;140585.29707351397;142449.8632520513;143006;144961.27519362335;11550.537978480934;11706.765864682659;11718.824217636742;11796.52813887435;11913.940430297793;15441;15449.227538623249;15469.381224751109;15470.5358839235;15476.535703928901;8376.790580235544;8520.829583408296;8524.360672949553;8594.398392112616;8648.394612377073;8082.555459449669;8363.749087527383;8398.034226063959;8523.190296921783;8546.31629469641;4505.234110201208;4632.16621008215;4636.79134438951;4640.883977900579;4699.530046995274;1958.7257783910263;2023.8077382648626;2026.381953504166;2029.533207362315;2030.2488079410712;998.6953979036464;1007.3401921741271;1016.3800081950004;1023.6161439460202;1057.7571353659418;20734;21206.681899771516;21418.57162856734;21419.78580214209;21422.57154856894;834.9290310323569;976.8827740671165;982.6930182856784;1058.1006144776877;1068.4943806773106;10297.764268287854;10890.564377424973;10932.617358392417;10977.945110274557;11015.394153321484;762764.1861790655;763573;763755;771503;787177;119628.40185799015;144222.557774423;152107;157740;157931;830.9667613295401;951.6003278622995;983.311681822727;988.1205726903062;989.9653512127041;17808.109594519963;18489.53776155607;18713.064346782878;18743.437696869114;18766.71849922225;57551.1367329482;59814.80370392481;60090.82289535511;60669.0899636497;61580.76838463295;88095.55952220198;89080;89535;90821.18357632942;91918;4679.625629949528;5651.067573850269;7950.9663743712945;8291.461055031645;8350.206730360605;9997;10415.739606509898;10622.29947851999;12591.433385497492;13108.606741797761;10699.411532365482;10882.455877206266;11084.057855082408;11242.718932026764;11287.266327688674;9229.954115142122;9230.076992300716;10298.279120461495;10814.405207713651;11211.103111750877;10353.119984801377;10450.68647940563;11174.55301787952;11215.775684486427;11366.829497557377;8024.438289319692;8287.544185069879;8435.198656127657;8501;8502.957485212783;10667.679969600924;11019.56745623096;11024.779504410028;11081.113510918945;11202.719932001439 03:14:13 INFO - PROCESS | 1637 | |3;mootools.html;1441.1785282389035;1441.7332793433209;1449.4202319072374;1463.9268036598173;1466.1349803615865;7856.371490280778;8142.877856832145;8534.91465085349;8546.230839224469;8559.443636163653;7089.574625522472;7766.805829854256;7785.221477852212;8151.673933042686;8416.57917104144;2327.3367090379247;2370.7866292033714;2375.928722138339;2376.9168079117235;2377.9048838046456;2341.2507997440825;2374.6794182785275;2377.7503362146986;2387.77316154965;2388.462595915914;2328.4062564046144;2332.9300120996313;2362.881855907198;2363.4800343924394;2372.027468737818;2292.747797742247;2298.2186056740707;2315.560043591712;2352.717673879128;2353.376355265856;2089.7357098955217;2202.8458007939453;2309.099451214028;2385.093664407514;2386.606209975352;8498.70254541088;8571.614277357472;8572.957135214285;8590.613422396007;8599.05410404855;4949.975250123763;5029.823956161554;5198.142306519419;5199.48005199477;5208.635395522315;3312;3527.453244747043;3541.8052007139595;3606.459031145323;3606.459031145323;1168.9596259329203;1226.405193481161;1242.8446444194476;1253.0977696058824;1267.9982813577262;10893.564257429693;10967.890321096767;10969.396683182502;10974.615888443866;10985.835212471819;4381.627561657231;4652.488226295105;4744.525547445297;4750.026244619845;4759.619230461555;9583.041695830361;9590.712278631652;9602.32783705148;9603.567839447102;9635.807283854283;5264.736763161826;5274.551663108678;5277.261183434322;5278.630495865253;5285.048691235615;3950.822213000422;4267.935980960288;4339.207376751909;4741.573258406691;4793.065352256276;3885.6891448684037;3891;4009.1380353224195;4015.437838702584;4049.6152865477734;1272.338384040294;1287.073307218801;1292.2440372382073;1300.7918733002864;1301.1737546657941;668.3951024322995;733.7945375294926;752.6838727734365;768.4812751392788;795.8408318336355;4857.80568777252;5145.15105007677;5179.585633149339;5601.943980560142;5632.85917852057;564.8700798816295;574.7902015764216;578.6701580099387;589.593180705312;589.7965202005302;3542.4863394807608;3662.4140137578393;3738.8504459821847;3739.476473293741;3755;9792.412455252708;10121.03850134236;10172.338797978107;10183.388996660076;10199.949000254952;9813.705588832347;9900.950495247478;10144.391336519833;10146.036126567964;10162.136218421369;7767.495112817649;7850.646720897574;7867.685292588347;7870.72452464161;7889.921100788919;5349.679019258857;5377.946220537745;5379.515843574097;5506.752196151103;5524.281843360337;9036.457812531005;9179.219766319671;9254.722358329262;9322.860157097513;9424.29317801154;8413.90619219522;8699.652013919373;9542.713718588453;9546.284028697737;9590.952045239728;6646;6876.209235937931;6920.619365934922;7200.49596528238;7288.67200975968;7961.8407631848195;7992.040955085427;8084.555349455836;8139.79650508742;8149.959250203711;7041.4014808739785;7184.1738200105565;7204.56772593646;7213.098362704662;7227.710891564278;7011.824704382431;7013.088298521159;7056.223815380202;7214.422846172399;7222.3860971817985;6323.6838158090995;6467.838304042437;6472.805815825533;6476.740930362921;6482.870342593027;4923.236898280772;4964.3298154748645;4977.328060711758;4985.277134815504;5003.499650034967;4825.30033145199;4894.95105048945;4950.8267210647455;5045.419776725576;5132.538071573576 03:14:13 INFO - PROCESS | 1637 | |4;prototype.html;353.5333359964846;354.6117001882938;362.0875394007101;376.24562751682873;377.07616339967086;4526.004279058606;4678.7192768433915;5211.244369566411;5331.280277162582;5440.510354068133;5185.403678576965;5225.529702326789;5291.391489978653;5293.179557168635;5301.5539899065625;4192.664586833046;4210.46318093895;4228.365745138239;4279.48646162461;4294.763787991659;3399.5351574579245;3829.0427393151713;3844.365679662866;4015.217032678629;4121.196366708493;3953.3081710700512;4160.254232206744;4167.229062623409;4202.348635961415;4212.4945006599255;3539.5752509699;3707.2195853110165;4175.724230294497;4178.895527611819;4197.97901010496;3109.8289594072317;3346.297277571713;3601.531800865897;3704.1850792825803;3782.316868993272;4849.951500485021;5061.506855477606;5185.248139019859;5268.81559145428;5418.268533747933;4124.4019617155345;4519.5480451954545;4521.892136426596;4805.591524720403;4858.368412106439;5002.974985125087;5139.1734545999925;5157.638965272433;5289.709066001368;5742.626729262584;4022.2156679447226;4063.735857169304;4127.731697439657;4132.793360332002;4166.791660416998;5638.618538458063;5777;5800.185845748061;5831.89709004621;5841.678707671076;3675.467057276733;4105.7331273467125;4197.727147735387;4220.683448741357;4244.978775106105;3624.5831729350934;3718.7768733876055;4197.328427451593;4237.660987121023;4289.528151903288;4796.625670293227;4832.371791667061;4834.371531700926;4851.466338702739;4856.562909338177;4970.589264206857;5666.320041594952;5702;5761.971190144106;5827.708614569255;1220.5727995201607;1242.4967888005372;1254.2474515290753;1254.4480428611382;1404.3048690897867;817.4073796497611;856.6165642487463;940.9905900941039;986.7483791633088;992.6724181020246;4413.955860441354;4645.607512131255;4666.440027196758;4748.762561871962;5143.459936706667;4863.106451661256;5111.7699703513435;5175.205389089924;5529.502344788988;5628.887422251614;4219.303814870574;4365.541618130114;4463.745808366754;4489.88775280614;4985.903101317705;2594.727553606844;2612.568926127206;2885.1344596621348;2899.275181204699;2988.8356140412484;4808.9519104808505;5198.02475059475;5775.422457754275;5974.3428222895445;6005.567745063257;5068.873278168002;5310.654807437504;5510.641808282529;6071.332153463116;6132.877342453126;5825.921854701725;5936;6112.358202388774;6128.662923539248;6130.601510901777;5131.307273518177;5549.084401073777;5722.62511057923;5790.826275211751;5944.940550594439;4797.616190704665;5093.6247213252955;5247.457965873096;5380.408155103014;5623.100303951348;4834.365270927283;5916.26046744157;5981.663294111908;6042.728077236623;6131.264248290234;3565.3777531222713;3667.431548110047;3863.4204869269834;3886.9416958746206;3940.763554186758;4627.421572303462;4729.895196637463;5130.358705161855;5768.202421825327;5818.9127163093435;4461.933071003873;4907.362042934538;5389.895071510409;5559.360673522435;5685.573581981451;4801.91956809715;5423.83728488146;5433.701146436984;5458.61789674719;5632.605717599728;4594.379758732528;5226.320578324793;5443.755031023693;5473.589480789036;5585.636933599303;4376.6717496187275;4582.358469814162;5225.1117310056625;5286.97356513215;5624.803131890364;4540.341650460598;4905.773556610848;5016.849494515171;5406.939120911879;5468.7539060741565 03:14:13 INFO - PROCESS | 1637 | |5;yui.html;693.5526585352451;729.6096588325247;746.7386414754836;805.4683908620311;812.825242572847;14269.928650356747;15224.847751522482;15249.618759531017;15261.465848695298;15268.236588170603;13624.591262262124;13939.303034848243;13984.37070331835;14055.718885622282;14129.222892740896;835.5905606252923;883.1212943121603;885.8006948436615;901.914318139779;902.0122965352928;852.2883392367349;889.5329951775337;889.6263569300877;889.6975028490313;889.7553172877446;741.7626359564941;760.4714723267332;910.3718434280325;941.3504681769557;949.8337790886602;939.3800091939355;939.628846605587;939.8120375924808;940.3652534539159;941.3269512298739;694.5450729772008;696.2723953468637;697.1181455458849;697.5709938387905;700.0094865764936;10499.685009449653;11022.834657480144;12738.172018818746;14626.195559244237;14715.926420367936;14034.298285085704;14211.502597409144;14262.64343391413;14277.071990320595;14323.069000514934;10919.781604367947;11211.887881121247;11294.491747871365;11581.826272605833;12079.154459187861;3229.8223597702117;3331.583552055993;3621.2938476996997;3632.2735452909524;3804.923901521982;100546.9945300545;101433;104859;105449.47275263652;105663;10365.896341036643;10372.222083343779;10531.15750739939;11023.17326200538;11123.499442525106;21663;21683.34949951504;22320;22634.094636214697;22961.425964351023;7583.681747113951;7631.084269887538;7631.3894888408795;7653.119891212582;7835.333996610352;4168.166366726667;4174.373843923436;4251.638610718123;4342.261815491374;4484.887877803081;3513.648635136466;3527.2592755521114;3582.7492075554983;3626.0390996385977;3642.7085833133287;631.1542533005794;634.8825467288566;642.1715986377613;644.8613548087184;647.5175993884492;611.9326874043894;669.1368135105756;673.8483841135803;676.4419354032844;693.6531734132933;10013.849792253122;10097;10103;10319.813221479475;10424.895751042393;681.877262092828;705.1432509500981;705.4237489364293;717.0964584623308;720.4704542161508;4667.393238878924;4942.728149951715;4956.826511072095;4962.8759281018265;4964;104247.47876260722;105524;106812.93187068186;108981;109949.45025274823;88621;88918;89806;90953.09046909578;92543.61184582236;78660;80455.59772201102;80920.19079809244;81723;82256.58871705603;9465.05349465048;9544.33189676716;9584.779406257077;9588.616455341707;9669.274804389559;49401.75299123481;50295;51224.74387628038;52018.73990630022;52535.68660783511;45110;67001.32998669951;67906.66046669734;69152.27119322057;69505.30494694988;12499;12849.164804287691;13162.868371316546;13178.538751143664;13328.2669453181;14035.36840842185;14258.64353391132;14568.708625827636;14613.780793288322;15018.474353397578;12839.935800320938;13279.933600331937;13447.865521345053;13645.317734113452;13732;10674.271543707378;11644.708882277671;12712.427940742873;13463.12489688167;13545.864541354855;13158.60524184276;13201.801972970221;13260.734785304432;13550.186988780704;14092.474420174007;10751.892481075089;11015.614453494089;11310.660680179608;11626.593069242535;11808;10579.31234469757;10609.098226650513;11389;11555.653330400102;11627 03:14:13 INFO - PROCESS | 1637 | __end_tp_report 03:14:13 INFO - PROCESS | 1637 | __start_cc_report 03:14:13 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,1743 03:14:13 INFO - PROCESS | 1637 | __end_cc_report 03:14:13 INFO - PROCESS | 1637 | __startTimestamp1487934853476__endTimestamp 03:14:13 INFO - PROCESS | 1637 | 03:14:13 INFO - PROCESS | 1637 | ------- Summary: start ------- 03:14:13 INFO - PROCESS | 1637 | Number of tests: 6 03:14:13 INFO - PROCESS | 1637 | 03:14:13 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5693.88 Median:5904.76 stddev:635.06 (10.8%) stddev-sans-first:608.63 03:14:13 INFO - PROCESS | 1637 | Values: 3300.8 3318.2 3340.8 3352.2 3383.5 5641.1 5644.4 5659.9 5660.8 5663.1 5538.2 5575.1 5587.1 5667.8 5709.4 5133.9 5140.0 5167.5 5191.1 5240.5 4786.3 5078.8 5094.2 5250.1 5301.0 5168.3 5177.7 5199.8 5208.0 5218.0 5217.8 5220.7 5221.5 5224.9 5227.3 4986.2 5114.0 5140.6 5174.4 5175.1 5707.7 5738.5 5747.7 5754.6 5769.5 5757.9 6119.0 6226.3 6243.3 6261.2 4950.7 6143.2 6184.4 6188.7 6285.8 5806.8 5848.2 5854.6 5868.5 5894.1 6281.6 6282.2 6290.2 6291.3 6294.2 6002.3 6064.8 6137.8 6144.8 6154.1 6109.7 6124.3 6131.9 6140.5 6141.8 6109.3 6116.0 6125.8 6129.6 6148.7 6087.7 6118.6 6123.0 6124.8 6150.9 4814.5 4871.6 4872.2 4913.9 4947.4 4445.6 4449.5 4464.0 4484.1 4485.2 5755.7 5764.1 5769.1 5772.8 5773.7 5128.9 6087.5 6130.5 6141.6 6174.2 5597.0 5598.3 5670.0 5683.0 5719.7 5287.2 5306.8 5315.1 5369.0 5447.4 6268.1 6278.0 6311.4 6324.2 6325.5 6223.6 6321.6 6340.1 6351.2 6352.5 6195.4 6215.2 6235.3 6250.7 6274.8 6153.1 6167.0 6171.8 6180.3 6194.3 6192.9 6220.9 6228.2 6231.7 6239.6 5871.4 5897.5 5994.2 6073.2 6084.7 5897.4 5933.0 6049.3 6082.9 6133.3 5931.6 5962.9 5985.3 6003.5 6004.3 5169.1 5904.8 5962.9 5992.0 6100.5 5910.3 5927.5 5943.8 5944.4 5966.9 03:14:13 INFO - PROCESS | 1637 | 03:14:13 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:71261.07 Median:39618.20 stddev:152748.06 (385.6%) stddev-sans-first:153083.98 03:14:13 INFO - PROCESS | 1637 | Values: 428.7 451.1 468.8 484.8 512.7 31389.5 40756.0 41874.6 41969.6 42095.6 36634.6 38124.8 42662.8 44351.6 44849.8 9165.9 9363.0 9384.5 9394.4 9396.3 8397.8 8620.4 11133.0 11387.3 11394.4 11315.9 11450.8 11498.0 11505.9 11515.3 11346.0 11409.3 11412.4 11414.3 11442.5 8322.1 8532.4 10984.3 11215.4 11249.2 41653.0 42043.4 42107.0 42134.8 42190.0 3977.0 4003.9 4014.4 4017.6 4038.8 29512.6 29536.9 29618.9 30314.4 30330.1 3039.3 3233.4 3333.4 3351.4 3357.2 462469.0 464109.0 464460.0 466461.0 467453.0 63470.1 63601.4 66088.0 66405.3 66598.0 67369.7 70849.6 71020.0 71102.6 71137.0 16813.1 17046.7 17057.8 17070.8 17114.6 11735.6 12971.5 13005.0 13014.8 13027.3 16087.9 16606.9 17817.7 21626.9 21936.9 8712.0 8870.7 8892.6 8897.5 8908.8 881.9 891.2 897.3 904.3 920.9 30026.7 30874.8 31014.5 31307.4 31673.4 1064.5 1066.8 1107.2 1116.3 1185.2 16012.6 16082.9 16157.8 16250.6 16639.8 541145.0 663412.0 665666.0 666860.0 668554.0 52274.7 62673.0 63244.4 63444.0 63571.7 1420.3 1462.6 1479.3 1485.2 1486.5 28402.4 30366.5 30494.2 30796.7 30981.0 54424.5 54837.7 54862.7 54921.9 55011.7 592510.0 592597.0 593800.0 594000.0 596190.0 36491.6 44261.8 44633.9 45092.8 45217.8 39755.0 45951.3 45977.9 47199.3 48716.8 38085.8 39084.8 39206.8 39611.6 40443.4 38420.8 38917.8 39624.8 39654.4 39953.8 36715.4 37264.8 37690.0 37738.6 38097.0 32081.0 32969.7 34494.6 34508.0 34593.8 21422.9 24410.9 24824.6 25122.7 25383.4 03:14:13 INFO - PROCESS | 1637 | 03:14:13 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:40932.88 Median:2578.46 stddev:128203.75 (4972.1%) stddev-sans-first:128527.23 03:14:13 INFO - PROCESS | 1637 | Values: 376.5 395.5 398.2 405.5 427.0 13720.1 15843.3 17873.8 20310.4 20837.9 20768.2 20871.4 21195.0 21272.3 21425.8 5606.4 5655.0 5728.5 5826.2 5922.2 5830.6 5879.9 5887.9 5888.0 5900.5 3812.3 4002.5 5382.0 5629.5 5656.6 4855.7 5568.9 5707.4 5726.3 5758.2 5671.2 5731.0 5737.9 5742.4 5743.3 13034.0 13038.7 13050.9 13202.4 13240.3 2546.6 2564.7 2592.3 2604.3 2604.5 9165.2 9314.6 9607.6 9674.1 11469.8 1750.5 1754.3 1757.1 1765.5 1789.7 125553.0 140585.3 142449.9 143006.0 144961.3 11550.5 11706.8 11718.8 11796.5 11913.9 15441.0 15449.2 15469.4 15470.5 15476.5 8376.8 8520.8 8524.4 8594.4 8648.4 8082.6 8363.7 8398.0 8523.2 8546.3 4505.2 4632.2 4636.8 4640.9 4699.5 1958.7 2023.8 2026.4 2029.5 2030.2 998.7 1007.3 1016.4 1023.6 1057.8 20734.0 21206.7 21418.6 21419.8 21422.6 834.9 976.9 982.7 1058.1 1068.5 10297.8 10890.6 10932.6 10977.9 11015.4 762764.2 763573.0 763755.0 771503.0 787177.0 119628.4 144222.6 152107.0 157740.0 157931.0 831.0 951.6 983.3 988.1 990.0 17808.1 18489.5 18713.1 18743.4 18766.7 57551.1 59814.8 60090.8 60669.1 61580.8 88095.6 89080.0 89535.0 90821.2 91918.0 4679.6 5651.1 7951.0 8291.5 8350.2 9997.0 10415.7 10622.3 12591.4 13108.6 10699.4 10882.5 11084.1 11242.7 11287.3 9230.0 9230.1 10298.3 10814.4 11211.1 10353.1 10450.7 11174.6 11215.8 11366.8 8024.4 8287.5 8435.2 8501.0 8503.0 10667.7 11019.6 11024.8 11081.1 11202.7 03:14:13 INFO - PROCESS | 1637 | 03:14:13 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5437.12 Median:5162.37 stddev:2996.03 (58.0%) stddev-sans-first:2989.39 03:14:13 INFO - PROCESS | 1637 | Values: 1441.2 1441.7 1449.4 1463.9 1466.1 7856.4 8142.9 8534.9 8546.2 8559.4 7089.6 7766.8 7785.2 8151.7 8416.6 2327.3 2370.8 2375.9 2376.9 2377.9 2341.3 2374.7 2377.8 2387.8 2388.5 2328.4 2332.9 2362.9 2363.5 2372.0 2292.7 2298.2 2315.6 2352.7 2353.4 2089.7 2202.8 2309.1 2385.1 2386.6 8498.7 8571.6 8573.0 8590.6 8599.1 4950.0 5029.8 5198.1 5199.5 5208.6 3312.0 3527.5 3541.8 3606.5 3606.5 1169.0 1226.4 1242.8 1253.1 1268.0 10893.6 10967.9 10969.4 10974.6 10985.8 4381.6 4652.5 4744.5 4750.0 4759.6 9583.0 9590.7 9602.3 9603.6 9635.8 5264.7 5274.6 5277.3 5278.6 5285.0 3950.8 4267.9 4339.2 4741.6 4793.1 3885.7 3891.0 4009.1 4015.4 4049.6 1272.3 1287.1 1292.2 1300.8 1301.2 668.4 733.8 752.7 768.5 795.8 4857.8 5145.2 5179.6 5601.9 5632.9 564.9 574.8 578.7 589.6 589.8 3542.5 3662.4 3738.9 3739.5 3755.0 9792.4 10121.0 10172.3 10183.4 10199.9 9813.7 9901.0 10144.4 10146.0 10162.1 7767.5 7850.6 7867.7 7870.7 7889.9 5349.7 5377.9 5379.5 5506.8 5524.3 9036.5 9179.2 9254.7 9322.9 9424.3 8413.9 8699.7 9542.7 9546.3 9591.0 6646.0 6876.2 6920.6 7200.5 7288.7 7961.8 7992.0 8084.6 8139.8 8150.0 7041.4 7184.2 7204.6 7213.1 7227.7 7011.8 7013.1 7056.2 7214.4 7222.4 6323.7 6467.8 6472.8 6476.7 6482.9 4923.2 4964.3 4977.3 4985.3 5003.5 4825.3 4895.0 4950.8 5045.4 5132.5 03:14:13 INFO - PROCESS | 1637 | 03:14:13 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4498.97 Median:4857.47 stddev:1352.50 (27.8%) stddev-sans-first:1320.02 03:14:13 INFO - PROCESS | 1637 | Values: 353.5 354.6 362.1 376.2 377.1 4526.0 4678.7 5211.2 5331.3 5440.5 5185.4 5225.5 5291.4 5293.2 5301.6 4192.7 4210.5 4228.4 4279.5 4294.8 3399.5 3829.0 3844.4 4015.2 4121.2 3953.3 4160.3 4167.2 4202.3 4212.5 3539.6 3707.2 4175.7 4178.9 4198.0 3109.8 3346.3 3601.5 3704.2 3782.3 4850.0 5061.5 5185.2 5268.8 5418.3 4124.4 4519.5 4521.9 4805.6 4858.4 5003.0 5139.2 5157.6 5289.7 5742.6 4022.2 4063.7 4127.7 4132.8 4166.8 5638.6 5777.0 5800.2 5831.9 5841.7 3675.5 4105.7 4197.7 4220.7 4245.0 3624.6 3718.8 4197.3 4237.7 4289.5 4796.6 4832.4 4834.4 4851.5 4856.6 4970.6 5666.3 5702.0 5762.0 5827.7 1220.6 1242.5 1254.2 1254.4 1404.3 817.4 856.6 941.0 986.7 992.7 4414.0 4645.6 4666.4 4748.8 5143.5 4863.1 5111.8 5175.2 5529.5 5628.9 4219.3 4365.5 4463.7 4489.9 4985.9 2594.7 2612.6 2885.1 2899.3 2988.8 4809.0 5198.0 5775.4 5974.3 6005.6 5068.9 5310.7 5510.6 6071.3 6132.9 5825.9 5936.0 6112.4 6128.7 6130.6 5131.3 5549.1 5722.6 5790.8 5944.9 4797.6 5093.6 5247.5 5380.4 5623.1 4834.4 5916.3 5981.7 6042.7 6131.3 3565.4 3667.4 3863.4 3886.9 3940.8 4627.4 4729.9 5130.4 5768.2 5818.9 4461.9 4907.4 5389.9 5559.4 5685.6 4801.9 5423.8 5433.7 5458.6 5632.6 4594.4 5226.3 5443.8 5473.6 5585.6 4376.7 4582.4 5225.1 5287.0 5624.8 4540.3 4905.8 5016.8 5406.9 5468.8 03:14:13 INFO - PROCESS | 1637 | 03:14:13 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:20465.11 Median:3623.67 stddev:29692.19 (819.4%) stddev-sans-first:29738.37 03:14:13 INFO - PROCESS | 1637 | Values: 693.6 729.6 746.7 805.5 812.8 14269.9 15224.8 15249.6 15261.5 15268.2 13624.6 13939.3 13984.4 14055.7 14129.2 835.6 883.1 885.8 901.9 902.0 852.3 889.5 889.6 889.7 889.8 741.8 760.5 910.4 941.4 949.8 939.4 939.6 939.8 940.4 941.3 694.5 696.3 697.1 697.6 700.0 10499.7 11022.8 12738.2 14626.2 14715.9 14034.3 14211.5 14262.6 14277.1 14323.1 10919.8 11211.9 11294.5 11581.8 12079.2 3229.8 3331.6 3621.3 3632.3 3804.9 100547.0 101433.0 104859.0 105449.5 105663.0 10365.9 10372.2 10531.2 11023.2 11123.5 21663.0 21683.3 22320.0 22634.1 22961.4 7583.7 7631.1 7631.4 7653.1 7835.3 4168.2 4174.4 4251.6 4342.3 4484.9 3513.6 3527.3 3582.7 3626.0 3642.7 631.2 634.9 642.2 644.9 647.5 611.9 669.1 673.8 676.4 693.7 10013.8 10097.0 10103.0 10319.8 10424.9 681.9 705.1 705.4 717.1 720.5 4667.4 4942.7 4956.8 4962.9 4964.0 104247.5 105524.0 106812.9 108981.0 109949.5 88621.0 88918.0 89806.0 90953.1 92543.6 78660.0 80455.6 80920.2 81723.0 82256.6 9465.1 9544.3 9584.8 9588.6 9669.3 49401.8 50295.0 51224.7 52018.7 52535.7 45110.0 67001.3 67906.7 69152.3 69505.3 12499.0 12849.2 13162.9 13178.5 13328.3 14035.4 14258.6 14568.7 14613.8 15018.5 12839.9 13279.9 13447.9 13645.3 13732.0 10674.3 11644.7 12712.4 13463.1 13545.9 13158.6 13201.8 13260.7 13550.2 14092.5 10751.9 11015.6 11310.7 11626.6 11808.0 10579.3 10609.1 11389.0 11555.7 11627.0 03:14:13 INFO - PROCESS | 1637 | -------- Summary: end -------- 03:14:13 INFO - PROCESS | 1637 | 03:14:14 INFO - TEST-INFO | 1637: exit 0 03:14:14 INFO - TEST-OK | dromaeo_css | took 1118579ms 03:14:14 INFO - TEST-START | kraken 03:14:14 INFO - operating with platform_type : mac_ 03:14:14 INFO - Initialising browser for kraken test... 03:14:14 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/tmpLA8ir9/profile http://localhost:49247/getInfo.html) 03:14:16 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 03:14:16 INFO - PROCESS | 1646 | colorDepth:24 03:14:16 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 03:14:16 INFO - PROCESS | 1646 | __metrics 03:14:16 INFO - PROCESS | 1646 | 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" 03:14:16 INFO - PROCESS | 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:14:17 INFO - TEST-INFO | 1646: exit 0 03:14:17 INFO - Browser initialized. 03:14:17 INFO - Running cycle 1/1 for kraken test... 03:14:17 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/tmpLA8ir9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:14:29 INFO - PROCESS | 1647 | RSS: Main: 213123072 03:14:29 INFO - PROCESS | 1647 | 03:14:32 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection) 03:14:33 INFO - PROCESS | 1647 | RSS: Main: 266067968 03:14:33 INFO - PROCESS | 1647 | 03:14:35 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-dft) 03:14:36 INFO - PROCESS | 1647 | RSS: Main: 275185664 03:14:36 INFO - PROCESS | 1647 | 03:14:39 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-fft) 03:14:40 INFO - PROCESS | 1647 | RSS: Main: 373088256 03:14:40 INFO - PROCESS | 1647 | 03:14:42 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator) 03:14:42 INFO - PROCESS | 1647 | RSS: Main: 277315584 03:14:42 INFO - PROCESS | 1647 | 03:14:44 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:14:45 INFO - PROCESS | 1647 | RSS: Main: 278732800 03:14:45 INFO - PROCESS | 1647 | 03:14:48 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom) 03:14:49 INFO - PROCESS | 1647 | RSS: Main: 318914560 03:14:49 INFO - PROCESS | 1647 | 03:14:52 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate) 03:14:52 INFO - PROCESS | 1647 | RSS: Main: 320290816 03:14:52 INFO - PROCESS | 1647 | 03:14:55 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial) 03:14:56 INFO - PROCESS | 1647 | RSS: Main: 318418944 03:14:56 INFO - PROCESS | 1647 | 03:14:57 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:14:58 INFO - PROCESS | 1647 | RSS: Main: 295378944 03:14:58 INFO - PROCESS | 1647 | 03:15:00 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:15:00 INFO - PROCESS | 1647 | RSS: Main: 299233280 03:15:00 INFO - PROCESS | 1647 | 03:15:03 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:15:03 INFO - PROCESS | 1647 | RSS: Main: 302026752 03:15:03 INFO - PROCESS | 1647 | 03:15:06 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:15:07 INFO - PROCESS | 1647 | RSS: Main: 318218240 03:15:07 INFO - PROCESS | 1647 | 03:15:10 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:15:11 INFO - PROCESS | 1647 | RSS: Main: 312446976 03:15:11 INFO - PROCESS | 1647 | 03:15:12 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49247/tests/kraken/driver.html?testName=ai-astar) 03:15:13 INFO - PROCESS | 1647 | RSS: Main: 356896768 03:15:13 INFO - PROCESS | 1647 | 03:15:13 INFO - PROCESS | 1647 | __start_tp_report 03:15:13 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 03:15:13 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 03:15:13 INFO - PROCESS | 1647 | |i|pagename|runs| 03:15:13 INFO - PROCESS | 1647 | |0;ai-astar;117;114;113;113;113;113;112;113;113;111 03:15:13 INFO - PROCESS | 1647 | |1;audio-beat-detection;149;119;138;177;142;109;107;108;128;109 03:15:13 INFO - PROCESS | 1647 | |2;audio-dft;183;184;184;184;184;186;185;185;185;185 03:15:13 INFO - PROCESS | 1647 | |3;audio-fft;80;59;79;115;87;71;58;57;73;58 03:15:13 INFO - PROCESS | 1647 | |4;audio-oscillator;88;71;86;69;67;68;80;68;68;82 03:15:13 INFO - PROCESS | 1647 | |5;imaging-gaussian-blur;87;85;89;131;126;85;88;85;86;85 03:15:13 INFO - PROCESS | 1647 | |6;imaging-darkroom;96;116;122;96;96;97;98;96;97;95 03:15:13 INFO - PROCESS | 1647 | |7;imaging-desaturate;88;84;85;86;85;85;86;86;85;85 03:15:13 INFO - PROCESS | 1647 | |8;json-parse-financial;58;56;55;53;53;57;55;55;55;56 03:15:13 INFO - PROCESS | 1647 | |9;json-stringify-tinderbox;63;72;77;70;70;68;69;70;68;93 03:15:13 INFO - PROCESS | 1647 | |10;stanford-crypto-aes;84;83;82;85;83;83;83;84;100;87 03:15:13 INFO - PROCESS | 1647 | |11;stanford-crypto-ccm;138;137;139;140;143;145;152;137;197;140 03:15:13 INFO - PROCESS | 1647 | |12;stanford-crypto-pbkdf2;169;167;180;228;205;167;167;167;166;165 03:15:13 INFO - PROCESS | 1647 | |13;stanford-crypto-sha256-iterative;66;67;65;66;66;65;64;67;64;67 03:15:13 INFO - PROCESS | 1647 | __end_tp_report 03:15:13 INFO - PROCESS | 1647 | __start_cc_report 03:15:13 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,2206 03:15:13 INFO - PROCESS | 1647 | __end_cc_report 03:15:13 INFO - PROCESS | 1647 | __startTimestamp1487934913155__endTimestamp 03:15:13 INFO - PROCESS | 1647 | 03:15:13 INFO - PROCESS | 1647 | ------- Summary: start ------- 03:15:13 INFO - PROCESS | 1647 | Number of tests: 14 03:15:13 INFO - PROCESS | 1647 | 03:15:13 INFO - PROCESS | 1647 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.00 stddev:1.55 (1.4%) stddev-sans-first:0.83 03:15:13 INFO - PROCESS | 1647 | Values: 117.0 114.0 113.0 113.0 113.0 113.0 112.0 113.0 113.0 111.0 03:15:13 INFO - PROCESS | 1647 | 03:15:13 INFO - PROCESS | 1647 | [#1] audio-beat-detection Cycles:10 Average:128.60 Median:133.00 stddev:23.04 (17.3%) stddev-sans-first:23.23 03:15:13 INFO - PROCESS | 1647 | Values: 149.0 119.0 138.0 177.0 142.0 109.0 107.0 108.0 128.0 109.0 03:15:13 INFO - PROCESS | 1647 | 03:15:13 INFO - PROCESS | 1647 | [#2] audio-dft Cycles:10 Average:184.50 Median:185.00 stddev:0.85 (0.5%) stddev-sans-first:0.71 03:15:13 INFO - PROCESS | 1647 | Values: 183.0 184.0 184.0 184.0 184.0 186.0 185.0 185.0 185.0 185.0 03:15:13 INFO - PROCESS | 1647 | 03:15:13 INFO - PROCESS | 1647 | [#3] audio-fft Cycles:10 Average:73.70 Median:72.00 stddev:18.09 (25.1%) stddev-sans-first:19.05 03:15:13 INFO - PROCESS | 1647 | Values: 80.0 59.0 79.0 115.0 87.0 71.0 58.0 57.0 73.0 58.0 03:15:13 INFO - PROCESS | 1647 | 03:15:13 INFO - PROCESS | 1647 | [#4] audio-oscillator Cycles:10 Average:74.70 Median:75.50 stddev:8.34 (11.0%) stddev-sans-first:7.33 03:15:13 INFO - PROCESS | 1647 | Values: 88.0 71.0 86.0 69.0 67.0 68.0 80.0 68.0 68.0 82.0 03:15:13 INFO - PROCESS | 1647 | 03:15:13 INFO - PROCESS | 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:94.70 Median:85.50 stddev:17.91 (20.9%) stddev-sans-first:18.78 03:15:13 INFO - PROCESS | 1647 | Values: 87.0 85.0 89.0 131.0 126.0 85.0 88.0 85.0 86.0 85.0 03:15:13 INFO - PROCESS | 1647 | 03:15:13 INFO - PROCESS | 1647 | [#6] imaging-darkroom Cycles:10 Average:100.90 Median:96.00 stddev:9.68 (10.1%) stddev-sans-first:10.10 03:15:13 INFO - PROCESS | 1647 | Values: 96.0 116.0 122.0 96.0 96.0 97.0 98.0 96.0 97.0 95.0 03:15:13 INFO - PROCESS | 1647 | 03:15:13 INFO - PROCESS | 1647 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:85.50 stddev:1.08 (1.3%) stddev-sans-first:0.67 03:15:13 INFO - PROCESS | 1647 | Values: 88.0 84.0 85.0 86.0 85.0 85.0 86.0 86.0 85.0 85.0 03:15:13 INFO - PROCESS | 1647 | 03:15:13 INFO - PROCESS | 1647 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.50 stddev:1.57 (2.8%) stddev-sans-first:1.32 03:15:13 INFO - PROCESS | 1647 | Values: 58.0 56.0 55.0 53.0 53.0 57.0 55.0 55.0 55.0 56.0 03:15:13 INFO - PROCESS | 1647 | 03:15:13 INFO - PROCESS | 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:72.00 Median:70.00 stddev:8.16 (11.7%) stddev-sans-first:7.98 03:15:13 INFO - PROCESS | 1647 | Values: 63.0 72.0 77.0 70.0 70.0 68.0 69.0 70.0 68.0 93.0 03:15:13 INFO - PROCESS | 1647 | 03:15:13 INFO - PROCESS | 1647 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:83.50 stddev:5.32 (6.4%) stddev-sans-first:5.61 03:15:13 INFO - PROCESS | 1647 | Values: 84.0 83.0 82.0 85.0 83.0 83.0 83.0 84.0 100.0 87.0 03:15:13 INFO - PROCESS | 1647 | 03:15:13 INFO - PROCESS | 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:146.80 Median:141.50 stddev:18.22 (12.9%) stddev-sans-first:19.04 03:15:13 INFO - PROCESS | 1647 | Values: 138.0 137.0 139.0 140.0 143.0 145.0 152.0 137.0 197.0 140.0 03:15:13 INFO - PROCESS | 1647 | 03:15:13 INFO - PROCESS | 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.10 Median:168.00 stddev:21.37 (12.7%) stddev-sans-first:22.41 03:15:13 INFO - PROCESS | 1647 | Values: 169.0 167.0 180.0 228.0 205.0 167.0 167.0 167.0 166.0 165.0 03:15:13 INFO - PROCESS | 1647 | 03:15:13 INFO - PROCESS | 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:1.16 (1.8%) stddev-sans-first:1.22 03:15:13 INFO - PROCESS | 1647 | Values: 66.0 67.0 65.0 66.0 66.0 65.0 64.0 67.0 64.0 67.0 03:15:13 INFO - PROCESS | 1647 | -------- Summary: end -------- 03:15:13 INFO - PROCESS | 1647 | 03:15:14 INFO - TEST-INFO | 1647: exit 0 03:15:14 INFO - TEST-OK | kraken | took 59963ms 03:15:14 INFO - SUITE-END | took 1178s 03:15:14 INFO - Completed test suite (00:19:38) 03:15:14 INFO - javascript benchmark 03:15:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3300.801951882887, 3318.1704573856537, 3340.832958352083, 3352.2122301259215, 3383.5432216650743, 5641.097424412095, 5644.379118296989, 5659.915101273484, 5660.773569057243, 5663.065594176961, 5538.224648549196, 5575.107982722765, 5587.106063029916, 5667.829965101054, 5709.371969083398, 5133.922991155136, 5139.997700448414, 5167.483251674821, 5191.0656081905245, 5240.528352448298, 4786.282057691339, 5078.847634570969, 5094.184930411135, 5250.05499010178, 5300.966311569246, 5168.2764412982215, 5177.741112944356, 5199.818006369778, 5207.973960130194, 5218.034663587248, 5217.843464696065, 5220.712860792674, 5221.451747566489, 5224.92162617561, 5227.294315267428, 4986.227134794112, 5114.028334616448, 5140.563052140536, 5174.3790745110455, 5175.120229560984, 5707.714614269312, 5738.540916726652, 5747.683877386742, 5754.597178197528, 5769.451902069297, 5757.856053598652, 6118.990366589507, 6226.283977342573, 6243.250809902841, 6261.217347831521, 4950.653454258203, 6143.170671959273, 6184.412480814315, 6188.659623720693, 6285.842853928642, 5806.796762113306, 5848.239728835224, 5854.590178687451, 5868.530517558585, 5894.115882617599, 6281.59169653971, 6282.2147231596055, 6290.150829638032, 6291.307956124822, 6294.213223347082, 6002.309734380515, 6064.848378790477, 6137.754489820357, 6144.78493252734, 6154.076888466676, 6109.694515274218, 6124.2588809726185, 6131.877781547492, 6140.486742244447, 6141.823559979257, 6109.321562077401, 6116.040548005192, 6125.766718196725, 6129.614667185397, 6148.661823599745, 6087.6956152192215, 6118.5982485574605, 6123.0, 6124.816255512342, 6150.892839288881, 4814.470408255089, 4871.561559459666, 4872.19608764557, 4913.87715307113, 4947.406311242674, 4445.5776701213335, 4449.466064072332, 4463.977680111579, 4484.148011877733, 4485.237509623372, 5755.65466072037, 5764.106563482667, 5769.07694768835, 5772.797952071657, 5773.711314434346, 5128.897422051538, 6087.482563982023, 6130.540209484307, 6141.631502109798, 6174.166487524217, 5596.97201513998, 5598.300212473441, 5669.951059054089, 5683.0, 5719.685417302088, 5287.154055351125, 5306.8407947761625, 5315.069862773999, 5369.0, 5447.428020057916, 6268.059791031291, 6278.0, 6311.400416960473, 6324.2410910691015, 6325.5255855811, 6223.626582405071, 6321.620702757849, 6340.1440805490665, 6351.174347334817, 6352.491800656029, 6195.380461953769, 6215.223097112861, 6235.282942461494, 6250.687465626791, 6274.8431289216305, 6153.138560601609, 6166.969165154145, 6171.783987560414, 6180.289266734383, 6194.349593292639, 6192.907106393498, 6220.875582488416, 6228.159198508143, 6231.688415579112, 6239.563230573816, 5871.383504731942, 5897.498712609477, 5994.220751302303, 6073.180120683651, 6084.726187321493, 5897.351291357862, 5933.0, 6049.334573197033, 6082.878342433038, 6133.325334213144, 5931.555133365101, 5962.9105563415715, 5985.341612422717, 6003.459688628044, 6004.279486461653, 5169.147090729987, 5904.763809447746, 5962.880742385215, 5991.970040149771, 6100.481459076028, 5910.290765108042, 5927.496162826035, 5943.821685349447, 5944.405559444021, 5966.910496342472], "value": 5653.883157092638, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.66992415839803, 451.05954085731247, 468.84429880344965, 484.80850064224654, 512.7205672908266, 31389.529157062632, 40756.0, 41874.58125418745, 41969.58030419695, 42095.579044209546, 36634.633653663455, 38124.80937595308, 42662.7866860666, 44351.55648443515, 44849.77575112128, 9165.862512062324, 9362.953185234099, 9384.483853388061, 9394.389364691307, 9396.295277854155, 8397.83204335916, 8620.396572239946, 11133.0, 11387.316760994367, 11394.373309467976, 11315.943420282887, 11450.770984580304, 11498.0, 11505.942470287679, 11515.30908145514, 11346.0, 11409.315441073479, 11412.372319522465, 11414.258073225214, 11442.485088171052, 8322.126176751475, 8532.402731808776, 10984.340939543574, 11215.38315392653, 11249.212555121145, 41653.0, 42043.36934945978, 42107.0, 42134.78932605348, 42190.0, 3976.9581805939943, 4003.919921601552, 4014.3777714454304, 4017.638412542856, 4038.7980600970127, 29512.55731164013, 29536.8523157385, 29618.851905740332, 30314.393712125635, 30330.090097297118, 3039.270575061991, 3233.401820663185, 3333.399988002159, 3351.3632409842053, 3357.1607098225445, 462469.0, 464109.0, 464460.0, 466460.9999999966, 467453.0, 63470.143843527156, 63601.36398636047, 66088.0, 66405.33594664089, 66598.0, 67369.66315168393, 70849.64575177194, 71020.0, 71102.64448677724, 71137.0, 16813.07528085967, 17046.74429883553, 17057.829421705625, 17070.829291706923, 17114.572135696457, 11735.647930562096, 12971.481140754453, 13005.0, 13014.804777928339, 13027.283499407624, 16087.919560402357, 16606.916965415097, 17817.673902262402, 21626.918654067547, 21936.903154842195, 8712.0, 8870.689525866565, 8892.555372231363, 8897.510636914902, 8908.7728067983, 881.8633111867671, 891.1979218703219, 897.3359713811863, 904.2856143646577, 920.9309301802392, 30026.69973300239, 30874.845625771726, 31014.534781978287, 31307.373852522822, 31673.36653266968, 1064.4571268652887, 1066.802641511323, 1107.2083460325905, 1116.3469370418395, 1185.2355230876037, 16012.594847471712, 16082.919585401998, 16157.838421615868, 16250.593735156479, 16639.833601663828, 541145.0, 663412.0, 665666.0, 666860.0, 668554.0, 52274.73862630662, 62673.0, 63244.36755632385, 63444.0, 63571.68214158899, 1420.2898550724638, 1462.627030107316, 1479.32690625765, 1485.18314926792, 1486.5317425011087, 28402.43195136127, 30366.544501832934, 30494.196649395788, 30796.692033079384, 30981.0, 54424.45575544352, 54837.725811370685, 54862.72568637131, 54921.90156196934, 55011.72494137504, 592510.0, 592597.0, 593800.0, 594000.0, 596190.0, 36491.63508364883, 44261.77869110634, 44633.88415289644, 45092.77453612711, 45217.773911130236, 39755.0, 45951.3107303384, 45977.850553736425, 47199.29201062056, 48716.78208044827, 38085.809570953075, 39084.80457597694, 39206.80396597999, 39611.60388396079, 40443.39334910038, 38420.807895960344, 38917.80541097277, 39624.80187599159, 39654.40518392284, 39953.801385957304, 36715.44926826046, 37264.813675931444, 37690.0, 37738.62261377461, 38097.0, 32081.0, 32969.67030329666, 34494.62021519111, 34508.0, 34593.82703086468, 21422.892885536097, 24410.87794561016, 24824.627630585193, 25122.74877251204, 25383.36541586475], "value": 20875.60688305596, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.4879763521612, 395.45229856648535, 398.2453251089186, 405.49110865863344, 427.0349011234609, 13720.134814629884, 15843.287052082655, 17873.82126178738, 20310.390688279338, 20837.853918034503, 20768.169273229054, 20871.37385878426, 21195.0, 21272.255471058477, 21425.785742142572, 5606.383297837245, 5654.971725141369, 5728.513076388512, 5826.242588463494, 5922.230110085683, 5830.591858569902, 5879.911801322984, 5887.8528036799, 5888.02847530157, 5900.498457631106, 3812.2756676231566, 4002.4596679448337, 5382.0, 5629.549636029108, 5656.604037717361, 4855.68438051529, 5568.916466253009, 5707.42925707428, 5726.255586773714, 5758.157389635318, 5671.234383358235, 5730.997075511768, 5737.88524229513, 5742.368339482654, 5743.310802703702, 13034.0, 13038.739225215442, 13050.869491305155, 13202.4058917348, 13240.337983100806, 2546.6052761821948, 2564.666593342872, 2592.2612055564073, 2604.2838219489604, 2604.5181641396402, 9165.220956218729, 9314.580843862042, 9607.56765945534, 9674.129328360412, 11469.827952580717, 1750.483607335839, 1754.3158168314367, 1757.1302205408276, 1765.523308706642, 1789.6689112514227, 125553.0, 140585.29707351397, 142449.8632520513, 143006.0, 144961.27519362335, 11550.537978480934, 11706.765864682659, 11718.824217636742, 11796.52813887435, 11913.940430297793, 15441.0, 15449.227538623249, 15469.381224751109, 15470.5358839235, 15476.535703928901, 8376.790580235544, 8520.829583408296, 8524.360672949553, 8594.398392112616, 8648.394612377073, 8082.555459449669, 8363.749087527383, 8398.034226063959, 8523.190296921783, 8546.31629469641, 4505.234110201208, 4632.16621008215, 4636.79134438951, 4640.883977900579, 4699.530046995274, 1958.7257783910263, 2023.8077382648626, 2026.381953504166, 2029.533207362315, 2030.2488079410712, 998.6953979036464, 1007.3401921741271, 1016.3800081950004, 1023.6161439460202, 1057.7571353659418, 20734.0, 21206.681899771516, 21418.57162856734, 21419.78580214209, 21422.57154856894, 834.9290310323569, 976.8827740671165, 982.6930182856784, 1058.1006144776877, 1068.4943806773106, 10297.764268287854, 10890.564377424973, 10932.617358392417, 10977.945110274557, 11015.394153321484, 762764.1861790655, 763573.0, 763755.0, 771503.0, 787177.0, 119628.40185799015, 144222.557774423, 152107.0, 157740.0, 157931.0, 830.9667613295401, 951.6003278622995, 983.311681822727, 988.1205726903062, 989.9653512127041, 17808.109594519963, 18489.53776155607, 18713.064346782878, 18743.437696869114, 18766.71849922225, 57551.1367329482, 59814.80370392481, 60090.82289535511, 60669.0899636497, 61580.76838463295, 88095.55952220198, 89080.0, 89535.0, 90821.18357632942, 91918.0, 4679.625629949528, 5651.067573850269, 7950.9663743712945, 8291.461055031645, 8350.206730360605, 9997.0, 10415.739606509898, 10622.29947851999, 12591.433385497492, 13108.606741797761, 10699.411532365482, 10882.455877206266, 11084.057855082408, 11242.718932026764, 11287.266327688674, 9229.954115142122, 9230.076992300716, 10298.279120461495, 10814.405207713651, 11211.103111750877, 10353.119984801377, 10450.68647940563, 11174.55301787952, 11215.775684486427, 11366.829497557377, 8024.438289319692, 8287.544185069879, 8435.198656127657, 8501.0, 8502.957485212783, 10667.679969600924, 11019.56745623096, 11024.779504410028, 11081.113510918945, 11202.719932001439], "value": 9521.224247747134, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1441.1785282389035, 1441.7332793433209, 1449.4202319072374, 1463.9268036598173, 1466.1349803615865, 7856.371490280778, 8142.877856832145, 8534.91465085349, 8546.230839224469, 8559.443636163653, 7089.574625522472, 7766.805829854256, 7785.221477852212, 8151.673933042686, 8416.57917104144, 2327.3367090379247, 2370.7866292033714, 2375.928722138339, 2376.9168079117235, 2377.9048838046456, 2341.2507997440825, 2374.6794182785275, 2377.7503362146986, 2387.77316154965, 2388.462595915914, 2328.4062564046144, 2332.9300120996313, 2362.881855907198, 2363.4800343924394, 2372.027468737818, 2292.747797742247, 2298.2186056740707, 2315.560043591712, 2352.717673879128, 2353.376355265856, 2089.7357098955217, 2202.8458007939453, 2309.099451214028, 2385.093664407514, 2386.606209975352, 8498.70254541088, 8571.614277357472, 8572.957135214285, 8590.613422396007, 8599.05410404855, 4949.975250123763, 5029.823956161554, 5198.142306519419, 5199.48005199477, 5208.635395522315, 3312.0, 3527.453244747043, 3541.8052007139595, 3606.459031145323, 3606.459031145323, 1168.9596259329203, 1226.405193481161, 1242.8446444194476, 1253.0977696058824, 1267.9982813577262, 10893.564257429693, 10967.890321096767, 10969.396683182502, 10974.615888443866, 10985.835212471819, 4381.627561657231, 4652.488226295105, 4744.525547445297, 4750.026244619845, 4759.619230461555, 9583.041695830361, 9590.712278631652, 9602.32783705148, 9603.567839447102, 9635.807283854283, 5264.736763161826, 5274.551663108678, 5277.261183434322, 5278.630495865253, 5285.048691235615, 3950.822213000422, 4267.935980960288, 4339.207376751909, 4741.573258406691, 4793.065352256276, 3885.6891448684037, 3891.0, 4009.1380353224195, 4015.437838702584, 4049.6152865477734, 1272.338384040294, 1287.073307218801, 1292.2440372382073, 1300.7918733002864, 1301.1737546657941, 668.3951024322995, 733.7945375294926, 752.6838727734365, 768.4812751392788, 795.8408318336355, 4857.80568777252, 5145.15105007677, 5179.585633149339, 5601.943980560142, 5632.85917852057, 564.8700798816295, 574.7902015764216, 578.6701580099387, 589.593180705312, 589.7965202005302, 3542.4863394807608, 3662.4140137578393, 3738.8504459821847, 3739.476473293741, 3755.0, 9792.412455252708, 10121.03850134236, 10172.338797978107, 10183.388996660076, 10199.949000254952, 9813.705588832347, 9900.950495247478, 10144.391336519833, 10146.036126567964, 10162.136218421369, 7767.495112817649, 7850.646720897574, 7867.685292588347, 7870.72452464161, 7889.921100788919, 5349.679019258857, 5377.946220537745, 5379.515843574097, 5506.752196151103, 5524.281843360337, 9036.457812531005, 9179.219766319671, 9254.722358329262, 9322.860157097513, 9424.29317801154, 8413.90619219522, 8699.652013919373, 9542.713718588453, 9546.284028697737, 9590.952045239728, 6646.0, 6876.209235937931, 6920.619365934922, 7200.49596528238, 7288.67200975968, 7961.8407631848195, 7992.040955085427, 8084.555349455836, 8139.79650508742, 8149.959250203711, 7041.4014808739785, 7184.1738200105565, 7204.56772593646, 7213.098362704662, 7227.710891564278, 7011.824704382431, 7013.088298521159, 7056.223815380202, 7214.422846172399, 7222.3860971817985, 6323.6838158090995, 6467.838304042437, 6472.805815825533, 6476.740930362921, 6482.870342593027, 4923.236898280772, 4964.3298154748645, 4977.328060711758, 4985.277134815504, 5003.499650034967, 4825.30033145199, 4894.95105048945, 4950.8267210647455, 5045.419776725576, 5132.538071573576], "value": 4358.3619106555525, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.5333359964846, 354.6117001882938, 362.0875394007101, 376.24562751682873, 377.07616339967086, 4526.004279058606, 4678.7192768433915, 5211.244369566411, 5331.280277162582, 5440.510354068133, 5185.403678576965, 5225.529702326789, 5291.391489978653, 5293.179557168635, 5301.5539899065625, 4192.664586833046, 4210.46318093895, 4228.365745138239, 4279.48646162461, 4294.763787991659, 3399.5351574579245, 3829.0427393151713, 3844.365679662866, 4015.217032678629, 4121.196366708493, 3953.3081710700512, 4160.254232206744, 4167.229062623409, 4202.348635961415, 4212.4945006599255, 3539.5752509699, 3707.2195853110165, 4175.724230294497, 4178.895527611819, 4197.97901010496, 3109.8289594072317, 3346.297277571713, 3601.531800865897, 3704.1850792825803, 3782.316868993272, 4849.951500485021, 5061.506855477606, 5185.248139019859, 5268.81559145428, 5418.268533747933, 4124.4019617155345, 4519.5480451954545, 4521.892136426596, 4805.591524720403, 4858.368412106439, 5002.974985125087, 5139.1734545999925, 5157.638965272433, 5289.709066001368, 5742.626729262584, 4022.2156679447226, 4063.735857169304, 4127.731697439657, 4132.793360332002, 4166.791660416998, 5638.618538458063, 5777.0, 5800.185845748061, 5831.89709004621, 5841.678707671076, 3675.467057276733, 4105.7331273467125, 4197.727147735387, 4220.683448741357, 4244.978775106105, 3624.5831729350934, 3718.7768733876055, 4197.328427451593, 4237.660987121023, 4289.528151903288, 4796.625670293227, 4832.371791667061, 4834.371531700926, 4851.466338702739, 4856.562909338177, 4970.589264206857, 5666.320041594952, 5702.0, 5761.971190144106, 5827.708614569255, 1220.5727995201607, 1242.4967888005372, 1254.2474515290753, 1254.4480428611382, 1404.3048690897867, 817.4073796497611, 856.6165642487463, 940.9905900941039, 986.7483791633088, 992.6724181020246, 4413.955860441354, 4645.607512131255, 4666.440027196758, 4748.762561871962, 5143.459936706667, 4863.106451661256, 5111.7699703513435, 5175.205389089924, 5529.502344788988, 5628.887422251614, 4219.303814870574, 4365.541618130114, 4463.745808366754, 4489.88775280614, 4985.903101317705, 2594.727553606844, 2612.568926127206, 2885.1344596621348, 2899.275181204699, 2988.8356140412484, 4808.9519104808505, 5198.02475059475, 5775.422457754275, 5974.3428222895445, 6005.567745063257, 5068.873278168002, 5310.654807437504, 5510.641808282529, 6071.332153463116, 6132.877342453126, 5825.921854701725, 5936.0, 6112.358202388774, 6128.662923539248, 6130.601510901777, 5131.307273518177, 5549.084401073777, 5722.62511057923, 5790.826275211751, 5944.940550594439, 4797.616190704665, 5093.6247213252955, 5247.457965873096, 5380.408155103014, 5623.100303951348, 4834.365270927283, 5916.26046744157, 5981.663294111908, 6042.728077236623, 6131.264248290234, 3565.3777531222713, 3667.431548110047, 3863.4204869269834, 3886.9416958746206, 3940.763554186758, 4627.421572303462, 4729.895196637463, 5130.358705161855, 5768.202421825327, 5818.9127163093435, 4461.933071003873, 4907.362042934538, 5389.895071510409, 5559.360673522435, 5685.573581981451, 4801.91956809715, 5423.83728488146, 5433.701146436984, 5458.61789674719, 5632.605717599728, 4594.379758732528, 5226.320578324793, 5443.755031023693, 5473.589480789036, 5585.636933599303, 4376.6717496187275, 4582.358469814162, 5225.1117310056625, 5286.97356513215, 5624.803131890364, 4540.341650460598, 4905.773556610848, 5016.849494515171, 5406.939120911879, 5468.7539060741565], "value": 4086.5659056174836, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.5526585352451, 729.6096588325247, 746.7386414754836, 805.4683908620311, 812.825242572847, 14269.928650356747, 15224.847751522482, 15249.618759531017, 15261.465848695298, 15268.236588170603, 13624.591262262124, 13939.303034848243, 13984.37070331835, 14055.718885622282, 14129.222892740896, 835.5905606252923, 883.1212943121603, 885.8006948436615, 901.914318139779, 902.0122965352928, 852.2883392367349, 889.5329951775337, 889.6263569300877, 889.6975028490313, 889.7553172877446, 741.7626359564941, 760.4714723267332, 910.3718434280325, 941.3504681769557, 949.8337790886602, 939.3800091939355, 939.628846605587, 939.8120375924808, 940.3652534539159, 941.3269512298739, 694.5450729772008, 696.2723953468637, 697.1181455458849, 697.5709938387905, 700.0094865764936, 10499.685009449653, 11022.834657480144, 12738.172018818746, 14626.195559244237, 14715.926420367936, 14034.298285085704, 14211.502597409144, 14262.64343391413, 14277.071990320595, 14323.069000514934, 10919.781604367947, 11211.887881121247, 11294.491747871365, 11581.826272605833, 12079.154459187861, 3229.8223597702117, 3331.583552055993, 3621.2938476996997, 3632.2735452909524, 3804.923901521982, 100546.9945300545, 101433.0, 104859.0, 105449.47275263652, 105663.0, 10365.896341036643, 10372.222083343779, 10531.15750739939, 11023.17326200538, 11123.499442525106, 21663.0, 21683.34949951504, 22320.0, 22634.094636214697, 22961.425964351023, 7583.681747113951, 7631.084269887538, 7631.3894888408795, 7653.119891212582, 7835.333996610352, 4168.166366726667, 4174.373843923436, 4251.638610718123, 4342.261815491374, 4484.887877803081, 3513.648635136466, 3527.2592755521114, 3582.7492075554983, 3626.0390996385977, 3642.7085833133287, 631.1542533005794, 634.8825467288566, 642.1715986377613, 644.8613548087184, 647.5175993884492, 611.9326874043894, 669.1368135105756, 673.8483841135803, 676.4419354032844, 693.6531734132933, 10013.849792253122, 10097.0, 10103.0, 10319.813221479475, 10424.895751042393, 681.877262092828, 705.1432509500981, 705.4237489364293, 717.0964584623308, 720.4704542161508, 4667.393238878924, 4942.728149951715, 4956.826511072095, 4962.8759281018265, 4964.0, 104247.47876260722, 105524.0, 106812.93187068186, 108981.0, 109949.45025274823, 88621.0, 88918.0, 89806.0, 90953.09046909578, 92543.61184582236, 78660.0, 80455.59772201102, 80920.19079809244, 81723.0, 82256.58871705603, 9465.05349465048, 9544.33189676716, 9584.779406257077, 9588.616455341707, 9669.274804389559, 49401.75299123481, 50295.0, 51224.74387628038, 52018.73990630022, 52535.68660783511, 45110.0, 67001.32998669951, 67906.66046669734, 69152.27119322057, 69505.30494694988, 12499.0, 12849.164804287691, 13162.868371316546, 13178.538751143664, 13328.2669453181, 14035.36840842185, 14258.64353391132, 14568.708625827636, 14613.780793288322, 15018.474353397578, 12839.935800320938, 13279.933600331937, 13447.865521345053, 13645.317734113452, 13732.0, 10674.271543707378, 11644.708882277671, 12712.427940742873, 13463.12489688167, 13545.864541354855, 13158.60524184276, 13201.801972970221, 13260.734785304432, 13550.186988780704, 14092.474420174007, 10751.892481075089, 11015.614453494089, 11310.660680179608, 11626.593069242535, 11808.0, 10579.31234469757, 10609.098226650513, 11389.0, 11555.653330400102, 11627.0], "value": 7479.280110953816, "unit": "score"}], "name": "dromaeo_css", "value": 7286.936579946048, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 113.0, 113.0, 113.0, 113.0, 112.0, 113.0, 113.0, 111.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 119.0, 138.0, 177.0, 142.0, 109.0, 107.0, 108.0, 128.0, 109.0], "value": 128.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 184.0, 184.0, 184.0, 186.0, 185.0, 185.0, 185.0, 185.0], "value": 184.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 79.0, 115.0, 87.0, 71.0, 58.0, 57.0, 73.0, 58.0], "value": 73.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 86.0, 69.0, 67.0, 68.0, 80.0, 68.0, 68.0, 82.0], "value": 74.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 89.0, 131.0, 126.0, 85.0, 88.0, 85.0, 86.0, 85.0], "value": 94.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 116.0, 122.0, 96.0, 96.0, 97.0, 98.0, 96.0, 97.0, 95.0], "value": 100.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 85.0, 86.0, 85.0, 85.0, 86.0, 86.0, 85.0, 85.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 55.0, 53.0, 53.0, 57.0, 55.0, 55.0, 55.0, 56.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 72.0, 77.0, 70.0, 70.0, 68.0, 69.0, 70.0, 68.0, 93.0], "value": 72.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 82.0, 85.0, 83.0, 83.0, 83.0, 84.0, 100.0, 87.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 137.0, 139.0, 140.0, 143.0, 145.0, 152.0, 137.0, 197.0, 140.0], "value": 146.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 167.0, 180.0, 228.0, 205.0, 167.0, 167.0, 167.0, 166.0, 165.0], "value": 178.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 66.0, 66.0, 65.0, 64.0, 67.0, 64.0, 67.0], "value": 65.7, "unit": "score"}], "name": "kraken", "value": 1459.1, "alertThreshold": 2.0}]} 03:15:14 INFO - Return code: 0 03:15:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:15:14 ERROR - # TBPL SUCCESS # 03:15:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:15:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:15:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:15:14 INFO - 2017-02-24 03:15:14.457 screenresolution[1651:9663] starting screenresolution argv=screenresolution get 03:15:14 INFO - 2017-02-24 03:15:14.460 screenresolution[1651:9663] Display 0: 1600x1200x32@60 03:15:14 INFO - 2017-02-24 03:15:14.466 screenresolution[1652:9666] starting screenresolution argv=screenresolution list 03:15:14 INFO - Available Modes on Display 0 03:15:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:15:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:15:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:15:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:15:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:15:14 INFO - Intel Iris: 03:15:14 INFO - Chipset Model: Intel Iris 03:15:14 INFO - Type: GPU 03:15:14 INFO - Bus: Built-In 03:15:14 INFO - VRAM (Dynamic, Max): 1536 MB 03:15:14 INFO - Vendor: Intel (0x8086) 03:15:14 INFO - Device ID: 0x0a2e 03:15:14 INFO - Revision ID: 0x0009 03:15:14 INFO - Displays: 03:15:14 INFO - Display: 03:15:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:15:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:15:14 INFO - Display Serial Number: 1600x1200 60 03:15:14 INFO - Main Display: Yes 03:15:14 INFO - Mirror: Off 03:15:14 INFO - Online: Yes 03:15:14 INFO - Rotation: Supported 03:15:14 INFO - Return code: 0 03:15:14 INFO - Running post-action listener: _resource_record_post_action 03:15:14 INFO - [mozharness: 2017-02-24 11:15:14.708400Z] Finished run-tests step (success) 03:15:14 INFO - Running post-run listener: _resource_record_post_run 03:15:14 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 37757952; Write bytes: 508934656; Read time: 237; Write time: 1594 03:15:14 INFO - TinderboxPrint: CPU usage
53.7% 03:15:14 INFO - TinderboxPrint: I/O read bytes / time
37,757,952 / 237 03:15:14 INFO - TinderboxPrint: I/O write bytes / time
508,934,656 / 1,594 03:15:14 INFO - TinderboxPrint: CPU idle
2,223.1 (46.3%) 03:15:14 INFO - TinderboxPrint: CPU system
960.4 (20.0%) 03:15:14 INFO - TinderboxPrint: CPU user
1,614.3 (33.6%) 03:15:14 INFO - TinderboxPrint: Swap in / out
245,714,944 / 0 03:15:14 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207700480; Write bytes: 203806720; Read time: 15934; Write time: 460 03:15:14 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 34182144; Write bytes: 295047680; Read time: 214; Write time: 1104 03:15:15 INFO - Running post-run listener: _upload_blobber_files 03:15:15 INFO - Blob upload gear active. 03:15:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:15:15 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 03:15:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:15:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:15:15 INFO - (blobuploader) - INFO - Open directory for files ... 03:15:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:15:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:15:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:15:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:15:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:15:16 INFO - (blobuploader) - INFO - Done attempting. 03:15:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:15:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:15:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:15:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:15:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:15:17 INFO - (blobuploader) - INFO - Done attempting. 03:15:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:15:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:15:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:15:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:15:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:15:18 INFO - (blobuploader) - INFO - Done attempting. 03:15:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:15:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:15:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:15:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:15:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:15:20 INFO - (blobuploader) - INFO - Done attempting. 03:15:20 INFO - (blobuploader) - INFO - Iteration through files over. 03:15:20 INFO - Return code: 0 03:15:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:15:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:15:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e66e65cc87f858a29eae29c7c1960a5137023154eae96a8c0919fc723924220dc3ae77e3339a97ee39f551bb8f22bd0fcf75c293b34ee029b2642d17bcd780b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/23498f491d5f90c443b7bcd9f9aa42a973b65fdc7d3ac9d0069fd441aa535c1b58c4f7feca9bf264f0a8aef87a3bf11f2edb91bdaefbcc85d24fed7c5e8b38e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bcc751daa082ec875d4adc46f195ee7884d3a77facf8131b9e0a96e8e1c5652c57492ad8994204048ad818379ea5a1f655bc31dc2da90bb6997987ed02117e7c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4e76303ecdd6acf3239a3b7cbc61b578713798153d61dc21532395d14c34200c688788c4583ccca0485dee2a92827d765381eaee9753dda3cd6569bf0ee8264"} 03:15:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:15:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:15:20 INFO - Contents: 03:15:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e66e65cc87f858a29eae29c7c1960a5137023154eae96a8c0919fc723924220dc3ae77e3339a97ee39f551bb8f22bd0fcf75c293b34ee029b2642d17bcd780b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/23498f491d5f90c443b7bcd9f9aa42a973b65fdc7d3ac9d0069fd441aa535c1b58c4f7feca9bf264f0a8aef87a3bf11f2edb91bdaefbcc85d24fed7c5e8b38e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bcc751daa082ec875d4adc46f195ee7884d3a77facf8131b9e0a96e8e1c5652c57492ad8994204048ad818379ea5a1f655bc31dc2da90bb6997987ed02117e7c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4e76303ecdd6acf3239a3b7cbc61b578713798153d61dc21532395d14c34200c688788c4583ccca0485dee2a92827d765381eaee9753dda3cd6569bf0ee8264"} 03:15:20 INFO - Running post-run listener: copy_logs_to_upload_dir 03:15:20 INFO - Copying logs to upload dir... 03:15:20 INFO - mkdir: /builds/slave/test/build/upload/logs 03:15:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.643514 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-24 03:15:20.842013) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-24 03:15:20.846210) ========= 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.knUqtxD9Wq/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.NhniYQq4TZ/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e66e65cc87f858a29eae29c7c1960a5137023154eae96a8c0919fc723924220dc3ae77e3339a97ee39f551bb8f22bd0fcf75c293b34ee029b2642d17bcd780b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/23498f491d5f90c443b7bcd9f9aa42a973b65fdc7d3ac9d0069fd441aa535c1b58c4f7feca9bf264f0a8aef87a3bf11f2edb91bdaefbcc85d24fed7c5e8b38e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bcc751daa082ec875d4adc46f195ee7884d3a77facf8131b9e0a96e8e1c5652c57492ad8994204048ad818379ea5a1f655bc31dc2da90bb6997987ed02117e7c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4e76303ecdd6acf3239a3b7cbc61b578713798153d61dc21532395d14c34200c688788c4583ccca0485dee2a92827d765381eaee9753dda3cd6569bf0ee8264"} build_url:https://queue.taskcluster.net/v1/task/czFwyfV5TNSXYTFyfdQ94w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010969 build_url: 'https://queue.taskcluster.net/v1/task/czFwyfV5TNSXYTFyfdQ94w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e66e65cc87f858a29eae29c7c1960a5137023154eae96a8c0919fc723924220dc3ae77e3339a97ee39f551bb8f22bd0fcf75c293b34ee029b2642d17bcd780b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/23498f491d5f90c443b7bcd9f9aa42a973b65fdc7d3ac9d0069fd441aa535c1b58c4f7feca9bf264f0a8aef87a3bf11f2edb91bdaefbcc85d24fed7c5e8b38e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bcc751daa082ec875d4adc46f195ee7884d3a77facf8131b9e0a96e8e1c5652c57492ad8994204048ad818379ea5a1f655bc31dc2da90bb6997987ed02117e7c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4e76303ecdd6acf3239a3b7cbc61b578713798153d61dc21532395d14c34200c688788c4583ccca0485dee2a92827d765381eaee9753dda3cd6569bf0ee8264"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-24 03:15:20.879869) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 03:15:20.880196) ========= 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.knUqtxD9Wq/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.NhniYQq4TZ/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005164 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 03:15:20.929406) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-24 03:15:20.929721) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-24 03:15:20.930052) ========= ========= Total master_lag: 0.18 =========