builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0369 starttime: 1489767470.34 results: success (0) buildid: 20170317083720 builduid: f61c6aa3690c44eebc15de47965a8770 revision: 9837b1734807ea2a1e8e8d3bdf418a2c82082b0d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-17 09:17:50.335714) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-17 09:17:50.336171) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-17 09:17:50.336481) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-17 09:17:50.364318) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 09:17:50.364701) ========= 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.M9AP7yeZE0/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.lM095QDLcw/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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-03-17 09:17:50-- 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% 119M=0s 2017-03-17 09:17:50 (119 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122942 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 09:17:50.511387) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 09:17:50.511696) ========= 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.M9AP7yeZE0/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.lM095QDLcw/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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.040484 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 09:17:50.573752) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-17 09:17:50.574118) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9837b1734807ea2a1e8e8d3bdf418a2c82082b0d --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 9837b1734807ea2a1e8e8d3bdf418a2c82082b0d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.M9AP7yeZE0/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.lM095QDLcw/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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-03-17 09:17:50,682 truncating revision to first 12 chars 2017-03-17 09:17:50,682 Setting DEBUG logging. 2017-03-17 09:17:50,682 attempt 1/10 2017-03-17 09:17:50,682 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9837b1734807?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-17 09:17:51,533 unpacking tar archive at: mozilla-aurora-9837b1734807/testing/mozharness/ program finished with exit code 0 elapsedTime=1.116848 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-17 09:17:51.714977) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-17 09:17:51.715370) ========= script_repo_revision: 9837b1734807ea2a1e8e8d3bdf418a2c82082b0d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-17 09:17:51.715816) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-17 09:17:51.716119) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-17 09:17:51.736495) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-17 09:17:51.736968) ========= /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.M9AP7yeZE0/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.lM095QDLcw/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 09:17:51 INFO - MultiFileLogger online at 20170317 09:17:51 in /builds/slave/test 09:17:51 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 09:17:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:17:51 INFO - {'append_to_log': False, 09:17:51 INFO - 'base_work_dir': '/builds/slave/test', 09:17:51 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:17:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:17:51 INFO - 'branch': 'Mozilla-Aurora', 09:17:51 INFO - 'buildbot_json_path': 'buildprops.json', 09:17:51 INFO - 'config_files': ('talos/mac_config.py',), 09:17:51 INFO - 'default_actions': ('clobber', 09:17:51 INFO - 'read-buildbot-config', 09:17:51 INFO - 'download-and-extract', 09:17:51 INFO - 'populate-webroot', 09:17:51 INFO - 'create-virtualenv', 09:17:51 INFO - 'install', 09:17:51 INFO - 'run-tests'), 09:17:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:17:51 INFO - 'download_minidump_stackwalk': True, 09:17:51 INFO - 'download_symbols': 'ondemand', 09:17:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:17:51 INFO - 'tooltool.py': '/tools/tooltool.py', 09:17:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:17:51 INFO - '/tools/misc-python/virtualenv.py')}, 09:17:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:17:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:17:51 INFO - 'gecko_profile': False, 09:17:51 INFO - 'gecko_profile_interval': 0, 09:17:51 INFO - 'installer_path': 'installer.exe', 09:17:51 INFO - 'log_level': 'info', 09:17:51 INFO - 'log_name': 'talos', 09:17:51 INFO - 'log_to_console': True, 09:17:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:17:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:17:51 INFO - 'opt_config_files': (), 09:17:51 INFO - 'pip_index': False, 09:17:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:17:51 INFO - 'cmd': ('bash', 09:17:51 INFO - '-c', 09:17:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:17:51 INFO - 'enabled': True, 09:17:51 INFO - 'halt_on_failure': False, 09:17:51 INFO - 'name': 'check_screen_resolution'},), 09:17:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:17:51 INFO - 'cmd': ('bash', 09:17:51 INFO - '-c', 09:17:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:17:51 INFO - 'enabled': True, 09:17:51 INFO - 'halt_on_failure': False, 09:17:51 INFO - 'name': 'check_screen_resolution'},), 09:17:51 INFO - 'run_cmd_checks_enabled': True, 09:17:51 INFO - 'suite': 'dromaeojs', 09:17:51 INFO - 'system_bits': '32', 09:17:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:17:51 INFO - 'title': 't-yosemite-r7-0369', 09:17:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:17:51 INFO - 'use_talos_json': True, 09:17:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:17:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:17:51 INFO - 'work_dir': 'build'} 09:17:51 INFO - [mozharness: 2017-03-17 16:17:51.949438Z] Running clobber step. 09:17:51 INFO - Running pre-action listener: _resource_record_pre_action 09:17:51 INFO - Running main action method: clobber 09:17:51 INFO - rmtree: /builds/slave/test/build 09:17:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:17:54 INFO - Running post-action listener: _resource_record_post_action 09:17:54 INFO - [mozharness: 2017-03-17 16:17:54.368608Z] Finished clobber step (success) 09:17:54 INFO - [mozharness: 2017-03-17 16:17:54.368856Z] Running read-buildbot-config step. 09:17:54 INFO - Running pre-action listener: _resource_record_pre_action 09:17:54 INFO - Running main action method: read_buildbot_config 09:17:54 INFO - Using buildbot properties: 09:17:54 INFO - { 09:17:54 INFO - "project": "", 09:17:54 INFO - "product": "firefox", 09:17:54 INFO - "script_repo_revision": "production", 09:17:54 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 09:17:54 INFO - "repository": "", 09:17:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 09:17:54 INFO - "buildid": "20170317083720", 09:17:54 INFO - "pgo_build": "False", 09:17:54 INFO - "basedir": "/builds/slave/test", 09:17:54 INFO - "buildnumber": 8, 09:17:54 INFO - "slavename": "t-yosemite-r7-0369", 09:17:54 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 09:17:54 INFO - "platform": "yosemite_r7", 09:17:54 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:17:54 INFO - "branch": "mozilla-aurora", 09:17:54 INFO - "repo_path": "releases/mozilla-aurora", 09:17:54 INFO - "revision": "9837b1734807ea2a1e8e8d3bdf418a2c82082b0d", 09:17:54 INFO - "stage_platform": "macosx64", 09:17:54 INFO - "builduid": "f61c6aa3690c44eebc15de47965a8770", 09:17:54 INFO - "slavebuilddir": "test" 09:17:54 INFO - } 09:17:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/RtEcmaV6TjGzN2_t8uok4w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 09:17:54 INFO - Running post-action listener: _resource_record_post_action 09:17:54 INFO - [mozharness: 2017-03-17 16:17:54.374663Z] Finished read-buildbot-config step (success) 09:17:54 INFO - [mozharness: 2017-03-17 16:17:54.374821Z] Running download-and-extract step. 09:17:54 INFO - Running pre-action listener: _resource_record_pre_action 09:17:54 INFO - Running main action method: download_and_extract 09:17:54 INFO - mkdir: /builds/slave/test/build/tests 09:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:54 INFO - trying https://queue.taskcluster.net/v1/task/RtEcmaV6TjGzN2_t8uok4w/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 09:17:54 INFO - Downloading https://queue.taskcluster.net/v1/task/RtEcmaV6TjGzN2_t8uok4w/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 09:17:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RtEcmaV6TjGzN2_t8uok4w/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 09:17:55 INFO - Downloaded 1199 bytes. 09:17:55 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 09:17:55 INFO - Using the following test package requirements: 09:17:55 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 09:17:55 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:17:55 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 09:17:55 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:17:55 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 09:17:55 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:17:55 INFO - u'jsshell-mac.zip'], 09:17:55 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:17:55 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 09:17:55 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 09:17:55 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:17:55 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 09:17:55 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:17:55 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 09:17:55 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:17:55 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 09:17:55 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:17:55 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 09:17:55 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:17:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RtEcmaV6TjGzN2_t8uok4w/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 09:17:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RtEcmaV6TjGzN2_t8uok4w/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:17:55 INFO - Fetch https://queue.taskcluster.net/v1/task/RtEcmaV6TjGzN2_t8uok4w/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 09:17:57 INFO - Expected file size: 51784308 09:17:57 INFO - Obtained file size: 51784308 09:18:13 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:18:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RtEcmaV6TjGzN2_t8uok4w/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 09:18:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RtEcmaV6TjGzN2_t8uok4w/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:18:13 INFO - Fetch https://queue.taskcluster.net/v1/task/RtEcmaV6TjGzN2_t8uok4w/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 09:18:15 INFO - Expected file size: 51784308 09:18:15 INFO - Obtained file size: 51784308 09:18:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RtEcmaV6TjGzN2_t8uok4w/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 09:18:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RtEcmaV6TjGzN2_t8uok4w/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:18:30 INFO - Fetch https://queue.taskcluster.net/v1/task/RtEcmaV6TjGzN2_t8uok4w/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 09:18:31 INFO - Expected file size: 14404424 09:18:31 INFO - Obtained file size: 14404424 09:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:31 INFO - trying https://queue.taskcluster.net/v1/task/RtEcmaV6TjGzN2_t8uok4w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 09:18:31 INFO - Downloading https://queue.taskcluster.net/v1/task/RtEcmaV6TjGzN2_t8uok4w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 09:18:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RtEcmaV6TjGzN2_t8uok4w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 09:18:33 INFO - Downloaded 74618879 bytes. 09:18:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RtEcmaV6TjGzN2_t8uok4w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 09:18:33 INFO - mkdir: /builds/slave/test/properties 09:18:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:18:33 INFO - Writing to file /builds/slave/test/properties/build_url 09:18:33 INFO - Contents: 09:18:33 INFO - build_url:https://queue.taskcluster.net/v1/task/RtEcmaV6TjGzN2_t8uok4w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 09:18:34 INFO - Running post-action listener: _resource_record_post_action 09:18:34 INFO - Running post-action listener: set_extra_try_arguments 09:18:34 INFO - [mozharness: 2017-03-17 16:18:34.201283Z] Finished download-and-extract step (success) 09:18:34 INFO - [mozharness: 2017-03-17 16:18:34.201411Z] Running populate-webroot step. 09:18:34 INFO - Running pre-action listener: _resource_record_pre_action 09:18:34 INFO - Running main action method: populate_webroot 09:18:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:18:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:18:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:18:34 INFO - '--tppagecycles', 09:18:34 INFO - '7'], 09:18:34 INFO - 'tests': ['tsvgm']}}, 09:18:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:18:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:18:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:18:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:18:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:18:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:18:34 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:18:34 INFO - 'talos_options': ['--disable-e10s'], 09:18:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:18:34 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:18:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:18:34 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:18:34 INFO - 'talos_options': ['--disable-e10s'], 09:18:34 INFO - 'tests': ['damp', 'tps']}, 09:18:34 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:18:34 INFO - 'tests': ['damp', 'tps']}, 09:18:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:18:34 INFO - 'tests': ['dromaeo_dom']}, 09:18:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:18:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:18:34 INFO - 'tests': ['basic_compositor_video']}, 09:18:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:18:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:18:34 INFO - 'tests': ['a11yr', 09:18:34 INFO - 'ts_paint', 09:18:34 INFO - 'tpaint', 09:18:34 INFO - 'sessionrestore', 09:18:34 INFO - 'sessionrestore_no_auto_restore', 09:18:34 INFO - 'tabpaint']}, 09:18:34 INFO - 'other-e10s': {'tests': ['a11yr', 09:18:34 INFO - 'ts_paint', 09:18:34 INFO - 'tpaint', 09:18:34 INFO - 'sessionrestore', 09:18:34 INFO - 'sessionrestore_no_auto_restore', 09:18:34 INFO - 'tabpaint']}, 09:18:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:18:34 INFO - 'ts_paint', 09:18:34 INFO - 'tpaint', 09:18:34 INFO - 'sessionrestore', 09:18:34 INFO - 'sessionrestore_no_auto_restore', 09:18:34 INFO - 'tabpaint']}, 09:18:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:18:34 INFO - 'ts_paint', 09:18:34 INFO - 'tpaint', 09:18:34 INFO - 'sessionrestore', 09:18:34 INFO - 'sessionrestore_no_auto_restore', 09:18:34 INFO - 'tabpaint']}, 09:18:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:18:34 INFO - 'tests': ['a11yr', 09:18:34 INFO - 'ts_paint', 09:18:34 INFO - 'tpaint', 09:18:34 INFO - 'sessionrestore', 09:18:34 INFO - 'sessionrestore_no_auto_restore', 09:18:34 INFO - 'tabpaint']}, 09:18:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:18:34 INFO - 'tests': ['a11yr', 09:18:34 INFO - 'ts_paint', 09:18:34 INFO - 'tpaint', 09:18:34 INFO - 'sessionrestore', 09:18:34 INFO - 'sessionrestore_no_auto_restore', 09:18:34 INFO - 'tabpaint']}, 09:18:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:18:34 INFO - 'tests': ['tsvgx', 09:18:34 INFO - 'tsvgr_opacity', 09:18:34 INFO - 'tart', 09:18:34 INFO - 'tscrollx', 09:18:34 INFO - 'cart', 09:18:34 INFO - 'tsvg_static']}, 09:18:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:18:34 INFO - 'tsvgr_opacity', 09:18:34 INFO - 'tart', 09:18:34 INFO - 'tscrollx', 09:18:34 INFO - 'cart', 09:18:34 INFO - 'tsvg_static']}, 09:18:34 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:18:34 INFO - 'talos_options': ['--disable-e10s'], 09:18:34 INFO - 'tests': ['tp5o']}, 09:18:34 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:18:34 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:18:34 INFO - 'talos_options': ['--disable-e10s', 09:18:34 INFO - '--xperf_path', 09:18:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:18:34 INFO - 'tests': ['tp5n']}, 09:18:34 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:18:34 INFO - 'talos_options': ['--xperf_path', 09:18:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:18:34 INFO - 'tests': ['tp5n']}}, 09:18:34 INFO - 'talos.zip': {'path': '', 09:18:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:18:34 INFO - Running post-action listener: _resource_record_post_action 09:18:34 INFO - [mozharness: 2017-03-17 16:18:34.220018Z] Finished populate-webroot step (success) 09:18:34 INFO - [mozharness: 2017-03-17 16:18:34.220132Z] Running create-virtualenv step. 09:18:34 INFO - Running pre-action listener: _resource_record_pre_action 09:18:34 INFO - Running main action method: create_virtualenv 09:18:34 INFO - Creating virtualenv /builds/slave/test/build/venv 09:18:34 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 09:18:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:18:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:18:34 INFO - Using real prefix '/tools/python27' 09:18:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:18:35 INFO - Installing distribute.............................................................................................................................................................................................done. 09:18:37 INFO - Installing pip.................done. 09:18:37 INFO - Return code: 0 09:18:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:18:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:18:38 INFO - Reading from file tmpfile_stdout 09:18:38 INFO - Output received: 09:18:38 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) 09:18:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:18:38 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')]} 09:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:38 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')]} 09:18:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:38 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 0x10b54cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b54f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7f2d5a4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b32ad30>, '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 0x10b251db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b31fbe8>, '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.M9AP7yeZE0/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.lM095QDLcw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 09:18:38 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 09:18:38 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 09:18:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M9AP7yeZE0/Render', 09:18:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:38 INFO - 'HOME': '/Users/cltbld', 09:18:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:38 INFO - 'LOGNAME': 'cltbld', 09:18:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:38 INFO - 'MOZ_NO_REMOTE': '1', 09:18:38 INFO - 'NO_EM_RESTART': '1', 09:18:38 INFO - 'PAGER': '/bin/cat', 09:18:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:38 INFO - 'PWD': '/builds/slave/test', 09:18:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:38 INFO - 'SHELL': '/bin/bash', 09:18:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lM095QDLcw/Listeners', 09:18:38 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 09:18:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:38 INFO - 'USER': 'cltbld', 09:18:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:38 INFO - 'XPC_FLAGS': '0x0', 09:18:38 INFO - 'XPC_SERVICE_NAME': '0', 09:18:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:38 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 09:18:38 INFO - Cleaning up... 09:18:38 INFO - Return code: 0 09:18:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:18:38 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')]} 09:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:38 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')]} 09:18:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:38 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 0x10b54cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b54f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7f2d5a4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b32ad30>, '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 0x10b251db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b31fbe8>, '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.M9AP7yeZE0/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.lM095QDLcw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 09:18:38 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 09:18:38 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 09:18:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M9AP7yeZE0/Render', 09:18:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:38 INFO - 'HOME': '/Users/cltbld', 09:18:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:38 INFO - 'LOGNAME': 'cltbld', 09:18:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:38 INFO - 'MOZ_NO_REMOTE': '1', 09:18:38 INFO - 'NO_EM_RESTART': '1', 09:18:38 INFO - 'PAGER': '/bin/cat', 09:18:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:38 INFO - 'PWD': '/builds/slave/test', 09:18:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:38 INFO - 'SHELL': '/bin/bash', 09:18:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lM095QDLcw/Listeners', 09:18:38 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 09:18:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:38 INFO - 'USER': 'cltbld', 09:18:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:38 INFO - 'XPC_FLAGS': '0x0', 09:18:38 INFO - 'XPC_SERVICE_NAME': '0', 09:18:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:38 INFO - Downloading/unpacking psutil>=3.1.1 09:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:18:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:18:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:18:42 INFO - Installing collected packages: psutil 09:18:42 INFO - Running setup.py install for psutil 09:18:42 INFO - building 'psutil._psutil_osx' extension 09:18:42 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 09:18:42 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 09:18:42 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 09:18:42 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 09:18:43 INFO - building 'psutil._psutil_posix' extension 09:18:43 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 09:18:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:18:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:18:43 INFO - ^ 09:18:43 INFO - 1 warning generated. 09:18:43 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 09:18:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:18:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:18:43 INFO - Successfully installed psutil 09:18:43 INFO - Cleaning up... 09:18:43 INFO - Return code: 0 09:18:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b54cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b54f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7f2d5a4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b32ad30>, '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 0x10b251db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b31fbe8>, '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.M9AP7yeZE0/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.lM095QDLcw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 09:18:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:18:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:18:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M9AP7yeZE0/Render', 09:18:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:43 INFO - 'HOME': '/Users/cltbld', 09:18:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:43 INFO - 'LOGNAME': 'cltbld', 09:18:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:43 INFO - 'MOZ_NO_REMOTE': '1', 09:18:43 INFO - 'NO_EM_RESTART': '1', 09:18:43 INFO - 'PAGER': '/bin/cat', 09:18:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:43 INFO - 'PWD': '/builds/slave/test', 09:18:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:43 INFO - 'SHELL': '/bin/bash', 09:18:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lM095QDLcw/Listeners', 09:18:43 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 09:18:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:43 INFO - 'USER': 'cltbld', 09:18:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:43 INFO - 'XPC_FLAGS': '0x0', 09:18:43 INFO - 'XPC_SERVICE_NAME': '0', 09:18:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:18:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:18:46 INFO - Installing collected packages: mozsystemmonitor 09:18:46 INFO - Running setup.py install for mozsystemmonitor 09:18:46 INFO - Successfully installed mozsystemmonitor 09:18:46 INFO - Cleaning up... 09:18:46 INFO - Return code: 0 09:18:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:18: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')]} 09:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18: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')]} 09:18:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18: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', '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 0x10b54cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b54f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7f2d5a4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b32ad30>, '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 0x10b251db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b31fbe8>, '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.M9AP7yeZE0/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.lM095QDLcw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 09:18: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:18: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 jsonschema==2.5.1 09:18:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M9AP7yeZE0/Render', 09:18:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:47 INFO - 'HOME': '/Users/cltbld', 09:18:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:47 INFO - 'LOGNAME': 'cltbld', 09:18:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:47 INFO - 'MOZ_NO_REMOTE': '1', 09:18:47 INFO - 'NO_EM_RESTART': '1', 09:18:47 INFO - 'PAGER': '/bin/cat', 09:18:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:47 INFO - 'PWD': '/builds/slave/test', 09:18:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:47 INFO - 'SHELL': '/bin/bash', 09:18:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lM095QDLcw/Listeners', 09:18:47 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 09:18:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:47 INFO - 'USER': 'cltbld', 09:18:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:47 INFO - 'XPC_FLAGS': '0x0', 09:18:47 INFO - 'XPC_SERVICE_NAME': '0', 09:18:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:47 INFO - Downloading/unpacking jsonschema==2.5.1 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:18:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:18:50 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 09:18:50 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 09:18:50 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 09:18:50 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 09:18:50 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 09:18:50 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 09:18:51 INFO - Downloading functools32-3.2.3-2.tar.gz 09:18:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:18:51 INFO - warning: no files found matching '*.txt' 09:18:51 INFO - no previously-included directories found matching 'build' 09:18:51 INFO - no previously-included directories found matching 'dist' 09:18:51 INFO - no previously-included directories found matching '.git*' 09:18:51 INFO - Installing collected packages: jsonschema, functools32 09:18:51 INFO - Running setup.py install for functools32 09:18:51 INFO - warning: no files found matching '*.txt' 09:18:51 INFO - no previously-included directories found matching 'build' 09:18:51 INFO - no previously-included directories found matching 'dist' 09:18:51 INFO - no previously-included directories found matching '.git*' 09:18:51 INFO - Successfully installed jsonschema functools32 09:18:51 INFO - Cleaning up... 09:18:51 INFO - Return code: 0 09:18:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b54cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b54f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7f2d5a4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b32ad30>, '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 0x10b251db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b31fbe8>, '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.M9AP7yeZE0/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.lM095QDLcw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 09:18:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:18:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:18:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M9AP7yeZE0/Render', 09:18:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:51 INFO - 'HOME': '/Users/cltbld', 09:18:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:51 INFO - 'LOGNAME': 'cltbld', 09:18:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:51 INFO - 'MOZ_NO_REMOTE': '1', 09:18:51 INFO - 'NO_EM_RESTART': '1', 09:18:51 INFO - 'PAGER': '/bin/cat', 09:18:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:51 INFO - 'PWD': '/builds/slave/test', 09:18:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:51 INFO - 'SHELL': '/bin/bash', 09:18:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lM095QDLcw/Listeners', 09:18:51 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 09:18:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:51 INFO - 'USER': 'cltbld', 09:18:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:51 INFO - 'XPC_FLAGS': '0x0', 09:18:51 INFO - 'XPC_SERVICE_NAME': '0', 09:18:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:18:51 INFO - Cleaning up... 09:18:51 INFO - Return code: 0 09:18:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b54cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b54f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7f2d5a4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b32ad30>, '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 0x10b251db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b31fbe8>, '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.M9AP7yeZE0/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.lM095QDLcw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 09:18:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:18:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:18:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M9AP7yeZE0/Render', 09:18:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:51 INFO - 'HOME': '/Users/cltbld', 09:18:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:51 INFO - 'LOGNAME': 'cltbld', 09:18:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:51 INFO - 'MOZ_NO_REMOTE': '1', 09:18:51 INFO - 'NO_EM_RESTART': '1', 09:18:51 INFO - 'PAGER': '/bin/cat', 09:18:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:51 INFO - 'PWD': '/builds/slave/test', 09:18:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:51 INFO - 'SHELL': '/bin/bash', 09:18:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lM095QDLcw/Listeners', 09:18:51 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 09:18:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:51 INFO - 'USER': 'cltbld', 09:18:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:51 INFO - 'XPC_FLAGS': '0x0', 09:18:51 INFO - 'XPC_SERVICE_NAME': '0', 09:18:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:52 INFO - Downloading/unpacking blobuploader==1.2.4 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18:54 INFO - Downloading blobuploader-1.2.4.tar.gz 09:18:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:18:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:18:54 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 09:18:54 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 09:18:54 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 09:18:54 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 09:18:54 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 09:18:54 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 09:18:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:18:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18:55 INFO - Downloading docopt-0.6.1.tar.gz 09:18:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:18:56 INFO - Installing collected packages: blobuploader, requests, docopt 09:18:56 INFO - Running setup.py install for blobuploader 09:18:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:18:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:18:56 INFO - Running setup.py install for requests 09:18:56 INFO - Running setup.py install for docopt 09:18:56 INFO - Successfully installed blobuploader requests docopt 09:18:56 INFO - Cleaning up... 09:18:57 INFO - Return code: 0 09:18:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:57 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 0x10b54cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b54f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7f2d5a4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b32ad30>, '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 0x10b251db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b31fbe8>, '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.M9AP7yeZE0/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.lM095QDLcw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 09:18:57 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 09:18:57 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 09:18:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M9AP7yeZE0/Render', 09:18:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:57 INFO - 'HOME': '/Users/cltbld', 09:18:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:57 INFO - 'LOGNAME': 'cltbld', 09:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:57 INFO - 'MOZ_NO_REMOTE': '1', 09:18:57 INFO - 'NO_EM_RESTART': '1', 09:18:57 INFO - 'PAGER': '/bin/cat', 09:18:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:57 INFO - 'PWD': '/builds/slave/test', 09:18:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:57 INFO - 'SHELL': '/bin/bash', 09:18:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lM095QDLcw/Listeners', 09:18:57 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 09:18:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:57 INFO - 'USER': 'cltbld', 09:18:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:57 INFO - 'XPC_FLAGS': '0x0', 09:18:57 INFO - 'XPC_SERVICE_NAME': '0', 09:18:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:18:57 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-Ofvvuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:18:57 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-CSyPK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:18:57 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-tGpwhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:18:57 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-XZa05O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:18:57 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-qA9v15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:18:57 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-fY3alM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:18:57 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-lC_APg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:18:58 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-YGJNMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:18:58 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-VyllZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:18:58 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-1Im4hD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:18:58 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-Bx8s1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:18:58 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-Semi1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:18:58 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-I9bt1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:18:58 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-OMzuQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:58 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-EF4548-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:18:58 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-qhoabL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:18:58 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-I3nl51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:18:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:18:59 INFO - Running setup.py install for manifestparser 09:18:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:18:59 INFO - Running setup.py install for mozcrash 09:18:59 INFO - Running setup.py install for mozdebug 09:18:59 INFO - Running setup.py install for mozdevice 09:18:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:18:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:18:59 INFO - Running setup.py install for mozfile 09:18:59 INFO - Running setup.py install for mozhttpd 09:18:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:18:59 INFO - Running setup.py install for mozinfo 09:19:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:19:00 INFO - Running setup.py install for mozInstall 09:19:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:19:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:19:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:19:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:19:00 INFO - Running setup.py install for mozleak 09:19:00 INFO - Running setup.py install for mozlog 09:19:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:19:00 INFO - Running setup.py install for moznetwork 09:19:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:19:00 INFO - Running setup.py install for mozprocess 09:19:00 INFO - Running setup.py install for mozprofile 09:19:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:19:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:19:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:19:00 INFO - Running setup.py install for mozrunner 09:19:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:19:01 INFO - Running setup.py install for mozscreenshot 09:19:01 INFO - Running setup.py install for moztest 09:19:01 INFO - Running setup.py install for mozversion 09:19:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:19:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:19:01 INFO - Cleaning up... 09:19:01 INFO - Return code: 0 09:19:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:01 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')]} 09:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:01 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')]} 09:19:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:01 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 0x10b54cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b54f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7f2d5a4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b32ad30>, '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 0x10b251db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b31fbe8>, '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.M9AP7yeZE0/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.lM095QDLcw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 09:19:01 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 09:19:01 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 09:19:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M9AP7yeZE0/Render', 09:19:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:01 INFO - 'HOME': '/Users/cltbld', 09:19:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:01 INFO - 'LOGNAME': 'cltbld', 09:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:01 INFO - 'MOZ_NO_REMOTE': '1', 09:19:01 INFO - 'NO_EM_RESTART': '1', 09:19:01 INFO - 'PAGER': '/bin/cat', 09:19:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:01 INFO - 'PWD': '/builds/slave/test', 09:19:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:01 INFO - 'SHELL': '/bin/bash', 09:19:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lM095QDLcw/Listeners', 09:19:01 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 09:19:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:01 INFO - 'USER': 'cltbld', 09:19:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:01 INFO - 'XPC_FLAGS': '0x0', 09:19:01 INFO - 'XPC_SERVICE_NAME': '0', 09:19:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:19:01 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-ruydqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:19:02 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)) 09:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:19:02 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-Wx6qnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:19:02 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)) 09:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:19:02 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-Jt8LI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:19:02 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)) 09:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:19:02 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-m9_2bf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:19:02 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)) 09:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:19:02 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-h8xQoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:19:02 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)) 09:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:19:02 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-gf8_KE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:19:02 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)) 09:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:19:02 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-_298Xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:19:02 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)) 09:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:19:02 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-Xi6esB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:19:02 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)) 09:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:19:02 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-w2JjZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:19:02 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)) 09:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:19:02 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-O_ovPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:19:02 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)) 09:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:19:02 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-XNLN4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:19:03 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)) 09:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:19:03 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-8xtZa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:19:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 09:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:19:03 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-TsRGlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:19:03 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)) 09:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:19:03 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-lJ8tRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:19:03 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)) 09:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:03 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-iNNgx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:03 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)) 09:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:19:03 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-w7rPO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:19:03 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)) 09:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:19:03 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-j4V_is-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:19:03 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)) 09:19:03 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)) 09:19:03 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)) 09:19:03 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)) 09:19:03 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)) 09:19:03 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)) 09:19:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:19:03 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 09:19:03 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 09:19:03 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 09:19:03 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 09:19:03 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 09:19:03 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 09:19:06 INFO - Downloading blessings-1.6.tar.gz 09:19:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:19:06 INFO - Installing collected packages: blessings 09:19:06 INFO - Running setup.py install for blessings 09:19:06 INFO - Successfully installed blessings 09:19:06 INFO - Cleaning up... 09:19:06 INFO - Return code: 0 09:19:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:19:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:19:07 INFO - Reading from file tmpfile_stdout 09:19:07 INFO - Current package versions: 09:19:07 INFO - blessings == 1.6 09:19:07 INFO - blobuploader == 1.2.4 09:19:07 INFO - docopt == 0.6.1 09:19:07 INFO - functools32 == 3.2.3-2 09:19:07 INFO - jsonschema == 2.5.1 09:19:07 INFO - manifestparser == 1.1 09:19:07 INFO - mozInstall == 1.12 09:19:07 INFO - mozcrash == 1.0 09:19:07 INFO - mozdebug == 0.1 09:19:07 INFO - mozdevice == 0.49 09:19:07 INFO - mozfile == 1.2 09:19:07 INFO - mozhttpd == 0.7 09:19:07 INFO - mozinfo == 0.9 09:19:07 INFO - mozleak == 0.1 09:19:07 INFO - mozlog == 3.4 09:19:07 INFO - moznetwork == 0.27 09:19:07 INFO - mozprocess == 0.25 09:19:07 INFO - mozprofile == 0.28 09:19:07 INFO - mozrunner == 6.13 09:19:07 INFO - mozscreenshot == 0.1 09:19:07 INFO - mozsystemmonitor == 0.3 09:19:07 INFO - moztest == 0.8 09:19:07 INFO - mozversion == 1.4 09:19:07 INFO - psutil == 3.1.1 09:19:07 INFO - requests == 1.2.3 09:19:07 INFO - wsgiref == 0.1.2 09:19:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:07 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 0x10b54cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b54f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7f2d5a4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b32ad30>, '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 0x10b251db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b31fbe8>, '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.M9AP7yeZE0/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.lM095QDLcw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 09:19:07 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 09:19:07 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 09:19:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M9AP7yeZE0/Render', 09:19:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:07 INFO - 'HOME': '/Users/cltbld', 09:19:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:07 INFO - 'LOGNAME': 'cltbld', 09:19:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:07 INFO - 'MOZ_NO_REMOTE': '1', 09:19:07 INFO - 'NO_EM_RESTART': '1', 09:19:07 INFO - 'PAGER': '/bin/cat', 09:19:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:07 INFO - 'PWD': '/builds/slave/test', 09:19:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:07 INFO - 'SHELL': '/bin/bash', 09:19:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lM095QDLcw/Listeners', 09:19:07 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 09:19:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:07 INFO - 'USER': 'cltbld', 09:19:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:07 INFO - 'XPC_FLAGS': '0x0', 09:19:07 INFO - 'XPC_SERVICE_NAME': '0', 09:19:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:07 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)) 09:19:07 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)) 09:19:07 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)) 09:19:07 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)) 09:19:07 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)) 09:19:07 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)) 09:19:07 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)) 09:19:07 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)) 09:19:07 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)) 09:19:07 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)) 09:19:07 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)) 09:19:07 INFO - Cleaning up... 09:19:07 INFO - Return code: 0 09:19:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b54cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b54f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7f2d5a4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b32ad30>, '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 0x10b251db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b31fbe8>, '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.M9AP7yeZE0/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.lM095QDLcw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 09:19:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:19:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:19:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M9AP7yeZE0/Render', 09:19:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:07 INFO - 'HOME': '/Users/cltbld', 09:19:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:07 INFO - 'LOGNAME': 'cltbld', 09:19:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:07 INFO - 'MOZ_NO_REMOTE': '1', 09:19:07 INFO - 'NO_EM_RESTART': '1', 09:19:07 INFO - 'PAGER': '/bin/cat', 09:19:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:07 INFO - 'PWD': '/builds/slave/test', 09:19:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:07 INFO - 'SHELL': '/bin/bash', 09:19:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lM095QDLcw/Listeners', 09:19:07 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 09:19:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:07 INFO - 'USER': 'cltbld', 09:19:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:07 INFO - 'XPC_FLAGS': '0x0', 09:19:07 INFO - 'XPC_SERVICE_NAME': '0', 09:19:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:19:07 INFO - Cleaning up... 09:19:07 INFO - Return code: 0 09:19:07 INFO - Running post-action listener: _resource_record_post_action 09:19:07 INFO - Running post-action listener: _start_resource_monitoring 09:19:07 INFO - Starting resource monitoring. 09:19:07 INFO - [mozharness: 2017-03-17 16:19:07.606618Z] Finished create-virtualenv step (success) 09:19:07 INFO - [mozharness: 2017-03-17 16:19:07.607570Z] Running install step. 09:19:07 INFO - Running pre-action listener: _resource_record_pre_action 09:19:07 INFO - Running main action method: install 09:19:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:19:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:19:07 INFO - Reading from file tmpfile_stdout 09:19:07 INFO - Detecting whether we're running mozinstall >=1.0... 09:19:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:19:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:19:07 INFO - Reading from file tmpfile_stdout 09:19:07 INFO - Output received: 09:19:07 INFO - Usage: mozinstall [options] installer 09:19:07 INFO - Options: 09:19:07 INFO - -h, --help show this help message and exit 09:19:07 INFO - -d DEST, --destination=DEST 09:19:07 INFO - Directory to install application into. [default: 09:19:07 INFO - "/builds/slave/test"] 09:19:07 INFO - --app=APP Application being installed. [default: firefox] 09:19:07 INFO - mkdir: /builds/slave/test/build/application 09:19:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:19:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:19:28 INFO - Reading from file tmpfile_stdout 09:19:28 INFO - Output received: 09:19:28 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:19:28 INFO - Running post-action listener: _resource_record_post_action 09:19:28 INFO - [mozharness: 2017-03-17 16:19:28.746964Z] Finished install step (success) 09:19:28 INFO - [mozharness: 2017-03-17 16:19:28.747104Z] Running run-tests step. 09:19:28 INFO - Running pre-action listener: _resource_record_pre_action 09:19:28 INFO - Running main action method: run_tests 09:19:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:19:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:19:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:19:28 INFO - 2017-03-17 09:19:28.762 screenresolution[1630:7338] starting screenresolution argv=screenresolution get 09:19:28 INFO - 2017-03-17 09:19:28.764 screenresolution[1630:7338] Display 0: 1600x1200x32@60 09:19:28 INFO - 2017-03-17 09:19:28.770 screenresolution[1631:7341] starting screenresolution argv=screenresolution list 09:19:28 INFO - Available Modes on Display 0 09:19:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:19:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:19:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:19:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:19:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:19:28 INFO - Intel Iris: 09:19:28 INFO - Chipset Model: Intel Iris 09:19:28 INFO - Type: GPU 09:19:28 INFO - Bus: Built-In 09:19:28 INFO - VRAM (Dynamic, Max): 1536 MB 09:19:28 INFO - Vendor: Intel (0x8086) 09:19:28 INFO - Device ID: 0x0a2e 09:19:28 INFO - Revision ID: 0x0009 09:19:29 INFO - Displays: 09:19:29 INFO - Display: 09:19:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:19:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:19:29 INFO - Display Serial Number: 1600x1200 60 09:19:29 INFO - Main Display: Yes 09:19:29 INFO - Mirror: Off 09:19:29 INFO - Online: Yes 09:19:29 INFO - Rotation: Supported 09:19:29 INFO - Return code: 0 09:19:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:19:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:19:29 INFO - Python 2.7.3 09:19:29 INFO - Return code: 0 09:19:29 INFO - grabbing minidump binary from tooltool 09:19:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:29 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 0x10b32ad30>, '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 0x10b251db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b31fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:19:29 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 09:19:29 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 09:19:29 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 09:19:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:19:29 INFO - Return code: 0 09:19:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:19:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:19:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:19:29 INFO - ENV: RUST_BACKTRACE is now 1 09:19:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:19:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:19:29 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/RtEcmaV6TjGzN2_t8uok4w/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0369', '--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 09:19:29 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/RtEcmaV6TjGzN2_t8uok4w/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0369 --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 09:19:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.M9AP7yeZE0/Render', 09:19:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:29 INFO - 'HOME': '/Users/cltbld', 09:19:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:29 INFO - 'LOGNAME': 'cltbld', 09:19:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:19:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:19:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:29 INFO - 'MOZ_NO_REMOTE': '1', 09:19:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:19:29 INFO - 'NO_EM_RESTART': '1', 09:19:29 INFO - 'PAGER': '/bin/cat', 09:19:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:29 INFO - 'PWD': '/builds/slave/test', 09:19:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:19:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:29 INFO - 'RUST_BACKTRACE': '1', 09:19:29 INFO - 'SHELL': '/bin/bash', 09:19:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lM095QDLcw/Listeners', 09:19:29 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 09:19:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:29 INFO - 'USER': 'cltbld', 09:19:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:29 INFO - 'XPC_FLAGS': '0x0', 09:19:29 INFO - 'XPC_SERVICE_NAME': '0', 09:19:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:29 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/RtEcmaV6TjGzN2_t8uok4w/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0369', '--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 09:19:29 INFO - mozversion application_buildid: 20170317083720 09:19:29 INFO - mozversion application_changeset: 9837b1734807ea2a1e8e8d3bdf418a2c82082b0d 09:19:29 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:19:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:19:29 INFO - mozversion application_name: Firefox 09:19:29 INFO - mozversion application_remotingname: firefox-dev 09:19:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:19:29 INFO - mozversion application_vendor: Mozilla 09:19:29 INFO - mozversion application_version: 54.0a2 09:19:29 INFO - mozversion platform_buildid: 20170317083720 09:19:29 INFO - mozversion platform_changeset: 9837b1734807ea2a1e8e8d3bdf418a2c82082b0d 09:19:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:19:29 INFO - mozversion platform_version: 54.0a2 09:19:29 INFO - using testdate: 1489767569 09:19:29 INFO - actual date: 1489767569 09:19:29 INFO - starting webserver on 'localhost:49241' 09:19:29 INFO - SUITE-START | Running 2 tests 09:19:29 INFO - TEST-START | dromaeo_css 09:19:29 INFO - operating with platform_type : mac_ 09:19:29 INFO - Initialising browser for dromaeo_css test... 09:19:29 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/tmptKEKMA/profile http://localhost:49241/getInfo.html) 09:19:31 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 09:19:31 INFO - PROCESS | 1641 | colorDepth:24 09:19:31 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 09:19:31 INFO - PROCESS | 1641 | __metrics 09:19:31 INFO - PROCESS | 1641 | 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" 09:19:31 INFO - PROCESS | 1641 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:19:32 INFO - TEST-INFO | 1641: exit 0 09:19:32 INFO - Browser initialized. 09:19:32 INFO - Running cycle 1/1 for dromaeo_css test... 09:19:32 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/tmptKEKMA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:19:44 INFO - PROCESS | 1643 | RSS: Main: 214544384 09:19:44 INFO - PROCESS | 1643 | 09:22:48 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 09:22:51 INFO - PROCESS | 1643 | RSS: Main: 393637888 09:22:51 INFO - PROCESS | 1643 | 09:24:34 INFO - PROCESS | 1643 | ************************* 09:24:34 INFO - PROCESS | 1643 | A coding exception was thrown and uncaught in a Task. 09:24:34 INFO - PROCESS | 1643 | 09:24:34 ERROR - PROCESS | 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:24:34 INFO - PROCESS | 1643 | Full stack: 09:24:34 INFO - PROCESS | 1643 | ************************* 09:25:54 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 09:25:55 INFO - PROCESS | 1643 | RSS: Main: 353435648 09:25:55 INFO - PROCESS | 1643 | 09:28:57 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 09:28:58 INFO - PROCESS | 1643 | RSS: Main: 338870272 09:28:58 INFO - PROCESS | 1643 | 09:32:00 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 09:32:01 INFO - PROCESS | 1643 | RSS: Main: 329469952 09:32:01 INFO - PROCESS | 1643 | 09:35:05 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 09:35:06 INFO - PROCESS | 1643 | RSS: Main: 321806336 09:35:06 INFO - PROCESS | 1643 | 09:38:09 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 09:38:09 INFO - PROCESS | 1643 | RSS: Main: 409763840 09:38:09 INFO - PROCESS | 1643 | 09:38:09 INFO - PROCESS | 1643 | __start_tp_report 09:38:09 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 09:38:09 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 09:38:09 INFO - PROCESS | 1643 | |i|pagename|runs| 09:38:09 INFO - PROCESS | 1643 | |0;dojo.html;3213.8875139370125;3468.5317482139912;3472.513848061271;3472.895813125607;3522.925507720146;6011.1084567606285;6020.247469066367;6026.397360263972;6055.727492262848;6106.694665266736;5996.430339117787;6052.001419765734;6072.332043475214;6072.605280656765;6101.511879049676;5362.731863406824;5387.057264978633;5419.918701219485;5424.321959755031;5506.862328441801;5292.735363231823;5305.151175811871;5497.890042199154;5503.9174412383845;5549.861253468675;5306.893862122755;5360.088784906556;5371.409144994048;5378.596605254602;5387.218853266274;5364.329458817648;5375.3280839895015;5378.569714422876;5382.784688612471;5390.9191362129595;5243.68537887728;5320.201969704575;5335.759890804923;5338.62629615927;5366.8926621467745;5997.1304160896425;6000.75996960121;6002;6015.518758499309;6025.578209525335;6293.653849038301;6309.589876658002;6313.905291420632;6319.526035547352;6327.272363678144;5244.947550524484;6265.592736472115;6268.467180289681;6269.2476902771505;6271.780487682955;6084.847878803065;6094.299155597118;6095.359987201325;6103.054026625836;6129.601575897597;6481.93518064818;6533.314002029813;6548.541602087856;6562.540622156451;6565.507586930999;6123.526657168115;6167.691615419211;6206.844828879224;6282.748690052438;6288.685565721696;4806.4406470495705;6287.842803929847;6301.6219026858535;6313.305536390993;6313.589616674902;6212.844678882973;6246.937530624636;6313.147725057059;6313.179286692793;6315.052742088724;6281.466075383643;6293.811185664345;6304.716287767062;6307.747690092437;6310.968445157745;5080.7205603692155;5169.029552219534;5172.379314482287;5197;5215.973920130375;4474.485434175046;4496.775161241925;4533.365328853963;4554.88612784683;4568.6116680081905;6108.7670647404;6161;6161.507079433634;6165.167702360213;6168.722407491584;6209;6388.009858471944;6388.361163883667;6403.071554624554;6413.3266007069515;5958.463738263577;5965.791197308074;6086.178365920633;6112.847178820476;6144.095330447575;5677.971610141923;5684.772609095672;5684.8294551163535;5699.800506982236;5729.997250481149;6630.204375474974;6644.402003819776;6662.56693314933;6671.166104236971;6686.7993960181275;5319.414864364994;6151.046587778901;6166.1983942087245;6237.033259844731;6247.375262473716;6322.114903913363;6365.649889256136;6372.840678983062;6376.075469056868;6558.573692709959;6287.056941458635;6293.968530157503;6305.022721478178;6321.683915804283;6326.715297811517;6373.203349581302;6383.616982981036;6390.872182556416;6407.935920640734;6423.582467139621;5066.847994560169;6031.336552979256;6251.468625166912;6272.529560282906;6275.121482992294;6207.286162091417;6212.316645169119;6227.657478838707;6241.594296370903;6252.124702541557;6111.470193407285;6134.78528251509;6136.417040381157;6203.410675985774;6249.187605611241;6266.216722909637;6271.62370257786;6285.371462853678;6287.2140982377205;6292.056191571301;6271.122042913905;6285.905711414241;6290.24517057956;6291.339409361951;6309.936900630935 09:38:09 INFO - PROCESS | 1643 | |1;ext.html;641.3714559731463;760.8516339313834;764.6024067484908;765.1315756616242;765.7626135897868;29435.41129177415;40011.99970000752;40612;40790;40938.385924211085;41455;41793.373099403456;41799.37300940481;41816;41853.58146418535;7099.929000710004;8833.514156721361;9127.497987610679;9137.862932055992;9149.359544831865;7137.643117844113;7298.598577078258;7355.190928997806;7355.485116041879;7358.595277259748;10827.566897324097;11073.335599863995;11161.609343672973;11167.497462614201;11174.10607151426;10930.836037459445;11013;11013.559457621686;11029.227954043221;11054.944725276402;7177.636249112652;10637.946810265976;10707.518161682743;10723.785524289471;10747.51636176366;23622.76377236223;27858;28036.859815700995;37792.43311350332;38618.61381386178;3644.7084233261276;3736.5142531470733;3844.4233364995193;3885.3783394657003;3888.202918401721;25371.746282537122;25639.74360256392;26546.070887518843;27050.45899082027;27225.04712335059;2959.837208953507;3015.8682902140417;3129.4992801151934;3138.5135304027913;3221.2752130770623;324384;328572;352369.99999999744;352721;352982;45078;45318.54681453209;45401.54598454039;45436.86407839831;45497.545024549334;46693.29960050534;46705.29942050804;46730.76634616805;46735.831604210165;46741.83145421392;13339.866601333862;13706;13707.725845483234;13718.93140534291;13759.312034398241;11819.940900295443;11836.526538938519;11837.171398002229;11840.052795776317;11861.76276474483;11950.641480755592;11983.940080299542;12029.518819247307;12054.095942804324;12146.635600931986;5674.404187560247;5739.339975902742;5751.683657398799;5772.62477938941;5789.392113828072;919.7286800393766;976.6532880827347;1021.5607288865859;1184;1206.5897594817804;28831.42337153245;29575.85212073926;29645.407091858044;30150.396992060036;30229.244268893013;1039.656913218636;1052.8157572424795;1064.3722431521408;1079.578964203961;1084.902358787697;14787.11277323364;15366.308516116802;15424.228788560527;15558.377664893504;15695.450659226872;448111;449718;450182;451001;451129;58674.41325586775;58738.41261587415;58820;58937.5265618363;59220;1410.7460657081824;1466.8239811222722;1469.9118052916858;1472.2785834941017;1473.3517252408906;21523.892380537996;29608.851955740945;30788.384232315675;30907.536386953765;31752.841235793672;54875.45124548863;55259.17111243415;55293;55322.616934575344;55371;482482;485742;486426;486460;486840;32456.513152303207;32733;33004.17489562684;33114.66885331212;33151.67393304241;43646.030611785936;44375.11249775051;44641.857862339064;45415.77292113518;45478.317825231985;36221.913342599764;36625;36961.81519092387;37266;37393.626063739015;29243;35886.923392298275;35940.82029589835;37143.814280928425;37352.252954941294;35013.47479787754;36352.81823590865;36377.63622363848;36648.26703465969;37558.43662345122;29014.854925725238;29213.123606291847;31967;32263.838680807385;32348.35303293874;23979;24203.51592968166;24473.143439979514;24657.753422465546;24709.50580988406 09:38:09 INFO - PROCESS | 1643 | |2;jquery.html;339.99022901981107;403.79204709574554;419.79220285958445;430.80183115766744;443.8291257865721;12036.939815300922;21213;21382.144714211434;22195.33413997583;22440.102395904185;20644;21110.894445527752;22096.447588810286;22831.657525137136;23143.0742770289;6572.948328267478;6734.797956061326;6789.287124851893;6881.415079718205;6943.236244013155;6773.119494465713;6816.9318306816795;6832.282610325894;6842.692078856463;6857.588544687334;6873.381395674388;7069.399101076415;7363.26367363262;7530.246975302481;7561.546307221557;7242.420606351479;7354.632268386559;7395.926040739578;7454.366378857803;7471.55170689755;6969.16370035599;7254.673539690727;7258.274172582753;7259;7266.164391095039;20977.895110524503;25979.44123352605;26774.196774096807;26800.73199268002;27201.86399067992;2908.4037772256847;2926.385459053601;2938.397628486155;2945.2931296488687;2976.166673331449;15031.849681503154;16036.35854565816;16055.678886422324;16181.676366472604;16860.325586976505;1575.3777257983033;1996.241428257253;2020.1515363547346;2032.0855614973173;2041.7345745053196;165494;169900.15049924795;171893.14053429777;174429.38355924672;175252;13414.530491432948;16708.987303808808;18515.186051626675;20055.09752061161;20238.49403764888;27206;27848.74680639376;27861.16416507508;27868.16395508138;29360;8614.483131012159;9768.804623907625;10085.344452610558;10272.229582781321;10303.330283531546;5578.995780759502;5854;7356.852862942711;8578.957105214435;8761.25529330014;8324.792905028737;8557.229849313591;8615.956920215483;9134.543272836332;9493.740226885662;3329.450640644315;4015.641225660006;4028.8992775180855;4029.959700403017;4035.616616421435;986.8470387090013;991.1377101921374;993.3741742702196;1002.4837208837455;1042.6976176908763;21067.473313166985;21344.893275533523;21346.517231381586;21398.928320275645;21493;957.7701351675547;964.2286171063122;1004.7940172264668;1005.9346142500714;1006.6476733143342;10614.25700200994;10968.575974542498;10975.50610222542;11062.391568463812;11091.389973551532;710421;711175;729310;730664;748567;131328;155683;158969;159936.83332340137;161682;1229.330015141732;1239.3617287097152;1273.8089286606898;1278.9168704034207;1281.218456741387;17870.91064544669;18353.90823045876;18533.629327413644;18703.90648046751;18709.064546772333;63073;63287.36712632999;64000;64062.35937640564;64202.67898660477;91613.54193228991;91785.54107229688;92052.53973730089;92605.5369723147;94141;11440.542378304775;11453.198276120926;11571;11653.825192621947;11838.822417663914;12948.15836970594;12981.545645902726;13242.933785331012;13279.004074694243;13427;11343.20597558163;11390.031847293072;11449.084073274285;11494.94252528732;11679.591214307799;10896.78206435851;10995.395253261147;11001.064909482784;11309.71725706864;11439;9987.850182247126;10941.671749847517;10954.945225274141;11152.996230338984;11303.547858085585;10099;11508.36703981289;11671.183017188716;11682.415879206175;11867.940660296643;10690.327418145464;10944.835827462435;10954;10975.121990240601;11227.831582526433 09:38:09 INFO - PROCESS | 1643 | |3;mootools.html;1537.1161582090301;1550.852668996445;1580.84981926717;1582.5489735425406;1597.3291217688572;10432.16542676586;10658.307210031362;11007.119430445566;11014.449277536121;11045.28205666631;10948.233623646347;11137.387443690593;11159.553617855276;11164.776704465905;11171.329720216792;2377.4531857672746;2404.4710163763943;2406.614941609343;2407.6990376202975;2410.867402292873;2357.045396614374;2363.8699871507147;2394.1261439574605;2397.9520409591796;2407.3861165402886;2363.1728894886824;2378.5361854438393;2388.199953015742;2392.4018995251186;2392.6530653055297;2311.2257393773107;2332.7084114485688;2339.836211465198;2342.578335899546;2342.8008619267384;2311.295055008222;2332.97667023331;2359.398353419884;2360.3391050505884;2361.315218586608;10753.462326883702;10993.395363255018;10995.395253261067;10997.725056873562;11013.61452349172;5575.804846830341;5746.626469279484;5753.856153596152;5760.942390576082;5761.9135712964335;3319.286353433999;3400.370931377703;3445.982770086159;3466.77465964714;3483.407820670492;999.6401295533602;1150.4987481619792;1177.0524727594284;1177.3995262416229;1196.0312147160828;13474.19154850712;13777.793333100011;14079.436822527188;15094.018888772194;15140.621484462867;4137.731047481904;4247.23549761046;4249.2988656871885;4263;4449.132419178294;11450.54197832094;11461.541538338373;11476.655700329004;11477.54089836414;11491.310521368578;5658.434156584309;5661.377248502661;5664.122061080539;5666.801661941812;5672.064109421982;4937.728424936663;5135.820246291362;5195.2986346843445;5202.115640341151;5209.426963034063;3293.7035666789625;3672.7979961102396;3777.2823163598828;3813.542374915028;3873.922521549553;854.9871751923727;996.9351992120489;1006.7785087280787;1010.4190090697878;1017.4658304390107;894.5393122541897;923.3305853256336;925.9490728010024;926.8192702422963;956.4452617481983;5777.8555536111935;6248.562600618004;6441.32366101562;6451.9354806452275;6512.5441219115155;884.8407286688458;967.5452537307455;984.5618699678574;1014.6043043213152;1026.707388394319;3921.274564205574;3973.5827738087664;3986.621270979252;4136.669066474675;4142.958570414257;13151.145175563557;13653.180809151483;13659.385327660279;13680.863191368158;13687;13168.683131686754;13341.66645833862;13518;13523.256220907748;13524.323783810967;8477.194666506672;10112.393256404639;10213.897861021444;10214;10215.846762298572;6184.5052395809125;6227.96886015567;6285.528585356025;6287.622742635456;6388.68056597159;11337.206395552563;11418.771624567627;11648.534058637559;11653.825192621947;11667.241629294069;11017.338959662446;11081;11516.193866429605;11791.587294444653;12011.699707507381;8137;8296.004479462503;8302.003759548892;8305.916940830515;8309.875351869607;8826;10125.392476451141;10132.088112069654;10191.08280254751;10211.387316761018;8108.432409731498;8771.254443372385;8968;9037.728868133967;9074.818503629758;7575.772726818204;8729.869051964099;8772.210501054935;8825;8843.602037908438;7574.697012119454;7728.879312499544;7735.806604834924;7737.342325902361;7760.146383897654;5494.36814766291;5565.582581306499;5577.0797818359515;5635.464630860061;5716.54267658578;5711.200431939449;5723;5739.483446489836;5816.47651711348;5847.5906686533235 09:38:09 INFO - PROCESS | 1643 | |4;prototype.html;327.39758843727543;332.52525051397055;366.86242659002875;376.8341929550996;378.4682521057913;5280;5286.656367336125;5315.671082229443;5345.732713364326;5362.35651721793;4459.799309031093;4870.587529616407;5151.871203219921;5169.043726910524;5191.4548972357925;3488.9127771805656;4167.312393455076;4277;4317.805698743564;4351.6518678505645;3600.8739694110714;4075.205334959684;4261.275583150872;4280.871573852789;4314.654827613784;3596.777095787432;3744.307303148926;4007.9158837404534;4338.089001309729;4338.414314067592;3845.3847384418636;3889.9027524311837;3986.6013398660193;4237.4491316129015;4365.890852728691;3466.497357883118;3496.73774466916;3644;3706.4069748840056;3942.526896772377;4340.435743353344;4823.237874457928;5064.670796398223;5123.308353372285;5136.972605478882;4613.377194078824;4813.614910807127;4962.950370496285;4993.176125939216;5005.399352077738;4574.5425457453985;5050.595952323805;5248.947510524884;5494.917576236359;5623.26897503326;4023.6177563131455;4064.0289459612063;4401.735895846259;4424.823007079713;4478.305862591304;5201;5629.691826351176;5673.347565030033;6004.309504407005;6032.742319147655;3632.727545434103;3880.9223815523533;4013.518377794683;4461.442319710036;4481.036577135931;4623.6016527852;4652.394923751301;4668.649851261169;4670.813167473331;4674.36397260956;4355.259605867011;4658.557437043475;4909.901801963941;4935.777889994959;5005.849824505271;4915.107683541791;5368.785248590013;5480.698561579152;5586.581006424534;5607.990561698852;1358.2665360705307;1443.588577255477;1486.31629450454;1584.635533827203;1602.278974461497;1102.443266150589;1167.7197472606683;1178.4637989714658;1191.7724743514195;1206.9094817888692;4878.975605121952;4896.436909755424;4924.926126108111;5175;5265.157194981725;5313.57491400687;5550.833474995757;5642.858928526737;5801.970990145107;5834.066549352084;4541.750203738826;4828.420589529279;4837.32277481153;5119.0273847968765;5239.816606418757;2538.8984440622166;2826.816256943292;2880.3519208178413;2982.925426864302;2987.908464075156;5572.0527510323345;5707.571932105108;5806.680632565165;5838;5974.820755377345;4677.579017888406;4974.328465657162;5683.914741278884;5969.552283578749;5997.790077347272;5415.025295446779;5802.47777700009;5804.593678442553;6013.616868120269;6061.727222275008;5221.997351522814;5229.555487783581;5764.769409223584;5784.681842498703;5793.653570304034;5555.388907220122;5621.634593751393;5712.429406767054;5716.399778023414;5752;5820.30156381237;5904.789518148855;6020.39796020412;6034.1036302575885;6042.407770094672;3925.7819332077283;4059.4316795649224;4119.752814831119;4313.352997050468;4570.565796249351;5514.283143191359;5679.630823996427;5795.927753365472;5797.782465682254;5803.47768700819;5482.314710661168;5635.633683810539;5645.915311270416;5679;5723.7996670116345;4938.407391113089;5308.5494428621705;5585.441455854382;5674.574406919415;5692.715364231854;4523.562092809554;4585.587297143273;5537.584681148849;5576.5817563683695;5636.915446268391;5107.744612769421;5221.765020574007;5619.887602247851;5627.8354018027185;5713.314402271754;4803.759812009315;4847.030593881308;4913.135995364635;5077.060743762416;5281.920771188358 09:38:09 INFO - PROCESS | 1643 | |5;yui.html;598.7814447726576;755.8866170074491;767.8541077195332;828.6354004238136;839.3872473094641;14973.176475293854;15441.305141268642;15824.841751582466;16044.83955160448;16156.111413872231;13542.864571354283;13557.664481234218;13609.38757755901;13648.454061837514;13664.726705465884;917.3807679816131;931.6506310133666;947.369998950697;948.5446985446989;950.4629884115452;929.2844509727506;951.6336210558916;953.8521529162991;953.909378609031;957.760559860035;983.1053741095604;989.5052473763119;990.8018396320729;992.3351354592404;993.1855878179896;985.4727720669407;987.4371608183338;987.5407935310079;988.4711679251566;991.6231831903866;712.0849708125035;731.6012773038653;732.5568031341069;733.1788396995346;733.8092096055011;13112.672183195402;15718.135502547355;15803.893727439085;15948.601284967852;16115.435959741353;13958.720825583432;14124.85875141256;14208.360623771956;14247.857521424758;14251.50359212278;10254.384736915808;11553.19127661064;11650.242734222249;11731.332902777036;12203.511859525608;3021.9546706799415;3603.279344131184;3614.4216925291826;3731.8693845715543;3828.846846126152;92986.07013929842;93114.60328095085;94309.58535621903;96565.51717241439;98239;10050.899491005142;10308.123809476128;10555.366677999345;10766.084882784895;11021.228514003942;20571.4857128573;20752.792472075387;20794.376168714964;20817.895910520652;20838.791612083987;7478.2895624915545;7482.700691972369;7577.621118944141;7627.046619172604;7627.821097616018;4195.748255104703;4235.089455767024;4305.634021108241;4394.626456751148;4409.603135717801;3459.2562599041325;3533.840977156034;3560.679538841465;3561.3767590672046;3565.322588708137;586.3901542395946;599.1192946368831;604.3865476541314;605.4248463959257;623.8908191066636;658.2134349452455;682.3006418421159;696.8153439338579;698.937095661393;707.5895980331395;8961.59672814725;9894.406335619886;10271.794564108675;10276.537555810006;10324.535395907202;553;696.7839969609437;705.1326867952447;710.765447402356;736.8710475666737;4954.405471343462;4973.90052198954;4976.651634385558;4986.202207646759;4990.575801056951;84458;85694.28961352476;103916.48041759743;106770.46614767032;108376.56042297595;91825.081749183;94056.52971735234;94086;95705;96379;80803.59598201972;82262.58868705737;83989;84394;84422.73365899516;9556.808863822824;9620.567074481805;9634;9638;9653.420794752337;50623;50693.718782654134;50979.49020509747;51621.96756064783;53213.4678653224;50574;63037;63611.363886360545;63777.681111594145;66165.66917165575;12356.25862448256;12764.808527872276;13023.609291721263;13030.41363138642;13066.80399794023;13984.650383740487;14392.568222953329;14503.637409064857;14526.709465810836;14875.107493550422;13817.309134543031;14061.718765624426;14261.001729878808;14286.285685715466;14316.355763990854;13353.465861365437;13744.725105497633;14303.927205459424;14628.561143165722;14876.479323223635;13140.474381025035;13317.267550284827;13548.983826212876;13657.931710341385;14006.369713363127;11053;11089.667309980714;11373.539314715916;11511.827322590336;11762;9558.522073896416;9684.176844968257;9735.9026409735;9761.707148785548;9856.704298871045 09:38:09 INFO - PROCESS | 1643 | __end_tp_report 09:38:09 INFO - PROCESS | 1643 | __start_cc_report 09:38:09 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,2820 09:38:09 INFO - PROCESS | 1643 | __end_cc_report 09:38:09 INFO - PROCESS | 1643 | __startTimestamp1489768689721__endTimestamp 09:38:09 INFO - PROCESS | 1643 | 09:38:09 INFO - PROCESS | 1643 | ------- Summary: start ------- 09:38:09 INFO - PROCESS | 1643 | Number of tests: 6 09:38:09 INFO - PROCESS | 1643 | 09:38:09 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:5907.63 Median:6161.51 stddev:653.33 (10.6%) stddev-sans-first:620.22 09:38:09 INFO - PROCESS | 1643 | Values: 3213.9 3468.5 3472.5 3472.9 3522.9 6011.1 6020.2 6026.4 6055.7 6106.7 5996.4 6052.0 6072.3 6072.6 6101.5 5362.7 5387.1 5419.9 5424.3 5506.9 5292.7 5305.2 5497.9 5503.9 5549.9 5306.9 5360.1 5371.4 5378.6 5387.2 5364.3 5375.3 5378.6 5382.8 5390.9 5243.7 5320.2 5335.8 5338.6 5366.9 5997.1 6000.8 6002.0 6015.5 6025.6 6293.7 6309.6 6313.9 6319.5 6327.3 5244.9 6265.6 6268.5 6269.2 6271.8 6084.8 6094.3 6095.4 6103.1 6129.6 6481.9 6533.3 6548.5 6562.5 6565.5 6123.5 6167.7 6206.8 6282.7 6288.7 4806.4 6287.8 6301.6 6313.3 6313.6 6212.8 6246.9 6313.1 6313.2 6315.1 6281.5 6293.8 6304.7 6307.7 6311.0 5080.7 5169.0 5172.4 5197.0 5216.0 4474.5 4496.8 4533.4 4554.9 4568.6 6108.8 6161.0 6161.5 6165.2 6168.7 6209.0 6388.0 6388.4 6403.1 6413.3 5958.5 5965.8 6086.2 6112.8 6144.1 5678.0 5684.8 5684.8 5699.8 5730.0 6630.2 6644.4 6662.6 6671.2 6686.8 5319.4 6151.0 6166.2 6237.0 6247.4 6322.1 6365.6 6372.8 6376.1 6558.6 6287.1 6294.0 6305.0 6321.7 6326.7 6373.2 6383.6 6390.9 6407.9 6423.6 5066.8 6031.3 6251.5 6272.5 6275.1 6207.3 6212.3 6227.7 6241.6 6252.1 6111.5 6134.8 6136.4 6203.4 6249.2 6266.2 6271.6 6285.4 6287.2 6292.1 6271.1 6285.9 6290.2 6291.3 6309.9 09:38:09 INFO - PROCESS | 1643 | 09:38:09 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:56653.41 Median:352545.50 stddev:114248.59 (32.4%) stddev-sans-first:114491.68 09:38:09 INFO - PROCESS | 1643 | Values: 641.4 760.9 764.6 765.1 765.8 29435.4 40012.0 40612.0 40790.0 40938.4 41455.0 41793.4 41799.4 41816.0 41853.6 7099.9 8833.5 9127.5 9137.9 9149.4 7137.6 7298.6 7355.2 7355.5 7358.6 10827.6 11073.3 11161.6 11167.5 11174.1 10930.8 11013.0 11013.6 11029.2 11054.9 7177.6 10637.9 10707.5 10723.8 10747.5 23622.8 27858.0 28036.9 37792.4 38618.6 3644.7 3736.5 3844.4 3885.4 3888.2 25371.7 25639.7 26546.1 27050.5 27225.0 2959.8 3015.9 3129.5 3138.5 3221.3 324384.0 328572.0 352370.0 352721.0 352982.0 45078.0 45318.5 45401.5 45436.9 45497.5 46693.3 46705.3 46730.8 46735.8 46741.8 13339.9 13706.0 13707.7 13718.9 13759.3 11819.9 11836.5 11837.2 11840.1 11861.8 11950.6 11983.9 12029.5 12054.1 12146.6 5674.4 5739.3 5751.7 5772.6 5789.4 919.7 976.7 1021.6 1184.0 1206.6 28831.4 29575.9 29645.4 30150.4 30229.2 1039.7 1052.8 1064.4 1079.6 1084.9 14787.1 15366.3 15424.2 15558.4 15695.5 448111.0 449718.0 450182.0 451001.0 451129.0 58674.4 58738.4 58820.0 58937.5 59220.0 1410.7 1466.8 1469.9 1472.3 1473.4 21523.9 29608.9 30788.4 30907.5 31752.8 54875.5 55259.2 55293.0 55322.6 55371.0 482482.0 485742.0 486426.0 486460.0 486840.0 32456.5 32733.0 33004.2 33114.7 33151.7 43646.0 44375.1 44641.9 45415.8 45478.3 36221.9 36625.0 36961.8 37266.0 37393.6 29243.0 35886.9 35940.8 37143.8 37352.3 35013.5 36352.8 36377.6 36648.3 37558.4 29014.9 29213.1 31967.0 32263.8 32348.4 23979.0 24203.5 24473.1 24657.8 24709.5 09:38:09 INFO - PROCESS | 1643 | 09:38:09 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:42814.97 Median:21390.54 stddev:121936.23 (570.0%) stddev-sans-first:122236.58 09:38:09 INFO - PROCESS | 1643 | Values: 340.0 403.8 419.8 430.8 443.8 12036.9 21213.0 21382.1 22195.3 22440.1 20644.0 21110.9 22096.4 22831.7 23143.1 6572.9 6734.8 6789.3 6881.4 6943.2 6773.1 6816.9 6832.3 6842.7 6857.6 6873.4 7069.4 7363.3 7530.2 7561.5 7242.4 7354.6 7395.9 7454.4 7471.6 6969.2 7254.7 7258.3 7259.0 7266.2 20977.9 25979.4 26774.2 26800.7 27201.9 2908.4 2926.4 2938.4 2945.3 2976.2 15031.8 16036.4 16055.7 16181.7 16860.3 1575.4 1996.2 2020.2 2032.1 2041.7 165494.0 169900.2 171893.1 174429.4 175252.0 13414.5 16709.0 18515.2 20055.1 20238.5 27206.0 27848.7 27861.2 27868.2 29360.0 8614.5 9768.8 10085.3 10272.2 10303.3 5579.0 5854.0 7356.9 8579.0 8761.3 8324.8 8557.2 8616.0 9134.5 9493.7 3329.5 4015.6 4028.9 4030.0 4035.6 986.8 991.1 993.4 1002.5 1042.7 21067.5 21344.9 21346.5 21398.9 21493.0 957.8 964.2 1004.8 1005.9 1006.6 10614.3 10968.6 10975.5 11062.4 11091.4 710421.0 711175.0 729310.0 730664.0 748567.0 131328.0 155683.0 158969.0 159936.8 161682.0 1229.3 1239.4 1273.8 1278.9 1281.2 17870.9 18353.9 18533.6 18703.9 18709.1 63073.0 63287.4 64000.0 64062.4 64202.7 91613.5 91785.5 92052.5 92605.5 94141.0 11440.5 11453.2 11571.0 11653.8 11838.8 12948.2 12981.5 13242.9 13279.0 13427.0 11343.2 11390.0 11449.1 11494.9 11679.6 10896.8 10995.4 11001.1 11309.7 11439.0 9987.9 10941.7 10954.9 11153.0 11303.5 10099.0 11508.4 11671.2 11682.4 11867.9 10690.3 10944.8 10954.0 10975.1 11227.8 09:38:09 INFO - PROCESS | 1643 | 09:38:09 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:6529.16 Median:2409.28 stddev:4080.32 (169.4%) stddev-sans-first:4074.52 09:38:09 INFO - PROCESS | 1643 | Values: 1537.1 1550.9 1580.8 1582.5 1597.3 10432.2 10658.3 11007.1 11014.4 11045.3 10948.2 11137.4 11159.6 11164.8 11171.3 2377.5 2404.5 2406.6 2407.7 2410.9 2357.0 2363.9 2394.1 2398.0 2407.4 2363.2 2378.5 2388.2 2392.4 2392.7 2311.2 2332.7 2339.8 2342.6 2342.8 2311.3 2333.0 2359.4 2360.3 2361.3 10753.5 10993.4 10995.4 10997.7 11013.6 5575.8 5746.6 5753.9 5760.9 5761.9 3319.3 3400.4 3446.0 3466.8 3483.4 999.6 1150.5 1177.1 1177.4 1196.0 13474.2 13777.8 14079.4 15094.0 15140.6 4137.7 4247.2 4249.3 4263.0 4449.1 11450.5 11461.5 11476.7 11477.5 11491.3 5658.4 5661.4 5664.1 5666.8 5672.1 4937.7 5135.8 5195.3 5202.1 5209.4 3293.7 3672.8 3777.3 3813.5 3873.9 855.0 996.9 1006.8 1010.4 1017.5 894.5 923.3 925.9 926.8 956.4 5777.9 6248.6 6441.3 6451.9 6512.5 884.8 967.5 984.6 1014.6 1026.7 3921.3 3973.6 3986.6 4136.7 4143.0 13151.1 13653.2 13659.4 13680.9 13687.0 13168.7 13341.7 13518.0 13523.3 13524.3 8477.2 10112.4 10213.9 10214.0 10215.8 6184.5 6228.0 6285.5 6287.6 6388.7 11337.2 11418.8 11648.5 11653.8 11667.2 11017.3 11081.0 11516.2 11791.6 12011.7 8137.0 8296.0 8302.0 8305.9 8309.9 8826.0 10125.4 10132.1 10191.1 10211.4 8108.4 8771.3 8968.0 9037.7 9074.8 7575.8 8729.9 8772.2 8825.0 8843.6 7574.7 7728.9 7735.8 7737.3 7760.1 5494.4 5565.6 5577.1 5635.5 5716.5 5711.2 5723.0 5739.5 5816.5 5847.6 09:38:09 INFO - PROCESS | 1643 | 09:38:09 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4622.38 Median:4968.64 stddev:1330.09 (26.8%) stddev-sans-first:1294.16 09:38:09 INFO - PROCESS | 1643 | Values: 327.4 332.5 366.9 376.8 378.5 5280.0 5286.7 5315.7 5345.7 5362.4 4459.8 4870.6 5151.9 5169.0 5191.5 3488.9 4167.3 4277.0 4317.8 4351.7 3600.9 4075.2 4261.3 4280.9 4314.7 3596.8 3744.3 4007.9 4338.1 4338.4 3845.4 3889.9 3986.6 4237.4 4365.9 3466.5 3496.7 3644.0 3706.4 3942.5 4340.4 4823.2 5064.7 5123.3 5137.0 4613.4 4813.6 4963.0 4993.2 5005.4 4574.5 5050.6 5248.9 5494.9 5623.3 4023.6 4064.0 4401.7 4424.8 4478.3 5201.0 5629.7 5673.3 6004.3 6032.7 3632.7 3880.9 4013.5 4461.4 4481.0 4623.6 4652.4 4668.6 4670.8 4674.4 4355.3 4658.6 4909.9 4935.8 5005.8 4915.1 5368.8 5480.7 5586.6 5608.0 1358.3 1443.6 1486.3 1584.6 1602.3 1102.4 1167.7 1178.5 1191.8 1206.9 4879.0 4896.4 4924.9 5175.0 5265.2 5313.6 5550.8 5642.9 5802.0 5834.1 4541.8 4828.4 4837.3 5119.0 5239.8 2538.9 2826.8 2880.4 2982.9 2987.9 5572.1 5707.6 5806.7 5838.0 5974.8 4677.6 4974.3 5683.9 5969.6 5997.8 5415.0 5802.5 5804.6 6013.6 6061.7 5222.0 5229.6 5764.8 5784.7 5793.7 5555.4 5621.6 5712.4 5716.4 5752.0 5820.3 5904.8 6020.4 6034.1 6042.4 3925.8 4059.4 4119.8 4313.4 4570.6 5514.3 5679.6 5795.9 5797.8 5803.5 5482.3 5635.6 5645.9 5679.0 5723.8 4938.4 5308.5 5585.4 5674.6 5692.7 4523.6 4585.6 5537.6 5576.6 5636.9 5107.7 5221.8 5619.9 5627.8 5713.3 4803.8 4847.0 4913.1 5077.1 5281.9 09:38:09 INFO - PROCESS | 1643 | 09:38:09 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:20165.92 Median:27782.29 stddev:28665.17 (103.2%) stddev-sans-first:28707.93 09:38:09 INFO - PROCESS | 1643 | Values: 598.8 755.9 767.9 828.6 839.4 14973.2 15441.3 15824.8 16044.8 16156.1 13542.9 13557.7 13609.4 13648.5 13664.7 917.4 931.7 947.4 948.5 950.5 929.3 951.6 953.9 953.9 957.8 983.1 989.5 990.8 992.3 993.2 985.5 987.4 987.5 988.5 991.6 712.1 731.6 732.6 733.2 733.8 13112.7 15718.1 15803.9 15948.6 16115.4 13958.7 14124.9 14208.4 14247.9 14251.5 10254.4 11553.2 11650.2 11731.3 12203.5 3022.0 3603.3 3614.4 3731.9 3828.8 92986.1 93114.6 94309.6 96565.5 98239.0 10050.9 10308.1 10555.4 10766.1 11021.2 20571.5 20752.8 20794.4 20817.9 20838.8 7478.3 7482.7 7577.6 7627.0 7627.8 4195.7 4235.1 4305.6 4394.6 4409.6 3459.3 3533.8 3560.7 3561.4 3565.3 586.4 599.1 604.4 605.4 623.9 658.2 682.3 696.8 698.9 707.6 8961.6 9894.4 10271.8 10276.5 10324.5 553.0 696.8 705.1 710.8 736.9 4954.4 4973.9 4976.7 4986.2 4990.6 84458.0 85694.3 103916.5 106770.5 108376.6 91825.1 94056.5 94086.0 95705.0 96379.0 80803.6 82262.6 83989.0 84394.0 84422.7 9556.8 9620.6 9634.0 9638.0 9653.4 50623.0 50693.7 50979.5 51622.0 53213.5 50574.0 63037.0 63611.4 63777.7 66165.7 12356.3 12764.8 13023.6 13030.4 13066.8 13984.7 14392.6 14503.6 14526.7 14875.1 13817.3 14061.7 14261.0 14286.3 14316.4 13353.5 13744.7 14303.9 14628.6 14876.5 13140.5 13317.3 13549.0 13657.9 14006.4 11053.0 11089.7 11373.5 11511.8 11762.0 9558.5 9684.2 9735.9 9761.7 9856.7 09:38:09 INFO - PROCESS | 1643 | -------- Summary: end -------- 09:38:09 INFO - PROCESS | 1643 | 09:38:10 INFO - TEST-INFO | 1643: exit 0 09:38:10 INFO - TEST-OK | dromaeo_css | took 1121037ms 09:38:10 INFO - TEST-START | kraken 09:38:10 INFO - operating with platform_type : mac_ 09:38:10 INFO - Initialising browser for kraken test... 09:38:10 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/tmpe34MiF/profile http://localhost:49241/getInfo.html) 09:38:12 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 09:38:12 INFO - PROCESS | 1653 | colorDepth:24 09:38:12 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 09:38:12 INFO - PROCESS | 1653 | __metrics 09:38:12 INFO - PROCESS | 1653 | 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" 09:38:12 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:38:13 INFO - TEST-INFO | 1653: exit 0 09:38:13 INFO - Browser initialized. 09:38:13 INFO - Running cycle 1/1 for kraken test... 09:38:13 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/tmpe34MiF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:38:25 INFO - PROCESS | 1654 | RSS: Main: 215691264 09:38:25 INFO - PROCESS | 1654 | 09:38:28 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 09:38:29 INFO - PROCESS | 1654 | RSS: Main: 267833344 09:38:29 INFO - PROCESS | 1654 | 09:38:32 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 09:38:32 INFO - PROCESS | 1654 | RSS: Main: 278736896 09:38:32 INFO - PROCESS | 1654 | 09:38:35 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 09:38:36 INFO - PROCESS | 1654 | RSS: Main: 377569280 09:38:36 INFO - PROCESS | 1654 | 09:38:38 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 09:38:39 INFO - PROCESS | 1654 | RSS: Main: 277778432 09:38:39 INFO - PROCESS | 1654 | 09:38:41 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:38:41 INFO - PROCESS | 1654 | RSS: Main: 280547328 09:38:41 INFO - PROCESS | 1654 | 09:38:44 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 09:38:45 INFO - PROCESS | 1654 | RSS: Main: 321036288 09:38:45 INFO - PROCESS | 1654 | 09:38:48 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 09:38:48 INFO - PROCESS | 1654 | RSS: Main: 321589248 09:38:48 INFO - PROCESS | 1654 | 09:38:51 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 09:38:52 INFO - PROCESS | 1654 | RSS: Main: 319123456 09:38:52 INFO - PROCESS | 1654 | 09:38:54 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:38:54 INFO - PROCESS | 1654 | RSS: Main: 296292352 09:38:54 INFO - PROCESS | 1654 | 09:38:56 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:38:57 INFO - PROCESS | 1654 | RSS: Main: 298610688 09:38:57 INFO - PROCESS | 1654 | 09:38:59 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:39:00 INFO - PROCESS | 1654 | RSS: Main: 307994624 09:39:00 INFO - PROCESS | 1654 | 09:39:03 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:39:03 INFO - PROCESS | 1654 | RSS: Main: 323039232 09:39:03 INFO - PROCESS | 1654 | 09:39:06 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:39:07 INFO - PROCESS | 1654 | RSS: Main: 316084224 09:39:07 INFO - PROCESS | 1654 | 09:39:09 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 09:39:09 INFO - PROCESS | 1654 | RSS: Main: 360284160 09:39:09 INFO - PROCESS | 1654 | 09:39:09 INFO - PROCESS | 1654 | __start_tp_report 09:39:09 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 09:39:09 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 09:39:09 INFO - PROCESS | 1654 | |i|pagename|runs| 09:39:09 INFO - PROCESS | 1654 | |0;ai-astar;118;115;114;116;114;115;112;113;114;116 09:39:09 INFO - PROCESS | 1654 | |1;audio-beat-detection;130;108;108;138;110;109;107;106;125;107 09:39:09 INFO - PROCESS | 1654 | |2;audio-dft;186;187;183;182;185;184;184;184;186;179 09:39:09 INFO - PROCESS | 1654 | |3;audio-fft;82;60;59;91;59;62;59;60;75;59 09:39:09 INFO - PROCESS | 1654 | |4;audio-oscillator;87;69;88;69;70;67;83;68;70;85 09:39:09 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;89;89;89;89;90;89;90;89;90;90 09:39:09 INFO - PROCESS | 1654 | |6;imaging-darkroom;98;99;96;96;96;99;96;97;97;99 09:39:09 INFO - PROCESS | 1654 | |7;imaging-desaturate;85;91;136;99;85;85;84;84;85;112 09:39:09 INFO - PROCESS | 1654 | |8;json-parse-financial;60;63;62;61;66;65;66;64;63;65 09:39:09 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;54;63;69;67;61;57;57;57;62;82 09:39:09 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;80;85;83;84;85;84;85;90;90;83 09:39:09 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;158;131;126;139;141;146;139;135;203;174 09:39:09 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;160;163;167;164;163;162;164;164;231;172 09:39:09 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;70;79;85;82;83;67;62;63;64;64 09:39:09 INFO - PROCESS | 1654 | __end_tp_report 09:39:09 INFO - PROCESS | 1654 | __start_cc_report 09:39:09 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,2188 09:39:09 INFO - PROCESS | 1654 | __end_cc_report 09:39:09 INFO - PROCESS | 1654 | __startTimestamp1489768749447__endTimestamp 09:39:09 INFO - PROCESS | 1654 | 09:39:09 INFO - PROCESS | 1654 | ------- Summary: start ------- 09:39:09 INFO - PROCESS | 1654 | Number of tests: 14 09:39:09 INFO - PROCESS | 1654 | 09:39:09 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:114.70 Median:115.00 stddev:1.70 (1.5%) stddev-sans-first:1.32 09:39:09 INFO - PROCESS | 1654 | Values: 118.0 115.0 114.0 116.0 114.0 115.0 112.0 113.0 114.0 116.0 09:39:09 INFO - PROCESS | 1654 | 09:39:09 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:114.80 Median:109.50 stddev:11.65 (10.6%) stddev-sans-first:10.98 09:39:09 INFO - PROCESS | 1654 | Values: 130.0 108.0 108.0 138.0 110.0 109.0 107.0 106.0 125.0 107.0 09:39:09 INFO - PROCESS | 1654 | 09:39:09 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:184.00 Median:184.50 stddev:2.31 (1.3%) stddev-sans-first:2.33 09:39:09 INFO - PROCESS | 1654 | Values: 186.0 187.0 183.0 182.0 185.0 184.0 184.0 184.0 186.0 179.0 09:39:09 INFO - PROCESS | 1654 | 09:39:09 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:66.60 Median:61.00 stddev:11.75 (19.3%) stddev-sans-first:11.06 09:39:09 INFO - PROCESS | 1654 | Values: 82.0 60.0 59.0 91.0 59.0 62.0 59.0 60.0 75.0 59.0 09:39:09 INFO - PROCESS | 1654 | 09:39:09 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:75.60 Median:76.50 stddev:8.87 (11.6%) stddev-sans-first:8.40 09:39:09 INFO - PROCESS | 1654 | Values: 87.0 69.0 88.0 69.0 70.0 67.0 83.0 68.0 70.0 85.0 09:39:09 INFO - PROCESS | 1654 | 09:39:09 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:89.40 Median:89.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 09:39:09 INFO - PROCESS | 1654 | Values: 89.0 89.0 89.0 89.0 90.0 89.0 90.0 89.0 90.0 90.0 09:39:09 INFO - PROCESS | 1654 | 09:39:09 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:97.30 Median:97.50 stddev:1.34 (1.4%) stddev-sans-first:1.39 09:39:09 INFO - PROCESS | 1654 | Values: 98.0 99.0 96.0 96.0 96.0 99.0 96.0 97.0 97.0 99.0 09:39:09 INFO - PROCESS | 1654 | 09:39:09 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:85.00 stddev:17.13 (20.2%) stddev-sans-first:17.82 09:39:09 INFO - PROCESS | 1654 | Values: 85.0 91.0 136.0 99.0 85.0 85.0 84.0 84.0 85.0 112.0 09:39:09 INFO - PROCESS | 1654 | 09:39:09 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:63.50 Median:64.50 stddev:2.07 (3.2%) stddev-sans-first:1.76 09:39:09 INFO - PROCESS | 1654 | Values: 60.0 63.0 62.0 61.0 66.0 65.0 66.0 64.0 63.0 65.0 09:39:09 INFO - PROCESS | 1654 | 09:39:09 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:62.50 stddev:8.21 (13.1%) stddev-sans-first:8.05 09:39:09 INFO - PROCESS | 1654 | Values: 54.0 63.0 69.0 67.0 61.0 57.0 57.0 57.0 62.0 82.0 09:39:09 INFO - PROCESS | 1654 | 09:39:09 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:85.00 stddev:3.07 (3.6%) stddev-sans-first:2.70 09:39:09 INFO - PROCESS | 1654 | Values: 80.0 85.0 83.0 84.0 85.0 84.0 85.0 90.0 90.0 83.0 09:39:09 INFO - PROCESS | 1654 | 09:39:09 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:149.20 Median:143.50 stddev:23.44 (16.3%) stddev-sans-first:24.64 09:39:09 INFO - PROCESS | 1654 | Values: 158.0 131.0 126.0 139.0 141.0 146.0 139.0 135.0 203.0 174.0 09:39:09 INFO - PROCESS | 1654 | 09:39:09 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.00 Median:164.00 stddev:21.33 (13.0%) stddev-sans-first:22.25 09:39:09 INFO - PROCESS | 1654 | Values: 160.0 163.0 167.0 164.0 163.0 162.0 164.0 164.0 231.0 172.0 09:39:09 INFO - PROCESS | 1654 | 09:39:09 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:74.50 stddev:9.29 (12.5%) stddev-sans-first:9.83 09:39:09 INFO - PROCESS | 1654 | Values: 70.0 79.0 85.0 82.0 83.0 67.0 62.0 63.0 64.0 64.0 09:39:09 INFO - PROCESS | 1654 | -------- Summary: end -------- 09:39:09 INFO - PROCESS | 1654 | 09:39:10 INFO - TEST-INFO | 1654: exit 0 09:39:10 INFO - TEST-OK | kraken | took 59997ms 09:39:10 INFO - SUITE-END | took 1181s 09:39:10 INFO - Completed test suite (00:19:41) 09:39:10 INFO - javascript benchmark 09:39:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7648.9559587670765, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3213.8875139370125, 3468.5317482139912, 3472.513848061271, 3472.895813125607, 3522.925507720146, 6011.1084567606285, 6020.247469066367, 6026.397360263972, 6055.727492262848, 6106.694665266736, 5996.430339117787, 6052.001419765734, 6072.332043475214, 6072.605280656765, 6101.511879049676, 5362.731863406824, 5387.057264978633, 5419.918701219485, 5424.321959755031, 5506.862328441801, 5292.735363231823, 5305.151175811871, 5497.890042199154, 5503.9174412383845, 5549.861253468675, 5306.893862122755, 5360.088784906556, 5371.409144994048, 5378.596605254602, 5387.218853266274, 5364.329458817648, 5375.3280839895015, 5378.569714422876, 5382.784688612471, 5390.9191362129595, 5243.68537887728, 5320.201969704575, 5335.759890804923, 5338.62629615927, 5366.8926621467745, 5997.1304160896425, 6000.75996960121, 6002.0, 6015.518758499309, 6025.578209525335, 6293.653849038301, 6309.589876658002, 6313.905291420632, 6319.526035547352, 6327.272363678144, 5244.947550524484, 6265.592736472115, 6268.467180289681, 6269.2476902771505, 6271.780487682955, 6084.847878803065, 6094.299155597118, 6095.359987201325, 6103.054026625836, 6129.601575897597, 6481.93518064818, 6533.314002029813, 6548.541602087856, 6562.540622156451, 6565.507586930999, 6123.526657168115, 6167.691615419211, 6206.844828879224, 6282.748690052438, 6288.685565721696, 4806.4406470495705, 6287.842803929847, 6301.6219026858535, 6313.305536390993, 6313.589616674902, 6212.844678882973, 6246.937530624636, 6313.147725057059, 6313.179286692793, 6315.052742088724, 6281.466075383643, 6293.811185664345, 6304.716287767062, 6307.747690092437, 6310.968445157745, 5080.7205603692155, 5169.029552219534, 5172.379314482287, 5197.0, 5215.973920130375, 4474.485434175046, 4496.775161241925, 4533.365328853963, 4554.88612784683, 4568.6116680081905, 6108.7670647404, 6161.0, 6161.507079433634, 6165.167702360213, 6168.722407491584, 6209.0, 6388.009858471944, 6388.361163883667, 6403.071554624554, 6413.3266007069515, 5958.463738263577, 5965.791197308074, 6086.178365920633, 6112.847178820476, 6144.095330447575, 5677.971610141923, 5684.772609095672, 5684.8294551163535, 5699.800506982236, 5729.997250481149, 6630.204375474974, 6644.402003819776, 6662.56693314933, 6671.166104236971, 6686.7993960181275, 5319.414864364994, 6151.046587778901, 6166.1983942087245, 6237.033259844731, 6247.375262473716, 6322.114903913363, 6365.649889256136, 6372.840678983062, 6376.075469056868, 6558.573692709959, 6287.056941458635, 6293.968530157503, 6305.022721478178, 6321.683915804283, 6326.715297811517, 6373.203349581302, 6383.616982981036, 6390.872182556416, 6407.935920640734, 6423.582467139621, 5066.847994560169, 6031.336552979256, 6251.468625166912, 6272.529560282906, 6275.121482992294, 6207.286162091417, 6212.316645169119, 6227.657478838707, 6241.594296370903, 6252.124702541557, 6111.470193407285, 6134.78528251509, 6136.417040381157, 6203.410675985774, 6249.187605611241, 6266.216722909637, 6271.62370257786, 6285.371462853678, 6287.2140982377205, 6292.056191571301, 6271.122042913905, 6285.905711414241, 6290.24517057956, 6291.339409361951, 6309.936900630935], "value": 5866.867972957301, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [641.3714559731463, 760.8516339313834, 764.6024067484908, 765.1315756616242, 765.7626135897868, 29435.41129177415, 40011.99970000752, 40612.0, 40790.0, 40938.385924211085, 41455.0, 41793.373099403456, 41799.37300940481, 41816.0, 41853.58146418535, 7099.929000710004, 8833.514156721361, 9127.497987610679, 9137.862932055992, 9149.359544831865, 7137.643117844113, 7298.598577078258, 7355.190928997806, 7355.485116041879, 7358.595277259748, 10827.566897324097, 11073.335599863995, 11161.609343672973, 11167.497462614201, 11174.10607151426, 10930.836037459445, 11013.0, 11013.559457621686, 11029.227954043221, 11054.944725276402, 7177.636249112652, 10637.946810265976, 10707.518161682743, 10723.785524289471, 10747.51636176366, 23622.76377236223, 27858.0, 28036.859815700995, 37792.43311350332, 38618.61381386178, 3644.7084233261276, 3736.5142531470733, 3844.4233364995193, 3885.3783394657003, 3888.202918401721, 25371.746282537122, 25639.74360256392, 26546.070887518843, 27050.45899082027, 27225.04712335059, 2959.837208953507, 3015.8682902140417, 3129.4992801151934, 3138.5135304027913, 3221.2752130770623, 324384.0, 328572.0, 352369.99999999744, 352721.0, 352982.0, 45078.0, 45318.54681453209, 45401.54598454039, 45436.86407839831, 45497.545024549334, 46693.29960050534, 46705.29942050804, 46730.76634616805, 46735.831604210165, 46741.83145421392, 13339.866601333862, 13706.0, 13707.725845483234, 13718.93140534291, 13759.312034398241, 11819.940900295443, 11836.526538938519, 11837.171398002229, 11840.052795776317, 11861.76276474483, 11950.641480755592, 11983.940080299542, 12029.518819247307, 12054.095942804324, 12146.635600931986, 5674.404187560247, 5739.339975902742, 5751.683657398799, 5772.62477938941, 5789.392113828072, 919.7286800393766, 976.6532880827347, 1021.5607288865859, 1184.0, 1206.5897594817804, 28831.42337153245, 29575.85212073926, 29645.407091858044, 30150.396992060036, 30229.244268893013, 1039.656913218636, 1052.8157572424795, 1064.3722431521408, 1079.578964203961, 1084.902358787697, 14787.11277323364, 15366.308516116802, 15424.228788560527, 15558.377664893504, 15695.450659226872, 448111.0, 449718.0, 450182.0, 451001.0, 451129.0, 58674.41325586775, 58738.41261587415, 58820.0, 58937.5265618363, 59220.0, 1410.7460657081824, 1466.8239811222722, 1469.9118052916858, 1472.2785834941017, 1473.3517252408906, 21523.892380537996, 29608.851955740945, 30788.384232315675, 30907.536386953765, 31752.841235793672, 54875.45124548863, 55259.17111243415, 55293.0, 55322.616934575344, 55371.0, 482482.0, 485742.0, 486426.0, 486460.0, 486840.0, 32456.513152303207, 32733.0, 33004.17489562684, 33114.66885331212, 33151.67393304241, 43646.030611785936, 44375.11249775051, 44641.857862339064, 45415.77292113518, 45478.317825231985, 36221.913342599764, 36625.0, 36961.81519092387, 37266.0, 37393.626063739015, 29243.0, 35886.923392298275, 35940.82029589835, 37143.814280928425, 37352.252954941294, 35013.47479787754, 36352.81823590865, 36377.63622363848, 36648.26703465969, 37558.43662345122, 29014.854925725238, 29213.123606291847, 31967.0, 32263.838680807385, 32348.35303293874, 23979.0, 24203.51592968166, 24473.143439979514, 24657.753422465546, 24709.50580988406], "value": 18673.84279864614, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.99022901981107, 403.79204709574554, 419.79220285958445, 430.80183115766744, 443.8291257865721, 12036.939815300922, 21213.0, 21382.144714211434, 22195.33413997583, 22440.102395904185, 20644.0, 21110.894445527752, 22096.447588810286, 22831.657525137136, 23143.0742770289, 6572.948328267478, 6734.797956061326, 6789.287124851893, 6881.415079718205, 6943.236244013155, 6773.119494465713, 6816.9318306816795, 6832.282610325894, 6842.692078856463, 6857.588544687334, 6873.381395674388, 7069.399101076415, 7363.26367363262, 7530.246975302481, 7561.546307221557, 7242.420606351479, 7354.632268386559, 7395.926040739578, 7454.366378857803, 7471.55170689755, 6969.16370035599, 7254.673539690727, 7258.274172582753, 7259.0, 7266.164391095039, 20977.895110524503, 25979.44123352605, 26774.196774096807, 26800.73199268002, 27201.86399067992, 2908.4037772256847, 2926.385459053601, 2938.397628486155, 2945.2931296488687, 2976.166673331449, 15031.849681503154, 16036.35854565816, 16055.678886422324, 16181.676366472604, 16860.325586976505, 1575.3777257983033, 1996.241428257253, 2020.1515363547346, 2032.0855614973173, 2041.7345745053196, 165494.0, 169900.15049924795, 171893.14053429777, 174429.38355924672, 175252.0, 13414.530491432948, 16708.987303808808, 18515.186051626675, 20055.09752061161, 20238.49403764888, 27206.0, 27848.74680639376, 27861.16416507508, 27868.16395508138, 29360.0, 8614.483131012159, 9768.804623907625, 10085.344452610558, 10272.229582781321, 10303.330283531546, 5578.995780759502, 5854.0, 7356.852862942711, 8578.957105214435, 8761.25529330014, 8324.792905028737, 8557.229849313591, 8615.956920215483, 9134.543272836332, 9493.740226885662, 3329.450640644315, 4015.641225660006, 4028.8992775180855, 4029.959700403017, 4035.616616421435, 986.8470387090013, 991.1377101921374, 993.3741742702196, 1002.4837208837455, 1042.6976176908763, 21067.473313166985, 21344.893275533523, 21346.517231381586, 21398.928320275645, 21493.0, 957.7701351675547, 964.2286171063122, 1004.7940172264668, 1005.9346142500714, 1006.6476733143342, 10614.25700200994, 10968.575974542498, 10975.50610222542, 11062.391568463812, 11091.389973551532, 710421.0, 711175.0, 729310.0, 730664.0, 748567.0, 131328.0, 155683.0, 158969.0, 159936.83332340137, 161682.0, 1229.330015141732, 1239.3617287097152, 1273.8089286606898, 1278.9168704034207, 1281.218456741387, 17870.91064544669, 18353.90823045876, 18533.629327413644, 18703.90648046751, 18709.064546772333, 63073.0, 63287.36712632999, 64000.0, 64062.35937640564, 64202.67898660477, 91613.54193228991, 91785.54107229688, 92052.53973730089, 92605.5369723147, 94141.0, 11440.542378304775, 11453.198276120926, 11571.0, 11653.825192621947, 11838.822417663914, 12948.15836970594, 12981.545645902726, 13242.933785331012, 13279.004074694243, 13427.0, 11343.20597558163, 11390.031847293072, 11449.084073274285, 11494.94252528732, 11679.591214307799, 10896.78206435851, 10995.395253261147, 11001.064909482784, 11309.71725706864, 11439.0, 9987.850182247126, 10941.671749847517, 10954.945225274141, 11152.996230338984, 11303.547858085585, 10099.0, 11508.36703981289, 11671.183017188716, 11682.415879206175, 11867.940660296643, 10690.327418145464, 10944.835827462435, 10954.0, 10975.121990240601, 11227.831582526433], "value": 11480.961553567202, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1537.1161582090301, 1550.852668996445, 1580.84981926717, 1582.5489735425406, 1597.3291217688572, 10432.16542676586, 10658.307210031362, 11007.119430445566, 11014.449277536121, 11045.28205666631, 10948.233623646347, 11137.387443690593, 11159.553617855276, 11164.776704465905, 11171.329720216792, 2377.4531857672746, 2404.4710163763943, 2406.614941609343, 2407.6990376202975, 2410.867402292873, 2357.045396614374, 2363.8699871507147, 2394.1261439574605, 2397.9520409591796, 2407.3861165402886, 2363.1728894886824, 2378.5361854438393, 2388.199953015742, 2392.4018995251186, 2392.6530653055297, 2311.2257393773107, 2332.7084114485688, 2339.836211465198, 2342.578335899546, 2342.8008619267384, 2311.295055008222, 2332.97667023331, 2359.398353419884, 2360.3391050505884, 2361.315218586608, 10753.462326883702, 10993.395363255018, 10995.395253261067, 10997.725056873562, 11013.61452349172, 5575.804846830341, 5746.626469279484, 5753.856153596152, 5760.942390576082, 5761.9135712964335, 3319.286353433999, 3400.370931377703, 3445.982770086159, 3466.77465964714, 3483.407820670492, 999.6401295533602, 1150.4987481619792, 1177.0524727594284, 1177.3995262416229, 1196.0312147160828, 13474.19154850712, 13777.793333100011, 14079.436822527188, 15094.018888772194, 15140.621484462867, 4137.731047481904, 4247.23549761046, 4249.2988656871885, 4263.0, 4449.132419178294, 11450.54197832094, 11461.541538338373, 11476.655700329004, 11477.54089836414, 11491.310521368578, 5658.434156584309, 5661.377248502661, 5664.122061080539, 5666.801661941812, 5672.064109421982, 4937.728424936663, 5135.820246291362, 5195.2986346843445, 5202.115640341151, 5209.426963034063, 3293.7035666789625, 3672.7979961102396, 3777.2823163598828, 3813.542374915028, 3873.922521549553, 854.9871751923727, 996.9351992120489, 1006.7785087280787, 1010.4190090697878, 1017.4658304390107, 894.5393122541897, 923.3305853256336, 925.9490728010024, 926.8192702422963, 956.4452617481983, 5777.8555536111935, 6248.562600618004, 6441.32366101562, 6451.9354806452275, 6512.5441219115155, 884.8407286688458, 967.5452537307455, 984.5618699678574, 1014.6043043213152, 1026.707388394319, 3921.274564205574, 3973.5827738087664, 3986.621270979252, 4136.669066474675, 4142.958570414257, 13151.145175563557, 13653.180809151483, 13659.385327660279, 13680.863191368158, 13687.0, 13168.683131686754, 13341.66645833862, 13518.0, 13523.256220907748, 13524.323783810967, 8477.194666506672, 10112.393256404639, 10213.897861021444, 10214.0, 10215.846762298572, 6184.5052395809125, 6227.96886015567, 6285.528585356025, 6287.622742635456, 6388.68056597159, 11337.206395552563, 11418.771624567627, 11648.534058637559, 11653.825192621947, 11667.241629294069, 11017.338959662446, 11081.0, 11516.193866429605, 11791.587294444653, 12011.699707507381, 8137.0, 8296.004479462503, 8302.003759548892, 8305.916940830515, 8309.875351869607, 8826.0, 10125.392476451141, 10132.088112069654, 10191.08280254751, 10211.387316761018, 8108.432409731498, 8771.254443372385, 8968.0, 9037.728868133967, 9074.818503629758, 7575.772726818204, 8729.869051964099, 8772.210501054935, 8825.0, 8843.602037908438, 7574.697012119454, 7728.879312499544, 7735.806604834924, 7737.342325902361, 7760.146383897654, 5494.36814766291, 5565.582581306499, 5577.0797818359515, 5635.464630860061, 5716.54267658578, 5711.200431939449, 5723.0, 5739.483446489836, 5816.47651711348, 5847.5906686533235], "value": 4987.3512913146005, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.39758843727543, 332.52525051397055, 366.86242659002875, 376.8341929550996, 378.4682521057913, 5280.0, 5286.656367336125, 5315.671082229443, 5345.732713364326, 5362.35651721793, 4459.799309031093, 4870.587529616407, 5151.871203219921, 5169.043726910524, 5191.4548972357925, 3488.9127771805656, 4167.312393455076, 4277.0, 4317.805698743564, 4351.6518678505645, 3600.8739694110714, 4075.205334959684, 4261.275583150872, 4280.871573852789, 4314.654827613784, 3596.777095787432, 3744.307303148926, 4007.9158837404534, 4338.089001309729, 4338.414314067592, 3845.3847384418636, 3889.9027524311837, 3986.6013398660193, 4237.4491316129015, 4365.890852728691, 3466.497357883118, 3496.73774466916, 3644.0, 3706.4069748840056, 3942.526896772377, 4340.435743353344, 4823.237874457928, 5064.670796398223, 5123.308353372285, 5136.972605478882, 4613.377194078824, 4813.614910807127, 4962.950370496285, 4993.176125939216, 5005.399352077738, 4574.5425457453985, 5050.595952323805, 5248.947510524884, 5494.917576236359, 5623.26897503326, 4023.6177563131455, 4064.0289459612063, 4401.735895846259, 4424.823007079713, 4478.305862591304, 5201.0, 5629.691826351176, 5673.347565030033, 6004.309504407005, 6032.742319147655, 3632.727545434103, 3880.9223815523533, 4013.518377794683, 4461.442319710036, 4481.036577135931, 4623.6016527852, 4652.394923751301, 4668.649851261169, 4670.813167473331, 4674.36397260956, 4355.259605867011, 4658.557437043475, 4909.901801963941, 4935.777889994959, 5005.849824505271, 4915.107683541791, 5368.785248590013, 5480.698561579152, 5586.581006424534, 5607.990561698852, 1358.2665360705307, 1443.588577255477, 1486.31629450454, 1584.635533827203, 1602.278974461497, 1102.443266150589, 1167.7197472606683, 1178.4637989714658, 1191.7724743514195, 1206.9094817888692, 4878.975605121952, 4896.436909755424, 4924.926126108111, 5175.0, 5265.157194981725, 5313.57491400687, 5550.833474995757, 5642.858928526737, 5801.970990145107, 5834.066549352084, 4541.750203738826, 4828.420589529279, 4837.32277481153, 5119.0273847968765, 5239.816606418757, 2538.8984440622166, 2826.816256943292, 2880.3519208178413, 2982.925426864302, 2987.908464075156, 5572.0527510323345, 5707.571932105108, 5806.680632565165, 5838.0, 5974.820755377345, 4677.579017888406, 4974.328465657162, 5683.914741278884, 5969.552283578749, 5997.790077347272, 5415.025295446779, 5802.47777700009, 5804.593678442553, 6013.616868120269, 6061.727222275008, 5221.997351522814, 5229.555487783581, 5764.769409223584, 5784.681842498703, 5793.653570304034, 5555.388907220122, 5621.634593751393, 5712.429406767054, 5716.399778023414, 5752.0, 5820.30156381237, 5904.789518148855, 6020.39796020412, 6034.1036302575885, 6042.407770094672, 3925.7819332077283, 4059.4316795649224, 4119.752814831119, 4313.352997050468, 4570.565796249351, 5514.283143191359, 5679.630823996427, 5795.927753365472, 5797.782465682254, 5803.47768700819, 5482.314710661168, 5635.633683810539, 5645.915311270416, 5679.0, 5723.7996670116345, 4938.407391113089, 5308.5494428621705, 5585.441455854382, 5674.574406919415, 5692.715364231854, 4523.562092809554, 4585.587297143273, 5537.584681148849, 5576.5817563683695, 5636.915446268391, 5107.744612769421, 5221.765020574007, 5619.887602247851, 5627.8354018027185, 5713.314402271754, 4803.759812009315, 4847.030593881308, 4913.135995364635, 5077.060743762416, 5281.920771188358], "value": 4228.665613905317, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.7814447726576, 755.8866170074491, 767.8541077195332, 828.6354004238136, 839.3872473094641, 14973.176475293854, 15441.305141268642, 15824.841751582466, 16044.83955160448, 16156.111413872231, 13542.864571354283, 13557.664481234218, 13609.38757755901, 13648.454061837514, 13664.726705465884, 917.3807679816131, 931.6506310133666, 947.369998950697, 948.5446985446989, 950.4629884115452, 929.2844509727506, 951.6336210558916, 953.8521529162991, 953.909378609031, 957.760559860035, 983.1053741095604, 989.5052473763119, 990.8018396320729, 992.3351354592404, 993.1855878179896, 985.4727720669407, 987.4371608183338, 987.5407935310079, 988.4711679251566, 991.6231831903866, 712.0849708125035, 731.6012773038653, 732.5568031341069, 733.1788396995346, 733.8092096055011, 13112.672183195402, 15718.135502547355, 15803.893727439085, 15948.601284967852, 16115.435959741353, 13958.720825583432, 14124.85875141256, 14208.360623771956, 14247.857521424758, 14251.50359212278, 10254.384736915808, 11553.19127661064, 11650.242734222249, 11731.332902777036, 12203.511859525608, 3021.9546706799415, 3603.279344131184, 3614.4216925291826, 3731.8693845715543, 3828.846846126152, 92986.07013929842, 93114.60328095085, 94309.58535621903, 96565.51717241439, 98239.0, 10050.899491005142, 10308.123809476128, 10555.366677999345, 10766.084882784895, 11021.228514003942, 20571.4857128573, 20752.792472075387, 20794.376168714964, 20817.895910520652, 20838.791612083987, 7478.2895624915545, 7482.700691972369, 7577.621118944141, 7627.046619172604, 7627.821097616018, 4195.748255104703, 4235.089455767024, 4305.634021108241, 4394.626456751148, 4409.603135717801, 3459.2562599041325, 3533.840977156034, 3560.679538841465, 3561.3767590672046, 3565.322588708137, 586.3901542395946, 599.1192946368831, 604.3865476541314, 605.4248463959257, 623.8908191066636, 658.2134349452455, 682.3006418421159, 696.8153439338579, 698.937095661393, 707.5895980331395, 8961.59672814725, 9894.406335619886, 10271.794564108675, 10276.537555810006, 10324.535395907202, 553.0, 696.7839969609437, 705.1326867952447, 710.765447402356, 736.8710475666737, 4954.405471343462, 4973.90052198954, 4976.651634385558, 4986.202207646759, 4990.575801056951, 84458.0, 85694.28961352476, 103916.48041759743, 106770.46614767032, 108376.56042297595, 91825.081749183, 94056.52971735234, 94086.0, 95705.0, 96379.0, 80803.59598201972, 82262.58868705737, 83989.0, 84394.0, 84422.73365899516, 9556.808863822824, 9620.567074481805, 9634.0, 9638.0, 9653.420794752337, 50623.0, 50693.718782654134, 50979.49020509747, 51621.96756064783, 53213.4678653224, 50574.0, 63037.0, 63611.363886360545, 63777.681111594145, 66165.66917165575, 12356.25862448256, 12764.808527872276, 13023.609291721263, 13030.41363138642, 13066.80399794023, 13984.650383740487, 14392.568222953329, 14503.637409064857, 14526.709465810836, 14875.107493550422, 13817.309134543031, 14061.718765624426, 14261.001729878808, 14286.285685715466, 14316.355763990854, 13353.465861365437, 13744.725105497633, 14303.927205459424, 14628.561143165722, 14876.479323223635, 13140.474381025035, 13317.267550284827, 13548.983826212876, 13657.931710341385, 14006.369713363127, 11053.0, 11089.667309980714, 11373.539314715916, 11511.827322590336, 11762.0, 9558.522073896416, 9684.176844968257, 9735.9026409735, 9761.707148785548, 9856.704298871045], "value": 7548.829922692708, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1440.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 115.0, 114.0, 116.0, 114.0, 115.0, 112.0, 113.0, 114.0, 116.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 108.0, 108.0, 138.0, 110.0, 109.0, 107.0, 106.0, 125.0, 107.0], "value": 114.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 187.0, 183.0, 182.0, 185.0, 184.0, 184.0, 184.0, 186.0, 179.0], "value": 184.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 59.0, 91.0, 59.0, 62.0, 59.0, 60.0, 75.0, 59.0], "value": 66.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 69.0, 88.0, 69.0, 70.0, 67.0, 83.0, 68.0, 70.0, 85.0], "value": 75.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 89.0, 89.0, 90.0, 89.0, 90.0, 89.0, 90.0, 90.0], "value": 89.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 99.0, 96.0, 96.0, 96.0, 99.0, 96.0, 97.0, 97.0, 99.0], "value": 97.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 91.0, 136.0, 99.0, 85.0, 85.0, 84.0, 84.0, 85.0, 112.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 63.0, 62.0, 61.0, 66.0, 65.0, 66.0, 64.0, 63.0, 65.0], "value": 63.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 63.0, 69.0, 67.0, 61.0, 57.0, 57.0, 57.0, 62.0, 82.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 85.0, 83.0, 84.0, 85.0, 84.0, 85.0, 90.0, 90.0, 83.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 131.0, 126.0, 139.0, 141.0, 146.0, 139.0, 135.0, 203.0, 174.0], "value": 149.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 167.0, 164.0, 163.0, 162.0, 164.0, 164.0, 231.0, 172.0], "value": 171.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 79.0, 85.0, 82.0, 83.0, 67.0, 62.0, 63.0, 64.0, 64.0], "value": 71.9, "unit": "score"}]}]} 09:39:10 INFO - Return code: 0 09:39:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:39:10 ERROR - # TBPL SUCCESS # 09:39:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:39:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:39:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:39:10 INFO - 2017-03-17 09:39:10.773 screenresolution[1658:10107] starting screenresolution argv=screenresolution get 09:39:10 INFO - 2017-03-17 09:39:10.776 screenresolution[1658:10107] Display 0: 1600x1200x32@60 09:39:10 INFO - 2017-03-17 09:39:10.783 screenresolution[1659:10110] starting screenresolution argv=screenresolution list 09:39:10 INFO - Available Modes on Display 0 09:39:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:39:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:39:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:39:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:39:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:39:11 INFO - Intel Iris: 09:39:11 INFO - Chipset Model: Intel Iris 09:39:11 INFO - Type: GPU 09:39:11 INFO - Bus: Built-In 09:39:11 INFO - VRAM (Dynamic, Max): 1536 MB 09:39:11 INFO - Vendor: Intel (0x8086) 09:39:11 INFO - Device ID: 0x0a2e 09:39:11 INFO - Revision ID: 0x0009 09:39:11 INFO - Displays: 09:39:11 INFO - Display: 09:39:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:39:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:39:11 INFO - Display Serial Number: 1600x1200 60 09:39:11 INFO - Main Display: Yes 09:39:11 INFO - Mirror: Off 09:39:11 INFO - Online: Yes 09:39:11 INFO - Rotation: Supported 09:39:11 INFO - Return code: 0 09:39:11 INFO - Running post-action listener: _resource_record_post_action 09:39:11 INFO - [mozharness: 2017-03-17 16:39:11.031514Z] Finished run-tests step (success) 09:39:11 INFO - Running post-run listener: _resource_record_post_run 09:39:11 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 37893120; Write bytes: 506319872; Read time: 388; Write time: 1578 09:39:11 INFO - TinderboxPrint: CPU usage
53.9% 09:39:11 INFO - TinderboxPrint: I/O read bytes / time
37,893,120 / 388 09:39:11 INFO - TinderboxPrint: I/O write bytes / time
506,319,872 / 1,578 09:39:11 INFO - TinderboxPrint: CPU idle
2,217.4 (46.1%) 09:39:11 INFO - TinderboxPrint: CPU system
960.6 (20.0%) 09:39:11 INFO - TinderboxPrint: CPU user
1,631.6 (33.9%) 09:39:11 INFO - TinderboxPrint: Swap in / out
246,255,616 / 0 09:39:11 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 209625600; Write bytes: 210802688; Read time: 16566; Write time: 451 09:39:11 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 34243584; Write bytes: 294018048; Read time: 364; Write time: 1120 09:39:11 INFO - Running post-run listener: _upload_blobber_files 09:39:11 INFO - Blob upload gear active. 09:39:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:39:11 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 09:39:11 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'] 09:39:11 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 09:39:11 INFO - (blobuploader) - INFO - Open directory for files ... 09:39:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:39:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:39:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:12 INFO - (blobuploader) - INFO - Done attempting. 09:39:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:39:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:39:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:13 INFO - (blobuploader) - INFO - Done attempting. 09:39:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:39:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:39:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:14 INFO - (blobuploader) - INFO - Done attempting. 09:39:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:39:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:39:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:17 INFO - (blobuploader) - INFO - Done attempting. 09:39:17 INFO - (blobuploader) - INFO - Iteration through files over. 09:39:17 INFO - Return code: 0 09:39:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:39:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:39:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/799a9c586d8d04f97d87843cc263ac03b19bac06ff05b50f12c15909cc5c9a33674f17f3ed948d7dca74dc8c3ccec1885fbea3bfebf96757b07e3cec4e1984b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ec4981f318cb9abb0b33b6b77eea44dae4fbb85e11cd960731c8e95468d562938985e4fc2e880e5d10d9e979553a714edbc73b22c05ebd2d2eea16afc768674e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3dda3f78296aa2d9b10599f8290f9ed843505b21ca44312591cdb9c6f7f97bcabd9bd809e1e8ca42077b49e6917cbc3151d7dce1ac609c6ebc3c3fc4090ea771", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8042f73c6890d169d4d0eef12fe7ab84b2a8be689e27e33e6a5f6a13ba3fcdebe49a60449a3d204fe01b2758caaf9e02a1a68e0c4b00fff159d7c741f271da49"} 09:39:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:39:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:39:17 INFO - Contents: 09:39:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/799a9c586d8d04f97d87843cc263ac03b19bac06ff05b50f12c15909cc5c9a33674f17f3ed948d7dca74dc8c3ccec1885fbea3bfebf96757b07e3cec4e1984b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ec4981f318cb9abb0b33b6b77eea44dae4fbb85e11cd960731c8e95468d562938985e4fc2e880e5d10d9e979553a714edbc73b22c05ebd2d2eea16afc768674e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3dda3f78296aa2d9b10599f8290f9ed843505b21ca44312591cdb9c6f7f97bcabd9bd809e1e8ca42077b49e6917cbc3151d7dce1ac609c6ebc3c3fc4090ea771", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8042f73c6890d169d4d0eef12fe7ab84b2a8be689e27e33e6a5f6a13ba3fcdebe49a60449a3d204fe01b2758caaf9e02a1a68e0c4b00fff159d7c741f271da49"} 09:39:17 INFO - Running post-run listener: copy_logs_to_upload_dir 09:39:17 INFO - Copying logs to upload dir... 09:39:17 INFO - mkdir: /builds/slave/test/build/upload/logs 09:39:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.342927 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-17 09:39:17.124157) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-17 09:39:17.127489) ========= 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.M9AP7yeZE0/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.lM095QDLcw/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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/799a9c586d8d04f97d87843cc263ac03b19bac06ff05b50f12c15909cc5c9a33674f17f3ed948d7dca74dc8c3ccec1885fbea3bfebf96757b07e3cec4e1984b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ec4981f318cb9abb0b33b6b77eea44dae4fbb85e11cd960731c8e95468d562938985e4fc2e880e5d10d9e979553a714edbc73b22c05ebd2d2eea16afc768674e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3dda3f78296aa2d9b10599f8290f9ed843505b21ca44312591cdb9c6f7f97bcabd9bd809e1e8ca42077b49e6917cbc3151d7dce1ac609c6ebc3c3fc4090ea771", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8042f73c6890d169d4d0eef12fe7ab84b2a8be689e27e33e6a5f6a13ba3fcdebe49a60449a3d204fe01b2758caaf9e02a1a68e0c4b00fff159d7c741f271da49"} build_url:https://queue.taskcluster.net/v1/task/RtEcmaV6TjGzN2_t8uok4w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011112 build_url: 'https://queue.taskcluster.net/v1/task/RtEcmaV6TjGzN2_t8uok4w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/799a9c586d8d04f97d87843cc263ac03b19bac06ff05b50f12c15909cc5c9a33674f17f3ed948d7dca74dc8c3ccec1885fbea3bfebf96757b07e3cec4e1984b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ec4981f318cb9abb0b33b6b77eea44dae4fbb85e11cd960731c8e95468d562938985e4fc2e880e5d10d9e979553a714edbc73b22c05ebd2d2eea16afc768674e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3dda3f78296aa2d9b10599f8290f9ed843505b21ca44312591cdb9c6f7f97bcabd9bd809e1e8ca42077b49e6917cbc3151d7dce1ac609c6ebc3c3fc4090ea771", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8042f73c6890d169d4d0eef12fe7ab84b2a8be689e27e33e6a5f6a13ba3fcdebe49a60449a3d204fe01b2758caaf9e02a1a68e0c4b00fff159d7c741f271da49"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-17 09:39:17.166490) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 09:39:17.167239) ========= 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.M9AP7yeZE0/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.lM095QDLcw/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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.005400 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-17 09:39:17.218565) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-17 09:39:17.219282) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-17 09:39:17.219941) ========= ========= Total master_lag: 0.19 =========