builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0210 starttime: 1489199436.58 results: success (0) buildid: 20170310170836 builduid: 4589e19ff09d4be68053d7cdbc14b369 revision: 4ceb9062ea8f4113bfd1b3536ace4a840a72faa7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 18:30:36.576095) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 18:30:36.576557) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 18:30:36.576841) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 18:30:36.603343) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 18:30:36.603747) ========= 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.y2rFti42sE/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.5WihervzjT/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-10 18:30:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 194M=0s 2017-03-10 18:30:36 (194 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120071 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 18:30:36.747987) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 18:30:36.748484) ========= 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.y2rFti42sE/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.5WihervzjT/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.025650 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 18:30:36.799335) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-10 18:30:36.799879) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4ceb9062ea8f4113bfd1b3536ace4a840a72faa7 --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 4ceb9062ea8f4113bfd1b3536ace4a840a72faa7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.y2rFti42sE/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.5WihervzjT/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-10 18:30:36,909 truncating revision to first 12 chars 2017-03-10 18:30:36,909 Setting DEBUG logging. 2017-03-10 18:30:36,909 attempt 1/10 2017-03-10 18:30:36,909 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4ceb9062ea8f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-10 18:30:37,890 unpacking tar archive at: mozilla-central-4ceb9062ea8f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.259613 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-10 18:30:38.083658) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 18:30:38.083988) ========= script_repo_revision: 4ceb9062ea8f4113bfd1b3536ace4a840a72faa7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 18:30:38.084389) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 18:30:38.084677) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 18:30:38.104118) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-10 18:30:38.104470) ========= /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.y2rFti42sE/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.5WihervzjT/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 18:30:38 INFO - MultiFileLogger online at 20170310 18:30:38 in /builds/slave/test 18:30:38 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 18:30:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:30:38 INFO - {'append_to_log': False, 18:30:38 INFO - 'base_work_dir': '/builds/slave/test', 18:30:38 INFO - 'blob_upload_branch': 'Firefox', 18:30:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:30:38 INFO - 'branch': 'Firefox', 18:30:38 INFO - 'buildbot_json_path': 'buildprops.json', 18:30:38 INFO - 'config_files': ('talos/mac_config.py',), 18:30:38 INFO - 'default_actions': ('clobber', 18:30:38 INFO - 'read-buildbot-config', 18:30:38 INFO - 'download-and-extract', 18:30:38 INFO - 'populate-webroot', 18:30:38 INFO - 'create-virtualenv', 18:30:38 INFO - 'install', 18:30:38 INFO - 'run-tests'), 18:30:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:30:38 INFO - 'download_minidump_stackwalk': True, 18:30:38 INFO - 'download_symbols': 'ondemand', 18:30:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:30:38 INFO - 'tooltool.py': '/tools/tooltool.py', 18:30:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:30:38 INFO - '/tools/misc-python/virtualenv.py')}, 18:30:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:30:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:30:38 INFO - 'gecko_profile': False, 18:30:38 INFO - 'gecko_profile_interval': 0, 18:30:38 INFO - 'installer_path': 'installer.exe', 18:30:38 INFO - 'log_level': 'info', 18:30:38 INFO - 'log_name': 'talos', 18:30:38 INFO - 'log_to_console': True, 18:30:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:30:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:30:38 INFO - 'opt_config_files': (), 18:30:38 INFO - 'pip_index': False, 18:30:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:30:38 INFO - 'cmd': ('bash', 18:30:38 INFO - '-c', 18:30:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:30:38 INFO - 'enabled': True, 18:30:38 INFO - 'halt_on_failure': False, 18:30:38 INFO - 'name': 'check_screen_resolution'},), 18:30:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:30:38 INFO - 'cmd': ('bash', 18:30:38 INFO - '-c', 18:30:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:30:38 INFO - 'enabled': True, 18:30:38 INFO - 'halt_on_failure': False, 18:30:38 INFO - 'name': 'check_screen_resolution'},), 18:30:38 INFO - 'run_cmd_checks_enabled': True, 18:30:38 INFO - 'suite': 'dromaeojs', 18:30:38 INFO - 'system_bits': '32', 18:30:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:30:38 INFO - 'title': 't-yosemite-r7-0210', 18:30:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:30:38 INFO - 'use_talos_json': True, 18:30:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:30:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:30:38 INFO - 'work_dir': 'build'} 18:30:38 INFO - [mozharness: 2017-03-11 02:30:38.328207Z] Running clobber step. 18:30:38 INFO - Running pre-action listener: _resource_record_pre_action 18:30:38 INFO - Running main action method: clobber 18:30:38 INFO - rmtree: /builds/slave/test/build 18:30:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:30:40 INFO - Running post-action listener: _resource_record_post_action 18:30:40 INFO - [mozharness: 2017-03-11 02:30:40.802673Z] Finished clobber step (success) 18:30:40 INFO - [mozharness: 2017-03-11 02:30:40.802865Z] Running read-buildbot-config step. 18:30:40 INFO - Running pre-action listener: _resource_record_pre_action 18:30:40 INFO - Running main action method: read_buildbot_config 18:30:40 INFO - Using buildbot properties: 18:30:40 INFO - { 18:30:40 INFO - "project": "", 18:30:40 INFO - "product": "firefox", 18:30:40 INFO - "script_repo_revision": "production", 18:30:40 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 18:30:40 INFO - "repository": "", 18:30:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 18:30:40 INFO - "buildid": "20170310170836", 18:30:40 INFO - "pgo_build": "False", 18:30:40 INFO - "basedir": "/builds/slave/test", 18:30:40 INFO - "buildnumber": 19, 18:30:40 INFO - "slavename": "t-yosemite-r7-0210", 18:30:40 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 18:30:40 INFO - "platform": "yosemite_r7", 18:30:40 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:30:40 INFO - "branch": "mozilla-central", 18:30:40 INFO - "repo_path": "mozilla-central", 18:30:40 INFO - "revision": "4ceb9062ea8f4113bfd1b3536ace4a840a72faa7", 18:30:40 INFO - "stage_platform": "macosx64", 18:30:40 INFO - "builduid": "4589e19ff09d4be68053d7cdbc14b369", 18:30:40 INFO - "slavebuilddir": "test" 18:30:40 INFO - } 18:30:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/erJsxxJMT8Go5oSfaH43Mg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 18:30:40 INFO - Running post-action listener: _resource_record_post_action 18:30:40 INFO - [mozharness: 2017-03-11 02:30:40.806328Z] Finished read-buildbot-config step (success) 18:30:40 INFO - [mozharness: 2017-03-11 02:30:40.806448Z] Running download-and-extract step. 18:30:40 INFO - Running pre-action listener: _resource_record_pre_action 18:30:40 INFO - Running main action method: download_and_extract 18:30:40 INFO - mkdir: /builds/slave/test/build/tests 18:30:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:40 INFO - trying https://queue.taskcluster.net/v1/task/erJsxxJMT8Go5oSfaH43Mg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 18:30:40 INFO - Downloading https://queue.taskcluster.net/v1/task/erJsxxJMT8Go5oSfaH43Mg/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 18:30:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/erJsxxJMT8Go5oSfaH43Mg/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 18:30:42 INFO - Downloaded 1199 bytes. 18:30:42 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 18:30:42 INFO - Using the following test package requirements: 18:30:42 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 18:30:42 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:30:42 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 18:30:42 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:30:42 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 18:30:42 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:30:42 INFO - u'jsshell-mac.zip'], 18:30:42 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:30:42 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 18:30:42 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 18:30:42 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:30:42 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 18:30:42 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:30:42 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 18:30:42 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:30:42 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 18:30:42 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:30:42 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 18:30:42 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:30:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/erJsxxJMT8Go5oSfaH43Mg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 18:30:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/erJsxxJMT8Go5oSfaH43Mg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:30:42 INFO - Fetch https://queue.taskcluster.net/v1/task/erJsxxJMT8Go5oSfaH43Mg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 18:30:43 INFO - Expected file size: 51787234 18:30:43 INFO - Obtained file size: 51787234 18:31:00 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 18:31:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/erJsxxJMT8Go5oSfaH43Mg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 18:31:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/erJsxxJMT8Go5oSfaH43Mg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:31:00 INFO - Fetch https://queue.taskcluster.net/v1/task/erJsxxJMT8Go5oSfaH43Mg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 18:31:02 INFO - Expected file size: 51787234 18:31:02 INFO - Obtained file size: 51787234 18:31:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/erJsxxJMT8Go5oSfaH43Mg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 18:31:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/erJsxxJMT8Go5oSfaH43Mg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:31:17 INFO - Fetch https://queue.taskcluster.net/v1/task/erJsxxJMT8Go5oSfaH43Mg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 18:31:18 INFO - Expected file size: 14404438 18:31:18 INFO - Obtained file size: 14404438 18:31: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')]} 18:31:18 INFO - trying https://queue.taskcluster.net/v1/task/erJsxxJMT8Go5oSfaH43Mg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 18:31:18 INFO - Downloading https://queue.taskcluster.net/v1/task/erJsxxJMT8Go5oSfaH43Mg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 18:31:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/erJsxxJMT8Go5oSfaH43Mg/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 18:31:20 INFO - Downloaded 74942013 bytes. 18:31:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/erJsxxJMT8Go5oSfaH43Mg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 18:31:20 INFO - mkdir: /builds/slave/test/properties 18:31:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:31:20 INFO - Writing to file /builds/slave/test/properties/build_url 18:31:20 INFO - Contents: 18:31:20 INFO - build_url:https://queue.taskcluster.net/v1/task/erJsxxJMT8Go5oSfaH43Mg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 18:31:21 INFO - Running post-action listener: _resource_record_post_action 18:31:21 INFO - Running post-action listener: set_extra_try_arguments 18:31:21 INFO - [mozharness: 2017-03-11 02:31:21.446681Z] Finished download-and-extract step (success) 18:31:21 INFO - [mozharness: 2017-03-11 02:31:21.446826Z] Running populate-webroot step. 18:31:21 INFO - Running pre-action listener: _resource_record_pre_action 18:31:21 INFO - Running main action method: populate_webroot 18:31:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:31:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:31:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:31:21 INFO - '--tppagecycles', 18:31:21 INFO - '7'], 18:31:21 INFO - 'tests': ['tsvgm']}}, 18:31:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:31:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:31:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:31:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:31:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:31:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:31:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:31:21 INFO - 'talos_options': ['--disable-e10s'], 18:31:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:31:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:31:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:31:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:31:21 INFO - 'talos_options': ['--disable-e10s'], 18:31:21 INFO - 'tests': ['damp', 'tps']}, 18:31:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:31:21 INFO - 'tests': ['damp', 'tps']}, 18:31:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:31:21 INFO - 'tests': ['dromaeo_dom']}, 18:31:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:31:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:31:21 INFO - 'tests': ['basic_compositor_video']}, 18:31:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:31:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:31:21 INFO - 'tests': ['a11yr', 18:31:21 INFO - 'ts_paint', 18:31:21 INFO - 'tpaint', 18:31:21 INFO - 'sessionrestore', 18:31:21 INFO - 'sessionrestore_no_auto_restore', 18:31:21 INFO - 'tabpaint']}, 18:31:21 INFO - 'other-e10s': {'tests': ['a11yr', 18:31:21 INFO - 'ts_paint', 18:31:21 INFO - 'tpaint', 18:31:21 INFO - 'sessionrestore', 18:31:21 INFO - 'sessionrestore_no_auto_restore', 18:31:21 INFO - 'tabpaint']}, 18:31:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:31:21 INFO - 'ts_paint', 18:31:21 INFO - 'tpaint', 18:31:21 INFO - 'sessionrestore', 18:31:21 INFO - 'sessionrestore_no_auto_restore', 18:31:21 INFO - 'tabpaint']}, 18:31:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:31:21 INFO - 'ts_paint', 18:31:21 INFO - 'tpaint', 18:31:21 INFO - 'sessionrestore', 18:31:21 INFO - 'sessionrestore_no_auto_restore', 18:31:21 INFO - 'tabpaint']}, 18:31:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:31:21 INFO - 'tests': ['a11yr', 18:31:21 INFO - 'ts_paint', 18:31:21 INFO - 'tpaint', 18:31:21 INFO - 'sessionrestore', 18:31:21 INFO - 'sessionrestore_no_auto_restore', 18:31:21 INFO - 'tabpaint']}, 18:31:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:31:21 INFO - 'tests': ['a11yr', 18:31:21 INFO - 'ts_paint', 18:31:21 INFO - 'tpaint', 18:31:21 INFO - 'sessionrestore', 18:31:21 INFO - 'sessionrestore_no_auto_restore', 18:31:21 INFO - 'tabpaint']}, 18:31:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:31:21 INFO - 'tests': ['tsvgx', 18:31:21 INFO - 'tsvgr_opacity', 18:31:21 INFO - 'tart', 18:31:21 INFO - 'tscrollx', 18:31:21 INFO - 'cart', 18:31:21 INFO - 'tsvg_static']}, 18:31:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:31:21 INFO - 'tsvgr_opacity', 18:31:21 INFO - 'tart', 18:31:21 INFO - 'tscrollx', 18:31:21 INFO - 'cart', 18:31:21 INFO - 'tsvg_static']}, 18:31:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:31:21 INFO - 'talos_options': ['--disable-e10s'], 18:31:21 INFO - 'tests': ['tp5o']}, 18:31:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:31:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:31:21 INFO - 'talos_options': ['--disable-e10s', 18:31:21 INFO - '--xperf_path', 18:31:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:31:21 INFO - 'tests': ['tp5n']}, 18:31:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:31:21 INFO - 'talos_options': ['--xperf_path', 18:31:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:31:21 INFO - 'tests': ['tp5n']}}, 18:31:21 INFO - 'talos.zip': {'path': '', 18:31:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:31:21 INFO - Running post-action listener: _resource_record_post_action 18:31:21 INFO - [mozharness: 2017-03-11 02:31:21.465205Z] Finished populate-webroot step (success) 18:31:21 INFO - [mozharness: 2017-03-11 02:31:21.465326Z] Running create-virtualenv step. 18:31:21 INFO - Running pre-action listener: _resource_record_pre_action 18:31:21 INFO - Running main action method: create_virtualenv 18:31:21 INFO - Creating virtualenv /builds/slave/test/build/venv 18:31:21 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 18:31:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:31:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:31:21 INFO - Using real prefix '/tools/python27' 18:31:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:31:22 INFO - Installing distribute.............................................................................................................................................................................................done. 18:31:25 INFO - Installing pip.................done. 18:31:25 INFO - Return code: 0 18:31:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:31:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:31:25 INFO - Reading from file tmpfile_stdout 18:31:25 INFO - Output received: 18:31:25 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) 18:31:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:31:25 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')]} 18:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:25 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')]} 18:31:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:25 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 0x108b9eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ba1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0835dd430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10897cd30>, '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 0x1088a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108971be8>, '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.y2rFti42sE/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.5WihervzjT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:31:25 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 18:31:25 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 18:31:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y2rFti42sE/Render', 18:31:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:25 INFO - 'HOME': '/Users/cltbld', 18:31:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:25 INFO - 'LOGNAME': 'cltbld', 18:31:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:25 INFO - 'MOZ_NO_REMOTE': '1', 18:31:25 INFO - 'NO_EM_RESTART': '1', 18:31:25 INFO - 'PAGER': '/bin/cat', 18:31:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:25 INFO - 'PWD': '/builds/slave/test', 18:31:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:25 INFO - 'SHELL': '/bin/bash', 18:31:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5WihervzjT/Listeners', 18:31:25 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 18:31:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:25 INFO - 'USER': 'cltbld', 18:31:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:25 INFO - 'XPC_FLAGS': '0x0', 18:31:25 INFO - 'XPC_SERVICE_NAME': '0', 18:31:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:25 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 18:31:25 INFO - Cleaning up... 18:31:25 INFO - Return code: 0 18:31:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:31:25 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')]} 18:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:25 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')]} 18:31:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:25 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 0x108b9eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ba1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0835dd430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10897cd30>, '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 0x1088a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108971be8>, '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.y2rFti42sE/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.5WihervzjT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:31:25 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 18:31:25 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 18:31:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y2rFti42sE/Render', 18:31:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:25 INFO - 'HOME': '/Users/cltbld', 18:31:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:25 INFO - 'LOGNAME': 'cltbld', 18:31:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:25 INFO - 'MOZ_NO_REMOTE': '1', 18:31:25 INFO - 'NO_EM_RESTART': '1', 18:31:25 INFO - 'PAGER': '/bin/cat', 18:31:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:25 INFO - 'PWD': '/builds/slave/test', 18:31:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:25 INFO - 'SHELL': '/bin/bash', 18:31:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5WihervzjT/Listeners', 18:31:25 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 18:31:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:25 INFO - 'USER': 'cltbld', 18:31:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:25 INFO - 'XPC_FLAGS': '0x0', 18:31:25 INFO - 'XPC_SERVICE_NAME': '0', 18:31:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:25 INFO - Downloading/unpacking psutil>=3.1.1 18:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:31:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:31:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:31:29 INFO - Installing collected packages: psutil 18:31:29 INFO - Running setup.py install for psutil 18:31:29 INFO - building 'psutil._psutil_osx' extension 18:31:29 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 18:31:30 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 18:31:30 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 18:31:30 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 18:31:30 INFO - building 'psutil._psutil_posix' extension 18:31:30 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 18:31:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:31:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:31:30 INFO - ^ 18:31:30 INFO - 1 warning generated. 18:31:30 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 18:31:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:31:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:31:30 INFO - Successfully installed psutil 18:31:30 INFO - Cleaning up... 18:31:31 INFO - Return code: 0 18:31:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:31 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 0x108b9eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ba1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0835dd430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10897cd30>, '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 0x1088a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108971be8>, '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.y2rFti42sE/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.5WihervzjT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:31:31 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 18:31:31 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 18:31:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y2rFti42sE/Render', 18:31:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:31 INFO - 'HOME': '/Users/cltbld', 18:31:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:31 INFO - 'LOGNAME': 'cltbld', 18:31:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:31 INFO - 'MOZ_NO_REMOTE': '1', 18:31:31 INFO - 'NO_EM_RESTART': '1', 18:31:31 INFO - 'PAGER': '/bin/cat', 18:31:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:31 INFO - 'PWD': '/builds/slave/test', 18:31:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:31 INFO - 'SHELL': '/bin/bash', 18:31:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5WihervzjT/Listeners', 18:31:31 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 18:31:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:31 INFO - 'USER': 'cltbld', 18:31:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:31 INFO - 'XPC_FLAGS': '0x0', 18:31:31 INFO - 'XPC_SERVICE_NAME': '0', 18:31:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:31:31 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 18:31:31 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 18:31:31 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 18:31:31 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 18:31:31 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 18:31:31 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 18:31:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:31:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:31:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:31:34 INFO - Installing collected packages: mozsystemmonitor 18:31:34 INFO - Running setup.py install for mozsystemmonitor 18:31:34 INFO - Successfully installed mozsystemmonitor 18:31:34 INFO - Cleaning up... 18:31:34 INFO - Return code: 0 18:31:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:31:34 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')]} 18:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:34 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')]} 18:31:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:34 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 0x108b9eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ba1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0835dd430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10897cd30>, '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 0x1088a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108971be8>, '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.y2rFti42sE/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.5WihervzjT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:31:34 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 18:31:34 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 18:31:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y2rFti42sE/Render', 18:31:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:34 INFO - 'HOME': '/Users/cltbld', 18:31:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:34 INFO - 'LOGNAME': 'cltbld', 18:31:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:34 INFO - 'MOZ_NO_REMOTE': '1', 18:31:34 INFO - 'NO_EM_RESTART': '1', 18:31:34 INFO - 'PAGER': '/bin/cat', 18:31:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:34 INFO - 'PWD': '/builds/slave/test', 18:31:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:34 INFO - 'SHELL': '/bin/bash', 18:31:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5WihervzjT/Listeners', 18:31:34 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 18:31:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:34 INFO - 'USER': 'cltbld', 18:31:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:34 INFO - 'XPC_FLAGS': '0x0', 18:31:34 INFO - 'XPC_SERVICE_NAME': '0', 18:31:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:34 INFO - Downloading/unpacking jsonschema==2.5.1 18:31:34 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 18:31:34 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 18:31:34 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 18:31:34 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 18:31:34 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 18:31:34 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 18:31:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:31:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:31:37 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 18:31:37 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 18:31:37 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 18:31:37 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 18:31:37 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 18:31:37 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 18:31:37 INFO - Downloading functools32-3.2.3-2.tar.gz 18:31:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:31:37 INFO - warning: no files found matching '*.txt' 18:31:37 INFO - no previously-included directories found matching 'build' 18:31:37 INFO - no previously-included directories found matching 'dist' 18:31:37 INFO - no previously-included directories found matching '.git*' 18:31:37 INFO - Installing collected packages: jsonschema, functools32 18:31:37 INFO - Running setup.py install for functools32 18:31:37 INFO - warning: no files found matching '*.txt' 18:31:37 INFO - no previously-included directories found matching 'build' 18:31:37 INFO - no previously-included directories found matching 'dist' 18:31:37 INFO - no previously-included directories found matching '.git*' 18:31:37 INFO - Successfully installed jsonschema functools32 18:31:37 INFO - Cleaning up... 18:31:37 INFO - Return code: 0 18:31:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:31:37 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')]} 18:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:37 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')]} 18:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:37 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 0x108b9eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ba1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0835dd430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10897cd30>, '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 0x1088a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108971be8>, '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.y2rFti42sE/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.5WihervzjT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:31:37 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 18:31:37 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 18:31:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y2rFti42sE/Render', 18:31:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:37 INFO - 'HOME': '/Users/cltbld', 18:31:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:37 INFO - 'LOGNAME': 'cltbld', 18:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:37 INFO - 'MOZ_NO_REMOTE': '1', 18:31:37 INFO - 'NO_EM_RESTART': '1', 18:31:37 INFO - 'PAGER': '/bin/cat', 18:31:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:37 INFO - 'PWD': '/builds/slave/test', 18:31:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:37 INFO - 'SHELL': '/bin/bash', 18:31:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5WihervzjT/Listeners', 18:31:37 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 18:31:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:37 INFO - 'USER': 'cltbld', 18:31:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:37 INFO - 'XPC_FLAGS': '0x0', 18:31:37 INFO - 'XPC_SERVICE_NAME': '0', 18:31:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:31:38 INFO - Cleaning up... 18:31:38 INFO - Return code: 0 18:31:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108b9eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ba1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0835dd430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10897cd30>, '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 0x1088a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108971be8>, '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.y2rFti42sE/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.5WihervzjT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:31:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:31:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y2rFti42sE/Render', 18:31:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:38 INFO - 'HOME': '/Users/cltbld', 18:31:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:38 INFO - 'LOGNAME': 'cltbld', 18:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:38 INFO - 'MOZ_NO_REMOTE': '1', 18:31:38 INFO - 'NO_EM_RESTART': '1', 18:31:38 INFO - 'PAGER': '/bin/cat', 18:31:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:38 INFO - 'PWD': '/builds/slave/test', 18:31:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:38 INFO - 'SHELL': '/bin/bash', 18:31:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5WihervzjT/Listeners', 18:31:38 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 18:31:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:38 INFO - 'USER': 'cltbld', 18:31:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:38 INFO - 'XPC_FLAGS': '0x0', 18:31:38 INFO - 'XPC_SERVICE_NAME': '0', 18:31:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:38 INFO - Downloading/unpacking blobuploader==1.2.4 18:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:41 INFO - Downloading blobuploader-1.2.4.tar.gz 18:31:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:31:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:31:41 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 18:31:41 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 18:31:41 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 18:31:41 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 18:31:41 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 18:31:41 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 18:31:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:31:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:31:41 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 18:31:41 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 18:31:41 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 18:31:41 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 18:31:41 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 18:31:41 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 18:31:42 INFO - Downloading docopt-0.6.1.tar.gz 18:31:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:31:42 INFO - Installing collected packages: blobuploader, requests, docopt 18:31:42 INFO - Running setup.py install for blobuploader 18:31:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:31:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:31:42 INFO - Running setup.py install for requests 18:31:43 INFO - Running setup.py install for docopt 18:31:43 INFO - Successfully installed blobuploader requests docopt 18:31:43 INFO - Cleaning up... 18:31:43 INFO - Return code: 0 18:31:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:43 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 0x108b9eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ba1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0835dd430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10897cd30>, '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 0x1088a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108971be8>, '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.y2rFti42sE/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.5WihervzjT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:31:43 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 18:31:43 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 18:31:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y2rFti42sE/Render', 18:31:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:43 INFO - 'HOME': '/Users/cltbld', 18:31:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:43 INFO - 'LOGNAME': 'cltbld', 18:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:43 INFO - 'MOZ_NO_REMOTE': '1', 18:31:43 INFO - 'NO_EM_RESTART': '1', 18:31:43 INFO - 'PAGER': '/bin/cat', 18:31:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:43 INFO - 'PWD': '/builds/slave/test', 18:31:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:43 INFO - 'SHELL': '/bin/bash', 18:31:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5WihervzjT/Listeners', 18:31:43 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 18:31:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:43 INFO - 'USER': 'cltbld', 18:31:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:43 INFO - 'XPC_FLAGS': '0x0', 18:31:43 INFO - 'XPC_SERVICE_NAME': '0', 18:31:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:31:43 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-lWotnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:31:43 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-Jdm7sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:31:43 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-a_ZDcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:31:43 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-tiNH18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:31:44 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-zGs82z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:31:44 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-KT3Sea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:31:44 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-Q6aTxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:31:44 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-_JZMMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:31:44 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-OGmFdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:31:44 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-EcAZJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:31:44 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-Y_XFbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:31:44 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-4Yco1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:31:44 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-dHHtHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:31:44 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-KXv1oB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:45 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-KlVMs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:31:45 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-xzDgQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:31:45 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-CC09Hg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:31:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:31:45 INFO - Running setup.py install for manifestparser 18:31:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:31:45 INFO - Running setup.py install for mozcrash 18:31:45 INFO - Running setup.py install for mozdebug 18:31:45 INFO - Running setup.py install for mozdevice 18:31:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:31:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:31:46 INFO - Running setup.py install for mozfile 18:31:46 INFO - Running setup.py install for mozhttpd 18:31:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:31:46 INFO - Running setup.py install for mozinfo 18:31:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:31:46 INFO - Running setup.py install for mozInstall 18:31:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:31:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:31:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:31:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:31:46 INFO - Running setup.py install for mozleak 18:31:46 INFO - Running setup.py install for mozlog 18:31:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:31:46 INFO - Running setup.py install for moznetwork 18:31:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:31:47 INFO - Running setup.py install for mozprocess 18:31:47 INFO - Running setup.py install for mozprofile 18:31:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:31:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:31:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:31:47 INFO - Running setup.py install for mozrunner 18:31:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:31:47 INFO - Running setup.py install for mozscreenshot 18:31:47 INFO - Running setup.py install for moztest 18:31:47 INFO - Running setup.py install for mozversion 18:31:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:31:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:31:47 INFO - Cleaning up... 18:31:48 INFO - Return code: 0 18:31:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:48 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 0x108b9eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ba1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0835dd430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10897cd30>, '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 0x1088a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108971be8>, '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.y2rFti42sE/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.5WihervzjT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:31:48 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 18:31:48 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 18:31:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y2rFti42sE/Render', 18:31:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:48 INFO - 'HOME': '/Users/cltbld', 18:31:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:48 INFO - 'LOGNAME': 'cltbld', 18:31:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:48 INFO - 'MOZ_NO_REMOTE': '1', 18:31:48 INFO - 'NO_EM_RESTART': '1', 18:31:48 INFO - 'PAGER': '/bin/cat', 18:31:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:48 INFO - 'PWD': '/builds/slave/test', 18:31:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:48 INFO - 'SHELL': '/bin/bash', 18:31:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5WihervzjT/Listeners', 18:31:48 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 18:31:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:48 INFO - 'USER': 'cltbld', 18:31:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:48 INFO - 'XPC_FLAGS': '0x0', 18:31:48 INFO - 'XPC_SERVICE_NAME': '0', 18:31:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:31:48 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-jRprfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:31:48 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)) 18:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:31:48 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-eHTaxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:31:48 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)) 18:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:31:48 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-zISyCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:31:48 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)) 18:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:31:48 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-YKmaV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:31:48 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-xmIlmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:31:48 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)) 18:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:31:48 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-bOinDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:31:48 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)) 18:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:31:48 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-WUQR85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:31:49 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)) 18:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:31:49 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-UnXC1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:31:49 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)) 18:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:31:49 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-Aq1qyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:31:49 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)) 18:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:31:49 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-QTHLgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:31:49 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)) 18:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:31:49 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-dsAOm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:31:49 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)) 18:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:31:49 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-oxBMFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:31:49 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)) 18:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:31:49 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-G0IHo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:31:49 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)) 18:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:31:49 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-YiYxa6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:31:49 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)) 18:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:49 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-m0XN__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:49 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)) 18:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:31:49 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-ciVKKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:31:50 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)) 18:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:31:50 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-9KEyhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:31:50 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)) 18:31:50 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)) 18:31:50 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)) 18:31:50 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)) 18:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:31:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:52 INFO - Downloading blessings-1.6.tar.gz 18:31:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:31:52 INFO - Installing collected packages: blessings 18:31:52 INFO - Running setup.py install for blessings 18:31:53 INFO - Successfully installed blessings 18:31:53 INFO - Cleaning up... 18:31:53 INFO - Return code: 0 18:31:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:31:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:31:53 INFO - Reading from file tmpfile_stdout 18:31:53 INFO - Current package versions: 18:31:53 INFO - blessings == 1.6 18:31:53 INFO - blobuploader == 1.2.4 18:31:53 INFO - docopt == 0.6.1 18:31:53 INFO - functools32 == 3.2.3-2 18:31:53 INFO - jsonschema == 2.5.1 18:31:53 INFO - manifestparser == 1.1 18:31:53 INFO - mozInstall == 1.12 18:31:53 INFO - mozcrash == 1.0 18:31:53 INFO - mozdebug == 0.1 18:31:53 INFO - mozdevice == 0.49 18:31:53 INFO - mozfile == 1.2 18:31:53 INFO - mozhttpd == 0.7 18:31:53 INFO - mozinfo == 0.9 18:31:53 INFO - mozleak == 0.1 18:31:53 INFO - mozlog == 3.4 18:31:53 INFO - moznetwork == 0.27 18:31:53 INFO - mozprocess == 0.25 18:31:53 INFO - mozprofile == 0.28 18:31:53 INFO - mozrunner == 6.13 18:31:53 INFO - mozscreenshot == 0.1 18:31:53 INFO - mozsystemmonitor == 0.3 18:31:53 INFO - moztest == 0.8 18:31:53 INFO - mozversion == 1.4 18:31:53 INFO - psutil == 3.1.1 18:31:53 INFO - requests == 1.2.3 18:31:53 INFO - wsgiref == 0.1.2 18:31:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:53 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')]} 18:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:53 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')]} 18:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:53 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 0x108b9eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ba1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0835dd430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10897cd30>, '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 0x1088a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108971be8>, '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.y2rFti42sE/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.5WihervzjT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:31:53 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 18:31:53 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 18:31:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y2rFti42sE/Render', 18:31:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:53 INFO - 'HOME': '/Users/cltbld', 18:31:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:53 INFO - 'LOGNAME': 'cltbld', 18:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:53 INFO - 'MOZ_NO_REMOTE': '1', 18:31:53 INFO - 'NO_EM_RESTART': '1', 18:31:53 INFO - 'PAGER': '/bin/cat', 18:31:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:53 INFO - 'PWD': '/builds/slave/test', 18:31:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:53 INFO - 'SHELL': '/bin/bash', 18:31:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5WihervzjT/Listeners', 18:31:53 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 18:31:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:53 INFO - 'USER': 'cltbld', 18:31:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:53 INFO - 'XPC_FLAGS': '0x0', 18:31:53 INFO - 'XPC_SERVICE_NAME': '0', 18:31:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:53 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)) 18:31:53 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)) 18:31:53 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)) 18:31:53 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)) 18:31:53 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)) 18:31:53 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)) 18:31:53 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)) 18:31:53 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)) 18:31:53 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)) 18:31:53 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)) 18:31:53 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)) 18:31:53 INFO - Cleaning up... 18:31:53 INFO - Return code: 0 18:31:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:31:53 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')]} 18:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:53 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')]} 18:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:53 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 0x108b9eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ba1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0835dd430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10897cd30>, '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 0x1088a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108971be8>, '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.y2rFti42sE/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.5WihervzjT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:31:53 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 18:31:53 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 18:31:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y2rFti42sE/Render', 18:31:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:53 INFO - 'HOME': '/Users/cltbld', 18:31:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:53 INFO - 'LOGNAME': 'cltbld', 18:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:53 INFO - 'MOZ_NO_REMOTE': '1', 18:31:53 INFO - 'NO_EM_RESTART': '1', 18:31:53 INFO - 'PAGER': '/bin/cat', 18:31:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:53 INFO - 'PWD': '/builds/slave/test', 18:31:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:53 INFO - 'SHELL': '/bin/bash', 18:31:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5WihervzjT/Listeners', 18:31:53 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 18:31:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:53 INFO - 'USER': 'cltbld', 18:31:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:53 INFO - 'XPC_FLAGS': '0x0', 18:31:53 INFO - 'XPC_SERVICE_NAME': '0', 18:31:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:31:54 INFO - Cleaning up... 18:31:54 INFO - Return code: 0 18:31:54 INFO - Running post-action listener: _resource_record_post_action 18:31:54 INFO - Running post-action listener: _start_resource_monitoring 18:31:54 INFO - Starting resource monitoring. 18:31:54 INFO - [mozharness: 2017-03-11 02:31:54.057678Z] Finished create-virtualenv step (success) 18:31:54 INFO - [mozharness: 2017-03-11 02:31:54.058645Z] Running install step. 18:31:54 INFO - Running pre-action listener: _resource_record_pre_action 18:31:54 INFO - Running main action method: install 18:31:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:31:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:31:54 INFO - Reading from file tmpfile_stdout 18:31:54 INFO - Detecting whether we're running mozinstall >=1.0... 18:31:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:31:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:31:54 INFO - Reading from file tmpfile_stdout 18:31:54 INFO - Output received: 18:31:54 INFO - Usage: mozinstall [options] installer 18:31:54 INFO - Options: 18:31:54 INFO - -h, --help show this help message and exit 18:31:54 INFO - -d DEST, --destination=DEST 18:31:54 INFO - Directory to install application into. [default: 18:31:54 INFO - "/builds/slave/test"] 18:31:54 INFO - --app=APP Application being installed. [default: firefox] 18:31:54 INFO - mkdir: /builds/slave/test/build/application 18:31:54 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'] 18:31:54 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 18:32:14 INFO - Reading from file tmpfile_stdout 18:32:14 INFO - Output received: 18:32:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:32:14 INFO - Running post-action listener: _resource_record_post_action 18:32:14 INFO - [mozharness: 2017-03-11 02:32:14.541831Z] Finished install step (success) 18:32:14 INFO - [mozharness: 2017-03-11 02:32:14.542010Z] Running run-tests step. 18:32:14 INFO - Running pre-action listener: _resource_record_pre_action 18:32:14 INFO - Running main action method: run_tests 18:32:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:32:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:32:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:32:14 INFO - 2017-03-10 18:32:14.556 screenresolution[1632:7650] starting screenresolution argv=screenresolution get 18:32:14 INFO - 2017-03-10 18:32:14.559 screenresolution[1632:7650] Display 0: 1600x1200x32@60 18:32:14 INFO - 2017-03-10 18:32:14.564 screenresolution[1633:7652] starting screenresolution argv=screenresolution list 18:32:14 INFO - Available Modes on Display 0 18:32:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:32:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:32:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:32:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:32:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:32:14 INFO - Intel Iris: 18:32:14 INFO - Chipset Model: Intel Iris 18:32:14 INFO - Type: GPU 18:32:14 INFO - Bus: Built-In 18:32:14 INFO - VRAM (Dynamic, Max): 1536 MB 18:32:14 INFO - Vendor: Intel (0x8086) 18:32:14 INFO - Device ID: 0x0a2e 18:32:14 INFO - Revision ID: 0x0009 18:32:14 INFO - Displays: 18:32:14 INFO - Display: 18:32:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:32:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:32:14 INFO - Display Serial Number: 1600x1200 60 18:32:14 INFO - Main Display: Yes 18:32:14 INFO - Mirror: Off 18:32:14 INFO - Online: Yes 18:32:14 INFO - Rotation: Supported 18:32:14 INFO - Return code: 0 18:32:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:32:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:32:14 INFO - Python 2.7.3 18:32:14 INFO - Return code: 0 18:32:14 INFO - grabbing minidump binary from tooltool 18:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:32:14 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 0x10897cd30>, '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 0x1088a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108971be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:32:14 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 18:32:14 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 18:32:14 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 18:32:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:32:14 INFO - Return code: 0 18:32:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:32:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:32:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:32:14 INFO - ENV: RUST_BACKTRACE is now 1 18:32:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:32:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:32:14 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/erJsxxJMT8Go5oSfaH43Mg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0210', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:32:14 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/erJsxxJMT8Go5oSfaH43Mg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0210 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:32:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y2rFti42sE/Render', 18:32:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:32:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:32:14 INFO - 'HOME': '/Users/cltbld', 18:32:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:32:14 INFO - 'LOGNAME': 'cltbld', 18:32:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:32:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:14 INFO - 'MOZ_NO_REMOTE': '1', 18:32:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:32:14 INFO - 'NO_EM_RESTART': '1', 18:32:14 INFO - 'PAGER': '/bin/cat', 18:32:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:14 INFO - 'PWD': '/builds/slave/test', 18:32:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:32:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:32:14 INFO - 'RUST_BACKTRACE': '1', 18:32:14 INFO - 'SHELL': '/bin/bash', 18:32:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5WihervzjT/Listeners', 18:32:14 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 18:32:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:32:14 INFO - 'USER': 'cltbld', 18:32:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:32:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:14 INFO - 'XPC_FLAGS': '0x0', 18:32:14 INFO - 'XPC_SERVICE_NAME': '0', 18:32:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:32:14 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/erJsxxJMT8Go5oSfaH43Mg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0210', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:32:15 INFO - mozversion application_buildid: 20170310170836 18:32:15 INFO - mozversion application_changeset: 4ceb9062ea8f4113bfd1b3536ace4a840a72faa7 18:32:15 INFO - mozversion application_display_name: Nightly 18:32:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:32:15 INFO - mozversion application_name: Firefox 18:32:15 INFO - mozversion application_remotingname: firefox 18:32:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:32:15 INFO - mozversion application_vendor: Mozilla 18:32:15 INFO - mozversion application_version: 55.0a1 18:32:15 INFO - mozversion platform_buildid: 20170310170836 18:32:15 INFO - mozversion platform_changeset: 4ceb9062ea8f4113bfd1b3536ace4a840a72faa7 18:32:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:32:15 INFO - mozversion platform_version: 55.0a1 18:32:15 INFO - using testdate: 1489199535 18:32:15 INFO - actual date: 1489199535 18:32:15 INFO - starting webserver on 'localhost:49239' 18:32:15 INFO - SUITE-START | Running 2 tests 18:32:15 INFO - TEST-START | dromaeo_css 18:32:15 INFO - operating with platform_type : mac_ 18:32:15 INFO - Initialising browser for dromaeo_css test... 18:32:15 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/tmpIjvzHH/profile http://localhost:49239/getInfo.html) 18:32:17 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 18:32:17 INFO - PROCESS | 1643 | colorDepth:24 18:32:17 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 18:32:17 INFO - PROCESS | 1643 | __metrics 18:32:18 INFO - PROCESS | 1643 | 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" 18:32:18 INFO - PROCESS | 1643 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:32:18 INFO - TEST-INFO | 1643: exit 0 18:32:18 INFO - Browser initialized. 18:32:18 INFO - Running cycle 1/1 for dromaeo_css test... 18:32:18 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/tmpIjvzHH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:32:30 INFO - PROCESS | 1646 | RSS: Main: 232652800 18:32:30 INFO - PROCESS | 1646 | 18:35:35 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49239/tests/dromaeo/cssquery-ext.html) 18:35:37 INFO - PROCESS | 1646 | RSS: Main: 405233664 18:35:37 INFO - PROCESS | 1646 | 18:37:20 INFO - PROCESS | 1646 | ************************* 18:37:20 INFO - PROCESS | 1646 | A coding exception was thrown and uncaught in a Task. 18:37:20 INFO - PROCESS | 1646 | 18:37:20 ERROR - PROCESS | 1646 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:37:20 INFO - PROCESS | 1646 | Full stack: 18:37:20 INFO - PROCESS | 1646 | ************************* 18:38:40 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-ext.html (next: http://localhost:49239/tests/dromaeo/cssquery-jquery.html) 18:38:40 INFO - PROCESS | 1646 | RSS: Main: 472838144 18:38:40 INFO - PROCESS | 1646 | 18:41:43 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49239/tests/dromaeo/cssquery-mootools.html) 18:41:44 INFO - PROCESS | 1646 | RSS: Main: 361140224 18:41:44 INFO - PROCESS | 1646 | 18:44:46 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49239/tests/dromaeo/cssquery-prototype.html) 18:44:47 INFO - PROCESS | 1646 | RSS: Main: 357138432 18:44:47 INFO - PROCESS | 1646 | 18:47:51 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49239/tests/dromaeo/cssquery-yui.html) 18:47:52 INFO - PROCESS | 1646 | RSS: Main: 330002432 18:47:52 INFO - PROCESS | 1646 | 18:50:55 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-yui.html (next: http://localhost:49239/tests/dromaeo/cssquery-dojo.html) 18:50:55 INFO - PROCESS | 1646 | RSS: Main: 525524992 18:50:55 INFO - PROCESS | 1646 | 18:50:55 INFO - PROCESS | 1646 | __start_tp_report 18:50:55 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 18:50:55 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 18:50:55 INFO - PROCESS | 1646 | |i|pagename|runs| 18:50:55 INFO - PROCESS | 1646 | |0;dojo.html;3366.4781958796384;3389.1188291044336;3394.185395505078;3398.830073355688;3463;5618.213450116977;5787.074068149097;5914.112883067537;5941.970290148543;5960;5804.912926306109;5848.6490810551395;5861.032929566616;5886.205362276091;5907.616004959675;5219.895602087956;5222.92165617516;5267.578593712494;5291.973540132294;5314.92027619586;5401.162819762923;5415.64798288112;5439.5376393006645;5457.263269458632;5478.096114141162;5198.220266959948;5229.398619158807;5297.099493086146;5299.814506492293;5357.08929481989;5293.4971177738435;5298.417174110845;5301.231321458406;5321.388040375367;5328.44051374604;5188.429272779991;5233.842984710464;5243.397009343936;5253.973730131325;5258.0535503609335;5742.885142297131;5756.280464941882;5761;5767.279090113736;5774.307083150007;6321.525885558555;6321.6523091229965;6327.651979141146;6330.715117819663;6332.461740751995;6212.751489940442;6327.936720632781;6332.240131184288;6343.714532846033;6349.968250158766;5965.880682386328;5966.761329546813;6028.608140470899;6044.335123136451;6052.213212282463;6436.14210363639;6464.159659244268;6476.255230648536;6480.189976252968;6491;6186.133941248228;6229;6285.277193122758;6324.620522768649;6352.078948552434;6275.121482992385;6341.8097457076365;6368.808935731936;6372.1716176897635;6374.521910856704;6300.086487459293;6307.211598550181;6310.274318453345;6313.021481670348;6336.968315158395;6230.968845155836;6285.245770507477;6295.464885484785;6320.62076275425;6329;4945.282933974626;5087.313212716236;5091.66904151229;5096.0317539668085;5100.846974590768;4531.637469002472;4566.383538222364;4595.1039547287955;4622.537746225418;4622.9768851156205;5739.512141467939;5820.476157145878;5826.475617194473;5836.766529338779;5837.211976383134;6292.590981586182;6313.021481670348;6318.147050148263;6337.556371054075;6341.175647165839;4639.350490931272;5792.478676919098;5900.881982360329;6035.486983606443;6051.4553690168095;5018.723970181602;5660.8867822643315;5664.51851592611;5673.3475650299915;5674.631148975303;6585.111010013587;6589.406953374123;6601.669916504252;6611.504137189826;6631.469482441393;6242.500599952084;6309.842253943688;6311.621302721851;6312.84217894538;6318.210223722035;6443.226812782309;6443.420092191538;6448.516361272829;6456.031595260749;6457.483401327976;6251.374862513712;6288.937110629018;6327.050942358499;6339;6349.396807303298;6378.968105159444;6402.167718196604;6410.262819775599;6411.551191416556;6419.037144428373;6115.021596544531;6143.1706719592285;6248.625082494883;6274.968625156845;6278.497720182466;6131.356207598316;6151.415615516519;6170.9074363885475;6200.56596038273;6226.906596401148;6207.193064901534;6246.063090536274;6253.37466253371;6254.3745625437095;6256.593321434092;6292.528060395397;6312.747490100528;6313.936860631335;6323.08315294289;6326.240851097898;6009.06859436788;6092.75628974836;6117.12715980571;6236.314005459487;6238.407351301619 18:50:55 INFO - PROCESS | 1646 | |1;ext.html;721.54542638138;767.1331395523059;785.5757890739001;856.687309132167;868.7306934850193;27194.456110877796;38906;39177.99999999996;39190.21619567607;39378.62174823882;39673;40010.599894001054;40011.19977600446;40013.79958601239;40044;7230.819229519251;8904.287656987426;9057.592408341641;9071.047540008303;9072.909270907272;7329.19378868324;10807.83788243177;11031.062359699436;11220.214584979014;11294.152938529602;11079.224454288164;11104.389258590814;11113.444327783618;11117.833232501518;11121.388323642197;7190.316919892602;11067.778644427146;11087.889121108767;11088.501017454233;11101.278416902916;7302.74440394589;7336.413086953031;7350;7356.117265928069;10551.788964220672;37957.43063854044;38034.809825950695;38094.428583571265;38203.61796382028;38238.04404889872;3680.7607505512055;3698.6076823349963;3706.981465092684;3709.684676802475;3757.830897609614;26785;27057.1882843515;27265.1820445385;27389.178324650293;27955.301117472023;2810.199093258432;3060.2039140754478;3118.5789918360956;3129.264622813637;3145.1036454610326;276073;333863;335118;335839;337285.99999999756;49747.75630609264;49870.75064624654;49955.750221249386;49993.75003124961;50027.499725002286;51286;51351;51401.228981565306;51417;51453.742731286104;14369.856301437061;14476.638084047772;14481;14525.491607793889;14549.34527946245;10364.689059328231;10612.57549698019;11940.820887686692;11975.401229938469;11977.760444791056;10427.791444171226;10489.685309440729;10510.842337364946;10515.369077855354;10532.736681582868;4731.157944406738;5467.398586155519;5615.943840561624;5627.662340259598;5654.37801841797;966.6809952715587;968.6971023972745;975.3708857786688;975.7120600806867;1001.4992503748126;25200.99196032175;25316.493670126863;25331.746682533307;25425.36436589063;25489.61765573518;1035.1511760356436;1037.419045334615;1072.8015317166348;1079.422508957704;1082.2153938394758;11740.473738414123;12247.632571022883;12449.004079673605;13124.934375328254;13161.47354105825;445560;445632;446548;447023;447458.7627061844;52273.95452090937;52438.737806310724;52597;52756;52759.472405275454;1339.819124418191;1420.2117824607442;1421.5451055662295;1424.7364237615866;1424.7364237616075;24078.638820417356;28121.71878281191;29111.563326549694;29227.269318267212;29944.700552995062;51371.74314128555;51817;51824;51857.7407112962;51886;449869;451233;451618;452812;452900;31601.8419907899;31988.20029499281;32076;32277.354452910342;32314.676853232108;34199.974000780014;41225.38161927513;41522.169556609304;41592.792036039624;42402.36396453994;32994;33663.326733465685;34475.4828677565;35499.112522187155;35510.644893550736;33744.662553375136;33812.83093584615;33925.32149357048;35139.82430087833;35290;34400.82799585986;34948.47577286292;35181.29637407289;35325.646743532234;35425.46861797023;25383.97345466787;30442.93449729249;30833.039444077713;31040.68959310378;32449.837750811093;23255.534889302457;24455.877720611283;24478.265652029757;24495.387615309046;24871.37821554403 18:50:55 INFO - PROCESS | 1646 | |2;jquery.html;379.54454654414707;389.4878235120816;389.9571047184811;404.77130421311955;434.4048653344916;13401.98970154476;14749.451307612708;18220.36228731993;19297.26324630783;22173.002214900327;18936.147873345697;22382.77617223827;23136.30591082266;23457.648135277985;23669.171578994738;6096.847578810543;6465.9676701616545;6606.669666516679;6963.40811031063;7490.925090749104;7188.748393806218;7491.400687944952;7604.315611594955;7728.961355193216;7748.806279843021;7673.46285759997;7698.153203147677;7711.537307761552;7727.768166954972;7731.342835858959;7410.5924174170395;7534.962325188394;7648.770536883902;7651.502652327581;7657.425693072986;6939.4448444124855;7209.531380460253;7354.227806080338;7418;7434.256574342522;26489.33776655599;28015.719842801514;28431.857840710873;28432.28919277014;28689.426211475864;2805.6072149899032;2884.8172249377653;2898.087102562686;2900.347421830071;2911.083008852205;13380.531681391105;15262.618434539225;15704.607384815357;16306.347746090261;16795.160241987975;1964.6168997045581;1969.812867777559;1975.4172519106899;1984.642764302425;1995.8503112266637;152920.7079292073;166760.65632780505;169420.5708346659;172589.19286457053;175571;19402.805971940383;19869.708468949473;21144.577108457746;21917.452063698216;22035;37008;37128.257434851694;37129.81435092807;37147;37150.07124821847;10344.37933723979;10505.894941050492;10731.141508679288;10764.515596798163;10933.649265407976;8600.655973760979;8601.698940537051;8620.439671421338;8809.559522024001;8815.955920220358;8435.873461898076;10159.898401016044;10166.237532185116;10335.689929302132;10387.896121038844;3924.3132451820816;4037.4953130858644;4042.8382864685673;4044.676425885922;4068.5117785865887;858.819647873941;882.6557642519423;899.0515006667897;902.0933961368913;928.7863791328033;23340.76659233386;24388.390290242885;24907.62638560423;24954.750452495606;25005.749712514666;869.8127056567739;901.7024381953939;925.8379783537854;933.7152168588646;959.1128206409044;7249.927500725031;7289.963550182215;7392.297731715478;7464.290892365217;7537.886931696029;548006;695284;714282;726495;730720;151064.2446787759;156580;157781.42218577667;160415;161773;1229.2133034857698;1263.968400789969;1295.533607901155;1296.786030305008;1310.3710219094887;12656.936715316364;12727.363631818558;12900.935495322463;12915.870841291842;13109.73780524365;55567.44432555623;59465.40534594599;60133.69933150306;62490.06264905939;62996.055059175065;74580;81153;86211;88083.55958220168;89838.55080724554;10145.847812282675;11763.353015584225;11847.644570662895;11967.401629918295;12241.143119981516;13631.93184034113;13646.590602281947;13967.511137110152;14167;14247.572572822832;11254.718632034264;11533.192676512563;11596;11802.940985295361;11901.285922844658;11388.487518061873;11499.655010349703;11530.308181509135;11571.363575003119;11862.288262704265;11705.941470292593;11710.765784684429;11928;11978.940105299418;12092.274463532216;11688.649340519798;11966.042716582479;12050.397480125783;12062.276263424223;12074.154809163625;11005.86781044289;11018.724531886766;11347.602833900773;11438.714032149262;11728.296302221894 18:50:55 INFO - PROCESS | 1646 | |3;mootools.html;1334.9866501334984;1554.8289688134303;1582.4065975259277;1585.0727324515158;1588.182086225594;8991.37060405771;9409.96490386057;10651.573937042509;10657.253992220538;11061.170412219075;10774.138068954484;10886.510107045182;10930.945345273283;10932.836007459895;10938.835917461245;2289.839711220219;2335.089315167086;2336.6261398176293;2338.088145623208;2339.777721116491;1991.890446025468;2072.823809976154;2255.988720056406;2331.743508214095;2353.4234112642425;2309.3880121767743;2334.1130370459286;2336.1473062332298;2337.0184522500504;2341.1922886604093;2264.784845439681;2302.82728795341;2306.815454763615;2307.746147923727;2311.364374796936;2217.1020736601704;2220.411590928405;2263.841531092824;2300.0799680127916;2312.0520586559596;9083.273338132933;9191.494467804268;10940.671779846618;10951.890481095166;10955.780884382268;5576;5760.395158508338;5761.423857614247;5765.336986246593;5778.393268706809;2946.4401763664837;3342.782719123249;3530.8058056806867;3596.514470546469;3629.5644522657185;1114.7658991611772;1180.1648436680957;1216.3735676126803;1221.0902877356427;1222.8165775133712;14987.100773953489;14993.625159371102;15186.936914415995;15190.164540950243;15213.771793422997;4506.324051392317;4644.373009643655;4755.429348478136;4770.546798054179;4821;10123.544440500194;12560.560380386643;12573.93713031429;12581.496740130475;12612.747745045048;5775.393583673737;5779.508741756998;5779.595428320062;5783.421657834183;5788.739506722208;4107.835686572504;5033.119204139261;5114.948850511521;5143.639945203875;5156.871078222999;3545.71634269263;3628.5101511296166;3629.346717590859;3632.6730594246646;3641.308151451216;951.6574033347989;1028.2134167361974;1088.3198001249218;1119.457063324287;1127.560251501915;785.6195726947359;795.6578671171336;840.5125027484045;848.588434609214;941.2140862379989;6481.48148148147;6639.435647969976;6857.245702972669;6862.588244705334;6948.096747422803;1006.1246715357686;1018.4296793795498;1026.199564339816;1029.552144817007;1070.4754670211696;4190.617096358194;4198.8110535026;4208.85269015583;4317.309230523101;4332.4801023877335;11732.824007639892;12943.5469758558;13394.263315517741;13423.463061477432;13453.798193027113;12169.513219471122;12921.289329086803;13152.342382881008;13369.799453008212;13391.598252052454;9273.629054837731;9828.852567211497;9963.252756043326;9971;9971.952944940822;6589.374009469093;6681.866362672622;6799.966000169968;6828.9658551706925;6852.965735171292;11659.242149260272;11661.76676466483;12022.75954480923;12024.819627705767;12025.699357516132;11847.229930054518;11900.642980710592;12025;12219.144659873724;12336.50653973831;8205.95897020511;8462.95768521178;8483.10927352619;8493.57532123379;8500.91499085026;9948.602055917681;10038.949805250926;10078.798424031625;10115.59537618487;10152.695419137437;8847.646094156162;8848.513331766557;8932.330075244252;8973.50645714492;9183.265338772748;8625.439346442461;8644.438111522732;8694.434861733967;8724.20216068546;8931.955340223258;7618.238176182337;7683.039620047494;7806.141324454419;7807.141214466291;7807.843843122992;5646.632968857176;5726.685032323096;5782.87233989368;5811.1573821794755;5882.823515294548;5778.393268706725;5913.556483263858;5937.19847820556;5950.928832810136;5989.610675306091 18:50:55 INFO - PROCESS | 1646 | |4;prototype.html;363.91811842335477;375.6975634614136;379.54454654414707;380.83433706337746;386.60759329280785;4539.455265368152;5009.02324046811;5136.691798492088;5190.9740451297785;5198.740062996854;3997.6014391365165;4630.606398456127;4959.330490383806;4989.829424200475;5017.799288028475;3834.6740527055235;3916.4125381192766;3967;4200.537940826506;4239.389032167772;3913.7651740895494;4208.768517731523;4269.359596060584;4278.35824626307;4301.634361079312;4040.919181616366;4163.666906647461;4180.6237438630515;4233.640140588053;4243.490781106271;3585.533880595532;4151.709380343347;4185.267578173823;4194.909323575862;4235.57644235577;3490.8080055596934;3718.4050551911564;3786.9775160706454;3885.941710874339;3897.9610203897882;3979.9204015919518;4923.704577725348;4940.973106917851;4955.479674634147;5020.021095886304;4390.363397307405;4802.422195464366;4810.518948105197;4841.273808928654;4856.295837103636;5027.773750181251;5335.413104558495;5438.791113243166;5440.727963601804;5505.614606977513;3812.485314482537;4023.652076554358;4122.3404255319;4325.545817689161;4329.718568293051;4652.534746525321;5265.210218467222;5391.81128660499;5401.945980540223;5681.744321505501;3782.451544526083;4414.911701766011;4416.80124394403;4466.932996005063;4504.954950450519;4496.595306422438;4520.819167233274;4520.954790452053;4525.637948964075;4534.954650453519;4220.2192594370135;4246.978765106216;4555.85645904325;4746.724759915716;4824.445188803333;4551.385562949025;4841.1285968526;4953.554180123734;5319.962607291541;5359.23999140443;1365.0922136778931;1376.9793453098212;1403.5789263221197;1509.3057193690806;1539.2842328317386;1039.5010395010286;1054.1566746602687;1056.487603512296;1077.983830242547;1163.4008485629906;4063.674906007512;4606.516315786861;4729.0541891621815;4824.480288709045;4944.629152813553;4834.95165048352;5211.348581427322;5231.973840130775;5245.291885595396;5571.554275657938;4243.6605071594195;4323.978380108079;4509.751963641966;4679.67242293043;4770.829272680991;2534.505771374564;2561.743825617423;2653.4295126547886;2899.913002609925;2902.7677785777087;4909.410870695539;5694.658320500783;5764.011416061452;5774.595778295563;5775.624584402;5434.294887774336;5535.308086489189;5670.971645141748;5715.31416230055;5777.277840269966;5306.52241298285;5391.838244852661;5601.831945041574;5757.71810068257;5771.1920331154515;5078.898422031465;5289.709066001253;5484.012877682056;5566.749496272597;5593.888122237614;4514.367988481549;4994.9750251248515;5130.769115389742;5269.499397557226;5527.2538207341495;4888.2870007146375;5138.97430512845;5326.760295786621;5462.579729270339;5625.693465679052;3876.9806150970194;3893.357595996742;4102.323116685713;4286.849960251377;4288.71338598413;4271.675780508052;5033.5353575530435;5362.839114826562;5485.259489968803;5556.777728890799;4722.906496244965;5372.650777699437;5406.810501689622;5414.404415514212;5497.45025497463;4867.491077765904;5275.841724748264;5391.919121213264;5469.316335458067;5562.833115006556;4734;4914.8053765053;4957.578605818546;5337.919931201112;5341.839744807662;4703.506131856243;4703.717776933395;5391.840754237857;5419.918701219406;5472.781088756406;4490.708103973231;4594.540545945379;4935.938773163787;5298.2052692096495;5319.38827034896 18:50:55 INFO - PROCESS | 1646 | |5;yui.html;726.0815068937794;766.222284381353;786.8111653203231;792.8771040488726;818.8607936650767;15451.381944722198;15595.922020389911;15598.610034749137;15689.13709745965;15720.292586833591;14443.783343249834;14523.491677791279;14537.709245815078;14560.053596516245;14565.563033108998;940.6754669638964;943.575391074016;961.9759506012335;984.9803003939917;988.9109980101789;812.6627449608405;980.1374790184627;981.0140808487496;986.2159583131428;986.6448078691665;1023.4115383654391;1036.7822757220993;1042.7445275907414;1045.080329310206;1047.3244757131645;1028.5782829040133;1032.102071198055;1032.7934413117368;1033.5245786938017;1034.348360532867;769.3729610367533;772.0118248641747;773.215186585616;773.2576726342718;773.6827900560743;15610.9219453902;15915.522534323989;16035.91982040094;16069.598260043593;16130.274137663833;14333.21167335796;14432.639184020378;14474.855251447456;14475.493357732534;14516.782248266285;11515.481803318788;11645.767084658259;11841.526338946433;11866.52533898643;12191.939040304742;3654.526369203674;3685.3182161300247;3813.0657988792645;3894.902627434337;3895.02624343914;111934.32098518529;113044.30433543421;115102;118428;118594;9729;10043.296969212084;10223.437710925971;10256.12822910046;10828.458577071273;22280.777192228194;23076.423089422562;24695.62956555653;24799;24929.62605560918;7933.920660793434;7937.563434011069;8177.713780017671;8257.628406721711;8281.54451505173;4161.10536234705;4261.808218630169;4266.1254442839145;4371.868843934687;4380.102079073782;3296.0935742670476;3334.6665333466945;3373.6963673269033;3375.375555522236;3377.3751855906735;549.895519851235;639.8912184928573;645.686841881687;647.414090248326;659.8452707761418;627.2692313454866;629.7260691599078;661.216458496683;678.1726293921506;687.4225650453643;9802;10067.295289329677;10188.847167292497;10307.330023548595;10360.585576576852;632.7595513704855;690.994602852848;704.4998051383473;708.1502197363081;713.2368365848596;4837.661363704507;4898.522049344933;4918.704877707349;4922.655414121049;4937.802487900443;104153;104709.47645261725;106261.46869265604;106548.93451065545;108572.45713771539;75145.12137196504;90839.63740543897;90954.54522727476;92840.53579732058;93200;66321;77265.61367193128;77524;77674;78214;8712.821794551362;9437.339386243171;9453.43279403238;9459.337846350689;9472.905270947202;46936.7653161732;51021;52088.437346879655;52943.735281323345;53098.67253318698;61565;62598;66061.66969165123;67822;68835.57706247234;12032.458539365925;13285.867141328463;13665.31673416345;13800.723985520433;13868.791968120688;14437.566872993826;14469;14638.268086595415;14776.63058423548;15397.69204615879;13520.932395338354;13615.52345667897;13659.248741319323;13785.793213101611;13854.099483533539;12767.170133941636;12940.352982351033;13064.608061758163;13193.60419187426;13485.595432136659;12435.564755233523;12639.115261931576;13244;13253.271070090852;13660.248686322348;10353.689389318333;10726.892731072589;10965.671029869116;11110.44447777624;11588.884111159117;9621.374610650286;9896.802063958825;11189;11365.829512557153;11723.237989530653 18:50:55 INFO - PROCESS | 1646 | __end_tp_report 18:50:55 INFO - PROCESS | 1646 | __start_cc_report 18:50:55 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,1646 18:50:55 INFO - PROCESS | 1646 | __end_cc_report 18:50:55 INFO - PROCESS | 1646 | __startTimestamp1489200655960__endTimestamp 18:50:55 INFO - PROCESS | 1646 | 18:50:55 INFO - PROCESS | 1646 | ------- Summary: start ------- 18:50:55 INFO - PROCESS | 1646 | Number of tests: 6 18:50:55 INFO - PROCESS | 1646 | 18:50:55 INFO - PROCESS | 1646 | [#0] dojo.html Cycles:165 Average:5875.73 Median:6170.91 stddev:664.60 (10.8%) stddev-sans-first:636.82 18:50:55 INFO - PROCESS | 1646 | Values: 3366.5 3389.1 3394.2 3398.8 3463.0 5618.2 5787.1 5914.1 5942.0 5960.0 5804.9 5848.6 5861.0 5886.2 5907.6 5219.9 5222.9 5267.6 5292.0 5314.9 5401.2 5415.6 5439.5 5457.3 5478.1 5198.2 5229.4 5297.1 5299.8 5357.1 5293.5 5298.4 5301.2 5321.4 5328.4 5188.4 5233.8 5243.4 5254.0 5258.1 5742.9 5756.3 5761.0 5767.3 5774.3 6321.5 6321.7 6327.7 6330.7 6332.5 6212.8 6327.9 6332.2 6343.7 6350.0 5965.9 5966.8 6028.6 6044.3 6052.2 6436.1 6464.2 6476.3 6480.2 6491.0 6186.1 6229.0 6285.3 6324.6 6352.1 6275.1 6341.8 6368.8 6372.2 6374.5 6300.1 6307.2 6310.3 6313.0 6337.0 6231.0 6285.2 6295.5 6320.6 6329.0 4945.3 5087.3 5091.7 5096.0 5100.8 4531.6 4566.4 4595.1 4622.5 4623.0 5739.5 5820.5 5826.5 5836.8 5837.2 6292.6 6313.0 6318.1 6337.6 6341.2 4639.4 5792.5 5900.9 6035.5 6051.5 5018.7 5660.9 5664.5 5673.3 5674.6 6585.1 6589.4 6601.7 6611.5 6631.5 6242.5 6309.8 6311.6 6312.8 6318.2 6443.2 6443.4 6448.5 6456.0 6457.5 6251.4 6288.9 6327.1 6339.0 6349.4 6379.0 6402.2 6410.3 6411.6 6419.0 6115.0 6143.2 6248.6 6275.0 6278.5 6131.4 6151.4 6170.9 6200.6 6226.9 6207.2 6246.1 6253.4 6254.4 6256.6 6292.5 6312.7 6313.9 6323.1 6326.2 6009.1 6092.8 6117.1 6236.3 6238.4 18:50:55 INFO - PROCESS | 1646 | 18:50:55 INFO - PROCESS | 1646 | [#1] ext.html Cycles:180 Average:54642.18 Median:34062.65 stddev:109241.63 (320.7%) stddev-sans-first:109473.06 18:50:55 INFO - PROCESS | 1646 | Values: 721.5 767.1 785.6 856.7 868.7 27194.5 38906.0 39178.0 39190.2 39378.6 39673.0 40010.6 40011.2 40013.8 40044.0 7230.8 8904.3 9057.6 9071.0 9072.9 7329.2 10807.8 11031.1 11220.2 11294.2 11079.2 11104.4 11113.4 11117.8 11121.4 7190.3 11067.8 11087.9 11088.5 11101.3 7302.7 7336.4 7350.0 7356.1 10551.8 37957.4 38034.8 38094.4 38203.6 38238.0 3680.8 3698.6 3707.0 3709.7 3757.8 26785.0 27057.2 27265.2 27389.2 27955.3 2810.2 3060.2 3118.6 3129.3 3145.1 276073.0 333863.0 335118.0 335839.0 337286.0 49747.8 49870.8 49955.8 49993.8 50027.5 51286.0 51351.0 51401.2 51417.0 51453.7 14369.9 14476.6 14481.0 14525.5 14549.3 10364.7 10612.6 11940.8 11975.4 11977.8 10427.8 10489.7 10510.8 10515.4 10532.7 4731.2 5467.4 5615.9 5627.7 5654.4 966.7 968.7 975.4 975.7 1001.5 25201.0 25316.5 25331.7 25425.4 25489.6 1035.2 1037.4 1072.8 1079.4 1082.2 11740.5 12247.6 12449.0 13124.9 13161.5 445560.0 445632.0 446548.0 447023.0 447458.8 52274.0 52438.7 52597.0 52756.0 52759.5 1339.8 1420.2 1421.5 1424.7 1424.7 24078.6 28121.7 29111.6 29227.3 29944.7 51371.7 51817.0 51824.0 51857.7 51886.0 449869.0 451233.0 451618.0 452812.0 452900.0 31601.8 31988.2 32076.0 32277.4 32314.7 34200.0 41225.4 41522.2 41592.8 42402.4 32994.0 33663.3 34475.5 35499.1 35510.6 33744.7 33812.8 33925.3 35139.8 35290.0 34400.8 34948.5 35181.3 35325.6 35425.5 25384.0 30442.9 30833.0 31040.7 32449.8 23255.5 24455.9 24478.3 24495.4 24871.4 18:50:55 INFO - PROCESS | 1646 | 18:50:55 INFO - PROCESS | 1646 | [#2] jquery.html Cycles:180 Average:41680.64 Median:24648.01 stddev:115588.30 (469.0%) stddev-sans-first:115870.95 18:50:55 INFO - PROCESS | 1646 | Values: 379.5 389.5 390.0 404.8 434.4 13402.0 14749.5 18220.4 19297.3 22173.0 18936.1 22382.8 23136.3 23457.6 23669.2 6096.8 6466.0 6606.7 6963.4 7490.9 7188.7 7491.4 7604.3 7729.0 7748.8 7673.5 7698.2 7711.5 7727.8 7731.3 7410.6 7535.0 7648.8 7651.5 7657.4 6939.4 7209.5 7354.2 7418.0 7434.3 26489.3 28015.7 28431.9 28432.3 28689.4 2805.6 2884.8 2898.1 2900.3 2911.1 13380.5 15262.6 15704.6 16306.3 16795.2 1964.6 1969.8 1975.4 1984.6 1995.9 152920.7 166760.7 169420.6 172589.2 175571.0 19402.8 19869.7 21144.6 21917.5 22035.0 37008.0 37128.3 37129.8 37147.0 37150.1 10344.4 10505.9 10731.1 10764.5 10933.6 8600.7 8601.7 8620.4 8809.6 8816.0 8435.9 10159.9 10166.2 10335.7 10387.9 3924.3 4037.5 4042.8 4044.7 4068.5 858.8 882.7 899.1 902.1 928.8 23340.8 24388.4 24907.6 24954.8 25005.7 869.8 901.7 925.8 933.7 959.1 7249.9 7290.0 7392.3 7464.3 7537.9 548006.0 695284.0 714282.0 726495.0 730720.0 151064.2 156580.0 157781.4 160415.0 161773.0 1229.2 1264.0 1295.5 1296.8 1310.4 12656.9 12727.4 12900.9 12915.9 13109.7 55567.4 59465.4 60133.7 62490.1 62996.1 74580.0 81153.0 86211.0 88083.6 89838.6 10145.8 11763.4 11847.6 11967.4 12241.1 13631.9 13646.6 13967.5 14167.0 14247.6 11254.7 11533.2 11596.0 11802.9 11901.3 11388.5 11499.7 11530.3 11571.4 11862.3 11705.9 11710.8 11928.0 11978.9 12092.3 11688.6 11966.0 12050.4 12062.3 12074.2 11005.9 11018.7 11347.6 11438.7 11728.3 18:50:55 INFO - PROCESS | 1646 | 18:50:55 INFO - PROCESS | 1646 | [#3] mootools.html Cycles:180 Average:6577.77 Median:3436.79 stddev:4106.08 (119.5%) stddev-sans-first:4098.69 18:50:55 INFO - PROCESS | 1646 | Values: 1335.0 1554.8 1582.4 1585.1 1588.2 8991.4 9410.0 10651.6 10657.3 11061.2 10774.1 10886.5 10930.9 10932.8 10938.8 2289.8 2335.1 2336.6 2338.1 2339.8 1991.9 2072.8 2256.0 2331.7 2353.4 2309.4 2334.1 2336.1 2337.0 2341.2 2264.8 2302.8 2306.8 2307.7 2311.4 2217.1 2220.4 2263.8 2300.1 2312.1 9083.3 9191.5 10940.7 10951.9 10955.8 5576.0 5760.4 5761.4 5765.3 5778.4 2946.4 3342.8 3530.8 3596.5 3629.6 1114.8 1180.2 1216.4 1221.1 1222.8 14987.1 14993.6 15186.9 15190.2 15213.8 4506.3 4644.4 4755.4 4770.5 4821.0 10123.5 12560.6 12573.9 12581.5 12612.7 5775.4 5779.5 5779.6 5783.4 5788.7 4107.8 5033.1 5114.9 5143.6 5156.9 3545.7 3628.5 3629.3 3632.7 3641.3 951.7 1028.2 1088.3 1119.5 1127.6 785.6 795.7 840.5 848.6 941.2 6481.5 6639.4 6857.2 6862.6 6948.1 1006.1 1018.4 1026.2 1029.6 1070.5 4190.6 4198.8 4208.9 4317.3 4332.5 11732.8 12943.5 13394.3 13423.5 13453.8 12169.5 12921.3 13152.3 13369.8 13391.6 9273.6 9828.9 9963.3 9971.0 9972.0 6589.4 6681.9 6800.0 6829.0 6853.0 11659.2 11661.8 12022.8 12024.8 12025.7 11847.2 11900.6 12025.0 12219.1 12336.5 8206.0 8463.0 8483.1 8493.6 8500.9 9948.6 10038.9 10078.8 10115.6 10152.7 8847.6 8848.5 8932.3 8973.5 9183.3 8625.4 8644.4 8694.4 8724.2 8932.0 7618.2 7683.0 7806.1 7807.1 7807.8 5646.6 5726.7 5782.9 5811.2 5882.8 5778.4 5913.6 5937.2 5950.9 5989.6 18:50:55 INFO - PROCESS | 1646 | 18:50:55 INFO - PROCESS | 1646 | [#4] prototype.html Cycles:180 Average:4445.68 Median:4758.78 stddev:1244.22 (26.1%) stddev-sans-first:1209.41 18:50:55 INFO - PROCESS | 1646 | Values: 363.9 375.7 379.5 380.8 386.6 4539.5 5009.0 5136.7 5191.0 5198.7 3997.6 4630.6 4959.3 4989.8 5017.8 3834.7 3916.4 3967.0 4200.5 4239.4 3913.8 4208.8 4269.4 4278.4 4301.6 4040.9 4163.7 4180.6 4233.6 4243.5 3585.5 4151.7 4185.3 4194.9 4235.6 3490.8 3718.4 3787.0 3885.9 3898.0 3979.9 4923.7 4941.0 4955.5 5020.0 4390.4 4802.4 4810.5 4841.3 4856.3 5027.8 5335.4 5438.8 5440.7 5505.6 3812.5 4023.7 4122.3 4325.5 4329.7 4652.5 5265.2 5391.8 5401.9 5681.7 3782.5 4414.9 4416.8 4466.9 4505.0 4496.6 4520.8 4521.0 4525.6 4535.0 4220.2 4247.0 4555.9 4746.7 4824.4 4551.4 4841.1 4953.6 5320.0 5359.2 1365.1 1377.0 1403.6 1509.3 1539.3 1039.5 1054.2 1056.5 1078.0 1163.4 4063.7 4606.5 4729.1 4824.5 4944.6 4835.0 5211.3 5232.0 5245.3 5571.6 4243.7 4324.0 4509.8 4679.7 4770.8 2534.5 2561.7 2653.4 2899.9 2902.8 4909.4 5694.7 5764.0 5774.6 5775.6 5434.3 5535.3 5671.0 5715.3 5777.3 5306.5 5391.8 5601.8 5757.7 5771.2 5078.9 5289.7 5484.0 5566.7 5593.9 4514.4 4995.0 5130.8 5269.5 5527.3 4888.3 5139.0 5326.8 5462.6 5625.7 3877.0 3893.4 4102.3 4286.8 4288.7 4271.7 5033.5 5362.8 5485.3 5556.8 4722.9 5372.7 5406.8 5414.4 5497.5 4867.5 5275.8 5391.9 5469.3 5562.8 4734.0 4914.8 4957.6 5337.9 5341.8 4703.5 4703.7 5391.8 5419.9 5472.8 4490.7 4594.5 4935.9 5298.2 5319.4 18:50:55 INFO - PROCESS | 1646 | 18:50:55 INFO - PROCESS | 1646 | [#5] yui.html Cycles:180 Average:20822.19 Median:14112.86 stddev:30227.36 (214.2%) stddev-sans-first:30274.49 18:50:55 INFO - PROCESS | 1646 | Values: 726.1 766.2 786.8 792.9 818.9 15451.4 15595.9 15598.6 15689.1 15720.3 14443.8 14523.5 14537.7 14560.1 14565.6 940.7 943.6 962.0 985.0 988.9 812.7 980.1 981.0 986.2 986.6 1023.4 1036.8 1042.7 1045.1 1047.3 1028.6 1032.1 1032.8 1033.5 1034.3 769.4 772.0 773.2 773.3 773.7 15610.9 15915.5 16035.9 16069.6 16130.3 14333.2 14432.6 14474.9 14475.5 14516.8 11515.5 11645.8 11841.5 11866.5 12191.9 3654.5 3685.3 3813.1 3894.9 3895.0 111934.3 113044.3 115102.0 118428.0 118594.0 9729.0 10043.3 10223.4 10256.1 10828.5 22280.8 23076.4 24695.6 24799.0 24929.6 7933.9 7937.6 8177.7 8257.6 8281.5 4161.1 4261.8 4266.1 4371.9 4380.1 3296.1 3334.7 3373.7 3375.4 3377.4 549.9 639.9 645.7 647.4 659.8 627.3 629.7 661.2 678.2 687.4 9802.0 10067.3 10188.8 10307.3 10360.6 632.8 691.0 704.5 708.2 713.2 4837.7 4898.5 4918.7 4922.7 4937.8 104153.0 104709.5 106261.5 106548.9 108572.5 75145.1 90839.6 90954.5 92840.5 93200.0 66321.0 77265.6 77524.0 77674.0 78214.0 8712.8 9437.3 9453.4 9459.3 9472.9 46936.8 51021.0 52088.4 52943.7 53098.7 61565.0 62598.0 66061.7 67822.0 68835.6 12032.5 13285.9 13665.3 13800.7 13868.8 14437.6 14469.0 14638.3 14776.6 15397.7 13520.9 13615.5 13659.2 13785.8 13854.1 12767.2 12940.4 13064.6 13193.6 13485.6 12435.6 12639.1 13244.0 13253.3 13660.2 10353.7 10726.9 10965.7 11110.4 11588.9 9621.4 9896.8 11189.0 11365.8 11723.2 18:50:55 INFO - PROCESS | 1646 | -------- Summary: end -------- 18:50:55 INFO - PROCESS | 1646 | 18:50:56 INFO - TEST-INFO | 1646: exit 0 18:50:56 INFO - TEST-OK | dromaeo_css | took 1121500ms 18:50:56 INFO - TEST-START | kraken 18:50:56 INFO - operating with platform_type : mac_ 18:50:56 INFO - Initialising browser for kraken test... 18:50:56 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/tmpLDLF3C/profile http://localhost:49239/getInfo.html) 18:50:59 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 18:50:59 INFO - PROCESS | 1651 | colorDepth:24 18:50:59 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 18:50:59 INFO - PROCESS | 1651 | __metrics 18:50:59 INFO - PROCESS | 1651 | 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" 18:50:59 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:51:00 INFO - TEST-INFO | 1651: exit 0 18:51:00 INFO - Browser initialized. 18:51:00 INFO - Running cycle 1/1 for kraken test... 18:51:00 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/tmpLDLF3C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:51:12 INFO - PROCESS | 1652 | RSS: Main: 224641024 18:51:12 INFO - PROCESS | 1652 | 18:51:15 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-beat-detection) 18:51:16 INFO - PROCESS | 1652 | RSS: Main: 285016064 18:51:16 INFO - PROCESS | 1652 | 18:51:18 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-dft) 18:51:19 INFO - PROCESS | 1652 | RSS: Main: 286564352 18:51:19 INFO - PROCESS | 1652 | 18:51:22 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-fft) 18:51:23 INFO - PROCESS | 1652 | RSS: Main: 380928000 18:51:23 INFO - PROCESS | 1652 | 18:51:25 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-oscillator) 18:51:25 INFO - PROCESS | 1652 | RSS: Main: 280797184 18:51:25 INFO - PROCESS | 1652 | 18:51:27 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:51:28 INFO - PROCESS | 1652 | RSS: Main: 285048832 18:51:28 INFO - PROCESS | 1652 | 18:51:31 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-darkroom) 18:51:32 INFO - PROCESS | 1652 | RSS: Main: 328118272 18:51:32 INFO - PROCESS | 1652 | 18:51:35 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-desaturate) 18:51:35 INFO - PROCESS | 1652 | RSS: Main: 329547776 18:51:35 INFO - PROCESS | 1652 | 18:51:38 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49239/tests/kraken/driver.html?testName=json-parse-financial) 18:51:39 INFO - PROCESS | 1652 | RSS: Main: 329121792 18:51:39 INFO - PROCESS | 1652 | 18:51:41 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49239/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:51:41 INFO - PROCESS | 1652 | RSS: Main: 302682112 18:51:41 INFO - PROCESS | 1652 | 18:51:43 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:51:44 INFO - PROCESS | 1652 | RSS: Main: 307888128 18:51:44 INFO - PROCESS | 1652 | 18:51:46 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:51:47 INFO - PROCESS | 1652 | RSS: Main: 310054912 18:51:47 INFO - PROCESS | 1652 | 18:51:49 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:51:50 INFO - PROCESS | 1652 | RSS: Main: 326463488 18:51:50 INFO - PROCESS | 1652 | 18:51:53 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:51:54 INFO - PROCESS | 1652 | RSS: Main: 320749568 18:51:54 INFO - PROCESS | 1652 | 18:51:56 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49239/tests/kraken/driver.html?testName=ai-astar) 18:51:56 INFO - PROCESS | 1652 | RSS: Main: 365850624 18:51:56 INFO - PROCESS | 1652 | 18:51:56 INFO - PROCESS | 1652 | __start_tp_report 18:51:56 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 18:51:56 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 18:51:56 INFO - PROCESS | 1652 | |i|pagename|runs| 18:51:56 INFO - PROCESS | 1652 | |0;ai-astar;114;115;122;175;148;115;115;115;115;115 18:51:56 INFO - PROCESS | 1652 | |1;audio-beat-detection;135;112;109;145;113;110;108;111;130;109 18:51:56 INFO - PROCESS | 1652 | |2;audio-dft;184;184;184;184;182;184;182;184;182;184 18:51:56 INFO - PROCESS | 1652 | |3;audio-fft;82;60;61;90;64;60;61;60;76;61 18:51:56 INFO - PROCESS | 1652 | |4;audio-oscillator;90;72;87;68;68;68;84;68;68;83 18:51:56 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;88;91;135;108;88;88;88;88;88;88 18:51:56 INFO - PROCESS | 1652 | |6;imaging-darkroom;94;94;96;96;95;96;96;95;95;94 18:51:56 INFO - PROCESS | 1652 | |7;imaging-desaturate;84;84;86;83;102;101;123;131;129;83 18:51:56 INFO - PROCESS | 1652 | |8;json-parse-financial;61;60;61;61;61;62;62;62;61;62 18:51:56 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;54;62;58;65;62;58;58;58;57;58 18:51:56 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;86;77;85;97;104;107;90;86;87;86 18:51:56 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;144;145;134;136;139;141;139;140;175;144 18:51:56 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;170;172;167;167;170;172;172;170;174;188 18:51:56 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;67;67;68;67;67;68;68;66;66;64 18:51:56 INFO - PROCESS | 1652 | __end_tp_report 18:51:56 INFO - PROCESS | 1652 | __start_cc_report 18:51:56 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,2129 18:51:56 INFO - PROCESS | 1652 | __end_cc_report 18:51:56 INFO - PROCESS | 1652 | __startTimestamp1489200716352__endTimestamp 18:51:56 INFO - PROCESS | 1652 | 18:51:56 INFO - PROCESS | 1652 | ------- Summary: start ------- 18:51:56 INFO - PROCESS | 1652 | Number of tests: 14 18:51:56 INFO - PROCESS | 1652 | 18:51:56 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:124.90 Median:115.00 stddev:20.44 (17.8%) stddev-sans-first:21.29 18:51:56 INFO - PROCESS | 1652 | Values: 114.0 115.0 122.0 175.0 148.0 115.0 115.0 115.0 115.0 115.0 18:51:56 INFO - PROCESS | 1652 | 18:51:56 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:118.20 Median:112.50 stddev:13.32 (11.8%) stddev-sans-first:12.67 18:51:56 INFO - PROCESS | 1652 | Values: 135.0 112.0 109.0 145.0 113.0 110.0 108.0 111.0 130.0 109.0 18:51:56 INFO - PROCESS | 1652 | 18:51:56 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.00 stddev:0.97 (0.5%) stddev-sans-first:1.00 18:51:56 INFO - PROCESS | 1652 | Values: 184.0 184.0 184.0 184.0 182.0 184.0 182.0 184.0 182.0 184.0 18:51:56 INFO - PROCESS | 1652 | 18:51:56 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:67.50 Median:62.50 stddev:11.04 (17.7%) stddev-sans-first:10.39 18:51:56 INFO - PROCESS | 1652 | Values: 82.0 60.0 61.0 90.0 64.0 60.0 61.0 60.0 76.0 61.0 18:51:56 INFO - PROCESS | 1652 | 18:51:56 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:75.60 Median:77.50 stddev:9.22 (11.9%) stddev-sans-first:8.17 18:51:56 INFO - PROCESS | 1652 | Values: 90.0 72.0 87.0 68.0 68.0 68.0 84.0 68.0 68.0 83.0 18:51:56 INFO - PROCESS | 1652 | 18:51:56 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:95.00 Median:88.00 stddev:15.38 (17.5%) stddev-sans-first:16.10 18:51:56 INFO - PROCESS | 1652 | Values: 88.0 91.0 135.0 108.0 88.0 88.0 88.0 88.0 88.0 88.0 18:51:56 INFO - PROCESS | 1652 | 18:51:56 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:95.10 Median:95.50 stddev:0.88 (0.9%) stddev-sans-first:0.83 18:51:56 INFO - PROCESS | 1652 | Values: 94.0 94.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 94.0 18:51:56 INFO - PROCESS | 1652 | 18:51:56 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:100.60 Median:83.00 stddev:20.05 (24.2%) stddev-sans-first:20.35 18:51:56 INFO - PROCESS | 1652 | Values: 84.0 84.0 86.0 83.0 102.0 101.0 123.0 131.0 129.0 83.0 18:51:56 INFO - PROCESS | 1652 | 18:51:56 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:61.30 Median:61.50 stddev:0.67 (1.1%) stddev-sans-first:0.71 18:51:56 INFO - PROCESS | 1652 | Values: 61.0 60.0 61.0 61.0 61.0 62.0 62.0 62.0 61.0 62.0 18:51:56 INFO - PROCESS | 1652 | 18:51:56 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:58.00 stddev:3.13 (5.4%) stddev-sans-first:2.74 18:51:56 INFO - PROCESS | 1652 | Values: 54.0 62.0 58.0 65.0 62.0 58.0 58.0 58.0 57.0 58.0 18:51:56 INFO - PROCESS | 1652 | 18:51:56 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:90.50 Median:86.00 stddev:9.32 (10.8%) stddev-sans-first:9.75 18:51:56 INFO - PROCESS | 1652 | Values: 86.0 77.0 85.0 97.0 104.0 107.0 90.0 86.0 87.0 86.0 18:51:56 INFO - PROCESS | 1652 | 18:51:56 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:143.70 Median:142.50 stddev:11.55 (8.1%) stddev-sans-first:12.25 18:51:56 INFO - PROCESS | 1652 | Values: 144.0 145.0 134.0 136.0 139.0 141.0 139.0 140.0 175.0 144.0 18:51:56 INFO - PROCESS | 1652 | 18:51:56 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:172.00 stddev:5.98 (3.5%) stddev-sans-first:6.29 18:51:56 INFO - PROCESS | 1652 | Values: 170.0 172.0 167.0 167.0 170.0 172.0 172.0 170.0 174.0 188.0 18:51:56 INFO - PROCESS | 1652 | 18:51:56 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.23 (1.8%) stddev-sans-first:1.30 18:51:56 INFO - PROCESS | 1652 | Values: 67.0 67.0 68.0 67.0 67.0 68.0 68.0 66.0 66.0 64.0 18:51:56 INFO - PROCESS | 1652 | -------- Summary: end -------- 18:51:56 INFO - PROCESS | 1652 | 18:51:57 INFO - TEST-INFO | 1652: exit 0 18:51:57 INFO - TEST-OK | kraken | took 60604ms 18:51:57 INFO - SUITE-END | took 1182s 18:51:57 INFO - Completed test suite (00:19:42) 18:51:57 INFO - javascript benchmark 18:51:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7606.438083522364, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3366.4781958796384, 3389.1188291044336, 3394.185395505078, 3398.830073355688, 3463.0, 5618.213450116977, 5787.074068149097, 5914.112883067537, 5941.970290148543, 5960.0, 5804.912926306109, 5848.6490810551395, 5861.032929566616, 5886.205362276091, 5907.616004959675, 5219.895602087956, 5222.92165617516, 5267.578593712494, 5291.973540132294, 5314.92027619586, 5401.162819762923, 5415.64798288112, 5439.5376393006645, 5457.263269458632, 5478.096114141162, 5198.220266959948, 5229.398619158807, 5297.099493086146, 5299.814506492293, 5357.08929481989, 5293.4971177738435, 5298.417174110845, 5301.231321458406, 5321.388040375367, 5328.44051374604, 5188.429272779991, 5233.842984710464, 5243.397009343936, 5253.973730131325, 5258.0535503609335, 5742.885142297131, 5756.280464941882, 5761.0, 5767.279090113736, 5774.307083150007, 6321.525885558555, 6321.6523091229965, 6327.651979141146, 6330.715117819663, 6332.461740751995, 6212.751489940442, 6327.936720632781, 6332.240131184288, 6343.714532846033, 6349.968250158766, 5965.880682386328, 5966.761329546813, 6028.608140470899, 6044.335123136451, 6052.213212282463, 6436.14210363639, 6464.159659244268, 6476.255230648536, 6480.189976252968, 6491.0, 6186.133941248228, 6229.0, 6285.277193122758, 6324.620522768649, 6352.078948552434, 6275.121482992385, 6341.8097457076365, 6368.808935731936, 6372.1716176897635, 6374.521910856704, 6300.086487459293, 6307.211598550181, 6310.274318453345, 6313.021481670348, 6336.968315158395, 6230.968845155836, 6285.245770507477, 6295.464885484785, 6320.62076275425, 6329.0, 4945.282933974626, 5087.313212716236, 5091.66904151229, 5096.0317539668085, 5100.846974590768, 4531.637469002472, 4566.383538222364, 4595.1039547287955, 4622.537746225418, 4622.9768851156205, 5739.512141467939, 5820.476157145878, 5826.475617194473, 5836.766529338779, 5837.211976383134, 6292.590981586182, 6313.021481670348, 6318.147050148263, 6337.556371054075, 6341.175647165839, 4639.350490931272, 5792.478676919098, 5900.881982360329, 6035.486983606443, 6051.4553690168095, 5018.723970181602, 5660.8867822643315, 5664.51851592611, 5673.3475650299915, 5674.631148975303, 6585.111010013587, 6589.406953374123, 6601.669916504252, 6611.504137189826, 6631.469482441393, 6242.500599952084, 6309.842253943688, 6311.621302721851, 6312.84217894538, 6318.210223722035, 6443.226812782309, 6443.420092191538, 6448.516361272829, 6456.031595260749, 6457.483401327976, 6251.374862513712, 6288.937110629018, 6327.050942358499, 6339.0, 6349.396807303298, 6378.968105159444, 6402.167718196604, 6410.262819775599, 6411.551191416556, 6419.037144428373, 6115.021596544531, 6143.1706719592285, 6248.625082494883, 6274.968625156845, 6278.497720182466, 6131.356207598316, 6151.415615516519, 6170.9074363885475, 6200.56596038273, 6226.906596401148, 6207.193064901534, 6246.063090536274, 6253.37466253371, 6254.3745625437095, 6256.593321434092, 6292.528060395397, 6312.747490100528, 6313.936860631335, 6323.08315294289, 6326.240851097898, 6009.06859436788, 6092.75628974836, 6117.12715980571, 6236.314005459487, 6238.407351301619], "value": 5832.312121765708, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.54542638138, 767.1331395523059, 785.5757890739001, 856.687309132167, 868.7306934850193, 27194.456110877796, 38906.0, 39177.99999999996, 39190.21619567607, 39378.62174823882, 39673.0, 40010.599894001054, 40011.19977600446, 40013.79958601239, 40044.0, 7230.819229519251, 8904.287656987426, 9057.592408341641, 9071.047540008303, 9072.909270907272, 7329.19378868324, 10807.83788243177, 11031.062359699436, 11220.214584979014, 11294.152938529602, 11079.224454288164, 11104.389258590814, 11113.444327783618, 11117.833232501518, 11121.388323642197, 7190.316919892602, 11067.778644427146, 11087.889121108767, 11088.501017454233, 11101.278416902916, 7302.74440394589, 7336.413086953031, 7350.0, 7356.117265928069, 10551.788964220672, 37957.43063854044, 38034.809825950695, 38094.428583571265, 38203.61796382028, 38238.04404889872, 3680.7607505512055, 3698.6076823349963, 3706.981465092684, 3709.684676802475, 3757.830897609614, 26785.0, 27057.1882843515, 27265.1820445385, 27389.178324650293, 27955.301117472023, 2810.199093258432, 3060.2039140754478, 3118.5789918360956, 3129.264622813637, 3145.1036454610326, 276073.0, 333863.0, 335118.0, 335839.0, 337285.99999999756, 49747.75630609264, 49870.75064624654, 49955.750221249386, 49993.75003124961, 50027.499725002286, 51286.0, 51351.0, 51401.228981565306, 51417.0, 51453.742731286104, 14369.856301437061, 14476.638084047772, 14481.0, 14525.491607793889, 14549.34527946245, 10364.689059328231, 10612.57549698019, 11940.820887686692, 11975.401229938469, 11977.760444791056, 10427.791444171226, 10489.685309440729, 10510.842337364946, 10515.369077855354, 10532.736681582868, 4731.157944406738, 5467.398586155519, 5615.943840561624, 5627.662340259598, 5654.37801841797, 966.6809952715587, 968.6971023972745, 975.3708857786688, 975.7120600806867, 1001.4992503748126, 25200.99196032175, 25316.493670126863, 25331.746682533307, 25425.36436589063, 25489.61765573518, 1035.1511760356436, 1037.419045334615, 1072.8015317166348, 1079.422508957704, 1082.2153938394758, 11740.473738414123, 12247.632571022883, 12449.004079673605, 13124.934375328254, 13161.47354105825, 445560.0, 445632.0, 446548.0, 447023.0, 447458.7627061844, 52273.95452090937, 52438.737806310724, 52597.0, 52756.0, 52759.472405275454, 1339.819124418191, 1420.2117824607442, 1421.5451055662295, 1424.7364237615866, 1424.7364237616075, 24078.638820417356, 28121.71878281191, 29111.563326549694, 29227.269318267212, 29944.700552995062, 51371.74314128555, 51817.0, 51824.0, 51857.7407112962, 51886.0, 449869.0, 451233.0, 451618.0, 452812.0, 452900.0, 31601.8419907899, 31988.20029499281, 32076.0, 32277.354452910342, 32314.676853232108, 34199.974000780014, 41225.38161927513, 41522.169556609304, 41592.792036039624, 42402.36396453994, 32994.0, 33663.326733465685, 34475.4828677565, 35499.112522187155, 35510.644893550736, 33744.662553375136, 33812.83093584615, 33925.32149357048, 35139.82430087833, 35290.0, 34400.82799585986, 34948.47577286292, 35181.29637407289, 35325.646743532234, 35425.46861797023, 25383.97345466787, 30442.93449729249, 30833.039444077713, 31040.68959310378, 32449.837750811093, 23255.534889302457, 24455.877720611283, 24478.265652029757, 24495.387615309046, 24871.37821554403], "value": 18234.90219269046, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.54454654414707, 389.4878235120816, 389.9571047184811, 404.77130421311955, 434.4048653344916, 13401.98970154476, 14749.451307612708, 18220.36228731993, 19297.26324630783, 22173.002214900327, 18936.147873345697, 22382.77617223827, 23136.30591082266, 23457.648135277985, 23669.171578994738, 6096.847578810543, 6465.9676701616545, 6606.669666516679, 6963.40811031063, 7490.925090749104, 7188.748393806218, 7491.400687944952, 7604.315611594955, 7728.961355193216, 7748.806279843021, 7673.46285759997, 7698.153203147677, 7711.537307761552, 7727.768166954972, 7731.342835858959, 7410.5924174170395, 7534.962325188394, 7648.770536883902, 7651.502652327581, 7657.425693072986, 6939.4448444124855, 7209.531380460253, 7354.227806080338, 7418.0, 7434.256574342522, 26489.33776655599, 28015.719842801514, 28431.857840710873, 28432.28919277014, 28689.426211475864, 2805.6072149899032, 2884.8172249377653, 2898.087102562686, 2900.347421830071, 2911.083008852205, 13380.531681391105, 15262.618434539225, 15704.607384815357, 16306.347746090261, 16795.160241987975, 1964.6168997045581, 1969.812867777559, 1975.4172519106899, 1984.642764302425, 1995.8503112266637, 152920.7079292073, 166760.65632780505, 169420.5708346659, 172589.19286457053, 175571.0, 19402.805971940383, 19869.708468949473, 21144.577108457746, 21917.452063698216, 22035.0, 37008.0, 37128.257434851694, 37129.81435092807, 37147.0, 37150.07124821847, 10344.37933723979, 10505.894941050492, 10731.141508679288, 10764.515596798163, 10933.649265407976, 8600.655973760979, 8601.698940537051, 8620.439671421338, 8809.559522024001, 8815.955920220358, 8435.873461898076, 10159.898401016044, 10166.237532185116, 10335.689929302132, 10387.896121038844, 3924.3132451820816, 4037.4953130858644, 4042.8382864685673, 4044.676425885922, 4068.5117785865887, 858.819647873941, 882.6557642519423, 899.0515006667897, 902.0933961368913, 928.7863791328033, 23340.76659233386, 24388.390290242885, 24907.62638560423, 24954.750452495606, 25005.749712514666, 869.8127056567739, 901.7024381953939, 925.8379783537854, 933.7152168588646, 959.1128206409044, 7249.927500725031, 7289.963550182215, 7392.297731715478, 7464.290892365217, 7537.886931696029, 548006.0, 695284.0, 714282.0, 726495.0, 730720.0, 151064.2446787759, 156580.0, 157781.42218577667, 160415.0, 161773.0, 1229.2133034857698, 1263.968400789969, 1295.533607901155, 1296.786030305008, 1310.3710219094887, 12656.936715316364, 12727.363631818558, 12900.935495322463, 12915.870841291842, 13109.73780524365, 55567.44432555623, 59465.40534594599, 60133.69933150306, 62490.06264905939, 62996.055059175065, 74580.0, 81153.0, 86211.0, 88083.55958220168, 89838.55080724554, 10145.847812282675, 11763.353015584225, 11847.644570662895, 11967.401629918295, 12241.143119981516, 13631.93184034113, 13646.590602281947, 13967.511137110152, 14167.0, 14247.572572822832, 11254.718632034264, 11533.192676512563, 11596.0, 11802.940985295361, 11901.285922844658, 11388.487518061873, 11499.655010349703, 11530.308181509135, 11571.363575003119, 11862.288262704265, 11705.941470292593, 11710.765784684429, 11928.0, 11978.940105299418, 12092.274463532216, 11688.649340519798, 11966.042716582479, 12050.397480125783, 12062.276263424223, 12074.154809163625, 11005.86781044289, 11018.724531886766, 11347.602833900773, 11438.714032149262, 11728.296302221894], "value": 11563.192274739898, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.9866501334984, 1554.8289688134303, 1582.4065975259277, 1585.0727324515158, 1588.182086225594, 8991.37060405771, 9409.96490386057, 10651.573937042509, 10657.253992220538, 11061.170412219075, 10774.138068954484, 10886.510107045182, 10930.945345273283, 10932.836007459895, 10938.835917461245, 2289.839711220219, 2335.089315167086, 2336.6261398176293, 2338.088145623208, 2339.777721116491, 1991.890446025468, 2072.823809976154, 2255.988720056406, 2331.743508214095, 2353.4234112642425, 2309.3880121767743, 2334.1130370459286, 2336.1473062332298, 2337.0184522500504, 2341.1922886604093, 2264.784845439681, 2302.82728795341, 2306.815454763615, 2307.746147923727, 2311.364374796936, 2217.1020736601704, 2220.411590928405, 2263.841531092824, 2300.0799680127916, 2312.0520586559596, 9083.273338132933, 9191.494467804268, 10940.671779846618, 10951.890481095166, 10955.780884382268, 5576.0, 5760.395158508338, 5761.423857614247, 5765.336986246593, 5778.393268706809, 2946.4401763664837, 3342.782719123249, 3530.8058056806867, 3596.514470546469, 3629.5644522657185, 1114.7658991611772, 1180.1648436680957, 1216.3735676126803, 1221.0902877356427, 1222.8165775133712, 14987.100773953489, 14993.625159371102, 15186.936914415995, 15190.164540950243, 15213.771793422997, 4506.324051392317, 4644.373009643655, 4755.429348478136, 4770.546798054179, 4821.0, 10123.544440500194, 12560.560380386643, 12573.93713031429, 12581.496740130475, 12612.747745045048, 5775.393583673737, 5779.508741756998, 5779.595428320062, 5783.421657834183, 5788.739506722208, 4107.835686572504, 5033.119204139261, 5114.948850511521, 5143.639945203875, 5156.871078222999, 3545.71634269263, 3628.5101511296166, 3629.346717590859, 3632.6730594246646, 3641.308151451216, 951.6574033347989, 1028.2134167361974, 1088.3198001249218, 1119.457063324287, 1127.560251501915, 785.6195726947359, 795.6578671171336, 840.5125027484045, 848.588434609214, 941.2140862379989, 6481.48148148147, 6639.435647969976, 6857.245702972669, 6862.588244705334, 6948.096747422803, 1006.1246715357686, 1018.4296793795498, 1026.199564339816, 1029.552144817007, 1070.4754670211696, 4190.617096358194, 4198.8110535026, 4208.85269015583, 4317.309230523101, 4332.4801023877335, 11732.824007639892, 12943.5469758558, 13394.263315517741, 13423.463061477432, 13453.798193027113, 12169.513219471122, 12921.289329086803, 13152.342382881008, 13369.799453008212, 13391.598252052454, 9273.629054837731, 9828.852567211497, 9963.252756043326, 9971.0, 9971.952944940822, 6589.374009469093, 6681.866362672622, 6799.966000169968, 6828.9658551706925, 6852.965735171292, 11659.242149260272, 11661.76676466483, 12022.75954480923, 12024.819627705767, 12025.699357516132, 11847.229930054518, 11900.642980710592, 12025.0, 12219.144659873724, 12336.50653973831, 8205.95897020511, 8462.95768521178, 8483.10927352619, 8493.57532123379, 8500.91499085026, 9948.602055917681, 10038.949805250926, 10078.798424031625, 10115.59537618487, 10152.695419137437, 8847.646094156162, 8848.513331766557, 8932.330075244252, 8973.50645714492, 9183.265338772748, 8625.439346442461, 8644.438111522732, 8694.434861733967, 8724.20216068546, 8931.955340223258, 7618.238176182337, 7683.039620047494, 7806.141324454419, 7807.141214466291, 7807.843843122992, 5646.632968857176, 5726.685032323096, 5782.87233989368, 5811.1573821794755, 5882.823515294548, 5778.393268706725, 5913.556483263858, 5937.19847820556, 5950.928832810136, 5989.610675306091], "value": 5016.934403759725, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.91811842335477, 375.6975634614136, 379.54454654414707, 380.83433706337746, 386.60759329280785, 4539.455265368152, 5009.02324046811, 5136.691798492088, 5190.9740451297785, 5198.740062996854, 3997.6014391365165, 4630.606398456127, 4959.330490383806, 4989.829424200475, 5017.799288028475, 3834.6740527055235, 3916.4125381192766, 3967.0, 4200.537940826506, 4239.389032167772, 3913.7651740895494, 4208.768517731523, 4269.359596060584, 4278.35824626307, 4301.634361079312, 4040.919181616366, 4163.666906647461, 4180.6237438630515, 4233.640140588053, 4243.490781106271, 3585.533880595532, 4151.709380343347, 4185.267578173823, 4194.909323575862, 4235.57644235577, 3490.8080055596934, 3718.4050551911564, 3786.9775160706454, 3885.941710874339, 3897.9610203897882, 3979.9204015919518, 4923.704577725348, 4940.973106917851, 4955.479674634147, 5020.021095886304, 4390.363397307405, 4802.422195464366, 4810.518948105197, 4841.273808928654, 4856.295837103636, 5027.773750181251, 5335.413104558495, 5438.791113243166, 5440.727963601804, 5505.614606977513, 3812.485314482537, 4023.652076554358, 4122.3404255319, 4325.545817689161, 4329.718568293051, 4652.534746525321, 5265.210218467222, 5391.81128660499, 5401.945980540223, 5681.744321505501, 3782.451544526083, 4414.911701766011, 4416.80124394403, 4466.932996005063, 4504.954950450519, 4496.595306422438, 4520.819167233274, 4520.954790452053, 4525.637948964075, 4534.954650453519, 4220.2192594370135, 4246.978765106216, 4555.85645904325, 4746.724759915716, 4824.445188803333, 4551.385562949025, 4841.1285968526, 4953.554180123734, 5319.962607291541, 5359.23999140443, 1365.0922136778931, 1376.9793453098212, 1403.5789263221197, 1509.3057193690806, 1539.2842328317386, 1039.5010395010286, 1054.1566746602687, 1056.487603512296, 1077.983830242547, 1163.4008485629906, 4063.674906007512, 4606.516315786861, 4729.0541891621815, 4824.480288709045, 4944.629152813553, 4834.95165048352, 5211.348581427322, 5231.973840130775, 5245.291885595396, 5571.554275657938, 4243.6605071594195, 4323.978380108079, 4509.751963641966, 4679.67242293043, 4770.829272680991, 2534.505771374564, 2561.743825617423, 2653.4295126547886, 2899.913002609925, 2902.7677785777087, 4909.410870695539, 5694.658320500783, 5764.011416061452, 5774.595778295563, 5775.624584402, 5434.294887774336, 5535.308086489189, 5670.971645141748, 5715.31416230055, 5777.277840269966, 5306.52241298285, 5391.838244852661, 5601.831945041574, 5757.71810068257, 5771.1920331154515, 5078.898422031465, 5289.709066001253, 5484.012877682056, 5566.749496272597, 5593.888122237614, 4514.367988481549, 4994.9750251248515, 5130.769115389742, 5269.499397557226, 5527.2538207341495, 4888.2870007146375, 5138.97430512845, 5326.760295786621, 5462.579729270339, 5625.693465679052, 3876.9806150970194, 3893.357595996742, 4102.323116685713, 4286.849960251377, 4288.71338598413, 4271.675780508052, 5033.5353575530435, 5362.839114826562, 5485.259489968803, 5556.777728890799, 4722.906496244965, 5372.650777699437, 5406.810501689622, 5414.404415514212, 5497.45025497463, 4867.491077765904, 5275.841724748264, 5391.919121213264, 5469.316335458067, 5562.833115006556, 4734.0, 4914.8053765053, 4957.578605818546, 5337.919931201112, 5341.839744807662, 4703.506131856243, 4703.717776933395, 5391.840754237857, 5419.918701219406, 5472.781088756406, 4490.708103973231, 4594.540545945379, 4935.938773163787, 5298.2052692096495, 5319.38827034896], "value": 4082.688089131896, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.0815068937794, 766.222284381353, 786.8111653203231, 792.8771040488726, 818.8607936650767, 15451.381944722198, 15595.922020389911, 15598.610034749137, 15689.13709745965, 15720.292586833591, 14443.783343249834, 14523.491677791279, 14537.709245815078, 14560.053596516245, 14565.563033108998, 940.6754669638964, 943.575391074016, 961.9759506012335, 984.9803003939917, 988.9109980101789, 812.6627449608405, 980.1374790184627, 981.0140808487496, 986.2159583131428, 986.6448078691665, 1023.4115383654391, 1036.7822757220993, 1042.7445275907414, 1045.080329310206, 1047.3244757131645, 1028.5782829040133, 1032.102071198055, 1032.7934413117368, 1033.5245786938017, 1034.348360532867, 769.3729610367533, 772.0118248641747, 773.215186585616, 773.2576726342718, 773.6827900560743, 15610.9219453902, 15915.522534323989, 16035.91982040094, 16069.598260043593, 16130.274137663833, 14333.21167335796, 14432.639184020378, 14474.855251447456, 14475.493357732534, 14516.782248266285, 11515.481803318788, 11645.767084658259, 11841.526338946433, 11866.52533898643, 12191.939040304742, 3654.526369203674, 3685.3182161300247, 3813.0657988792645, 3894.902627434337, 3895.02624343914, 111934.32098518529, 113044.30433543421, 115102.0, 118428.0, 118594.0, 9729.0, 10043.296969212084, 10223.437710925971, 10256.12822910046, 10828.458577071273, 22280.777192228194, 23076.423089422562, 24695.62956555653, 24799.0, 24929.62605560918, 7933.920660793434, 7937.563434011069, 8177.713780017671, 8257.628406721711, 8281.54451505173, 4161.10536234705, 4261.808218630169, 4266.1254442839145, 4371.868843934687, 4380.102079073782, 3296.0935742670476, 3334.6665333466945, 3373.6963673269033, 3375.375555522236, 3377.3751855906735, 549.895519851235, 639.8912184928573, 645.686841881687, 647.414090248326, 659.8452707761418, 627.2692313454866, 629.7260691599078, 661.216458496683, 678.1726293921506, 687.4225650453643, 9802.0, 10067.295289329677, 10188.847167292497, 10307.330023548595, 10360.585576576852, 632.7595513704855, 690.994602852848, 704.4998051383473, 708.1502197363081, 713.2368365848596, 4837.661363704507, 4898.522049344933, 4918.704877707349, 4922.655414121049, 4937.802487900443, 104153.0, 104709.47645261725, 106261.46869265604, 106548.93451065545, 108572.45713771539, 75145.12137196504, 90839.63740543897, 90954.54522727476, 92840.53579732058, 93200.0, 66321.0, 77265.61367193128, 77524.0, 77674.0, 78214.0, 8712.821794551362, 9437.339386243171, 9453.43279403238, 9459.337846350689, 9472.905270947202, 46936.7653161732, 51021.0, 52088.437346879655, 52943.735281323345, 53098.67253318698, 61565.0, 62598.0, 66061.66969165123, 67822.0, 68835.57706247234, 12032.458539365925, 13285.867141328463, 13665.31673416345, 13800.723985520433, 13868.791968120688, 14437.566872993826, 14469.0, 14638.268086595415, 14776.63058423548, 15397.69204615879, 13520.932395338354, 13615.52345667897, 13659.248741319323, 13785.793213101611, 13854.099483533539, 12767.170133941636, 12940.352982351033, 13064.608061758163, 13193.60419187426, 13485.595432136659, 12435.564755233523, 12639.115261931576, 13244.0, 13253.271070090852, 13660.248686322348, 10353.689389318333, 10726.892731072589, 10965.671029869116, 11110.44447777624, 11588.884111159117, 9621.374610650286, 9896.802063958825, 11189.0, 11365.829512557153, 11723.237989530653], "value": 7688.449374639973, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1453.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 122.0, 175.0, 148.0, 115.0, 115.0, 115.0, 115.0, 115.0], "value": 124.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 112.0, 109.0, 145.0, 113.0, 110.0, 108.0, 111.0, 130.0, 109.0], "value": 118.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 184.0, 184.0, 182.0, 184.0, 182.0, 184.0, 182.0, 184.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 61.0, 90.0, 64.0, 60.0, 61.0, 60.0, 76.0, 61.0], "value": 67.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 72.0, 87.0, 68.0, 68.0, 68.0, 84.0, 68.0, 68.0, 83.0], "value": 75.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 91.0, 135.0, 108.0, 88.0, 88.0, 88.0, 88.0, 88.0, 88.0], "value": 95.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 86.0, 83.0, 102.0, 101.0, 123.0, 131.0, 129.0, 83.0], "value": 100.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 61.0, 61.0, 61.0, 62.0, 62.0, 62.0, 61.0, 62.0], "value": 61.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 62.0, 58.0, 65.0, 62.0, 58.0, 58.0, 58.0, 57.0, 58.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 77.0, 85.0, 97.0, 104.0, 107.0, 90.0, 86.0, 87.0, 86.0], "value": 90.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 145.0, 134.0, 136.0, 139.0, 141.0, 139.0, 140.0, 175.0, 144.0], "value": 143.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 172.0, 167.0, 167.0, 170.0, 172.0, 172.0, 170.0, 174.0, 188.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 67.0, 67.0, 68.0, 68.0, 66.0, 66.0, 64.0], "value": 66.8, "unit": "score"}]}]} 18:51:57 INFO - Return code: 0 18:51:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:51:57 ERROR - # TBPL SUCCESS # 18:51:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:51:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:51:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:51:57 INFO - 2017-03-10 18:51:57.661 screenresolution[1656:10124] starting screenresolution argv=screenresolution get 18:51:57 INFO - 2017-03-10 18:51:57.664 screenresolution[1656:10124] Display 0: 1600x1200x32@60 18:51:57 INFO - 2017-03-10 18:51:57.671 screenresolution[1657:10127] starting screenresolution argv=screenresolution list 18:51:57 INFO - Available Modes on Display 0 18:51:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:51:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:51:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:51:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:51:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:51:57 INFO - Intel Iris: 18:51:57 INFO - Chipset Model: Intel Iris 18:51:57 INFO - Type: GPU 18:51:57 INFO - Bus: Built-In 18:51:57 INFO - VRAM (Dynamic, Max): 1536 MB 18:51:57 INFO - Vendor: Intel (0x8086) 18:51:57 INFO - Device ID: 0x0a2e 18:51:57 INFO - Revision ID: 0x0009 18:51:57 INFO - Displays: 18:51:57 INFO - Display: 18:51:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:51:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:51:57 INFO - Display Serial Number: 1600x1200 60 18:51:57 INFO - Main Display: Yes 18:51:57 INFO - Mirror: Off 18:51:57 INFO - Online: Yes 18:51:57 INFO - Rotation: Supported 18:51:57 INFO - Return code: 0 18:51:57 INFO - Running post-action listener: _resource_record_post_action 18:51:57 INFO - [mozharness: 2017-03-11 02:51:57.909662Z] Finished run-tests step (success) 18:51:57 INFO - Running post-run listener: _resource_record_post_run 18:51:57 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 32599040; Write bytes: 510377984; Read time: 201; Write time: 1573 18:51:57 INFO - TinderboxPrint: CPU usage
54.0% 18:51:57 INFO - TinderboxPrint: I/O read bytes / time
32,599,040 / 201 18:51:57 INFO - TinderboxPrint: I/O write bytes / time
510,377,984 / 1,573 18:51:57 INFO - TinderboxPrint: CPU idle
2,212.9 (46.0%) 18:51:57 INFO - TinderboxPrint: CPU system
957.8 (19.9%) 18:51:57 INFO - TinderboxPrint: CPU user
1,643.1 (34.1%) 18:51:57 INFO - TinderboxPrint: Swap in / out
238,297,088 / 0 18:51:57 INFO - install - Wall time: 20s; CPU: 55.0%; Read bytes: 205437440; Write bytes: 202499584; Read time: 15671; Write time: 439 18:51:57 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 30608384; Write bytes: 297093632; Read time: 180; Write time: 1104 18:51:58 INFO - Running post-run listener: _upload_blobber_files 18:51:58 INFO - Blob upload gear active. 18:51:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:51:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:51:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:51:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:51:58 INFO - (blobuploader) - INFO - Open directory for files ... 18:51:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:51:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:51:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:51:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:51:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:51:59 INFO - (blobuploader) - INFO - Done attempting. 18:51:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:51:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:51:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:52:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:52:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:52:01 INFO - (blobuploader) - INFO - Done attempting. 18:52:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:52:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:52:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:52:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:52:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:52:02 INFO - (blobuploader) - INFO - Done attempting. 18:52:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:52:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:52:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:52:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:52:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:52:04 INFO - (blobuploader) - INFO - Done attempting. 18:52:04 INFO - (blobuploader) - INFO - Iteration through files over. 18:52:04 INFO - Return code: 0 18:52:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:52:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:52:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8a65a3ae8e66765ba3bf091af819795cc30e0f269ca21d3fd1260ead1111f45aaafbd7a760a4e98ffe00c1208c69d6968417fd075c89164728bfe982e032d46", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cf279ff00051a066b6af862d24b0e4350a647d937bdc68765e0dc8abb7a93e09e22855b6668eeb82197c03ef6dd568efdd73a810fb7757c035c3aebfca25049", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4b1fdfae146117eee433e6a5197ef8868f45c201cc5c8cc5c042a74f49388c7d21fe542b6458f219d982a11d064fa1a413a5323633d0417c27996a44da37305", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c54b3557d3f8e1b5a3eb1789131f38490c3dac5bbafd6489f55af529dfbf858c82442fc754d7aeeb2d84b017a947c7ccfdb0f143f8d879af09afba49224cbb5c"} 18:52:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:52:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:52:04 INFO - Contents: 18:52:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8a65a3ae8e66765ba3bf091af819795cc30e0f269ca21d3fd1260ead1111f45aaafbd7a760a4e98ffe00c1208c69d6968417fd075c89164728bfe982e032d46", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cf279ff00051a066b6af862d24b0e4350a647d937bdc68765e0dc8abb7a93e09e22855b6668eeb82197c03ef6dd568efdd73a810fb7757c035c3aebfca25049", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4b1fdfae146117eee433e6a5197ef8868f45c201cc5c8cc5c042a74f49388c7d21fe542b6458f219d982a11d064fa1a413a5323633d0417c27996a44da37305", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c54b3557d3f8e1b5a3eb1789131f38490c3dac5bbafd6489f55af529dfbf858c82442fc754d7aeeb2d84b017a947c7ccfdb0f143f8d879af09afba49224cbb5c"} 18:52:04 INFO - Running post-run listener: copy_logs_to_upload_dir 18:52:04 INFO - Copying logs to upload dir... 18:52:04 INFO - mkdir: /builds/slave/test/build/upload/logs 18:52:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.486696 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-10 18:52:04.638386) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 18:52:04.641995) ========= 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.y2rFti42sE/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.5WihervzjT/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8a65a3ae8e66765ba3bf091af819795cc30e0f269ca21d3fd1260ead1111f45aaafbd7a760a4e98ffe00c1208c69d6968417fd075c89164728bfe982e032d46", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cf279ff00051a066b6af862d24b0e4350a647d937bdc68765e0dc8abb7a93e09e22855b6668eeb82197c03ef6dd568efdd73a810fb7757c035c3aebfca25049", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4b1fdfae146117eee433e6a5197ef8868f45c201cc5c8cc5c042a74f49388c7d21fe542b6458f219d982a11d064fa1a413a5323633d0417c27996a44da37305", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c54b3557d3f8e1b5a3eb1789131f38490c3dac5bbafd6489f55af529dfbf858c82442fc754d7aeeb2d84b017a947c7ccfdb0f143f8d879af09afba49224cbb5c"} build_url:https://queue.taskcluster.net/v1/task/erJsxxJMT8Go5oSfaH43Mg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010955 build_url: 'https://queue.taskcluster.net/v1/task/erJsxxJMT8Go5oSfaH43Mg/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/f8a65a3ae8e66765ba3bf091af819795cc30e0f269ca21d3fd1260ead1111f45aaafbd7a760a4e98ffe00c1208c69d6968417fd075c89164728bfe982e032d46", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cf279ff00051a066b6af862d24b0e4350a647d937bdc68765e0dc8abb7a93e09e22855b6668eeb82197c03ef6dd568efdd73a810fb7757c035c3aebfca25049", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4b1fdfae146117eee433e6a5197ef8868f45c201cc5c8cc5c042a74f49388c7d21fe542b6458f219d982a11d064fa1a413a5323633d0417c27996a44da37305", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c54b3557d3f8e1b5a3eb1789131f38490c3dac5bbafd6489f55af529dfbf858c82442fc754d7aeeb2d84b017a947c7ccfdb0f143f8d879af09afba49224cbb5c"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 18:52:04.680282) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 18:52:04.680629) ========= 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.y2rFti42sE/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.5WihervzjT/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005172 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 18:52:04.732114) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 18:52:04.733012) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 18:52:04.733783) ========= ========= Total master_lag: 0.19 =========