builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0112 starttime: 1480751147.6 results: success (0) buildid: 20161202221643 builduid: ccfc05b7945447b9b51412dc9bfd7bdc revision: a8e20bf36959426f0a6eb4b5df29ef3dd85ad4bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-02 23:45:47.599238) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-02 23:45:47.599714) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-02 23:45:47.600012) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-02 23:45:47.626395) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 23:45:47.626709) ========= 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.Tc9woTBpSs/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.9ZIc7w3uEY/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-02 23:45:47-- 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% 9.50M=0.001s 2016-12-02 23:45:48 (9.50 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.495610 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 23:45:48.147495) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 23:45:48.147970) ========= 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.Tc9woTBpSs/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.9ZIc7w3uEY/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.026087 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 23:45:48.203304) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-12-02 23:45:48.203613) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a8e20bf36959426f0a6eb4b5df29ef3dd85ad4bd --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 a8e20bf36959426f0a6eb4b5df29ef3dd85ad4bd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Tc9woTBpSs/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.9ZIc7w3uEY/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-02 23:45:48,299 truncating revision to first 12 chars 2016-12-02 23:45:48,299 Setting DEBUG logging. 2016-12-02 23:45:48,299 attempt 1/10 2016-12-02 23:45:48,299 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a8e20bf36959?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-02 23:45:49,562 unpacking tar archive at: mozilla-central-a8e20bf36959/testing/mozharness/ program finished with exit code 0 elapsedTime=1.523259 ========= master_lag: 3.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-12-02 23:45:52.839385) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-02 23:45:52.839662) ========= script_repo_revision: a8e20bf36959426f0a6eb4b5df29ef3dd85ad4bd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-02 23:45:52.843032) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 5 secs) (at 2016-12-02 23:45:52.843344) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 5 secs) (at 2016-12-02 23:45:58.838831) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-12-02 23:45:58.843153) ========= /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.Tc9woTBpSs/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.9ZIc7w3uEY/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 23:45:59 INFO - MultiFileLogger online at 20161202 23:45:59 in /builds/slave/test 23:45:59 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 23:45:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:45:59 INFO - {'append_to_log': False, 23:45:59 INFO - 'base_work_dir': '/builds/slave/test', 23:45:59 INFO - 'blob_upload_branch': 'Firefox', 23:45:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:45:59 INFO - 'branch': 'Firefox', 23:45:59 INFO - 'buildbot_json_path': 'buildprops.json', 23:45:59 INFO - 'config_files': ('talos/mac_config.py',), 23:45:59 INFO - 'default_actions': ('clobber', 23:45:59 INFO - 'read-buildbot-config', 23:45:59 INFO - 'download-and-extract', 23:45:59 INFO - 'populate-webroot', 23:45:59 INFO - 'create-virtualenv', 23:45:59 INFO - 'install', 23:45:59 INFO - 'run-tests'), 23:45:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:45:59 INFO - 'download_minidump_stackwalk': True, 23:45:59 INFO - 'download_symbols': 'ondemand', 23:45:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:45:59 INFO - 'tooltool.py': '/tools/tooltool.py', 23:45:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:45:59 INFO - '/tools/misc-python/virtualenv.py')}, 23:45:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:45:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:45:59 INFO - 'installer_path': 'installer.exe', 23:45:59 INFO - 'log_level': 'info', 23:45:59 INFO - 'log_name': 'talos', 23:45:59 INFO - 'log_to_console': True, 23:45:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:45:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:45:59 INFO - 'opt_config_files': (), 23:45:59 INFO - 'pip_index': False, 23:45:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:45:59 INFO - 'cmd': ('bash', 23:45:59 INFO - '-c', 23:45:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:45:59 INFO - 'enabled': True, 23:45:59 INFO - 'halt_on_failure': False, 23:45:59 INFO - 'name': 'check_screen_resolution'},), 23:45:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:45:59 INFO - 'cmd': ('bash', 23:45:59 INFO - '-c', 23:45:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:45:59 INFO - 'enabled': True, 23:45:59 INFO - 'halt_on_failure': False, 23:45:59 INFO - 'name': 'check_screen_resolution'},), 23:45:59 INFO - 'run_cmd_checks_enabled': True, 23:45:59 INFO - 'sps_profile': False, 23:45:59 INFO - 'sps_profile_interval': 0, 23:45:59 INFO - 'suite': 'dromaeojs', 23:45:59 INFO - 'system_bits': '32', 23:45:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:45:59 INFO - 'title': 't-yosemite-r7-0112', 23:45:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:45:59 INFO - 'use_talos_json': True, 23:45:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:45:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:45:59 INFO - 'work_dir': 'build'} 23:45:59 INFO - [mozharness: 2016-12-03 07:45:59.142036Z] Running clobber step. 23:45:59 INFO - Running pre-action listener: _resource_record_pre_action 23:45:59 INFO - Running main action method: clobber 23:45:59 INFO - rmtree: /builds/slave/test/build 23:45:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:46:01 INFO - Running post-action listener: _resource_record_post_action 23:46:01 INFO - [mozharness: 2016-12-03 07:46:01.432325Z] Finished clobber step (success) 23:46:01 INFO - [mozharness: 2016-12-03 07:46:01.432489Z] Running read-buildbot-config step. 23:46:01 INFO - Running pre-action listener: _resource_record_pre_action 23:46:01 INFO - Running main action method: read_buildbot_config 23:46:01 INFO - Using buildbot properties: 23:46:01 INFO - { 23:46:01 INFO - "project": "", 23:46:01 INFO - "product": "firefox", 23:46:01 INFO - "script_repo_revision": "production", 23:46:01 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 23:46:01 INFO - "repository": "", 23:46:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 23:46:01 INFO - "buildid": "20161202221643", 23:46:01 INFO - "pgo_build": "False", 23:46:01 INFO - "basedir": "/builds/slave/test", 23:46:01 INFO - "buildnumber": 11, 23:46:01 INFO - "slavename": "t-yosemite-r7-0112", 23:46:01 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 23:46:01 INFO - "platform": "yosemite_r7", 23:46:01 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 23:46:01 INFO - "branch": "mozilla-central", 23:46:01 INFO - "repo_path": "mozilla-central", 23:46:01 INFO - "revision": "a8e20bf36959426f0a6eb4b5df29ef3dd85ad4bd", 23:46:01 INFO - "stage_platform": "macosx64", 23:46:01 INFO - "builduid": "ccfc05b7945447b9b51412dc9bfd7bdc", 23:46:01 INFO - "slavebuilddir": "test" 23:46:01 INFO - } 23:46:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/A68zA02IS_6mslMwrRAzcg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 23:46:01 INFO - Running post-action listener: _resource_record_post_action 23:46:01 INFO - [mozharness: 2016-12-03 07:46:01.435888Z] Finished read-buildbot-config step (success) 23:46:01 INFO - [mozharness: 2016-12-03 07:46:01.435996Z] Running download-and-extract step. 23:46:01 INFO - Running pre-action listener: _resource_record_pre_action 23:46:01 INFO - Running main action method: download_and_extract 23:46:01 INFO - mkdir: /builds/slave/test/build/tests 23:46:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:46:01 INFO - trying https://queue.taskcluster.net/v1/task/A68zA02IS_6mslMwrRAzcg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 23:46:01 INFO - Downloading https://queue.taskcluster.net/v1/task/A68zA02IS_6mslMwrRAzcg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 23:46:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A68zA02IS_6mslMwrRAzcg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 23:46:02 INFO - Downloaded 1199 bytes. 23:46:02 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 23:46:02 INFO - Using the following test package requirements: 23:46:02 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 23:46:02 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 23:46:02 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 23:46:02 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 23:46:02 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 23:46:02 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 23:46:02 INFO - u'jsshell-mac.zip'], 23:46:02 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 23:46:02 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 23:46:02 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 23:46:02 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 23:46:02 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 23:46:02 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 23:46:02 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 23:46:02 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 23:46:02 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 23:46:02 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 23:46:02 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 23:46:02 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 23:46:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A68zA02IS_6mslMwrRAzcg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 23:46:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A68zA02IS_6mslMwrRAzcg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 23:46:02 INFO - Fetch https://queue.taskcluster.net/v1/task/A68zA02IS_6mslMwrRAzcg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 23:46:03 INFO - Expected file size: 16274822 23:46:03 INFO - Obtained file size: 16274822 23:46:10 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 23:46:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A68zA02IS_6mslMwrRAzcg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 23:46:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A68zA02IS_6mslMwrRAzcg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 23:46:10 INFO - Fetch https://queue.taskcluster.net/v1/task/A68zA02IS_6mslMwrRAzcg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 23:46:11 INFO - Expected file size: 16274822 23:46:11 INFO - Obtained file size: 16274822 23:46:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A68zA02IS_6mslMwrRAzcg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 23:46:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A68zA02IS_6mslMwrRAzcg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 23:46:17 INFO - Fetch https://queue.taskcluster.net/v1/task/A68zA02IS_6mslMwrRAzcg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 23:46:18 INFO - Expected file size: 14409734 23:46:18 INFO - Obtained file size: 14409734 23:46: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')]} 23:46:18 INFO - trying https://queue.taskcluster.net/v1/task/A68zA02IS_6mslMwrRAzcg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 23:46:18 INFO - Downloading https://queue.taskcluster.net/v1/task/A68zA02IS_6mslMwrRAzcg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 23:46:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A68zA02IS_6mslMwrRAzcg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 23:46:22 INFO - Downloaded 107620390 bytes. 23:46:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A68zA02IS_6mslMwrRAzcg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 23:46:22 INFO - mkdir: /builds/slave/test/properties 23:46:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:46:22 INFO - Writing to file /builds/slave/test/properties/build_url 23:46:22 INFO - Contents: 23:46:22 INFO - build_url:https://queue.taskcluster.net/v1/task/A68zA02IS_6mslMwrRAzcg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 23:46:22 INFO - Running post-action listener: _resource_record_post_action 23:46:22 INFO - Running post-action listener: set_extra_try_arguments 23:46:22 INFO - [mozharness: 2016-12-03 07:46:22.897156Z] Finished download-and-extract step (success) 23:46:22 INFO - [mozharness: 2016-12-03 07:46:22.897282Z] Running populate-webroot step. 23:46:22 INFO - Running pre-action listener: _resource_record_pre_action 23:46:22 INFO - Running main action method: populate_webroot 23:46:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:46:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:46:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:46:22 INFO - '--tppagecycles', 23:46:22 INFO - '7'], 23:46:22 INFO - 'tests': ['tsvgm']}}, 23:46:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:46:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:46:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:46:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:46:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:46:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:46:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 23:46:22 INFO - 'talos_options': ['--disable-e10s'], 23:46:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:46:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 23:46:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:46:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 23:46:22 INFO - 'talos_options': ['--disable-e10s'], 23:46:22 INFO - 'tests': ['damp', 'tps']}, 23:46:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 23:46:22 INFO - 'tests': ['damp', 'tps']}, 23:46:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:46:22 INFO - 'tests': ['dromaeo_dom']}, 23:46:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:46:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:46:22 INFO - 'tests': ['basic_compositor_video']}, 23:46:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:46:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:46:22 INFO - 'tests': ['a11yr', 23:46:22 INFO - 'ts_paint', 23:46:22 INFO - 'tpaint', 23:46:22 INFO - 'sessionrestore', 23:46:22 INFO - 'sessionrestore_no_auto_restore', 23:46:22 INFO - 'tabpaint']}, 23:46:22 INFO - 'other-e10s': {'tests': ['a11yr', 23:46:22 INFO - 'ts_paint', 23:46:22 INFO - 'tpaint', 23:46:22 INFO - 'sessionrestore', 23:46:22 INFO - 'sessionrestore_no_auto_restore', 23:46:22 INFO - 'tabpaint']}, 23:46:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:46:22 INFO - 'ts_paint', 23:46:22 INFO - 'tpaint', 23:46:22 INFO - 'sessionrestore', 23:46:22 INFO - 'sessionrestore_no_auto_restore', 23:46:22 INFO - 'tabpaint']}, 23:46:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:46:22 INFO - 'ts_paint', 23:46:22 INFO - 'tpaint', 23:46:22 INFO - 'sessionrestore', 23:46:22 INFO - 'sessionrestore_no_auto_restore', 23:46:22 INFO - 'tabpaint']}, 23:46:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:46:22 INFO - 'tests': ['a11yr', 23:46:22 INFO - 'ts_paint', 23:46:22 INFO - 'tpaint', 23:46:22 INFO - 'sessionrestore', 23:46:22 INFO - 'sessionrestore_no_auto_restore', 23:46:22 INFO - 'tabpaint']}, 23:46:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:46:22 INFO - 'tests': ['a11yr', 23:46:22 INFO - 'ts_paint', 23:46:22 INFO - 'tpaint', 23:46:22 INFO - 'sessionrestore', 23:46:22 INFO - 'sessionrestore_no_auto_restore', 23:46:22 INFO - 'tabpaint']}, 23:46:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:46:22 INFO - 'tests': ['tsvgx', 23:46:22 INFO - 'tsvgr_opacity', 23:46:22 INFO - 'tart', 23:46:22 INFO - 'tscrollx', 23:46:22 INFO - 'cart', 23:46:22 INFO - 'tsvg_static']}, 23:46:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:46:22 INFO - 'tsvgr_opacity', 23:46:22 INFO - 'tart', 23:46:22 INFO - 'tscrollx', 23:46:22 INFO - 'cart', 23:46:22 INFO - 'tsvg_static']}, 23:46:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 23:46:22 INFO - 'talos_options': ['--disable-e10s'], 23:46:22 INFO - 'tests': ['tp5o']}, 23:46:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 23:46:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 23:46:22 INFO - 'talos_options': ['--disable-e10s', 23:46:22 INFO - '--xperf_path', 23:46:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:46:22 INFO - 'tests': ['tp5n']}, 23:46:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 23:46:22 INFO - 'talos_options': ['--xperf_path', 23:46:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:46:22 INFO - 'tests': ['tp5n']}}, 23:46:22 INFO - 'talos.zip': {'path': '', 23:46:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:46:22 INFO - Running post-action listener: _resource_record_post_action 23:46:22 INFO - [mozharness: 2016-12-03 07:46:22.915960Z] Finished populate-webroot step (success) 23:46:22 INFO - [mozharness: 2016-12-03 07:46:22.916095Z] Running create-virtualenv step. 23:46:22 INFO - Running pre-action listener: _resource_record_pre_action 23:46:22 INFO - Running main action method: create_virtualenv 23:46:22 INFO - Creating virtualenv /builds/slave/test/build/venv 23:46:22 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 23:46:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:46:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:46:23 INFO - Using real prefix '/tools/python27' 23:46:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:46:23 INFO - Installing distribute.............................................................................................................................................................................................done. 23:46:26 INFO - Installing pip.................done. 23:46:26 INFO - Return code: 0 23:46:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:46:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:46:26 INFO - Reading from file tmpfile_stdout 23:46:26 INFO - Output received: 23:46:26 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) 23:46:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:46:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:46:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e13d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe90a569ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df52d30>, '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 0x10ddb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df4ab20>, '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.Tc9woTBpSs/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.9ZIc7w3uEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 23:46:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:46:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:46:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Tc9woTBpSs/Render', 23:46:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:46:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:46:26 INFO - 'HOME': '/Users/cltbld', 23:46:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:46:26 INFO - 'LOGNAME': 'cltbld', 23:46:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:26 INFO - 'MOZ_NO_REMOTE': '1', 23:46:26 INFO - 'NO_EM_RESTART': '1', 23:46:26 INFO - 'PAGER': '/bin/cat', 23:46:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:46:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:26 INFO - 'PWD': '/builds/slave/test', 23:46:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:46:26 INFO - 'SHELL': '/bin/bash', 23:46:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9ZIc7w3uEY/Listeners', 23:46:26 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 23:46:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:46:26 INFO - 'USER': 'cltbld', 23:46:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:46:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:46:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:26 INFO - 'XPC_FLAGS': '0x0', 23:46:26 INFO - 'XPC_SERVICE_NAME': '0', 23:46:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:46:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:27 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 23:46:27 INFO - Cleaning up... 23:46:27 INFO - Return code: 0 23:46:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:46:27 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')]} 23:46:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:27 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')]} 23:46:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:27 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 0x10e13d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe90a569ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df52d30>, '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 0x10ddb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df4ab20>, '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.Tc9woTBpSs/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.9ZIc7w3uEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 23:46:27 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 23:46:27 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 23:46:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Tc9woTBpSs/Render', 23:46:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:46:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:46:27 INFO - 'HOME': '/Users/cltbld', 23:46:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:46:27 INFO - 'LOGNAME': 'cltbld', 23:46:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:27 INFO - 'MOZ_NO_REMOTE': '1', 23:46:27 INFO - 'NO_EM_RESTART': '1', 23:46:27 INFO - 'PAGER': '/bin/cat', 23:46:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:46:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:27 INFO - 'PWD': '/builds/slave/test', 23:46:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:46:27 INFO - 'SHELL': '/bin/bash', 23:46:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9ZIc7w3uEY/Listeners', 23:46:27 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 23:46:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:46:27 INFO - 'USER': 'cltbld', 23:46:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:46:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:46:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:27 INFO - 'XPC_FLAGS': '0x0', 23:46:27 INFO - 'XPC_SERVICE_NAME': '0', 23:46:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:46:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:27 INFO - Downloading/unpacking psutil>=3.1.1 23:46:27 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 23:46:27 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 23:46:27 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 23:46:27 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 23:46:27 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 23:46:27 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 23:46:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:46:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:46:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:46:31 INFO - Installing collected packages: psutil 23:46:31 INFO - Running setup.py install for psutil 23:46:31 INFO - building 'psutil._psutil_osx' extension 23:46:31 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 23:46:31 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 23:46:32 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 23:46:32 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 23:46:32 INFO - building 'psutil._psutil_posix' extension 23:46:32 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 23:46:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:46:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:46:32 INFO - ^ 23:46:32 INFO - 1 warning generated. 23:46:32 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 23:46:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:46:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:46:32 INFO - Successfully installed psutil 23:46:32 INFO - Cleaning up... 23:46:32 INFO - Return code: 0 23:46:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:46:32 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')]} 23:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:32 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')]} 23:46:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:32 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 0x10e13d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe90a569ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df52d30>, '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 0x10ddb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df4ab20>, '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.Tc9woTBpSs/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.9ZIc7w3uEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 23:46:32 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 23:46:32 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 23:46:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Tc9woTBpSs/Render', 23:46:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:46:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:46:32 INFO - 'HOME': '/Users/cltbld', 23:46:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:46:32 INFO - 'LOGNAME': 'cltbld', 23:46:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:32 INFO - 'MOZ_NO_REMOTE': '1', 23:46:32 INFO - 'NO_EM_RESTART': '1', 23:46:32 INFO - 'PAGER': '/bin/cat', 23:46:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:46:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:32 INFO - 'PWD': '/builds/slave/test', 23:46:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:46:32 INFO - 'SHELL': '/bin/bash', 23:46:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9ZIc7w3uEY/Listeners', 23:46:32 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 23:46:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:46:32 INFO - 'USER': 'cltbld', 23:46:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:46:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:46:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:32 INFO - 'XPC_FLAGS': '0x0', 23:46:32 INFO - 'XPC_SERVICE_NAME': '0', 23:46:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:46:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:46:32 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 23:46:32 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 23:46:32 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 23:46:32 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 23:46:32 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 23:46:32 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 23:46:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:46:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:46:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:46:35 INFO - Installing collected packages: mozsystemmonitor 23:46:35 INFO - Running setup.py install for mozsystemmonitor 23:46:35 INFO - Successfully installed mozsystemmonitor 23:46:35 INFO - Cleaning up... 23:46:35 INFO - Return code: 0 23:46:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:46:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:35 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 0x10e13d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe90a569ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df52d30>, '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 0x10ddb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df4ab20>, '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.Tc9woTBpSs/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.9ZIc7w3uEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 23:46:35 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 23:46:35 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 23:46:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Tc9woTBpSs/Render', 23:46:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:46:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:46:35 INFO - 'HOME': '/Users/cltbld', 23:46:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:46:35 INFO - 'LOGNAME': 'cltbld', 23:46:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:35 INFO - 'MOZ_NO_REMOTE': '1', 23:46:35 INFO - 'NO_EM_RESTART': '1', 23:46:35 INFO - 'PAGER': '/bin/cat', 23:46:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:46:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:35 INFO - 'PWD': '/builds/slave/test', 23:46:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:46:35 INFO - 'SHELL': '/bin/bash', 23:46:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9ZIc7w3uEY/Listeners', 23:46:35 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 23:46:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:46:35 INFO - 'USER': 'cltbld', 23:46:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:46:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:46:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:35 INFO - 'XPC_FLAGS': '0x0', 23:46:35 INFO - 'XPC_SERVICE_NAME': '0', 23:46:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:46:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:35 INFO - Downloading/unpacking jsonschema==2.5.1 23:46:35 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 23:46:35 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 23:46:35 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 23:46:35 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 23:46:35 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 23:46:35 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 23:46:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:46:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:46: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 23:46: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 23:46: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 23:46: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 23:46: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 23:46: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 23:46:38 INFO - Downloading functools32-3.2.3-2.tar.gz 23:46:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:46:38 INFO - warning: no files found matching '*.txt' 23:46:38 INFO - no previously-included directories found matching 'build' 23:46:38 INFO - no previously-included directories found matching 'dist' 23:46:38 INFO - no previously-included directories found matching '.git*' 23:46:39 INFO - Installing collected packages: jsonschema, functools32 23:46:39 INFO - Running setup.py install for functools32 23:46:39 INFO - warning: no files found matching '*.txt' 23:46:39 INFO - no previously-included directories found matching 'build' 23:46:39 INFO - no previously-included directories found matching 'dist' 23:46:39 INFO - no previously-included directories found matching '.git*' 23:46:39 INFO - Successfully installed jsonschema functools32 23:46:39 INFO - Cleaning up... 23:46:39 INFO - Return code: 0 23:46:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:46:39 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')]} 23:46:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:39 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')]} 23:46:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:39 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 0x10e13d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe90a569ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df52d30>, '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 0x10ddb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df4ab20>, '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.Tc9woTBpSs/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.9ZIc7w3uEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 23:46:39 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 23:46:39 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 23:46:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Tc9woTBpSs/Render', 23:46:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:46:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:46:39 INFO - 'HOME': '/Users/cltbld', 23:46:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:46:39 INFO - 'LOGNAME': 'cltbld', 23:46:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:39 INFO - 'MOZ_NO_REMOTE': '1', 23:46:39 INFO - 'NO_EM_RESTART': '1', 23:46:39 INFO - 'PAGER': '/bin/cat', 23:46:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:46:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:39 INFO - 'PWD': '/builds/slave/test', 23:46:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:46:39 INFO - 'SHELL': '/bin/bash', 23:46:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9ZIc7w3uEY/Listeners', 23:46:39 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 23:46:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:46:39 INFO - 'USER': 'cltbld', 23:46:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:46:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:46:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:39 INFO - 'XPC_FLAGS': '0x0', 23:46:39 INFO - 'XPC_SERVICE_NAME': '0', 23:46:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:46:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:46:39 INFO - Cleaning up... 23:46:39 INFO - Return code: 0 23:46:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:46:39 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')]} 23:46:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:39 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')]} 23:46:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:39 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 0x10e13d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe90a569ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df52d30>, '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 0x10ddb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df4ab20>, '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.Tc9woTBpSs/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.9ZIc7w3uEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 23:46:39 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 23:46:39 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 23:46:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Tc9woTBpSs/Render', 23:46:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:46:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:46:39 INFO - 'HOME': '/Users/cltbld', 23:46:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:46:39 INFO - 'LOGNAME': 'cltbld', 23:46:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:39 INFO - 'MOZ_NO_REMOTE': '1', 23:46:39 INFO - 'NO_EM_RESTART': '1', 23:46:39 INFO - 'PAGER': '/bin/cat', 23:46:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:46:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:39 INFO - 'PWD': '/builds/slave/test', 23:46:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:46:39 INFO - 'SHELL': '/bin/bash', 23:46:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9ZIc7w3uEY/Listeners', 23:46:39 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 23:46:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:46:39 INFO - 'USER': 'cltbld', 23:46:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:46:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:46:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:39 INFO - 'XPC_FLAGS': '0x0', 23:46:39 INFO - 'XPC_SERVICE_NAME': '0', 23:46:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:46:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:39 INFO - Downloading/unpacking blobuploader==1.2.4 23:46:39 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 23:46:39 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 23:46:39 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 23:46:39 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 23:46:39 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 23:46:39 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 23:46:42 INFO - Downloading blobuploader-1.2.4.tar.gz 23:46:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:46:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:46:42 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 23:46:42 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 23:46:42 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 23:46:42 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 23:46:42 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 23:46:42 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 23:46:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:46:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:46:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:43 INFO - Downloading docopt-0.6.1.tar.gz 23:46:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:46:43 INFO - Installing collected packages: blobuploader, requests, docopt 23:46:43 INFO - Running setup.py install for blobuploader 23:46:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:46:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:46:43 INFO - Running setup.py install for requests 23:46:44 INFO - Running setup.py install for docopt 23:46:44 INFO - Successfully installed blobuploader requests docopt 23:46:44 INFO - Cleaning up... 23:46:44 INFO - Return code: 0 23:46:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:46:44 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')]} 23:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:44 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')]} 23:46:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:44 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 0x10e13d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe90a569ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df52d30>, '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 0x10ddb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df4ab20>, '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.Tc9woTBpSs/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.9ZIc7w3uEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 23:46:44 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 23:46:44 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 23:46:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Tc9woTBpSs/Render', 23:46:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:46:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:46:44 INFO - 'HOME': '/Users/cltbld', 23:46:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:46:44 INFO - 'LOGNAME': 'cltbld', 23:46:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:44 INFO - 'MOZ_NO_REMOTE': '1', 23:46:44 INFO - 'NO_EM_RESTART': '1', 23:46:44 INFO - 'PAGER': '/bin/cat', 23:46:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:46:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:44 INFO - 'PWD': '/builds/slave/test', 23:46:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:46:44 INFO - 'SHELL': '/bin/bash', 23:46:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9ZIc7w3uEY/Listeners', 23:46:44 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 23:46:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:46:44 INFO - 'USER': 'cltbld', 23:46:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:46:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:46:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:44 INFO - 'XPC_FLAGS': '0x0', 23:46:44 INFO - 'XPC_SERVICE_NAME': '0', 23:46:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:46:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:46:44 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-3i5etO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:46:44 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-jTCwEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:46:45 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-cfljAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:46:45 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-MCEs7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:46:45 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-_Renf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:46:45 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-6_8Naw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:46:45 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-IyW4EE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:46:45 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-kJJMft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:46:45 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-y5IZfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:46:45 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-BYMjg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:46:45 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-Hb8apc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:46:46 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-hSdaZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:46:46 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-i0sYXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:46:46 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-wcJSeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:46:46 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-msKQzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:46:46 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-9CQ9LM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:46:46 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-C49QXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:46:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:46:46 INFO - Running setup.py install for manifestparser 23:46:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:46:46 INFO - Running setup.py install for mozcrash 23:46:46 INFO - Running setup.py install for mozdebug 23:46:47 INFO - Running setup.py install for mozdevice 23:46:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:46:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:46:47 INFO - Running setup.py install for mozfile 23:46:47 INFO - Running setup.py install for mozhttpd 23:46:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:46:47 INFO - Running setup.py install for mozinfo 23:46:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:46:47 INFO - Running setup.py install for mozInstall 23:46:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:46:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:46:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:46:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:46:47 INFO - Running setup.py install for mozleak 23:46:47 INFO - Running setup.py install for mozlog 23:46:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:46:48 INFO - Running setup.py install for moznetwork 23:46:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:46:48 INFO - Running setup.py install for mozprocess 23:46:48 INFO - Running setup.py install for mozprofile 23:46:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:46:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:46:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:46:48 INFO - Running setup.py install for mozrunner 23:46:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:46:48 INFO - Running setup.py install for mozscreenshot 23:46:48 INFO - Running setup.py install for moztest 23:46:49 INFO - Running setup.py install for mozversion 23:46:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:46:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:46:49 INFO - Cleaning up... 23:46:49 INFO - Return code: 0 23:46:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:46:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:49 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 0x10e13d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe90a569ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df52d30>, '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 0x10ddb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df4ab20>, '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.Tc9woTBpSs/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.9ZIc7w3uEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 23:46:49 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 23:46:49 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 23:46:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Tc9woTBpSs/Render', 23:46:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:46:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:46:49 INFO - 'HOME': '/Users/cltbld', 23:46:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:46:49 INFO - 'LOGNAME': 'cltbld', 23:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:49 INFO - 'MOZ_NO_REMOTE': '1', 23:46:49 INFO - 'NO_EM_RESTART': '1', 23:46:49 INFO - 'PAGER': '/bin/cat', 23:46:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:49 INFO - 'PWD': '/builds/slave/test', 23:46:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:46:49 INFO - 'SHELL': '/bin/bash', 23:46:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9ZIc7w3uEY/Listeners', 23:46:49 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 23:46:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:46:49 INFO - 'USER': 'cltbld', 23:46:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:46:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:49 INFO - 'XPC_FLAGS': '0x0', 23:46:49 INFO - 'XPC_SERVICE_NAME': '0', 23:46:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:46:49 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-3Bs0ox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:46:49 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)) 23:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:46:49 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-g27Nv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:46:49 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)) 23:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:46:49 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-nf5g2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:46:49 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)) 23:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:46:49 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-7Jb8JA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:46:49 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)) 23:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:46:49 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-A0lr9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:46:50 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)) 23:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:46:50 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-EzEVeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:46:50 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)) 23:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:46:50 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-2AvCCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:46:50 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)) 23:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:46:50 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-uyLwWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:46:50 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)) 23:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:46:50 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-wSvbey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:46:50 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)) 23:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:46:50 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-nISU4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:46:50 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)) 23:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:46:50 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-9wxCWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:46:50 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)) 23:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:46:50 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-0A9LAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:46:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:46:50 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-AInlvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:46:50 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)) 23:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:46:50 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-Ff2p3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:46:50 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)) 23:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:46:50 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-2yaHt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:46:51 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)) 23:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:46:51 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-fSHXat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:46:51 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-Inqmm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:46:51 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)) 23:46:51 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)) 23:46:51 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)) 23:46:51 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)) 23:46:51 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)) 23:46:51 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)) 23:46:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:46:51 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 23:46:51 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 23:46:51 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 23:46:51 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 23:46:51 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 23:46:51 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 23:46:53 INFO - Downloading blessings-1.6.tar.gz 23:46:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:46:53 INFO - Installing collected packages: blessings 23:46:53 INFO - Running setup.py install for blessings 23:46:54 INFO - Successfully installed blessings 23:46:54 INFO - Cleaning up... 23:46:54 INFO - Return code: 0 23:46:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:46:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:46:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:46:54 INFO - Reading from file tmpfile_stdout 23:46:54 INFO - Current package versions: 23:46:54 INFO - blessings == 1.6 23:46:54 INFO - blobuploader == 1.2.4 23:46:54 INFO - docopt == 0.6.1 23:46:54 INFO - functools32 == 3.2.3-2 23:46:54 INFO - jsonschema == 2.5.1 23:46:54 INFO - manifestparser == 1.1 23:46:54 INFO - mozInstall == 1.12 23:46:54 INFO - mozcrash == 1.0 23:46:54 INFO - mozdebug == 0.1 23:46:54 INFO - mozdevice == 0.49 23:46:54 INFO - mozfile == 1.2 23:46:54 INFO - mozhttpd == 0.7 23:46:54 INFO - mozinfo == 0.9 23:46:54 INFO - mozleak == 0.1 23:46:54 INFO - mozlog == 3.4 23:46:54 INFO - moznetwork == 0.27 23:46:54 INFO - mozprocess == 0.23 23:46:54 INFO - mozprofile == 0.28 23:46:54 INFO - mozrunner == 6.13 23:46:54 INFO - mozscreenshot == 0.1 23:46:54 INFO - mozsystemmonitor == 0.3 23:46:54 INFO - moztest == 0.7 23:46:54 INFO - mozversion == 1.4 23:46:54 INFO - psutil == 3.1.1 23:46:54 INFO - requests == 1.2.3 23:46:54 INFO - wsgiref == 0.1.2 23:46:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:54 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 0x10e13d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe90a569ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df52d30>, '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 0x10ddb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df4ab20>, '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.Tc9woTBpSs/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.9ZIc7w3uEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 23:46:54 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 23:46:54 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 23:46:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Tc9woTBpSs/Render', 23:46:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:46:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:46:54 INFO - 'HOME': '/Users/cltbld', 23:46:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:46:54 INFO - 'LOGNAME': 'cltbld', 23:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:54 INFO - 'MOZ_NO_REMOTE': '1', 23:46:54 INFO - 'NO_EM_RESTART': '1', 23:46:54 INFO - 'PAGER': '/bin/cat', 23:46:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:54 INFO - 'PWD': '/builds/slave/test', 23:46:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:46:54 INFO - 'SHELL': '/bin/bash', 23:46:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9ZIc7w3uEY/Listeners', 23:46:54 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 23:46:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:46:54 INFO - 'USER': 'cltbld', 23:46:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:46:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:54 INFO - 'XPC_FLAGS': '0x0', 23:46:54 INFO - 'XPC_SERVICE_NAME': '0', 23:46:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:54 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)) 23:46:54 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)) 23:46:54 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)) 23:46:54 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)) 23:46:54 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)) 23:46:54 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)) 23:46:54 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)) 23:46:54 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)) 23:46:54 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)) 23:46:54 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)) 23:46:54 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)) 23:46:54 INFO - Cleaning up... 23:46:54 INFO - Return code: 0 23:46:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:46:54 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 0x10e13d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe90a569ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df52d30>, '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 0x10ddb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df4ab20>, '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.Tc9woTBpSs/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.9ZIc7w3uEY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 23:46:54 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 23:46:54 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 23:46:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Tc9woTBpSs/Render', 23:46:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:46:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:46:54 INFO - 'HOME': '/Users/cltbld', 23:46:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:46:54 INFO - 'LOGNAME': 'cltbld', 23:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:54 INFO - 'MOZ_NO_REMOTE': '1', 23:46:54 INFO - 'NO_EM_RESTART': '1', 23:46:54 INFO - 'PAGER': '/bin/cat', 23:46:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:54 INFO - 'PWD': '/builds/slave/test', 23:46:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:46:54 INFO - 'SHELL': '/bin/bash', 23:46:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9ZIc7w3uEY/Listeners', 23:46:54 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 23:46:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:46:54 INFO - 'USER': 'cltbld', 23:46:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:46:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:54 INFO - 'XPC_FLAGS': '0x0', 23:46:54 INFO - 'XPC_SERVICE_NAME': '0', 23:46:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:46:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:46:55 INFO - Cleaning up... 23:46:55 INFO - Return code: 0 23:46:55 INFO - Running post-action listener: _resource_record_post_action 23:46:55 INFO - Running post-action listener: _start_resource_monitoring 23:46:55 INFO - Starting resource monitoring. 23:46:55 INFO - [mozharness: 2016-12-03 07:46:55.097979Z] Finished create-virtualenv step (success) 23:46:55 INFO - [mozharness: 2016-12-03 07:46:55.098974Z] Running install step. 23:46:55 INFO - Running pre-action listener: _resource_record_pre_action 23:46:55 INFO - Running main action method: install 23:46:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:46:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:46:55 INFO - Reading from file tmpfile_stdout 23:46:55 INFO - Detecting whether we're running mozinstall >=1.0... 23:46:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:46:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:46:55 INFO - Reading from file tmpfile_stdout 23:46:55 INFO - Output received: 23:46:55 INFO - Usage: mozinstall [options] installer 23:46:55 INFO - Options: 23:46:55 INFO - -h, --help show this help message and exit 23:46:55 INFO - -d DEST, --destination=DEST 23:46:55 INFO - Directory to install application into. [default: 23:46:55 INFO - "/builds/slave/test"] 23:46:55 INFO - --app=APP Application being installed. [default: firefox] 23:46:55 INFO - mkdir: /builds/slave/test/build/application 23:46:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 23:46:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 23:47:28 INFO - Reading from file tmpfile_stdout 23:47:28 INFO - Output received: 23:47:28 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 23:47:28 INFO - Running post-action listener: _resource_record_post_action 23:47:28 INFO - [mozharness: 2016-12-03 07:47:28.160839Z] Finished install step (success) 23:47:28 INFO - [mozharness: 2016-12-03 07:47:28.160974Z] Running run-tests step. 23:47:28 INFO - Running pre-action listener: _resource_record_pre_action 23:47:28 INFO - Running main action method: run_tests 23:47:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:47:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:47:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:47:28 INFO - 2016-12-02 23:47:28.176 screenresolution[1634:7781] starting screenresolution argv=screenresolution get 23:47:28 INFO - 2016-12-02 23:47:28.179 screenresolution[1634:7781] Display 0: 1600x1200x32@60 23:47:28 INFO - 2016-12-02 23:47:28.185 screenresolution[1635:7783] starting screenresolution argv=screenresolution list 23:47:28 INFO - Available Modes on Display 0 23:47:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:47:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:47:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:47:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:47:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:47:28 INFO - Intel Iris: 23:47:28 INFO - Chipset Model: Intel Iris 23:47:28 INFO - Type: GPU 23:47:28 INFO - Bus: Built-In 23:47:28 INFO - VRAM (Dynamic, Max): 1536 MB 23:47:28 INFO - Vendor: Intel (0x8086) 23:47:28 INFO - Device ID: 0x0a2e 23:47:28 INFO - Revision ID: 0x0009 23:47:28 INFO - Displays: 23:47:28 INFO - Display: 23:47:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:47:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:47:28 INFO - Display Serial Number: 1600x1200 60 23:47:28 INFO - Main Display: Yes 23:47:28 INFO - Mirror: Off 23:47:28 INFO - Online: Yes 23:47:28 INFO - Rotation: Supported 23:47:28 INFO - Return code: 0 23:47:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:47:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:47:28 INFO - Python 2.7.3 23:47:28 INFO - Return code: 0 23:47:28 INFO - grabbing minidump binary from tooltool 23:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:47:28 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 0x10df52d30>, '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 0x10ddb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df4ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:47:28 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 23:47:28 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 23:47:28 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 23:47:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:47:28 INFO - Return code: 0 23:47:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:47:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:47:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:47:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:47:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:47:28 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/A68zA02IS_6mslMwrRAzcg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0112', '--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 23:47:28 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/A68zA02IS_6mslMwrRAzcg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0112 --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 23:47:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Tc9woTBpSs/Render', 23:47:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:47:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:47:28 INFO - 'HOME': '/Users/cltbld', 23:47:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:47:28 INFO - 'LOGNAME': 'cltbld', 23:47:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:47:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:47:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:47:28 INFO - 'MOZ_NO_REMOTE': '1', 23:47:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:47:28 INFO - 'NO_EM_RESTART': '1', 23:47:28 INFO - 'PAGER': '/bin/cat', 23:47:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:47:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:47:28 INFO - 'PWD': '/builds/slave/test', 23:47:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:47:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:47:28 INFO - 'SHELL': '/bin/bash', 23:47:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9ZIc7w3uEY/Listeners', 23:47:28 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 23:47:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:47:28 INFO - 'USER': 'cltbld', 23:47:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:47:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:47:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:47:28 INFO - 'XPC_FLAGS': '0x0', 23:47:28 INFO - 'XPC_SERVICE_NAME': '0', 23:47:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:47:28 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/A68zA02IS_6mslMwrRAzcg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0112', '--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 23:47:28 INFO - mozversion application_buildid: 20161202221643 23:47:28 INFO - mozversion application_changeset: a8e20bf36959426f0a6eb4b5df29ef3dd85ad4bd 23:47:28 INFO - mozversion application_display_name: Nightly 23:47:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:47:28 INFO - mozversion application_name: Firefox 23:47:28 INFO - mozversion application_remotingname: firefox 23:47:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 23:47:28 INFO - mozversion application_vendor: Mozilla 23:47:28 INFO - mozversion application_version: 53.0a1 23:47:28 INFO - mozversion platform_buildid: 20161202221643 23:47:28 INFO - mozversion platform_changeset: a8e20bf36959426f0a6eb4b5df29ef3dd85ad4bd 23:47:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 23:47:28 INFO - mozversion platform_version: 53.0a1 23:47:28 INFO - using testdate: 1480751248 23:47:28 INFO - actual date: 1480751248 23:47:28 INFO - starting webserver on 'localhost:49241' 23:47:28 INFO - SUITE-START | Running 2 tests 23:47:28 INFO - TEST-START | dromaeo_css 23:47:28 INFO - operating with platform_type : mac_ 23:47:28 INFO - Initialising browser for dromaeo_css test... 23:47:28 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpxiLKDX/profile http://localhost:49241/getInfo.html) 23:47:31 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 23:47:31 INFO - PROCESS | 1645 | colorDepth:24 23:47:31 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 23:47:31 INFO - PROCESS | 1645 | __metrics 23:47:31 INFO - PROCESS | 1645 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:47:31 INFO - PROCESS | 1645 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:47:32 INFO - TEST-INFO | 1645: exit 0 23:47:32 INFO - Browser initialized. 23:47:32 INFO - Running cycle 1/1 for dromaeo_css test... 23:47:32 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpxiLKDX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:47:44 INFO - PROCESS | 1648 | RSS: Main: 245637120 23:47:44 INFO - PROCESS | 1648 | 23:48:35 INFO - PROCESS | 1648 | 1480751315530 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 23:50:48 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 23:50:50 INFO - PROCESS | 1648 | RSS: Main: 469098496 23:50:50 INFO - PROCESS | 1648 | 23:53:54 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 23:53:54 INFO - PROCESS | 1648 | RSS: Main: 373592064 23:53:54 INFO - PROCESS | 1648 | 23:56:57 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 23:56:57 INFO - PROCESS | 1648 | RSS: Main: 339369984 23:56:57 INFO - PROCESS | 1648 | 00:00:00 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 00:00:00 INFO - PROCESS | 1648 | RSS: Main: 349974528 00:00:00 INFO - PROCESS | 1648 | 00:03:04 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 00:03:04 INFO - PROCESS | 1648 | RSS: Main: 332558336 00:03:04 INFO - PROCESS | 1648 | 00:06:08 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 00:06:08 INFO - PROCESS | 1648 | RSS: Main: 434188288 00:06:08 INFO - PROCESS | 1648 | 00:06:08 INFO - PROCESS | 1648 | __start_tp_report 00:06:08 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 00:06:08 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 00:06:08 INFO - PROCESS | 1648 | |i|pagename|runs| 00:06:08 INFO - PROCESS | 1648 | |0;dojo.html;2831.654963892151;3269.7384209263255;3273.819939903306;3289.950650740238;3319.336132773446;5465.863353416166;5540.556755459564;5556.222128901957;5665.036943719567;5677.602567820254;5600.971995140018;5627.930693168305;5638.718064096799;5652.660840349572;5655.066913959202;5067.442581316052;5088.847334579968;5117.5650069744115;5154.149565321717;5195.974020129913;5076.923846142292;5154.098032844256;5160;5236.92144617831;5257.474252574731;5129.846104616849;5151.150060240056;5185.844424667247;5220.712860792655;5225.294585231002;5021.6735912165595;5194.37667479901;5195.142801437777;5199.1161502544655;5202.947970520284;4894.828680996148;5007.84976450707;5113.488651134894;5138.2549530318265;5139.84580462583;4541.43232095988;5513.972430137864;5526.530244929186;5607.719614019283;5645.068563686987;6075.453209211192;6097.603655762361;6128.014278093809;6132.988056970595;6148.262208534959;6121.632702037848;6166.044263139221;6170.969145154246;6190.783322583733;6197.504199664016;5710.885782284414;5714.514266287412;5728.283964504437;5742.626729262626;5746.166805813217;5159.948400515947;6101.435748753901;6118.314626315956;6166.260048794174;6179.474744646665;6051.878962420727;6056.515478761688;6067.605605635619;6075.422834830772;6093.847653808691;6026.9754141796;6127.754889804447;6141.232345956755;6155.199824022849;6176.3514830943;5953.732082056318;6014.097885317237;6026.186464827192;6113.358097399798;6137.079438084323;6053.667048312385;6119.388061193934;6119.571629985859;6121.296050954197;6130.969345153335;4843.24929635907;4848.8787780305065;4863.659543831968;4868.41579010521;4894.412670479494;4219.936700949488;4333.544977777288;4369.344598310216;4376.102898905717;4418.050119224318;5508.063629182969;5588.329400471888;5620.9437905621235;5651;5661.943380566224;6157.199564056734;6195.070739389038;6205.720742566596;6217.285012223561;6224.37756224374;5647.181158731961;5649.802256920988;5662.943370566241;5676.035074037423;5709.200711900337;5222.033923724123;5239.607029472805;5243.711595862188;5288.153895376721;5332.760025798849;6251.718672659741;6314.273858506147;6314.273858506331;6319.58922670025;6327.810165695037;6122;6132.478739307209;6141.3551577085545;6157.138000679998;6163.84590385244;5122.46214147524;6229.283632382153;6260.092286618324;6305.464035557029;6312.810615681537;5842.328132264844;5852.209951656472;5872.119182122716;5929.258842644669;5959.404059594006;5875.73559189846;6035.728392222449;6071.635701857903;6076.696165191811;6098.176746139392;5811.360750317377;5834.562407819515;5866.67733274674;5871.060630299132;5882.647041177543;5850.64896106235;5950.7917222896995;5950.821475355746;5956.851078723066;5962.344142144448;5731.541476681772;5784.21913041734;5785.132230165341;5790.131480277992;5791.681457519709;5937.970310148422;5941.851453713519;5944.554158438048;5954.791582294599;5963.105534169909;5779.942200577941;5790.826275211751;5792.82621521355;5799.333076696234;5800.4489573490455 00:06:08 INFO - PROCESS | 1648 | |1;ext.html;469.55626932548756;479.1184221033298;508.0524821208445;512.8897287083278;522.3940229333973;25614;39547;39678.20643587127;39684.404733928975;41492.58507414925;40122.799386003106;40820;40967.79516102423;40993.38509922346;41211.17577648445;8363.540005299707;8590.067234872135;9075.636974521029;9397.530123493832;9403.905960940405;8498.872516912252;8576.39965202436;8578.742637720878;11066.004059634632;11359.091272698164;11332.036776873976;11364.659060228207;11453.427328633577;11477.713057173554;11479.827802582968;11344.978951894327;11377.2035957483;11382.886171138265;11391.259568128087;11400.657980260605;11148.275362101438;11244.04425623823;11250.774984500345;11258.211925165242;11276.718082047932;38590.80704596459;38878;38888.61111388878;38917.22165556702;38985.025374365585;3234.2884565395575;3258.283177700902;3298.752593555469;3303.9174020649434;3364;28847.278818029507;29442.263943401587;29808.8509557453;30034.84982575073;30504.08487745371;3173.539836723662;3180.522921561761;3180.9363812723846;3288.96711032889;3300.372929143455;467868;485310;492529;492720;499049;60182.57443957849;60487.69756151279;60612;60626.78746425047;60654.696726516086;58693.41306586965;58745.11882321769;58779.706101469215;58799.41200588025;58851;15092.849071509365;15639.921800390925;15641.217939102999;15653.295601697951;15682.921585392;12038.75922481563;12123.393830308449;12124.151309408433;12125.636230913087;12135.635930922086;15970.60073498172;16435.09606971604;18025;18480;18629;6754.696038678271;7610.353119984753;7636.732714355082;7674.53952762836;7759.68961241544;836.3184005035877;919.6965001549606;979.1970584120952;1077.3589714120087;1117.3910218930703;26332.078377256705;28267;28443.295381096967;29412.705872941;29514.409711806074;1009.3741880034279;1052.6210564197036;1092.9781404371868;1098.983515247272;1139.4245905817675;14604.926975365268;15143.772843407358;15242.618934526725;15483.690326193413;15619.921900390425;893510;910941;912808;912985;914369;49020;49665.0066998658;49703.75148124309;53135.937281254155;56109.43890561042;1327.9136856104515;1352.1008529327887;1364.9454021839413;1366.9931650341684;1371.1430356027483;25981.610275846255;28289.57565636558;28312.150635480968;29604.703952960193;29872.551911720908;50503;51042.97914041772;51067.744661276454;51092.48907510877;51093.722656933875;568448;576958;646330.7683461553;826576;826835;33414.49878251877;39778.60221397865;40296.798516008406;40591.59408405878;40805;44061.45784897513;44478;44709.776451117534;44922.550774491836;45047.873803155184;36054.63945360513;36340.454893176095;36569.4049578539;37069.62930370662;37378;31827;33076.338473230884;36274;37381.87854364373;37529;35307.29385412329;35315.11712207215;35831.925042247734;35919;36285.63714362823;30877;31721.20696982594;32450.35099298048;32926;32943;20375.184992600723;23990.92267781044;24393;24870.626940596267;25050.874745626155 00:06:08 INFO - PROCESS | 1648 | |2;jquery.html;356.6237619311625;364.81941438987695;378.73677793933194;380.29645156460543;407.855211399953;14654.63363415915;15026.24868756562;16347.754783678225;20171.697424538645;20406.591868162628;19798;20385.18459261628;20540.794592054073;20717.171313147493;20918;6265.8120256392385;6327.5570710050315;6596.571222870498;6628.767993120242;6678.966605166992;6470.805875823733;6477.287498375175;6518.185226846645;6533.281339052701;6637.634930078843;4493.550644935497;4633.768311584424;4689.882752931187;4732.597729193006;7475.140358858746;7169.713211471535;7513.737019204329;7522.13495448025;7538.849223015563;7547.320741133324;7128.287171282882;7199.172095209065;7200.351968322876;7200.495965282433;7213.819654508627;26348.94604215848;26987.190384288504;27034.72965270342;27205;27516.62416879168;2340.3564019894493;2369.7393286738443;2404.8076153907646;2476.938076548083;3211.6627754085716;15100.602364468017;15378.077315361114;15917.52247432579;16048.197590120564;16777.161141942976;1860.7208918662309;1956.7945365736678;1968.0553334399426;1974;1988.8508361872916;98014;99645.50177249068;100049;110621;141357.2932135343;17472.82527174712;20037.599248014958;20169.899150504152;20213.8454694055;20258.594828103356;33291.83354083214;33416.83291583575;33425.99722008344;33502.3299534008;33506.49740253898;9902.257330700226;9912.306138570375;10070.848937265946;10260.179185665129;10405.115565177044;8253.711120110767;8348.290395316466;8362.58187090643;8524.445911015764;8537;8859.734207973772;9172.587233574504;9227.077292270718;9238.399504032217;9265.166135047879;2950.542665886791;3511.5610548681416;3608.332458495187;3616.8191590420374;3629.6007439181667;845.4842546046906;885.4288983605538;904.5025236120108;940.6566603189787;1002.1181360402944;19116.139773710216;19613.80386196148;20024.69962950557;20071.59856802856;20174.092165852573;909.7816524034184;935.6070450410843;936.8688383626297;950.676769898224;987.5605355616682;10085.596576136872;10427.217958653131;10556.47217639115;10564.260501764802;10565.471726413802;572710.1364493151;577973;585381;587402;589069;85734;123997;126415;129184;129306.70693293135;948.2982592881218;971.3491960386558;1012.7468132966758;1022.1720406470633;1024.5031159887449;13877.722445551235;17228.655426891142;17499.7375039372;18689.822551125682;18793.90603046976;44427.77786111049;54264;54540.18189727236;55230.89538209294;55554;73434;75655.62172189103;76380;76442;77735.7294287799;6826.829329266808;7184.568925864465;7676.4647070587225;7929;8206.507609543447;11411.885881141414;12524.93737531343;12543.435545400662;12944.223346599234;13036.739265214832;8789.956050219707;10817.242793004414;10820.621278255223;11184.217104802585;11339;10709.036186743231;10731.087857532197;11031.558737650405;11164.776704465703;11247.493862776031;10943.781124377627;11394.601188958346;11570.59502917394;11672.88327116718;11708.414579270831;7254.45591580623;7256.2018178001435;7339.155997060193;7385.778426646994;7393.44549158826;9697.660581879883;10753.89246107529;11067.944660276647;11139.88860111421;11216.270942388719 00:06:08 INFO - PROCESS | 1648 | |3;mootools.html;1467.6330917270686;1496.4687535924747;1662.1772222749732;1825.087456271864;1838.9632207355853;7850.254225848543;8243.134470880561;8248.17518248175;8250.876236856444;8271.710490132855;7273.7817865463985;7425.962870185642;7516.060492438445;7528.435367347443;8076.798080048002;2237.451824303044;2293.4037150340946;2293.678884956099;2295.1393227539675;2298.069281940817;2287.954240915181;2294.4837411582425;2310.041332846875;2314.513952070059;2326.5114325991563;1938.8836669799787;2260.7852254035924;2287.5996700577416;2287.782660647236;2290.7823756743164;2263.0608297556496;2285.8171346292424;2287.2223444028946;2289.8053665438456;2291.8510296830655;2264.467850055236;2284.588774020676;2291.8395712300144;2295.437617783654;2296.5751336002727;8059.556724380157;8228.547429891354;8237.46456480333;8247.175282471764;8255.628496717602;4954.9009019819405;5118.923216151761;5121.052605268037;5121.615878809067;5139.254808052849;3133.4359815233247;3268.6567910369545;3301.4222511060707;3355.07735372772;3386.9491957620407;904.380499357942;954.9713508594754;992.5235886774317;1002.5087707023579;1002.5187909803335;10643.78712425755;10716.196285278558;10722.249442539025;10731.087857532119;10736.194785391126;4225.19721252961;4495.483019452739;4574.679772415965;4595.149897268949;4690.742009189527;7952.36381089523;9213.30900182489;9220.815583688289;9226.169644732006;9262.95368523153;5117.360329958755;5123.436421993578;5123.7438128093445;5123.948760512421;5129.3075434816565;4569.95430045702;4593.333966574828;4648.48866624671;4696.154692155376;4702.083093796745;3102.3640153768424;3656.469811877263;3710.2023065040607;3751.399776035821;3795.4306853972125;1096.819024860905;1209.6854817747274;1244.7821631214501;1249.1131296779388;1265.2155663488695;692.8545005548891;786.6263524825662;811.9188081191834;817.6157206113118;827.4042689263721;4923.163062279421;4956.231784073474;4956.975215123901;5064.82273120439;5150.175971844487;353.40451339493035;424.74090804609165;431.1484817485441;434.03427374092394;443.2155085498649;3706.4625629283605;3716.962830371716;3756.7370284079852;3765.548134223911;3833.884983450501;8961.507117108491;9873.308868379145;10041.949790251001;10045.899541004497;10056.64801731936;9987.650432234837;9989.100980911753;9991.200703943667;9995.550200241007;10008.3494572854;6630.86738265232;7003.369696727319;7312.939623754526;7599.810004749926;7735.1491335953;5503.559715222693;5704.971475142598;5709.400512946081;5722.856928576819;5756.510696590837;8864.601092950703;9154.725358239264;9236.815263694554;9248.006550796143;9390.76523086901;9233.215176709786;9436;9464.479453630116;9507.334486585873;9516.619335226791;6215.96892015537;6408.198975128109;6412.39082287182;6414.069959855888;6420.486361091008;7562.810929726801;7632.313091821763;7718.807029824299;7731.342835859015;7807.453478256468;6104.816855494342;6937.861242775217;7008.719651213894;7035;7150;5892.587518873637;6800.591964482147;6893.655317234218;6934.271901450476;6936.375726184668;6466.741330346734;6602.60384376939;6612.074309596756;6613;6617.338266173537;4607.585317321457;4768.213244814567;4833.903321933612;4844.224924012282;4902.166631672696;4663.743494107856;4707.81168753246;4761.1429942609275;4782.258749893772;4965.602751779777 00:06:08 INFO - PROCESS | 1648 | |4;prototype.html;270.7509091635695;280.50210875695626;301.3746476062171;305.625608629429;310.2244389027431;5379.112446446336;5384.561592791285;5432.511074003339;5435.701036442994;5443.074677304858;5169.09540830355;5373.328333958255;5381.19282107684;5409.673840248692;5415.323084614423;3450.7411944104165;3481.408160612702;3724.646158614934;3970.7419017763896;3971.5631280559114;3722.88831335059;3963.4451176835264;4081.428599996003;4108.301588729923;4112.074783173792;4060.9187816243657;4061.431399604058;4079.388091786226;4092.283850326196;4099.323611604082;3336.582927134108;3590.0486371111806;3760.52993375828;3841.7706333973138;3999.900002499932;3118.672539383355;3556.413191823346;3556.5198698175673;3568.892933212008;3586.1214002569277;4860;4942.332785074005;5189.6886186828915;5235.502627250443;5239.318888544465;4493.371377744023;4612.285095810154;4620.884477888046;4658.136745301907;4677.345171675968;4942.9258561121615;5598.880223955225;5602.047651899187;5665.036943719578;5707.571932105108;3465.4455287154187;3920.941185882214;3933.9803300983313;3957.8021098944937;3958.148997965451;5790.334111577138;5960.195373624592;5994.580379373446;6043.969780151071;6047.03247480401;3606.6753992140307;3969.206158768258;3997.6402123809;3999.200159968018;4010.6590939770444;3434.759566830298;3564.946525802115;4055.533613634411;4060.3706425504092;4076.510818701775;4102.958970410317;4667.789949452283;4692.694974826693;4698.671093023524;4705.529447055335;5137.990459302226;5193.402758682724;5343.877785664976;5653.406392328829;5684.403137670568;1189.6431070678761;1229.9668278645981;1309.5874799438147;1310.6133690561308;1320.683036071336;857.2113655437013;910.7677542226689;916.3722849847876;918.8989211186764;925.2135684668112;4318.935215971763;5135.687481574364;5184.293230340325;5225.764840582183;5360.962834123086;5793.073108302651;5802.709864506758;5834.766609335664;5844.684945887141;5845.970770146122;5009.5741861941415;5263.921041184385;5309.7345132743985;5311.750599520368;5336.466353364633;2859.256593285719;2863.8854445821935;2893.6816950135467;2914.621099257083;2914.732091540144;5558.1648662422795;5627.705627705651;5719.96642954206;5741.511971482387;5748.5688573357165;4969.9126366925975;5100.183970564692;5258.763355649005;5668.817505260505;5692.715364231772;4868;5680.5455563554815;5698;5718.142278658234;5763.94236057634;4729.5034021427255;5240.737963101906;5483.670979741229;5493.835184944458;5505.697186654773;5451.781928722807;5458.8908221834545;5471.50756431923;5471.644343117685;5479.863003424946;4786.495530140366;5333.973330133324;5576.944230557805;5666.575006874418;5744.885102298014;3304.5043243513664;3594.676479116892;3732.6267373263545;3748.6626203641804;3798.981005094957;4542.409486766831;5457.181422786613;5468.207109969112;5486.286782718221;5493.258410114743;5322.654027488201;5347.51872331492;5348.438413966477;5361.571074313967;5381.596380271417;4416.801243943966;4972.3894955148835;5304.628675992643;5328.4671532846405;5370.03339398912;5202.2196670498215;5206.73966301691;5209.270702101633;5220.112580861187;5286.603504737083;5079.898402032012;5102.744862756922;5141.889157059925;5349.946500534945;5563.7496312666835;5551.417101204315;5562.276904002454;5591.412901645432;5595.8880822384135;5648.88702225945 00:06:08 INFO - PROCESS | 1648 | |5;yui.html;685.6914388525163;694.1982010777554;756.6670664907442;790.5967956342264;806.3831169155593;14489.058211216277;15410.99828511146;15432.768508472354;15460.613484662876;15509.302081406335;13520;14129.788053179185;14360.71278574428;14375.281235938188;14377.568672939802;827.6234313387424;840.5335039053323;842.970496032639;846.8687353460193;847.3644766425181;663.93692599203;690.8825499665069;692.7990882644052;809.9352051835868;846.5386364431369;879.6789171952255;902.4089221559889;903.5572569440959;904.398574947659;906.2885634776702;849.8980122385292;849.9872501912477;850.6087199888059;869.4044579463025;900.0414558495181;518.4659800405551;535.7963973690012;633.0346222011469;664.7208172567533;667.1293961380396;11859.940700296529;13741.24423156726;14147;14150.08024478416;14154.50459233932;13373.465061397532;13418.46326146953;13441.39513721885;13507.459701611924;13807.51673691416;12314.81527777084;12481.188722732993;12506.624801255977;12594.937025314906;12642.367881605884;4285.57144285572;4353.25994580922;4377.584129507692;4390.912181756379;4552.613027892633;114873;117681;118016;118932.40533797363;123250.76749232483;10584.682459526226;10708.411037392862;10847.186461015297;10927.125829933586;10929.289596176222;17676.469705908843;19991.800081999285;20898.58202835935;20898.686519702216;20919.26782562603;7531.322181003736;7567.621618919142;7616.3906887448875;7757.650905709256;7823.530588164728;4184.121334519724;4198.8110535026;4212.135747691599;4212.750898424438;4345.152695224464;3234.886778962725;3289.309245058517;3350.547676063749;3351.5978082629754;3353.128186671483;617.108278537518;621.201755743867;621.3568956130474;630.908518264849;647.1263793878227;474.34066647360197;585.5491271720751;597.5936363273016;598.8413070536311;613.3804857094277;7349.485536012535;8376.204260595234;8856.158664926821;9284.25725941923;9719.416834989923;600.828763802323;612.3080918562085;629.8834715577633;658.1608449227274;663.6151032401195;3216.8230747308653;3646.5988741238443;4080.7959602019782;4412.183746006999;4448.799804008828;99343.50328248457;101863.49068254759;103106.48446757719;104429;105777;88132.55933720291;90650.64024039645;91182.54408727914;91682;92784;65082;79887.20112798798;80036.19963800287;81475.18524814676;83135.58432207801;8312.33501319905;8613.26787223093;8613.65545378178;8899.911000890168;8923.598438070432;49714.751426242634;50304.24543631775;50695.2395714072;51092.48907510877;51634;62780.686096569225;62962.37037629565;68775.65612171908;68811.65594171998;75568.86646700413;12467.93766031164;12871.742565148832;13051;13145.277009764171;13243.735125297633;14061.086029408056;14264.358103885143;14488.985770995929;14620.634484137981;15002.474913377979;13173.077884548373;13386.330683465592;13505.932470337586;13697.246651434267;14158.78761818553;12680.048996325497;13174.341282936006;13252.80120798208;13494.662633434242;13640.590782276548;11283.66149015531;11346.375949322866;12457.750844982867;12570.811437828623;13262.005349598625;9624.37441566296;10510.579576816841;10811.6215932442;11085.612003579836;11337.149713771336;9825.803483930138;10057.446840423847;10418;11096.667099987013;11203.775924481302 00:06:08 INFO - PROCESS | 1648 | __end_tp_report 00:06:08 INFO - PROCESS | 1648 | __start_cc_report 00:06:08 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,2824 00:06:08 INFO - PROCESS | 1648 | __end_cc_report 00:06:08 INFO - PROCESS | 1648 | __startTimestamp1480752368532__endTimestamp 00:06:08 INFO - PROCESS | 1648 | 00:06:08 INFO - PROCESS | 1648 | ------- Summary: start ------- 00:06:08 INFO - PROCESS | 1648 | Number of tests: 6 00:06:08 INFO - PROCESS | 1648 | 00:06:08 INFO - PROCESS | 1648 | [#0] dojo.html Cycles:165 Average:5620.24 Median:5790.83 stddev:639.82 (11.0%) stddev-sans-first:603.22 00:06:08 INFO - PROCESS | 1648 | Values: 2831.7 3269.7 3273.8 3290.0 3319.3 5465.9 5540.6 5556.2 5665.0 5677.6 5601.0 5627.9 5638.7 5652.7 5655.1 5067.4 5088.8 5117.6 5154.1 5196.0 5076.9 5154.1 5160.0 5236.9 5257.5 5129.8 5151.2 5185.8 5220.7 5225.3 5021.7 5194.4 5195.1 5199.1 5202.9 4894.8 5007.8 5113.5 5138.3 5139.8 4541.4 5514.0 5526.5 5607.7 5645.1 6075.5 6097.6 6128.0 6133.0 6148.3 6121.6 6166.0 6171.0 6190.8 6197.5 5710.9 5714.5 5728.3 5742.6 5746.2 5159.9 6101.4 6118.3 6166.3 6179.5 6051.9 6056.5 6067.6 6075.4 6093.8 6027.0 6127.8 6141.2 6155.2 6176.4 5953.7 6014.1 6026.2 6113.4 6137.1 6053.7 6119.4 6119.6 6121.3 6131.0 4843.2 4848.9 4863.7 4868.4 4894.4 4219.9 4333.5 4369.3 4376.1 4418.1 5508.1 5588.3 5620.9 5651.0 5661.9 6157.2 6195.1 6205.7 6217.3 6224.4 5647.2 5649.8 5662.9 5676.0 5709.2 5222.0 5239.6 5243.7 5288.2 5332.8 6251.7 6314.3 6314.3 6319.6 6327.8 6122.0 6132.5 6141.4 6157.1 6163.8 5122.5 6229.3 6260.1 6305.5 6312.8 5842.3 5852.2 5872.1 5929.3 5959.4 5875.7 6035.7 6071.6 6076.7 6098.2 5811.4 5834.6 5866.7 5871.1 5882.6 5850.6 5950.8 5950.8 5956.9 5962.3 5731.5 5784.2 5785.1 5790.1 5791.7 5938.0 5941.9 5944.6 5954.8 5963.1 5779.9 5790.8 5792.8 5799.3 5800.4 00:06:08 INFO - PROCESS | 1648 | 00:06:08 INFO - PROCESS | 1648 | [#1] ext.html Cycles:180 Average:80242.38 Median:35875.46 stddev:194213.07 (541.4%) stddev-sans-first:194665.53 00:06:08 INFO - PROCESS | 1648 | Values: 469.6 479.1 508.1 512.9 522.4 25614.0 39547.0 39678.2 39684.4 41492.6 40122.8 40820.0 40967.8 40993.4 41211.2 8363.5 8590.1 9075.6 9397.5 9403.9 8498.9 8576.4 8578.7 11066.0 11359.1 11332.0 11364.7 11453.4 11477.7 11479.8 11345.0 11377.2 11382.9 11391.3 11400.7 11148.3 11244.0 11250.8 11258.2 11276.7 38590.8 38878.0 38888.6 38917.2 38985.0 3234.3 3258.3 3298.8 3303.9 3364.0 28847.3 29442.3 29808.9 30034.8 30504.1 3173.5 3180.5 3180.9 3289.0 3300.4 467868.0 485310.0 492529.0 492720.0 499049.0 60182.6 60487.7 60612.0 60626.8 60654.7 58693.4 58745.1 58779.7 58799.4 58851.0 15092.8 15639.9 15641.2 15653.3 15682.9 12038.8 12123.4 12124.2 12125.6 12135.6 15970.6 16435.1 18025.0 18480.0 18629.0 6754.7 7610.4 7636.7 7674.5 7759.7 836.3 919.7 979.2 1077.4 1117.4 26332.1 28267.0 28443.3 29412.7 29514.4 1009.4 1052.6 1093.0 1099.0 1139.4 14604.9 15143.8 15242.6 15483.7 15619.9 893510.0 910941.0 912808.0 912985.0 914369.0 49020.0 49665.0 49703.8 53135.9 56109.4 1327.9 1352.1 1364.9 1367.0 1371.1 25981.6 28289.6 28312.2 29604.7 29872.6 50503.0 51043.0 51067.7 51092.5 51093.7 568448.0 576958.0 646330.8 826576.0 826835.0 33414.5 39778.6 40296.8 40591.6 40805.0 44061.5 44478.0 44709.8 44922.6 45047.9 36054.6 36340.5 36569.4 37069.6 37378.0 31827.0 33076.3 36274.0 37381.9 37529.0 35307.3 35315.1 35831.9 35919.0 36285.6 30877.0 31721.2 32450.4 32926.0 32943.0 20375.2 23990.9 24393.0 24870.6 25050.9 00:06:08 INFO - PROCESS | 1648 | 00:06:08 INFO - PROCESS | 1648 | [#2] jquery.html Cycles:180 Average:35117.06 Median:33464.16 stddev:96816.64 (289.3%) stddev-sans-first:97053.05 00:06:08 INFO - PROCESS | 1648 | Values: 356.6 364.8 378.7 380.3 407.9 14654.6 15026.2 16347.8 20171.7 20406.6 19798.0 20385.2 20540.8 20717.2 20918.0 6265.8 6327.6 6596.6 6628.8 6679.0 6470.8 6477.3 6518.2 6533.3 6637.6 4493.6 4633.8 4689.9 4732.6 7475.1 7169.7 7513.7 7522.1 7538.8 7547.3 7128.3 7199.2 7200.4 7200.5 7213.8 26348.9 26987.2 27034.7 27205.0 27516.6 2340.4 2369.7 2404.8 2476.9 3211.7 15100.6 15378.1 15917.5 16048.2 16777.2 1860.7 1956.8 1968.1 1974.0 1988.9 98014.0 99645.5 100049.0 110621.0 141357.3 17472.8 20037.6 20169.9 20213.8 20258.6 33291.8 33416.8 33426.0 33502.3 33506.5 9902.3 9912.3 10070.8 10260.2 10405.1 8253.7 8348.3 8362.6 8524.4 8537.0 8859.7 9172.6 9227.1 9238.4 9265.2 2950.5 3511.6 3608.3 3616.8 3629.6 845.5 885.4 904.5 940.7 1002.1 19116.1 19613.8 20024.7 20071.6 20174.1 909.8 935.6 936.9 950.7 987.6 10085.6 10427.2 10556.5 10564.3 10565.5 572710.1 577973.0 585381.0 587402.0 589069.0 85734.0 123997.0 126415.0 129184.0 129306.7 948.3 971.3 1012.7 1022.2 1024.5 13877.7 17228.7 17499.7 18689.8 18793.9 44427.8 54264.0 54540.2 55230.9 55554.0 73434.0 75655.6 76380.0 76442.0 77735.7 6826.8 7184.6 7676.5 7929.0 8206.5 11411.9 12524.9 12543.4 12944.2 13036.7 8790.0 10817.2 10820.6 11184.2 11339.0 10709.0 10731.1 11031.6 11164.8 11247.5 10943.8 11394.6 11570.6 11672.9 11708.4 7254.5 7256.2 7339.2 7385.8 7393.4 9697.7 10753.9 11067.9 11139.9 11216.3 00:06:08 INFO - PROCESS | 1648 | 00:06:08 INFO - PROCESS | 1648 | [#3] mootools.html Cycles:180 Average:5282.49 Median:5091.09 stddev:2927.21 (57.5%) stddev-sans-first:2921.39 00:06:08 INFO - PROCESS | 1648 | Values: 1467.6 1496.5 1662.2 1825.1 1839.0 7850.3 8243.1 8248.2 8250.9 8271.7 7273.8 7426.0 7516.1 7528.4 8076.8 2237.5 2293.4 2293.7 2295.1 2298.1 2288.0 2294.5 2310.0 2314.5 2326.5 1938.9 2260.8 2287.6 2287.8 2290.8 2263.1 2285.8 2287.2 2289.8 2291.9 2264.5 2284.6 2291.8 2295.4 2296.6 8059.6 8228.5 8237.5 8247.2 8255.6 4954.9 5118.9 5121.1 5121.6 5139.3 3133.4 3268.7 3301.4 3355.1 3386.9 904.4 955.0 992.5 1002.5 1002.5 10643.8 10716.2 10722.2 10731.1 10736.2 4225.2 4495.5 4574.7 4595.1 4690.7 7952.4 9213.3 9220.8 9226.2 9263.0 5117.4 5123.4 5123.7 5123.9 5129.3 4570.0 4593.3 4648.5 4696.2 4702.1 3102.4 3656.5 3710.2 3751.4 3795.4 1096.8 1209.7 1244.8 1249.1 1265.2 692.9 786.6 811.9 817.6 827.4 4923.2 4956.2 4957.0 5064.8 5150.2 353.4 424.7 431.1 434.0 443.2 3706.5 3717.0 3756.7 3765.5 3833.9 8961.5 9873.3 10041.9 10045.9 10056.6 9987.7 9989.1 9991.2 9995.6 10008.3 6630.9 7003.4 7312.9 7599.8 7735.1 5503.6 5705.0 5709.4 5722.9 5756.5 8864.6 9154.7 9236.8 9248.0 9390.8 9233.2 9436.0 9464.5 9507.3 9516.6 6216.0 6408.2 6412.4 6414.1 6420.5 7562.8 7632.3 7718.8 7731.3 7807.5 6104.8 6937.9 7008.7 7035.0 7150.0 5892.6 6800.6 6893.7 6934.3 6936.4 6466.7 6602.6 6612.1 6613.0 6617.3 4607.6 4768.2 4833.9 4844.2 4902.2 4663.7 4707.8 4761.1 4782.3 4965.6 00:06:08 INFO - PROCESS | 1648 | 00:06:08 INFO - PROCESS | 1648 | [#4] prototype.html Cycles:180 Average:4503.78 Median:5191.55 stddev:1376.15 (26.5%) stddev-sans-first:1342.83 00:06:08 INFO - PROCESS | 1648 | Values: 270.8 280.5 301.4 305.6 310.2 5379.1 5384.6 5432.5 5435.7 5443.1 5169.1 5373.3 5381.2 5409.7 5415.3 3450.7 3481.4 3724.6 3970.7 3971.6 3722.9 3963.4 4081.4 4108.3 4112.1 4060.9 4061.4 4079.4 4092.3 4099.3 3336.6 3590.0 3760.5 3841.8 3999.9 3118.7 3556.4 3556.5 3568.9 3586.1 4860.0 4942.3 5189.7 5235.5 5239.3 4493.4 4612.3 4620.9 4658.1 4677.3 4942.9 5598.9 5602.0 5665.0 5707.6 3465.4 3920.9 3934.0 3957.8 3958.1 5790.3 5960.2 5994.6 6044.0 6047.0 3606.7 3969.2 3997.6 3999.2 4010.7 3434.8 3564.9 4055.5 4060.4 4076.5 4103.0 4667.8 4692.7 4698.7 4705.5 5138.0 5193.4 5343.9 5653.4 5684.4 1189.6 1230.0 1309.6 1310.6 1320.7 857.2 910.8 916.4 918.9 925.2 4318.9 5135.7 5184.3 5225.8 5361.0 5793.1 5802.7 5834.8 5844.7 5846.0 5009.6 5263.9 5309.7 5311.8 5336.5 2859.3 2863.9 2893.7 2914.6 2914.7 5558.2 5627.7 5720.0 5741.5 5748.6 4969.9 5100.2 5258.8 5668.8 5692.7 4868.0 5680.5 5698.0 5718.1 5763.9 4729.5 5240.7 5483.7 5493.8 5505.7 5451.8 5458.9 5471.5 5471.6 5479.9 4786.5 5334.0 5576.9 5666.6 5744.9 3304.5 3594.7 3732.6 3748.7 3799.0 4542.4 5457.2 5468.2 5486.3 5493.3 5322.7 5347.5 5348.4 5361.6 5381.6 4416.8 4972.4 5304.6 5328.5 5370.0 5202.2 5206.7 5209.3 5220.1 5286.6 5079.9 5102.7 5141.9 5349.9 5563.7 5551.4 5562.3 5591.4 5595.9 5648.9 00:06:08 INFO - PROCESS | 1648 | 00:06:08 INFO - PROCESS | 1648 | [#5] yui.html Cycles:180 Average:20660.64 Median:4349.21 stddev:30692.14 (705.7%) stddev-sans-first:30741.60 00:06:08 INFO - PROCESS | 1648 | Values: 685.7 694.2 756.7 790.6 806.4 14489.1 15411.0 15432.8 15460.6 15509.3 13520.0 14129.8 14360.7 14375.3 14377.6 827.6 840.5 843.0 846.9 847.4 663.9 690.9 692.8 809.9 846.5 879.7 902.4 903.6 904.4 906.3 849.9 850.0 850.6 869.4 900.0 518.5 535.8 633.0 664.7 667.1 11859.9 13741.2 14147.0 14150.1 14154.5 13373.5 13418.5 13441.4 13507.5 13807.5 12314.8 12481.2 12506.6 12594.9 12642.4 4285.6 4353.3 4377.6 4390.9 4552.6 114873.0 117681.0 118016.0 118932.4 123250.8 10584.7 10708.4 10847.2 10927.1 10929.3 17676.5 19991.8 20898.6 20898.7 20919.3 7531.3 7567.6 7616.4 7757.7 7823.5 4184.1 4198.8 4212.1 4212.8 4345.2 3234.9 3289.3 3350.5 3351.6 3353.1 617.1 621.2 621.4 630.9 647.1 474.3 585.5 597.6 598.8 613.4 7349.5 8376.2 8856.2 9284.3 9719.4 600.8 612.3 629.9 658.2 663.6 3216.8 3646.6 4080.8 4412.2 4448.8 99343.5 101863.5 103106.5 104429.0 105777.0 88132.6 90650.6 91182.5 91682.0 92784.0 65082.0 79887.2 80036.2 81475.2 83135.6 8312.3 8613.3 8613.7 8899.9 8923.6 49714.8 50304.2 50695.2 51092.5 51634.0 62780.7 62962.4 68775.7 68811.7 75568.9 12467.9 12871.7 13051.0 13145.3 13243.7 14061.1 14264.4 14489.0 14620.6 15002.5 13173.1 13386.3 13505.9 13697.2 14158.8 12680.0 13174.3 13252.8 13494.7 13640.6 11283.7 11346.4 12457.8 12570.8 13262.0 9624.4 10510.6 10811.6 11085.6 11337.1 9825.8 10057.4 10418.0 11096.7 11203.8 00:06:08 INFO - PROCESS | 1648 | -------- Summary: end -------- 00:06:08 INFO - PROCESS | 1648 | 00:06:09 INFO - TEST-INFO | 1648: exit 0 00:06:09 INFO - TEST-OK | dromaeo_css | took 1120468ms 00:06:09 INFO - TEST-START | kraken 00:06:09 INFO - operating with platform_type : mac_ 00:06:09 INFO - Initialising browser for kraken test... 00:06:09 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpV_C7Cd/profile http://localhost:49241/getInfo.html) 00:06:11 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 00:06:11 INFO - PROCESS | 1654 | colorDepth:24 00:06:11 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 00:06:11 INFO - PROCESS | 1654 | __metrics 00:06:11 INFO - PROCESS | 1654 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:06:11 INFO - PROCESS | 1654 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:06:12 INFO - TEST-INFO | 1654: exit 0 00:06:12 INFO - Browser initialized. 00:06:12 INFO - Running cycle 1/1 for kraken test... 00:06:12 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpV_C7Cd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:06:25 INFO - PROCESS | 1655 | RSS: Main: 236494848 00:06:25 INFO - PROCESS | 1655 | 00:06:28 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 00:06:28 INFO - PROCESS | 1655 | RSS: Main: 293867520 00:06:28 INFO - PROCESS | 1655 | 00:06:31 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 00:06:32 INFO - PROCESS | 1655 | RSS: Main: 296386560 00:06:32 INFO - PROCESS | 1655 | 00:06:35 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 00:06:36 INFO - PROCESS | 1655 | RSS: Main: 389296128 00:06:36 INFO - PROCESS | 1655 | 00:06:38 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 00:06:38 INFO - PROCESS | 1655 | RSS: Main: 291381248 00:06:38 INFO - PROCESS | 1655 | 00:06:40 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:06:41 INFO - PROCESS | 1655 | RSS: Main: 294735872 00:06:41 INFO - PROCESS | 1655 | 00:06:44 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 00:06:44 INFO - PROCESS | 1655 | RSS: Main: 337334272 00:06:44 INFO - PROCESS | 1655 | 00:06:47 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 00:06:48 INFO - PROCESS | 1655 | RSS: Main: 339615744 00:06:48 INFO - PROCESS | 1655 | 00:06:51 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 00:06:51 INFO - PROCESS | 1655 | RSS: Main: 334696448 00:06:51 INFO - PROCESS | 1655 | 00:06:53 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:06:54 INFO - PROCESS | 1655 | RSS: Main: 309293056 00:06:54 INFO - PROCESS | 1655 | 00:06:56 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:06:56 INFO - PROCESS | 1655 | RSS: Main: 313217024 00:06:56 INFO - PROCESS | 1655 | 00:06:58 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:06:59 INFO - PROCESS | 1655 | RSS: Main: 315183104 00:06:59 INFO - PROCESS | 1655 | 00:07:02 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:07:03 INFO - PROCESS | 1655 | RSS: Main: 334098432 00:07:03 INFO - PROCESS | 1655 | 00:07:06 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:07:07 INFO - PROCESS | 1655 | RSS: Main: 327995392 00:07:07 INFO - PROCESS | 1655 | 00:07:08 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 00:07:09 INFO - PROCESS | 1655 | RSS: Main: 372039680 00:07:09 INFO - PROCESS | 1655 | 00:07:09 INFO - PROCESS | 1655 | __start_tp_report 00:07:09 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 00:07:09 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 00:07:09 INFO - PROCESS | 1655 | |i|pagename|runs| 00:07:09 INFO - PROCESS | 1655 | |0;ai-astar;102;114;162;168;114;114;113;114;112;113 00:07:09 INFO - PROCESS | 1655 | |1;audio-beat-detection;150;126;140;183;142;114;114;115;133;112 00:07:09 INFO - PROCESS | 1655 | |2;audio-dft;183;184;186;184;190;255;195;185;184;184 00:07:09 INFO - PROCESS | 1655 | |3;audio-fft;79;59;59;89;62;59;59;57;73;58 00:07:09 INFO - PROCESS | 1655 | |4;audio-oscillator;86;71;85;69;67;70;81;68;68;84 00:07:09 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;89;86;88;86;88;87;89;85;88;85 00:07:09 INFO - PROCESS | 1655 | |6;imaging-darkroom;106;149;115;96;94;96;96;95;94;95 00:07:09 INFO - PROCESS | 1655 | |7;imaging-desaturate;87;85;86;88;87;88;87;88;86;86 00:07:09 INFO - PROCESS | 1655 | |8;json-parse-financial;57;57;57;57;55;58;56;56;56;57 00:07:09 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;65;73;79;76;72;70;70;72;70;70 00:07:09 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;89;87;88;86;88;87;87;88;87;88 00:07:09 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;162;162;147;148;152;156;156;166;209;160 00:07:09 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;175;174;171;175;176;169;200;230;187;175 00:07:09 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;70;70;70;69;69;69;69;68;70;69 00:07:09 INFO - PROCESS | 1655 | __end_tp_report 00:07:09 INFO - PROCESS | 1655 | __start_cc_report 00:07:09 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,2115 00:07:09 INFO - PROCESS | 1655 | __end_cc_report 00:07:09 INFO - PROCESS | 1655 | __startTimestamp1480752429165__endTimestamp 00:07:09 INFO - PROCESS | 1655 | 00:07:09 INFO - PROCESS | 1655 | ------- Summary: start ------- 00:07:09 INFO - PROCESS | 1655 | Number of tests: 14 00:07:09 INFO - PROCESS | 1655 | 00:07:09 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:122.60 Median:114.00 stddev:22.68 (19.9%) stddev-sans-first:22.80 00:07:09 INFO - PROCESS | 1655 | Values: 102.0 114.0 162.0 168.0 114.0 114.0 113.0 114.0 112.0 113.0 00:07:09 INFO - PROCESS | 1655 | 00:07:09 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:132.90 Median:136.50 stddev:22.25 (16.3%) stddev-sans-first:22.72 00:07:09 INFO - PROCESS | 1655 | Values: 150.0 126.0 140.0 183.0 142.0 114.0 114.0 115.0 133.0 112.0 00:07:09 INFO - PROCESS | 1655 | 00:07:09 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:193.00 Median:185.50 stddev:22.10 (11.9%) stddev-sans-first:23.14 00:07:09 INFO - PROCESS | 1655 | Values: 183.0 184.0 186.0 184.0 190.0 255.0 195.0 185.0 184.0 184.0 00:07:09 INFO - PROCESS | 1655 | 00:07:09 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:65.40 Median:60.50 stddev:11.06 (18.3%) stddev-sans-first:10.58 00:07:09 INFO - PROCESS | 1655 | Values: 79.0 59.0 59.0 89.0 62.0 59.0 59.0 57.0 73.0 58.0 00:07:09 INFO - PROCESS | 1655 | 00:07:09 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:74.90 Median:76.00 stddev:8.01 (10.5%) stddev-sans-first:7.42 00:07:09 INFO - PROCESS | 1655 | Values: 86.0 71.0 85.0 69.0 67.0 70.0 81.0 68.0 68.0 84.0 00:07:09 INFO - PROCESS | 1655 | 00:07:09 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:87.10 Median:88.00 stddev:1.52 (1.7%) stddev-sans-first:1.45 00:07:09 INFO - PROCESS | 1655 | Values: 89.0 86.0 88.0 86.0 88.0 87.0 89.0 85.0 88.0 85.0 00:07:09 INFO - PROCESS | 1655 | 00:07:09 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:103.60 Median:95.00 stddev:17.33 (18.2%) stddev-sans-first:18.36 00:07:09 INFO - PROCESS | 1655 | Values: 106.0 149.0 115.0 96.0 94.0 96.0 96.0 95.0 94.0 95.0 00:07:09 INFO - PROCESS | 1655 | 00:07:09 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:86.80 Median:87.00 stddev:1.03 (1.2%) stddev-sans-first:1.09 00:07:09 INFO - PROCESS | 1655 | Values: 87.0 85.0 86.0 88.0 87.0 88.0 87.0 88.0 86.0 86.0 00:07:09 INFO - PROCESS | 1655 | 00:07:09 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:57.00 stddev:0.84 (1.5%) stddev-sans-first:0.88 00:07:09 INFO - PROCESS | 1655 | Values: 57.0 57.0 57.0 57.0 55.0 58.0 56.0 56.0 56.0 57.0 00:07:09 INFO - PROCESS | 1655 | 00:07:09 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:72.00 stddev:3.80 (5.3%) stddev-sans-first:3.17 00:07:09 INFO - PROCESS | 1655 | Values: 65.0 73.0 79.0 76.0 72.0 70.0 70.0 72.0 70.0 70.0 00:07:09 INFO - PROCESS | 1655 | 00:07:09 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:88.00 stddev:0.85 (1.0%) stddev-sans-first:0.71 00:07:09 INFO - PROCESS | 1655 | Values: 89.0 87.0 88.0 86.0 88.0 87.0 87.0 88.0 87.0 88.0 00:07:09 INFO - PROCESS | 1655 | 00:07:09 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:161.80 Median:161.00 stddev:17.71 (11.0%) stddev-sans-first:18.78 00:07:09 INFO - PROCESS | 1655 | Values: 162.0 162.0 147.0 148.0 152.0 156.0 156.0 166.0 209.0 160.0 00:07:09 INFO - PROCESS | 1655 | 00:07:09 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.20 Median:175.50 stddev:18.78 (10.7%) stddev-sans-first:19.69 00:07:09 INFO - PROCESS | 1655 | Values: 175.0 174.0 171.0 175.0 176.0 169.0 200.0 230.0 187.0 175.0 00:07:09 INFO - PROCESS | 1655 | 00:07:09 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 00:07:09 INFO - PROCESS | 1655 | Values: 70.0 70.0 70.0 69.0 69.0 69.0 69.0 68.0 70.0 69.0 00:07:09 INFO - PROCESS | 1655 | -------- Summary: end -------- 00:07:09 INFO - PROCESS | 1655 | 00:07:10 INFO - TEST-INFO | 1655: exit 0 00:07:10 INFO - TEST-OK | kraken | took 61126ms 00:07:10 INFO - SUITE-END | took 1181s 00:07:10 INFO - Completed test suite (00:19:42) 00:07:10 INFO - javascript benchmark 00:07:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2831.654963892151, 3269.7384209263255, 3273.819939903306, 3289.950650740238, 3319.336132773446, 5465.863353416166, 5540.556755459564, 5556.222128901957, 5665.036943719567, 5677.602567820254, 5600.971995140018, 5627.930693168305, 5638.718064096799, 5652.660840349572, 5655.066913959202, 5067.442581316052, 5088.847334579968, 5117.5650069744115, 5154.149565321717, 5195.974020129913, 5076.923846142292, 5154.098032844256, 5160.0, 5236.92144617831, 5257.474252574731, 5129.846104616849, 5151.150060240056, 5185.844424667247, 5220.712860792655, 5225.294585231002, 5021.6735912165595, 5194.37667479901, 5195.142801437777, 5199.1161502544655, 5202.947970520284, 4894.828680996148, 5007.84976450707, 5113.488651134894, 5138.2549530318265, 5139.84580462583, 4541.43232095988, 5513.972430137864, 5526.530244929186, 5607.719614019283, 5645.068563686987, 6075.453209211192, 6097.603655762361, 6128.014278093809, 6132.988056970595, 6148.262208534959, 6121.632702037848, 6166.044263139221, 6170.969145154246, 6190.783322583733, 6197.504199664016, 5710.885782284414, 5714.514266287412, 5728.283964504437, 5742.626729262626, 5746.166805813217, 5159.948400515947, 6101.435748753901, 6118.314626315956, 6166.260048794174, 6179.474744646665, 6051.878962420727, 6056.515478761688, 6067.605605635619, 6075.422834830772, 6093.847653808691, 6026.9754141796, 6127.754889804447, 6141.232345956755, 6155.199824022849, 6176.3514830943, 5953.732082056318, 6014.097885317237, 6026.186464827192, 6113.358097399798, 6137.079438084323, 6053.667048312385, 6119.388061193934, 6119.571629985859, 6121.296050954197, 6130.969345153335, 4843.24929635907, 4848.8787780305065, 4863.659543831968, 4868.41579010521, 4894.412670479494, 4219.936700949488, 4333.544977777288, 4369.344598310216, 4376.102898905717, 4418.050119224318, 5508.063629182969, 5588.329400471888, 5620.9437905621235, 5651.0, 5661.943380566224, 6157.199564056734, 6195.070739389038, 6205.720742566596, 6217.285012223561, 6224.37756224374, 5647.181158731961, 5649.802256920988, 5662.943370566241, 5676.035074037423, 5709.200711900337, 5222.033923724123, 5239.607029472805, 5243.711595862188, 5288.153895376721, 5332.760025798849, 6251.718672659741, 6314.273858506147, 6314.273858506331, 6319.58922670025, 6327.810165695037, 6122.0, 6132.478739307209, 6141.3551577085545, 6157.138000679998, 6163.84590385244, 5122.46214147524, 6229.283632382153, 6260.092286618324, 6305.464035557029, 6312.810615681537, 5842.328132264844, 5852.209951656472, 5872.119182122716, 5929.258842644669, 5959.404059594006, 5875.73559189846, 6035.728392222449, 6071.635701857903, 6076.696165191811, 6098.176746139392, 5811.360750317377, 5834.562407819515, 5866.67733274674, 5871.060630299132, 5882.647041177543, 5850.64896106235, 5950.7917222896995, 5950.821475355746, 5956.851078723066, 5962.344142144448, 5731.541476681772, 5784.21913041734, 5785.132230165341, 5790.131480277992, 5791.681457519709, 5937.970310148422, 5941.851453713519, 5944.554158438048, 5954.791582294599, 5963.105534169909, 5779.942200577941, 5790.826275211751, 5792.82621521355, 5799.333076696234, 5800.4489573490455], "value": 5578.427232150905, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [469.55626932548756, 479.1184221033298, 508.0524821208445, 512.8897287083278, 522.3940229333973, 25614.0, 39547.0, 39678.20643587127, 39684.404733928975, 41492.58507414925, 40122.799386003106, 40820.0, 40967.79516102423, 40993.38509922346, 41211.17577648445, 8363.540005299707, 8590.067234872135, 9075.636974521029, 9397.530123493832, 9403.905960940405, 8498.872516912252, 8576.39965202436, 8578.742637720878, 11066.004059634632, 11359.091272698164, 11332.036776873976, 11364.659060228207, 11453.427328633577, 11477.713057173554, 11479.827802582968, 11344.978951894327, 11377.2035957483, 11382.886171138265, 11391.259568128087, 11400.657980260605, 11148.275362101438, 11244.04425623823, 11250.774984500345, 11258.211925165242, 11276.718082047932, 38590.80704596459, 38878.0, 38888.61111388878, 38917.22165556702, 38985.025374365585, 3234.2884565395575, 3258.283177700902, 3298.752593555469, 3303.9174020649434, 3364.0, 28847.278818029507, 29442.263943401587, 29808.8509557453, 30034.84982575073, 30504.08487745371, 3173.539836723662, 3180.522921561761, 3180.9363812723846, 3288.96711032889, 3300.372929143455, 467868.0, 485310.0, 492529.0, 492720.0, 499049.0, 60182.57443957849, 60487.69756151279, 60612.0, 60626.78746425047, 60654.696726516086, 58693.41306586965, 58745.11882321769, 58779.706101469215, 58799.41200588025, 58851.0, 15092.849071509365, 15639.921800390925, 15641.217939102999, 15653.295601697951, 15682.921585392, 12038.75922481563, 12123.393830308449, 12124.151309408433, 12125.636230913087, 12135.635930922086, 15970.60073498172, 16435.09606971604, 18025.0, 18480.0, 18629.0, 6754.696038678271, 7610.353119984753, 7636.732714355082, 7674.53952762836, 7759.68961241544, 836.3184005035877, 919.6965001549606, 979.1970584120952, 1077.3589714120087, 1117.3910218930703, 26332.078377256705, 28267.0, 28443.295381096967, 29412.705872941, 29514.409711806074, 1009.3741880034279, 1052.6210564197036, 1092.9781404371868, 1098.983515247272, 1139.4245905817675, 14604.926975365268, 15143.772843407358, 15242.618934526725, 15483.690326193413, 15619.921900390425, 893510.0, 910941.0, 912808.0, 912985.0, 914369.0, 49020.0, 49665.0066998658, 49703.75148124309, 53135.937281254155, 56109.43890561042, 1327.9136856104515, 1352.1008529327887, 1364.9454021839413, 1366.9931650341684, 1371.1430356027483, 25981.610275846255, 28289.57565636558, 28312.150635480968, 29604.703952960193, 29872.551911720908, 50503.0, 51042.97914041772, 51067.744661276454, 51092.48907510877, 51093.722656933875, 568448.0, 576958.0, 646330.7683461553, 826576.0, 826835.0, 33414.49878251877, 39778.60221397865, 40296.798516008406, 40591.59408405878, 40805.0, 44061.45784897513, 44478.0, 44709.776451117534, 44922.550774491836, 45047.873803155184, 36054.63945360513, 36340.454893176095, 36569.4049578539, 37069.62930370662, 37378.0, 31827.0, 33076.338473230884, 36274.0, 37381.87854364373, 37529.0, 35307.29385412329, 35315.11712207215, 35831.925042247734, 35919.0, 36285.63714362823, 30877.0, 31721.20696982594, 32450.35099298048, 32926.0, 32943.0, 20375.184992600723, 23990.92267781044, 24393.0, 24870.626940596267, 25050.874745626155], "value": 20149.061425591848, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.6237619311625, 364.81941438987695, 378.73677793933194, 380.29645156460543, 407.855211399953, 14654.63363415915, 15026.24868756562, 16347.754783678225, 20171.697424538645, 20406.591868162628, 19798.0, 20385.18459261628, 20540.794592054073, 20717.171313147493, 20918.0, 6265.8120256392385, 6327.5570710050315, 6596.571222870498, 6628.767993120242, 6678.966605166992, 6470.805875823733, 6477.287498375175, 6518.185226846645, 6533.281339052701, 6637.634930078843, 4493.550644935497, 4633.768311584424, 4689.882752931187, 4732.597729193006, 7475.140358858746, 7169.713211471535, 7513.737019204329, 7522.13495448025, 7538.849223015563, 7547.320741133324, 7128.287171282882, 7199.172095209065, 7200.351968322876, 7200.495965282433, 7213.819654508627, 26348.94604215848, 26987.190384288504, 27034.72965270342, 27205.0, 27516.62416879168, 2340.3564019894493, 2369.7393286738443, 2404.8076153907646, 2476.938076548083, 3211.6627754085716, 15100.602364468017, 15378.077315361114, 15917.52247432579, 16048.197590120564, 16777.161141942976, 1860.7208918662309, 1956.7945365736678, 1968.0553334399426, 1974.0, 1988.8508361872916, 98014.0, 99645.50177249068, 100049.0, 110621.0, 141357.2932135343, 17472.82527174712, 20037.599248014958, 20169.899150504152, 20213.8454694055, 20258.594828103356, 33291.83354083214, 33416.83291583575, 33425.99722008344, 33502.3299534008, 33506.49740253898, 9902.257330700226, 9912.306138570375, 10070.848937265946, 10260.179185665129, 10405.115565177044, 8253.711120110767, 8348.290395316466, 8362.58187090643, 8524.445911015764, 8537.0, 8859.734207973772, 9172.587233574504, 9227.077292270718, 9238.399504032217, 9265.166135047879, 2950.542665886791, 3511.5610548681416, 3608.332458495187, 3616.8191590420374, 3629.6007439181667, 845.4842546046906, 885.4288983605538, 904.5025236120108, 940.6566603189787, 1002.1181360402944, 19116.139773710216, 19613.80386196148, 20024.69962950557, 20071.59856802856, 20174.092165852573, 909.7816524034184, 935.6070450410843, 936.8688383626297, 950.676769898224, 987.5605355616682, 10085.596576136872, 10427.217958653131, 10556.47217639115, 10564.260501764802, 10565.471726413802, 572710.1364493151, 577973.0, 585381.0, 587402.0, 589069.0, 85734.0, 123997.0, 126415.0, 129184.0, 129306.70693293135, 948.2982592881218, 971.3491960386558, 1012.7468132966758, 1022.1720406470633, 1024.5031159887449, 13877.722445551235, 17228.655426891142, 17499.7375039372, 18689.822551125682, 18793.90603046976, 44427.77786111049, 54264.0, 54540.18189727236, 55230.89538209294, 55554.0, 73434.0, 75655.62172189103, 76380.0, 76442.0, 77735.7294287799, 6826.829329266808, 7184.568925864465, 7676.4647070587225, 7929.0, 8206.507609543447, 11411.885881141414, 12524.93737531343, 12543.435545400662, 12944.223346599234, 13036.739265214832, 8789.956050219707, 10817.242793004414, 10820.621278255223, 11184.217104802585, 11339.0, 10709.036186743231, 10731.087857532197, 11031.558737650405, 11164.776704465703, 11247.493862776031, 10943.781124377627, 11394.601188958346, 11570.59502917394, 11672.88327116718, 11708.414579270831, 7254.45591580623, 7256.2018178001435, 7339.155997060193, 7385.778426646994, 7393.44549158826, 9697.660581879883, 10753.89246107529, 11067.944660276647, 11139.88860111421, 11216.270942388719], "value": 10490.227570014224, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1467.6330917270686, 1496.4687535924747, 1662.1772222749732, 1825.087456271864, 1838.9632207355853, 7850.254225848543, 8243.134470880561, 8248.17518248175, 8250.876236856444, 8271.710490132855, 7273.7817865463985, 7425.962870185642, 7516.060492438445, 7528.435367347443, 8076.798080048002, 2237.451824303044, 2293.4037150340946, 2293.678884956099, 2295.1393227539675, 2298.069281940817, 2287.954240915181, 2294.4837411582425, 2310.041332846875, 2314.513952070059, 2326.5114325991563, 1938.8836669799787, 2260.7852254035924, 2287.5996700577416, 2287.782660647236, 2290.7823756743164, 2263.0608297556496, 2285.8171346292424, 2287.2223444028946, 2289.8053665438456, 2291.8510296830655, 2264.467850055236, 2284.588774020676, 2291.8395712300144, 2295.437617783654, 2296.5751336002727, 8059.556724380157, 8228.547429891354, 8237.46456480333, 8247.175282471764, 8255.628496717602, 4954.9009019819405, 5118.923216151761, 5121.052605268037, 5121.615878809067, 5139.254808052849, 3133.4359815233247, 3268.6567910369545, 3301.4222511060707, 3355.07735372772, 3386.9491957620407, 904.380499357942, 954.9713508594754, 992.5235886774317, 1002.5087707023579, 1002.5187909803335, 10643.78712425755, 10716.196285278558, 10722.249442539025, 10731.087857532119, 10736.194785391126, 4225.19721252961, 4495.483019452739, 4574.679772415965, 4595.149897268949, 4690.742009189527, 7952.36381089523, 9213.30900182489, 9220.815583688289, 9226.169644732006, 9262.95368523153, 5117.360329958755, 5123.436421993578, 5123.7438128093445, 5123.948760512421, 5129.3075434816565, 4569.95430045702, 4593.333966574828, 4648.48866624671, 4696.154692155376, 4702.083093796745, 3102.3640153768424, 3656.469811877263, 3710.2023065040607, 3751.399776035821, 3795.4306853972125, 1096.819024860905, 1209.6854817747274, 1244.7821631214501, 1249.1131296779388, 1265.2155663488695, 692.8545005548891, 786.6263524825662, 811.9188081191834, 817.6157206113118, 827.4042689263721, 4923.163062279421, 4956.231784073474, 4956.975215123901, 5064.82273120439, 5150.175971844487, 353.40451339493035, 424.74090804609165, 431.1484817485441, 434.03427374092394, 443.2155085498649, 3706.4625629283605, 3716.962830371716, 3756.7370284079852, 3765.548134223911, 3833.884983450501, 8961.507117108491, 9873.308868379145, 10041.949790251001, 10045.899541004497, 10056.64801731936, 9987.650432234837, 9989.100980911753, 9991.200703943667, 9995.550200241007, 10008.3494572854, 6630.86738265232, 7003.369696727319, 7312.939623754526, 7599.810004749926, 7735.1491335953, 5503.559715222693, 5704.971475142598, 5709.400512946081, 5722.856928576819, 5756.510696590837, 8864.601092950703, 9154.725358239264, 9236.815263694554, 9248.006550796143, 9390.76523086901, 9233.215176709786, 9436.0, 9464.479453630116, 9507.334486585873, 9516.619335226791, 6215.96892015537, 6408.198975128109, 6412.39082287182, 6414.069959855888, 6420.486361091008, 7562.810929726801, 7632.313091821763, 7718.807029824299, 7731.342835859015, 7807.453478256468, 6104.816855494342, 6937.861242775217, 7008.719651213894, 7035.0, 7150.0, 5892.587518873637, 6800.591964482147, 6893.655317234218, 6934.271901450476, 6936.375726184668, 6466.741330346734, 6602.60384376939, 6612.074309596756, 6613.0, 6617.338266173537, 4607.585317321457, 4768.213244814567, 4833.903321933612, 4844.224924012282, 4902.166631672696, 4663.743494107856, 4707.81168753246, 4761.1429942609275, 4782.258749893772, 4965.602751779777], "value": 4200.945532637142, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [270.7509091635695, 280.50210875695626, 301.3746476062171, 305.625608629429, 310.2244389027431, 5379.112446446336, 5384.561592791285, 5432.511074003339, 5435.701036442994, 5443.074677304858, 5169.09540830355, 5373.328333958255, 5381.19282107684, 5409.673840248692, 5415.323084614423, 3450.7411944104165, 3481.408160612702, 3724.646158614934, 3970.7419017763896, 3971.5631280559114, 3722.88831335059, 3963.4451176835264, 4081.428599996003, 4108.301588729923, 4112.074783173792, 4060.9187816243657, 4061.431399604058, 4079.388091786226, 4092.283850326196, 4099.323611604082, 3336.582927134108, 3590.0486371111806, 3760.52993375828, 3841.7706333973138, 3999.900002499932, 3118.672539383355, 3556.413191823346, 3556.5198698175673, 3568.892933212008, 3586.1214002569277, 4860.0, 4942.332785074005, 5189.6886186828915, 5235.502627250443, 5239.318888544465, 4493.371377744023, 4612.285095810154, 4620.884477888046, 4658.136745301907, 4677.345171675968, 4942.9258561121615, 5598.880223955225, 5602.047651899187, 5665.036943719578, 5707.571932105108, 3465.4455287154187, 3920.941185882214, 3933.9803300983313, 3957.8021098944937, 3958.148997965451, 5790.334111577138, 5960.195373624592, 5994.580379373446, 6043.969780151071, 6047.03247480401, 3606.6753992140307, 3969.206158768258, 3997.6402123809, 3999.200159968018, 4010.6590939770444, 3434.759566830298, 3564.946525802115, 4055.533613634411, 4060.3706425504092, 4076.510818701775, 4102.958970410317, 4667.789949452283, 4692.694974826693, 4698.671093023524, 4705.529447055335, 5137.990459302226, 5193.402758682724, 5343.877785664976, 5653.406392328829, 5684.403137670568, 1189.6431070678761, 1229.9668278645981, 1309.5874799438147, 1310.6133690561308, 1320.683036071336, 857.2113655437013, 910.7677542226689, 916.3722849847876, 918.8989211186764, 925.2135684668112, 4318.935215971763, 5135.687481574364, 5184.293230340325, 5225.764840582183, 5360.962834123086, 5793.073108302651, 5802.709864506758, 5834.766609335664, 5844.684945887141, 5845.970770146122, 5009.5741861941415, 5263.921041184385, 5309.7345132743985, 5311.750599520368, 5336.466353364633, 2859.256593285719, 2863.8854445821935, 2893.6816950135467, 2914.621099257083, 2914.732091540144, 5558.1648662422795, 5627.705627705651, 5719.96642954206, 5741.511971482387, 5748.5688573357165, 4969.9126366925975, 5100.183970564692, 5258.763355649005, 5668.817505260505, 5692.715364231772, 4868.0, 5680.5455563554815, 5698.0, 5718.142278658234, 5763.94236057634, 4729.5034021427255, 5240.737963101906, 5483.670979741229, 5493.835184944458, 5505.697186654773, 5451.781928722807, 5458.8908221834545, 5471.50756431923, 5471.644343117685, 5479.863003424946, 4786.495530140366, 5333.973330133324, 5576.944230557805, 5666.575006874418, 5744.885102298014, 3304.5043243513664, 3594.676479116892, 3732.6267373263545, 3748.6626203641804, 3798.981005094957, 4542.409486766831, 5457.181422786613, 5468.207109969112, 5486.286782718221, 5493.258410114743, 5322.654027488201, 5347.51872331492, 5348.438413966477, 5361.571074313967, 5381.596380271417, 4416.801243943966, 4972.3894955148835, 5304.628675992643, 5328.4671532846405, 5370.03339398912, 5202.2196670498215, 5206.73966301691, 5209.270702101633, 5220.112580861187, 5286.603504737083, 5079.898402032012, 5102.744862756922, 5141.889157059925, 5349.946500534945, 5563.7496312666835, 5551.417101204315, 5562.276904002454, 5591.412901645432, 5595.8880822384135, 5648.88702225945], "value": 4058.646532956468, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [685.6914388525163, 694.1982010777554, 756.6670664907442, 790.5967956342264, 806.3831169155593, 14489.058211216277, 15410.99828511146, 15432.768508472354, 15460.613484662876, 15509.302081406335, 13520.0, 14129.788053179185, 14360.71278574428, 14375.281235938188, 14377.568672939802, 827.6234313387424, 840.5335039053323, 842.970496032639, 846.8687353460193, 847.3644766425181, 663.93692599203, 690.8825499665069, 692.7990882644052, 809.9352051835868, 846.5386364431369, 879.6789171952255, 902.4089221559889, 903.5572569440959, 904.398574947659, 906.2885634776702, 849.8980122385292, 849.9872501912477, 850.6087199888059, 869.4044579463025, 900.0414558495181, 518.4659800405551, 535.7963973690012, 633.0346222011469, 664.7208172567533, 667.1293961380396, 11859.940700296529, 13741.24423156726, 14147.0, 14150.08024478416, 14154.50459233932, 13373.465061397532, 13418.46326146953, 13441.39513721885, 13507.459701611924, 13807.51673691416, 12314.81527777084, 12481.188722732993, 12506.624801255977, 12594.937025314906, 12642.367881605884, 4285.57144285572, 4353.25994580922, 4377.584129507692, 4390.912181756379, 4552.613027892633, 114873.0, 117681.0, 118016.0, 118932.40533797363, 123250.76749232483, 10584.682459526226, 10708.411037392862, 10847.186461015297, 10927.125829933586, 10929.289596176222, 17676.469705908843, 19991.800081999285, 20898.58202835935, 20898.686519702216, 20919.26782562603, 7531.322181003736, 7567.621618919142, 7616.3906887448875, 7757.650905709256, 7823.530588164728, 4184.121334519724, 4198.8110535026, 4212.135747691599, 4212.750898424438, 4345.152695224464, 3234.886778962725, 3289.309245058517, 3350.547676063749, 3351.5978082629754, 3353.128186671483, 617.108278537518, 621.201755743867, 621.3568956130474, 630.908518264849, 647.1263793878227, 474.34066647360197, 585.5491271720751, 597.5936363273016, 598.8413070536311, 613.3804857094277, 7349.485536012535, 8376.204260595234, 8856.158664926821, 9284.25725941923, 9719.416834989923, 600.828763802323, 612.3080918562085, 629.8834715577633, 658.1608449227274, 663.6151032401195, 3216.8230747308653, 3646.5988741238443, 4080.7959602019782, 4412.183746006999, 4448.799804008828, 99343.50328248457, 101863.49068254759, 103106.48446757719, 104429.0, 105777.0, 88132.55933720291, 90650.64024039645, 91182.54408727914, 91682.0, 92784.0, 65082.0, 79887.20112798798, 80036.19963800287, 81475.18524814676, 83135.58432207801, 8312.33501319905, 8613.26787223093, 8613.65545378178, 8899.911000890168, 8923.598438070432, 49714.751426242634, 50304.24543631775, 50695.2395714072, 51092.48907510877, 51634.0, 62780.686096569225, 62962.37037629565, 68775.65612171908, 68811.65594171998, 75568.86646700413, 12467.93766031164, 12871.742565148832, 13051.0, 13145.277009764171, 13243.735125297633, 14061.086029408056, 14264.358103885143, 14488.985770995929, 14620.634484137981, 15002.474913377979, 13173.077884548373, 13386.330683465592, 13505.932470337586, 13697.246651434267, 14158.78761818553, 12680.048996325497, 13174.341282936006, 13252.80120798208, 13494.662633434242, 13640.590782276548, 11283.66149015531, 11346.375949322866, 12457.750844982867, 12570.811437828623, 13262.005349598625, 9624.37441566296, 10510.579576816841, 10811.6215932442, 11085.612003579836, 11337.149713771336, 9825.803483930138, 10057.446840423847, 10418.0, 11096.667099987013, 11203.775924481302], "value": 7272.7119980504895, "unit": "score"}], "name": "dromaeo_css", "value": 7258.351745176392, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 162.0, 168.0, 114.0, 114.0, 113.0, 114.0, 112.0, 113.0], "value": 122.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 126.0, 140.0, 183.0, 142.0, 114.0, 114.0, 115.0, 133.0, 112.0], "value": 132.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 186.0, 184.0, 190.0, 255.0, 195.0, 185.0, 184.0, 184.0], "value": 193.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 59.0, 89.0, 62.0, 59.0, 59.0, 57.0, 73.0, 58.0], "value": 65.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 85.0, 69.0, 67.0, 70.0, 81.0, 68.0, 68.0, 84.0], "value": 74.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 88.0, 86.0, 88.0, 87.0, 89.0, 85.0, 88.0, 85.0], "value": 87.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 149.0, 115.0, 96.0, 94.0, 96.0, 96.0, 95.0, 94.0, 95.0], "value": 103.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 86.0, 88.0, 87.0, 88.0, 87.0, 88.0, 86.0, 86.0], "value": 86.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 57.0, 55.0, 58.0, 56.0, 56.0, 56.0, 57.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 79.0, 76.0, 72.0, 70.0, 70.0, 72.0, 70.0, 70.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 88.0, 86.0, 88.0, 87.0, 87.0, 88.0, 87.0, 88.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 147.0, 148.0, 152.0, 156.0, 156.0, 166.0, 209.0, 160.0], "value": 161.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 174.0, 171.0, 175.0, 176.0, 169.0, 200.0, 230.0, 187.0, 175.0], "value": 183.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 70.0, 69.0, 69.0, 69.0, 69.0, 68.0, 70.0, 69.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1496.3999999999999, "alertThreshold": 2.0}]} 00:07:10 INFO - Return code: 0 00:07:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:07:10 INFO - # TBPL SUCCESS # 00:07:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:07:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:07:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:07:11 INFO - 2016-12-03 00:07:11.010 screenresolution[1659:10138] starting screenresolution argv=screenresolution get 00:07:11 INFO - 2016-12-03 00:07:11.013 screenresolution[1659:10138] Display 0: 1600x1200x32@60 00:07:11 INFO - 2016-12-03 00:07:11.019 screenresolution[1660:10141] starting screenresolution argv=screenresolution list 00:07:11 INFO - Available Modes on Display 0 00:07:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:07:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:07:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:07:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:07:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:07:11 INFO - Intel Iris: 00:07:11 INFO - Chipset Model: Intel Iris 00:07:11 INFO - Type: GPU 00:07:11 INFO - Bus: Built-In 00:07:11 INFO - VRAM (Dynamic, Max): 1536 MB 00:07:11 INFO - Vendor: Intel (0x8086) 00:07:11 INFO - Device ID: 0x0a2e 00:07:11 INFO - Revision ID: 0x0009 00:07:11 INFO - Displays: 00:07:11 INFO - Display: 00:07:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:07:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:07:11 INFO - Display Serial Number: 1600x1200 60 00:07:11 INFO - Main Display: Yes 00:07:11 INFO - Mirror: Off 00:07:11 INFO - Online: Yes 00:07:11 INFO - Rotation: Supported 00:07:11 INFO - Return code: 0 00:07:11 INFO - Running post-action listener: _resource_record_post_action 00:07:11 INFO - [mozharness: 2016-12-03 08:07:11.254082Z] Finished run-tests step (success) 00:07:11 INFO - Running post-run listener: _resource_record_post_run 00:07:11 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 36895744; Write bytes: 698110976; Read time: 498; Write time: 2349 00:07:11 INFO - TinderboxPrint: CPU usage
53.8% 00:07:11 INFO - TinderboxPrint: I/O read bytes / time
36,895,744 / 498 00:07:11 INFO - TinderboxPrint: I/O write bytes / time
698,110,976 / 2,349 00:07:11 INFO - TinderboxPrint: CPU idle
2,244.0 (46.2%) 00:07:11 INFO - TinderboxPrint: CPU system
976.8 (20.1%) 00:07:11 INFO - TinderboxPrint: CPU user
1,641.0 (33.8%) 00:07:11 INFO - TinderboxPrint: Swap in / out
415,940,608 / 0 00:07:11 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 384887296; Write bytes: 386024960; Read time: 28976; Write time: 709 00:07:11 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 34671616; Write bytes: 310742528; Read time: 474; Write time: 1635 00:07:11 INFO - Running post-run listener: _upload_blobber_files 00:07:11 INFO - Blob upload gear active. 00:07:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:07:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 00:07:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:07:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:07:12 INFO - (blobuploader) - INFO - Open directory for files ... 00:07:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:07:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:07:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:07:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:07:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:07:13 INFO - (blobuploader) - INFO - Done attempting. 00:07:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:07:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:07:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:07:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:07:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:07:14 INFO - (blobuploader) - INFO - Done attempting. 00:07:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:07:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:07:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:07:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:07:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:07:16 INFO - (blobuploader) - INFO - Done attempting. 00:07:16 INFO - (blobuploader) - INFO - Iteration through files over. 00:07:16 INFO - Return code: 0 00:07:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:07:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:07:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb845727043a8584dabf86a10ea7f8f965d87851e5d5dc4af547a6bdda1e973c63b183402e7c766b5284758f72cadff8f789216ea51bd4b8f70ee10565286555", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5012136ded9dc70624e4d6e1d08a9abc8f1e987826feb25e3bd8f7afca89d717fcb3854806a261d3659f63c78b1281c7ce49231e08208bffafbafda0f95a687", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58374b13cc5e421d8d2c997314a6999cbffd4f954cf8877dde0497536528605e05b2a32df45356a8a606bd0b590ffdd2123e4f806cb6ad739e4bf14c1f44f256"} 00:07:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:07:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:07:16 INFO - Contents: 00:07:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb845727043a8584dabf86a10ea7f8f965d87851e5d5dc4af547a6bdda1e973c63b183402e7c766b5284758f72cadff8f789216ea51bd4b8f70ee10565286555", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5012136ded9dc70624e4d6e1d08a9abc8f1e987826feb25e3bd8f7afca89d717fcb3854806a261d3659f63c78b1281c7ce49231e08208bffafbafda0f95a687", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58374b13cc5e421d8d2c997314a6999cbffd4f954cf8877dde0497536528605e05b2a32df45356a8a606bd0b590ffdd2123e4f806cb6ad739e4bf14c1f44f256"} 00:07:16 INFO - Running post-run listener: copy_logs_to_upload_dir 00:07:16 INFO - Copying logs to upload dir... 00:07:16 INFO - mkdir: /builds/slave/test/build/upload/logs 00:07:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.759965 ========= master_lag: 0.12 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-12-03 00:07:16.722177) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-03 00:07:16.726056) ========= 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.Tc9woTBpSs/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.9ZIc7w3uEY/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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/bb845727043a8584dabf86a10ea7f8f965d87851e5d5dc4af547a6bdda1e973c63b183402e7c766b5284758f72cadff8f789216ea51bd4b8f70ee10565286555", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5012136ded9dc70624e4d6e1d08a9abc8f1e987826feb25e3bd8f7afca89d717fcb3854806a261d3659f63c78b1281c7ce49231e08208bffafbafda0f95a687", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58374b13cc5e421d8d2c997314a6999cbffd4f954cf8877dde0497536528605e05b2a32df45356a8a606bd0b590ffdd2123e4f806cb6ad739e4bf14c1f44f256"} build_url:https://queue.taskcluster.net/v1/task/A68zA02IS_6mslMwrRAzcg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011204 build_url: 'https://queue.taskcluster.net/v1/task/A68zA02IS_6mslMwrRAzcg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb845727043a8584dabf86a10ea7f8f965d87851e5d5dc4af547a6bdda1e973c63b183402e7c766b5284758f72cadff8f789216ea51bd4b8f70ee10565286555", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5012136ded9dc70624e4d6e1d08a9abc8f1e987826feb25e3bd8f7afca89d717fcb3854806a261d3659f63c78b1281c7ce49231e08208bffafbafda0f95a687", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58374b13cc5e421d8d2c997314a6999cbffd4f954cf8877dde0497536528605e05b2a32df45356a8a606bd0b590ffdd2123e4f806cb6ad739e4bf14c1f44f256"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-03 00:07:16.765296) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 00:07:16.768655) ========= 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.Tc9woTBpSs/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.9ZIc7w3uEY/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.005171 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 00:07:16.817407) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-03 00:07:16.817732) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-03 00:07:16.818070) ========= ========= Total master_lag: 3.36 =========