builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0274 starttime: 1493374570.74 results: success (0) buildid: 20170428013726 builduid: a69431d51a794d4080081319f03ec8c9 revision: 8f2b930cd02842fa1ca884be447a5bbff4ba1b9b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 03:16:10.741864) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 03:16:10.742367) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 03:16:10.742659) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 03:16:10.770694) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 03:16:10.771315) ========= 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.2WaiHwqxTn/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.DFbwwLQ2nq/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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-04-28 03:16:10-- 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% 75.4M=0s 2017-04-28 03:16:10 (75.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.086949 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 03:16:10.884282) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 03:16:10.884631) ========= 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.2WaiHwqxTn/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.DFbwwLQ2nq/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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.025919 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 03:16:10.933310) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-28 03:16:10.933690) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8f2b930cd02842fa1ca884be447a5bbff4ba1b9b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 8f2b930cd02842fa1ca884be447a5bbff4ba1b9b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2WaiHwqxTn/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.DFbwwLQ2nq/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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-04-28 03:16:11,078 truncating revision to first 12 chars 2017-04-28 03:16:11,078 Setting DEBUG logging. 2017-04-28 03:16:11,078 attempt 1/10 2017-04-28 03:16:11,078 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8f2b930cd028?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-28 03:16:12,119 unpacking tar archive at: mozilla-central-8f2b930cd028/testing/mozharness/ program finished with exit code 0 elapsedTime=1.315683 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-28 03:16:12.273743) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 03:16:12.274337) ========= script_repo_revision: 8f2b930cd02842fa1ca884be447a5bbff4ba1b9b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 03:16:12.275010) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 03:16:12.275536) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 03:16:12.297121) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-04-28 03:16:12.297543) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2WaiHwqxTn/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.DFbwwLQ2nq/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 03:16:12 INFO - MultiFileLogger online at 20170428 03:16:12 in /builds/slave/test 03:16:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:16:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:16:12 INFO - {'append_to_log': False, 03:16:12 INFO - 'base_work_dir': '/builds/slave/test', 03:16:12 INFO - 'blob_upload_branch': 'Firefox', 03:16:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:16:12 INFO - 'branch': 'Firefox', 03:16:12 INFO - 'buildbot_json_path': 'buildprops.json', 03:16:12 INFO - 'config_files': ('talos/mac_config.py',), 03:16:12 INFO - 'default_actions': ('clobber', 03:16:12 INFO - 'read-buildbot-config', 03:16:12 INFO - 'download-and-extract', 03:16:12 INFO - 'populate-webroot', 03:16:12 INFO - 'create-virtualenv', 03:16:12 INFO - 'install', 03:16:12 INFO - 'run-tests'), 03:16:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:16:12 INFO - 'download_minidump_stackwalk': True, 03:16:12 INFO - 'download_symbols': 'ondemand', 03:16:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:16:12 INFO - 'tooltool.py': '/tools/tooltool.py', 03:16:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:16:12 INFO - '/tools/misc-python/virtualenv.py')}, 03:16:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:16:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:16:12 INFO - 'gecko_profile': False, 03:16:12 INFO - 'gecko_profile_interval': 0, 03:16:12 INFO - 'installer_path': 'installer.exe', 03:16:12 INFO - 'log_level': 'info', 03:16:12 INFO - 'log_name': 'talos', 03:16:12 INFO - 'log_to_console': True, 03:16:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:16:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:16:12 INFO - 'opt_config_files': (), 03:16:12 INFO - 'pip_index': False, 03:16:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:16:12 INFO - 'cmd': ('bash', 03:16:12 INFO - '-c', 03:16:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:16:12 INFO - 'enabled': True, 03:16:12 INFO - 'halt_on_failure': False, 03:16:12 INFO - 'name': 'check_screen_resolution'},), 03:16:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:16:12 INFO - 'cmd': ('bash', 03:16:12 INFO - '-c', 03:16:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:16:12 INFO - 'enabled': True, 03:16:12 INFO - 'halt_on_failure': False, 03:16:12 INFO - 'name': 'check_screen_resolution'},), 03:16:12 INFO - 'run_cmd_checks_enabled': True, 03:16:12 INFO - 'suite': 'dromaeojs', 03:16:12 INFO - 'system_bits': '32', 03:16:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:16:12 INFO - 'title': 't-yosemite-r7-0274', 03:16:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:16:12 INFO - 'use_talos_json': True, 03:16:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:16:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:16:12 INFO - 'work_dir': 'build'} 03:16:12 INFO - [mozharness: 2017-04-28 10:16:12.548483Z] Running clobber step. 03:16:12 INFO - Running pre-action listener: _resource_record_pre_action 03:16:12 INFO - Running main action method: clobber 03:16:12 INFO - rmtree: /builds/slave/test/build 03:16:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:16:15 INFO - Running post-action listener: _resource_record_post_action 03:16:15 INFO - [mozharness: 2017-04-28 10:16:15.062079Z] Finished clobber step (success) 03:16:15 INFO - [mozharness: 2017-04-28 10:16:15.062153Z] Running read-buildbot-config step. 03:16:15 INFO - Running pre-action listener: _resource_record_pre_action 03:16:15 INFO - Running main action method: read_buildbot_config 03:16:15 INFO - Using buildbot properties: 03:16:15 INFO - { 03:16:15 INFO - "project": "", 03:16:15 INFO - "product": "firefox", 03:16:15 INFO - "script_repo_revision": "production", 03:16:15 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 03:16:15 INFO - "repository": "", 03:16:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 03:16:15 INFO - "buildid": "20170428013726", 03:16:15 INFO - "pgo_build": "False", 03:16:15 INFO - "basedir": "/builds/slave/test", 03:16:15 INFO - "buildnumber": 19, 03:16:15 INFO - "slavename": "t-yosemite-r7-0274", 03:16:15 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 03:16:15 INFO - "platform": "yosemite_r7", 03:16:15 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:16:15 INFO - "branch": "mozilla-central", 03:16:15 INFO - "repo_path": "mozilla-central", 03:16:15 INFO - "revision": "8f2b930cd02842fa1ca884be447a5bbff4ba1b9b", 03:16:15 INFO - "stage_platform": "macosx64", 03:16:15 INFO - "builduid": "a69431d51a794d4080081319f03ec8c9", 03:16:15 INFO - "slavebuilddir": "test" 03:16:15 INFO - } 03:16:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 03:16:15 INFO - Running post-action listener: _resource_record_post_action 03:16:15 INFO - [mozharness: 2017-04-28 10:16:15.065549Z] Finished read-buildbot-config step (success) 03:16:15 INFO - [mozharness: 2017-04-28 10:16:15.065677Z] Running download-and-extract step. 03:16:15 INFO - Running pre-action listener: _resource_record_pre_action 03:16:15 INFO - Running main action method: download_and_extract 03:16:15 INFO - mkdir: /builds/slave/test/build/tests 03:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:15 INFO - trying https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 03:16:15 INFO - Downloading https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 03:16:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 03:16:16 INFO - Downloaded 1325 bytes. 03:16:16 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 03:16:16 INFO - Using the following test package requirements: 03:16:16 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:16:16 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 03:16:16 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:16:16 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:16:16 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 03:16:16 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:16:16 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 03:16:16 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:16:16 INFO - u'jsshell-mac.zip'], 03:16:16 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:16:16 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 03:16:16 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:16:16 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:16:16 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 03:16:16 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:16:16 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 03:16:16 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:16:16 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 03:16:16 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:16:16 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 03:16:16 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:16:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:16:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:16:16 INFO - Fetch https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:16:17 INFO - Content-Length response header: 52698547 03:16:17 INFO - Bytes received: 52698547 03:16:33 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 03:16:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:16:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:16:33 INFO - Fetch https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:16:35 INFO - Content-Length response header: 52698547 03:16:35 INFO - Bytes received: 52698547 03:16:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 03:16:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:16:51 INFO - Fetch https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 03:16:52 INFO - Content-Length response header: 14408809 03:16:52 INFO - Bytes received: 14408809 03:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:52 INFO - trying https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:16:52 INFO - Downloading https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 03:16:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 03:16:54 INFO - Downloaded 71220116 bytes. 03:16:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:16:54 INFO - mkdir: /builds/slave/test/properties 03:16:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:16:54 INFO - Writing to file /builds/slave/test/properties/build_url 03:16:54 INFO - Contents: 03:16:54 INFO - build_url:https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:16:55 INFO - Running post-action listener: _resource_record_post_action 03:16:55 INFO - Running post-action listener: set_extra_try_arguments 03:16:55 INFO - [mozharness: 2017-04-28 10:16:55.301207Z] Finished download-and-extract step (success) 03:16:55 INFO - [mozharness: 2017-04-28 10:16:55.301363Z] Running populate-webroot step. 03:16:55 INFO - Running pre-action listener: _resource_record_pre_action 03:16:55 INFO - Running main action method: populate_webroot 03:16:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:16:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:16:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:16:55 INFO - '--tppagecycles', 03:16:55 INFO - '7'], 03:16:55 INFO - 'tests': ['tsvgm']}}, 03:16:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:16:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:16:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:16:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:16:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:16:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:16:55 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:16:55 INFO - 'talos_options': ['--disable-e10s'], 03:16:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:16:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:16:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:16:55 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:16:55 INFO - 'talos_options': ['--disable-e10s'], 03:16:55 INFO - 'tests': ['damp', 'tps']}, 03:16:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:16:55 INFO - 'tests': ['damp', 'tps']}, 03:16:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:16:55 INFO - 'tests': ['dromaeo_dom']}, 03:16:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:16:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:16:55 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:16:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:16:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:16:55 INFO - 'tests': ['a11yr', 03:16:55 INFO - 'ts_paint', 03:16:55 INFO - 'tpaint', 03:16:55 INFO - 'sessionrestore', 03:16:55 INFO - 'sessionrestore_no_auto_restore', 03:16:55 INFO - 'tabpaint']}, 03:16:55 INFO - 'other-e10s': {'tests': ['a11yr', 03:16:55 INFO - 'ts_paint', 03:16:55 INFO - 'tpaint', 03:16:55 INFO - 'sessionrestore', 03:16:55 INFO - 'sessionrestore_no_auto_restore', 03:16:55 INFO - 'tabpaint']}, 03:16:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:16:55 INFO - 'ts_paint', 03:16:55 INFO - 'tpaint', 03:16:55 INFO - 'sessionrestore', 03:16:55 INFO - 'sessionrestore_no_auto_restore', 03:16:55 INFO - 'tabpaint']}, 03:16:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:16:55 INFO - 'ts_paint', 03:16:55 INFO - 'tpaint', 03:16:55 INFO - 'sessionrestore', 03:16:55 INFO - 'sessionrestore_no_auto_restore', 03:16:55 INFO - 'tabpaint']}, 03:16:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:16:55 INFO - 'tests': ['a11yr', 03:16:55 INFO - 'ts_paint', 03:16:55 INFO - 'tpaint', 03:16:55 INFO - 'sessionrestore', 03:16:55 INFO - 'sessionrestore_no_auto_restore', 03:16:55 INFO - 'tabpaint']}, 03:16:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:16:55 INFO - 'tests': ['a11yr', 03:16:55 INFO - 'ts_paint', 03:16:55 INFO - 'tpaint', 03:16:55 INFO - 'sessionrestore', 03:16:55 INFO - 'sessionrestore_no_auto_restore', 03:16:55 INFO - 'tabpaint']}, 03:16:55 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:16:55 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:16:55 INFO - 'bloom_basic_ref']}, 03:16:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:16:55 INFO - 'tests': ['tsvgx', 03:16:55 INFO - 'tsvgr_opacity', 03:16:55 INFO - 'tart', 03:16:55 INFO - 'tscrollx', 03:16:55 INFO - 'cart', 03:16:55 INFO - 'tsvg_static']}, 03:16:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:16:55 INFO - 'tsvgr_opacity', 03:16:55 INFO - 'tart', 03:16:55 INFO - 'tscrollx', 03:16:55 INFO - 'cart', 03:16:55 INFO - 'tsvg_static']}, 03:16:55 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:16:55 INFO - 'talos_options': ['--disable-e10s'], 03:16:55 INFO - 'tests': ['tp5o']}, 03:16:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:16:55 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:16:55 INFO - 'talos_options': ['--disable-e10s', 03:16:55 INFO - '--xperf_path', 03:16:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:16:55 INFO - 'tests': ['tp5n']}, 03:16:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:16:55 INFO - 'talos_options': ['--xperf_path', 03:16:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:16:55 INFO - 'tests': ['tp5n']}}, 03:16:55 INFO - 'talos.zip': {'path': '', 03:16:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:16:55 INFO - Running post-action listener: _resource_record_post_action 03:16:55 INFO - [mozharness: 2017-04-28 10:16:55.319999Z] Finished populate-webroot step (success) 03:16:55 INFO - [mozharness: 2017-04-28 10:16:55.320112Z] Running create-virtualenv step. 03:16:55 INFO - Running pre-action listener: _resource_record_pre_action 03:16:55 INFO - Running main action method: create_virtualenv 03:16:55 INFO - Creating virtualenv /builds/slave/test/build/venv 03:16:55 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 03:16:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:16:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:16:55 INFO - Using real prefix '/tools/python27' 03:16:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:16:56 INFO - Installing distribute.............................................................................................................................................................................................done. 03:16:59 INFO - Installing pip.................done. 03:16:59 INFO - Return code: 0 03:16:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:16:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:16:59 INFO - Reading from file tmpfile_stdout 03:16:59 INFO - Output received: 03:16:59 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) 03:16:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103571b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103574768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e695e5b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10334fd30>, '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 0x103275db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103344be8>, '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.2WaiHwqxTn/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.DFbwwLQ2nq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 03:16:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:16:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:16:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2WaiHwqxTn/Render', 03:16:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:16:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:16:59 INFO - 'HOME': '/Users/cltbld', 03:16:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:16:59 INFO - 'LOGNAME': 'cltbld', 03:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:59 INFO - 'MOZ_NO_REMOTE': '1', 03:16:59 INFO - 'NO_EM_RESTART': '1', 03:16:59 INFO - 'PAGER': '/bin/cat', 03:16:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:59 INFO - 'PWD': '/builds/slave/test', 03:16:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:16:59 INFO - 'SHELL': '/bin/bash', 03:16:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DFbwwLQ2nq/Listeners', 03:16:59 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 03:16:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:16:59 INFO - 'USER': 'cltbld', 03:16:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:16:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:59 INFO - 'XPC_FLAGS': '0x0', 03:16:59 INFO - 'XPC_SERVICE_NAME': '0', 03:16:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:59 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 03:16:59 INFO - Cleaning up... 03:16:59 INFO - Return code: 0 03:16:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103571b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103574768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e695e5b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10334fd30>, '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 0x103275db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103344be8>, '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.2WaiHwqxTn/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.DFbwwLQ2nq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 03:16:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:16:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:16:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2WaiHwqxTn/Render', 03:16:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:16:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:16:59 INFO - 'HOME': '/Users/cltbld', 03:16:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:16:59 INFO - 'LOGNAME': 'cltbld', 03:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:59 INFO - 'MOZ_NO_REMOTE': '1', 03:16:59 INFO - 'NO_EM_RESTART': '1', 03:16:59 INFO - 'PAGER': '/bin/cat', 03:16:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:59 INFO - 'PWD': '/builds/slave/test', 03:16:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:16:59 INFO - 'SHELL': '/bin/bash', 03:16:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DFbwwLQ2nq/Listeners', 03:16:59 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 03:16:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:16:59 INFO - 'USER': 'cltbld', 03:16:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:16:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:59 INFO - 'XPC_FLAGS': '0x0', 03:16:59 INFO - 'XPC_SERVICE_NAME': '0', 03:16:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:59 INFO - Downloading/unpacking psutil>=3.1.1 03:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:17:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:17:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:17:03 INFO - Installing collected packages: psutil 03:17:03 INFO - Running setup.py install for psutil 03:17:03 INFO - building 'psutil._psutil_osx' extension 03:17:03 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 03:17:04 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 03:17:04 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 03:17:04 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 03:17:04 INFO - building 'psutil._psutil_posix' extension 03:17:04 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 03:17:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:17:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:17:04 INFO - ^ 03:17:04 INFO - 1 warning generated. 03:17:04 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 03:17:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:17:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:17:04 INFO - Successfully installed psutil 03:17:04 INFO - Cleaning up... 03:17:04 INFO - Return code: 0 03:17:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:04 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 0x103571b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103574768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e695e5b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10334fd30>, '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 0x103275db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103344be8>, '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.2WaiHwqxTn/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.DFbwwLQ2nq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 03:17:04 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 03:17:04 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 03:17:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2WaiHwqxTn/Render', 03:17:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:04 INFO - 'HOME': '/Users/cltbld', 03:17:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:04 INFO - 'LOGNAME': 'cltbld', 03:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:04 INFO - 'MOZ_NO_REMOTE': '1', 03:17:04 INFO - 'NO_EM_RESTART': '1', 03:17:04 INFO - 'PAGER': '/bin/cat', 03:17:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:04 INFO - 'PWD': '/builds/slave/test', 03:17:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:04 INFO - 'SHELL': '/bin/bash', 03:17:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DFbwwLQ2nq/Listeners', 03:17:04 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 03:17:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:04 INFO - 'USER': 'cltbld', 03:17:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:04 INFO - 'XPC_FLAGS': '0x0', 03:17:04 INFO - 'XPC_SERVICE_NAME': '0', 03:17:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:17:04 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 03:17:04 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 03:17:04 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 03:17:04 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 03:17:04 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 03:17:04 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 03:17:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:17:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:17:07 INFO - Installing collected packages: mozsystemmonitor 03:17:07 INFO - Running setup.py install for mozsystemmonitor 03:17:07 INFO - Successfully installed mozsystemmonitor 03:17:07 INFO - Cleaning up... 03:17:08 INFO - Return code: 0 03:17:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:08 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 0x103571b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103574768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e695e5b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10334fd30>, '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 0x103275db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103344be8>, '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.2WaiHwqxTn/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.DFbwwLQ2nq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 03:17:08 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 03:17:08 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 03:17:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2WaiHwqxTn/Render', 03:17:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:08 INFO - 'HOME': '/Users/cltbld', 03:17:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:08 INFO - 'LOGNAME': 'cltbld', 03:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:08 INFO - 'MOZ_NO_REMOTE': '1', 03:17:08 INFO - 'NO_EM_RESTART': '1', 03:17:08 INFO - 'PAGER': '/bin/cat', 03:17:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:08 INFO - 'PWD': '/builds/slave/test', 03:17:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:08 INFO - 'SHELL': '/bin/bash', 03:17:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DFbwwLQ2nq/Listeners', 03:17:08 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 03:17:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:08 INFO - 'USER': 'cltbld', 03:17:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:08 INFO - 'XPC_FLAGS': '0x0', 03:17:08 INFO - 'XPC_SERVICE_NAME': '0', 03:17:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:09 INFO - Downloading/unpacking jsonschema==2.5.1 03:17:09 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 03:17:09 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 03:17:09 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 03:17:09 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 03:17:09 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 03:17:09 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 03:17:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:17:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:12 INFO - Downloading functools32-3.2.3-2.tar.gz 03:17:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:17:12 INFO - warning: no files found matching '*.txt' 03:17:12 INFO - no previously-included directories found matching 'build' 03:17:12 INFO - no previously-included directories found matching 'dist' 03:17:12 INFO - no previously-included directories found matching '.git*' 03:17:12 INFO - Installing collected packages: jsonschema, functools32 03:17:12 INFO - Running setup.py install for functools32 03:17:12 INFO - warning: no files found matching '*.txt' 03:17:12 INFO - no previously-included directories found matching 'build' 03:17:12 INFO - no previously-included directories found matching 'dist' 03:17:12 INFO - no previously-included directories found matching '.git*' 03:17:12 INFO - Successfully installed jsonschema functools32 03:17:12 INFO - Cleaning up... 03:17:12 INFO - Return code: 0 03:17:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103571b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103574768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e695e5b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10334fd30>, '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 0x103275db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103344be8>, '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.2WaiHwqxTn/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.DFbwwLQ2nq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 03:17:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:17:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2WaiHwqxTn/Render', 03:17:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:12 INFO - 'HOME': '/Users/cltbld', 03:17:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:12 INFO - 'LOGNAME': 'cltbld', 03:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:12 INFO - 'MOZ_NO_REMOTE': '1', 03:17:12 INFO - 'NO_EM_RESTART': '1', 03:17:12 INFO - 'PAGER': '/bin/cat', 03:17:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:12 INFO - 'PWD': '/builds/slave/test', 03:17:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:12 INFO - 'SHELL': '/bin/bash', 03:17:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DFbwwLQ2nq/Listeners', 03:17:12 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 03:17:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:12 INFO - 'USER': 'cltbld', 03:17:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:12 INFO - 'XPC_FLAGS': '0x0', 03:17:12 INFO - 'XPC_SERVICE_NAME': '0', 03:17:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:17:13 INFO - Cleaning up... 03:17:13 INFO - Return code: 0 03:17:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:17:13 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')]} 03:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:13 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')]} 03:17:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:13 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 0x103571b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103574768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e695e5b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10334fd30>, '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 0x103275db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103344be8>, '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.2WaiHwqxTn/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.DFbwwLQ2nq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 03:17:13 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 03:17:13 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 03:17:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2WaiHwqxTn/Render', 03:17:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:13 INFO - 'HOME': '/Users/cltbld', 03:17:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:13 INFO - 'LOGNAME': 'cltbld', 03:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:13 INFO - 'MOZ_NO_REMOTE': '1', 03:17:13 INFO - 'NO_EM_RESTART': '1', 03:17:13 INFO - 'PAGER': '/bin/cat', 03:17:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:13 INFO - 'PWD': '/builds/slave/test', 03:17:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:13 INFO - 'SHELL': '/bin/bash', 03:17:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DFbwwLQ2nq/Listeners', 03:17:13 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 03:17:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:13 INFO - 'USER': 'cltbld', 03:17:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:13 INFO - 'XPC_FLAGS': '0x0', 03:17:13 INFO - 'XPC_SERVICE_NAME': '0', 03:17:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:13 INFO - Downloading/unpacking blobuploader==1.2.4 03:17:13 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 03:17:13 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 03:17:13 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 03:17:13 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 03:17:13 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 03:17:13 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 03:17:16 INFO - Downloading blobuploader-1.2.4.tar.gz 03:17:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:17:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:17:16 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 03:17:16 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 03:17:16 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 03:17:16 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 03:17:16 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 03:17:16 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 03:17:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:17:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:17:16 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 03:17:16 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 03:17:16 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 03:17:16 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 03:17:16 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 03:17:16 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 03:17:17 INFO - Downloading docopt-0.6.1.tar.gz 03:17:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:17:17 INFO - Installing collected packages: blobuploader, requests, docopt 03:17:17 INFO - Running setup.py install for blobuploader 03:17:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:17:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:17:17 INFO - Running setup.py install for requests 03:17:18 INFO - Running setup.py install for docopt 03:17:18 INFO - Successfully installed blobuploader requests docopt 03:17:18 INFO - Cleaning up... 03:17:18 INFO - Return code: 0 03:17:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:18 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 0x103571b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103574768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e695e5b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10334fd30>, '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 0x103275db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103344be8>, '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.2WaiHwqxTn/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.DFbwwLQ2nq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 03:17:18 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 03:17:18 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 03:17:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2WaiHwqxTn/Render', 03:17:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:18 INFO - 'HOME': '/Users/cltbld', 03:17:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:18 INFO - 'LOGNAME': 'cltbld', 03:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:18 INFO - 'MOZ_NO_REMOTE': '1', 03:17:18 INFO - 'NO_EM_RESTART': '1', 03:17:18 INFO - 'PAGER': '/bin/cat', 03:17:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:18 INFO - 'PWD': '/builds/slave/test', 03:17:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:18 INFO - 'SHELL': '/bin/bash', 03:17:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DFbwwLQ2nq/Listeners', 03:17:18 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 03:17:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:18 INFO - 'USER': 'cltbld', 03:17:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:18 INFO - 'XPC_FLAGS': '0x0', 03:17:18 INFO - 'XPC_SERVICE_NAME': '0', 03:17:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:17:18 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-iguHr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:17:18 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-gMPOQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:17:18 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-pGYomT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:17:18 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-skZokH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:17:19 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-FwQ3St-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:17:19 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-4YXPuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:17:19 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-bVWGXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:17:19 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-FfCgLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:17:19 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-YA0TOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:17:19 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-Rjf5X_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:17:19 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-G6tYPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:17:19 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-Hvnb2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:17:19 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-N5FKLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:17:19 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-Rx1OGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:20 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-8Tt0rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:17:20 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-PGYgIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:17:20 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-fpSQxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:17:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:17:20 INFO - Running setup.py install for manifestparser 03:17:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:17:20 INFO - Running setup.py install for mozcrash 03:17:20 INFO - Running setup.py install for mozdebug 03:17:20 INFO - Running setup.py install for mozdevice 03:17:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:17:20 INFO - Running setup.py install for mozfile 03:17:21 INFO - Running setup.py install for mozhttpd 03:17:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:17:21 INFO - Running setup.py install for mozinfo 03:17:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:17:21 INFO - Running setup.py install for mozInstall 03:17:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:17:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:17:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:17:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:17:21 INFO - Running setup.py install for mozleak 03:17:21 INFO - Running setup.py install for mozlog 03:17:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:17:21 INFO - Running setup.py install for moznetwork 03:17:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:17:21 INFO - Running setup.py install for mozprocess 03:17:22 INFO - Running setup.py install for mozprofile 03:17:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:17:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:17:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:17:22 INFO - Running setup.py install for mozrunner 03:17:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:17:22 INFO - Running setup.py install for mozscreenshot 03:17:22 INFO - Running setup.py install for moztest 03:17:22 INFO - Running setup.py install for mozversion 03:17:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:17:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:17:22 INFO - Cleaning up... 03:17:22 INFO - Return code: 0 03:17:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:22 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 0x103571b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103574768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e695e5b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10334fd30>, '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 0x103275db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103344be8>, '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.2WaiHwqxTn/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.DFbwwLQ2nq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 03:17:22 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 03:17:22 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 03:17:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2WaiHwqxTn/Render', 03:17:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:22 INFO - 'HOME': '/Users/cltbld', 03:17:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:22 INFO - 'LOGNAME': 'cltbld', 03:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:22 INFO - 'MOZ_NO_REMOTE': '1', 03:17:22 INFO - 'NO_EM_RESTART': '1', 03:17:22 INFO - 'PAGER': '/bin/cat', 03:17:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:22 INFO - 'PWD': '/builds/slave/test', 03:17:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:22 INFO - 'SHELL': '/bin/bash', 03:17:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DFbwwLQ2nq/Listeners', 03:17:22 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 03:17:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:22 INFO - 'USER': 'cltbld', 03:17:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:22 INFO - 'XPC_FLAGS': '0x0', 03:17:22 INFO - 'XPC_SERVICE_NAME': '0', 03:17:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:17:23 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-iLDRzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:17:23 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)) 03:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:17:23 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-hxfkIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:17:23 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)) 03:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:17:23 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-yZUYwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:17:23 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)) 03:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:17:23 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-_fLaBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 03:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:17:23 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-itDurF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:17:23 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)) 03:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:17:23 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-gZLcg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:17:23 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)) 03:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:17:23 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-ycjdQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:17:23 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)) 03:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:17:23 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-w8hC6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:17:23 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)) 03:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:17:23 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-ss575t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:17:24 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)) 03:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:17:24 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-rmpvj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:17:24 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)) 03:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:17:24 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-9mA51o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:17:24 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)) 03:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:17:24 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-XZXlaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:17:24 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)) 03:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:17:24 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-wN8KCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:17:24 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)) 03:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:17:24 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-OUA0I1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:17:24 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)) 03:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:24 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-sB8sxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:24 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)) 03:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:17:24 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-dJ4EiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:17:24 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)) 03:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:17:24 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-H20Krt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:17:24 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)) 03:17:24 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)) 03:17:24 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)) 03:17:24 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)) 03:17:24 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:17:24 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:17:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:17:24 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 03:17:24 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 03:17:24 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 03:17:24 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 03:17:24 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 03:17:24 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 03:17:27 INFO - Downloading blessings-1.6.tar.gz 03:17:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:17:27 INFO - Installing collected packages: blessings 03:17:27 INFO - Running setup.py install for blessings 03:17:27 INFO - Successfully installed blessings 03:17:27 INFO - Cleaning up... 03:17:28 INFO - Return code: 0 03:17:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:17:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:17:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:17:28 INFO - Reading from file tmpfile_stdout 03:17:28 INFO - Current package versions: 03:17:28 INFO - blessings == 1.6 03:17:28 INFO - blobuploader == 1.2.4 03:17:28 INFO - docopt == 0.6.1 03:17:28 INFO - functools32 == 3.2.3-2 03:17:28 INFO - jsonschema == 2.5.1 03:17:28 INFO - manifestparser == 1.1 03:17:28 INFO - mozInstall == 1.12 03:17:28 INFO - mozcrash == 1.0 03:17:28 INFO - mozdebug == 0.1 03:17:28 INFO - mozdevice == 0.50 03:17:28 INFO - mozfile == 1.2 03:17:28 INFO - mozhttpd == 0.7 03:17:28 INFO - mozinfo == 0.9 03:17:28 INFO - mozleak == 0.1 03:17:28 INFO - mozlog == 3.4 03:17:28 INFO - moznetwork == 0.27 03:17:28 INFO - mozprocess == 0.25 03:17:28 INFO - mozprofile == 0.28 03:17:28 INFO - mozrunner == 6.13 03:17:28 INFO - mozscreenshot == 0.1 03:17:28 INFO - mozsystemmonitor == 0.3 03:17:28 INFO - moztest == 0.8 03:17:28 INFO - mozversion == 1.4 03:17:28 INFO - psutil == 3.1.1 03:17:28 INFO - requests == 1.2.3 03:17:28 INFO - wsgiref == 0.1.2 03:17:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:17:28 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')]} 03:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:28 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')]} 03:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:28 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 0x103571b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103574768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e695e5b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10334fd30>, '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 0x103275db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103344be8>, '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.2WaiHwqxTn/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.DFbwwLQ2nq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 03:17:28 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 03:17:28 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 03:17:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2WaiHwqxTn/Render', 03:17:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:28 INFO - 'HOME': '/Users/cltbld', 03:17:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:28 INFO - 'LOGNAME': 'cltbld', 03:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:28 INFO - 'MOZ_NO_REMOTE': '1', 03:17:28 INFO - 'NO_EM_RESTART': '1', 03:17:28 INFO - 'PAGER': '/bin/cat', 03:17:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:28 INFO - 'PWD': '/builds/slave/test', 03:17:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:28 INFO - 'SHELL': '/bin/bash', 03:17:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DFbwwLQ2nq/Listeners', 03:17:28 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 03:17:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:28 INFO - 'USER': 'cltbld', 03:17:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:28 INFO - 'XPC_FLAGS': '0x0', 03:17:28 INFO - 'XPC_SERVICE_NAME': '0', 03:17:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:28 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)) 03:17:28 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)) 03:17:28 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)) 03:17:28 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)) 03:17:28 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)) 03:17:28 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)) 03:17:28 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)) 03:17:28 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)) 03:17:28 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)) 03:17:28 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)) 03:17:28 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)) 03:17:28 INFO - Cleaning up... 03:17:28 INFO - Return code: 0 03:17:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:17:28 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')]} 03:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:28 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')]} 03:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:28 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 0x103571b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103574768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e695e5b80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10334fd30>, '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 0x103275db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103344be8>, '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.2WaiHwqxTn/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.DFbwwLQ2nq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 03:17:28 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 03:17:28 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 03:17:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2WaiHwqxTn/Render', 03:17:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:28 INFO - 'HOME': '/Users/cltbld', 03:17:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:28 INFO - 'LOGNAME': 'cltbld', 03:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:28 INFO - 'MOZ_NO_REMOTE': '1', 03:17:28 INFO - 'NO_EM_RESTART': '1', 03:17:28 INFO - 'PAGER': '/bin/cat', 03:17:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:28 INFO - 'PWD': '/builds/slave/test', 03:17:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:28 INFO - 'SHELL': '/bin/bash', 03:17:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DFbwwLQ2nq/Listeners', 03:17:28 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 03:17:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:28 INFO - 'USER': 'cltbld', 03:17:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:28 INFO - 'XPC_FLAGS': '0x0', 03:17:28 INFO - 'XPC_SERVICE_NAME': '0', 03:17:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:17:28 INFO - Cleaning up... 03:17:28 INFO - Return code: 0 03:17:28 INFO - Running post-action listener: _resource_record_post_action 03:17:28 INFO - Running post-action listener: _start_resource_monitoring 03:17:28 INFO - Starting resource monitoring. 03:17:28 INFO - [mozharness: 2017-04-28 10:17:28.858594Z] Finished create-virtualenv step (success) 03:17:28 INFO - [mozharness: 2017-04-28 10:17:28.859539Z] Running install step. 03:17:28 INFO - Running pre-action listener: _resource_record_pre_action 03:17:28 INFO - Running main action method: install 03:17:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:17:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:17:29 INFO - Reading from file tmpfile_stdout 03:17:29 INFO - Detecting whether we're running mozinstall >=1.0... 03:17:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:17:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:17:29 INFO - Reading from file tmpfile_stdout 03:17:29 INFO - Output received: 03:17:29 INFO - Usage: mozinstall [options] installer 03:17:29 INFO - Options: 03:17:29 INFO - -h, --help show this help message and exit 03:17:29 INFO - -d DEST, --destination=DEST 03:17:29 INFO - Directory to install application into. [default: 03:17:29 INFO - "/builds/slave/test"] 03:17:29 INFO - --app=APP Application being installed. [default: firefox] 03:17:29 INFO - mkdir: /builds/slave/test/build/application 03:17:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:17:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 03:17:48 INFO - Reading from file tmpfile_stdout 03:17:48 INFO - Output received: 03:17:48 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:17:48 INFO - Running post-action listener: _resource_record_post_action 03:17:48 INFO - [mozharness: 2017-04-28 10:17:48.890586Z] Finished install step (success) 03:17:48 INFO - [mozharness: 2017-04-28 10:17:48.890729Z] Running run-tests step. 03:17:48 INFO - Running pre-action listener: _resource_record_pre_action 03:17:48 INFO - Running main action method: run_tests 03:17:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:17:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:17:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:17:48 INFO - 2017-04-28 03:17:48.905 screenresolution[1626:7313] starting screenresolution argv=screenresolution get 03:17:48 INFO - 2017-04-28 03:17:48.907 screenresolution[1626:7313] Display 0: 1600x1200x32@60 03:17:48 INFO - 2017-04-28 03:17:48.913 screenresolution[1627:7316] starting screenresolution argv=screenresolution list 03:17:48 INFO - Available Modes on Display 0 03:17:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:17:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:17:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:17:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:17:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:17:49 INFO - Intel Iris: 03:17:49 INFO - Chipset Model: Intel Iris 03:17:49 INFO - Type: GPU 03:17:49 INFO - Bus: Built-In 03:17:49 INFO - VRAM (Dynamic, Max): 1536 MB 03:17:49 INFO - Vendor: Intel (0x8086) 03:17:49 INFO - Device ID: 0x0a2e 03:17:49 INFO - Revision ID: 0x0009 03:17:49 INFO - Displays: 03:17:49 INFO - Display: 03:17:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:17:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:17:49 INFO - Display Serial Number: 1600x1200 60 03:17:49 INFO - Main Display: Yes 03:17:49 INFO - Mirror: Off 03:17:49 INFO - Online: Yes 03:17:49 INFO - Rotation: Supported 03:17:49 INFO - Return code: 0 03:17:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:17:49 INFO - Python 2.7.3 03:17:49 INFO - Return code: 0 03:17:49 INFO - grabbing minidump binary from tooltool 03:17:49 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')]} 03:17:49 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 0x10334fd30>, '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 0x103275db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103344be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:17:49 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 03:17:49 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 03:17:49 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 03:17:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:17:49 INFO - Return code: 0 03:17:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:17:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:17:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:17:49 INFO - ENV: RUST_BACKTRACE is now 1 03:17:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:17:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:17:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0274', '--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 03:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0274 --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 03:17:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2WaiHwqxTn/Render', 03:17:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:49 INFO - 'HOME': '/Users/cltbld', 03:17:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:49 INFO - 'LOGNAME': 'cltbld', 03:17:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:17:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:49 INFO - 'MOZ_NO_REMOTE': '1', 03:17:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:17:49 INFO - 'NO_EM_RESTART': '1', 03:17:49 INFO - 'PAGER': '/bin/cat', 03:17:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:49 INFO - 'PWD': '/builds/slave/test', 03:17:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:17:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:49 INFO - 'RUST_BACKTRACE': '1', 03:17:49 INFO - 'SHELL': '/bin/bash', 03:17:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DFbwwLQ2nq/Listeners', 03:17:49 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 03:17:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:49 INFO - 'USER': 'cltbld', 03:17:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:49 INFO - 'XPC_FLAGS': '0x0', 03:17:49 INFO - 'XPC_SERVICE_NAME': '0', 03:17:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0274', '--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 03:17:49 INFO - mozversion application_buildid: 20170428013726 03:17:49 INFO - mozversion application_changeset: 8f2b930cd02842fa1ca884be447a5bbff4ba1b9b 03:17:49 INFO - mozversion application_display_name: Nightly 03:17:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:17:49 INFO - mozversion application_name: Firefox 03:17:49 INFO - mozversion application_remotingname: firefox 03:17:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:17:49 INFO - mozversion application_vendor: Mozilla 03:17:49 INFO - mozversion application_version: 55.0a1 03:17:49 INFO - mozversion platform_buildid: 20170428013726 03:17:49 INFO - mozversion platform_changeset: 8f2b930cd02842fa1ca884be447a5bbff4ba1b9b 03:17:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:17:49 INFO - mozversion platform_version: 55.0a1 03:17:49 INFO - using testdate: 1493374669 03:17:49 INFO - actual date: 1493374669 03:17:49 INFO - starting webserver on 'localhost:49231' 03:17:49 INFO - SUITE-START | Running 2 tests 03:17:49 INFO - TEST-START | dromaeo_css 03:17:49 INFO - operating with platform_type : mac_ 03:17:49 INFO - Initialising browser for dromaeo_css test... 03:17:49 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpnFkgWg/profile http://localhost:49231/getInfo.html) 03:17:52 INFO - PID 1637 | __metrics Screen width/height:1600/1200 03:17:52 INFO - PID 1637 | colorDepth:24 03:17:52 INFO - PID 1637 | Browser inner width/height: 1024/689 03:17:52 INFO - PID 1637 | __metrics 03:17:52 INFO - PID 1637 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:17:52 INFO - PID 1637 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:17:53 INFO - TEST-INFO | 1637: exit 0 03:17:53 INFO - Browser initialized. 03:17:53 INFO - Running cycle 1/1 for dromaeo_css test... 03:17:53 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpnFkgWg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:18:05 INFO - PID 1639 | RSS: Main: 242159616 03:18:05 INFO - PID 1639 | 03:21:11 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49231/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49231/tests/dromaeo/cssquery-ext.html) 03:21:12 INFO - PID 1639 | RSS: Main: 381460480 03:21:12 INFO - PID 1639 | 03:22:55 INFO - PID 1639 | ************************* 03:22:55 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 03:22:55 INFO - PID 1639 | 03:22:55 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:22:55 INFO - PID 1639 | Full stack: 03:22:55 INFO - PID 1639 | ************************* 03:22:55 INFO - PID 1639 | ************************* 03:22:55 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 03:22:55 INFO - PID 1639 | 03:22:55 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:22:55 INFO - PID 1639 | Full stack: 03:22:55 INFO - PID 1639 | ************************* 03:22:55 INFO - PID 1639 | ************************* 03:22:55 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 03:22:55 INFO - PID 1639 | 03:22:55 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:22:55 INFO - PID 1639 | Full stack: 03:22:55 INFO - PID 1639 | ************************* 03:22:55 INFO - PID 1639 | ************************* 03:22:55 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 03:22:55 INFO - PID 1639 | 03:22:55 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:22:55 INFO - PID 1639 | Full stack: 03:22:55 INFO - PID 1639 | ************************* 03:24:15 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49231/tests/dromaeo/cssquery-ext.html (next: http://localhost:49231/tests/dromaeo/cssquery-jquery.html) 03:24:15 INFO - PID 1639 | RSS: Main: 363483136 03:24:15 INFO - PID 1639 | 03:27:17 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49231/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49231/tests/dromaeo/cssquery-mootools.html) 03:27:18 INFO - PID 1639 | RSS: Main: 358092800 03:27:18 INFO - PID 1639 | 03:30:20 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49231/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49231/tests/dromaeo/cssquery-prototype.html) 03:30:21 INFO - PID 1639 | RSS: Main: 358715392 03:30:21 INFO - PID 1639 | 03:33:25 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49231/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49231/tests/dromaeo/cssquery-yui.html) 03:33:25 INFO - PID 1639 | RSS: Main: 336121856 03:33:25 INFO - PID 1639 | 03:36:28 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49231/tests/dromaeo/cssquery-yui.html (next: http://localhost:49231/tests/dromaeo/cssquery-dojo.html) 03:36:28 INFO - PID 1639 | RSS: Main: 380051456 03:36:28 INFO - PID 1639 | 03:36:28 INFO - PID 1639 | __start_tp_report 03:36:28 INFO - PID 1639 | _x_x_mozilla_page_load 03:36:28 INFO - PID 1639 | _x_x_mozilla_page_load_details 03:36:28 INFO - PID 1639 | |i|pagename|runs| 03:36:28 INFO - PID 1639 | |0;dojo.html;3389.9322013559745;3481.3385456763212;3518.5425894633695;3554.3424466473703;3556.893293201205;5833.387494313089;6034.6379217246995;6062.818115456533;6095.573309868311;6125.448709616134;6026.668533230671;6079.057746049359;6100.5206187869435;6110.285381942539;6124.479419249369;5065.721385323805;5067.39191297043;5221.2951251580935;5233.03188910051;5302.045631786277;5256.185291279858;5298.788048478056;5312.840614781563;5314.734263286839;5324.1215199492035;5130.4356520782685;5199.324087868553;5221.817236396746;5221.869453263661;5257.921131183035;5233.947660523422;5264.947350526522;5283.788648454057;5286.814961476368;5290.947090529084;5208.947910520922;5214.8174813881715;5222.712750798704;5246.213068039825;5290.973545132289;5855.531557475434;5950.940490595125;6027.186329845503;6062.575619706622;6081.452669259744;6303.779367722108;6378.425941665226;6454.548181627288;6462.709178086998;6469.83825404364;6441.935580644181;6452.161219041494;6454.612723236574;6456.418922297016;6458.515611329169;6082.391760823971;6140;6149.815505534841;6159.599626024294;6159.692015399212;6394.328595497499;6478.125453063871;6545.836354091186;6658;6695.631740254333;6169.198004259418;6262.5616206866;6275.905861412082;6282.748690052438;6284;5295.470452954751;6295.276043254993;6321.1150438938585;6421.229452465734;6527.086207930894;6354.3010268870385;6360.84097897547;6367.61794292344;6372.107904893319;6386.648734319564;6278.340774218641;6352.6823658816875;6375.234971803413;6383.904241436382;6389.9680501597195;3951.78265195417;4955.950440495621;5115.923261151086;5130.204818253177;5146.356705411824;4567.954320456819;4626.930596041062;4633.976830115896;4645.442546894395;4675.625949923998;6094.839609484032;6133.1413602095745;6156;6158.076288556663;6160.445559899541;6483.805485835433;6495.7076931538195;6507.414332710079;6509.804705858832;6519.902201466982;5980.521558275327;6089.056196289582;6097.359777223416;6104.450599445982;6166.105914642351;5669.34802497718;5674.4892959633835;5683.147527870769;5689.544836413077;5717.485426311652;6601.603903765789;6686.197656281277;6714.764983225564;6714.899276510759;6719.664016799141;6300.653464059521;6383.904241436289;6533.640649764308;6535.856225160673;6540.967295163494;6621;6690.364415380531;6707.195136583641;6709.865802683821;6728.831779205559;6355.5551111421755;6356;6364.4908407326375;6377.617342959437;6394.552381333262;5622.662640241599;6274.466670333073;6309.211348581427;6365.331640177715;6475.676216189266;6249.406306400884;6260.154879091265;6286.277078136073;6343;6351.301356850835;6299.96850015747;6333.714982825692;6349.777757778455;6351.745930162927;6354.618722876642;6112.351504965139;6113.506711826627;6198.783042593487;6201.410865967726;6285.685715714105;6300.779472718433;6315.905261421174;6320.4311611955145;6325.588836725598;6326.9683651581445;4985.9501404985485;6200.162977997912;6236.18929539157;6238.157848690369;6238.500919926486 03:36:28 INFO - PID 1639 | |1;ext.html;769.1885061260372;798.3453568074178;804.0512195609181;1124.8425220469135;1135.1713249327995;26771.732282677192;33711.83144084279;37121.21590880688;37200;37374;39379.015524611896;39723.80138099313;39756.80121599395;39768.602313976924;39770.403443948366;8300.50196988181;8469.32245420365;8474.44916080456;8474.618642161118;8474.78813029673;6000.8499787505225;6091.817245482643;8351.83296334073;8518.659253629847;8527.275181609572;8485.278751306147;8562.100979397166;8564.528950907728;8573.271271941861;8618.913810861874;8484.321254299672;8534.103919088468;8551.401401901869;8565.657373705075;8580.699675511327;8422.957885210595;8469;8469.407141500098;8482.066972633005;8490.575471226475;37124.88625341244;37165.62834371649;37199.44200836989;37204.25591488182;37242.81378593117;3579.7673151245085;3597.1366871950804;3599.6580324869096;3601.0637234319265;3606.278744251134;30646.84676576625;30654.693453065407;30718.692813071808;30727;30772.846135769403;3059.5410688396696;3092.9845350773103;3127.6403213630497;3136.40408322418;3139.780215384901;292120;297115;298528.99999999785;300600;302356;49254.75372623114;49356.01287974221;49410;49476.5157045282;49512;50326.49673503218;50382.49617503851;50497.49502505001;50505.747471263145;50510;13860.930695346458;13949.790753138712;13950.93024534891;13965.58103256904;13974;9828.16460600857;11369.715757106138;11392.487338069806;11402.486888090056;11403;10427.374357538572;10502.68491945243;10505.31715438494;10506.632267870587;10509.421981790922;5030.195168772979;5231.267622532849;5235.214717792285;5260.789568417297;5278.97360513195;1032.6540608895955;1038.5326603028668;1040.157472447305;1068.5191663751343;1077.6605369308643;18726.625467490572;23467.647985280233;23517.41206469852;24629.50740985206;24725.381865453506;1141.5148561861176;1142.9771404572027;1180.2387460088196;1186.925832121931;1190.4821402689859;12184.329861857506;12585.867271945568;12586.244825310327;12691.238525688488;12706.618801435972;314459;314898;315682;315961.42019289755;316190;53496.930061398554;53671;53672.463275367525;53789;53806.461935380146;1489.0470099136778;1502.4741340530727;1534.294224656648;1534.9386024559117;1554.0442627784057;23956.92193851316;24003.879980599984;24132;24133.63799542973;24166.033358665456;37042.444363334034;37045.259094818495;37065.888023359345;37070.44394334141;37186.442203367515;291791;292126.0787392099;292335;292881;293325;32283;33167;33392.833035834665;33408.83295583507;33473;35722.928312150674;36224.818875905454;36547.72082977083;36574.817125914204;43576.12847742964;26322.683974551874;27133.72866271312;28437.857810710815;30188.79244830182;30366.392672146874;27780;29978.70021299759;29996.700033000263;30133.589312855358;30495.542566861957;36177.27645447024;36181.09547261339;36222.8188859054;36347.63652363443;36388.27223455463;28600.713992859804;28993.85503072471;29519;30673.773049078678;30732.23169420693;17746.592660193244;23788.643170352112;23797.167099151447;23922.52154956926;24614.50770984606 03:36:28 INFO - PID 1639 | |2;jquery.html;387.6511139974025;417.3385184482595;427.2906974422459;433.61841579410117;445.4076078815175;19661.901690491562;21502.139914403426;22167.667484987738;22248.555028899453;22283.44291392716;21537.46156346092;23151.884240578773;23305.9507510368;23430.5313893722;23546.411339716517;5902.734376953037;6195.349488303731;6198.78304259351;6202.658853763064;6213.596116252429;4635.304704294366;5748.856278593027;6110.786122485714;6123.142760013579;6202.78290259841;5885.4997325227405;6150.292716337612;6150.630962142263;6167.907481387782;6176.9691151544175;4721.622270218391;6084.452399284086;6113.052476866093;6115.510759139281;6123.724432400552;5174.3790745110455;5375.381831089397;5440.265564148829;5440.727963601804;5443;27160.45679086407;27349.45301093987;27377.863110684517;27386.45227095467;27647.44705105907;2176.662617294322;2232.3191426614876;2242.125571027301;2243.1588154442084;2248.336740661509;17317.307307707677;17584.29662813486;18135.36526221589;18211.18049687767;18212.726809097872;2148.4628842789302;2159.7840215978435;2170.750363708178;2186.311311936751;2186.5517568898335;169259.30740692682;171777;171931.28068719278;172028.41957370524;173140;12370.62888113358;12489.50041998328;12576.81134782979;12609.180403273758;12798.104132710621;16732.83267167337;16749.246283917008;16755.91622041882;16762.245698943578;16819.579510512336;8669.956650216709;8893.421927574816;8939.374243803002;8975.32685048611;9099.954500227457;8502.702405415781;8503.447275927045;8514.14858514156;8672.176143266379;8715.34634902372;6474.417302442803;7703.768886933401;7839.176886426843;7888.921110788819;7895.171007044292;1879.2764785557385;2098.880131067602;2127.2022991378235;2132.581833081015;2300.700908881868;911.6672414568635;930.3022732950287;946.1720994130136;950.9714708558754;968.8340137409112;20053.39839804808;20511.4872128198;20563;20583;20981.790182098288;920.5213289089636;958.5734348215117;961.1349785193382;1004.1565085328359;1004.5630150884389;7880.527168369917;10530.789384212272;10544.26190166681;10562.841557376645;10681.626143084955;501060;510155;521245;521892.17161742604;522175.1673724897;126096.36951815366;129671.35164324119;131006;131617;135514.6121346974;1137.5904674317073;1144.1361771862191;1181.8699943006263;1182.9585964491203;1185.8991985681314;17744.46766597004;17838.5540361492;17855.553611159827;18049.1877865499;18381.81618183801;56995.71502142463;57307.713461432424;57540.65660479291;57765.422345776;58402.45176708206;73227.26772732205;75581.62209188919;77787;78309;80093;6608.933910660832;7351.963240183765;8525.573721314033;8606.407814554328;9031.006589275306;14161;14284.500042498463;14453.49412770548;14456.494022709154;14571.907106966808;11179.888201117885;11634.70913227176;12129.939350303192;12243.571474998333;12252.571160009356;10186.847197292194;11250.437478126225;11254.930781575737;11414.82877756851;11596.420178990847;11697.181197316106;11812.468438920441;12135;12161;12247.142700010914;8712.825743484967;8774.808097681253;9163.312751543794;9168.174864262248;9185.632574697205;9604.471754053595;10677.878822723813;11622;11691.760862982024;12172.57395991136 03:36:28 INFO - PID 1639 | |3;mootools.html;1071.785642871425;1407.162738170788;1435.7200345932547;1436.030679291478;1469.2506821521024;9679.225661947045;10193.23550733695;11143.554257829677;11846.052315814735;11879.524819007229;11352.091832653388;11440.084793216543;11456.71358216045;11459.828102578447;11472.598459053936;2211.5466329402516;2477.863717495537;2529.8735063246854;2533.2020413569667;2535.5816290312077;2110.387987483628;2199.52710167314;2460.7416221296776;2535.290118766748;2554.0932968796087;2469.407342237868;2476.925692229236;2500.087468074149;2509.2221411362443;2512.309114993382;2477.1453848422266;2491.875406229681;2493.2395619336094;2494.164454907599;2496.6879140107485;2416.081888882231;2446.559619268531;2447.669564608773;2448.52253810507;2448.6204638281097;11298.378589177591;11332;11459.083273338112;11461.197716159872;11466;6504.739810407578;6754.088198093293;6756.986452032185;6760.526763126583;6771.661416929183;3677.2257286151566;4126;4238.109996900655;4283.0363168286885;4302.397664326997;1245.9003279737599;1257.4655771297253;1270.28863836252;1287.8905293050102;1302.446460254388;16721.247543860554;16754.162291885477;16770.74843877343;16806;16824.57938551546;5757.769689212385;5929.792457263975;5943.881122377615;6053.818385448443;6054.273487181478;13807.309634518233;13815.792763108562;13831.723365532633;13844.723105537832;13862.02965792405;6807.965960170168;6838.623875686785;6841.144856892888;6841.828954276183;6843.486738494633;5297;6088.969555152196;6228.626282423069;6229;6277.748890044439;3568.357695614762;4208.537060923296;4552.590266875931;4658.790354433991;4682.74244916526;1377.3870627570634;1409.8801601863956;1428.6999730056805;1435.1102316563797;1437.3460075665548;790.3756032734191;800.5949558524752;809.639710328898;810.943233973628;831.1771346367053;6223;6382.234131904202;6439.388258115471;6746.763863264762;6835.829104272333;769.8537277917178;903.9638414463348;918.1507105927125;935.8783358163395;938.7512309238058;3709.46212799148;3769.830357633858;3801.904952376213;3805.5243094613174;3859.4789703390243;14579.343929523196;15245.16151611672;15259.08445493274;15278.694426111415;15279.770803437958;14563;14933.850661493463;15154.696906061818;15164;15172.544823655307;8469.026062002826;8660.783480412914;8723.781905452288;8738.69414570487;8739.12608739121;6512.446442052289;6696.363845434676;6744.730210791709;6784.491163162684;6812.489063320171;13327.933360333136;13430.865691342962;13547.689652778748;13672.726545469233;13704.862951370758;13656.453741850612;14074.296285185905;14088;14113.717725645634;14188.787168192279;9035.232005279362;9153.130452606993;9194.632214711337;9203.033681463618;9297.163255307054;9196.12636799503;9462.243020558477;9477.383970041925;10161.898381016392;10476.895231047896;8025.8394832104195;9075.13786190311;9131.726048218565;9285.025072367574;9366.953165234403;8714.302855771397;8871.645134194818;8953.462792232487;9002.594883230402;9015.188633023059;8065.596720163851;8172.223638754309;8261.545614990993;8264.256216940505;8264.297534709376;5030.647854650139;5868.501177399798;6071.180390647206;6118.20463339763;6129.84675383119;4719.7404142772475;5959;5995.95070862606;6093.695315234309;6303.779367722108 03:36:28 INFO - PID 1639 | |4;prototype.html;322.61286456252486;402.3923874948827;410.8644147431348;412.6451251923347;417.3968615350818;4859.611231101512;5743.368229494752;5869.383714709958;6026.578139530229;6034.125051867482;5725.742341594628;5754.251947246862;5762.308522977249;5820.330661973874;5853.405077014544;4109.856155034567;4348.108637729274;4464.933026004613;4512.481064677555;4527.234378592351;4042.959570404302;4131.338985762279;4307.224699554079;4324.82700691972;4336;4082.1835632873544;4135.193637240739;4151.875443736692;4239.130978149472;4267.037162905068;3308.7353011759;3351.949720754191;4188.612490880199;4197.3703944408435;4261.211675839949;2985.970140298591;3664.486971823947;3679.6872265857432;3683.778973261586;3694.8891533254045;4641.164590373732;5226.895462090775;5589.888202235973;5695.345035320908;5738.368779434259;4985.376827896513;4999.450170447173;5007.84976450707;5041.8487445376695;5060.5951523878;5090.77091530882;6185.7317651759;6220.631461078556;6247.406496382836;6290.559660823744;4096.078382363974;4120.896977575555;4133.1940271647045;4172.395002724588;4184.3932629768515;6565.474762019027;6607.471402287805;6615.404613584752;6619.238787539398;6640.7675731349655;3838.9424158637644;3895.8052097395584;4161.375793630919;4176.290030694729;4188.476440444944;4131.876043718693;4196.223698615766;4257.5529569395385;4263.616274535307;4291.6566674665955;4152.771597562163;5009.373828271466;5028;5039.193729003342;5051.898962020812;5432.91850622241;5762.942370576325;5937.6734279614175;6054.940385432532;6329.620222786648;1178.885952774637;1450.3473436953414;1450.8331541872608;1459.9708005840037;1463.5389852196524;789.8547106695315;863.6890719341033;915.6402741928231;946.7207173883721;948.4025064209504;4958.925616115761;5043.873903152377;5882.441168089024;5960.76156953717;5971.940280597225;6054.666993315322;6288.748450062038;6355.968220158962;6415.582987105823;6423.871522569522;5211.5049070338255;5633.8591535211945;5843.2695913010875;5953.434423729739;5963.7912673056235;3231.5475833383343;3267.4772036474524;3396.8980930572125;3397.793783206975;3399.7280217582534;5777.62445441045;6344.651044192521;6556.967215163989;6748;6794.607105543352;6774.051632771416;6796.8300792479595;6798.456123510107;6801.65991700413;6825.590464572141;5925.614835035709;6638.83402914931;6748.122744043341;6833.4191593715095;6843.520953533304;5455.699936503531;6604.207495100619;6610.206775186816;6618.305077966937;6618.371254730793;5410.945890541044;6332.176817013758;6453.160369580092;6522.902156467562;6524.3149469305035;5551.8889622208135;6737.494687898526;6795.660216989229;6798.694058767268;6832.863342733018;4182.9581704182565;4226.4928208615165;4231.703780735442;4233.91532169361;4241.618254356999;5438.945610543844;5559.972200138974;6229.0100751638565;6382.872342553216;6428.903566446414;6233.625982440886;6240.313565507699;6255.093011513396;6262.405071518198;6263.342349053466;5325.440828713085;6158.337248942671;6271.3728627136925;6326.9683651581445;6358.601107756286;4899.39456910503;5042.420121686053;5361.651492652965;5874.030784920611;6266.530010249158;5487.807926722546;6342.207224096988;6349.111124442489;6355.491560675043;6364.140840986593;5072.54347108762;5748.626339287933;5994.28068631767;6191.721372538336;6226.906596401148 03:36:28 INFO - PID 1639 | |5;yui.html;702.097804321447;849.9660013599456;856.272168656642;857.2242120880601;871.559862269554;13299.002574806891;17588.64822703545;17978.280868765265;18621.068946552685;18707;16950;17122.571935701613;17433.21550530226;17465.126743662797;17493.7375939361;722.8012296618433;940.3793496292449;941.1200527506803;941.3833938770116;942.8632848237002;666.3536369721362;682.4335801284947;980.2794945714894;989.579428742785;999.4253304350028;1049.821530339844;1050.6742909698019;1051.7002654243543;1052.5737076483997;1054.3726482742757;1045.0229035851503;1048.7378155461097;1049.2812423489856;1050.186105768036;1057.2070946789909;771.9189485104096;772.1853444615928;772.4940164192462;775.6121939030485;780.1808101493409;16314.75527867083;16602.58493537659;16700.66598668032;16782.83217167825;17009.404670836462;16302.673946521003;16396.67206655872;16559;16923.661526769396;17081.316747330093;13763.655908602264;13957.720845583133;14005.719885602231;14153.08004979673;14186.858131418658;3371.7134043606325;3393.5588373511287;3397.5073614326034;3404.472306792451;3410.4884267360094;119593.99999999913;119626;120707.81671963343;121971.39014304872;123596;12136.635900922987;12136.635900922987;12161.756764864831;12194.451249693786;12356.011519078453;20464.897675511525;20586;20801.063952121887;20801.791982079987;20814.063367148516;7634.427417943676;7710.151883292833;7722.691092356243;7724.227577242344;7728.536287822749;3903.863364782219;3950.822213000422;3958.188571342868;3974.7615143091507;3994.900127496836;4197.664186865043;4282.1221649562385;4282.528921818597;4283.935740963888;4293.3130699088;819.9098099209082;853.8121613245077;857.8756080368312;860.2172023458622;860.8407444622765;651.7653644687908;655.5607742812327;665.3014334948285;672.9596224226563;686.4062585863293;11011.449427528592;11654.650360489199;11696.729435084242;11928.642140735792;12022.098342624338;487.2642310111757;646.5538778242998;659.7328082126746;661.4708233413251;679.5922446532041;5578.135389014709;5587.329520457572;5966;6046.758129674852;6132.787130938756;112781;114085;115128.42435787935;116247;116804;81945.59027204826;84069.57965210258;88389.11610883809;88870.11129888748;89825.55087224653;60279.09581356283;75352;76003;80256.19743802487;83920;10587;12247.571335003233;12280.447379867748;12648.177868438523;12705.872941270469;39120.6087939117;40571.1885762289;40905.38641920314;41417.171656567305;41901.74294771162;52637.7368113157;53467;53580.46419535755;54167.18749218686;54178.729106354214;15958.8404115962;15962.60093497672;16550.42073527421;16782.993020418326;16837.66324673475;15586.454474093352;17618.207180676643;17804.732929005815;17854.821451785316;18064.548386290448;16219.837801621832;16265.918670407045;16457.506274811774;16601;16795;16193.433229836899;16639.584010399838;16681.666366672354;16721.749173762648;16890;15539.766903496231;16169.75745363844;16375.099369534313;16427.17864106766;17457.214425350634;10144.28989970695;11093;11181.105511559219;11571.132165087483;11715.531378744754;13502.32488375597;13835.308234588432;14037.368318425491;14051.156930584199;14057.859421405656 03:36:28 INFO - PID 1639 | __end_tp_report 03:36:28 INFO - PID 1639 | __start_cc_report 03:36:28 INFO - PID 1639 | _x_x_mozilla_cycle_collect,1427 03:36:28 INFO - PID 1639 | __end_cc_report 03:36:28 INFO - PID 1639 | __startTimestamp1493375788428__endTimestamp 03:36:28 INFO - PID 1639 | 03:36:28 INFO - PID 1639 | ------- Summary: start ------- 03:36:28 INFO - PID 1639 | Number of tests: 6 03:36:28 INFO - PID 1639 | 03:36:28 INFO - PID 1639 | [#0] dojo.html Cycles:165 Average:5938.19 Median:6200.16 stddev:701.96 (11.3%) stddev-sans-first:675.05 03:36:28 INFO - PID 1639 | Values: 3389.9 3481.3 3518.5 3554.3 3556.9 5833.4 6034.6 6062.8 6095.6 6125.4 6026.7 6079.1 6100.5 6110.3 6124.5 5065.7 5067.4 5221.3 5233.0 5302.0 5256.2 5298.8 5312.8 5314.7 5324.1 5130.4 5199.3 5221.8 5221.9 5257.9 5233.9 5264.9 5283.8 5286.8 5290.9 5208.9 5214.8 5222.7 5246.2 5291.0 5855.5 5950.9 6027.2 6062.6 6081.5 6303.8 6378.4 6454.5 6462.7 6469.8 6441.9 6452.2 6454.6 6456.4 6458.5 6082.4 6140.0 6149.8 6159.6 6159.7 6394.3 6478.1 6545.8 6658.0 6695.6 6169.2 6262.6 6275.9 6282.7 6284.0 5295.5 6295.3 6321.1 6421.2 6527.1 6354.3 6360.8 6367.6 6372.1 6386.6 6278.3 6352.7 6375.2 6383.9 6390.0 3951.8 4956.0 5115.9 5130.2 5146.4 4568.0 4626.9 4634.0 4645.4 4675.6 6094.8 6133.1 6156.0 6158.1 6160.4 6483.8 6495.7 6507.4 6509.8 6519.9 5980.5 6089.1 6097.4 6104.5 6166.1 5669.3 5674.5 5683.1 5689.5 5717.5 6601.6 6686.2 6714.8 6714.9 6719.7 6300.7 6383.9 6533.6 6535.9 6541.0 6621.0 6690.4 6707.2 6709.9 6728.8 6355.6 6356.0 6364.5 6377.6 6394.6 5622.7 6274.5 6309.2 6365.3 6475.7 6249.4 6260.2 6286.3 6343.0 6351.3 6300.0 6333.7 6349.8 6351.7 6354.6 6112.4 6113.5 6198.8 6201.4 6285.7 6300.8 6315.9 6320.4 6325.6 6327.0 4986.0 6200.2 6236.2 6238.2 6238.5 03:36:28 INFO - PID 1639 | 03:36:28 INFO - PID 1639 | [#1] ext.html Cycles:180 Average:44714.53 Median:316075.71 stddev:79343.34 (25.1%) stddev-sans-first:79497.31 03:36:28 INFO - PID 1639 | Values: 769.2 798.3 804.1 1124.8 1135.2 26771.7 33711.8 37121.2 37200.0 37374.0 39379.0 39723.8 39756.8 39768.6 39770.4 8300.5 8469.3 8474.4 8474.6 8474.8 6000.8 6091.8 8351.8 8518.7 8527.3 8485.3 8562.1 8564.5 8573.3 8618.9 8484.3 8534.1 8551.4 8565.7 8580.7 8423.0 8469.0 8469.4 8482.1 8490.6 37124.9 37165.6 37199.4 37204.3 37242.8 3579.8 3597.1 3599.7 3601.1 3606.3 30646.8 30654.7 30718.7 30727.0 30772.8 3059.5 3093.0 3127.6 3136.4 3139.8 292120.0 297115.0 298529.0 300600.0 302356.0 49254.8 49356.0 49410.0 49476.5 49512.0 50326.5 50382.5 50497.5 50505.7 50510.0 13860.9 13949.8 13950.9 13965.6 13974.0 9828.2 11369.7 11392.5 11402.5 11403.0 10427.4 10502.7 10505.3 10506.6 10509.4 5030.2 5231.3 5235.2 5260.8 5279.0 1032.7 1038.5 1040.2 1068.5 1077.7 18726.6 23467.6 23517.4 24629.5 24725.4 1141.5 1143.0 1180.2 1186.9 1190.5 12184.3 12585.9 12586.2 12691.2 12706.6 314459.0 314898.0 315682.0 315961.4 316190.0 53496.9 53671.0 53672.5 53789.0 53806.5 1489.0 1502.5 1534.3 1534.9 1554.0 23956.9 24003.9 24132.0 24133.6 24166.0 37042.4 37045.3 37065.9 37070.4 37186.4 291791.0 292126.1 292335.0 292881.0 293325.0 32283.0 33167.0 33392.8 33408.8 33473.0 35722.9 36224.8 36547.7 36574.8 43576.1 26322.7 27133.7 28437.9 30188.8 30366.4 27780.0 29978.7 29996.7 30133.6 30495.5 36177.3 36181.1 36222.8 36347.6 36388.3 28600.7 28993.9 29519.0 30673.8 30732.2 17746.6 23788.6 23797.2 23922.5 24614.5 03:36:28 INFO - PID 1639 | 03:36:28 INFO - PID 1639 | [#2] jquery.html Cycles:180 Average:35053.69 Median:12726.29 stddev:88727.69 (697.2%) stddev-sans-first:88938.42 03:36:28 INFO - PID 1639 | Values: 387.7 417.3 427.3 433.6 445.4 19661.9 21502.1 22167.7 22248.6 22283.4 21537.5 23151.9 23306.0 23430.5 23546.4 5902.7 6195.3 6198.8 6202.7 6213.6 4635.3 5748.9 6110.8 6123.1 6202.8 5885.5 6150.3 6150.6 6167.9 6177.0 4721.6 6084.5 6113.1 6115.5 6123.7 5174.4 5375.4 5440.3 5440.7 5443.0 27160.5 27349.5 27377.9 27386.5 27647.4 2176.7 2232.3 2242.1 2243.2 2248.3 17317.3 17584.3 18135.4 18211.2 18212.7 2148.5 2159.8 2170.8 2186.3 2186.6 169259.3 171777.0 171931.3 172028.4 173140.0 12370.6 12489.5 12576.8 12609.2 12798.1 16732.8 16749.2 16755.9 16762.2 16819.6 8670.0 8893.4 8939.4 8975.3 9100.0 8502.7 8503.4 8514.1 8672.2 8715.3 6474.4 7703.8 7839.2 7888.9 7895.2 1879.3 2098.9 2127.2 2132.6 2300.7 911.7 930.3 946.2 951.0 968.8 20053.4 20511.5 20563.0 20583.0 20981.8 920.5 958.6 961.1 1004.2 1004.6 7880.5 10530.8 10544.3 10562.8 10681.6 501060.0 510155.0 521245.0 521892.2 522175.2 126096.4 129671.4 131006.0 131617.0 135514.6 1137.6 1144.1 1181.9 1183.0 1185.9 17744.5 17838.6 17855.6 18049.2 18381.8 56995.7 57307.7 57540.7 57765.4 58402.5 73227.3 75581.6 77787.0 78309.0 80093.0 6608.9 7352.0 8525.6 8606.4 9031.0 14161.0 14284.5 14453.5 14456.5 14571.9 11179.9 11634.7 12129.9 12243.6 12252.6 10186.8 11250.4 11254.9 11414.8 11596.4 11697.2 11812.5 12135.0 12161.0 12247.1 8712.8 8774.8 9163.3 9168.2 9185.6 9604.5 10677.9 11622.0 11691.8 12172.6 03:36:28 INFO - PID 1639 | 03:36:28 INFO - PID 1639 | [#3] mootools.html Cycles:180 Average:7123.47 Median:3803.71 stddev:4579.52 (120.4%) stddev-sans-first:4569.78 03:36:28 INFO - PID 1639 | Values: 1071.8 1407.2 1435.7 1436.0 1469.3 9679.2 10193.2 11143.6 11846.1 11879.5 11352.1 11440.1 11456.7 11459.8 11472.6 2211.5 2477.9 2529.9 2533.2 2535.6 2110.4 2199.5 2460.7 2535.3 2554.1 2469.4 2476.9 2500.1 2509.2 2512.3 2477.1 2491.9 2493.2 2494.2 2496.7 2416.1 2446.6 2447.7 2448.5 2448.6 11298.4 11332.0 11459.1 11461.2 11466.0 6504.7 6754.1 6757.0 6760.5 6771.7 3677.2 4126.0 4238.1 4283.0 4302.4 1245.9 1257.5 1270.3 1287.9 1302.4 16721.2 16754.2 16770.7 16806.0 16824.6 5757.8 5929.8 5943.9 6053.8 6054.3 13807.3 13815.8 13831.7 13844.7 13862.0 6808.0 6838.6 6841.1 6841.8 6843.5 5297.0 6089.0 6228.6 6229.0 6277.7 3568.4 4208.5 4552.6 4658.8 4682.7 1377.4 1409.9 1428.7 1435.1 1437.3 790.4 800.6 809.6 810.9 831.2 6223.0 6382.2 6439.4 6746.8 6835.8 769.9 904.0 918.2 935.9 938.8 3709.5 3769.8 3801.9 3805.5 3859.5 14579.3 15245.2 15259.1 15278.7 15279.8 14563.0 14933.9 15154.7 15164.0 15172.5 8469.0 8660.8 8723.8 8738.7 8739.1 6512.4 6696.4 6744.7 6784.5 6812.5 13327.9 13430.9 13547.7 13672.7 13704.9 13656.5 14074.3 14088.0 14113.7 14188.8 9035.2 9153.1 9194.6 9203.0 9297.2 9196.1 9462.2 9477.4 10161.9 10476.9 8025.8 9075.1 9131.7 9285.0 9367.0 8714.3 8871.6 8953.5 9002.6 9015.2 8065.6 8172.2 8261.5 8264.3 8264.3 5030.6 5868.5 6071.2 6118.2 6129.8 4719.7 5959.0 5996.0 6093.7 6303.8 03:36:28 INFO - PID 1639 | 03:36:28 INFO - PID 1639 | [#4] prototype.html Cycles:180 Average:5016.77 Median:5664.60 stddev:1611.99 (28.5%) stddev-sans-first:1577.54 03:36:28 INFO - PID 1639 | Values: 322.6 402.4 410.9 412.6 417.4 4859.6 5743.4 5869.4 6026.6 6034.1 5725.7 5754.3 5762.3 5820.3 5853.4 4109.9 4348.1 4464.9 4512.5 4527.2 4043.0 4131.3 4307.2 4324.8 4336.0 4082.2 4135.2 4151.9 4239.1 4267.0 3308.7 3351.9 4188.6 4197.4 4261.2 2986.0 3664.5 3679.7 3683.8 3694.9 4641.2 5226.9 5589.9 5695.3 5738.4 4985.4 4999.5 5007.8 5041.8 5060.6 5090.8 6185.7 6220.6 6247.4 6290.6 4096.1 4120.9 4133.2 4172.4 4184.4 6565.5 6607.5 6615.4 6619.2 6640.8 3838.9 3895.8 4161.4 4176.3 4188.5 4131.9 4196.2 4257.6 4263.6 4291.7 4152.8 5009.4 5028.0 5039.2 5051.9 5432.9 5762.9 5937.7 6054.9 6329.6 1178.9 1450.3 1450.8 1460.0 1463.5 789.9 863.7 915.6 946.7 948.4 4958.9 5043.9 5882.4 5960.8 5971.9 6054.7 6288.7 6356.0 6415.6 6423.9 5211.5 5633.9 5843.3 5953.4 5963.8 3231.5 3267.5 3396.9 3397.8 3399.7 5777.6 6344.7 6557.0 6748.0 6794.6 6774.1 6796.8 6798.5 6801.7 6825.6 5925.6 6638.8 6748.1 6833.4 6843.5 5455.7 6604.2 6610.2 6618.3 6618.4 5410.9 6332.2 6453.2 6522.9 6524.3 5551.9 6737.5 6795.7 6798.7 6832.9 4183.0 4226.5 4231.7 4233.9 4241.6 5438.9 5560.0 6229.0 6382.9 6428.9 6233.6 6240.3 6255.1 6262.4 6263.3 5325.4 6158.3 6271.4 6327.0 6358.6 4899.4 5042.4 5361.7 5874.0 6266.5 5487.8 6342.2 6349.1 6355.5 6364.1 5072.5 5748.6 5994.3 6191.7 6226.9 03:36:28 INFO - PID 1639 | 03:36:28 INFO - PID 1639 | [#5] yui.html Cycles:180 Average:21442.52 Median:17916.55 stddev:30441.22 (169.9%) stddev-sans-first:30486.78 03:36:28 INFO - PID 1639 | Values: 702.1 850.0 856.3 857.2 871.6 13299.0 17588.6 17978.3 18621.1 18707.0 16950.0 17122.6 17433.2 17465.1 17493.7 722.8 940.4 941.1 941.4 942.9 666.4 682.4 980.3 989.6 999.4 1049.8 1050.7 1051.7 1052.6 1054.4 1045.0 1048.7 1049.3 1050.2 1057.2 771.9 772.2 772.5 775.6 780.2 16314.8 16602.6 16700.7 16782.8 17009.4 16302.7 16396.7 16559.0 16923.7 17081.3 13763.7 13957.7 14005.7 14153.1 14186.9 3371.7 3393.6 3397.5 3404.5 3410.5 119594.0 119626.0 120707.8 121971.4 123596.0 12136.6 12136.6 12161.8 12194.5 12356.0 20464.9 20586.0 20801.1 20801.8 20814.1 7634.4 7710.2 7722.7 7724.2 7728.5 3903.9 3950.8 3958.2 3974.8 3994.9 4197.7 4282.1 4282.5 4283.9 4293.3 819.9 853.8 857.9 860.2 860.8 651.8 655.6 665.3 673.0 686.4 11011.4 11654.7 11696.7 11928.6 12022.1 487.3 646.6 659.7 661.5 679.6 5578.1 5587.3 5966.0 6046.8 6132.8 112781.0 114085.0 115128.4 116247.0 116804.0 81945.6 84069.6 88389.1 88870.1 89825.6 60279.1 75352.0 76003.0 80256.2 83920.0 10587.0 12247.6 12280.4 12648.2 12705.9 39120.6 40571.2 40905.4 41417.2 41901.7 52637.7 53467.0 53580.5 54167.2 54178.7 15958.8 15962.6 16550.4 16783.0 16837.7 15586.5 17618.2 17804.7 17854.8 18064.5 16219.8 16265.9 16457.5 16601.0 16795.0 16193.4 16639.6 16681.7 16721.7 16890.0 15539.8 16169.8 16375.1 16427.2 17457.2 10144.3 11093.0 11181.1 11571.1 11715.5 13502.3 13835.3 14037.4 14051.2 14057.9 03:36:28 INFO - PID 1639 | -------- Summary: end -------- 03:36:28 INFO - PID 1639 | 03:36:29 INFO - TEST-INFO | 1639: exit 0 03:36:29 INFO - TEST-OK | dromaeo_css | took 1119605ms 03:36:29 INFO - TEST-START | kraken 03:36:29 INFO - operating with platform_type : mac_ 03:36:29 INFO - Initialising browser for kraken test... 03:36:29 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpTDsxuG/profile http://localhost:49231/getInfo.html) 03:36:31 INFO - PID 1671 | __metrics Screen width/height:1600/1200 03:36:31 INFO - PID 1671 | colorDepth:24 03:36:31 INFO - PID 1671 | Browser inner width/height: 1024/689 03:36:31 INFO - PID 1671 | __metrics 03:36:31 INFO - PID 1671 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:36:31 INFO - PID 1671 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:36:32 INFO - TEST-INFO | 1671: exit 0 03:36:32 INFO - Browser initialized. 03:36:32 INFO - Running cycle 1/1 for kraken test... 03:36:32 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpTDsxuG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:36:44 INFO - PID 1672 | RSS: Main: 241393664 03:36:44 INFO - PID 1672 | 03:36:47 INFO - PID 1672 | Cycle 1(1): loaded http://localhost:49231/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49231/tests/kraken/driver.html?testName=audio-beat-detection) 03:36:48 INFO - PID 1672 | RSS: Main: 310910976 03:36:48 INFO - PID 1672 | 03:36:50 INFO - PID 1672 | Cycle 1(1): loaded http://localhost:49231/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49231/tests/kraken/driver.html?testName=audio-dft) 03:36:51 INFO - PID 1672 | RSS: Main: 293052416 03:36:51 INFO - PID 1672 | 03:36:54 INFO - PID 1672 | Cycle 1(1): loaded http://localhost:49231/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49231/tests/kraken/driver.html?testName=audio-fft) 03:36:55 INFO - PID 1672 | RSS: Main: 383660032 03:36:55 INFO - PID 1672 | 03:36:57 INFO - PID 1672 | Cycle 1(1): loaded http://localhost:49231/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49231/tests/kraken/driver.html?testName=audio-oscillator) 03:36:57 INFO - PID 1672 | RSS: Main: 288817152 03:36:57 INFO - PID 1672 | 03:37:00 INFO - PID 1672 | Cycle 1(1): loaded http://localhost:49231/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49231/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:37:00 INFO - PID 1672 | RSS: Main: 290861056 03:37:00 INFO - PID 1672 | 03:37:03 INFO - PID 1672 | Cycle 1(1): loaded http://localhost:49231/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49231/tests/kraken/driver.html?testName=imaging-darkroom) 03:37:04 INFO - PID 1672 | RSS: Main: 354095104 03:37:04 INFO - PID 1672 | 03:37:07 INFO - PID 1672 | Cycle 1(1): loaded http://localhost:49231/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49231/tests/kraken/driver.html?testName=imaging-desaturate) 03:37:07 INFO - PID 1672 | RSS: Main: 370638848 03:37:07 INFO - PID 1672 | 03:37:10 INFO - PID 1672 | Cycle 1(1): loaded http://localhost:49231/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49231/tests/kraken/driver.html?testName=json-parse-financial) 03:37:11 INFO - PID 1672 | RSS: Main: 374829056 03:37:11 INFO - PID 1672 | 03:37:12 INFO - PID 1672 | Cycle 1(1): loaded http://localhost:49231/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49231/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:37:13 INFO - PID 1672 | RSS: Main: 333221888 03:37:13 INFO - PID 1672 | 03:37:14 INFO - PID 1672 | Cycle 1(1): loaded http://localhost:49231/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49231/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:37:15 INFO - PID 1672 | RSS: Main: 333402112 03:37:15 INFO - PID 1672 | 03:37:17 INFO - PID 1672 | Cycle 1(1): loaded http://localhost:49231/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49231/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:37:18 INFO - PID 1672 | RSS: Main: 335589376 03:37:18 INFO - PID 1672 | 03:37:21 INFO - PID 1672 | Cycle 1(1): loaded http://localhost:49231/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49231/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:37:22 INFO - PID 1672 | RSS: Main: 350113792 03:37:22 INFO - PID 1672 | 03:37:25 INFO - PID 1672 | Cycle 1(1): loaded http://localhost:49231/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49231/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:37:26 INFO - PID 1672 | RSS: Main: 342786048 03:37:26 INFO - PID 1672 | 03:37:27 INFO - PID 1672 | Cycle 1(1): loaded http://localhost:49231/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49231/tests/kraken/driver.html?testName=ai-astar) 03:37:28 INFO - PID 1672 | RSS: Main: 385978368 03:37:28 INFO - PID 1672 | 03:37:28 INFO - PID 1672 | __start_tp_report 03:37:28 INFO - PID 1672 | _x_x_mozilla_page_load 03:37:28 INFO - PID 1672 | _x_x_mozilla_page_load_details 03:37:28 INFO - PID 1672 | |i|pagename|runs| 03:37:28 INFO - PID 1672 | |0;ai-astar;110;111;109;110;109;112;109;112;111;110 03:37:28 INFO - PID 1672 | |1;audio-beat-detection;146;111;107;147;110;110;108;105;135;108 03:37:28 INFO - PID 1672 | |2;audio-dft;183;185;185;185;183;184;184;184;182;184 03:37:28 INFO - PID 1672 | |3;audio-fft;82;59;62;93;60;60;58;59;83;57 03:37:28 INFO - PID 1672 | |4;audio-oscillator;86;70;85;70;68;69;92;93;101;117 03:37:28 INFO - PID 1672 | |5;imaging-gaussian-blur;88;93;89;89;88;92;93;91;92;88 03:37:28 INFO - PID 1672 | |6;imaging-darkroom;94;95;94;94;94;95;95;99;94;94 03:37:28 INFO - PID 1672 | |7;imaging-desaturate;83;83;83;86;81;83;83;83;84;82 03:37:28 INFO - PID 1672 | |8;json-parse-financial;50;47;47;46;49;49;49;50;47;48 03:37:28 INFO - PID 1672 | |9;json-stringify-tinderbox;56;60;54;56;65;57;56;57;55;55 03:37:28 INFO - PID 1672 | |10;stanford-crypto-aes;81;70;87;95;106;105;106;71;96;106 03:37:28 INFO - PID 1672 | |11;stanford-crypto-ccm;146;135;140;127;162;149;157;128;184;188 03:37:28 INFO - PID 1672 | |12;stanford-crypto-pbkdf2;181;189;215;187;186;186;185;185;198;242 03:37:28 INFO - PID 1672 | |13;stanford-crypto-sha256-iterative;67;67;68;67;69;68;71;82;98;98 03:37:28 INFO - PID 1672 | __end_tp_report 03:37:28 INFO - PID 1672 | __start_cc_report 03:37:28 INFO - PID 1672 | _x_x_mozilla_cycle_collect,2231 03:37:28 INFO - PID 1672 | __end_cc_report 03:37:28 INFO - PID 1672 | __startTimestamp1493375848146__endTimestamp 03:37:28 INFO - PID 1672 | 03:37:28 INFO - PID 1672 | ------- Summary: start ------- 03:37:28 INFO - PID 1672 | Number of tests: 14 03:37:28 INFO - PID 1672 | 03:37:28 INFO - PID 1672 | [#0] ai-astar Cycles:10 Average:110.30 Median:110.50 stddev:1.16 (1.0%) stddev-sans-first:1.22 03:37:28 INFO - PID 1672 | Values: 110.0 111.0 109.0 110.0 109.0 112.0 109.0 112.0 111.0 110.0 03:37:28 INFO - PID 1672 | 03:37:28 INFO - PID 1672 | [#1] audio-beat-detection Cycles:10 Average:118.70 Median:110.50 stddev:16.92 (15.3%) stddev-sans-first:14.78 03:37:28 INFO - PID 1672 | Values: 146.0 111.0 107.0 147.0 110.0 110.0 108.0 105.0 135.0 108.0 03:37:28 INFO - PID 1672 | 03:37:28 INFO - PID 1672 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.00 stddev:0.99 (0.5%) stddev-sans-first:1.00 03:37:28 INFO - PID 1672 | Values: 183.0 185.0 185.0 185.0 183.0 184.0 184.0 184.0 182.0 184.0 03:37:28 INFO - PID 1672 | 03:37:28 INFO - PID 1672 | [#3] audio-fft Cycles:10 Average:67.30 Median:61.00 stddev:13.28 (21.8%) stddev-sans-first:12.98 03:37:28 INFO - PID 1672 | Values: 82.0 59.0 62.0 93.0 60.0 60.0 58.0 59.0 83.0 57.0 03:37:28 INFO - PID 1672 | 03:37:28 INFO - PID 1672 | [#4] audio-oscillator Cycles:10 Average:85.10 Median:77.50 stddev:16.29 (21.0%) stddev-sans-first:17.28 03:37:28 INFO - PID 1672 | Values: 86.0 70.0 85.0 70.0 68.0 69.0 92.0 93.0 101.0 117.0 03:37:28 INFO - PID 1672 | 03:37:28 INFO - PID 1672 | [#5] imaging-gaussian-blur Cycles:10 Average:90.30 Median:91.50 stddev:2.11 (2.3%) stddev-sans-first:2.07 03:37:28 INFO - PID 1672 | Values: 88.0 93.0 89.0 89.0 88.0 92.0 93.0 91.0 92.0 88.0 03:37:28 INFO - PID 1672 | 03:37:28 INFO - PID 1672 | [#6] imaging-darkroom Cycles:10 Average:94.80 Median:94.50 stddev:1.55 (1.6%) stddev-sans-first:1.62 03:37:28 INFO - PID 1672 | Values: 94.0 95.0 94.0 94.0 94.0 95.0 95.0 99.0 94.0 94.0 03:37:28 INFO - PID 1672 | 03:37:28 INFO - PID 1672 | [#7] imaging-desaturate Cycles:10 Average:83.10 Median:83.00 stddev:1.29 (1.6%) stddev-sans-first:1.36 03:37:28 INFO - PID 1672 | Values: 83.0 83.0 83.0 86.0 81.0 83.0 83.0 83.0 84.0 82.0 03:37:28 INFO - PID 1672 | 03:37:28 INFO - PID 1672 | [#8] json-parse-financial Cycles:10 Average:48.20 Median:49.00 stddev:1.40 (2.9%) stddev-sans-first:1.32 03:37:28 INFO - PID 1672 | Values: 50.0 47.0 47.0 46.0 49.0 49.0 49.0 50.0 47.0 48.0 03:37:28 INFO - PID 1672 | 03:37:28 INFO - PID 1672 | [#9] json-stringify-tinderbox Cycles:10 Average:57.10 Median:56.50 stddev:3.21 (5.7%) stddev-sans-first:3.38 03:37:28 INFO - PID 1672 | Values: 56.0 60.0 54.0 56.0 65.0 57.0 56.0 57.0 55.0 55.0 03:37:28 INFO - PID 1672 | 03:37:28 INFO - PID 1672 | [#10] stanford-crypto-aes Cycles:10 Average:92.30 Median:76.00 stddev:14.35 (18.9%) stddev-sans-first:14.62 03:37:28 INFO - PID 1672 | Values: 81.0 70.0 87.0 95.0 106.0 105.0 106.0 71.0 96.0 106.0 03:37:28 INFO - PID 1672 | 03:37:28 INFO - PID 1672 | [#11] stanford-crypto-ccm Cycles:10 Average:151.60 Median:153.00 stddev:21.40 (14.0%) stddev-sans-first:22.60 03:37:28 INFO - PID 1672 | Values: 146.0 135.0 140.0 127.0 162.0 149.0 157.0 128.0 184.0 188.0 03:37:28 INFO - PID 1672 | 03:37:28 INFO - PID 1672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.40 Median:188.00 stddev:19.07 (10.1%) stddev-sans-first:19.51 03:37:28 INFO - PID 1672 | Values: 181.0 189.0 215.0 187.0 186.0 186.0 185.0 185.0 198.0 242.0 03:37:28 INFO - PID 1672 | 03:37:28 INFO - PID 1672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.50 Median:70.00 stddev:12.68 (18.1%) stddev-sans-first:13.07 03:37:28 INFO - PID 1672 | Values: 67.0 67.0 68.0 67.0 69.0 68.0 71.0 82.0 98.0 98.0 03:37:28 INFO - PID 1672 | -------- Summary: end -------- 03:37:28 INFO - PID 1672 | 03:37:29 INFO - TEST-INFO | 1672: exit 0 03:37:29 INFO - TEST-OK | kraken | took 60121ms 03:37:29 INFO - SUITE-END | took 1179s 03:37:29 INFO - Completed test suite (00:19:39) 03:37:29 INFO - javascript benchmark 03:37:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7692.652025296619, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3389.9322013559745, 3481.3385456763212, 3518.5425894633695, 3554.3424466473703, 3556.893293201205, 5833.387494313089, 6034.6379217246995, 6062.818115456533, 6095.573309868311, 6125.448709616134, 6026.668533230671, 6079.057746049359, 6100.5206187869435, 6110.285381942539, 6124.479419249369, 5065.721385323805, 5067.39191297043, 5221.2951251580935, 5233.03188910051, 5302.045631786277, 5256.185291279858, 5298.788048478056, 5312.840614781563, 5314.734263286839, 5324.1215199492035, 5130.4356520782685, 5199.324087868553, 5221.817236396746, 5221.869453263661, 5257.921131183035, 5233.947660523422, 5264.947350526522, 5283.788648454057, 5286.814961476368, 5290.947090529084, 5208.947910520922, 5214.8174813881715, 5222.712750798704, 5246.213068039825, 5290.973545132289, 5855.531557475434, 5950.940490595125, 6027.186329845503, 6062.575619706622, 6081.452669259744, 6303.779367722108, 6378.425941665226, 6454.548181627288, 6462.709178086998, 6469.83825404364, 6441.935580644181, 6452.161219041494, 6454.612723236574, 6456.418922297016, 6458.515611329169, 6082.391760823971, 6140.0, 6149.815505534841, 6159.599626024294, 6159.692015399212, 6394.328595497499, 6478.125453063871, 6545.836354091186, 6658.0, 6695.631740254333, 6169.198004259418, 6262.5616206866, 6275.905861412082, 6282.748690052438, 6284.0, 5295.470452954751, 6295.276043254993, 6321.1150438938585, 6421.229452465734, 6527.086207930894, 6354.3010268870385, 6360.84097897547, 6367.61794292344, 6372.107904893319, 6386.648734319564, 6278.340774218641, 6352.6823658816875, 6375.234971803413, 6383.904241436382, 6389.9680501597195, 3951.78265195417, 4955.950440495621, 5115.923261151086, 5130.204818253177, 5146.356705411824, 4567.954320456819, 4626.930596041062, 4633.976830115896, 4645.442546894395, 4675.625949923998, 6094.839609484032, 6133.1413602095745, 6156.0, 6158.076288556663, 6160.445559899541, 6483.805485835433, 6495.7076931538195, 6507.414332710079, 6509.804705858832, 6519.902201466982, 5980.521558275327, 6089.056196289582, 6097.359777223416, 6104.450599445982, 6166.105914642351, 5669.34802497718, 5674.4892959633835, 5683.147527870769, 5689.544836413077, 5717.485426311652, 6601.603903765789, 6686.197656281277, 6714.764983225564, 6714.899276510759, 6719.664016799141, 6300.653464059521, 6383.904241436289, 6533.640649764308, 6535.856225160673, 6540.967295163494, 6621.0, 6690.364415380531, 6707.195136583641, 6709.865802683821, 6728.831779205559, 6355.5551111421755, 6356.0, 6364.4908407326375, 6377.617342959437, 6394.552381333262, 5622.662640241599, 6274.466670333073, 6309.211348581427, 6365.331640177715, 6475.676216189266, 6249.406306400884, 6260.154879091265, 6286.277078136073, 6343.0, 6351.301356850835, 6299.96850015747, 6333.714982825692, 6349.777757778455, 6351.745930162927, 6354.618722876642, 6112.351504965139, 6113.506711826627, 6198.783042593487, 6201.410865967726, 6285.685715714105, 6300.779472718433, 6315.905261421174, 6320.4311611955145, 6325.588836725598, 6326.9683651581445, 4985.9501404985485, 6200.162977997912, 6236.18929539157, 6238.157848690369, 6238.500919926486], "value": 5892.027385182444, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [769.1885061260372, 798.3453568074178, 804.0512195609181, 1124.8425220469135, 1135.1713249327995, 26771.732282677192, 33711.83144084279, 37121.21590880688, 37200.0, 37374.0, 39379.015524611896, 39723.80138099313, 39756.80121599395, 39768.602313976924, 39770.403443948366, 8300.50196988181, 8469.32245420365, 8474.44916080456, 8474.618642161118, 8474.78813029673, 6000.8499787505225, 6091.817245482643, 8351.83296334073, 8518.659253629847, 8527.275181609572, 8485.278751306147, 8562.100979397166, 8564.528950907728, 8573.271271941861, 8618.913810861874, 8484.321254299672, 8534.103919088468, 8551.401401901869, 8565.657373705075, 8580.699675511327, 8422.957885210595, 8469.0, 8469.407141500098, 8482.066972633005, 8490.575471226475, 37124.88625341244, 37165.62834371649, 37199.44200836989, 37204.25591488182, 37242.81378593117, 3579.7673151245085, 3597.1366871950804, 3599.6580324869096, 3601.0637234319265, 3606.278744251134, 30646.84676576625, 30654.693453065407, 30718.692813071808, 30727.0, 30772.846135769403, 3059.5410688396696, 3092.9845350773103, 3127.6403213630497, 3136.40408322418, 3139.780215384901, 292120.0, 297115.0, 298528.99999999785, 300600.0, 302356.0, 49254.75372623114, 49356.01287974221, 49410.0, 49476.5157045282, 49512.0, 50326.49673503218, 50382.49617503851, 50497.49502505001, 50505.747471263145, 50510.0, 13860.930695346458, 13949.790753138712, 13950.93024534891, 13965.58103256904, 13974.0, 9828.16460600857, 11369.715757106138, 11392.487338069806, 11402.486888090056, 11403.0, 10427.374357538572, 10502.68491945243, 10505.31715438494, 10506.632267870587, 10509.421981790922, 5030.195168772979, 5231.267622532849, 5235.214717792285, 5260.789568417297, 5278.97360513195, 1032.6540608895955, 1038.5326603028668, 1040.157472447305, 1068.5191663751343, 1077.6605369308643, 18726.625467490572, 23467.647985280233, 23517.41206469852, 24629.50740985206, 24725.381865453506, 1141.5148561861176, 1142.9771404572027, 1180.2387460088196, 1186.925832121931, 1190.4821402689859, 12184.329861857506, 12585.867271945568, 12586.244825310327, 12691.238525688488, 12706.618801435972, 314459.0, 314898.0, 315682.0, 315961.42019289755, 316190.0, 53496.930061398554, 53671.0, 53672.463275367525, 53789.0, 53806.461935380146, 1489.0470099136778, 1502.4741340530727, 1534.294224656648, 1534.9386024559117, 1554.0442627784057, 23956.92193851316, 24003.879980599984, 24132.0, 24133.63799542973, 24166.033358665456, 37042.444363334034, 37045.259094818495, 37065.888023359345, 37070.44394334141, 37186.442203367515, 291791.0, 292126.0787392099, 292335.0, 292881.0, 293325.0, 32283.0, 33167.0, 33392.833035834665, 33408.83295583507, 33473.0, 35722.928312150674, 36224.818875905454, 36547.72082977083, 36574.817125914204, 43576.12847742964, 26322.683974551874, 27133.72866271312, 28437.857810710815, 30188.79244830182, 30366.392672146874, 27780.0, 29978.70021299759, 29996.700033000263, 30133.589312855358, 30495.542566861957, 36177.27645447024, 36181.09547261339, 36222.8188859054, 36347.63652363443, 36388.27223455463, 28600.713992859804, 28993.85503072471, 29519.0, 30673.773049078678, 30732.23169420693, 17746.592660193244, 23788.643170352112, 23797.167099151447, 23922.52154956926, 24614.50770984606], "value": 17105.623964479528, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.6511139974025, 417.3385184482595, 427.2906974422459, 433.61841579410117, 445.4076078815175, 19661.901690491562, 21502.139914403426, 22167.667484987738, 22248.555028899453, 22283.44291392716, 21537.46156346092, 23151.884240578773, 23305.9507510368, 23430.5313893722, 23546.411339716517, 5902.734376953037, 6195.349488303731, 6198.78304259351, 6202.658853763064, 6213.596116252429, 4635.304704294366, 5748.856278593027, 6110.786122485714, 6123.142760013579, 6202.78290259841, 5885.4997325227405, 6150.292716337612, 6150.630962142263, 6167.907481387782, 6176.9691151544175, 4721.622270218391, 6084.452399284086, 6113.052476866093, 6115.510759139281, 6123.724432400552, 5174.3790745110455, 5375.381831089397, 5440.265564148829, 5440.727963601804, 5443.0, 27160.45679086407, 27349.45301093987, 27377.863110684517, 27386.45227095467, 27647.44705105907, 2176.662617294322, 2232.3191426614876, 2242.125571027301, 2243.1588154442084, 2248.336740661509, 17317.307307707677, 17584.29662813486, 18135.36526221589, 18211.18049687767, 18212.726809097872, 2148.4628842789302, 2159.7840215978435, 2170.750363708178, 2186.311311936751, 2186.5517568898335, 169259.30740692682, 171777.0, 171931.28068719278, 172028.41957370524, 173140.0, 12370.62888113358, 12489.50041998328, 12576.81134782979, 12609.180403273758, 12798.104132710621, 16732.83267167337, 16749.246283917008, 16755.91622041882, 16762.245698943578, 16819.579510512336, 8669.956650216709, 8893.421927574816, 8939.374243803002, 8975.32685048611, 9099.954500227457, 8502.702405415781, 8503.447275927045, 8514.14858514156, 8672.176143266379, 8715.34634902372, 6474.417302442803, 7703.768886933401, 7839.176886426843, 7888.921110788819, 7895.171007044292, 1879.2764785557385, 2098.880131067602, 2127.2022991378235, 2132.581833081015, 2300.700908881868, 911.6672414568635, 930.3022732950287, 946.1720994130136, 950.9714708558754, 968.8340137409112, 20053.39839804808, 20511.4872128198, 20563.0, 20583.0, 20981.790182098288, 920.5213289089636, 958.5734348215117, 961.1349785193382, 1004.1565085328359, 1004.5630150884389, 7880.527168369917, 10530.789384212272, 10544.26190166681, 10562.841557376645, 10681.626143084955, 501060.0, 510155.0, 521245.0, 521892.17161742604, 522175.1673724897, 126096.36951815366, 129671.35164324119, 131006.0, 131617.0, 135514.6121346974, 1137.5904674317073, 1144.1361771862191, 1181.8699943006263, 1182.9585964491203, 1185.8991985681314, 17744.46766597004, 17838.5540361492, 17855.553611159827, 18049.1877865499, 18381.81618183801, 56995.71502142463, 57307.713461432424, 57540.65660479291, 57765.422345776, 58402.45176708206, 73227.26772732205, 75581.62209188919, 77787.0, 78309.0, 80093.0, 6608.933910660832, 7351.963240183765, 8525.573721314033, 8606.407814554328, 9031.006589275306, 14161.0, 14284.500042498463, 14453.49412770548, 14456.494022709154, 14571.907106966808, 11179.888201117885, 11634.70913227176, 12129.939350303192, 12243.571474998333, 12252.571160009356, 10186.847197292194, 11250.437478126225, 11254.930781575737, 11414.82877756851, 11596.420178990847, 11697.181197316106, 11812.468438920441, 12135.0, 12161.0, 12247.142700010914, 8712.825743484967, 8774.808097681253, 9163.312751543794, 9168.174864262248, 9185.632574697205, 9604.471754053595, 10677.878822723813, 11622.0, 11691.760862982024, 12172.57395991136], "value": 10332.36397102604, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1071.785642871425, 1407.162738170788, 1435.7200345932547, 1436.030679291478, 1469.2506821521024, 9679.225661947045, 10193.23550733695, 11143.554257829677, 11846.052315814735, 11879.524819007229, 11352.091832653388, 11440.084793216543, 11456.71358216045, 11459.828102578447, 11472.598459053936, 2211.5466329402516, 2477.863717495537, 2529.8735063246854, 2533.2020413569667, 2535.5816290312077, 2110.387987483628, 2199.52710167314, 2460.7416221296776, 2535.290118766748, 2554.0932968796087, 2469.407342237868, 2476.925692229236, 2500.087468074149, 2509.2221411362443, 2512.309114993382, 2477.1453848422266, 2491.875406229681, 2493.2395619336094, 2494.164454907599, 2496.6879140107485, 2416.081888882231, 2446.559619268531, 2447.669564608773, 2448.52253810507, 2448.6204638281097, 11298.378589177591, 11332.0, 11459.083273338112, 11461.197716159872, 11466.0, 6504.739810407578, 6754.088198093293, 6756.986452032185, 6760.526763126583, 6771.661416929183, 3677.2257286151566, 4126.0, 4238.109996900655, 4283.0363168286885, 4302.397664326997, 1245.9003279737599, 1257.4655771297253, 1270.28863836252, 1287.8905293050102, 1302.446460254388, 16721.247543860554, 16754.162291885477, 16770.74843877343, 16806.0, 16824.57938551546, 5757.769689212385, 5929.792457263975, 5943.881122377615, 6053.818385448443, 6054.273487181478, 13807.309634518233, 13815.792763108562, 13831.723365532633, 13844.723105537832, 13862.02965792405, 6807.965960170168, 6838.623875686785, 6841.144856892888, 6841.828954276183, 6843.486738494633, 5297.0, 6088.969555152196, 6228.626282423069, 6229.0, 6277.748890044439, 3568.357695614762, 4208.537060923296, 4552.590266875931, 4658.790354433991, 4682.74244916526, 1377.3870627570634, 1409.8801601863956, 1428.6999730056805, 1435.1102316563797, 1437.3460075665548, 790.3756032734191, 800.5949558524752, 809.639710328898, 810.943233973628, 831.1771346367053, 6223.0, 6382.234131904202, 6439.388258115471, 6746.763863264762, 6835.829104272333, 769.8537277917178, 903.9638414463348, 918.1507105927125, 935.8783358163395, 938.7512309238058, 3709.46212799148, 3769.830357633858, 3801.904952376213, 3805.5243094613174, 3859.4789703390243, 14579.343929523196, 15245.16151611672, 15259.08445493274, 15278.694426111415, 15279.770803437958, 14563.0, 14933.850661493463, 15154.696906061818, 15164.0, 15172.544823655307, 8469.026062002826, 8660.783480412914, 8723.781905452288, 8738.69414570487, 8739.12608739121, 6512.446442052289, 6696.363845434676, 6744.730210791709, 6784.491163162684, 6812.489063320171, 13327.933360333136, 13430.865691342962, 13547.689652778748, 13672.726545469233, 13704.862951370758, 13656.453741850612, 14074.296285185905, 14088.0, 14113.717725645634, 14188.787168192279, 9035.232005279362, 9153.130452606993, 9194.632214711337, 9203.033681463618, 9297.163255307054, 9196.12636799503, 9462.243020558477, 9477.383970041925, 10161.898381016392, 10476.895231047896, 8025.8394832104195, 9075.13786190311, 9131.726048218565, 9285.025072367574, 9366.953165234403, 8714.302855771397, 8871.645134194818, 8953.462792232487, 9002.594883230402, 9015.188633023059, 8065.596720163851, 8172.223638754309, 8261.545614990993, 8264.256216940505, 8264.297534709376, 5030.647854650139, 5868.501177399798, 6071.180390647206, 6118.20463339763, 6129.84675383119, 4719.7404142772475, 5959.0, 5995.95070862606, 6093.695315234309, 6303.779367722108], "value": 5369.700864102716, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.61286456252486, 402.3923874948827, 410.8644147431348, 412.6451251923347, 417.3968615350818, 4859.611231101512, 5743.368229494752, 5869.383714709958, 6026.578139530229, 6034.125051867482, 5725.742341594628, 5754.251947246862, 5762.308522977249, 5820.330661973874, 5853.405077014544, 4109.856155034567, 4348.108637729274, 4464.933026004613, 4512.481064677555, 4527.234378592351, 4042.959570404302, 4131.338985762279, 4307.224699554079, 4324.82700691972, 4336.0, 4082.1835632873544, 4135.193637240739, 4151.875443736692, 4239.130978149472, 4267.037162905068, 3308.7353011759, 3351.949720754191, 4188.612490880199, 4197.3703944408435, 4261.211675839949, 2985.970140298591, 3664.486971823947, 3679.6872265857432, 3683.778973261586, 3694.8891533254045, 4641.164590373732, 5226.895462090775, 5589.888202235973, 5695.345035320908, 5738.368779434259, 4985.376827896513, 4999.450170447173, 5007.84976450707, 5041.8487445376695, 5060.5951523878, 5090.77091530882, 6185.7317651759, 6220.631461078556, 6247.406496382836, 6290.559660823744, 4096.078382363974, 4120.896977575555, 4133.1940271647045, 4172.395002724588, 4184.3932629768515, 6565.474762019027, 6607.471402287805, 6615.404613584752, 6619.238787539398, 6640.7675731349655, 3838.9424158637644, 3895.8052097395584, 4161.375793630919, 4176.290030694729, 4188.476440444944, 4131.876043718693, 4196.223698615766, 4257.5529569395385, 4263.616274535307, 4291.6566674665955, 4152.771597562163, 5009.373828271466, 5028.0, 5039.193729003342, 5051.898962020812, 5432.91850622241, 5762.942370576325, 5937.6734279614175, 6054.940385432532, 6329.620222786648, 1178.885952774637, 1450.3473436953414, 1450.8331541872608, 1459.9708005840037, 1463.5389852196524, 789.8547106695315, 863.6890719341033, 915.6402741928231, 946.7207173883721, 948.4025064209504, 4958.925616115761, 5043.873903152377, 5882.441168089024, 5960.76156953717, 5971.940280597225, 6054.666993315322, 6288.748450062038, 6355.968220158962, 6415.582987105823, 6423.871522569522, 5211.5049070338255, 5633.8591535211945, 5843.2695913010875, 5953.434423729739, 5963.7912673056235, 3231.5475833383343, 3267.4772036474524, 3396.8980930572125, 3397.793783206975, 3399.7280217582534, 5777.62445441045, 6344.651044192521, 6556.967215163989, 6748.0, 6794.607105543352, 6774.051632771416, 6796.8300792479595, 6798.456123510107, 6801.65991700413, 6825.590464572141, 5925.614835035709, 6638.83402914931, 6748.122744043341, 6833.4191593715095, 6843.520953533304, 5455.699936503531, 6604.207495100619, 6610.206775186816, 6618.305077966937, 6618.371254730793, 5410.945890541044, 6332.176817013758, 6453.160369580092, 6522.902156467562, 6524.3149469305035, 5551.8889622208135, 6737.494687898526, 6795.660216989229, 6798.694058767268, 6832.863342733018, 4182.9581704182565, 4226.4928208615165, 4231.703780735442, 4233.91532169361, 4241.618254356999, 5438.945610543844, 5559.972200138974, 6229.0100751638565, 6382.872342553216, 6428.903566446414, 6233.625982440886, 6240.313565507699, 6255.093011513396, 6262.405071518198, 6263.342349053466, 5325.440828713085, 6158.337248942671, 6271.3728627136925, 6326.9683651581445, 6358.601107756286, 4899.39456910503, 5042.420121686053, 5361.651492652965, 5874.030784920611, 6266.530010249158, 5487.807926722546, 6342.207224096988, 6349.111124442489, 6355.491560675043, 6364.140840986593, 5072.54347108762, 5748.626339287933, 5994.28068631767, 6191.721372538336, 6226.906596401148], "value": 4513.2345293116205, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.097804321447, 849.9660013599456, 856.272168656642, 857.2242120880601, 871.559862269554, 13299.002574806891, 17588.64822703545, 17978.280868765265, 18621.068946552685, 18707.0, 16950.0, 17122.571935701613, 17433.21550530226, 17465.126743662797, 17493.7375939361, 722.8012296618433, 940.3793496292449, 941.1200527506803, 941.3833938770116, 942.8632848237002, 666.3536369721362, 682.4335801284947, 980.2794945714894, 989.579428742785, 999.4253304350028, 1049.821530339844, 1050.6742909698019, 1051.7002654243543, 1052.5737076483997, 1054.3726482742757, 1045.0229035851503, 1048.7378155461097, 1049.2812423489856, 1050.186105768036, 1057.2070946789909, 771.9189485104096, 772.1853444615928, 772.4940164192462, 775.6121939030485, 780.1808101493409, 16314.75527867083, 16602.58493537659, 16700.66598668032, 16782.83217167825, 17009.404670836462, 16302.673946521003, 16396.67206655872, 16559.0, 16923.661526769396, 17081.316747330093, 13763.655908602264, 13957.720845583133, 14005.719885602231, 14153.08004979673, 14186.858131418658, 3371.7134043606325, 3393.5588373511287, 3397.5073614326034, 3404.472306792451, 3410.4884267360094, 119593.99999999913, 119626.0, 120707.81671963343, 121971.39014304872, 123596.0, 12136.635900922987, 12136.635900922987, 12161.756764864831, 12194.451249693786, 12356.011519078453, 20464.897675511525, 20586.0, 20801.063952121887, 20801.791982079987, 20814.063367148516, 7634.427417943676, 7710.151883292833, 7722.691092356243, 7724.227577242344, 7728.536287822749, 3903.863364782219, 3950.822213000422, 3958.188571342868, 3974.7615143091507, 3994.900127496836, 4197.664186865043, 4282.1221649562385, 4282.528921818597, 4283.935740963888, 4293.3130699088, 819.9098099209082, 853.8121613245077, 857.8756080368312, 860.2172023458622, 860.8407444622765, 651.7653644687908, 655.5607742812327, 665.3014334948285, 672.9596224226563, 686.4062585863293, 11011.449427528592, 11654.650360489199, 11696.729435084242, 11928.642140735792, 12022.098342624338, 487.2642310111757, 646.5538778242998, 659.7328082126746, 661.4708233413251, 679.5922446532041, 5578.135389014709, 5587.329520457572, 5966.0, 6046.758129674852, 6132.787130938756, 112781.0, 114085.0, 115128.42435787935, 116247.0, 116804.0, 81945.59027204826, 84069.57965210258, 88389.11610883809, 88870.11129888748, 89825.55087224653, 60279.09581356283, 75352.0, 76003.0, 80256.19743802487, 83920.0, 10587.0, 12247.571335003233, 12280.447379867748, 12648.177868438523, 12705.872941270469, 39120.6087939117, 40571.1885762289, 40905.38641920314, 41417.171656567305, 41901.74294771162, 52637.7368113157, 53467.0, 53580.46419535755, 54167.18749218686, 54178.729106354214, 15958.8404115962, 15962.60093497672, 16550.42073527421, 16782.993020418326, 16837.66324673475, 15586.454474093352, 17618.207180676643, 17804.732929005815, 17854.821451785316, 18064.548386290448, 16219.837801621832, 16265.918670407045, 16457.506274811774, 16601.0, 16795.0, 16193.433229836899, 16639.584010399838, 16681.666366672354, 16721.749173762648, 16890.0, 15539.766903496231, 16169.75745363844, 16375.099369534313, 16427.17864106766, 17457.214425350634, 10144.28989970695, 11093.0, 11181.105511559219, 11571.132165087483, 11715.531378744754, 13502.32488375597, 13835.308234588432, 14037.368318425491, 14051.156930584199, 14057.859421405656], "value": 8210.748912433592, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1453.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 109.0, 110.0, 109.0, 112.0, 109.0, 112.0, 111.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 111.0, 107.0, 147.0, 110.0, 110.0, 108.0, 105.0, 135.0, 108.0], "value": 118.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 185.0, 185.0, 183.0, 184.0, 184.0, 184.0, 182.0, 184.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 62.0, 93.0, 60.0, 60.0, 58.0, 59.0, 83.0, 57.0], "value": 67.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 85.0, 70.0, 68.0, 69.0, 92.0, 93.0, 101.0, 117.0], "value": 85.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 93.0, 89.0, 89.0, 88.0, 92.0, 93.0, 91.0, 92.0, 88.0], "value": 90.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 99.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 86.0, 81.0, 83.0, 83.0, 83.0, 84.0, 82.0], "value": 83.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 47.0, 47.0, 46.0, 49.0, 49.0, 49.0, 50.0, 47.0, 48.0], "value": 48.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 60.0, 54.0, 56.0, 65.0, 57.0, 56.0, 57.0, 55.0, 55.0], "value": 57.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 70.0, 87.0, 95.0, 106.0, 105.0, 106.0, 71.0, 96.0, 106.0], "value": 92.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 135.0, 140.0, 127.0, 162.0, 149.0, 157.0, 128.0, 184.0, 188.0], "value": 151.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 189.0, 215.0, 187.0, 186.0, 186.0, 185.0, 185.0, 198.0, 242.0], "value": 195.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 67.0, 69.0, 68.0, 71.0, 82.0, 98.0, 98.0], "value": 75.5, "unit": "score"}]}]} 03:37:29 INFO - Return code: 0 03:37:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:37:29 ERROR - # TBPL SUCCESS # 03:37:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:37:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:37:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:37:29 INFO - 2017-04-28 03:37:29.441 screenresolution[1676:9724] starting screenresolution argv=screenresolution get 03:37:29 INFO - 2017-04-28 03:37:29.443 screenresolution[1676:9724] Display 0: 1600x1200x32@60 03:37:29 INFO - 2017-04-28 03:37:29.449 screenresolution[1677:9727] starting screenresolution argv=screenresolution list 03:37:29 INFO - Available Modes on Display 0 03:37:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:37:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:37:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:37:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:37:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:37:29 INFO - Intel Iris: 03:37:29 INFO - Chipset Model: Intel Iris 03:37:29 INFO - Type: GPU 03:37:29 INFO - Bus: Built-In 03:37:29 INFO - VRAM (Dynamic, Max): 1536 MB 03:37:29 INFO - Vendor: Intel (0x8086) 03:37:29 INFO - Device ID: 0x0a2e 03:37:29 INFO - Revision ID: 0x0009 03:37:29 INFO - Displays: 03:37:29 INFO - Display: 03:37:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:37:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:37:29 INFO - Display Serial Number: 1600x1200 60 03:37:29 INFO - Main Display: Yes 03:37:29 INFO - Mirror: Off 03:37:29 INFO - Online: Yes 03:37:29 INFO - Rotation: Supported 03:37:29 INFO - Return code: 0 03:37:29 INFO - Running post-action listener: _resource_record_post_action 03:37:29 INFO - [mozharness: 2017-04-28 10:37:29.696291Z] Finished run-tests step (success) 03:37:29 INFO - Running post-run listener: _resource_record_post_run 03:37:29 INFO - Total resource usage - Wall time: 1200s; CPU: 53.0%; Read bytes: 38212608; Write bytes: 510921216; Read time: 340; Write time: 1590 03:37:29 INFO - TinderboxPrint: CPU usage
53.1% 03:37:29 INFO - TinderboxPrint: I/O read bytes / time
38,212,608 / 340 03:37:29 INFO - TinderboxPrint: I/O write bytes / time
510,921,216 / 1,590 03:37:29 INFO - TinderboxPrint: CPU idle
2,250.7 (46.9%) 03:37:29 INFO - TinderboxPrint: CPU system
953.6 (19.9%) 03:37:29 INFO - TinderboxPrint: CPU user
1,597.4 (33.3%) 03:37:29 INFO - TinderboxPrint: Swap in / out
246,726,656 / 0 03:37:29 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 210065920; Write bytes: 211302400; Read time: 15998; Write time: 478 03:37:29 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 34255872; Write bytes: 298029568; Read time: 314; Write time: 1105 03:37:30 INFO - Running post-run listener: _upload_blobber_files 03:37:30 INFO - Blob upload gear active. 03:37:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:37:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:37:30 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:37:30 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:37:30 INFO - (blobuploader) - INFO - Open directory for files ... 03:37:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:37:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:37:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:37:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:37:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:37:32 INFO - (blobuploader) - INFO - Done attempting. 03:37:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:37:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:37:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:37:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:37:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:37:33 INFO - (blobuploader) - INFO - Done attempting. 03:37:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:37:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:37:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:37:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:37:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:37:34 INFO - (blobuploader) - INFO - Done attempting. 03:37:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:37:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:37:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:37:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:37:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:37:37 INFO - (blobuploader) - INFO - Done attempting. 03:37:37 INFO - (blobuploader) - INFO - Iteration through files over. 03:37:37 INFO - Return code: 0 03:37:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:37:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:37:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/902510acb20bb774b2c67a2e0205be81b9a6afc4c753ab9dc08b91bb71f5e4436b9921098ad540ee755b190e0f33bd1e0187ad71cf1fb488a6f567a560376d15", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/55da20cf5f1dc334e904a7c9cc19e66b4d8941363a4fcbf529c1a8738a6f30c6cda350508e67b979e747df3c8b66ae145bab90bf7fada5f6fd9c8fb813e6c618", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d4158c381ea35c1b7a436e9cf7c67b75fb6ba9f533af79643c36c8124ec7eb168d5af68109fc1f621e2fc7fbf8b959f07cac2f8754ba573cd53c911cb84c97e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b5e29ab06f90ec1b08649614a15eaee64fe864f715e8b04f04e13b541697dc25067475f98e995398bf339aa8904a2d077cfe4ef3668b21f60b6abc3274ecc8a"} 03:37:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:37:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:37:37 INFO - Contents: 03:37:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/902510acb20bb774b2c67a2e0205be81b9a6afc4c753ab9dc08b91bb71f5e4436b9921098ad540ee755b190e0f33bd1e0187ad71cf1fb488a6f567a560376d15", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/55da20cf5f1dc334e904a7c9cc19e66b4d8941363a4fcbf529c1a8738a6f30c6cda350508e67b979e747df3c8b66ae145bab90bf7fada5f6fd9c8fb813e6c618", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d4158c381ea35c1b7a436e9cf7c67b75fb6ba9f533af79643c36c8124ec7eb168d5af68109fc1f621e2fc7fbf8b959f07cac2f8754ba573cd53c911cb84c97e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b5e29ab06f90ec1b08649614a15eaee64fe864f715e8b04f04e13b541697dc25067475f98e995398bf339aa8904a2d077cfe4ef3668b21f60b6abc3274ecc8a"} 03:37:37 INFO - Running post-run listener: copy_logs_to_upload_dir 03:37:37 INFO - Copying logs to upload dir... 03:37:37 INFO - mkdir: /builds/slave/test/build/upload/logs 03:37:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.938321 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-04-28 03:37:37.279394) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 03:37:37.282728) ========= 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.2WaiHwqxTn/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.DFbwwLQ2nq/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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/Firefox/sha512/902510acb20bb774b2c67a2e0205be81b9a6afc4c753ab9dc08b91bb71f5e4436b9921098ad540ee755b190e0f33bd1e0187ad71cf1fb488a6f567a560376d15", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/55da20cf5f1dc334e904a7c9cc19e66b4d8941363a4fcbf529c1a8738a6f30c6cda350508e67b979e747df3c8b66ae145bab90bf7fada5f6fd9c8fb813e6c618", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d4158c381ea35c1b7a436e9cf7c67b75fb6ba9f533af79643c36c8124ec7eb168d5af68109fc1f621e2fc7fbf8b959f07cac2f8754ba573cd53c911cb84c97e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b5e29ab06f90ec1b08649614a15eaee64fe864f715e8b04f04e13b541697dc25067475f98e995398bf339aa8904a2d077cfe4ef3668b21f60b6abc3274ecc8a"} build_url:https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011380 build_url: 'https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/902510acb20bb774b2c67a2e0205be81b9a6afc4c753ab9dc08b91bb71f5e4436b9921098ad540ee755b190e0f33bd1e0187ad71cf1fb488a6f567a560376d15", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/55da20cf5f1dc334e904a7c9cc19e66b4d8941363a4fcbf529c1a8738a6f30c6cda350508e67b979e747df3c8b66ae145bab90bf7fada5f6fd9c8fb813e6c618", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d4158c381ea35c1b7a436e9cf7c67b75fb6ba9f533af79643c36c8124ec7eb168d5af68109fc1f621e2fc7fbf8b959f07cac2f8754ba573cd53c911cb84c97e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b5e29ab06f90ec1b08649614a15eaee64fe864f715e8b04f04e13b541697dc25067475f98e995398bf339aa8904a2d077cfe4ef3668b21f60b6abc3274ecc8a"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 03:37:37.319699) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 03:37:37.320086) ========= 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.2WaiHwqxTn/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.DFbwwLQ2nq/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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.005168 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 03:37:37.370682) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 03:37:37.371090) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 03:37:37.371561) ========= ========= Total master_lag: 0.19 =========