builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0277 starttime: 1481765127.7 results: success (0) buildid: 20161214160703 builduid: 292354d9e139468380726b26ea57d292 revision: b1ab720c6d3e412ede797b08dfe63dca170f6ee0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-14 17:25:27.700458) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-14 17:25:27.701128) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-14 17:25:27.701581) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-14 17:25:27.728542) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 17:25:27.729230) ========= 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.4HnDupuN8s/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.JngHKYhDqG/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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-14 17:25:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 67.9M=0s 2016-12-14 17:25:27 (67.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.139712 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 17:25:27.898200) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 17:25:27.898746) ========= 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.4HnDupuN8s/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.JngHKYhDqG/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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.018893 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 17:25:27.950066) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-14 17:25:27.950916) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b1ab720c6d3e412ede797b08dfe63dca170f6ee0 --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 b1ab720c6d3e412ede797b08dfe63dca170f6ee0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4HnDupuN8s/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.JngHKYhDqG/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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-14 17:25:28,044 truncating revision to first 12 chars 2016-12-14 17:25:28,044 Setting DEBUG logging. 2016-12-14 17:25:28,044 attempt 1/10 2016-12-14 17:25:28,044 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b1ab720c6d3e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-14 17:25:29,277 unpacking tar archive at: mozilla-central-b1ab720c6d3e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.497496 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-14 17:25:29.478725) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-14 17:25:29.479574) ========= script_repo_revision: b1ab720c6d3e412ede797b08dfe63dca170f6ee0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-14 17:25:29.480563) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-14 17:25:29.481328) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-14 17:25:29.504397) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-12-14 17:25:29.505082) ========= /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.4HnDupuN8s/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.JngHKYhDqG/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 17:25:29 INFO - MultiFileLogger online at 20161214 17:25:29 in /builds/slave/test 17:25:29 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 17:25:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:25:29 INFO - {'append_to_log': False, 17:25:29 INFO - 'base_work_dir': '/builds/slave/test', 17:25:29 INFO - 'blob_upload_branch': 'Firefox', 17:25:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:25:29 INFO - 'branch': 'Firefox', 17:25:29 INFO - 'buildbot_json_path': 'buildprops.json', 17:25:29 INFO - 'config_files': ('talos/mac_config.py',), 17:25:29 INFO - 'default_actions': ('clobber', 17:25:29 INFO - 'read-buildbot-config', 17:25:29 INFO - 'download-and-extract', 17:25:29 INFO - 'populate-webroot', 17:25:29 INFO - 'create-virtualenv', 17:25:29 INFO - 'install', 17:25:29 INFO - 'run-tests'), 17:25:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:25:29 INFO - 'download_minidump_stackwalk': True, 17:25:29 INFO - 'download_symbols': 'ondemand', 17:25:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:25:29 INFO - 'tooltool.py': '/tools/tooltool.py', 17:25:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:25:29 INFO - '/tools/misc-python/virtualenv.py')}, 17:25:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:25:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:25:29 INFO - 'installer_path': 'installer.exe', 17:25:29 INFO - 'log_level': 'info', 17:25:29 INFO - 'log_name': 'talos', 17:25:29 INFO - 'log_to_console': True, 17:25:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:25:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:25:29 INFO - 'opt_config_files': (), 17:25:29 INFO - 'pip_index': False, 17:25:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:25:29 INFO - 'cmd': ('bash', 17:25:29 INFO - '-c', 17:25:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:25:29 INFO - 'enabled': True, 17:25:29 INFO - 'halt_on_failure': False, 17:25:29 INFO - 'name': 'check_screen_resolution'},), 17:25:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:25:29 INFO - 'cmd': ('bash', 17:25:29 INFO - '-c', 17:25:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:25:29 INFO - 'enabled': True, 17:25:29 INFO - 'halt_on_failure': False, 17:25:29 INFO - 'name': 'check_screen_resolution'},), 17:25:29 INFO - 'run_cmd_checks_enabled': True, 17:25:29 INFO - 'sps_profile': False, 17:25:29 INFO - 'sps_profile_interval': 0, 17:25:29 INFO - 'suite': 'dromaeojs', 17:25:29 INFO - 'system_bits': '32', 17:25:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:25:29 INFO - 'title': 't-yosemite-r7-0277', 17:25:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:25:29 INFO - 'use_talos_json': True, 17:25:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:25:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:25:29 INFO - 'work_dir': 'build'} 17:25:29 INFO - [mozharness: 2016-12-15 01:25:29.716082Z] Running clobber step. 17:25:29 INFO - Running pre-action listener: _resource_record_pre_action 17:25:29 INFO - Running main action method: clobber 17:25:29 INFO - rmtree: /builds/slave/test/build 17:25:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:25:30 INFO - Running post-action listener: _resource_record_post_action 17:25:30 INFO - [mozharness: 2016-12-15 01:25:30.604909Z] Finished clobber step (success) 17:25:30 INFO - [mozharness: 2016-12-15 01:25:30.605126Z] Running read-buildbot-config step. 17:25:30 INFO - Running pre-action listener: _resource_record_pre_action 17:25:30 INFO - Running main action method: read_buildbot_config 17:25:30 INFO - Using buildbot properties: 17:25:30 INFO - { 17:25:30 INFO - "project": "", 17:25:30 INFO - "product": "firefox", 17:25:30 INFO - "script_repo_revision": "production", 17:25:30 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 17:25:30 INFO - "repository": "", 17:25:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 17:25:30 INFO - "buildid": "20161214160703", 17:25:30 INFO - "pgo_build": "False", 17:25:30 INFO - "basedir": "/builds/slave/test", 17:25:30 INFO - "buildnumber": 53, 17:25:30 INFO - "slavename": "t-yosemite-r7-0277", 17:25:30 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 17:25:30 INFO - "platform": "yosemite_r7", 17:25:30 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:25:30 INFO - "branch": "mozilla-central", 17:25:30 INFO - "repo_path": "mozilla-central", 17:25:30 INFO - "revision": "b1ab720c6d3e412ede797b08dfe63dca170f6ee0", 17:25:30 INFO - "stage_platform": "macosx64", 17:25:30 INFO - "builduid": "292354d9e139468380726b26ea57d292", 17:25:30 INFO - "slavebuilddir": "test" 17:25:30 INFO - } 17:25:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/OpBXSswwQ12yWaJ4jiDqOg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 17:25:30 INFO - Running post-action listener: _resource_record_post_action 17:25:30 INFO - [mozharness: 2016-12-15 01:25:30.608327Z] Finished read-buildbot-config step (success) 17:25:30 INFO - [mozharness: 2016-12-15 01:25:30.608431Z] Running download-and-extract step. 17:25:30 INFO - Running pre-action listener: _resource_record_pre_action 17:25:30 INFO - Running main action method: download_and_extract 17:25:30 INFO - mkdir: /builds/slave/test/build/tests 17:25:30 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')]} 17:25:30 INFO - trying https://queue.taskcluster.net/v1/task/OpBXSswwQ12yWaJ4jiDqOg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 17:25:30 INFO - Downloading https://queue.taskcluster.net/v1/task/OpBXSswwQ12yWaJ4jiDqOg/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 17:25:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OpBXSswwQ12yWaJ4jiDqOg/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 17:25:31 INFO - Downloaded 1199 bytes. 17:25:31 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 17:25:31 INFO - Using the following test package requirements: 17:25:31 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 17:25:31 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 17:25:31 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 17:25:31 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 17:25:31 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 17:25:31 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 17:25:31 INFO - u'jsshell-mac.zip'], 17:25:31 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 17:25:31 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 17:25:31 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 17:25:31 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 17:25:31 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 17:25:31 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 17:25:31 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 17:25:31 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 17:25:31 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 17:25:31 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 17:25:31 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 17:25:31 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:25:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OpBXSswwQ12yWaJ4jiDqOg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 17:25:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OpBXSswwQ12yWaJ4jiDqOg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:25:31 INFO - Fetch https://queue.taskcluster.net/v1/task/OpBXSswwQ12yWaJ4jiDqOg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 17:25:32 INFO - Expected file size: 16276245 17:25:32 INFO - Obtained file size: 16276245 17:25:38 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 17:25:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OpBXSswwQ12yWaJ4jiDqOg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 17:25:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OpBXSswwQ12yWaJ4jiDqOg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:25:38 INFO - Fetch https://queue.taskcluster.net/v1/task/OpBXSswwQ12yWaJ4jiDqOg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 17:25:39 INFO - Expected file size: 16276245 17:25:39 INFO - Obtained file size: 16276245 17:25:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OpBXSswwQ12yWaJ4jiDqOg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 17:25:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OpBXSswwQ12yWaJ4jiDqOg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:25:46 INFO - Fetch https://queue.taskcluster.net/v1/task/OpBXSswwQ12yWaJ4jiDqOg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 17:25:47 INFO - Expected file size: 14409734 17:25:47 INFO - Obtained file size: 14409734 17:25:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:25:47 INFO - trying https://queue.taskcluster.net/v1/task/OpBXSswwQ12yWaJ4jiDqOg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 17:25:47 INFO - Downloading https://queue.taskcluster.net/v1/task/OpBXSswwQ12yWaJ4jiDqOg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 17:25:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OpBXSswwQ12yWaJ4jiDqOg/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 17:25:49 INFO - Downloaded 69667724 bytes. 17:25:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OpBXSswwQ12yWaJ4jiDqOg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 17:25:49 INFO - mkdir: /builds/slave/test/properties 17:25:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:25:49 INFO - Writing to file /builds/slave/test/properties/build_url 17:25:49 INFO - Contents: 17:25:49 INFO - build_url:https://queue.taskcluster.net/v1/task/OpBXSswwQ12yWaJ4jiDqOg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 17:25:50 INFO - Running post-action listener: _resource_record_post_action 17:25:50 INFO - Running post-action listener: set_extra_try_arguments 17:25:50 INFO - [mozharness: 2016-12-15 01:25:50.198661Z] Finished download-and-extract step (success) 17:25:50 INFO - [mozharness: 2016-12-15 01:25:50.198781Z] Running populate-webroot step. 17:25:50 INFO - Running pre-action listener: _resource_record_pre_action 17:25:50 INFO - Running main action method: populate_webroot 17:25:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:25:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:25:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:25:50 INFO - '--tppagecycles', 17:25:50 INFO - '7'], 17:25:50 INFO - 'tests': ['tsvgm']}}, 17:25:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:25:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:25:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:25:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:25:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:25:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:25:50 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:25:50 INFO - 'talos_options': ['--disable-e10s'], 17:25:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:25:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:25:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:25:50 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:25:50 INFO - 'talos_options': ['--disable-e10s'], 17:25:50 INFO - 'tests': ['damp', 'tps']}, 17:25:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:25:50 INFO - 'tests': ['damp', 'tps']}, 17:25:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:25:50 INFO - 'tests': ['dromaeo_dom']}, 17:25:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:25:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:25:50 INFO - 'tests': ['basic_compositor_video']}, 17:25:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:25:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:25:50 INFO - 'tests': ['a11yr', 17:25:50 INFO - 'ts_paint', 17:25:50 INFO - 'tpaint', 17:25:50 INFO - 'sessionrestore', 17:25:50 INFO - 'sessionrestore_no_auto_restore', 17:25:50 INFO - 'tabpaint']}, 17:25:50 INFO - 'other-e10s': {'tests': ['a11yr', 17:25:50 INFO - 'ts_paint', 17:25:50 INFO - 'tpaint', 17:25:50 INFO - 'sessionrestore', 17:25:50 INFO - 'sessionrestore_no_auto_restore', 17:25:50 INFO - 'tabpaint']}, 17:25:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:25:50 INFO - 'ts_paint', 17:25:50 INFO - 'tpaint', 17:25:50 INFO - 'sessionrestore', 17:25:50 INFO - 'sessionrestore_no_auto_restore', 17:25:50 INFO - 'tabpaint']}, 17:25:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:25:50 INFO - 'ts_paint', 17:25:50 INFO - 'tpaint', 17:25:50 INFO - 'sessionrestore', 17:25:50 INFO - 'sessionrestore_no_auto_restore', 17:25:50 INFO - 'tabpaint']}, 17:25:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:25:50 INFO - 'tests': ['a11yr', 17:25:50 INFO - 'ts_paint', 17:25:50 INFO - 'tpaint', 17:25:50 INFO - 'sessionrestore', 17:25:50 INFO - 'sessionrestore_no_auto_restore', 17:25:50 INFO - 'tabpaint']}, 17:25:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:25:50 INFO - 'tests': ['a11yr', 17:25:50 INFO - 'ts_paint', 17:25:50 INFO - 'tpaint', 17:25:50 INFO - 'sessionrestore', 17:25:50 INFO - 'sessionrestore_no_auto_restore', 17:25:50 INFO - 'tabpaint']}, 17:25:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:25:50 INFO - 'tests': ['tsvgx', 17:25:50 INFO - 'tsvgr_opacity', 17:25:50 INFO - 'tart', 17:25:50 INFO - 'tscrollx', 17:25:50 INFO - 'cart', 17:25:50 INFO - 'tsvg_static']}, 17:25:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:25:50 INFO - 'tsvgr_opacity', 17:25:50 INFO - 'tart', 17:25:50 INFO - 'tscrollx', 17:25:50 INFO - 'cart', 17:25:50 INFO - 'tsvg_static']}, 17:25:50 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:25:50 INFO - 'talos_options': ['--disable-e10s'], 17:25:50 INFO - 'tests': ['tp5o']}, 17:25:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:25:50 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:25:50 INFO - 'talos_options': ['--disable-e10s', 17:25:50 INFO - '--xperf_path', 17:25:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:25:50 INFO - 'tests': ['tp5n']}, 17:25:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:25:50 INFO - 'talos_options': ['--xperf_path', 17:25:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:25:50 INFO - 'tests': ['tp5n']}}, 17:25:50 INFO - 'talos.zip': {'path': '', 17:25:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:25:50 INFO - Running post-action listener: _resource_record_post_action 17:25:50 INFO - [mozharness: 2016-12-15 01:25:50.217193Z] Finished populate-webroot step (success) 17:25:50 INFO - [mozharness: 2016-12-15 01:25:50.217315Z] Running create-virtualenv step. 17:25:50 INFO - Running pre-action listener: _resource_record_pre_action 17:25:50 INFO - Running main action method: create_virtualenv 17:25:50 INFO - Creating virtualenv /builds/slave/test/build/venv 17:25:50 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 17:25:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:25:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:25:50 INFO - Using real prefix '/tools/python27' 17:25:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:25:51 INFO - Installing distribute.............................................................................................................................................................................................done. 17:25:53 INFO - Installing pip.................done. 17:25:53 INFO - Return code: 0 17:25:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:25:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:25:54 INFO - Reading from file tmpfile_stdout 17:25:54 INFO - Output received: 17:25:54 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) 17:25:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:25: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')]} 17:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25: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')]} 17:25:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10813a3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080b0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9db1466500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f4fd30>, '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 0x107db6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f47b20>, '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.4HnDupuN8s/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.JngHKYhDqG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 17:25: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', 'pip>=1.5'] in /builds/slave/test/build 17:25: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 pip>=1.5 17:25:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4HnDupuN8s/Render', 17:25:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:25:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:25:54 INFO - 'HOME': '/Users/cltbld', 17:25:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:25:54 INFO - 'LOGNAME': 'cltbld', 17:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:54 INFO - 'MOZ_NO_REMOTE': '1', 17:25:54 INFO - 'NO_EM_RESTART': '1', 17:25:54 INFO - 'PAGER': '/bin/cat', 17:25:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:54 INFO - 'PWD': '/builds/slave/test', 17:25:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:25:54 INFO - 'SHELL': '/bin/bash', 17:25:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JngHKYhDqG/Listeners', 17:25:54 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 17:25:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:25:54 INFO - 'USER': 'cltbld', 17:25:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:25:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:54 INFO - 'XPC_FLAGS': '0x0', 17:25:54 INFO - 'XPC_SERVICE_NAME': '0', 17:25:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:54 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 17:25:54 INFO - Cleaning up... 17:25:54 INFO - Return code: 0 17:25:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:25: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')]} 17:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25: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')]} 17:25:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25: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', '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 0x10813a3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080b0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9db1466500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f4fd30>, '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 0x107db6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f47b20>, '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.4HnDupuN8s/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.JngHKYhDqG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 17:25: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', 'psutil>=3.1.1'] in /builds/slave/test/build 17:25: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 psutil>=3.1.1 17:25:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4HnDupuN8s/Render', 17:25:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:25:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:25:54 INFO - 'HOME': '/Users/cltbld', 17:25:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:25:54 INFO - 'LOGNAME': 'cltbld', 17:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:54 INFO - 'MOZ_NO_REMOTE': '1', 17:25:54 INFO - 'NO_EM_RESTART': '1', 17:25:54 INFO - 'PAGER': '/bin/cat', 17:25:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:54 INFO - 'PWD': '/builds/slave/test', 17:25:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:25:54 INFO - 'SHELL': '/bin/bash', 17:25:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JngHKYhDqG/Listeners', 17:25:54 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 17:25:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:25:54 INFO - 'USER': 'cltbld', 17:25:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:25:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:54 INFO - 'XPC_FLAGS': '0x0', 17:25:54 INFO - 'XPC_SERVICE_NAME': '0', 17:25:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:54 INFO - Downloading/unpacking psutil>=3.1.1 17:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:25:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:25:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:25:58 INFO - Installing collected packages: psutil 17:25:58 INFO - Running setup.py install for psutil 17:25:58 INFO - building 'psutil._psutil_osx' extension 17:25:58 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 17:25:58 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 17:25:58 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 17:25:58 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 17:25:58 INFO - building 'psutil._psutil_posix' extension 17:25:58 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 17:25:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:25:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:25:58 INFO - ^ 17:25:58 INFO - 1 warning generated. 17:25:58 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 17:25:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:25:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:25:59 INFO - Successfully installed psutil 17:25:59 INFO - Cleaning up... 17:25:59 INFO - Return code: 0 17:25:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:25:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10813a3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080b0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9db1466500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f4fd30>, '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 0x107db6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f47b20>, '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.4HnDupuN8s/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.JngHKYhDqG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 17:25:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:25:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:25:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4HnDupuN8s/Render', 17:25:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:25:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:25:59 INFO - 'HOME': '/Users/cltbld', 17:25:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:25:59 INFO - 'LOGNAME': 'cltbld', 17:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:59 INFO - 'MOZ_NO_REMOTE': '1', 17:25:59 INFO - 'NO_EM_RESTART': '1', 17:25:59 INFO - 'PAGER': '/bin/cat', 17:25:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:59 INFO - 'PWD': '/builds/slave/test', 17:25:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:25:59 INFO - 'SHELL': '/bin/bash', 17:25:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JngHKYhDqG/Listeners', 17:25:59 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 17:25:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:25:59 INFO - 'USER': 'cltbld', 17:25:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:25:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:59 INFO - 'XPC_FLAGS': '0x0', 17:25:59 INFO - 'XPC_SERVICE_NAME': '0', 17:25:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:26:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:26:01 INFO - Installing collected packages: mozsystemmonitor 17:26:01 INFO - Running setup.py install for mozsystemmonitor 17:26:02 INFO - Successfully installed mozsystemmonitor 17:26:02 INFO - Cleaning up... 17:26:02 INFO - Return code: 0 17:26:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:26:02 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')]} 17:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:02 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')]} 17:26:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:02 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 0x10813a3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080b0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9db1466500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f4fd30>, '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 0x107db6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f47b20>, '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.4HnDupuN8s/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.JngHKYhDqG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 17:26:02 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 17:26:02 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 17:26:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4HnDupuN8s/Render', 17:26:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:26:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:26:02 INFO - 'HOME': '/Users/cltbld', 17:26:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:26:02 INFO - 'LOGNAME': 'cltbld', 17:26:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:02 INFO - 'MOZ_NO_REMOTE': '1', 17:26:02 INFO - 'NO_EM_RESTART': '1', 17:26:02 INFO - 'PAGER': '/bin/cat', 17:26:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:26:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:02 INFO - 'PWD': '/builds/slave/test', 17:26:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:26:02 INFO - 'SHELL': '/bin/bash', 17:26:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JngHKYhDqG/Listeners', 17:26:02 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 17:26:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:26:02 INFO - 'USER': 'cltbld', 17:26:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:26:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:26:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:02 INFO - 'XPC_FLAGS': '0x0', 17:26:02 INFO - 'XPC_SERVICE_NAME': '0', 17:26:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:26:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:02 INFO - Downloading/unpacking jsonschema==2.5.1 17:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:26:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:26:05 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 17:26:05 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 17:26:05 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 17:26:05 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 17:26:05 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 17:26:05 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 17:26:05 INFO - Downloading functools32-3.2.3-2.tar.gz 17:26:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:26:05 INFO - warning: no files found matching '*.txt' 17:26:05 INFO - no previously-included directories found matching 'build' 17:26:05 INFO - no previously-included directories found matching 'dist' 17:26:05 INFO - no previously-included directories found matching '.git*' 17:26:05 INFO - Installing collected packages: jsonschema, functools32 17:26:05 INFO - Running setup.py install for functools32 17:26:05 INFO - warning: no files found matching '*.txt' 17:26:05 INFO - no previously-included directories found matching 'build' 17:26:05 INFO - no previously-included directories found matching 'dist' 17:26:05 INFO - no previously-included directories found matching '.git*' 17:26:05 INFO - Successfully installed jsonschema functools32 17:26:05 INFO - Cleaning up... 17:26:05 INFO - Return code: 0 17:26:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:26:05 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')]} 17:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:05 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')]} 17:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:05 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 0x10813a3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080b0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9db1466500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f4fd30>, '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 0x107db6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f47b20>, '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.4HnDupuN8s/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.JngHKYhDqG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 17:26:05 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 17:26:05 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 17:26:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4HnDupuN8s/Render', 17:26:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:26:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:26:05 INFO - 'HOME': '/Users/cltbld', 17:26:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:26:05 INFO - 'LOGNAME': 'cltbld', 17:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:05 INFO - 'MOZ_NO_REMOTE': '1', 17:26:05 INFO - 'NO_EM_RESTART': '1', 17:26:05 INFO - 'PAGER': '/bin/cat', 17:26:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:05 INFO - 'PWD': '/builds/slave/test', 17:26:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:26:05 INFO - 'SHELL': '/bin/bash', 17:26:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JngHKYhDqG/Listeners', 17:26:05 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 17:26:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:26:05 INFO - 'USER': 'cltbld', 17:26:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:26:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:05 INFO - 'XPC_FLAGS': '0x0', 17:26:05 INFO - 'XPC_SERVICE_NAME': '0', 17:26:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:26:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:26:06 INFO - Cleaning up... 17:26:06 INFO - Return code: 0 17:26:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:26:06 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')]} 17:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:06 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')]} 17:26:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:06 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 0x10813a3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080b0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9db1466500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f4fd30>, '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 0x107db6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f47b20>, '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.4HnDupuN8s/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.JngHKYhDqG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 17:26:06 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 17:26:06 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 17:26:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4HnDupuN8s/Render', 17:26:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:26:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:26:06 INFO - 'HOME': '/Users/cltbld', 17:26:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:26:06 INFO - 'LOGNAME': 'cltbld', 17:26:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:06 INFO - 'MOZ_NO_REMOTE': '1', 17:26:06 INFO - 'NO_EM_RESTART': '1', 17:26:06 INFO - 'PAGER': '/bin/cat', 17:26:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:26:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:06 INFO - 'PWD': '/builds/slave/test', 17:26:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:26:06 INFO - 'SHELL': '/bin/bash', 17:26:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JngHKYhDqG/Listeners', 17:26:06 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 17:26:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:26:06 INFO - 'USER': 'cltbld', 17:26:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:26:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:26:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:06 INFO - 'XPC_FLAGS': '0x0', 17:26:06 INFO - 'XPC_SERVICE_NAME': '0', 17:26:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:26:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:06 INFO - Downloading/unpacking blobuploader==1.2.4 17:26:06 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 17:26:06 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 17:26:06 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 17:26:06 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 17:26:06 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 17:26:06 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 17:26:08 INFO - Downloading blobuploader-1.2.4.tar.gz 17:26:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:26:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:26:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:10 INFO - Downloading docopt-0.6.1.tar.gz 17:26:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:26:10 INFO - Installing collected packages: blobuploader, requests, docopt 17:26:10 INFO - Running setup.py install for blobuploader 17:26:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:26:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:26:10 INFO - Running setup.py install for requests 17:26:10 INFO - Running setup.py install for docopt 17:26:10 INFO - Successfully installed blobuploader requests docopt 17:26:10 INFO - Cleaning up... 17:26:11 INFO - Return code: 0 17:26:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:26:11 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')]} 17:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:11 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')]} 17:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:11 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 0x10813a3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080b0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9db1466500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f4fd30>, '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 0x107db6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f47b20>, '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.4HnDupuN8s/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.JngHKYhDqG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 17:26:11 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 17:26:11 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 17:26:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4HnDupuN8s/Render', 17:26:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:26:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:26:11 INFO - 'HOME': '/Users/cltbld', 17:26:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:26:11 INFO - 'LOGNAME': 'cltbld', 17:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:11 INFO - 'MOZ_NO_REMOTE': '1', 17:26:11 INFO - 'NO_EM_RESTART': '1', 17:26:11 INFO - 'PAGER': '/bin/cat', 17:26:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:11 INFO - 'PWD': '/builds/slave/test', 17:26:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:26:11 INFO - 'SHELL': '/bin/bash', 17:26:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JngHKYhDqG/Listeners', 17:26:11 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 17:26:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:26:11 INFO - 'USER': 'cltbld', 17:26:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:26:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:11 INFO - 'XPC_FLAGS': '0x0', 17:26:11 INFO - 'XPC_SERVICE_NAME': '0', 17:26:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:26:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:26:11 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-gJuFLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:26:11 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-FemqUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:26:11 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-8bxc5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:26:11 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-48DyVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:26:11 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-qQovc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:26:11 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-ZzEH0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:26:11 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-o5tfNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:26:12 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-n3gF7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:26:12 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-JBuCoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:26:12 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-8Nx0r4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:26:12 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-5ub66Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:26:12 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-smK91D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:26:12 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-2QPmDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:26:12 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-zTojQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:26:12 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-jKl8gS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:26:12 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-qvhuGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:26:12 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-ST7ihw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:26:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:26:13 INFO - Running setup.py install for manifestparser 17:26:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:26:13 INFO - Running setup.py install for mozcrash 17:26:13 INFO - Running setup.py install for mozdebug 17:26:13 INFO - Running setup.py install for mozdevice 17:26:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:26:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:26:13 INFO - Running setup.py install for mozfile 17:26:13 INFO - Running setup.py install for mozhttpd 17:26:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:26:13 INFO - Running setup.py install for mozinfo 17:26:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:26:14 INFO - Running setup.py install for mozInstall 17:26:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:26:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:26:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:26:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:26:14 INFO - Running setup.py install for mozleak 17:26:14 INFO - Running setup.py install for mozlog 17:26:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:26:14 INFO - Running setup.py install for moznetwork 17:26:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:26:14 INFO - Running setup.py install for mozprocess 17:26:14 INFO - Running setup.py install for mozprofile 17:26:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:26:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:26:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:26:15 INFO - Running setup.py install for mozrunner 17:26:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:26:15 INFO - Running setup.py install for mozscreenshot 17:26:15 INFO - Running setup.py install for moztest 17:26:15 INFO - Running setup.py install for mozversion 17:26:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:26:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:26:15 INFO - Cleaning up... 17:26:15 INFO - Return code: 0 17:26:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:26:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:15 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 0x10813a3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080b0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9db1466500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f4fd30>, '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 0x107db6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f47b20>, '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.4HnDupuN8s/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.JngHKYhDqG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 17:26:15 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 17:26:15 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 17:26:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4HnDupuN8s/Render', 17:26:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:26:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:26:15 INFO - 'HOME': '/Users/cltbld', 17:26:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:26:15 INFO - 'LOGNAME': 'cltbld', 17:26:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:15 INFO - 'MOZ_NO_REMOTE': '1', 17:26:15 INFO - 'NO_EM_RESTART': '1', 17:26:15 INFO - 'PAGER': '/bin/cat', 17:26:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:26:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:15 INFO - 'PWD': '/builds/slave/test', 17:26:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:26:15 INFO - 'SHELL': '/bin/bash', 17:26:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JngHKYhDqG/Listeners', 17:26:15 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 17:26:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:26:15 INFO - 'USER': 'cltbld', 17:26:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:26:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:26:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:15 INFO - 'XPC_FLAGS': '0x0', 17:26:15 INFO - 'XPC_SERVICE_NAME': '0', 17:26:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:26:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:26:15 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-Rr0Qdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:26:16 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)) 17:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:26:16 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-BGE9Me-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:26:16 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)) 17:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:26:16 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-NZIkAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:26:16 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)) 17:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:26:16 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-P_W9sY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:26:16 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)) 17:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:26:16 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-SogA3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:26:16 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)) 17:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:26:16 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-qgUU9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:26:16 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)) 17:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:26:16 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-WtnzRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:26:16 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)) 17:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:26:16 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-h1no9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:26:16 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)) 17:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:26:16 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-84Z_Vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:26:16 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)) 17:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:26:16 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-sUWsuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:26:16 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)) 17:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:26:16 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-8WqvYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:26:17 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)) 17:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:26:17 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-oqj645-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:26:17 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)) 17:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:26:17 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-YpPbKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:26:17 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)) 17:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:26:17 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-Qd4t0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:26:17 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)) 17:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:26:17 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-_06Cme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:26:17 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)) 17:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:26:17 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-BX5sHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:26:17 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)) 17:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:26:17 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-X79oFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:26:17 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)) 17:26:17 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)) 17:26:17 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)) 17:26:17 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)) 17:26:17 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)) 17:26:17 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)) 17:26:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:26:17 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 17:26:17 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 17:26:17 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 17:26:17 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 17:26:17 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 17:26:17 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 17:26:20 INFO - Downloading blessings-1.6.tar.gz 17:26:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:26:20 INFO - Installing collected packages: blessings 17:26:20 INFO - Running setup.py install for blessings 17:26:20 INFO - Successfully installed blessings 17:26:20 INFO - Cleaning up... 17:26:20 INFO - Return code: 0 17:26:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:26:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:26:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:26:20 INFO - Reading from file tmpfile_stdout 17:26:20 INFO - Current package versions: 17:26:20 INFO - blessings == 1.6 17:26:20 INFO - blobuploader == 1.2.4 17:26:20 INFO - docopt == 0.6.1 17:26:20 INFO - functools32 == 3.2.3-2 17:26:20 INFO - jsonschema == 2.5.1 17:26:20 INFO - manifestparser == 1.1 17:26:20 INFO - mozInstall == 1.12 17:26:20 INFO - mozcrash == 1.0 17:26:20 INFO - mozdebug == 0.1 17:26:20 INFO - mozdevice == 0.49 17:26:20 INFO - mozfile == 1.2 17:26:20 INFO - mozhttpd == 0.7 17:26:20 INFO - mozinfo == 0.9 17:26:20 INFO - mozleak == 0.1 17:26:20 INFO - mozlog == 3.4 17:26:20 INFO - moznetwork == 0.27 17:26:20 INFO - mozprocess == 0.23 17:26:20 INFO - mozprofile == 0.28 17:26:20 INFO - mozrunner == 6.13 17:26:20 INFO - mozscreenshot == 0.1 17:26:20 INFO - mozsystemmonitor == 0.3 17:26:20 INFO - moztest == 0.7 17:26:20 INFO - mozversion == 1.4 17:26:20 INFO - psutil == 3.1.1 17:26:20 INFO - requests == 1.2.3 17:26:20 INFO - wsgiref == 0.1.2 17:26:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:26:20 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')]} 17:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:20 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')]} 17:26:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:20 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 0x10813a3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080b0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9db1466500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f4fd30>, '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 0x107db6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f47b20>, '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.4HnDupuN8s/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.JngHKYhDqG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 17:26:20 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 17:26:20 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 17:26:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4HnDupuN8s/Render', 17:26:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:26:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:26:20 INFO - 'HOME': '/Users/cltbld', 17:26:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:26:20 INFO - 'LOGNAME': 'cltbld', 17:26:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:20 INFO - 'MOZ_NO_REMOTE': '1', 17:26:20 INFO - 'NO_EM_RESTART': '1', 17:26:20 INFO - 'PAGER': '/bin/cat', 17:26:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:26:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:20 INFO - 'PWD': '/builds/slave/test', 17:26:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:26:20 INFO - 'SHELL': '/bin/bash', 17:26:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JngHKYhDqG/Listeners', 17:26:20 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 17:26:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:26:20 INFO - 'USER': 'cltbld', 17:26:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:26:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:26:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:20 INFO - 'XPC_FLAGS': '0x0', 17:26:20 INFO - 'XPC_SERVICE_NAME': '0', 17:26:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:26:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:21 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)) 17:26:21 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)) 17:26:21 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)) 17:26:21 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)) 17:26:21 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)) 17:26:21 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)) 17:26:21 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)) 17:26:21 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)) 17:26:21 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)) 17:26:21 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)) 17:26:21 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)) 17:26:21 INFO - Cleaning up... 17:26:21 INFO - Return code: 0 17:26:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:26:21 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')]} 17:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:21 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')]} 17:26:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:21 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 0x10813a3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080b0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9db1466500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f4fd30>, '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 0x107db6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f47b20>, '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.4HnDupuN8s/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.JngHKYhDqG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 17:26:21 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 17:26:21 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 17:26:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4HnDupuN8s/Render', 17:26:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:26:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:26:21 INFO - 'HOME': '/Users/cltbld', 17:26:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:26:21 INFO - 'LOGNAME': 'cltbld', 17:26:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:21 INFO - 'MOZ_NO_REMOTE': '1', 17:26:21 INFO - 'NO_EM_RESTART': '1', 17:26:21 INFO - 'PAGER': '/bin/cat', 17:26:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:26:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:21 INFO - 'PWD': '/builds/slave/test', 17:26:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:26:21 INFO - 'SHELL': '/bin/bash', 17:26:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JngHKYhDqG/Listeners', 17:26:21 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 17:26:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:26:21 INFO - 'USER': 'cltbld', 17:26:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:26:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:26:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:21 INFO - 'XPC_FLAGS': '0x0', 17:26:21 INFO - 'XPC_SERVICE_NAME': '0', 17:26:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:26:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:26:21 INFO - Cleaning up... 17:26:21 INFO - Return code: 0 17:26:21 INFO - Running post-action listener: _resource_record_post_action 17:26:21 INFO - Running post-action listener: _start_resource_monitoring 17:26:21 INFO - Starting resource monitoring. 17:26:21 INFO - [mozharness: 2016-12-15 01:26:21.542630Z] Finished create-virtualenv step (success) 17:26:21 INFO - [mozharness: 2016-12-15 01:26:21.543616Z] Running install step. 17:26:21 INFO - Running pre-action listener: _resource_record_pre_action 17:26:21 INFO - Running main action method: install 17:26:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:26:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:26:21 INFO - Reading from file tmpfile_stdout 17:26:21 INFO - Detecting whether we're running mozinstall >=1.0... 17:26:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:26:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:26:21 INFO - Reading from file tmpfile_stdout 17:26:21 INFO - Output received: 17:26:21 INFO - Usage: mozinstall [options] installer 17:26:21 INFO - Options: 17:26:21 INFO - -h, --help show this help message and exit 17:26:21 INFO - -d DEST, --destination=DEST 17:26:21 INFO - Directory to install application into. [default: 17:26:21 INFO - "/builds/slave/test"] 17:26:21 INFO - --app=APP Application being installed. [default: firefox] 17:26:21 INFO - mkdir: /builds/slave/test/build/application 17:26:21 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'] 17:26:21 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 17:26:43 INFO - Reading from file tmpfile_stdout 17:26:43 INFO - Output received: 17:26:43 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:26:43 INFO - Running post-action listener: _resource_record_post_action 17:26:43 INFO - [mozharness: 2016-12-15 01:26:43.591144Z] Finished install step (success) 17:26:43 INFO - [mozharness: 2016-12-15 01:26:43.591276Z] Running run-tests step. 17:26:43 INFO - Running pre-action listener: _resource_record_pre_action 17:26:43 INFO - Running main action method: run_tests 17:26:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:26:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:26:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:26:43 INFO - 2016-12-14 17:26:43.605 screenresolution[1938:13273] starting screenresolution argv=screenresolution get 17:26:43 INFO - 2016-12-14 17:26:43.608 screenresolution[1938:13273] Display 0: 1600x1200x32@60 17:26:43 INFO - 2016-12-14 17:26:43.614 screenresolution[1939:13275] starting screenresolution argv=screenresolution list 17:26:43 INFO - Available Modes on Display 0 17:26:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:26:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:26:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:26:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:26:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:26:43 INFO - Intel Iris: 17:26:43 INFO - Chipset Model: Intel Iris 17:26:43 INFO - Type: GPU 17:26:43 INFO - Bus: Built-In 17:26:43 INFO - VRAM (Dynamic, Max): 1536 MB 17:26:43 INFO - Vendor: Intel (0x8086) 17:26:43 INFO - Device ID: 0x0a2e 17:26:43 INFO - Revision ID: 0x0009 17:26:43 INFO - Displays: 17:26:43 INFO - Display: 17:26:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:26:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:26:43 INFO - Display Serial Number: 1600x1200 60 17:26:43 INFO - Main Display: Yes 17:26:43 INFO - Mirror: Off 17:26:43 INFO - Online: Yes 17:26:43 INFO - Rotation: Supported 17:26:43 INFO - Return code: 0 17:26:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:26:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:26:43 INFO - Python 2.7.3 17:26:43 INFO - Return code: 0 17:26:43 INFO - grabbing minidump binary from tooltool 17:26:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:43 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 0x107f4fd30>, '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 0x107db6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f47b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:26:43 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 17:26:43 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 17:26:43 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 17:26:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:26:43 INFO - Return code: 0 17:26:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:26:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:26:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:26:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:26:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:26:43 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/OpBXSswwQ12yWaJ4jiDqOg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0277', '--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 17:26:43 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/OpBXSswwQ12yWaJ4jiDqOg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0277 --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 17:26:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4HnDupuN8s/Render', 17:26:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:26:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:26:43 INFO - 'HOME': '/Users/cltbld', 17:26:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:26:43 INFO - 'LOGNAME': 'cltbld', 17:26:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:26:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:26:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:43 INFO - 'MOZ_NO_REMOTE': '1', 17:26:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:26:43 INFO - 'NO_EM_RESTART': '1', 17:26:43 INFO - 'PAGER': '/bin/cat', 17:26:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:26:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:43 INFO - 'PWD': '/builds/slave/test', 17:26:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:26:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:26:43 INFO - 'SHELL': '/bin/bash', 17:26:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JngHKYhDqG/Listeners', 17:26:43 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 17:26:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:26:43 INFO - 'USER': 'cltbld', 17:26:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:26:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:26:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:43 INFO - 'XPC_FLAGS': '0x0', 17:26:43 INFO - 'XPC_SERVICE_NAME': '0', 17:26:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:26:43 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/OpBXSswwQ12yWaJ4jiDqOg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0277', '--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 17:26:44 INFO - mozversion application_buildid: 20161214160703 17:26:44 INFO - mozversion application_changeset: b1ab720c6d3e412ede797b08dfe63dca170f6ee0 17:26:44 INFO - mozversion application_display_name: Nightly 17:26:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:26:44 INFO - mozversion application_name: Firefox 17:26:44 INFO - mozversion application_remotingname: firefox 17:26:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:26:44 INFO - mozversion application_vendor: Mozilla 17:26:44 INFO - mozversion application_version: 53.0a1 17:26:44 INFO - mozversion platform_buildid: 20161214160703 17:26:44 INFO - mozversion platform_changeset: b1ab720c6d3e412ede797b08dfe63dca170f6ee0 17:26:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:26:44 INFO - mozversion platform_version: 53.0a1 17:26:44 INFO - using testdate: 1481765204 17:26:44 INFO - actual date: 1481765204 17:26:44 INFO - starting webserver on 'localhost:49525' 17:26:44 INFO - SUITE-START | Running 2 tests 17:26:44 INFO - TEST-START | dromaeo_css 17:26:44 INFO - operating with platform_type : mac_ 17:26:44 INFO - Initialising browser for dromaeo_css test... 17:26:44 INFO - TEST-INFO | started process 1949 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmp6cx0k6/profile http://localhost:49525/getInfo.html) 17:26:46 INFO - PROCESS | 1949 | __metrics Screen width/height:1600/1200 17:26:46 INFO - PROCESS | 1949 | colorDepth:24 17:26:46 INFO - PROCESS | 1949 | Browser inner width/height: 1024/689 17:26:46 INFO - PROCESS | 1949 | __metrics 17:26:46 INFO - PROCESS | 1949 | 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" 17:26:46 INFO - PROCESS | 1949 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:26:47 INFO - TEST-INFO | 1949: exit 0 17:26:47 INFO - Browser initialized. 17:26:47 INFO - Running cycle 1/1 for dromaeo_css test... 17:26:47 INFO - TEST-INFO | started process 1951 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmp6cx0k6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:26:59 INFO - PROCESS | 1951 | RSS: Main: 238129152 17:26:59 INFO - PROCESS | 1951 | 17:27:50 INFO - PROCESS | 1951 | 1481765270794 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] 17:30:03 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49525/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49525/tests/dromaeo/cssquery-ext.html) 17:30:05 INFO - PROCESS | 1951 | RSS: Main: 403271680 17:30:05 INFO - PROCESS | 1951 | 17:33:08 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49525/tests/dromaeo/cssquery-ext.html (next: http://localhost:49525/tests/dromaeo/cssquery-jquery.html) 17:33:09 INFO - PROCESS | 1951 | RSS: Main: 373125120 17:33:09 INFO - PROCESS | 1951 | 17:36:11 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49525/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49525/tests/dromaeo/cssquery-mootools.html) 17:36:12 INFO - PROCESS | 1951 | RSS: Main: 352022528 17:36:12 INFO - PROCESS | 1951 | 17:39:14 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49525/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49525/tests/dromaeo/cssquery-prototype.html) 17:39:15 INFO - PROCESS | 1951 | RSS: Main: 342577152 17:39:15 INFO - PROCESS | 1951 | 17:42:18 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49525/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49525/tests/dromaeo/cssquery-yui.html) 17:42:19 INFO - PROCESS | 1951 | RSS: Main: 341037056 17:42:19 INFO - PROCESS | 1951 | 17:45:22 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49525/tests/dromaeo/cssquery-yui.html (next: http://localhost:49525/tests/dromaeo/cssquery-dojo.html) 17:45:23 INFO - PROCESS | 1951 | RSS: Main: 483299328 17:45:23 INFO - PROCESS | 1951 | 17:45:23 INFO - PROCESS | 1951 | __start_tp_report 17:45:23 INFO - PROCESS | 1951 | _x_x_mozilla_page_load 17:45:23 INFO - PROCESS | 1951 | _x_x_mozilla_page_load_details 17:45:23 INFO - PROCESS | 1951 | |i|pagename|runs| 17:45:23 INFO - PROCESS | 1951 | |0;dojo.html;3269.2807582331884;3284.8193349365774;3293.374258890811;3325.9689496256146;3332.5667663203794;5546.639468434549;5609.607327487072;5644.209810626506;5673.914891276634;5681.2614360133175;5613.242212301338;5618.971905140479;5711.114777209529;5720.399358067405;5723.856903577413;5065.290859279704;5095.439501654815;5120.487951204887;5144.485551444863;5165.560927321182;5239.816606418776;5250.973745131269;5253.8949221015555;5261.710605916673;5298.417174110845;5095.414027386861;5189.610779191576;5212.739363031833;5216.843494695166;5316.73416329184;5127.717975511346;5162.766531444217;5163.896722065575;5164.096283150434;5171.689698618095;5065.214891691794;5133.948660513422;5152.072626927152;5152.639315247934;5178.378594568639;5629.831105066854;5640.887182256373;5643.7460314285545;5649.830505084854;5669.9433005669825;6103.284053494327;6106.915739268672;6115.879294474695;6135.846603834895;6141.692915354214;6129.022607377584;6182.938170618281;6217.440430361244;6221.720022598994;6222.222222222223;5108.463611320795;5448.809291674812;5664.830055098354;5727.799527016535;5735.827925162252;6288.088227207029;6332.1135041094285;6339.841503962346;6356.904646430307;6369.872602547923;6121.449069583669;6127.448529632355;6134;6138.785142519991;6142.293636231891;6104.13283069852;6110.236220472441;6121.879793613239;6153.600015998945;6238.064290356483;6153.692315384213;6179.0422484514975;6185.072239164071;6185.443310102112;6186.19579454668;6168.074788781629;6175.660338681416;6176.81469555914;6185.288691800411;6215.844603884849;4818.253170758538;4849.442314133849;4885.169521181408;4894.412670479494;4912.778924948315;4297.656187504992;4331.263685173528;4347.760873151944;4368.737875727466;4387.122575484916;5680.233168522279;5686.97156514223;5701.458361455655;5703.258576385043;5704.8859022819315;5134.48655134491;6222.471089957314;6268.153799237136;6273.12176295319;6279.058141278753;5532.17017447378;5618.410066942994;5625.915611265835;5657.349404818417;5702.8289151325525;5362.892742145214;5363.704996225167;5383.5962302826665;5389.434109418533;5403.324584426947;6324.367563243823;6330.9050364245495;6334.1765570475545;6353.047042943595;6359.7456101755415;6016.819495415145;6142.078688196806;6212.627242365473;6253.5935164216;6286.308506064238;6294.370562943669;6298.590591611531;6312.715927783169;6316.84207894788;6350.68246587678;6127.189528148541;6128.686460748492;6143.419763699168;6144.692765361625;6145.248604147975;6147.72335244924;6227.657478838526;6237.220347456568;6257.561970662192;6272.996320588684;5898.764049437975;5942.73257703413;5962.612430192197;6057.091436284592;6070.453659170696;6001.549883758648;6007.879842403215;6014.48876845473;6019.608725432833;6095.573309868444;5847.94152058474;5872.970635146797;5873.882522349443;5883.235179426647;5895.852603684943;5884.35272120075;5949.434803693643;5982.820515384546;6010.519158467399;6029.457348838626;5787.074068149076;5838.5621078418435;5838.912416313674;5846.6784326862435;5880.411958804086 17:45:23 INFO - PROCESS | 1951 | |1;ext.html;422.27790478282134;451.1225666079475;471.2295397025863;479.6594417963246;491.5060364333843;29864.850675746617;37850.62149378505;39375;39558.802205988926;39661.603383966154;40879.59120408795;41302.38046429306;41344;41350.793246033725;41487.792561037226;7869.685212591504;9414.199793017602;9418.905810941871;9419.152276295132;9428.010058943815;8497.277731392807;8715.738527844174;10960.342379457219;11210.103191744642;11255.774884502305;11153.832692509619;11271.154663400237;11369.715757106098;11390.430478476084;11393.259438136494;11165;11242.775144497145;11247.606333778278;11254.774904501905;11257.662270131908;8387.370947178924;8614.784630384227;8642.697505587274;8719.346049046348;8734.344924130652;37954.81022594897;38836.80581597102;38858.22283554341;39862;39868.20263594741;2738.2906639656144;3308.024132880782;3431.9313613727836;3724.3668576341815;3938.8227529760943;23633.409164770845;28980.855095724597;29933.401331973455;30114.397712045855;30273.091807245597;3192.393445245396;3207.4226639204935;3271.247613048988;3296.324253528045;3306.9173270668425;498681;501172.4941375306;501304;503961;505185;56681.7165914176;57115.14327285094;57221.71389143111;57252.713736431055;57264.42735572591;58717.70641146767;59631;59782;59786.80426391535;60135;15532.223388830513;15747.763783543256;15765.763513547307;15768.92115539415;15781.21093945321;10937;12256.632301030982;12320.199187052813;12343.938280308721;12355.32045737493;13136.40886160106;13406.994475414383;14733.263336833115;15096.622584435478;15142.54572362831;6739.022841687928;7061.435085193172;7073.292670732885;7111.146662400545;7143;880.9867851982225;978.3787295067683;987.807377561383;1049.9080955805875;1074.8495210670512;29171.833126674694;29345.972890949142;29731.40537189244;29877.850610746806;30197.943071992373;1001.2890847498212;1015.6749840051112;1045.6340280901622;1049.4280617063566;1064.7284942339809;14648.414063437556;14994.625134371729;15126.470573529874;15438.691226175413;15529.990550614173;611731;615427;617293;619696;620277;49472;50388.74805625949;56451;57713;57757;1305.6344223617402;1346.1721041559567;1359.5581436033328;1382.4193838587817;1382.7441923244232;29647.851760741058;29889.5516567256;30154.396912062075;30278.84860575683;30311.734813462197;48539.75730121327;49097.754511228646;49198.75400622974;49273.753631231615;49339;576412;578169;578845;579456;583139.5901143439;37323.880283591534;37659.05852353713;38016.619833801306;38168.2366352677;38177;40003.99990000273;45150.32274515819;45740;46148.307775382724;46376.536234638574;37602.435963460026;37627.81186094052;38243.09463742724;38444.807775960944;38641.42037869491;37790.43314350342;38136.85589432321;38602.80698596489;38632;39110.608893911834;36695.449568255965;36781.26437471289;37274.44088338732;37494;37704.81147594244;30864.537031944987;32225.677743222266;33770.493442597886;33790;33914.96510209297;20238;21847.579907305975;22098.668519972536;23639.881800590887;23647.64528532039 17:45:23 INFO - PROCESS | 1951 | |2;jquery.html;342.10198229647176;356.6593902822803;364.4605983144945;369.36004141611244;392.9783861887595;14402.49591264306;14952;15528.767068493982;19286.32497862575;19951.700724489107;17762.378316758917;18267.08664566773;18724.438266851983;18965.24139034437;18985.810141898575;5549.694766787835;5918.911216331759;5923.88152236955;5927.466528012478;5931.614445061079;5517.724113794295;5718.428157184269;5724.685142317171;5776.39347868474;5785.363610002896;5726.427357264281;5727.599068065237;5730.68481233532;5737.971310143444;5740.827775166752;5544.944550554504;5645.1814486899375;5699.715014249313;5746.310442746855;5748.741306641211;4288.270993931008;5012.949870501285;5020.322256495363;5025.597952163818;5032.974835125838;22887.313380598607;23939.640905386434;24545.87727061371;24683.87658061716;24812.751872481225;2233.955320893573;2352.5177338645535;2399.292208798391;2432.537817814627;2452.509498100387;13916.15516513007;15233.466828660943;15387.923060384739;15469.149196794171;15481.922590387088;1803.8376546110783;1849.4821449994024;1878.8966606836618;1986.3445063129277;2014.264793350431;113326;116909;117527;117756.82243177544;117963.84433867905;8300.750977470685;10933.507992140372;11221.326720396803;11242.831357529643;11440.771184576262;13939.860601393857;14060;14065.296735163201;14083.507077252247;14114.576562703136;7930.405219608552;8062.596870156469;8150.470219435718;8334.541600212047;8357.58212089393;8015.238552337519;8019.39854510914;8048.839023219502;8213.589320533949;8231.629576669064;3513.94729079064;4237.982884107853;4338.631216346583;4457.9331310030375;4486.080353527519;1598.8720902327786;1838.4025191812714;1887.3488646416963;1893.5644801695687;1918.4867823151717;813.4021494201756;861.6553378648591;919.3334832246701;945.5036106044382;978.3200675530438;17133.31466741341;20878;21009.57980840405;21078.78921210799;21520.677189842165;769.3960241210734;866.1161972709458;928.4475736936512;942.6182396129578;972.7227740094039;9934.701958941243;10825.891741082645;10880.67357979262;10965.56137754497;10998.670039898816;549012;555097;556500;563147;568146;98659.50670246602;122631;125503;127766;128768.35615821861;950.4724877692947;963.1572374172599;1011.9190464762949;1027.060239880501;1028.280203857303;18748.343807966656;19065.04674766284;19195.904020479808;19232.807671923103;19302.4209273722;41049;48784.75607621939;51697.48302516927;53222.43878730125;54713.72643136759;71061.28938710547;71866;72023.27976720166;72049;72561;6423.935760642334;7367.300106489874;7584.2794934481135;7802.336801371947;7911.5253084815095;10180.338278011906;10271.589136434757;11688.123390745557;12249.571265005681;12405.069619778373;8963.865542016745;10110.949445252727;10470.84820669741;10527.789444211227;10665.41340226295;10016;10113.69658910234;10116.393016419039;10483.528241229316;10529.42088185157;10253.692389228336;10417.687469375931;10838.295510791773;10850.45747712627;11006.119510439306;7495.925040749523;7517.548947062975;7521.548707077374;7674.462787604814;7821.217878212134;9428.669996550088;10407.15919102742;10614.0447359738;10782.568697252022;10829.508016965989 17:45:23 INFO - PROCESS | 1951 | |3;mootools.html;1351.0610125962448;1476.9926150369247;1504.6088017115553;1681.251842929896;1850.426367825973;6902.378785909267;7339;7761.6507257173425;8084.19158084192;8150.796230094251;8126.4311498195;8225.712100076498;8226.17738226177;8229.177082291782;8234.217749313806;2030.3401394546759;2261.2989973108306;2302.2517681753498;2308.803751681109;2312.9768702313013;2062.783407742188;2119.8516103872735;2254.3349711834967;2329.9184528541505;2343.0627748900406;2274.2040285899884;2292.3695983604557;2293.151533932439;2295.8392912496133;2299.4596269876565;2247.4381404648757;2277.81777457803;2279.4871153990384;2279.4985103277254;2286.588414085464;2114.3234165067183;2172.8918251691753;2281.1103669568884;2313.710786151731;2317.3627252505526;8212.055613604392;8261.876071858927;8313.625886835107;8321.542315172663;8338.332933365376;4915.705057696514;5071.518205770446;5074.441811400743;5080.720560369178;5086.745662716849;3325.2684409429885;3464.0993341731078;3554.608993010767;3554.751167418282;3571.017970058229;996.8654231678703;1037.5019990404649;1074.623881641427;1076.0692001418795;1077.6389909380366;10344.120749736281;10781.353118812896;10806.243562950596;10806.459677016117;10821.404822734747;4251.59609837065;4365.934510982338;4379.890502737457;4384.802683879233;4397.582229688174;8532.402731808714;8538.316934645214;8541.615627296787;8546.31629469641;8555.82888342242;5042.722650254272;5044.747762611928;5049.267856160836;5049.621278404061;5050.696958182521;4269.231538323132;4406.008648054162;4563.931541026887;4674.672772905932;4737.431508218967;3377.527146199534;3500.824958752052;3523.119220194951;3579.6599323064265;3585.6235095315137;1122.7810576937582;1126.7802778458122;1126.8253420719802;1138.317009794117;1142.097742783192;843.4601854812925;852.7441767469734;869.9782505437288;910.0535443139194;942.9768700959398;5459.2902922619805;5490.670559766427;5748.798792042258;5780.364159942403;5841.474267315877;875.2735229759285;897.9820403591891;904.2359206470522;912;919.8482250428738;3573.3746594345885;3626.9455958160647;3728.8694895678523;3809.447630093621;3830.5211848518934;9323.393979391318;9448.622055117856;9482.715518534455;9551.997040310667;9896.851547226797;9637.951810240904;9793.020697930293;9797.412155270707;9801.215902727907;9811.31320807551;7419.258074192538;7703.691852325845;7726.497777644435;7731.110922243902;7744.883826742604;4927.679700819435;5308;5310.840674779763;5409.890972350738;5618.775248989995;7543.547387156788;7954.801129971797;8252.09226985019;8747.343949203709;9238;7321.487495875451;9113.270938324786;9229.030951750237;9338.066193380608;9361.906380936103;6558.278589355072;6967.338102880219;7020.22777494465;7138.428925686037;7141.642917853983;7131.037309963089;7443.888341674988;7571.697132114874;7678.232176782501;7722.845543089219;6988.755393561201;7091.893621595577;7101.715931362688;7137.607431591312;7246.89129663066;6870.20992585859;6879.828004299932;6917.723291068301;6993.860122797414;7014.929850701427;6158.538109641705;6249.093881387264;6355.5551111421755;6473.158489396348;6507.446867016357;4730.385049943623;4733.881652958704;4765.070811191785;4817.759112044454;4897.142999975062;4245.936310955276;4315.9352609711505;4810.326554282333;4829.227323628203;4913.70517768935 17:45:23 INFO - PROCESS | 1951 | |4;prototype.html;305.32370798680927;337.08313387585764;341.6515154542367;352.92941411717663;354.2383874669459;4707.505711900252;4940.728259945706;5378.52090675064;5383.730813459331;5424.1321388577835;4719.787609557569;5274.182501712241;5289.206619007141;5372.328458942632;5377.946220537793;3367.3433680432204;3431.1765176357744;3616.9691637883207;3929.7052721045893;4044.3124668806227;4116.855910043149;4149.190907772985;4164.354525048622;4196.307609244471;4202.495700515927;3116.6727493613184;3922.8038598070125;4061.2283666103494;4063.6952228582827;4131.153113611703;3238.5951756030495;3381.8140002299865;3950.486436763202;4144.295469770146;4174.645155161815;2752.628395166647;3592.389293820057;3615.349237137314;3625;3678.5585729712607;4021.6380525752825;5115.5396014358885;5165.560927321182;5183.682443236332;5331.680099194061;4109.239790638741;4164.271827191742;4423.933640995388;4741.857744267678;4756.619470442391;5474.644148130398;5570.498655121018;5620.91568626471;5657.349404818417;5666.603337766358;3646.835892384849;3745.494358261627;3992.2414741199077;4004.9199016019516;4035;5503.3395992480355;5822.039363505017;5847.970760146214;5855.882882342372;5862.765489380419;3287.408266512051;3759.7368184226843;3837.6162383761402;3858.5176852893387;3865.7487263327794;3402.9450870230307;3597.982010089933;3795.2409518096492;3915.9426954722067;3939.212157568498;3944.36890097583;4529.9547004530195;4547.249309015987;4554.294084416921;4577.725336479822;4735.4428608551;4762.880927976828;5060.569851562658;5163.974180129076;5307.6284660073425;1134.9602763903224;1254.1158483269273;1258.6475786779715;1265.8733726982994;1288.672667152834;807.2169995104856;841.7769291137853;854.7520619895023;860.832137733136;866.2377108144918;4240.067185219247;4432.556744325541;4965.329680493087;5042.193249080129;5063.5695965843315;5365.731713414314;5808.224653974866;5850.707464626752;5856.795012174553;5896.498797602252;4731.739754313546;4875.609951203966;5028.748562571856;5278.4721527846905;5322.33470816148;2665.4939958923146;2671.358873870257;2787.665480142396;2892.363679990399;2955.5418910068975;5070.400015988689;5771.769129234784;5778.595498315078;5850.824475265749;5881.911771323434;4811.374521312207;5442.83671489848;5582.074184406373;5702.82891513247;5746.569007324468;5710.685912274865;5734.22587950638;5735.971320143372;6063.484603808637;6103.298120716086;5139.8458046258675;5372.379753411984;5727.627704199213;5893.322267939242;5904.6161999471615;5110.642255042111;5380.632521690443;5632.352279487911;5699.572532060195;5708.686022268815;5105.540501354896;5501.422350653123;5579.8047068354035;6053.969730151321;6056.848578785565;3632.7275454341557;3871.496705428276;3883.514560679915;3884.3008258513737;3902.6292502212245;4768.451628062817;5482.369527504228;5579.744557474536;5863.120531920246;5881.235439392852;4629.421322334708;4997.475265097258;5646.237757902795;5647.971760141338;5680.40355762639;4573.542645735533;4774.045190961752;5186.351706036746;5465.426130256265;5521.806736764194;5350.238287923673;5369.624126311121;5471.261379713687;5568.656447970589;5628.718564071862;4582.8836391252935;4720.362751028704;5073.7675422813845;5419.647722897999;5729.817233419543;5105.6426050177615;5341.545968592558;5448;5583.1904373864745;5615.129654903497 17:45:23 INFO - PROCESS | 1951 | |5;yui.html;728.8177955511121;735.5623404074573;735.6321839080459;770.8920751094847;780.6994307191729;14476.348564314605;14931.776023359658;15041.62395940102;15075.924620376896;15099.245037748124;13360.265185414799;13552.18686878788;13554.322283885816;13609.863901360983;13614.183149011067;679.1205389021229;706.8515611721544;709.5707097206193;714.1037997313365;843.3169133002273;706.0961968680098;711.5446114486732;832.4755404095412;868.0061329777401;873.8645509945968;902.2421166220373;913.2693844924067;913.9405938613969;915.9129882661136;916.8395530782086;908.513945039404;910.4946754551221;912.2473958983865;912.3020889019905;912.3704643795793;517.3016427822447;679.0764560198127;680.6052489556046;680.6426626021329;681.0533358631507;11828.231164974335;12984.610461686165;13504.392302346418;13612.31938403076;13932.164070155723;13154.671133221746;13278.668033299246;13311.938254201588;13361.924612993032;13430.918207677825;9903.90096099037;11544.826827597593;11656.30062196271;11682.883171168265;11703.2978021319;3674.1182116292166;3675.1730860556427;3678.282734866702;3758.906027349311;3801.9619803801884;86753.56623216906;103872.48063759632;106180.46909765479;106974;107635.46182269117;8446.66213351459;9885.901140988643;9965.152961998167;10054.899451005396;10531;17703.734443983092;21161;21328;21576.568468630852;21636.89181554082;7573.318401343795;7574.204708505527;7605.315521603082;7610.885836712454;7678.61606919663;4114.958850411457;4214.4099826024385;4238.703290769617;4260.339647354665;4271.10306835568;3517.3668739627115;3543.344481270973;3556.87550935716;3594.2092739597247;3626.4741612466046;635.5995722694673;642.5502148496072;643.5816719132602;653.7221680785742;655.9048937903978;567.2059117235902;579.8492391978116;625.5996162456032;655.2308766330925;687.5221720904024;8855.73432797017;9086.86369704455;9204.447733136034;9224.077592240856;9948.502574871227;617.8486270863667;619.8543342314553;683.9555428897205;685.5441131647498;688.4561196654587;3956.584558621303;4438.889027774331;4466.307722303049;4535.795889184995;4666.673332866667;75629.62185189039;84415;84890;107585.4620726907;111413;82692.58653706693;92003.539982301;92923;94172;96410.51794740981;56102.15846762302;78223;80174;80369.59815200887;82627.5868620653;9525.380850244712;9827.164691001344;9875.111239988435;9886.802263954825;9901.851472228067;50052.998940021724;52920.73539632277;53486.732566338476;54654.453455464936;54852;74275.6286218587;74322.62838685772;77085.61457192678;79510;82527.81041421798;12969.416376262901;12993.350332483527;13015.674608134494;13059.542915997894;13098.476060957455;12037.960046253796;14561.92719036398;14749.410023598935;14796.038257513228;14868.62828429298;13544.187348759106;13632.795508067586;13696.31518424055;13868;14230.430782768573;13496.987725920399;13619;13938;14129.576112716635;14275;13296.468141274241;13691.794623080861;13693.863061369259;13871.861281387057;14159.929200353932;9895.901040989498;10340.172786176938;10907.236493445384;11103.611373601885;11537.538498459968;9852.310338276251;11230.719232019264;11551.595694151001;11578.478968446609;11581.43650607191 17:45:23 INFO - PROCESS | 1951 | __end_tp_report 17:45:23 INFO - PROCESS | 1951 | __start_cc_report 17:45:23 INFO - PROCESS | 1951 | _x_x_mozilla_cycle_collect,1689 17:45:23 INFO - PROCESS | 1951 | __end_cc_report 17:45:23 INFO - PROCESS | 1951 | __startTimestamp1481766323020__endTimestamp 17:45:23 INFO - PROCESS | 1951 | 17:45:23 INFO - PROCESS | 1951 | ------- Summary: start ------- 17:45:23 INFO - PROCESS | 1951 | Number of tests: 6 17:45:23 INFO - PROCESS | 1951 | 17:45:23 INFO - PROCESS | 1951 | [#0] dojo.html Cycles:165 Average:5691.72 Median:5873.88 stddev:646.22 (11.0%) stddev-sans-first:619.63 17:45:23 INFO - PROCESS | 1951 | Values: 3269.3 3284.8 3293.4 3326.0 3332.6 5546.6 5609.6 5644.2 5673.9 5681.3 5613.2 5619.0 5711.1 5720.4 5723.9 5065.3 5095.4 5120.5 5144.5 5165.6 5239.8 5251.0 5253.9 5261.7 5298.4 5095.4 5189.6 5212.7 5216.8 5316.7 5127.7 5162.8 5163.9 5164.1 5171.7 5065.2 5133.9 5152.1 5152.6 5178.4 5629.8 5640.9 5643.7 5649.8 5669.9 6103.3 6106.9 6115.9 6135.8 6141.7 6129.0 6182.9 6217.4 6221.7 6222.2 5108.5 5448.8 5664.8 5727.8 5735.8 6288.1 6332.1 6339.8 6356.9 6369.9 6121.4 6127.4 6134.0 6138.8 6142.3 6104.1 6110.2 6121.9 6153.6 6238.1 6153.7 6179.0 6185.1 6185.4 6186.2 6168.1 6175.7 6176.8 6185.3 6215.8 4818.3 4849.4 4885.2 4894.4 4912.8 4297.7 4331.3 4347.8 4368.7 4387.1 5680.2 5687.0 5701.5 5703.3 5704.9 5134.5 6222.5 6268.2 6273.1 6279.1 5532.2 5618.4 5625.9 5657.3 5702.8 5362.9 5363.7 5383.6 5389.4 5403.3 6324.4 6330.9 6334.2 6353.0 6359.7 6016.8 6142.1 6212.6 6253.6 6286.3 6294.4 6298.6 6312.7 6316.8 6350.7 6127.2 6128.7 6143.4 6144.7 6145.2 6147.7 6227.7 6237.2 6257.6 6273.0 5898.8 5942.7 5962.6 6057.1 6070.5 6001.5 6007.9 6014.5 6019.6 6095.6 5847.9 5873.0 5873.9 5883.2 5895.9 5884.4 5949.4 5982.8 6010.5 6029.5 5787.1 5838.6 5838.9 5846.7 5880.4 17:45:23 INFO - PROCESS | 1951 | 17:45:23 INFO - PROCESS | 1951 | [#1] ext.html Cycles:180 Average:69470.17 Median:37902.72 stddev:151764.03 (400.4%) stddev-sans-first:152101.22 17:45:23 INFO - PROCESS | 1951 | Values: 422.3 451.1 471.2 479.7 491.5 29864.9 37850.6 39375.0 39558.8 39661.6 40879.6 41302.4 41344.0 41350.8 41487.8 7869.7 9414.2 9418.9 9419.2 9428.0 8497.3 8715.7 10960.3 11210.1 11255.8 11153.8 11271.2 11369.7 11390.4 11393.3 11165.0 11242.8 11247.6 11254.8 11257.7 8387.4 8614.8 8642.7 8719.3 8734.3 37954.8 38836.8 38858.2 39862.0 39868.2 2738.3 3308.0 3431.9 3724.4 3938.8 23633.4 28980.9 29933.4 30114.4 30273.1 3192.4 3207.4 3271.2 3296.3 3306.9 498681.0 501172.5 501304.0 503961.0 505185.0 56681.7 57115.1 57221.7 57252.7 57264.4 58717.7 59631.0 59782.0 59786.8 60135.0 15532.2 15747.8 15765.8 15768.9 15781.2 10937.0 12256.6 12320.2 12343.9 12355.3 13136.4 13407.0 14733.3 15096.6 15142.5 6739.0 7061.4 7073.3 7111.1 7143.0 881.0 978.4 987.8 1049.9 1074.8 29171.8 29346.0 29731.4 29877.9 30197.9 1001.3 1015.7 1045.6 1049.4 1064.7 14648.4 14994.6 15126.5 15438.7 15530.0 611731.0 615427.0 617293.0 619696.0 620277.0 49472.0 50388.7 56451.0 57713.0 57757.0 1305.6 1346.2 1359.6 1382.4 1382.7 29647.9 29889.6 30154.4 30278.8 30311.7 48539.8 49097.8 49198.8 49273.8 49339.0 576412.0 578169.0 578845.0 579456.0 583139.6 37323.9 37659.1 38016.6 38168.2 38177.0 40004.0 45150.3 45740.0 46148.3 46376.5 37602.4 37627.8 38243.1 38444.8 38641.4 37790.4 38136.9 38602.8 38632.0 39110.6 36695.4 36781.3 37274.4 37494.0 37704.8 30864.5 32225.7 33770.5 33790.0 33915.0 20238.0 21847.6 22098.7 23639.9 23647.6 17:45:23 INFO - PROCESS | 1951 | 17:45:23 INFO - PROCESS | 1951 | [#2] jquery.html Cycles:180 Average:33124.36 Median:24614.88 stddev:93350.55 (379.2%) stddev-sans-first:93579.97 17:45:23 INFO - PROCESS | 1951 | Values: 342.1 356.7 364.5 369.4 393.0 14402.5 14952.0 15528.8 19286.3 19951.7 17762.4 18267.1 18724.4 18965.2 18985.8 5549.7 5918.9 5923.9 5927.5 5931.6 5517.7 5718.4 5724.7 5776.4 5785.4 5726.4 5727.6 5730.7 5738.0 5740.8 5544.9 5645.2 5699.7 5746.3 5748.7 4288.3 5012.9 5020.3 5025.6 5033.0 22887.3 23939.6 24545.9 24683.9 24812.8 2234.0 2352.5 2399.3 2432.5 2452.5 13916.2 15233.5 15387.9 15469.1 15481.9 1803.8 1849.5 1878.9 1986.3 2014.3 113326.0 116909.0 117527.0 117756.8 117963.8 8300.8 10933.5 11221.3 11242.8 11440.8 13939.9 14060.0 14065.3 14083.5 14114.6 7930.4 8062.6 8150.5 8334.5 8357.6 8015.2 8019.4 8048.8 8213.6 8231.6 3513.9 4238.0 4338.6 4457.9 4486.1 1598.9 1838.4 1887.3 1893.6 1918.5 813.4 861.7 919.3 945.5 978.3 17133.3 20878.0 21009.6 21078.8 21520.7 769.4 866.1 928.4 942.6 972.7 9934.7 10825.9 10880.7 10965.6 10998.7 549012.0 555097.0 556500.0 563147.0 568146.0 98659.5 122631.0 125503.0 127766.0 128768.4 950.5 963.2 1011.9 1027.1 1028.3 18748.3 19065.0 19195.9 19232.8 19302.4 41049.0 48784.8 51697.5 53222.4 54713.7 71061.3 71866.0 72023.3 72049.0 72561.0 6423.9 7367.3 7584.3 7802.3 7911.5 10180.3 10271.6 11688.1 12249.6 12405.1 8963.9 10110.9 10470.8 10527.8 10665.4 10016.0 10113.7 10116.4 10483.5 10529.4 10253.7 10417.7 10838.3 10850.5 11006.1 7495.9 7517.5 7521.5 7674.5 7821.2 9428.7 10407.2 10614.0 10782.6 10829.5 17:45:23 INFO - PROCESS | 1951 | 17:45:23 INFO - PROCESS | 1951 | [#3] mootools.html Cycles:180 Average:5260.29 Median:5309.42 stddev:2849.23 (53.7%) stddev-sans-first:2842.07 17:45:23 INFO - PROCESS | 1951 | Values: 1351.1 1477.0 1504.6 1681.3 1850.4 6902.4 7339.0 7761.7 8084.2 8150.8 8126.4 8225.7 8226.2 8229.2 8234.2 2030.3 2261.3 2302.3 2308.8 2313.0 2062.8 2119.9 2254.3 2329.9 2343.1 2274.2 2292.4 2293.2 2295.8 2299.5 2247.4 2277.8 2279.5 2279.5 2286.6 2114.3 2172.9 2281.1 2313.7 2317.4 8212.1 8261.9 8313.6 8321.5 8338.3 4915.7 5071.5 5074.4 5080.7 5086.7 3325.3 3464.1 3554.6 3554.8 3571.0 996.9 1037.5 1074.6 1076.1 1077.6 10344.1 10781.4 10806.2 10806.5 10821.4 4251.6 4365.9 4379.9 4384.8 4397.6 8532.4 8538.3 8541.6 8546.3 8555.8 5042.7 5044.7 5049.3 5049.6 5050.7 4269.2 4406.0 4563.9 4674.7 4737.4 3377.5 3500.8 3523.1 3579.7 3585.6 1122.8 1126.8 1126.8 1138.3 1142.1 843.5 852.7 870.0 910.1 943.0 5459.3 5490.7 5748.8 5780.4 5841.5 875.3 898.0 904.2 912.0 919.8 3573.4 3626.9 3728.9 3809.4 3830.5 9323.4 9448.6 9482.7 9552.0 9896.9 9638.0 9793.0 9797.4 9801.2 9811.3 7419.3 7703.7 7726.5 7731.1 7744.9 4927.7 5308.0 5310.8 5409.9 5618.8 7543.5 7954.8 8252.1 8747.3 9238.0 7321.5 9113.3 9229.0 9338.1 9361.9 6558.3 6967.3 7020.2 7138.4 7141.6 7131.0 7443.9 7571.7 7678.2 7722.8 6988.8 7091.9 7101.7 7137.6 7246.9 6870.2 6879.8 6917.7 6993.9 7014.9 6158.5 6249.1 6355.6 6473.2 6507.4 4730.4 4733.9 4765.1 4817.8 4897.1 4245.9 4315.9 4810.3 4829.2 4913.7 17:45:23 INFO - PROCESS | 1951 | 17:45:23 INFO - PROCESS | 1951 | [#4] prototype.html Cycles:180 Average:4477.17 Median:5051.38 stddev:1396.90 (27.7%) stddev-sans-first:1365.27 17:45:23 INFO - PROCESS | 1951 | Values: 305.3 337.1 341.7 352.9 354.2 4707.5 4940.7 5378.5 5383.7 5424.1 4719.8 5274.2 5289.2 5372.3 5377.9 3367.3 3431.2 3617.0 3929.7 4044.3 4116.9 4149.2 4164.4 4196.3 4202.5 3116.7 3922.8 4061.2 4063.7 4131.2 3238.6 3381.8 3950.5 4144.3 4174.6 2752.6 3592.4 3615.3 3625.0 3678.6 4021.6 5115.5 5165.6 5183.7 5331.7 4109.2 4164.3 4423.9 4741.9 4756.6 5474.6 5570.5 5620.9 5657.3 5666.6 3646.8 3745.5 3992.2 4004.9 4035.0 5503.3 5822.0 5848.0 5855.9 5862.8 3287.4 3759.7 3837.6 3858.5 3865.7 3402.9 3598.0 3795.2 3915.9 3939.2 3944.4 4530.0 4547.2 4554.3 4577.7 4735.4 4762.9 5060.6 5164.0 5307.6 1135.0 1254.1 1258.6 1265.9 1288.7 807.2 841.8 854.8 860.8 866.2 4240.1 4432.6 4965.3 5042.2 5063.6 5365.7 5808.2 5850.7 5856.8 5896.5 4731.7 4875.6 5028.7 5278.5 5322.3 2665.5 2671.4 2787.7 2892.4 2955.5 5070.4 5771.8 5778.6 5850.8 5881.9 4811.4 5442.8 5582.1 5702.8 5746.6 5710.7 5734.2 5736.0 6063.5 6103.3 5139.8 5372.4 5727.6 5893.3 5904.6 5110.6 5380.6 5632.4 5699.6 5708.7 5105.5 5501.4 5579.8 6054.0 6056.8 3632.7 3871.5 3883.5 3884.3 3902.6 4768.5 5482.4 5579.7 5863.1 5881.2 4629.4 4997.5 5646.2 5648.0 5680.4 4573.5 4774.0 5186.4 5465.4 5521.8 5350.2 5369.6 5471.3 5568.7 5628.7 4582.9 4720.4 5073.8 5419.6 5729.8 5105.6 5341.5 5448.0 5583.2 5615.1 17:45:23 INFO - PROCESS | 1951 | 17:45:23 INFO - PROCESS | 1951 | [#5] yui.html Cycles:180 Average:20263.72 Median:25285.15 stddev:29201.52 (115.5%) stddev-sans-first:29246.59 17:45:23 INFO - PROCESS | 1951 | Values: 728.8 735.6 735.6 770.9 780.7 14476.3 14931.8 15041.6 15075.9 15099.2 13360.3 13552.2 13554.3 13609.9 13614.2 679.1 706.9 709.6 714.1 843.3 706.1 711.5 832.5 868.0 873.9 902.2 913.3 913.9 915.9 916.8 908.5 910.5 912.2 912.3 912.4 517.3 679.1 680.6 680.6 681.1 11828.2 12984.6 13504.4 13612.3 13932.2 13154.7 13278.7 13311.9 13361.9 13430.9 9903.9 11544.8 11656.3 11682.9 11703.3 3674.1 3675.2 3678.3 3758.9 3802.0 86753.6 103872.5 106180.5 106974.0 107635.5 8446.7 9885.9 9965.2 10054.9 10531.0 17703.7 21161.0 21328.0 21576.6 21636.9 7573.3 7574.2 7605.3 7610.9 7678.6 4115.0 4214.4 4238.7 4260.3 4271.1 3517.4 3543.3 3556.9 3594.2 3626.5 635.6 642.6 643.6 653.7 655.9 567.2 579.8 625.6 655.2 687.5 8855.7 9086.9 9204.4 9224.1 9948.5 617.8 619.9 684.0 685.5 688.5 3956.6 4438.9 4466.3 4535.8 4666.7 75629.6 84415.0 84890.0 107585.5 111413.0 82692.6 92003.5 92923.0 94172.0 96410.5 56102.2 78223.0 80174.0 80369.6 82627.6 9525.4 9827.2 9875.1 9886.8 9901.9 50053.0 52920.7 53486.7 54654.5 54852.0 74275.6 74322.6 77085.6 79510.0 82527.8 12969.4 12993.4 13015.7 13059.5 13098.5 12038.0 14561.9 14749.4 14796.0 14868.6 13544.2 13632.8 13696.3 13868.0 14230.4 13497.0 13619.0 13938.0 14129.6 14275.0 13296.5 13691.8 13693.9 13871.9 14159.9 9895.9 10340.2 10907.2 11103.6 11537.5 9852.3 11230.7 11551.6 11578.5 11581.4 17:45:23 INFO - PROCESS | 1951 | -------- Summary: end -------- 17:45:23 INFO - PROCESS | 1951 | 17:45:23 INFO - TEST-INFO | 1951: exit 0 17:45:23 INFO - TEST-OK | dromaeo_css | took 1119514ms 17:45:23 INFO - TEST-START | kraken 17:45:23 INFO - operating with platform_type : mac_ 17:45:23 INFO - Initialising browser for kraken test... 17:45:23 INFO - TEST-INFO | started process 1955 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpVok3_4/profile http://localhost:49525/getInfo.html) 17:45:26 INFO - PROCESS | 1955 | __metrics Screen width/height:1600/1200 17:45:26 INFO - PROCESS | 1955 | colorDepth:24 17:45:26 INFO - PROCESS | 1955 | Browser inner width/height: 1024/689 17:45:26 INFO - PROCESS | 1955 | __metrics 17:45:26 INFO - PROCESS | 1955 | 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" 17:45:26 INFO - PROCESS | 1955 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:45:26 INFO - TEST-INFO | 1955: exit 0 17:45:26 INFO - Browser initialized. 17:45:26 INFO - Running cycle 1/1 for kraken test... 17:45:26 INFO - TEST-INFO | started process 1956 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpVok3_4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:45:38 INFO - PROCESS | 1956 | RSS: Main: 237080576 17:45:38 INFO - PROCESS | 1956 | 17:45:41 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49525/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49525/tests/kraken/driver.html?testName=audio-beat-detection) 17:45:42 INFO - PROCESS | 1956 | RSS: Main: 289972224 17:45:42 INFO - PROCESS | 1956 | 17:45:45 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49525/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49525/tests/kraken/driver.html?testName=audio-dft) 17:45:45 INFO - PROCESS | 1956 | RSS: Main: 292495360 17:45:45 INFO - PROCESS | 1956 | 17:45:49 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49525/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49525/tests/kraken/driver.html?testName=audio-fft) 17:45:49 INFO - PROCESS | 1956 | RSS: Main: 382050304 17:45:49 INFO - PROCESS | 1956 | 17:45:51 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49525/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49525/tests/kraken/driver.html?testName=audio-oscillator) 17:45:52 INFO - PROCESS | 1956 | RSS: Main: 284794880 17:45:52 INFO - PROCESS | 1956 | 17:45:54 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49525/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49525/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:45:55 INFO - PROCESS | 1956 | RSS: Main: 289488896 17:45:55 INFO - PROCESS | 1956 | 17:45:58 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49525/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49525/tests/kraken/driver.html?testName=imaging-darkroom) 17:45:58 INFO - PROCESS | 1956 | RSS: Main: 332513280 17:45:58 INFO - PROCESS | 1956 | 17:46:01 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49525/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49525/tests/kraken/driver.html?testName=imaging-desaturate) 17:46:02 INFO - PROCESS | 1956 | RSS: Main: 333619200 17:46:02 INFO - PROCESS | 1956 | 17:46:05 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49525/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49525/tests/kraken/driver.html?testName=json-parse-financial) 17:46:06 INFO - PROCESS | 1956 | RSS: Main: 330809344 17:46:06 INFO - PROCESS | 1956 | 17:46:07 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49525/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49525/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:46:08 INFO - PROCESS | 1956 | RSS: Main: 303902720 17:46:08 INFO - PROCESS | 1956 | 17:46:10 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49525/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49525/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:46:10 INFO - PROCESS | 1956 | RSS: Main: 309305344 17:46:10 INFO - PROCESS | 1956 | 17:46:13 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49525/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49525/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:46:13 INFO - PROCESS | 1956 | RSS: Main: 310231040 17:46:13 INFO - PROCESS | 1956 | 17:46:16 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49525/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49525/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:46:17 INFO - PROCESS | 1956 | RSS: Main: 325636096 17:46:17 INFO - PROCESS | 1956 | 17:46:20 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49525/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49525/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:46:21 INFO - PROCESS | 1956 | RSS: Main: 320176128 17:46:21 INFO - PROCESS | 1956 | 17:46:23 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49525/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49525/tests/kraken/driver.html?testName=ai-astar) 17:46:23 INFO - PROCESS | 1956 | RSS: Main: 363503616 17:46:23 INFO - PROCESS | 1956 | 17:46:23 INFO - PROCESS | 1956 | __start_tp_report 17:46:23 INFO - PROCESS | 1956 | _x_x_mozilla_page_load 17:46:23 INFO - PROCESS | 1956 | _x_x_mozilla_page_load_details 17:46:23 INFO - PROCESS | 1956 | |i|pagename|runs| 17:46:23 INFO - PROCESS | 1956 | |0;ai-astar;114;113;114;113;112;114;114;114;114;112 17:46:23 INFO - PROCESS | 1956 | |1;audio-beat-detection;150;114;119;183;145;133;115;115;132;115 17:46:23 INFO - PROCESS | 1956 | |2;audio-dft;184;181;182;187;182;183;181;183;183;182 17:46:23 INFO - PROCESS | 1956 | |3;audio-fft;79;58;59;87;62;59;59;58;80;57 17:46:23 INFO - PROCESS | 1956 | |4;audio-oscillator;88;70;85;68;68;68;85;68;68;109 17:46:23 INFO - PROCESS | 1956 | |5;imaging-gaussian-blur;110;111;110;113;110;112;110;113;110;111 17:46:23 INFO - PROCESS | 1956 | |6;imaging-darkroom;95;98;98;98;97;98;126;120;95;95 17:46:23 INFO - PROCESS | 1956 | |7;imaging-desaturate;87;88;100;139;142;84;142;134;107;85 17:46:23 INFO - PROCESS | 1956 | |8;json-parse-financial;57;55;53;54;55;57;55;55;56;56 17:46:23 INFO - PROCESS | 1956 | |9;json-stringify-tinderbox;65;74;75;76;74;71;71;71;72;72 17:46:23 INFO - PROCESS | 1956 | |10;stanford-crypto-aes;90;90;87;91;88;88;87;89;89;91 17:46:23 INFO - PROCESS | 1956 | |11;stanford-crypto-ccm;175;158;153;139;140;154;152;151;197;147 17:46:23 INFO - PROCESS | 1956 | |12;stanford-crypto-pbkdf2;181;178;175;181;180;176;177;178;177;193 17:46:23 INFO - PROCESS | 1956 | |13;stanford-crypto-sha256-iterative;72;82;87;88;90;67;67;69;69;68 17:46:23 INFO - PROCESS | 1956 | __end_tp_report 17:46:23 INFO - PROCESS | 1956 | __start_cc_report 17:46:23 INFO - PROCESS | 1956 | _x_x_mozilla_cycle_collect,2080 17:46:23 INFO - PROCESS | 1956 | __end_cc_report 17:46:23 INFO - PROCESS | 1956 | __startTimestamp1481766383361__endTimestamp 17:46:23 INFO - PROCESS | 1956 | 17:46:23 INFO - PROCESS | 1956 | ------- Summary: start ------- 17:46:23 INFO - PROCESS | 1956 | Number of tests: 14 17:46:23 INFO - PROCESS | 1956 | 17:46:23 INFO - PROCESS | 1956 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:0.84 (0.7%) stddev-sans-first:0.87 17:46:23 INFO - PROCESS | 1956 | Values: 114.0 113.0 114.0 113.0 112.0 114.0 114.0 114.0 114.0 112.0 17:46:23 INFO - PROCESS | 1956 | 17:46:23 INFO - PROCESS | 1956 | [#1] audio-beat-detection Cycles:10 Average:132.10 Median:132.50 stddev:22.25 (16.8%) stddev-sans-first:22.64 17:46:23 INFO - PROCESS | 1956 | Values: 150.0 114.0 119.0 183.0 145.0 133.0 115.0 115.0 132.0 115.0 17:46:23 INFO - PROCESS | 1956 | 17:46:23 INFO - PROCESS | 1956 | [#2] audio-dft Cycles:10 Average:182.80 Median:183.00 stddev:1.75 (1.0%) stddev-sans-first:1.80 17:46:23 INFO - PROCESS | 1956 | Values: 184.0 181.0 182.0 187.0 182.0 183.0 181.0 183.0 183.0 182.0 17:46:23 INFO - PROCESS | 1956 | 17:46:23 INFO - PROCESS | 1956 | [#3] audio-fft Cycles:10 Average:65.80 Median:60.50 stddev:11.44 (18.9%) stddev-sans-first:11.09 17:46:23 INFO - PROCESS | 1956 | Values: 79.0 58.0 59.0 87.0 62.0 59.0 59.0 58.0 80.0 57.0 17:46:23 INFO - PROCESS | 1956 | 17:46:23 INFO - PROCESS | 1956 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:69.00 stddev:13.83 (20.0%) stddev-sans-first:14.16 17:46:23 INFO - PROCESS | 1956 | Values: 88.0 70.0 85.0 68.0 68.0 68.0 85.0 68.0 68.0 109.0 17:46:23 INFO - PROCESS | 1956 | 17:46:23 INFO - PROCESS | 1956 | [#5] imaging-gaussian-blur Cycles:10 Average:111.00 Median:111.00 stddev:1.25 (1.1%) stddev-sans-first:1.27 17:46:23 INFO - PROCESS | 1956 | Values: 110.0 111.0 110.0 113.0 110.0 112.0 110.0 113.0 110.0 111.0 17:46:23 INFO - PROCESS | 1956 | 17:46:23 INFO - PROCESS | 1956 | [#6] imaging-darkroom Cycles:10 Average:102.00 Median:97.50 stddev:11.23 (11.5%) stddev-sans-first:11.63 17:46:23 INFO - PROCESS | 1956 | Values: 95.0 98.0 98.0 98.0 97.0 98.0 126.0 120.0 95.0 95.0 17:46:23 INFO - PROCESS | 1956 | 17:46:23 INFO - PROCESS | 1956 | [#7] imaging-desaturate Cycles:10 Average:110.80 Median:113.00 stddev:25.56 (22.6%) stddev-sans-first:25.62 17:46:23 INFO - PROCESS | 1956 | Values: 87.0 88.0 100.0 139.0 142.0 84.0 142.0 134.0 107.0 85.0 17:46:23 INFO - PROCESS | 1956 | 17:46:23 INFO - PROCESS | 1956 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.50 stddev:1.25 (2.3%) stddev-sans-first:1.17 17:46:23 INFO - PROCESS | 1956 | Values: 57.0 55.0 53.0 54.0 55.0 57.0 55.0 55.0 56.0 56.0 17:46:23 INFO - PROCESS | 1956 | 17:46:23 INFO - PROCESS | 1956 | [#9] json-stringify-tinderbox Cycles:10 Average:72.10 Median:73.00 stddev:3.07 (4.2%) stddev-sans-first:1.90 17:46:23 INFO - PROCESS | 1956 | Values: 65.0 74.0 75.0 76.0 74.0 71.0 71.0 71.0 72.0 72.0 17:46:23 INFO - PROCESS | 1956 | 17:46:23 INFO - PROCESS | 1956 | [#10] stanford-crypto-aes Cycles:10 Average:89.00 Median:89.50 stddev:1.49 (1.7%) stddev-sans-first:1.54 17:46:23 INFO - PROCESS | 1956 | Values: 90.0 90.0 87.0 91.0 88.0 88.0 87.0 89.0 89.0 91.0 17:46:23 INFO - PROCESS | 1956 | 17:46:23 INFO - PROCESS | 1956 | [#11] stanford-crypto-ccm Cycles:10 Average:156.60 Median:153.50 stddev:17.39 (11.3%) stddev-sans-first:17.13 17:46:23 INFO - PROCESS | 1956 | Values: 175.0 158.0 153.0 139.0 140.0 154.0 152.0 151.0 197.0 147.0 17:46:23 INFO - PROCESS | 1956 | 17:46:23 INFO - PROCESS | 1956 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.60 Median:179.00 stddev:5.13 (2.9%) stddev-sans-first:5.41 17:46:23 INFO - PROCESS | 1956 | Values: 181.0 178.0 175.0 181.0 180.0 176.0 177.0 178.0 177.0 193.0 17:46:23 INFO - PROCESS | 1956 | 17:46:23 INFO - PROCESS | 1956 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.90 Median:77.00 stddev:9.64 (12.5%) stddev-sans-first:10.12 17:46:23 INFO - PROCESS | 1956 | Values: 72.0 82.0 87.0 88.0 90.0 67.0 67.0 69.0 69.0 68.0 17:46:23 INFO - PROCESS | 1956 | -------- Summary: end -------- 17:46:23 INFO - PROCESS | 1956 | 17:46:24 INFO - TEST-INFO | 1956: exit 0 17:46:24 INFO - TEST-OK | kraken | took 60589ms 17:46:24 INFO - SUITE-END | took 1180s 17:46:24 INFO - Completed test suite (00:19:40) 17:46:24 INFO - javascript benchmark 17:46:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3269.2807582331884, 3284.8193349365774, 3293.374258890811, 3325.9689496256146, 3332.5667663203794, 5546.639468434549, 5609.607327487072, 5644.209810626506, 5673.914891276634, 5681.2614360133175, 5613.242212301338, 5618.971905140479, 5711.114777209529, 5720.399358067405, 5723.856903577413, 5065.290859279704, 5095.439501654815, 5120.487951204887, 5144.485551444863, 5165.560927321182, 5239.816606418776, 5250.973745131269, 5253.8949221015555, 5261.710605916673, 5298.417174110845, 5095.414027386861, 5189.610779191576, 5212.739363031833, 5216.843494695166, 5316.73416329184, 5127.717975511346, 5162.766531444217, 5163.896722065575, 5164.096283150434, 5171.689698618095, 5065.214891691794, 5133.948660513422, 5152.072626927152, 5152.639315247934, 5178.378594568639, 5629.831105066854, 5640.887182256373, 5643.7460314285545, 5649.830505084854, 5669.9433005669825, 6103.284053494327, 6106.915739268672, 6115.879294474695, 6135.846603834895, 6141.692915354214, 6129.022607377584, 6182.938170618281, 6217.440430361244, 6221.720022598994, 6222.222222222223, 5108.463611320795, 5448.809291674812, 5664.830055098354, 5727.799527016535, 5735.827925162252, 6288.088227207029, 6332.1135041094285, 6339.841503962346, 6356.904646430307, 6369.872602547923, 6121.449069583669, 6127.448529632355, 6134.0, 6138.785142519991, 6142.293636231891, 6104.13283069852, 6110.236220472441, 6121.879793613239, 6153.600015998945, 6238.064290356483, 6153.692315384213, 6179.0422484514975, 6185.072239164071, 6185.443310102112, 6186.19579454668, 6168.074788781629, 6175.660338681416, 6176.81469555914, 6185.288691800411, 6215.844603884849, 4818.253170758538, 4849.442314133849, 4885.169521181408, 4894.412670479494, 4912.778924948315, 4297.656187504992, 4331.263685173528, 4347.760873151944, 4368.737875727466, 4387.122575484916, 5680.233168522279, 5686.97156514223, 5701.458361455655, 5703.258576385043, 5704.8859022819315, 5134.48655134491, 6222.471089957314, 6268.153799237136, 6273.12176295319, 6279.058141278753, 5532.17017447378, 5618.410066942994, 5625.915611265835, 5657.349404818417, 5702.8289151325525, 5362.892742145214, 5363.704996225167, 5383.5962302826665, 5389.434109418533, 5403.324584426947, 6324.367563243823, 6330.9050364245495, 6334.1765570475545, 6353.047042943595, 6359.7456101755415, 6016.819495415145, 6142.078688196806, 6212.627242365473, 6253.5935164216, 6286.308506064238, 6294.370562943669, 6298.590591611531, 6312.715927783169, 6316.84207894788, 6350.68246587678, 6127.189528148541, 6128.686460748492, 6143.419763699168, 6144.692765361625, 6145.248604147975, 6147.72335244924, 6227.657478838526, 6237.220347456568, 6257.561970662192, 6272.996320588684, 5898.764049437975, 5942.73257703413, 5962.612430192197, 6057.091436284592, 6070.453659170696, 6001.549883758648, 6007.879842403215, 6014.48876845473, 6019.608725432833, 6095.573309868444, 5847.94152058474, 5872.970635146797, 5873.882522349443, 5883.235179426647, 5895.852603684943, 5884.35272120075, 5949.434803693643, 5982.820515384546, 6010.519158467399, 6029.457348838626, 5787.074068149076, 5838.5621078418435, 5838.912416313674, 5846.6784326862435, 5880.411958804086], "value": 5649.1320006295455, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.27790478282134, 451.1225666079475, 471.2295397025863, 479.6594417963246, 491.5060364333843, 29864.850675746617, 37850.62149378505, 39375.0, 39558.802205988926, 39661.603383966154, 40879.59120408795, 41302.38046429306, 41344.0, 41350.793246033725, 41487.792561037226, 7869.685212591504, 9414.199793017602, 9418.905810941871, 9419.152276295132, 9428.010058943815, 8497.277731392807, 8715.738527844174, 10960.342379457219, 11210.103191744642, 11255.774884502305, 11153.832692509619, 11271.154663400237, 11369.715757106098, 11390.430478476084, 11393.259438136494, 11165.0, 11242.775144497145, 11247.606333778278, 11254.774904501905, 11257.662270131908, 8387.370947178924, 8614.784630384227, 8642.697505587274, 8719.346049046348, 8734.344924130652, 37954.81022594897, 38836.80581597102, 38858.22283554341, 39862.0, 39868.20263594741, 2738.2906639656144, 3308.024132880782, 3431.9313613727836, 3724.3668576341815, 3938.8227529760943, 23633.409164770845, 28980.855095724597, 29933.401331973455, 30114.397712045855, 30273.091807245597, 3192.393445245396, 3207.4226639204935, 3271.247613048988, 3296.324253528045, 3306.9173270668425, 498681.0, 501172.4941375306, 501304.0, 503961.0, 505185.0, 56681.7165914176, 57115.14327285094, 57221.71389143111, 57252.713736431055, 57264.42735572591, 58717.70641146767, 59631.0, 59782.0, 59786.80426391535, 60135.0, 15532.223388830513, 15747.763783543256, 15765.763513547307, 15768.92115539415, 15781.21093945321, 10937.0, 12256.632301030982, 12320.199187052813, 12343.938280308721, 12355.32045737493, 13136.40886160106, 13406.994475414383, 14733.263336833115, 15096.622584435478, 15142.54572362831, 6739.022841687928, 7061.435085193172, 7073.292670732885, 7111.146662400545, 7143.0, 880.9867851982225, 978.3787295067683, 987.807377561383, 1049.9080955805875, 1074.8495210670512, 29171.833126674694, 29345.972890949142, 29731.40537189244, 29877.850610746806, 30197.943071992373, 1001.2890847498212, 1015.6749840051112, 1045.6340280901622, 1049.4280617063566, 1064.7284942339809, 14648.414063437556, 14994.625134371729, 15126.470573529874, 15438.691226175413, 15529.990550614173, 611731.0, 615427.0, 617293.0, 619696.0, 620277.0, 49472.0, 50388.74805625949, 56451.0, 57713.0, 57757.0, 1305.6344223617402, 1346.1721041559567, 1359.5581436033328, 1382.4193838587817, 1382.7441923244232, 29647.851760741058, 29889.5516567256, 30154.396912062075, 30278.84860575683, 30311.734813462197, 48539.75730121327, 49097.754511228646, 49198.75400622974, 49273.753631231615, 49339.0, 576412.0, 578169.0, 578845.0, 579456.0, 583139.5901143439, 37323.880283591534, 37659.05852353713, 38016.619833801306, 38168.2366352677, 38177.0, 40003.99990000273, 45150.32274515819, 45740.0, 46148.307775382724, 46376.536234638574, 37602.435963460026, 37627.81186094052, 38243.09463742724, 38444.807775960944, 38641.42037869491, 37790.43314350342, 38136.85589432321, 38602.80698596489, 38632.0, 39110.608893911834, 36695.449568255965, 36781.26437471289, 37274.44088338732, 37494.0, 37704.81147594244, 30864.537031944987, 32225.677743222266, 33770.493442597886, 33790.0, 33914.96510209297, 20238.0, 21847.579907305975, 22098.668519972536, 23639.881800590887, 23647.64528532039], "value": 19638.88901764523, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.10198229647176, 356.6593902822803, 364.4605983144945, 369.36004141611244, 392.9783861887595, 14402.49591264306, 14952.0, 15528.767068493982, 19286.32497862575, 19951.700724489107, 17762.378316758917, 18267.08664566773, 18724.438266851983, 18965.24139034437, 18985.810141898575, 5549.694766787835, 5918.911216331759, 5923.88152236955, 5927.466528012478, 5931.614445061079, 5517.724113794295, 5718.428157184269, 5724.685142317171, 5776.39347868474, 5785.363610002896, 5726.427357264281, 5727.599068065237, 5730.68481233532, 5737.971310143444, 5740.827775166752, 5544.944550554504, 5645.1814486899375, 5699.715014249313, 5746.310442746855, 5748.741306641211, 4288.270993931008, 5012.949870501285, 5020.322256495363, 5025.597952163818, 5032.974835125838, 22887.313380598607, 23939.640905386434, 24545.87727061371, 24683.87658061716, 24812.751872481225, 2233.955320893573, 2352.5177338645535, 2399.292208798391, 2432.537817814627, 2452.509498100387, 13916.15516513007, 15233.466828660943, 15387.923060384739, 15469.149196794171, 15481.922590387088, 1803.8376546110783, 1849.4821449994024, 1878.8966606836618, 1986.3445063129277, 2014.264793350431, 113326.0, 116909.0, 117527.0, 117756.82243177544, 117963.84433867905, 8300.750977470685, 10933.507992140372, 11221.326720396803, 11242.831357529643, 11440.771184576262, 13939.860601393857, 14060.0, 14065.296735163201, 14083.507077252247, 14114.576562703136, 7930.405219608552, 8062.596870156469, 8150.470219435718, 8334.541600212047, 8357.58212089393, 8015.238552337519, 8019.39854510914, 8048.839023219502, 8213.589320533949, 8231.629576669064, 3513.94729079064, 4237.982884107853, 4338.631216346583, 4457.9331310030375, 4486.080353527519, 1598.8720902327786, 1838.4025191812714, 1887.3488646416963, 1893.5644801695687, 1918.4867823151717, 813.4021494201756, 861.6553378648591, 919.3334832246701, 945.5036106044382, 978.3200675530438, 17133.31466741341, 20878.0, 21009.57980840405, 21078.78921210799, 21520.677189842165, 769.3960241210734, 866.1161972709458, 928.4475736936512, 942.6182396129578, 972.7227740094039, 9934.701958941243, 10825.891741082645, 10880.67357979262, 10965.56137754497, 10998.670039898816, 549012.0, 555097.0, 556500.0, 563147.0, 568146.0, 98659.50670246602, 122631.0, 125503.0, 127766.0, 128768.35615821861, 950.4724877692947, 963.1572374172599, 1011.9190464762949, 1027.060239880501, 1028.280203857303, 18748.343807966656, 19065.04674766284, 19195.904020479808, 19232.807671923103, 19302.4209273722, 41049.0, 48784.75607621939, 51697.48302516927, 53222.43878730125, 54713.72643136759, 71061.28938710547, 71866.0, 72023.27976720166, 72049.0, 72561.0, 6423.935760642334, 7367.300106489874, 7584.2794934481135, 7802.336801371947, 7911.5253084815095, 10180.338278011906, 10271.589136434757, 11688.123390745557, 12249.571265005681, 12405.069619778373, 8963.865542016745, 10110.949445252727, 10470.84820669741, 10527.789444211227, 10665.41340226295, 10016.0, 10113.69658910234, 10116.393016419039, 10483.528241229316, 10529.42088185157, 10253.692389228336, 10417.687469375931, 10838.295510791773, 10850.45747712627, 11006.119510439306, 7495.925040749523, 7517.548947062975, 7521.548707077374, 7674.462787604814, 7821.217878212134, 9428.669996550088, 10407.15919102742, 10614.0447359738, 10782.568697252022, 10829.508016965989], "value": 9218.823745280984, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.0610125962448, 1476.9926150369247, 1504.6088017115553, 1681.251842929896, 1850.426367825973, 6902.378785909267, 7339.0, 7761.6507257173425, 8084.19158084192, 8150.796230094251, 8126.4311498195, 8225.712100076498, 8226.17738226177, 8229.177082291782, 8234.217749313806, 2030.3401394546759, 2261.2989973108306, 2302.2517681753498, 2308.803751681109, 2312.9768702313013, 2062.783407742188, 2119.8516103872735, 2254.3349711834967, 2329.9184528541505, 2343.0627748900406, 2274.2040285899884, 2292.3695983604557, 2293.151533932439, 2295.8392912496133, 2299.4596269876565, 2247.4381404648757, 2277.81777457803, 2279.4871153990384, 2279.4985103277254, 2286.588414085464, 2114.3234165067183, 2172.8918251691753, 2281.1103669568884, 2313.710786151731, 2317.3627252505526, 8212.055613604392, 8261.876071858927, 8313.625886835107, 8321.542315172663, 8338.332933365376, 4915.705057696514, 5071.518205770446, 5074.441811400743, 5080.720560369178, 5086.745662716849, 3325.2684409429885, 3464.0993341731078, 3554.608993010767, 3554.751167418282, 3571.017970058229, 996.8654231678703, 1037.5019990404649, 1074.623881641427, 1076.0692001418795, 1077.6389909380366, 10344.120749736281, 10781.353118812896, 10806.243562950596, 10806.459677016117, 10821.404822734747, 4251.59609837065, 4365.934510982338, 4379.890502737457, 4384.802683879233, 4397.582229688174, 8532.402731808714, 8538.316934645214, 8541.615627296787, 8546.31629469641, 8555.82888342242, 5042.722650254272, 5044.747762611928, 5049.267856160836, 5049.621278404061, 5050.696958182521, 4269.231538323132, 4406.008648054162, 4563.931541026887, 4674.672772905932, 4737.431508218967, 3377.527146199534, 3500.824958752052, 3523.119220194951, 3579.6599323064265, 3585.6235095315137, 1122.7810576937582, 1126.7802778458122, 1126.8253420719802, 1138.317009794117, 1142.097742783192, 843.4601854812925, 852.7441767469734, 869.9782505437288, 910.0535443139194, 942.9768700959398, 5459.2902922619805, 5490.670559766427, 5748.798792042258, 5780.364159942403, 5841.474267315877, 875.2735229759285, 897.9820403591891, 904.2359206470522, 912.0, 919.8482250428738, 3573.3746594345885, 3626.9455958160647, 3728.8694895678523, 3809.447630093621, 3830.5211848518934, 9323.393979391318, 9448.622055117856, 9482.715518534455, 9551.997040310667, 9896.851547226797, 9637.951810240904, 9793.020697930293, 9797.412155270707, 9801.215902727907, 9811.31320807551, 7419.258074192538, 7703.691852325845, 7726.497777644435, 7731.110922243902, 7744.883826742604, 4927.679700819435, 5308.0, 5310.840674779763, 5409.890972350738, 5618.775248989995, 7543.547387156788, 7954.801129971797, 8252.09226985019, 8747.343949203709, 9238.0, 7321.487495875451, 9113.270938324786, 9229.030951750237, 9338.066193380608, 9361.906380936103, 6558.278589355072, 6967.338102880219, 7020.22777494465, 7138.428925686037, 7141.642917853983, 7131.037309963089, 7443.888341674988, 7571.697132114874, 7678.232176782501, 7722.845543089219, 6988.755393561201, 7091.893621595577, 7101.715931362688, 7137.607431591312, 7246.89129663066, 6870.20992585859, 6879.828004299932, 6917.723291068301, 6993.860122797414, 7014.929850701427, 6158.538109641705, 6249.093881387264, 6355.5551111421755, 6473.158489396348, 6507.446867016357, 4730.385049943623, 4733.881652958704, 4765.070811191785, 4817.759112044454, 4897.142999975062, 4245.936310955276, 4315.9352609711505, 4810.326554282333, 4829.227323628203, 4913.70517768935], "value": 4282.059109262339, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.32370798680927, 337.08313387585764, 341.6515154542367, 352.92941411717663, 354.2383874669459, 4707.505711900252, 4940.728259945706, 5378.52090675064, 5383.730813459331, 5424.1321388577835, 4719.787609557569, 5274.182501712241, 5289.206619007141, 5372.328458942632, 5377.946220537793, 3367.3433680432204, 3431.1765176357744, 3616.9691637883207, 3929.7052721045893, 4044.3124668806227, 4116.855910043149, 4149.190907772985, 4164.354525048622, 4196.307609244471, 4202.495700515927, 3116.6727493613184, 3922.8038598070125, 4061.2283666103494, 4063.6952228582827, 4131.153113611703, 3238.5951756030495, 3381.8140002299865, 3950.486436763202, 4144.295469770146, 4174.645155161815, 2752.628395166647, 3592.389293820057, 3615.349237137314, 3625.0, 3678.5585729712607, 4021.6380525752825, 5115.5396014358885, 5165.560927321182, 5183.682443236332, 5331.680099194061, 4109.239790638741, 4164.271827191742, 4423.933640995388, 4741.857744267678, 4756.619470442391, 5474.644148130398, 5570.498655121018, 5620.91568626471, 5657.349404818417, 5666.603337766358, 3646.835892384849, 3745.494358261627, 3992.2414741199077, 4004.9199016019516, 4035.0, 5503.3395992480355, 5822.039363505017, 5847.970760146214, 5855.882882342372, 5862.765489380419, 3287.408266512051, 3759.7368184226843, 3837.6162383761402, 3858.5176852893387, 3865.7487263327794, 3402.9450870230307, 3597.982010089933, 3795.2409518096492, 3915.9426954722067, 3939.212157568498, 3944.36890097583, 4529.9547004530195, 4547.249309015987, 4554.294084416921, 4577.725336479822, 4735.4428608551, 4762.880927976828, 5060.569851562658, 5163.974180129076, 5307.6284660073425, 1134.9602763903224, 1254.1158483269273, 1258.6475786779715, 1265.8733726982994, 1288.672667152834, 807.2169995104856, 841.7769291137853, 854.7520619895023, 860.832137733136, 866.2377108144918, 4240.067185219247, 4432.556744325541, 4965.329680493087, 5042.193249080129, 5063.5695965843315, 5365.731713414314, 5808.224653974866, 5850.707464626752, 5856.795012174553, 5896.498797602252, 4731.739754313546, 4875.609951203966, 5028.748562571856, 5278.4721527846905, 5322.33470816148, 2665.4939958923146, 2671.358873870257, 2787.665480142396, 2892.363679990399, 2955.5418910068975, 5070.400015988689, 5771.769129234784, 5778.595498315078, 5850.824475265749, 5881.911771323434, 4811.374521312207, 5442.83671489848, 5582.074184406373, 5702.82891513247, 5746.569007324468, 5710.685912274865, 5734.22587950638, 5735.971320143372, 6063.484603808637, 6103.298120716086, 5139.8458046258675, 5372.379753411984, 5727.627704199213, 5893.322267939242, 5904.6161999471615, 5110.642255042111, 5380.632521690443, 5632.352279487911, 5699.572532060195, 5708.686022268815, 5105.540501354896, 5501.422350653123, 5579.8047068354035, 6053.969730151321, 6056.848578785565, 3632.7275454341557, 3871.496705428276, 3883.514560679915, 3884.3008258513737, 3902.6292502212245, 4768.451628062817, 5482.369527504228, 5579.744557474536, 5863.120531920246, 5881.235439392852, 4629.421322334708, 4997.475265097258, 5646.237757902795, 5647.971760141338, 5680.40355762639, 4573.542645735533, 4774.045190961752, 5186.351706036746, 5465.426130256265, 5521.806736764194, 5350.238287923673, 5369.624126311121, 5471.261379713687, 5568.656447970589, 5628.718564071862, 4582.8836391252935, 4720.362751028704, 5073.7675422813845, 5419.647722897999, 5729.817233419543, 5105.6426050177615, 5341.545968592558, 5448.0, 5583.1904373864745, 5615.129654903497], "value": 4039.235710239975, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.8177955511121, 735.5623404074573, 735.6321839080459, 770.8920751094847, 780.6994307191729, 14476.348564314605, 14931.776023359658, 15041.62395940102, 15075.924620376896, 15099.245037748124, 13360.265185414799, 13552.18686878788, 13554.322283885816, 13609.863901360983, 13614.183149011067, 679.1205389021229, 706.8515611721544, 709.5707097206193, 714.1037997313365, 843.3169133002273, 706.0961968680098, 711.5446114486732, 832.4755404095412, 868.0061329777401, 873.8645509945968, 902.2421166220373, 913.2693844924067, 913.9405938613969, 915.9129882661136, 916.8395530782086, 908.513945039404, 910.4946754551221, 912.2473958983865, 912.3020889019905, 912.3704643795793, 517.3016427822447, 679.0764560198127, 680.6052489556046, 680.6426626021329, 681.0533358631507, 11828.231164974335, 12984.610461686165, 13504.392302346418, 13612.31938403076, 13932.164070155723, 13154.671133221746, 13278.668033299246, 13311.938254201588, 13361.924612993032, 13430.918207677825, 9903.90096099037, 11544.826827597593, 11656.30062196271, 11682.883171168265, 11703.2978021319, 3674.1182116292166, 3675.1730860556427, 3678.282734866702, 3758.906027349311, 3801.9619803801884, 86753.56623216906, 103872.48063759632, 106180.46909765479, 106974.0, 107635.46182269117, 8446.66213351459, 9885.901140988643, 9965.152961998167, 10054.899451005396, 10531.0, 17703.734443983092, 21161.0, 21328.0, 21576.568468630852, 21636.89181554082, 7573.318401343795, 7574.204708505527, 7605.315521603082, 7610.885836712454, 7678.61606919663, 4114.958850411457, 4214.4099826024385, 4238.703290769617, 4260.339647354665, 4271.10306835568, 3517.3668739627115, 3543.344481270973, 3556.87550935716, 3594.2092739597247, 3626.4741612466046, 635.5995722694673, 642.5502148496072, 643.5816719132602, 653.7221680785742, 655.9048937903978, 567.2059117235902, 579.8492391978116, 625.5996162456032, 655.2308766330925, 687.5221720904024, 8855.73432797017, 9086.86369704455, 9204.447733136034, 9224.077592240856, 9948.502574871227, 617.8486270863667, 619.8543342314553, 683.9555428897205, 685.5441131647498, 688.4561196654587, 3956.584558621303, 4438.889027774331, 4466.307722303049, 4535.795889184995, 4666.673332866667, 75629.62185189039, 84415.0, 84890.0, 107585.4620726907, 111413.0, 82692.58653706693, 92003.539982301, 92923.0, 94172.0, 96410.51794740981, 56102.15846762302, 78223.0, 80174.0, 80369.59815200887, 82627.5868620653, 9525.380850244712, 9827.164691001344, 9875.111239988435, 9886.802263954825, 9901.851472228067, 50052.998940021724, 52920.73539632277, 53486.732566338476, 54654.453455464936, 54852.0, 74275.6286218587, 74322.62838685772, 77085.61457192678, 79510.0, 82527.81041421798, 12969.416376262901, 12993.350332483527, 13015.674608134494, 13059.542915997894, 13098.476060957455, 12037.960046253796, 14561.92719036398, 14749.410023598935, 14796.038257513228, 14868.62828429298, 13544.187348759106, 13632.795508067586, 13696.31518424055, 13868.0, 14230.430782768573, 13496.987725920399, 13619.0, 13938.0, 14129.576112716635, 14275.0, 13296.468141274241, 13691.794623080861, 13693.863061369259, 13871.861281387057, 14159.929200353932, 9895.901040989498, 10340.172786176938, 10907.236493445384, 11103.611373601885, 11537.538498459968, 9852.310338276251, 11230.719232019264, 11551.595694151001, 11578.478968446609, 11581.43650607191], "value": 7328.506339513317, "unit": "score"}], "name": "dromaeo_css", "value": 7114.290287232308, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 113.0, 112.0, 114.0, 114.0, 114.0, 114.0, 112.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 114.0, 119.0, 183.0, 145.0, 133.0, 115.0, 115.0, 132.0, 115.0], "value": 132.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 181.0, 182.0, 187.0, 182.0, 183.0, 181.0, 183.0, 183.0, 182.0], "value": 182.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 59.0, 87.0, 62.0, 59.0, 59.0, 58.0, 80.0, 57.0], "value": 65.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 85.0, 68.0, 68.0, 68.0, 85.0, 68.0, 68.0, 109.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 110.0, 113.0, 110.0, 112.0, 110.0, 113.0, 110.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 98.0, 98.0, 98.0, 97.0, 98.0, 126.0, 120.0, 95.0, 95.0], "value": 102.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 100.0, 139.0, 142.0, 84.0, 142.0, 134.0, 107.0, 85.0], "value": 110.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 53.0, 54.0, 55.0, 57.0, 55.0, 55.0, 56.0, 56.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 74.0, 75.0, 76.0, 74.0, 71.0, 71.0, 71.0, 72.0, 72.0], "value": 72.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 87.0, 91.0, 88.0, 88.0, 87.0, 89.0, 89.0, 91.0], "value": 89.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 158.0, 153.0, 139.0, 140.0, 154.0, 152.0, 151.0, 197.0, 147.0], "value": 156.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 178.0, 175.0, 181.0, 180.0, 176.0, 177.0, 178.0, 177.0, 193.0], "value": 179.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 82.0, 87.0, 88.0, 90.0, 67.0, 67.0, 69.0, 69.0, 68.0], "value": 75.9, "unit": "score"}], "name": "kraken", "value": 1524.1, "alertThreshold": 2.0}]} 17:46:24 INFO - Return code: 0 17:46:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:46:24 INFO - # TBPL SUCCESS # 17:46:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:46:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:46:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:46:24 INFO - 2016-12-14 17:46:24.691 screenresolution[1960:15293] starting screenresolution argv=screenresolution get 17:46:24 INFO - 2016-12-14 17:46:24.693 screenresolution[1960:15293] Display 0: 1600x1200x32@60 17:46:24 INFO - 2016-12-14 17:46:24.700 screenresolution[1961:15296] starting screenresolution argv=screenresolution list 17:46:24 INFO - Available Modes on Display 0 17:46:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:46:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:46:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:46:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:46:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:46:24 INFO - Intel Iris: 17:46:24 INFO - Chipset Model: Intel Iris 17:46:24 INFO - Type: GPU 17:46:24 INFO - Bus: Built-In 17:46:24 INFO - VRAM (Dynamic, Max): 1536 MB 17:46:24 INFO - Vendor: Intel (0x8086) 17:46:24 INFO - Device ID: 0x0a2e 17:46:24 INFO - Revision ID: 0x0009 17:46:24 INFO - Displays: 17:46:24 INFO - Display: 17:46:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:46:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:46:24 INFO - Display Serial Number: 1600x1200 60 17:46:24 INFO - Main Display: Yes 17:46:24 INFO - Mirror: Off 17:46:24 INFO - Online: Yes 17:46:24 INFO - Rotation: Supported 17:46:24 INFO - Return code: 0 17:46:24 INFO - Running post-action listener: _resource_record_post_action 17:46:24 INFO - [mozharness: 2016-12-15 01:46:24.937313Z] Finished run-tests step (success) 17:46:24 INFO - Running post-run listener: _resource_record_post_run 17:46:24 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 2039808; Write bytes: 547015168; Read time: 14; Write time: 1652 17:46:24 INFO - TinderboxPrint: CPU usage
53.7% 17:46:24 INFO - TinderboxPrint: I/O read bytes / time
2,039,808 / 14 17:46:24 INFO - TinderboxPrint: I/O write bytes / time
547,015,168 / 1,652 17:46:24 INFO - TinderboxPrint: CPU idle
2,224.7 (46.3%) 17:46:24 INFO - TinderboxPrint: CPU system
964.9 (20.1%) 17:46:24 INFO - TinderboxPrint: CPU user
1,620.0 (33.7%) 17:46:24 INFO - TinderboxPrint: Swap in / out
251,842,560 / 0 17:46:25 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 250305024; Write bytes: 250290176; Read time: 18135; Write time: 549 17:46:25 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 1064960; Write bytes: 295188992; Read time: 12; Write time: 1089 17:46:25 INFO - Running post-run listener: _upload_blobber_files 17:46:25 INFO - Blob upload gear active. 17:46:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:46:25 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 17:46:25 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'] 17:46:25 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 17:46:25 INFO - (blobuploader) - INFO - Open directory for files ... 17:46:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:46:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:46:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:46:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:46:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:46:26 INFO - (blobuploader) - INFO - Done attempting. 17:46:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:46:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:46:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:46:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:46:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:46:27 INFO - (blobuploader) - INFO - Done attempting. 17:46:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:46:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:46:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:46:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:46:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:46:29 INFO - (blobuploader) - INFO - Done attempting. 17:46:29 INFO - (blobuploader) - INFO - Iteration through files over. 17:46:29 INFO - Return code: 0 17:46:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:46:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:46:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c3277247123a3f84ef9452f032003eb2d7884bc7e5ee4952ad92032ba602067e815774420b413f7ae40e36175583946e323a4929556b4cf5512901b2bef40db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f65ad112810fe0286308b1370be267059de13a9fec050eba35e1cf0162b539527210fcf44ad333a018b8cd121838d41fd42c88db3c0f9d59cd9827f485098d57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b91157fb5edb45a8a1c3b461ca1b39973b966c2fa444799405de7aec3384ab11ea5a94b907b3e133ad6b4c36b92a14c6e83e1ce92e46baa16827834b240fe744"} 17:46:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:46:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:46:29 INFO - Contents: 17:46:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c3277247123a3f84ef9452f032003eb2d7884bc7e5ee4952ad92032ba602067e815774420b413f7ae40e36175583946e323a4929556b4cf5512901b2bef40db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f65ad112810fe0286308b1370be267059de13a9fec050eba35e1cf0162b539527210fcf44ad333a018b8cd121838d41fd42c88db3c0f9d59cd9827f485098d57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b91157fb5edb45a8a1c3b461ca1b39973b966c2fa444799405de7aec3384ab11ea5a94b907b3e133ad6b4c36b92a14c6e83e1ce92e46baa16827834b240fe744"} 17:46:29 INFO - Running post-run listener: copy_logs_to_upload_dir 17:46:29 INFO - Copying logs to upload dir... 17:46:29 INFO - mkdir: /builds/slave/test/build/upload/logs 17:46:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.343465 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-12-14 17:46:29.902854) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-14 17:46:29.906539) ========= 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.4HnDupuN8s/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.JngHKYhDqG/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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/6c3277247123a3f84ef9452f032003eb2d7884bc7e5ee4952ad92032ba602067e815774420b413f7ae40e36175583946e323a4929556b4cf5512901b2bef40db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f65ad112810fe0286308b1370be267059de13a9fec050eba35e1cf0162b539527210fcf44ad333a018b8cd121838d41fd42c88db3c0f9d59cd9827f485098d57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b91157fb5edb45a8a1c3b461ca1b39973b966c2fa444799405de7aec3384ab11ea5a94b907b3e133ad6b4c36b92a14c6e83e1ce92e46baa16827834b240fe744"} build_url:https://queue.taskcluster.net/v1/task/OpBXSswwQ12yWaJ4jiDqOg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011121 build_url: 'https://queue.taskcluster.net/v1/task/OpBXSswwQ12yWaJ4jiDqOg/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/6c3277247123a3f84ef9452f032003eb2d7884bc7e5ee4952ad92032ba602067e815774420b413f7ae40e36175583946e323a4929556b4cf5512901b2bef40db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f65ad112810fe0286308b1370be267059de13a9fec050eba35e1cf0162b539527210fcf44ad333a018b8cd121838d41fd42c88db3c0f9d59cd9827f485098d57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b91157fb5edb45a8a1c3b461ca1b39973b966c2fa444799405de7aec3384ab11ea5a94b907b3e133ad6b4c36b92a14c6e83e1ce92e46baa16827834b240fe744"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-14 17:46:29.942064) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 17:46:29.942820) ========= 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.4HnDupuN8s/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.JngHKYhDqG/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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.005282 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 17:46:29.992940) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-14 17:46:29.993316) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-14 17:46:29.993648) ========= ========= Total master_lag: 0.22 =========