builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0163 starttime: 1484748084.73 results: success (0) buildid: 20170118050726 builduid: df04d57f2cf54ee894856e3245d52267 revision: 8fcc95d1411532306d08b49471214e0f0fcd7a8c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-18 06:01:24.730503) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-18 06:01:24.730983) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-18 06:01:24.731264) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-18 06:01:24.760900) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 06:01:24.761259) ========= 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.uogyfgLNx6/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.kdfolJLwDw/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-18 06:01:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.9M=0.001s 2017-01-18 06:01:25 (15.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.152183 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 06:01:24.937541) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 06:01:24.937901) ========= 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.uogyfgLNx6/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.kdfolJLwDw/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.028142 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 06:01:24.992196) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-18 06:01:24.992557) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 8fcc95d1411532306d08b49471214e0f0fcd7a8c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 8fcc95d1411532306d08b49471214e0f0fcd7a8c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uogyfgLNx6/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.kdfolJLwDw/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-18 06:01:25,639 truncating revision to first 12 chars 2017-01-18 06:01:25,639 Setting DEBUG logging. 2017-01-18 06:01:25,639 attempt 1/10 2017-01-18 06:01:25,639 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/8fcc95d14115?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-18 06:01:26,693 unpacking tar archive at: graphics-8fcc95d14115/testing/mozharness/ program finished with exit code 0 elapsedTime=1.325152 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-18 06:01:26.341727) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-18 06:01:26.345070) ========= script_repo_revision: 8fcc95d1411532306d08b49471214e0f0fcd7a8c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-18 06:01:26.345464) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-18 06:01:26.345723) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-18 06:01:26.365665) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-18 06:01:26.366046) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uogyfgLNx6/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.kdfolJLwDw/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 06:01:27 INFO - MultiFileLogger online at 20170118 06:01:27 in /builds/slave/test 06:01:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 06:01:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:01:27 INFO - {'append_to_log': False, 06:01:27 INFO - 'base_work_dir': '/builds/slave/test', 06:01:27 INFO - 'blob_upload_branch': 'Graphics', 06:01:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:01:27 INFO - 'branch': 'Graphics', 06:01:27 INFO - 'buildbot_json_path': 'buildprops.json', 06:01:27 INFO - 'config_files': ('talos/mac_config.py',), 06:01:27 INFO - 'default_actions': ('clobber', 06:01:27 INFO - 'read-buildbot-config', 06:01:27 INFO - 'download-and-extract', 06:01:27 INFO - 'populate-webroot', 06:01:27 INFO - 'create-virtualenv', 06:01:27 INFO - 'install', 06:01:27 INFO - 'run-tests'), 06:01:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:01:27 INFO - 'download_minidump_stackwalk': True, 06:01:27 INFO - 'download_symbols': 'ondemand', 06:01:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:01:27 INFO - 'tooltool.py': '/tools/tooltool.py', 06:01:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:01:27 INFO - '/tools/misc-python/virtualenv.py')}, 06:01:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:01:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:01:27 INFO - 'installer_path': 'installer.exe', 06:01:27 INFO - 'log_level': 'info', 06:01:27 INFO - 'log_name': 'talos', 06:01:27 INFO - 'log_to_console': True, 06:01:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:01:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:01:27 INFO - 'opt_config_files': (), 06:01:27 INFO - 'pip_index': False, 06:01:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:01:27 INFO - 'cmd': ('bash', 06:01:27 INFO - '-c', 06:01:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:01:27 INFO - 'enabled': True, 06:01:27 INFO - 'halt_on_failure': False, 06:01:27 INFO - 'name': 'check_screen_resolution'},), 06:01:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:01:27 INFO - 'cmd': ('bash', 06:01:27 INFO - '-c', 06:01:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:01:27 INFO - 'enabled': True, 06:01:27 INFO - 'halt_on_failure': False, 06:01:27 INFO - 'name': 'check_screen_resolution'},), 06:01:27 INFO - 'run_cmd_checks_enabled': True, 06:01:27 INFO - 'sps_profile': False, 06:01:27 INFO - 'sps_profile_interval': 0, 06:01:27 INFO - 'suite': 'dromaeojs', 06:01:27 INFO - 'system_bits': '32', 06:01:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:01:27 INFO - 'title': 't-yosemite-r7-0163', 06:01:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:01:27 INFO - 'use_talos_json': True, 06:01:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:01:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:01:27 INFO - 'work_dir': 'build'} 06:01:27 INFO - [mozharness: 2017-01-18 14:01:27.125083Z] Running clobber step. 06:01:27 INFO - Running pre-action listener: _resource_record_pre_action 06:01:27 INFO - Running main action method: clobber 06:01:27 INFO - rmtree: /builds/slave/test/build 06:01:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:01:29 INFO - Running post-action listener: _resource_record_post_action 06:01:29 INFO - [mozharness: 2017-01-18 14:01:29.589911Z] Finished clobber step (success) 06:01:29 INFO - [mozharness: 2017-01-18 14:01:29.590040Z] Running read-buildbot-config step. 06:01:29 INFO - Running pre-action listener: _resource_record_pre_action 06:01:29 INFO - Running main action method: read_buildbot_config 06:01:29 INFO - Using buildbot properties: 06:01:29 INFO - { 06:01:29 INFO - "project": "", 06:01:29 INFO - "product": "firefox", 06:01:29 INFO - "script_repo_revision": "default", 06:01:29 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 06:01:29 INFO - "repository": "", 06:01:29 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 06:01:29 INFO - "buildid": "20170118050726", 06:01:29 INFO - "pgo_build": "False", 06:01:29 INFO - "basedir": "/builds/slave/test", 06:01:29 INFO - "buildnumber": 11, 06:01:29 INFO - "slavename": "t-yosemite-r7-0163", 06:01:29 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 06:01:29 INFO - "platform": "yosemite_r7", 06:01:29 INFO - "scheduler": "tests-graphics-macosx64-talos", 06:01:29 INFO - "branch": "graphics", 06:01:29 INFO - "repo_path": "projects/graphics", 06:01:29 INFO - "revision": "8fcc95d1411532306d08b49471214e0f0fcd7a8c", 06:01:29 INFO - "stage_platform": "macosx64", 06:01:29 INFO - "builduid": "df04d57f2cf54ee894856e3245d52267", 06:01:29 INFO - "slavebuilddir": "test" 06:01:29 INFO - } 06:01:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 06:01:29 INFO - Running post-action listener: _resource_record_post_action 06:01:29 INFO - [mozharness: 2017-01-18 14:01:29.593530Z] Finished read-buildbot-config step (success) 06:01:29 INFO - [mozharness: 2017-01-18 14:01:29.593618Z] Running download-and-extract step. 06:01:29 INFO - Running pre-action listener: _resource_record_pre_action 06:01:29 INFO - Running main action method: download_and_extract 06:01:29 INFO - mkdir: /builds/slave/test/build/tests 06:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:29 INFO - trying https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 06:01:29 INFO - Downloading https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/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 06:01:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/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 06:01:30 INFO - Downloaded 1199 bytes. 06:01:30 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 06:01:30 INFO - Using the following test package requirements: 06:01:30 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 06:01:30 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:01:30 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 06:01:30 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:01:30 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 06:01:30 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:01:30 INFO - u'jsshell-mac.zip'], 06:01:30 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:01:30 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 06:01:30 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 06:01:30 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:01:30 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 06:01:30 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:01:30 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 06:01:30 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:01:30 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 06:01:30 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:01:30 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 06:01:30 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:01:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 06:01:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:01:30 INFO - Fetch https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 06:01:31 INFO - Expected file size: 16326547 06:01:31 INFO - Obtained file size: 16326547 06:01: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 06:01:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 06:01:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:01:38 INFO - Fetch https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 06:01:39 INFO - Expected file size: 16326547 06:01:39 INFO - Obtained file size: 16326547 06:01:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 06:01:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:01:45 INFO - Fetch https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 06:01:47 INFO - Expected file size: 14403463 06:01:47 INFO - Obtained file size: 14403463 06:01:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:01:48 INFO - trying https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 06:01:48 INFO - Downloading https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 06:01:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/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 06:01:50 INFO - Downloaded 70310782 bytes. 06:01:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 06:01:50 INFO - mkdir: /builds/slave/test/properties 06:01:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:01:50 INFO - Writing to file /builds/slave/test/properties/build_url 06:01:50 INFO - Contents: 06:01:50 INFO - build_url:https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 06:01:50 INFO - Running post-action listener: _resource_record_post_action 06:01:50 INFO - Running post-action listener: set_extra_try_arguments 06:01:50 INFO - [mozharness: 2017-01-18 14:01:50.676713Z] Finished download-and-extract step (success) 06:01:50 INFO - [mozharness: 2017-01-18 14:01:50.676835Z] Running populate-webroot step. 06:01:50 INFO - Running pre-action listener: _resource_record_pre_action 06:01:50 INFO - Running main action method: populate_webroot 06:01:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:01:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:01:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:01:50 INFO - '--tppagecycles', 06:01:50 INFO - '7'], 06:01:50 INFO - 'tests': ['tsvgm']}}, 06:01:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:01:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:01:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:01:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:01:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:01:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:01:50 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:01:50 INFO - 'talos_options': ['--disable-e10s'], 06:01:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:01:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:01:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:01:50 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:01:50 INFO - 'talos_options': ['--disable-e10s'], 06:01:50 INFO - 'tests': ['damp', 'tps']}, 06:01:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:01:50 INFO - 'tests': ['damp', 'tps']}, 06:01:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:01:50 INFO - 'tests': ['dromaeo_dom']}, 06:01:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:01:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:01:50 INFO - 'tests': ['basic_compositor_video']}, 06:01:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:01:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:01:50 INFO - 'tests': ['a11yr', 06:01:50 INFO - 'ts_paint', 06:01:50 INFO - 'tpaint', 06:01:50 INFO - 'sessionrestore', 06:01:50 INFO - 'sessionrestore_no_auto_restore', 06:01:50 INFO - 'tabpaint']}, 06:01:50 INFO - 'other-e10s': {'tests': ['a11yr', 06:01:50 INFO - 'ts_paint', 06:01:50 INFO - 'tpaint', 06:01:50 INFO - 'sessionrestore', 06:01:50 INFO - 'sessionrestore_no_auto_restore', 06:01:50 INFO - 'tabpaint']}, 06:01:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:01:50 INFO - 'ts_paint', 06:01:50 INFO - 'tpaint', 06:01:50 INFO - 'sessionrestore', 06:01:50 INFO - 'sessionrestore_no_auto_restore', 06:01:50 INFO - 'tabpaint']}, 06:01:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:01:50 INFO - 'ts_paint', 06:01:50 INFO - 'tpaint', 06:01:50 INFO - 'sessionrestore', 06:01:50 INFO - 'sessionrestore_no_auto_restore', 06:01:50 INFO - 'tabpaint']}, 06:01:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:01:50 INFO - 'tests': ['a11yr', 06:01:50 INFO - 'ts_paint', 06:01:50 INFO - 'tpaint', 06:01:50 INFO - 'sessionrestore', 06:01:50 INFO - 'sessionrestore_no_auto_restore', 06:01:50 INFO - 'tabpaint']}, 06:01:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:01:50 INFO - 'tests': ['a11yr', 06:01:50 INFO - 'ts_paint', 06:01:50 INFO - 'tpaint', 06:01:50 INFO - 'sessionrestore', 06:01:50 INFO - 'sessionrestore_no_auto_restore', 06:01:50 INFO - 'tabpaint']}, 06:01:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:01:50 INFO - 'tests': ['tsvgx', 06:01:50 INFO - 'tsvgr_opacity', 06:01:50 INFO - 'tart', 06:01:50 INFO - 'tscrollx', 06:01:50 INFO - 'cart', 06:01:50 INFO - 'tsvg_static']}, 06:01:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:01:50 INFO - 'tsvgr_opacity', 06:01:50 INFO - 'tart', 06:01:50 INFO - 'tscrollx', 06:01:50 INFO - 'cart', 06:01:50 INFO - 'tsvg_static']}, 06:01:50 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:01:50 INFO - 'talos_options': ['--disable-e10s'], 06:01:50 INFO - 'tests': ['tp5o']}, 06:01:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:01:50 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:01:50 INFO - 'talos_options': ['--disable-e10s', 06:01:50 INFO - '--xperf_path', 06:01:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:01:50 INFO - 'tests': ['tp5n']}, 06:01:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:01:50 INFO - 'talos_options': ['--xperf_path', 06:01:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:01:50 INFO - 'tests': ['tp5n']}}, 06:01:50 INFO - 'talos.zip': {'path': '', 06:01:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:01:50 INFO - Running post-action listener: _resource_record_post_action 06:01:50 INFO - [mozharness: 2017-01-18 14:01:50.695678Z] Finished populate-webroot step (success) 06:01:50 INFO - [mozharness: 2017-01-18 14:01:50.695791Z] Running create-virtualenv step. 06:01:50 INFO - Running pre-action listener: _resource_record_pre_action 06:01:50 INFO - Running main action method: create_virtualenv 06:01:50 INFO - Creating virtualenv /builds/slave/test/build/venv 06:01: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 06:01:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:01:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:01:50 INFO - Using real prefix '/tools/python27' 06:01:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:01:51 INFO - Installing distribute.............................................................................................................................................................................................done. 06:01:54 INFO - Installing pip.................done. 06:01:54 INFO - Return code: 0 06:01:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:01:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:01:54 INFO - Reading from file tmpfile_stdout 06:01:54 INFO - Output received: 06:01: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) 06:01:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:01: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')]} 06:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01: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')]} 06:01:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01: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 0x10653db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106540768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff95b46fbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10631bd30>, '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 0x106242db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106310be8>, '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.uogyfgLNx6/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.kdfolJLwDw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 06:01: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 06:01: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 06:01:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uogyfgLNx6/Render', 06:01:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:01:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:01:54 INFO - 'HOME': '/Users/cltbld', 06:01:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:01:54 INFO - 'LOGNAME': 'cltbld', 06:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:54 INFO - 'MOZ_NO_REMOTE': '1', 06:01:54 INFO - 'NO_EM_RESTART': '1', 06:01:54 INFO - 'PAGER': '/bin/cat', 06:01:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:54 INFO - 'PWD': '/builds/slave/test', 06:01:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:01:54 INFO - 'SHELL': '/bin/bash', 06:01:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kdfolJLwDw/Listeners', 06:01:54 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:01:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:01:54 INFO - 'USER': 'cltbld', 06:01:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:01:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:54 INFO - 'XPC_FLAGS': '0x0', 06:01:54 INFO - 'XPC_SERVICE_NAME': '0', 06:01:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:01:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01: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 06:01:54 INFO - Cleaning up... 06:01:54 INFO - Return code: 0 06:01:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:01: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')]} 06:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01: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')]} 06:01:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01: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 0x10653db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106540768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff95b46fbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10631bd30>, '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 0x106242db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106310be8>, '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.uogyfgLNx6/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.kdfolJLwDw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 06:01: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 06:01: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 06:01:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uogyfgLNx6/Render', 06:01:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:01:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:01:54 INFO - 'HOME': '/Users/cltbld', 06:01:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:01:54 INFO - 'LOGNAME': 'cltbld', 06:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:54 INFO - 'MOZ_NO_REMOTE': '1', 06:01:54 INFO - 'NO_EM_RESTART': '1', 06:01:54 INFO - 'PAGER': '/bin/cat', 06:01:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:54 INFO - 'PWD': '/builds/slave/test', 06:01:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:01:54 INFO - 'SHELL': '/bin/bash', 06:01:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kdfolJLwDw/Listeners', 06:01:54 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:01:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:01:54 INFO - 'USER': 'cltbld', 06:01:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:01:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:54 INFO - 'XPC_FLAGS': '0x0', 06:01:54 INFO - 'XPC_SERVICE_NAME': '0', 06:01:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:01:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:55 INFO - Downloading/unpacking psutil>=3.1.1 06:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:01:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:01:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:01:58 INFO - Installing collected packages: psutil 06:01:58 INFO - Running setup.py install for psutil 06:01:58 INFO - building 'psutil._psutil_osx' extension 06:01: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 06:01:59 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 06:01:59 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 06:01:59 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 06:01:59 INFO - building 'psutil._psutil_posix' extension 06:01:59 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 06:01:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:01:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:01:59 INFO - ^ 06:01:59 INFO - 1 warning generated. 06:01:59 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 06:01:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:01:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:01:59 INFO - Successfully installed psutil 06:01:59 INFO - Cleaning up... 06:01:59 INFO - Return code: 0 06:01:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:01: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')]} 06:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01: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')]} 06:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01: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 0x10653db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106540768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff95b46fbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10631bd30>, '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 0x106242db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106310be8>, '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.uogyfgLNx6/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.kdfolJLwDw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 06:01: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 06:01: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 06:01:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uogyfgLNx6/Render', 06:01:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:01:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:01:59 INFO - 'HOME': '/Users/cltbld', 06:01:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:01:59 INFO - 'LOGNAME': 'cltbld', 06:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:59 INFO - 'MOZ_NO_REMOTE': '1', 06:01:59 INFO - 'NO_EM_RESTART': '1', 06:01:59 INFO - 'PAGER': '/bin/cat', 06:01:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:59 INFO - 'PWD': '/builds/slave/test', 06:01:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:01:59 INFO - 'SHELL': '/bin/bash', 06:01:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kdfolJLwDw/Listeners', 06:01:59 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:01:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:01:59 INFO - 'USER': 'cltbld', 06:01:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:01:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:59 INFO - 'XPC_FLAGS': '0x0', 06:01:59 INFO - 'XPC_SERVICE_NAME': '0', 06:01:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:02:00 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 06:02:00 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 06:02:00 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 06:02:00 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 06:02:00 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 06:02:00 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 06:02:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:02:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:02:02 INFO - Installing collected packages: mozsystemmonitor 06:02:02 INFO - Running setup.py install for mozsystemmonitor 06:02:03 INFO - Successfully installed mozsystemmonitor 06:02:03 INFO - Cleaning up... 06:02:03 INFO - Return code: 0 06:02:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:02:03 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')]} 06:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:03 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')]} 06:02:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:03 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 0x10653db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106540768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff95b46fbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10631bd30>, '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 0x106242db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106310be8>, '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.uogyfgLNx6/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.kdfolJLwDw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 06:02:03 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 06:02:03 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 06:02:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uogyfgLNx6/Render', 06:02:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:02:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:02:03 INFO - 'HOME': '/Users/cltbld', 06:02:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:02:03 INFO - 'LOGNAME': 'cltbld', 06:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:03 INFO - 'MOZ_NO_REMOTE': '1', 06:02:03 INFO - 'NO_EM_RESTART': '1', 06:02:03 INFO - 'PAGER': '/bin/cat', 06:02:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:03 INFO - 'PWD': '/builds/slave/test', 06:02:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:02:03 INFO - 'SHELL': '/bin/bash', 06:02:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kdfolJLwDw/Listeners', 06:02:03 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:02:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:02:03 INFO - 'USER': 'cltbld', 06:02:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:02:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:03 INFO - 'XPC_FLAGS': '0x0', 06:02:03 INFO - 'XPC_SERVICE_NAME': '0', 06:02:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:02:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:03 INFO - Downloading/unpacking jsonschema==2.5.1 06:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:02:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:02: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 06:02: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 06:02: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 06:02: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 06:02: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 06:02: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 06:02:06 INFO - Downloading functools32-3.2.3-2.tar.gz 06:02:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:02:06 INFO - warning: no files found matching '*.txt' 06:02:06 INFO - no previously-included directories found matching 'build' 06:02:06 INFO - no previously-included directories found matching 'dist' 06:02:06 INFO - no previously-included directories found matching '.git*' 06:02:06 INFO - Installing collected packages: jsonschema, functools32 06:02:06 INFO - Running setup.py install for functools32 06:02:06 INFO - warning: no files found matching '*.txt' 06:02:06 INFO - no previously-included directories found matching 'build' 06:02:06 INFO - no previously-included directories found matching 'dist' 06:02:06 INFO - no previously-included directories found matching '.git*' 06:02:06 INFO - Successfully installed jsonschema functools32 06:02:06 INFO - Cleaning up... 06:02:06 INFO - Return code: 0 06:02:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:02: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')]} 06:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02: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')]} 06:02:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02: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', '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 0x10653db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106540768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff95b46fbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10631bd30>, '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 0x106242db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106310be8>, '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.uogyfgLNx6/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.kdfolJLwDw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 06:02: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:02: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 functools32==3.2.3-2 06:02:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uogyfgLNx6/Render', 06:02:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:02:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:02:06 INFO - 'HOME': '/Users/cltbld', 06:02:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:02:06 INFO - 'LOGNAME': 'cltbld', 06:02:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:06 INFO - 'MOZ_NO_REMOTE': '1', 06:02:06 INFO - 'NO_EM_RESTART': '1', 06:02:06 INFO - 'PAGER': '/bin/cat', 06:02:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:02:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:06 INFO - 'PWD': '/builds/slave/test', 06:02:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:02:06 INFO - 'SHELL': '/bin/bash', 06:02:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kdfolJLwDw/Listeners', 06:02:06 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:02:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:02:06 INFO - 'USER': 'cltbld', 06:02:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:02:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:02:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:06 INFO - 'XPC_FLAGS': '0x0', 06:02:06 INFO - 'XPC_SERVICE_NAME': '0', 06:02:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:02:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:02:07 INFO - Cleaning up... 06:02:07 INFO - Return code: 0 06:02:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10653db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106540768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff95b46fbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10631bd30>, '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 0x106242db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106310be8>, '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.uogyfgLNx6/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.kdfolJLwDw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 06:02:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:02:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:02:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uogyfgLNx6/Render', 06:02:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:02:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:02:07 INFO - 'HOME': '/Users/cltbld', 06:02:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:02:07 INFO - 'LOGNAME': 'cltbld', 06:02:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:07 INFO - 'MOZ_NO_REMOTE': '1', 06:02:07 INFO - 'NO_EM_RESTART': '1', 06:02:07 INFO - 'PAGER': '/bin/cat', 06:02:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:02:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:07 INFO - 'PWD': '/builds/slave/test', 06:02:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:02:07 INFO - 'SHELL': '/bin/bash', 06:02:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kdfolJLwDw/Listeners', 06:02:07 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:02:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:02:07 INFO - 'USER': 'cltbld', 06:02:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:02:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:02:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:07 INFO - 'XPC_FLAGS': '0x0', 06:02:07 INFO - 'XPC_SERVICE_NAME': '0', 06:02:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:02:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:07 INFO - Downloading/unpacking blobuploader==1.2.4 06:02:07 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 06:02:07 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 06:02:07 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 06:02:07 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 06:02:07 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 06:02:07 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 06:02:09 INFO - Downloading blobuploader-1.2.4.tar.gz 06:02:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:02:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:02:10 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 06:02:10 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 06:02:10 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 06:02:10 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 06:02:10 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 06:02:10 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 06:02:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:02:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:02:10 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 06:02:10 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 06:02:10 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 06:02:10 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 06:02:10 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 06:02:10 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 06:02:11 INFO - Downloading docopt-0.6.1.tar.gz 06:02:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:02:11 INFO - Installing collected packages: blobuploader, requests, docopt 06:02:11 INFO - Running setup.py install for blobuploader 06:02:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:02:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:02:11 INFO - Running setup.py install for requests 06:02:11 INFO - Running setup.py install for docopt 06:02:12 INFO - Successfully installed blobuploader requests docopt 06:02:12 INFO - Cleaning up... 06:02:12 INFO - Return code: 0 06:02:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:12 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 0x10653db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106540768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff95b46fbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10631bd30>, '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 0x106242db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106310be8>, '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.uogyfgLNx6/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.kdfolJLwDw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 06:02:12 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 06:02:12 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 06:02:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uogyfgLNx6/Render', 06:02:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:02:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:02:12 INFO - 'HOME': '/Users/cltbld', 06:02:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:02:12 INFO - 'LOGNAME': 'cltbld', 06:02:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:12 INFO - 'MOZ_NO_REMOTE': '1', 06:02:12 INFO - 'NO_EM_RESTART': '1', 06:02:12 INFO - 'PAGER': '/bin/cat', 06:02:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:02:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:12 INFO - 'PWD': '/builds/slave/test', 06:02:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:02:12 INFO - 'SHELL': '/bin/bash', 06:02:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kdfolJLwDw/Listeners', 06:02:12 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:02:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:02:12 INFO - 'USER': 'cltbld', 06:02:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:02:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:02:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:12 INFO - 'XPC_FLAGS': '0x0', 06:02:12 INFO - 'XPC_SERVICE_NAME': '0', 06:02:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:02:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:02:12 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-nPYFHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:02:12 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-FWphMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:02:12 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-v4xCnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:02:12 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-hYF4Fq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:02:12 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-MUvo5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:02:13 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-O5VgRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:02:13 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-7kB7Oc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:02:13 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-ajgKaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:02:13 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-i3ba6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:02:13 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-IBEWJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:02:13 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Mfj0Wk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:02:13 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Z5C_pD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:02:13 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-RQAzYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:02:13 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-7Ix5zs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:02:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:02:13 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-0Vb1gQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:02:14 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-wRa1hP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:02:14 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-EhKURU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:02:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:02:14 INFO - Running setup.py install for manifestparser 06:02:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:02:14 INFO - Running setup.py install for mozcrash 06:02:14 INFO - Running setup.py install for mozdebug 06:02:14 INFO - Running setup.py install for mozdevice 06:02:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:02:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:02:14 INFO - Running setup.py install for mozfile 06:02:15 INFO - Running setup.py install for mozhttpd 06:02:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:02:15 INFO - Running setup.py install for mozinfo 06:02:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:02:15 INFO - Running setup.py install for mozInstall 06:02:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:02:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:02:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:02:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:02:15 INFO - Running setup.py install for mozleak 06:02:15 INFO - Running setup.py install for mozlog 06:02:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:02:15 INFO - Running setup.py install for moznetwork 06:02:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:02:15 INFO - Running setup.py install for mozprocess 06:02:16 INFO - Running setup.py install for mozprofile 06:02:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:02:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:02:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:02:16 INFO - Running setup.py install for mozrunner 06:02:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:02:16 INFO - Running setup.py install for mozscreenshot 06:02:16 INFO - Running setup.py install for moztest 06:02:16 INFO - Running setup.py install for mozversion 06:02:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:02:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:02:16 INFO - Cleaning up... 06:02:16 INFO - Return code: 0 06:02:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:02:16 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')]} 06:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:16 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')]} 06:02:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:16 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 0x10653db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106540768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff95b46fbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10631bd30>, '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 0x106242db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106310be8>, '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.uogyfgLNx6/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.kdfolJLwDw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 06:02:16 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 06:02:16 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 06:02:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uogyfgLNx6/Render', 06:02:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:02:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:02:16 INFO - 'HOME': '/Users/cltbld', 06:02:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:02:16 INFO - 'LOGNAME': 'cltbld', 06:02:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:16 INFO - 'MOZ_NO_REMOTE': '1', 06:02:16 INFO - 'NO_EM_RESTART': '1', 06:02:16 INFO - 'PAGER': '/bin/cat', 06:02:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:02:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:16 INFO - 'PWD': '/builds/slave/test', 06:02:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:02:16 INFO - 'SHELL': '/bin/bash', 06:02:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kdfolJLwDw/Listeners', 06:02:16 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:02:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:02:16 INFO - 'USER': 'cltbld', 06:02:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:02:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:02:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:16 INFO - 'XPC_FLAGS': '0x0', 06:02:16 INFO - 'XPC_SERVICE_NAME': '0', 06:02:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:02:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:02:17 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-N61hvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:02:17 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)) 06:02:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:02:17 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-pYXykP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:02:17 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)) 06:02:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:02:17 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-GWjUAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:02:17 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)) 06:02:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:02:17 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-3dDWQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:02:17 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)) 06:02:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:02:17 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-16ggkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:02:17 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)) 06:02:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:02:17 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-k40VkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:02:17 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)) 06:02:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:02:17 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-X3Q23L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:02:17 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)) 06:02:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:02:17 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-gKknIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:02:17 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)) 06:02:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:02:17 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-2NRFUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:02:18 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)) 06:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:02:18 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-hPzi6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:02:18 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)) 06:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:02:18 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-8sd_m5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:02:18 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)) 06:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:02:18 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-_yvsn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:02:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 06:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:02:18 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-4_1VW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:02:18 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)) 06:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:02:18 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-2vxGKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:02:18 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)) 06:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:02:18 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-EbYR9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:02:18 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)) 06:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:02:18 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-3ZHheQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:02:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:02:18 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-ic9pQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:02:18 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)) 06:02:18 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)) 06:02:18 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)) 06:02:18 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)) 06:02:18 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)) 06:02:18 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)) 06:02:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:02:18 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 06:02:18 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 06:02:18 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 06:02:18 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 06:02:18 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 06:02:18 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 06:02:21 INFO - Downloading blessings-1.6.tar.gz 06:02:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:02:21 INFO - Installing collected packages: blessings 06:02:21 INFO - Running setup.py install for blessings 06:02:21 INFO - Successfully installed blessings 06:02:21 INFO - Cleaning up... 06:02:21 INFO - Return code: 0 06:02:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:02:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:02:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:02:22 INFO - Reading from file tmpfile_stdout 06:02:22 INFO - Current package versions: 06:02:22 INFO - blessings == 1.6 06:02:22 INFO - blobuploader == 1.2.4 06:02:22 INFO - docopt == 0.6.1 06:02:22 INFO - functools32 == 3.2.3-2 06:02:22 INFO - jsonschema == 2.5.1 06:02:22 INFO - manifestparser == 1.1 06:02:22 INFO - mozInstall == 1.12 06:02:22 INFO - mozcrash == 1.0 06:02:22 INFO - mozdebug == 0.1 06:02:22 INFO - mozdevice == 0.49 06:02:22 INFO - mozfile == 1.2 06:02:22 INFO - mozhttpd == 0.7 06:02:22 INFO - mozinfo == 0.9 06:02:22 INFO - mozleak == 0.1 06:02:22 INFO - mozlog == 3.4 06:02:22 INFO - moznetwork == 0.27 06:02:22 INFO - mozprocess == 0.24 06:02:22 INFO - mozprofile == 0.28 06:02:22 INFO - mozrunner == 6.13 06:02:22 INFO - mozscreenshot == 0.1 06:02:22 INFO - mozsystemmonitor == 0.3 06:02:22 INFO - moztest == 0.8 06:02:22 INFO - mozversion == 1.4 06:02:22 INFO - psutil == 3.1.1 06:02:22 INFO - requests == 1.2.3 06:02:22 INFO - wsgiref == 0.1.2 06:02:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:02:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:22 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 0x10653db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106540768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff95b46fbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10631bd30>, '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 0x106242db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106310be8>, '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.uogyfgLNx6/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.kdfolJLwDw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 06:02:22 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 06:02:22 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 06:02:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uogyfgLNx6/Render', 06:02:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:02:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:02:22 INFO - 'HOME': '/Users/cltbld', 06:02:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:02:22 INFO - 'LOGNAME': 'cltbld', 06:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:22 INFO - 'MOZ_NO_REMOTE': '1', 06:02:22 INFO - 'NO_EM_RESTART': '1', 06:02:22 INFO - 'PAGER': '/bin/cat', 06:02:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:22 INFO - 'PWD': '/builds/slave/test', 06:02:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:02:22 INFO - 'SHELL': '/bin/bash', 06:02:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kdfolJLwDw/Listeners', 06:02:22 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:02:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:02:22 INFO - 'USER': 'cltbld', 06:02:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:02:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:22 INFO - 'XPC_FLAGS': '0x0', 06:02:22 INFO - 'XPC_SERVICE_NAME': '0', 06:02:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:02:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:23 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)) 06:02:23 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)) 06:02:23 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)) 06:02:23 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)) 06:02:23 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)) 06:02:23 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)) 06:02:23 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)) 06:02:23 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)) 06:02:23 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)) 06:02:23 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)) 06:02:23 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)) 06:02:23 INFO - Cleaning up... 06:02:23 INFO - Return code: 0 06:02:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:02:23 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')]} 06:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:23 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')]} 06:02:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:23 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 0x10653db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106540768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff95b46fbe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10631bd30>, '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 0x106242db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106310be8>, '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.uogyfgLNx6/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.kdfolJLwDw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 06:02:23 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 06:02:23 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 06:02:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uogyfgLNx6/Render', 06:02:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:02:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:02:23 INFO - 'HOME': '/Users/cltbld', 06:02:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:02:23 INFO - 'LOGNAME': 'cltbld', 06:02:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:23 INFO - 'MOZ_NO_REMOTE': '1', 06:02:23 INFO - 'NO_EM_RESTART': '1', 06:02:23 INFO - 'PAGER': '/bin/cat', 06:02:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:02:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:23 INFO - 'PWD': '/builds/slave/test', 06:02:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:02:23 INFO - 'SHELL': '/bin/bash', 06:02:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kdfolJLwDw/Listeners', 06:02:23 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:02:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:02:23 INFO - 'USER': 'cltbld', 06:02:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:02:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:02:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:23 INFO - 'XPC_FLAGS': '0x0', 06:02:23 INFO - 'XPC_SERVICE_NAME': '0', 06:02:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:02:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:02:23 INFO - Cleaning up... 06:02:23 INFO - Return code: 0 06:02:23 INFO - Running post-action listener: _resource_record_post_action 06:02:23 INFO - Running post-action listener: _start_resource_monitoring 06:02:23 INFO - Starting resource monitoring. 06:02:23 INFO - [mozharness: 2017-01-18 14:02:23.814858Z] Finished create-virtualenv step (success) 06:02:23 INFO - [mozharness: 2017-01-18 14:02:23.815705Z] Running install step. 06:02:23 INFO - Running pre-action listener: _resource_record_pre_action 06:02:23 INFO - Running main action method: install 06:02:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:02:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:02:24 INFO - Reading from file tmpfile_stdout 06:02:24 INFO - Detecting whether we're running mozinstall >=1.0... 06:02:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:02:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:02:24 INFO - Reading from file tmpfile_stdout 06:02:24 INFO - Output received: 06:02:24 INFO - Usage: mozinstall [options] installer 06:02:24 INFO - Options: 06:02:24 INFO - -h, --help show this help message and exit 06:02:24 INFO - -d DEST, --destination=DEST 06:02:24 INFO - Directory to install application into. [default: 06:02:24 INFO - "/builds/slave/test"] 06:02:24 INFO - --app=APP Application being installed. [default: firefox] 06:02:24 INFO - mkdir: /builds/slave/test/build/application 06:02:24 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'] 06:02:24 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 06:02:46 INFO - Reading from file tmpfile_stdout 06:02:46 INFO - Output received: 06:02:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:02:46 INFO - Running post-action listener: _resource_record_post_action 06:02:46 INFO - [mozharness: 2017-01-18 14:02:46.334554Z] Finished install step (success) 06:02:46 INFO - [mozharness: 2017-01-18 14:02:46.334670Z] Running run-tests step. 06:02:46 INFO - Running pre-action listener: _resource_record_pre_action 06:02:46 INFO - Running main action method: run_tests 06:02:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:02:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:02:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:02:46 INFO - 2017-01-18 06:02:46.349 screenresolution[1628:7691] starting screenresolution argv=screenresolution get 06:02:46 INFO - 2017-01-18 06:02:46.351 screenresolution[1628:7691] Display 0: 1600x1200x32@60 06:02:46 INFO - 2017-01-18 06:02:46.357 screenresolution[1629:7693] starting screenresolution argv=screenresolution list 06:02:46 INFO - Available Modes on Display 0 06:02:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:02:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:02:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:02:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:02:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:02:46 INFO - Intel Iris: 06:02:46 INFO - Chipset Model: Intel Iris 06:02:46 INFO - Type: GPU 06:02:46 INFO - Bus: Built-In 06:02:46 INFO - VRAM (Dynamic, Max): 1536 MB 06:02:46 INFO - Vendor: Intel (0x8086) 06:02:46 INFO - Device ID: 0x0a2e 06:02:46 INFO - Revision ID: 0x0009 06:02:46 INFO - Displays: 06:02:46 INFO - Display: 06:02:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:02:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:02:46 INFO - Display Serial Number: 1600x1200 60 06:02:46 INFO - Main Display: Yes 06:02:46 INFO - Mirror: Off 06:02:46 INFO - Online: Yes 06:02:46 INFO - Rotation: Supported 06:02:46 INFO - Return code: 0 06:02:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:02:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:02:46 INFO - Python 2.7.3 06:02:46 INFO - Return code: 0 06:02:46 INFO - grabbing minidump binary from tooltool 06:02:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:02:46 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 0x10631bd30>, '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 0x106242db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106310be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:02:46 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 06:02:46 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 06:02:46 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 06:02:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:02:46 INFO - Return code: 0 06:02:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:02:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:02:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:02:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:02:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:02:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--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 06:02:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0163 --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 06:02:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uogyfgLNx6/Render', 06:02:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:02:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:02:46 INFO - 'HOME': '/Users/cltbld', 06:02:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:02:46 INFO - 'LOGNAME': 'cltbld', 06:02:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:02:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:02:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:46 INFO - 'MOZ_NO_REMOTE': '1', 06:02:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:02:46 INFO - 'NO_EM_RESTART': '1', 06:02:46 INFO - 'PAGER': '/bin/cat', 06:02:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:02:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:46 INFO - 'PWD': '/builds/slave/test', 06:02:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:02:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:02:46 INFO - 'SHELL': '/bin/bash', 06:02:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kdfolJLwDw/Listeners', 06:02:46 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:02:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:02:46 INFO - 'USER': 'cltbld', 06:02:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:02:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:02:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:46 INFO - 'XPC_FLAGS': '0x0', 06:02:46 INFO - 'XPC_SERVICE_NAME': '0', 06:02:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:02:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--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 06:02:46 INFO - mozversion application_buildid: 20170118050726 06:02:46 INFO - mozversion application_changeset: 8fcc95d1411532306d08b49471214e0f0fcd7a8c 06:02:46 INFO - mozversion application_display_name: Nightly 06:02:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:02:46 INFO - mozversion application_name: Firefox 06:02:46 INFO - mozversion application_remotingname: firefox 06:02:46 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 06:02:46 INFO - mozversion application_vendor: Mozilla 06:02:46 INFO - mozversion application_version: 53.0a1 06:02:46 INFO - mozversion platform_buildid: 20170118050726 06:02:46 INFO - mozversion platform_changeset: 8fcc95d1411532306d08b49471214e0f0fcd7a8c 06:02:46 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 06:02:46 INFO - mozversion platform_version: 53.0a1 06:02:46 INFO - using testdate: 1484748166 06:02:46 INFO - actual date: 1484748166 06:02:46 INFO - starting webserver on 'localhost:49247' 06:02:46 INFO - SUITE-START | Running 2 tests 06:02:46 INFO - TEST-START | dromaeo_css 06:02:46 INFO - operating with platform_type : mac_ 06:02:46 INFO - Initialising browser for dromaeo_css test... 06:02:46 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpjgUzXX/profile http://localhost:49247/getInfo.html) 06:02:49 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 06:02:49 INFO - PROCESS | 1639 | colorDepth:24 06:02:49 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 06:02:49 INFO - PROCESS | 1639 | __metrics 06:02:49 INFO - PROCESS | 1639 | 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" 06:02:49 INFO - PROCESS | 1639 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:02:50 INFO - TEST-INFO | 1639: exit 0 06:02:50 INFO - Browser initialized. 06:02:50 INFO - Running cycle 1/1 for dromaeo_css test... 06:02:50 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpjgUzXX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:03:02 INFO - PROCESS | 1641 | RSS: Main: 235413504 06:03:02 INFO - PROCESS | 1641 | 06:06:05 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49247/tests/dromaeo/cssquery-ext.html) 06:06:06 INFO - PROCESS | 1641 | RSS: Main: 357027840 06:06:06 INFO - PROCESS | 1641 | 06:07:51 INFO - PROCESS | 1641 | ************************* 06:07:51 INFO - PROCESS | 1641 | A coding exception was thrown and uncaught in a Task. 06:07:51 INFO - PROCESS | 1641 | 06:07:51 ERROR - PROCESS | 1641 | Full message: TypeError: NetworkError when attempting to fetch resource. 06:07:51 INFO - PROCESS | 1641 | Full stack: 06:07:51 INFO - PROCESS | 1641 | ************************* 06:09:09 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-ext.html (next: http://localhost:49247/tests/dromaeo/cssquery-jquery.html) 06:09:10 INFO - PROCESS | 1641 | RSS: Main: 366968832 06:09:10 INFO - PROCESS | 1641 | 06:12:12 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49247/tests/dromaeo/cssquery-mootools.html) 06:12:12 INFO - PROCESS | 1641 | RSS: Main: 342487040 06:12:12 INFO - PROCESS | 1641 | 06:15:15 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49247/tests/dromaeo/cssquery-prototype.html) 06:15:15 INFO - PROCESS | 1641 | RSS: Main: 332873728 06:15:15 INFO - PROCESS | 1641 | 06:18:19 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49247/tests/dromaeo/cssquery-yui.html) 06:18:19 INFO - PROCESS | 1641 | RSS: Main: 326840320 06:18:19 INFO - PROCESS | 1641 | 06:21:23 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-yui.html (next: http://localhost:49247/tests/dromaeo/cssquery-dojo.html) 06:21:23 INFO - PROCESS | 1641 | RSS: Main: 507731968 06:21:23 INFO - PROCESS | 1641 | 06:21:23 INFO - PROCESS | 1641 | __start_tp_report 06:21:23 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 06:21:23 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 06:21:23 INFO - PROCESS | 1641 | |i|pagename|runs| 06:21:23 INFO - PROCESS | 1641 | |0;dojo.html;3325.135464779158;3333.1667083229195;3333.3999880021593;3366.0238530826064;3391.931541564407;4357.803898824553;5105.310783044288;5470.8085217017415;5526.944730552693;5538.086215774398;5556.91664625031;5580.553555715544;5586.804461843836;5592.161175823619;5598.4961353478175;5053.519915608012;5062.72155031475;5102.132637451642;5147.9704059188125;5182.844514664566;5102.719350435725;5131.743412829363;5194.168932970725;5201.141811601081;5204.32343795306;5128.461511541291;5150.098732721777;5216.426193118754;5230.032443997854;5250.921236181461;5162.122439185328;5177.249298851683;5181.948180518184;5190.2993095932325;5196.1166601677805;326.41707876059274;5084.3644544431945;5147.305113809625;5158.638895277332;5200.427952925175;5513.696746678931;5607.495325420691;5609.607327487078;5619.690916999604;5634.690092044936;6176.474999624992;6183.443490085914;6189;6198.256209254918;6204.565680402374;6124.540659450559;6198.783042593533;6242.250929888397;6271.749130034793;6286.748530058792;5637.3517045539875;5677.744501497484;5678.77284908599;5726.685032323262;5810.448007439287;6325.810225693236;6330.715117819709;6350.4602108820345;6351.745930162741;6354.078658594571;6100.69496525172;6104.4200800923845;6108.694565271808;6118.541109416722;6128.080787881764;6032.668203248863;6046.818595442144;6112.877742445126;6126.314740042852;6131.908021379683;6123.201403005315;6145.539084568675;6148.1392605035335;6164.753409863645;6172.69136543171;6172.598781079216;6177.6911154443;6181.7527298908435;6197.597156184834;6198.876022479525;4271.718484454651;4839.879003024882;4852.126617208936;4942.332785074041;5000.199968005102;4304.332828411601;4322.286822674287;4401.031773009932;4417.3153161259415;4430.933535996963;5627.5779316551425;5688.374278829326;5770.307563092456;5786.768529258867;5818.330891947396;6104.368208815921;6121.4529735759925;6143.1706719592285;6166.105914642351;6208.0998255253635;4873.926891096637;5646.4353564644025;5767.250257466587;5787.421257874263;5808.5933984621515;5323.1749078892835;5376.327959005124;5400.324959380077;5401.945980540223;5421.918671219935;6238.407351301619;6244.781432649836;6343.429091381798;6344.619322840645;6346.333634968262;6194.938050619436;6202.658853763086;6207.534434917309;6219.036049412167;6236.75052997875;6319.652419116993;6321.431071203614;6332.52506062038;6337.397947195009;6341.4292713656;5903.2325797646035;5956.821295361146;5984.072468767348;6085.1785009023215;6094.695265236632;6150.600210986271;6160.075988601567;6168.0439531872635;6258.812235632939;6270.435660790368;5866.208061911588;5877.35349111606;6024.246969128859;6026;6037.667928263988;5791.102379131242;5911.645301281937;5967.373425790403;5984.820455386345;5989.700514974146;5679.602427830012;5703.914441283467;5711.086226203787;5726.169705392778;5780.5953583248765;5027.9748601258225;5721.084626459747;5846.386129456346;5854.063349864001;5869.06095024794;5720.6853623049465;5739.368669446274;5746.367899530965;5754.597178197653;5770.076787713946 06:21:23 INFO - PROCESS | 1641 | |1;ext.html;494.2882249560633;505.5702652745167;506.98602794411175;517.3403910014731;573.0115550675083;30782.076537703877;40452.797736011315;42112.15775684485;42131.78934105325;44127.558724412746;42891.57108428915;43255.78372108143;43290.350644740356;43302.783486082524;43356.4825231117;8389.916100839006;8613.397062205648;9160.129787670177;9377.156055954963;9396.859047114298;11007.889921100767;11251.774964500704;11254.437278136102;11464.025557827596;11478.770424591503;11193.384363859985;11254.987051165393;11288.096952243843;11291.887081129165;11301.49143288554;11162.162837787198;11232.21374503785;11233.326000439918;11237.101031917427;11260.718482037933;11124;11219;11219;11228.270162439416;11231.32612043272;40838.59161408377;40964.79517602423;41101.58898411007;41198.38202426966;41211.381829272585;4002.419649150857;4015.8996025099314;4053.61490658387;4074.2666320062376;4106.301928672133;30139.849300753576;30886.680472024433;30953;31309;31334.686653133405;3179.205198700325;3222.274988127676;3265.330607225513;3290.720288775457;3332.350191712617;479318;479460;480551.9999999965;481273;483576;63580.68209658922;63873.680631596544;63899.97100318961;64044.67977660175;64054.35945640577;66157.66921165363;66308.33691663117;66309.33690663031;66347.00479492811;66417.33582664208;15869.68260634781;16024.278907449192;16026.67946641084;16034.11812350332;16083.356665733474;10913.017828395325;11176;12132.5146994121;12282.14025018258;12395.380230988594;16677.380217534832;16930;20411.693824592643;21122.36632900985;21134.365969020953;8729.60716767747;8748.550405886363;8770.38607297483;8775.956120219485;8851.557422128868;767.0948281028328;839.8656215005569;859.2052351574769;873.5108339329995;897.1208215948277;28930.492191503574;30194.54708179379;30257.09228723142;30531.69468305333;30841.537376939363;1070.5931745936493;1079.6545105566142;1084.8752393474695;1098.8297463201825;1192.7197108679454;15229.923850380677;15303.540893773205;15870.841291587167;15893.284802183929;16255.18724063792;641145;645009;645174;645396;646820;55848.72075639596;56435;56447;56587.43412565822;56619.43380566224;1374.1205628397834;1416.3980308368903;1433.31917339263;1436.0593811053568;1438.5900018494679;28752;28834.7116528832;28925.132246032652;29563.556546651387;29574.556381653863;48627.004004259325;49160.016799664525;49208.753956229986;49259;49302.26046609232;581987.9813220458;584987;586310.068449655;586478;587512;24903.750962490867;25551.6167257495;26411.943522258895;27097.72902270952;27112.864435677697;42663.7866810664;42760.35859462173;42985.785071074446;42992;43716.781416092716;36272.4559131608;36486;36717.816410917774;37398.06504837401;37646.435303471015;35539.40072696786;35583.288334233686;35946.46080308745;35954.28091438209;36590.8170459146;35202.47196292006;35282;35311.11722206863;35787.926362209175;35980;30928.69071309258;31783.523247151774;32109.678903210668;32182.67817321797;32397.35205295928;23548.764512354657;23638.17266395668;24013.399665008514;24189.758102419455;24191.51616967686 06:21:23 INFO - PROCESS | 1641 | |2;jquery.html;371.039008966776;388.47749776550546;391.87068267471733;397.71960767658794;416.014046709299;15119.319630616621;19597.24852955836;21008.05463754131;21015.36953891382;21890.781092189074;20780.376588702326;21145;21678.024488897998;21900.561988760255;22140.778592214072;4607.953920460786;5532.6680399176075;5774.2782152230975;5776.653400795944;5788.334341550733;5356.38401583817;5730.283714535683;5761.769529218826;5769.336526299488;5772.797952071678;5511.751971161308;5653.095504719246;5713.17159011943;5718.513926316268;5728.083506638938;5608.775648974057;5634.4928956393915;5656.1798539211995;5656.971715141398;5666.801661941853;4824.372831531913;4895.363602731622;4926.9014619707405;4987.401511818569;5000.82497112603;23278.767212327828;23414.64878026831;24332.87833560821;25771.226863194133;26086.478270434676;2713.0775536317747;2717.4565086982684;2752.6421565196597;2769.2938300733385;2815.0991682661556;11765;14793.260336983109;14843.628909277246;15352.080989876265;15489.612759680986;1570.9160679131478;1791.265581111738;1793.5695433096093;1841.7697787776528;1845.2342277954633;133361;134838;136251.31874340566;137319.31340343333;137762.3111884444;11131.944340278409;11184.776304473866;11414.600488982845;11500.654980350602;11505.309681418974;14414.711705765825;14425.609981654303;14427.49503767363;14429.91775616833;14430.42278308856;8245.340372770164;8511.787205319793;8512.74461766148;8674;8692.304615630734;8417.032041315204;8425.578721063923;8447.662093516314;8602.39783215169;8604.956975215084;6869.244383117853;6976.197737260179;6984.650767461607;6985.231624521299;6987.091678081919;1603.7170263788921;1779.3950056980689;1894.4316704988448;1913.4164079955747;1916.559191385989;1023.948802559869;1049.2026060194307;1049.9265051446325;1061.0633505536512;1082.5832054659013;17831.10844457772;22287.888560557094;22296.996635151456;22340.888295558743;22521;1009.3489699144011;1046.785408991155;1051.5215576912487;1102.2394547762178;1104.7790441911488;10789.514471848786;11659.533618655329;11730;11754.88245117555;11758.647240582795;296226;298660;541797;699278;728042.7565794723;136434.31782841022;136666;138604;139185.6081439193;139931;998.8951160128228;1005.3716427232979;1034.2088302448633;1037.823569993103;1040.5785656809005;15412.532180259352;18376;18458.907705461388;19290;19364;52328;53762.731186343815;54148;54353.72823135859;54670;71325.28674713186;72310.27689723036;74606;74988;75405.24594754202;7695.88456173169;7899.881501777363;7948.165442628672;8002.319802816825;8156;11841.815818418088;12928.353582321035;13101.148425352321;13600.93199533996;13918.58244252674;11440.48517816717;11488.094048023711;11647.12646551529;11678;11710.180287380143;9019.639214431349;9789.706308810748;10844.837327439936;10953.56185752561;11045.613403530839;11023.118150548098;11269.323840569592;11379.089672825989;11457.427128643702;11461.828072578752;7738.148803631483;7743.612819358897;7835.4123440743315;7918.287354138155;7943.92056079455;10616.84074738864;10914.399708015817;10933.343999360064;10955.780884382428;11018.724531886766 06:21:23 INFO - PROCESS | 1641 | |3;mootools.html;1340.3245942571784;1384.4393020826565;1452.477108241033;1476.0922032949738;1488.1963739580624;7405.629718514079;7770.533767973926;8077.434579579424;8336.749897503085;8340.499570025788;8205.466644668093;8292.668293268278;8303.33573314135;8303.91696083039;8313.916860831405;2298.7011688480475;2341.0752752662775;2348.6242201247805;2348.7533808949984;2349.1543044503965;2074.2429013410147;2135.1886283212357;2284.565932472833;2338.0998315648512;2348.1664009276715;2320.3271051395077;2320.3503019154577;2320.512692334612;2325.2326732178426;2328.3247858121126;2259.186692790594;2285.1430713482446;2285.7942785149335;2292.197730794225;2294.242899843048;2196.077647388101;2228.2089858100303;2242.573910956913;2246.6854640350366;2247.3932038349717;8212.301954333889;8390.580470976427;8396.874046889241;8401.495910245405;8425.11536288687;4980.825671101494;5139.665921715114;5154.149565321717;5154.891698284887;5154.896902061938;3291.53918451417;3435.1927297085167;3450.4996775467416;3468.497067925162;3529.1177205698577;1164.889335513125;1211.19455562052;1228.4656174564093;1254.2474515290844;1256.7674980128613;10661.040506354466;10682.626108086257;10809;10839.187060970458;10840.241183117185;4420;4594.517575654575;4632.652551058684;4670.7664616769025;4675.906481870344;9446.149846513847;9446.291528135418;9447.244220462484;9468.763280918032;9473.47895865734;5178.61160412963;5179.352580927384;5179.637425380262;5181.1969144782615;5196.986587615379;4556.3621093047;4654.092451971833;4699.248120300804;4748.715077095385;4748.738819364969;3731.2537492501065;3758.962410375916;3790.33669107905;3843.327417701947;3884.9223015539533;1231.4704676988802;1234.1237721218035;1240.8697086805937;1251.8810712982252;1254.2975933477283;861.8836457078339;871.5511511571545;883.3683916000091;904.1500989070253;917.2661870503571;5183.352080989876;5223.268742376071;5475.06923822951;5497.092979658391;5498.532624726863;523.9056969745483;569.7863301262026;575.4217011903011;577.5812535911431;579.9681017544076;3567.9821600892346;3621.8189090545893;3663.6153203913736;3670.4310831821113;3723.8510459581853;9415.717528474157;9846.359986600848;9855.655052073143;9858.654947076819;9869.555869985725;9702.466364350028;9844.409335439897;9863.852042219372;9879.012098790206;9892.25808064398;7376;7638.350740187036;7709.344705699966;7755.108162561265;7763.61181940912;5514.145307477347;5680.2047713321;5712.228849105318;5720.17057526648;5755.395683453345;8853.69012084574;9054.592543335697;9167.816643667224;9229.03095174997;9368.484733339732;9312.906870931203;9329.067093290616;9410.29422793307;9447.00806415344;9479.004704505927;7123.465740069412;7301.890471643036;7312.451566132455;7316.487845850952;7329.450291228072;7700.268474494914;7758.146603873683;7778.222177782177;7809.726659566888;7835.608219589112;7065.328793764585;7123.501354905314;7146.249643787535;7163.3552980232025;7197.352238298578;6031.909521357271;6998.335158159966;7002.614856182755;7022.40309573692;7071.575705457689;6257.812265632038;6337.96831015842;6389.280185565726;6397.136386587751;6443.130177425987;4861.6596838220985;4879.585235254901;4943.406791185081;4970.130227210151;5130.4100028497205;4415.735055896656;4877.975610121926;5030.220315851049;5044.066847633199;5070.112730272262 06:21:23 INFO - PROCESS | 1641 | |4;prototype.html;333.16375896499807;353.7947990165704;359.98740044098463;363.1846504597179;376.2888141412729;4799.688020278684;4837.8790530236765;4913.75692043252;5024.171011783052;5024.422191447985;3940.7635541867508;4798.352222449968;4974.726390048546;4983.800647974077;5018.874528136798;3503.9663299326758;3727.608601096873;3950.249452604003;3978.4231286463446;3981.9890955067794;3035.317053662919;3224.339010502841;3288.6053673559086;3847.7498962567483;3967.404889266604;3246.853891574873;3796.9240615187678;3885.7862817545024;3907.257621051991;3946.0529472926432;3570.8571657133684;3768.4912536807456;3907.7069219808345;3920.372740361557;3940.389239667856;3301.4882693182353;3464.0300715799617;3511.455724362728;3525.3301872644115;3536.3104194682046;4846.951530484721;4880.267959806022;4907.356035728036;4923.359963204796;4930.408350997904;3818.7708737475564;4021.416894550303;4562.087582483483;4567.33773602829;4571.405717256768;4288.828446862121;5096.490350964911;5277.234800953878;5296.9735151324385;5421.647592906448;3200.8239546824916;3680.1719613087107;3704.759190652599;3718.200586873835;3725.9813700931595;4943.579795717368;5496;5563.693996830173;5578.163275508666;5603.887922241533;3493.3013397320638;3622.3479773640997;3763.9059023524633;3768.1898391845884;3800.7719536827326;3663.432168013962;3711.587468145673;3770.6040865708705;3777.7166712496123;3808.7524310919703;3772.8868133956025;3958.44581758554;4023.5574086850424;4064.309067458539;4380.649548036149;4913.828016019422;4917.286993385939;4942.9011419771405;5342.973285133549;5388.030154572215;1124.690710054725;1188.257339163023;1223.9755204895853;1225.828384026237;1234.7714024545635;725.5646612032738;795.8976817108347;842.6587232170981;853.5134973065417;865.3466632692277;4466.868146964045;4575.839845605387;4642.651801114863;4773.832915847928;4880.536349046835;4640.443146822336;4642.79107440166;5153;5179.766910489037;5189.844304670866;3728.6209783518457;3799.031247031989;4269.815580730901;4558.133954548625;4750.667453278306;2334.9182778602667;2394.6527753476;2400.59189937711;2644.386923976373;2699.987504685743;4498.707584007029;4828.589569886529;5043.3861164427035;5410.269613602113;5432.2123292123215;4129.607687269705;4464.709793863389;4517.661175411858;5034.395872495324;5104.438511763703;5172.5344718973965;5243.973780131075;5274.472552744772;5402.486763757358;5410.404855465896;4247.893802654959;4586.798336798289;4858.028394321079;5125.692458452505;5147.536721695065;4198.187214566187;4562.292844609091;4873.610111191026;4887.926681099858;5100.7449627517735;4384.671149663852;4803.639727020557;5370.4629537045985;5428.647137936022;5433.782648694008;3070.3245286037036;3182.2521707399205;3514.927946976197;3517.2086280586664;3522.718182545339;4468.575485328888;4821.493743157058;5112.571528523921;5113.64204505681;5161.690298582097;4677.579017888406;4906.607471402351;5233.188855727369;5241.44964778708;5260.842174734764;4902.338184345068;5241.790328386975;5244.7902083916215;5256.345545499498;5259.237410575522;4111.033907031785;4161.479815023122;4881.925976285212;5098.592112631055;5112.156494178419;4185.9581404185565;4790.760461976817;4953.331300274561;5033.169527028146;5227.634065615523;5059.671121377099;5118.641695081457;5128;5128.230765385222;5151.922721159111 06:21:23 INFO - PROCESS | 1641 | |5;yui.html;729.4930023633574;765.7894079128242;778.2062296457614;830.9086000539941;836.5858899844578;15058.397664093436;15732.05607663541;15740.055596664208;15792.68414631708;15872.444464443732;14405.711885762279;14519.927400362983;14551.126932384064;14557.27213639319;14562.635934101652;671.4561205423598;698.2458944340101;700.7792545348225;845.4842546046906;872.2847265242503;860.862262038074;877.4603618774439;878.0560897035712;879.3053487744706;879.3580686099151;939.6992962252082;942.8255772682041;943.1417410156758;943.6036864516885;946.9005754395793;721.5959062924779;747.7495039161887;897.264243320471;939.6664184214574;942.5899733615864;694.8054544727485;698.2214830463996;699.8040548646387;700.4186525184085;700.6461736822872;13219.94240460761;14896.70206595862;15495.922520387327;15507.069575825486;15526.146061966587;13244.73510529784;13444.731105377936;13449.798253026212;13887.4445022199;14137.010409271355;12954.870451295461;12984.740305193938;13061.673458163526;13376.264305463195;13389.518725131536;4253.8301966959025;4540.4551453825425;4580.152671755736;4593.379893714339;4602.654800889946;96399.51800240955;103350;109634;109830.45084774605;110475.34286985782;10370;10787.460626968621;11046.668599942015;11069.944650276697;11089.778204435866;21274;21423.571528569653;21473.570528589342;21504.92475376225;21569.67645485319;6281.3404592518045;7517.8120546985665;7663;7828.412869034845;7855;4185.91628167441;4261.126469073833;4264.978675106605;4295.3771703102875;4435.933460998088;3455.7926524408617;3510.8771193008124;3513.3149035937745;3528.2590655962535;3557.573091229069;658.3581008516753;659.2715049869921;664.5215444879678;672.0591172358737;672.4519516593961;634.511426201822;655.8557117434252;659.677346919433;660.2572106380322;664.6012392564422;9458.33791634579;9736.318457708034;9751.317407781387;9862.260330475243;10005.899941000496;627.9058141278845;649.5972497051858;653.389081209071;665.4111111666114;676.546713701821;4538.319252112209;4603.309503574491;4812.494688057774;4835.395575553056;4874.195757699939;67933;94004;95435.52282238683;96198;97402;88432;88445.557772212;89241.55379223192;90246;90594;65164.34835651678;73814;74818.8777168343;76990;78219.60890195513;9231.58457869384;9303.441793492411;9442;10515.421651809223;10812.891871081503;42244.788776055924;44748.77625611851;45358.77320613376;45949;47452.8136796569;60149;66801.66396671942;67131.99302010571;67467.32532674611;67563.3243667557;12655.557055503014;12823.422945967268;13092.083554151119;13154.013448991554;13189.604311870658;14544.49094281695;14797.334119964413;14891.404343826125;15155.545333640008;15362.539123826304;11986.940065299617;12265.202761820454;13762.587122386345;14042.368093436024;14111.2944352784;11619.376577096806;13380.799288010492;13778;14064.648383790487;14224;13498.190108593515;13679.316034198051;13754;13951.162930224218;14213.147211167363;9560.904390956;10881.78236435251;11305.773884522428;11305.886941130813;11816.645500634995;8888.733337999613;10825.945870270913;10902.78194436091;11011.064059555027;11019 06:21:23 INFO - PROCESS | 1641 | __end_tp_report 06:21:23 INFO - PROCESS | 1641 | __start_cc_report 06:21:23 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,1290 06:21:23 INFO - PROCESS | 1641 | __end_cc_report 06:21:23 INFO - PROCESS | 1641 | __startTimestamp1484749283452__endTimestamp 06:21:23 INFO - PROCESS | 1641 | 06:21:23 INFO - PROCESS | 1641 | ------- Summary: start ------- 06:21:23 INFO - PROCESS | 1641 | Number of tests: 6 06:21:23 INFO - PROCESS | 1641 | 06:21:23 INFO - PROCESS | 1641 | [#0] dojo.html Cycles:165 Average:5625.82 Median:5786.77 stddev:770.04 (13.3%) stddev-sans-first:750.95 06:21:23 INFO - PROCESS | 1641 | Values: 3325.1 3333.2 3333.4 3366.0 3391.9 4357.8 5105.3 5470.8 5526.9 5538.1 5556.9 5580.6 5586.8 5592.2 5598.5 5053.5 5062.7 5102.1 5148.0 5182.8 5102.7 5131.7 5194.2 5201.1 5204.3 5128.5 5150.1 5216.4 5230.0 5250.9 5162.1 5177.2 5181.9 5190.3 5196.1 326.4 5084.4 5147.3 5158.6 5200.4 5513.7 5607.5 5609.6 5619.7 5634.7 6176.5 6183.4 6189.0 6198.3 6204.6 6124.5 6198.8 6242.3 6271.7 6286.7 5637.4 5677.7 5678.8 5726.7 5810.4 6325.8 6330.7 6350.5 6351.7 6354.1 6100.7 6104.4 6108.7 6118.5 6128.1 6032.7 6046.8 6112.9 6126.3 6131.9 6123.2 6145.5 6148.1 6164.8 6172.7 6172.6 6177.7 6181.8 6197.6 6198.9 4271.7 4839.9 4852.1 4942.3 5000.2 4304.3 4322.3 4401.0 4417.3 4430.9 5627.6 5688.4 5770.3 5786.8 5818.3 6104.4 6121.5 6143.2 6166.1 6208.1 4873.9 5646.4 5767.3 5787.4 5808.6 5323.2 5376.3 5400.3 5401.9 5421.9 6238.4 6244.8 6343.4 6344.6 6346.3 6194.9 6202.7 6207.5 6219.0 6236.8 6319.7 6321.4 6332.5 6337.4 6341.4 5903.2 5956.8 5984.1 6085.2 6094.7 6150.6 6160.1 6168.0 6258.8 6270.4 5866.2 5877.4 6024.2 6026.0 6037.7 5791.1 5911.6 5967.4 5984.8 5989.7 5679.6 5703.9 5711.1 5726.2 5780.6 5028.0 5721.1 5846.4 5854.1 5869.1 5720.7 5739.4 5746.4 5754.6 5770.1 06:21:23 INFO - PROCESS | 1641 | 06:21:23 INFO - PROCESS | 1641 | [#1] ext.html Cycles:180 Average:70310.70 Median:35685.61 stddev:153484.65 (430.1%) stddev-sans-first:153825.70 06:21:23 INFO - PROCESS | 1641 | Values: 494.3 505.6 507.0 517.3 573.0 30782.1 40452.8 42112.2 42131.8 44127.6 42891.6 43255.8 43290.4 43302.8 43356.5 8389.9 8613.4 9160.1 9377.2 9396.9 11007.9 11251.8 11254.4 11464.0 11478.8 11193.4 11255.0 11288.1 11291.9 11301.5 11162.2 11232.2 11233.3 11237.1 11260.7 11124.0 11219.0 11219.0 11228.3 11231.3 40838.6 40964.8 41101.6 41198.4 41211.4 4002.4 4015.9 4053.6 4074.3 4106.3 30139.8 30886.7 30953.0 31309.0 31334.7 3179.2 3222.3 3265.3 3290.7 3332.4 479318.0 479460.0 480552.0 481273.0 483576.0 63580.7 63873.7 63900.0 64044.7 64054.4 66157.7 66308.3 66309.3 66347.0 66417.3 15869.7 16024.3 16026.7 16034.1 16083.4 10913.0 11176.0 12132.5 12282.1 12395.4 16677.4 16930.0 20411.7 21122.4 21134.4 8729.6 8748.6 8770.4 8776.0 8851.6 767.1 839.9 859.2 873.5 897.1 28930.5 30194.5 30257.1 30531.7 30841.5 1070.6 1079.7 1084.9 1098.8 1192.7 15229.9 15303.5 15870.8 15893.3 16255.2 641145.0 645009.0 645174.0 645396.0 646820.0 55848.7 56435.0 56447.0 56587.4 56619.4 1374.1 1416.4 1433.3 1436.1 1438.6 28752.0 28834.7 28925.1 29563.6 29574.6 48627.0 49160.0 49208.8 49259.0 49302.3 581988.0 584987.0 586310.1 586478.0 587512.0 24903.8 25551.6 26411.9 27097.7 27112.9 42663.8 42760.4 42985.8 42992.0 43716.8 36272.5 36486.0 36717.8 37398.1 37646.4 35539.4 35583.3 35946.5 35954.3 36590.8 35202.5 35282.0 35311.1 35787.9 35980.0 30928.7 31783.5 32109.7 32182.7 32397.4 23548.8 23638.2 24013.4 24189.8 24191.5 06:21:23 INFO - PROCESS | 1641 | 06:21:23 INFO - PROCESS | 1641 | [#2] jquery.html Cycles:180 Average:33498.25 Median:21895.67 stddev:92678.89 (423.3%) stddev-sans-first:92905.50 06:21:23 INFO - PROCESS | 1641 | Values: 371.0 388.5 391.9 397.7 416.0 15119.3 19597.2 21008.1 21015.4 21890.8 20780.4 21145.0 21678.0 21900.6 22140.8 4608.0 5532.7 5774.3 5776.7 5788.3 5356.4 5730.3 5761.8 5769.3 5772.8 5511.8 5653.1 5713.2 5718.5 5728.1 5608.8 5634.5 5656.2 5657.0 5666.8 4824.4 4895.4 4926.9 4987.4 5000.8 23278.8 23414.6 24332.9 25771.2 26086.5 2713.1 2717.5 2752.6 2769.3 2815.1 11765.0 14793.3 14843.6 15352.1 15489.6 1570.9 1791.3 1793.6 1841.8 1845.2 133361.0 134838.0 136251.3 137319.3 137762.3 11131.9 11184.8 11414.6 11500.7 11505.3 14414.7 14425.6 14427.5 14429.9 14430.4 8245.3 8511.8 8512.7 8674.0 8692.3 8417.0 8425.6 8447.7 8602.4 8605.0 6869.2 6976.2 6984.7 6985.2 6987.1 1603.7 1779.4 1894.4 1913.4 1916.6 1023.9 1049.2 1049.9 1061.1 1082.6 17831.1 22287.9 22297.0 22340.9 22521.0 1009.3 1046.8 1051.5 1102.2 1104.8 10789.5 11659.5 11730.0 11754.9 11758.6 296226.0 298660.0 541797.0 699278.0 728042.8 136434.3 136666.0 138604.0 139185.6 139931.0 998.9 1005.4 1034.2 1037.8 1040.6 15412.5 18376.0 18458.9 19290.0 19364.0 52328.0 53762.7 54148.0 54353.7 54670.0 71325.3 72310.3 74606.0 74988.0 75405.2 7695.9 7899.9 7948.2 8002.3 8156.0 11841.8 12928.4 13101.1 13600.9 13918.6 11440.5 11488.1 11647.1 11678.0 11710.2 9019.6 9789.7 10844.8 10953.6 11045.6 11023.1 11269.3 11379.1 11457.4 11461.8 7738.1 7743.6 7835.4 7918.3 7943.9 10616.8 10914.4 10933.3 10955.8 11018.7 06:21:23 INFO - PROCESS | 1641 | 06:21:23 INFO - PROCESS | 1641 | [#3] mootools.html Cycles:180 Average:5392.97 Median:5210.13 stddev:2955.19 (56.7%) stddev-sans-first:2947.78 06:21:23 INFO - PROCESS | 1641 | Values: 1340.3 1384.4 1452.5 1476.1 1488.2 7405.6 7770.5 8077.4 8336.7 8340.5 8205.5 8292.7 8303.3 8303.9 8313.9 2298.7 2341.1 2348.6 2348.8 2349.2 2074.2 2135.2 2284.6 2338.1 2348.2 2320.3 2320.4 2320.5 2325.2 2328.3 2259.2 2285.1 2285.8 2292.2 2294.2 2196.1 2228.2 2242.6 2246.7 2247.4 8212.3 8390.6 8396.9 8401.5 8425.1 4980.8 5139.7 5154.1 5154.9 5154.9 3291.5 3435.2 3450.5 3468.5 3529.1 1164.9 1211.2 1228.5 1254.2 1256.8 10661.0 10682.6 10809.0 10839.2 10840.2 4420.0 4594.5 4632.7 4670.8 4675.9 9446.1 9446.3 9447.2 9468.8 9473.5 5178.6 5179.4 5179.6 5181.2 5197.0 4556.4 4654.1 4699.2 4748.7 4748.7 3731.3 3759.0 3790.3 3843.3 3884.9 1231.5 1234.1 1240.9 1251.9 1254.3 861.9 871.6 883.4 904.2 917.3 5183.4 5223.3 5475.1 5497.1 5498.5 523.9 569.8 575.4 577.6 580.0 3568.0 3621.8 3663.6 3670.4 3723.9 9415.7 9846.4 9855.7 9858.7 9869.6 9702.5 9844.4 9863.9 9879.0 9892.3 7376.0 7638.4 7709.3 7755.1 7763.6 5514.1 5680.2 5712.2 5720.2 5755.4 8853.7 9054.6 9167.8 9229.0 9368.5 9312.9 9329.1 9410.3 9447.0 9479.0 7123.5 7301.9 7312.5 7316.5 7329.5 7700.3 7758.1 7778.2 7809.7 7835.6 7065.3 7123.5 7146.2 7163.4 7197.4 6031.9 6998.3 7002.6 7022.4 7071.6 6257.8 6338.0 6389.3 6397.1 6443.1 4861.7 4879.6 4943.4 4970.1 5130.4 4415.7 4878.0 5030.2 5044.1 5070.1 06:21:23 INFO - PROCESS | 1641 | 06:21:23 INFO - PROCESS | 1641 | [#4] prototype.html Cycles:180 Average:4149.92 Median:4613.62 stddev:1250.32 (27.1%) stddev-sans-first:1220.57 06:21:23 INFO - PROCESS | 1641 | Values: 333.2 353.8 360.0 363.2 376.3 4799.7 4837.9 4913.8 5024.2 5024.4 3940.8 4798.4 4974.7 4983.8 5018.9 3504.0 3727.6 3950.2 3978.4 3982.0 3035.3 3224.3 3288.6 3847.7 3967.4 3246.9 3796.9 3885.8 3907.3 3946.1 3570.9 3768.5 3907.7 3920.4 3940.4 3301.5 3464.0 3511.5 3525.3 3536.3 4847.0 4880.3 4907.4 4923.4 4930.4 3818.8 4021.4 4562.1 4567.3 4571.4 4288.8 5096.5 5277.2 5297.0 5421.6 3200.8 3680.2 3704.8 3718.2 3726.0 4943.6 5496.0 5563.7 5578.2 5603.9 3493.3 3622.3 3763.9 3768.2 3800.8 3663.4 3711.6 3770.6 3777.7 3808.8 3772.9 3958.4 4023.6 4064.3 4380.6 4913.8 4917.3 4942.9 5343.0 5388.0 1124.7 1188.3 1224.0 1225.8 1234.8 725.6 795.9 842.7 853.5 865.3 4466.9 4575.8 4642.7 4773.8 4880.5 4640.4 4642.8 5153.0 5179.8 5189.8 3728.6 3799.0 4269.8 4558.1 4750.7 2334.9 2394.7 2400.6 2644.4 2700.0 4498.7 4828.6 5043.4 5410.3 5432.2 4129.6 4464.7 4517.7 5034.4 5104.4 5172.5 5244.0 5274.5 5402.5 5410.4 4247.9 4586.8 4858.0 5125.7 5147.5 4198.2 4562.3 4873.6 4887.9 5100.7 4384.7 4803.6 5370.5 5428.6 5433.8 3070.3 3182.3 3514.9 3517.2 3522.7 4468.6 4821.5 5112.6 5113.6 5161.7 4677.6 4906.6 5233.2 5241.4 5260.8 4902.3 5241.8 5244.8 5256.3 5259.2 4111.0 4161.5 4881.9 5098.6 5112.2 4186.0 4790.8 4953.3 5033.2 5227.6 5059.7 5118.6 5128.0 5128.2 5151.9 06:21:23 INFO - PROCESS | 1641 | 06:21:23 INFO - PROCESS | 1641 | [#5] yui.html Cycles:180 Average:19871.86 Median:4560.30 stddev:28093.31 (616.0%) stddev-sans-first:28135.35 06:21:23 INFO - PROCESS | 1641 | Values: 729.5 765.8 778.2 830.9 836.6 15058.4 15732.1 15740.1 15792.7 15872.4 14405.7 14519.9 14551.1 14557.3 14562.6 671.5 698.2 700.8 845.5 872.3 860.9 877.5 878.1 879.3 879.4 939.7 942.8 943.1 943.6 946.9 721.6 747.7 897.3 939.7 942.6 694.8 698.2 699.8 700.4 700.6 13219.9 14896.7 15495.9 15507.1 15526.1 13244.7 13444.7 13449.8 13887.4 14137.0 12954.9 12984.7 13061.7 13376.3 13389.5 4253.8 4540.5 4580.2 4593.4 4602.7 96399.5 103350.0 109634.0 109830.5 110475.3 10370.0 10787.5 11046.7 11069.9 11089.8 21274.0 21423.6 21473.6 21504.9 21569.7 6281.3 7517.8 7663.0 7828.4 7855.0 4185.9 4261.1 4265.0 4295.4 4435.9 3455.8 3510.9 3513.3 3528.3 3557.6 658.4 659.3 664.5 672.1 672.5 634.5 655.9 659.7 660.3 664.6 9458.3 9736.3 9751.3 9862.3 10005.9 627.9 649.6 653.4 665.4 676.5 4538.3 4603.3 4812.5 4835.4 4874.2 67933.0 94004.0 95435.5 96198.0 97402.0 88432.0 88445.6 89241.6 90246.0 90594.0 65164.3 73814.0 74818.9 76990.0 78219.6 9231.6 9303.4 9442.0 10515.4 10812.9 42244.8 44748.8 45358.8 45949.0 47452.8 60149.0 66801.7 67132.0 67467.3 67563.3 12655.6 12823.4 13092.1 13154.0 13189.6 14544.5 14797.3 14891.4 15155.5 15362.5 11986.9 12265.2 13762.6 14042.4 14111.3 11619.4 13380.8 13778.0 14064.6 14224.0 13498.2 13679.3 13754.0 13951.2 14213.1 9560.9 10881.8 11305.8 11305.9 11816.6 8888.7 10825.9 10902.8 11011.1 11019.0 06:21:23 INFO - PROCESS | 1641 | -------- Summary: end -------- 06:21:23 INFO - PROCESS | 1641 | 06:21:24 INFO - TEST-INFO | 1641: exit 0 06:21:24 INFO - TEST-OK | dromaeo_css | took 1117185ms 06:21:24 INFO - TEST-START | kraken 06:21:24 INFO - operating with platform_type : mac_ 06:21:24 INFO - Initialising browser for kraken test... 06:21:24 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmp6evkrW/profile http://localhost:49247/getInfo.html) 06:21:26 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 06:21:26 INFO - PROCESS | 1651 | colorDepth:24 06:21:26 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 06:21:26 INFO - PROCESS | 1651 | __metrics 06:21:26 INFO - PROCESS | 1651 | 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" 06:21:26 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:21:27 INFO - TEST-INFO | 1651: exit 0 06:21:27 INFO - Browser initialized. 06:21:27 INFO - Running cycle 1/1 for kraken test... 06:21:27 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmp6evkrW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:21:39 INFO - PROCESS | 1652 | RSS: Main: 227721216 06:21:39 INFO - PROCESS | 1652 | 06:21:42 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection) 06:21:43 INFO - PROCESS | 1652 | RSS: Main: 287174656 06:21:43 INFO - PROCESS | 1652 | 06:21:45 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-dft) 06:21:46 INFO - PROCESS | 1652 | RSS: Main: 288612352 06:21:46 INFO - PROCESS | 1652 | 06:21:49 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-fft) 06:21:50 INFO - PROCESS | 1652 | RSS: Main: 380526592 06:21:50 INFO - PROCESS | 1652 | 06:21:52 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator) 06:21:52 INFO - PROCESS | 1652 | RSS: Main: 285155328 06:21:52 INFO - PROCESS | 1652 | 06:21:54 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:21:55 INFO - PROCESS | 1652 | RSS: Main: 287686656 06:21:55 INFO - PROCESS | 1652 | 06:21:58 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom) 06:21:58 INFO - PROCESS | 1652 | RSS: Main: 328548352 06:21:58 INFO - PROCESS | 1652 | 06:22:01 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate) 06:22:02 INFO - PROCESS | 1652 | RSS: Main: 331083776 06:22:02 INFO - PROCESS | 1652 | 06:22:05 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial) 06:22:06 INFO - PROCESS | 1652 | RSS: Main: 329953280 06:22:06 INFO - PROCESS | 1652 | 06:22:07 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:22:08 INFO - PROCESS | 1652 | RSS: Main: 304504832 06:22:08 INFO - PROCESS | 1652 | 06:22:10 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:22:10 INFO - PROCESS | 1652 | RSS: Main: 308400128 06:22:10 INFO - PROCESS | 1652 | 06:22:12 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:22:13 INFO - PROCESS | 1652 | RSS: Main: 310571008 06:22:13 INFO - PROCESS | 1652 | 06:22:16 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:22:17 INFO - PROCESS | 1652 | RSS: Main: 327438336 06:22:17 INFO - PROCESS | 1652 | 06:22:20 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:22:20 INFO - PROCESS | 1652 | RSS: Main: 321761280 06:22:20 INFO - PROCESS | 1652 | 06:22:22 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49247/tests/kraken/driver.html?testName=ai-astar) 06:22:22 INFO - PROCESS | 1652 | RSS: Main: 365449216 06:22:22 INFO - PROCESS | 1652 | 06:22:22 INFO - PROCESS | 1652 | __start_tp_report 06:22:22 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 06:22:22 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 06:22:22 INFO - PROCESS | 1652 | |i|pagename|runs| 06:22:22 INFO - PROCESS | 1652 | |0;ai-astar;113;113;113;114;113;103;110;113;114;115 06:22:22 INFO - PROCESS | 1652 | |1;audio-beat-detection;146;110;111;146;112;110;110;112;131;108 06:22:22 INFO - PROCESS | 1652 | |2;audio-dft;186;185;183;186;185;183;181;183;185;183 06:22:22 INFO - PROCESS | 1652 | |3;audio-fft;78;59;58;85;60;59;59;59;75;73 06:22:22 INFO - PROCESS | 1652 | |4;audio-oscillator;89;71;86;70;69;70;82;69;69;83 06:22:22 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;88;100;112;84;87;85;88;84;88;85 06:22:22 INFO - PROCESS | 1652 | |6;imaging-darkroom;93;102;94;94;94;93;93;110;129;145 06:22:22 INFO - PROCESS | 1652 | |7;imaging-desaturate;85;87;112;132;130;86;87;87;85;88 06:22:22 INFO - PROCESS | 1652 | |8;json-parse-financial;58;57;57;57;55;55;55;56;56;56 06:22:22 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;66;75;66;76;75;69;71;71;73;72 06:22:22 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;86;86;85;86;87;86;84;106;107;76 06:22:22 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;145;150;148;129;146;148;145;171;199;171 06:22:22 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;173;173;174;173;172;175;172;171;172;172 06:22:22 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;68;67;67;68;67;67;66;67;65;66 06:22:22 INFO - PROCESS | 1652 | __end_tp_report 06:22:22 INFO - PROCESS | 1652 | __start_cc_report 06:22:22 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1937 06:22:22 INFO - PROCESS | 1652 | __end_cc_report 06:22:22 INFO - PROCESS | 1652 | __startTimestamp1484749342853__endTimestamp 06:22:22 INFO - PROCESS | 1652 | 06:22:22 INFO - PROCESS | 1652 | ------- Summary: start ------- 06:22:22 INFO - PROCESS | 1652 | Number of tests: 14 06:22:22 INFO - PROCESS | 1652 | 06:22:22 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:3.45 (3.0%) stddev-sans-first:3.64 06:22:22 INFO - PROCESS | 1652 | Values: 113.0 113.0 113.0 114.0 113.0 103.0 110.0 113.0 114.0 115.0 06:22:22 INFO - PROCESS | 1652 | 06:22:22 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:119.60 Median:112.00 stddev:15.36 (13.7%) stddev-sans-first:12.99 06:22:22 INFO - PROCESS | 1652 | Values: 146.0 110.0 111.0 146.0 112.0 110.0 110.0 112.0 131.0 108.0 06:22:22 INFO - PROCESS | 1652 | 06:22:22 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:184.00 Median:185.00 stddev:1.63 (0.9%) stddev-sans-first:1.56 06:22:22 INFO - PROCESS | 1652 | Values: 186.0 185.0 183.0 186.0 185.0 183.0 181.0 183.0 185.0 183.0 06:22:22 INFO - PROCESS | 1652 | 06:22:22 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:66.50 Median:66.50 stddev:10.16 (15.3%) stddev-sans-first:9.88 06:22:22 INFO - PROCESS | 1652 | Values: 78.0 59.0 58.0 85.0 60.0 59.0 59.0 59.0 75.0 73.0 06:22:22 INFO - PROCESS | 1652 | 06:22:22 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:75.80 Median:76.50 stddev:8.15 (10.7%) stddev-sans-first:7.11 06:22:22 INFO - PROCESS | 1652 | Values: 89.0 71.0 86.0 70.0 69.0 70.0 82.0 69.0 69.0 83.0 06:22:22 INFO - PROCESS | 1652 | 06:22:22 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:90.10 Median:86.00 stddev:8.99 (10.5%) stddev-sans-first:9.50 06:22:22 INFO - PROCESS | 1652 | Values: 88.0 100.0 112.0 84.0 87.0 85.0 88.0 84.0 88.0 85.0 06:22:22 INFO - PROCESS | 1652 | 06:22:22 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:104.70 Median:93.00 stddev:18.27 (19.6%) stddev-sans-first:18.88 06:22:22 INFO - PROCESS | 1652 | Values: 93.0 102.0 94.0 94.0 94.0 93.0 93.0 110.0 129.0 145.0 06:22:22 INFO - PROCESS | 1652 | 06:22:22 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:97.90 Median:86.50 stddev:19.21 (22.2%) stddev-sans-first:19.80 06:22:22 INFO - PROCESS | 1652 | Values: 85.0 87.0 112.0 132.0 130.0 86.0 87.0 87.0 85.0 88.0 06:22:22 INFO - PROCESS | 1652 | 06:22:22 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.50 stddev:1.03 (1.8%) stddev-sans-first:0.87 06:22:22 INFO - PROCESS | 1652 | Values: 58.0 57.0 57.0 57.0 55.0 55.0 55.0 56.0 56.0 56.0 06:22:22 INFO - PROCESS | 1652 | 06:22:22 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:72.50 stddev:3.57 (4.9%) stddev-sans-first:3.20 06:22:22 INFO - PROCESS | 1652 | Values: 66.0 75.0 66.0 76.0 75.0 69.0 71.0 71.0 73.0 72.0 06:22:22 INFO - PROCESS | 1652 | 06:22:22 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:86.00 stddev:9.79 (11.4%) stddev-sans-first:10.33 06:22:22 INFO - PROCESS | 1652 | Values: 86.0 86.0 85.0 86.0 87.0 86.0 84.0 106.0 107.0 76.0 06:22:22 INFO - PROCESS | 1652 | 06:22:22 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:155.20 Median:149.00 stddev:19.80 (13.3%) stddev-sans-first:20.65 06:22:22 INFO - PROCESS | 1652 | Values: 145.0 150.0 148.0 129.0 146.0 148.0 145.0 171.0 199.0 171.0 06:22:22 INFO - PROCESS | 1652 | 06:22:22 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.70 Median:173.00 stddev:1.16 (0.7%) stddev-sans-first:1.22 06:22:22 INFO - PROCESS | 1652 | Values: 173.0 173.0 174.0 173.0 172.0 175.0 172.0 171.0 172.0 172.0 06:22:22 INFO - PROCESS | 1652 | 06:22:22 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:0.92 (1.4%) stddev-sans-first:0.87 06:22:22 INFO - PROCESS | 1652 | Values: 68.0 67.0 67.0 68.0 67.0 67.0 66.0 67.0 65.0 66.0 06:22:22 INFO - PROCESS | 1652 | -------- Summary: end -------- 06:22:22 INFO - PROCESS | 1652 | 06:22:23 INFO - TEST-INFO | 1652: exit 0 06:22:23 INFO - TEST-OK | kraken | took 59633ms 06:22:23 INFO - SUITE-END | took 1176s 06:22:24 INFO - Completed test suite (00:19:37) 06:22:24 INFO - javascript benchmark 06:22:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3325.135464779158, 3333.1667083229195, 3333.3999880021593, 3366.0238530826064, 3391.931541564407, 4357.803898824553, 5105.310783044288, 5470.8085217017415, 5526.944730552693, 5538.086215774398, 5556.91664625031, 5580.553555715544, 5586.804461843836, 5592.161175823619, 5598.4961353478175, 5053.519915608012, 5062.72155031475, 5102.132637451642, 5147.9704059188125, 5182.844514664566, 5102.719350435725, 5131.743412829363, 5194.168932970725, 5201.141811601081, 5204.32343795306, 5128.461511541291, 5150.098732721777, 5216.426193118754, 5230.032443997854, 5250.921236181461, 5162.122439185328, 5177.249298851683, 5181.948180518184, 5190.2993095932325, 5196.1166601677805, 326.41707876059274, 5084.3644544431945, 5147.305113809625, 5158.638895277332, 5200.427952925175, 5513.696746678931, 5607.495325420691, 5609.607327487078, 5619.690916999604, 5634.690092044936, 6176.474999624992, 6183.443490085914, 6189.0, 6198.256209254918, 6204.565680402374, 6124.540659450559, 6198.783042593533, 6242.250929888397, 6271.749130034793, 6286.748530058792, 5637.3517045539875, 5677.744501497484, 5678.77284908599, 5726.685032323262, 5810.448007439287, 6325.810225693236, 6330.715117819709, 6350.4602108820345, 6351.745930162741, 6354.078658594571, 6100.69496525172, 6104.4200800923845, 6108.694565271808, 6118.541109416722, 6128.080787881764, 6032.668203248863, 6046.818595442144, 6112.877742445126, 6126.314740042852, 6131.908021379683, 6123.201403005315, 6145.539084568675, 6148.1392605035335, 6164.753409863645, 6172.69136543171, 6172.598781079216, 6177.6911154443, 6181.7527298908435, 6197.597156184834, 6198.876022479525, 4271.718484454651, 4839.879003024882, 4852.126617208936, 4942.332785074041, 5000.199968005102, 4304.332828411601, 4322.286822674287, 4401.031773009932, 4417.3153161259415, 4430.933535996963, 5627.5779316551425, 5688.374278829326, 5770.307563092456, 5786.768529258867, 5818.330891947396, 6104.368208815921, 6121.4529735759925, 6143.1706719592285, 6166.105914642351, 6208.0998255253635, 4873.926891096637, 5646.4353564644025, 5767.250257466587, 5787.421257874263, 5808.5933984621515, 5323.1749078892835, 5376.327959005124, 5400.324959380077, 5401.945980540223, 5421.918671219935, 6238.407351301619, 6244.781432649836, 6343.429091381798, 6344.619322840645, 6346.333634968262, 6194.938050619436, 6202.658853763086, 6207.534434917309, 6219.036049412167, 6236.75052997875, 6319.652419116993, 6321.431071203614, 6332.52506062038, 6337.397947195009, 6341.4292713656, 5903.2325797646035, 5956.821295361146, 5984.072468767348, 6085.1785009023215, 6094.695265236632, 6150.600210986271, 6160.075988601567, 6168.0439531872635, 6258.812235632939, 6270.435660790368, 5866.208061911588, 5877.35349111606, 6024.246969128859, 6026.0, 6037.667928263988, 5791.102379131242, 5911.645301281937, 5967.373425790403, 5984.820455386345, 5989.700514974146, 5679.602427830012, 5703.914441283467, 5711.086226203787, 5726.169705392778, 5780.5953583248765, 5027.9748601258225, 5721.084626459747, 5846.386129456346, 5854.063349864001, 5869.06095024794, 5720.6853623049465, 5739.368669446274, 5746.367899530965, 5754.597178197653, 5770.076787713946], "value": 5578.150993385545, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.2882249560633, 505.5702652745167, 506.98602794411175, 517.3403910014731, 573.0115550675083, 30782.076537703877, 40452.797736011315, 42112.15775684485, 42131.78934105325, 44127.558724412746, 42891.57108428915, 43255.78372108143, 43290.350644740356, 43302.783486082524, 43356.4825231117, 8389.916100839006, 8613.397062205648, 9160.129787670177, 9377.156055954963, 9396.859047114298, 11007.889921100767, 11251.774964500704, 11254.437278136102, 11464.025557827596, 11478.770424591503, 11193.384363859985, 11254.987051165393, 11288.096952243843, 11291.887081129165, 11301.49143288554, 11162.162837787198, 11232.21374503785, 11233.326000439918, 11237.101031917427, 11260.718482037933, 11124.0, 11219.0, 11219.0, 11228.270162439416, 11231.32612043272, 40838.59161408377, 40964.79517602423, 41101.58898411007, 41198.38202426966, 41211.381829272585, 4002.419649150857, 4015.8996025099314, 4053.61490658387, 4074.2666320062376, 4106.301928672133, 30139.849300753576, 30886.680472024433, 30953.0, 31309.0, 31334.686653133405, 3179.205198700325, 3222.274988127676, 3265.330607225513, 3290.720288775457, 3332.350191712617, 479318.0, 479460.0, 480551.9999999965, 481273.0, 483576.0, 63580.68209658922, 63873.680631596544, 63899.97100318961, 64044.67977660175, 64054.35945640577, 66157.66921165363, 66308.33691663117, 66309.33690663031, 66347.00479492811, 66417.33582664208, 15869.68260634781, 16024.278907449192, 16026.67946641084, 16034.11812350332, 16083.356665733474, 10913.017828395325, 11176.0, 12132.5146994121, 12282.14025018258, 12395.380230988594, 16677.380217534832, 16930.0, 20411.693824592643, 21122.36632900985, 21134.365969020953, 8729.60716767747, 8748.550405886363, 8770.38607297483, 8775.956120219485, 8851.557422128868, 767.0948281028328, 839.8656215005569, 859.2052351574769, 873.5108339329995, 897.1208215948277, 28930.492191503574, 30194.54708179379, 30257.09228723142, 30531.69468305333, 30841.537376939363, 1070.5931745936493, 1079.6545105566142, 1084.8752393474695, 1098.8297463201825, 1192.7197108679454, 15229.923850380677, 15303.540893773205, 15870.841291587167, 15893.284802183929, 16255.18724063792, 641145.0, 645009.0, 645174.0, 645396.0, 646820.0, 55848.72075639596, 56435.0, 56447.0, 56587.43412565822, 56619.43380566224, 1374.1205628397834, 1416.3980308368903, 1433.31917339263, 1436.0593811053568, 1438.5900018494679, 28752.0, 28834.7116528832, 28925.132246032652, 29563.556546651387, 29574.556381653863, 48627.004004259325, 49160.016799664525, 49208.753956229986, 49259.0, 49302.26046609232, 581987.9813220458, 584987.0, 586310.068449655, 586478.0, 587512.0, 24903.750962490867, 25551.6167257495, 26411.943522258895, 27097.72902270952, 27112.864435677697, 42663.7866810664, 42760.35859462173, 42985.785071074446, 42992.0, 43716.781416092716, 36272.4559131608, 36486.0, 36717.816410917774, 37398.06504837401, 37646.435303471015, 35539.40072696786, 35583.288334233686, 35946.46080308745, 35954.28091438209, 36590.8170459146, 35202.47196292006, 35282.0, 35311.11722206863, 35787.926362209175, 35980.0, 30928.69071309258, 31783.523247151774, 32109.678903210668, 32182.67817321797, 32397.35205295928, 23548.764512354657, 23638.17266395668, 24013.399665008514, 24189.758102419455, 24191.51616967686], "value": 20259.76894844047, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.039008966776, 388.47749776550546, 391.87068267471733, 397.71960767658794, 416.014046709299, 15119.319630616621, 19597.24852955836, 21008.05463754131, 21015.36953891382, 21890.781092189074, 20780.376588702326, 21145.0, 21678.024488897998, 21900.561988760255, 22140.778592214072, 4607.953920460786, 5532.6680399176075, 5774.2782152230975, 5776.653400795944, 5788.334341550733, 5356.38401583817, 5730.283714535683, 5761.769529218826, 5769.336526299488, 5772.797952071678, 5511.751971161308, 5653.095504719246, 5713.17159011943, 5718.513926316268, 5728.083506638938, 5608.775648974057, 5634.4928956393915, 5656.1798539211995, 5656.971715141398, 5666.801661941853, 4824.372831531913, 4895.363602731622, 4926.9014619707405, 4987.401511818569, 5000.82497112603, 23278.767212327828, 23414.64878026831, 24332.87833560821, 25771.226863194133, 26086.478270434676, 2713.0775536317747, 2717.4565086982684, 2752.6421565196597, 2769.2938300733385, 2815.0991682661556, 11765.0, 14793.260336983109, 14843.628909277246, 15352.080989876265, 15489.612759680986, 1570.9160679131478, 1791.265581111738, 1793.5695433096093, 1841.7697787776528, 1845.2342277954633, 133361.0, 134838.0, 136251.31874340566, 137319.31340343333, 137762.3111884444, 11131.944340278409, 11184.776304473866, 11414.600488982845, 11500.654980350602, 11505.309681418974, 14414.711705765825, 14425.609981654303, 14427.49503767363, 14429.91775616833, 14430.42278308856, 8245.340372770164, 8511.787205319793, 8512.74461766148, 8674.0, 8692.304615630734, 8417.032041315204, 8425.578721063923, 8447.662093516314, 8602.39783215169, 8604.956975215084, 6869.244383117853, 6976.197737260179, 6984.650767461607, 6985.231624521299, 6987.091678081919, 1603.7170263788921, 1779.3950056980689, 1894.4316704988448, 1913.4164079955747, 1916.559191385989, 1023.948802559869, 1049.2026060194307, 1049.9265051446325, 1061.0633505536512, 1082.5832054659013, 17831.10844457772, 22287.888560557094, 22296.996635151456, 22340.888295558743, 22521.0, 1009.3489699144011, 1046.785408991155, 1051.5215576912487, 1102.2394547762178, 1104.7790441911488, 10789.514471848786, 11659.533618655329, 11730.0, 11754.88245117555, 11758.647240582795, 296226.0, 298660.0, 541797.0, 699278.0, 728042.7565794723, 136434.31782841022, 136666.0, 138604.0, 139185.6081439193, 139931.0, 998.8951160128228, 1005.3716427232979, 1034.2088302448633, 1037.823569993103, 1040.5785656809005, 15412.532180259352, 18376.0, 18458.907705461388, 19290.0, 19364.0, 52328.0, 53762.731186343815, 54148.0, 54353.72823135859, 54670.0, 71325.28674713186, 72310.27689723036, 74606.0, 74988.0, 75405.24594754202, 7695.88456173169, 7899.881501777363, 7948.165442628672, 8002.319802816825, 8156.0, 11841.815818418088, 12928.353582321035, 13101.148425352321, 13600.93199533996, 13918.58244252674, 11440.48517816717, 11488.094048023711, 11647.12646551529, 11678.0, 11710.180287380143, 9019.639214431349, 9789.706308810748, 10844.837327439936, 10953.56185752561, 11045.613403530839, 11023.118150548098, 11269.323840569592, 11379.089672825989, 11457.427128643702, 11461.828072578752, 7738.148803631483, 7743.612819358897, 7835.4123440743315, 7918.287354138155, 7943.92056079455, 10616.84074738864, 10914.399708015817, 10933.343999360064, 10955.780884382428, 11018.724531886766], "value": 9813.81414541557, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.3245942571784, 1384.4393020826565, 1452.477108241033, 1476.0922032949738, 1488.1963739580624, 7405.629718514079, 7770.533767973926, 8077.434579579424, 8336.749897503085, 8340.499570025788, 8205.466644668093, 8292.668293268278, 8303.33573314135, 8303.91696083039, 8313.916860831405, 2298.7011688480475, 2341.0752752662775, 2348.6242201247805, 2348.7533808949984, 2349.1543044503965, 2074.2429013410147, 2135.1886283212357, 2284.565932472833, 2338.0998315648512, 2348.1664009276715, 2320.3271051395077, 2320.3503019154577, 2320.512692334612, 2325.2326732178426, 2328.3247858121126, 2259.186692790594, 2285.1430713482446, 2285.7942785149335, 2292.197730794225, 2294.242899843048, 2196.077647388101, 2228.2089858100303, 2242.573910956913, 2246.6854640350366, 2247.3932038349717, 8212.301954333889, 8390.580470976427, 8396.874046889241, 8401.495910245405, 8425.11536288687, 4980.825671101494, 5139.665921715114, 5154.149565321717, 5154.891698284887, 5154.896902061938, 3291.53918451417, 3435.1927297085167, 3450.4996775467416, 3468.497067925162, 3529.1177205698577, 1164.889335513125, 1211.19455562052, 1228.4656174564093, 1254.2474515290844, 1256.7674980128613, 10661.040506354466, 10682.626108086257, 10809.0, 10839.187060970458, 10840.241183117185, 4420.0, 4594.517575654575, 4632.652551058684, 4670.7664616769025, 4675.906481870344, 9446.149846513847, 9446.291528135418, 9447.244220462484, 9468.763280918032, 9473.47895865734, 5178.61160412963, 5179.352580927384, 5179.637425380262, 5181.1969144782615, 5196.986587615379, 4556.3621093047, 4654.092451971833, 4699.248120300804, 4748.715077095385, 4748.738819364969, 3731.2537492501065, 3758.962410375916, 3790.33669107905, 3843.327417701947, 3884.9223015539533, 1231.4704676988802, 1234.1237721218035, 1240.8697086805937, 1251.8810712982252, 1254.2975933477283, 861.8836457078339, 871.5511511571545, 883.3683916000091, 904.1500989070253, 917.2661870503571, 5183.352080989876, 5223.268742376071, 5475.06923822951, 5497.092979658391, 5498.532624726863, 523.9056969745483, 569.7863301262026, 575.4217011903011, 577.5812535911431, 579.9681017544076, 3567.9821600892346, 3621.8189090545893, 3663.6153203913736, 3670.4310831821113, 3723.8510459581853, 9415.717528474157, 9846.359986600848, 9855.655052073143, 9858.654947076819, 9869.555869985725, 9702.466364350028, 9844.409335439897, 9863.852042219372, 9879.012098790206, 9892.25808064398, 7376.0, 7638.350740187036, 7709.344705699966, 7755.108162561265, 7763.61181940912, 5514.145307477347, 5680.2047713321, 5712.228849105318, 5720.17057526648, 5755.395683453345, 8853.69012084574, 9054.592543335697, 9167.816643667224, 9229.03095174997, 9368.484733339732, 9312.906870931203, 9329.067093290616, 9410.29422793307, 9447.00806415344, 9479.004704505927, 7123.465740069412, 7301.890471643036, 7312.451566132455, 7316.487845850952, 7329.450291228072, 7700.268474494914, 7758.146603873683, 7778.222177782177, 7809.726659566888, 7835.608219589112, 7065.328793764585, 7123.501354905314, 7146.249643787535, 7163.3552980232025, 7197.352238298578, 6031.909521357271, 6998.335158159966, 7002.614856182755, 7022.40309573692, 7071.575705457689, 6257.812265632038, 6337.96831015842, 6389.280185565726, 6397.136386587751, 6443.130177425987, 4861.6596838220985, 4879.585235254901, 4943.406791185081, 4970.130227210151, 5130.4100028497205, 4415.735055896656, 4877.975610121926, 5030.220315851049, 5044.066847633199, 5070.112730272262], "value": 4334.200041540425, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.16375896499807, 353.7947990165704, 359.98740044098463, 363.1846504597179, 376.2888141412729, 4799.688020278684, 4837.8790530236765, 4913.75692043252, 5024.171011783052, 5024.422191447985, 3940.7635541867508, 4798.352222449968, 4974.726390048546, 4983.800647974077, 5018.874528136798, 3503.9663299326758, 3727.608601096873, 3950.249452604003, 3978.4231286463446, 3981.9890955067794, 3035.317053662919, 3224.339010502841, 3288.6053673559086, 3847.7498962567483, 3967.404889266604, 3246.853891574873, 3796.9240615187678, 3885.7862817545024, 3907.257621051991, 3946.0529472926432, 3570.8571657133684, 3768.4912536807456, 3907.7069219808345, 3920.372740361557, 3940.389239667856, 3301.4882693182353, 3464.0300715799617, 3511.455724362728, 3525.3301872644115, 3536.3104194682046, 4846.951530484721, 4880.267959806022, 4907.356035728036, 4923.359963204796, 4930.408350997904, 3818.7708737475564, 4021.416894550303, 4562.087582483483, 4567.33773602829, 4571.405717256768, 4288.828446862121, 5096.490350964911, 5277.234800953878, 5296.9735151324385, 5421.647592906448, 3200.8239546824916, 3680.1719613087107, 3704.759190652599, 3718.200586873835, 3725.9813700931595, 4943.579795717368, 5496.0, 5563.693996830173, 5578.163275508666, 5603.887922241533, 3493.3013397320638, 3622.3479773640997, 3763.9059023524633, 3768.1898391845884, 3800.7719536827326, 3663.432168013962, 3711.587468145673, 3770.6040865708705, 3777.7166712496123, 3808.7524310919703, 3772.8868133956025, 3958.44581758554, 4023.5574086850424, 4064.309067458539, 4380.649548036149, 4913.828016019422, 4917.286993385939, 4942.9011419771405, 5342.973285133549, 5388.030154572215, 1124.690710054725, 1188.257339163023, 1223.9755204895853, 1225.828384026237, 1234.7714024545635, 725.5646612032738, 795.8976817108347, 842.6587232170981, 853.5134973065417, 865.3466632692277, 4466.868146964045, 4575.839845605387, 4642.651801114863, 4773.832915847928, 4880.536349046835, 4640.443146822336, 4642.79107440166, 5153.0, 5179.766910489037, 5189.844304670866, 3728.6209783518457, 3799.031247031989, 4269.815580730901, 4558.133954548625, 4750.667453278306, 2334.9182778602667, 2394.6527753476, 2400.59189937711, 2644.386923976373, 2699.987504685743, 4498.707584007029, 4828.589569886529, 5043.3861164427035, 5410.269613602113, 5432.2123292123215, 4129.607687269705, 4464.709793863389, 4517.661175411858, 5034.395872495324, 5104.438511763703, 5172.5344718973965, 5243.973780131075, 5274.472552744772, 5402.486763757358, 5410.404855465896, 4247.893802654959, 4586.798336798289, 4858.028394321079, 5125.692458452505, 5147.536721695065, 4198.187214566187, 4562.292844609091, 4873.610111191026, 4887.926681099858, 5100.7449627517735, 4384.671149663852, 4803.639727020557, 5370.4629537045985, 5428.647137936022, 5433.782648694008, 3070.3245286037036, 3182.2521707399205, 3514.927946976197, 3517.2086280586664, 3522.718182545339, 4468.575485328888, 4821.493743157058, 5112.571528523921, 5113.64204505681, 5161.690298582097, 4677.579017888406, 4906.607471402351, 5233.188855727369, 5241.44964778708, 5260.842174734764, 4902.338184345068, 5241.790328386975, 5244.7902083916215, 5256.345545499498, 5259.237410575522, 4111.033907031785, 4161.479815023122, 4881.925976285212, 5098.592112631055, 5112.156494178419, 4185.9581404185565, 4790.760461976817, 4953.331300274561, 5033.169527028146, 5227.634065615523, 5059.671121377099, 5118.641695081457, 5128.0, 5128.230765385222, 5151.922721159111], "value": 3771.8442770184265, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.4930023633574, 765.7894079128242, 778.2062296457614, 830.9086000539941, 836.5858899844578, 15058.397664093436, 15732.05607663541, 15740.055596664208, 15792.68414631708, 15872.444464443732, 14405.711885762279, 14519.927400362983, 14551.126932384064, 14557.27213639319, 14562.635934101652, 671.4561205423598, 698.2458944340101, 700.7792545348225, 845.4842546046906, 872.2847265242503, 860.862262038074, 877.4603618774439, 878.0560897035712, 879.3053487744706, 879.3580686099151, 939.6992962252082, 942.8255772682041, 943.1417410156758, 943.6036864516885, 946.9005754395793, 721.5959062924779, 747.7495039161887, 897.264243320471, 939.6664184214574, 942.5899733615864, 694.8054544727485, 698.2214830463996, 699.8040548646387, 700.4186525184085, 700.6461736822872, 13219.94240460761, 14896.70206595862, 15495.922520387327, 15507.069575825486, 15526.146061966587, 13244.73510529784, 13444.731105377936, 13449.798253026212, 13887.4445022199, 14137.010409271355, 12954.870451295461, 12984.740305193938, 13061.673458163526, 13376.264305463195, 13389.518725131536, 4253.8301966959025, 4540.4551453825425, 4580.152671755736, 4593.379893714339, 4602.654800889946, 96399.51800240955, 103350.0, 109634.0, 109830.45084774605, 110475.34286985782, 10370.0, 10787.460626968621, 11046.668599942015, 11069.944650276697, 11089.778204435866, 21274.0, 21423.571528569653, 21473.570528589342, 21504.92475376225, 21569.67645485319, 6281.3404592518045, 7517.8120546985665, 7663.0, 7828.412869034845, 7855.0, 4185.91628167441, 4261.126469073833, 4264.978675106605, 4295.3771703102875, 4435.933460998088, 3455.7926524408617, 3510.8771193008124, 3513.3149035937745, 3528.2590655962535, 3557.573091229069, 658.3581008516753, 659.2715049869921, 664.5215444879678, 672.0591172358737, 672.4519516593961, 634.511426201822, 655.8557117434252, 659.677346919433, 660.2572106380322, 664.6012392564422, 9458.33791634579, 9736.318457708034, 9751.317407781387, 9862.260330475243, 10005.899941000496, 627.9058141278845, 649.5972497051858, 653.389081209071, 665.4111111666114, 676.546713701821, 4538.319252112209, 4603.309503574491, 4812.494688057774, 4835.395575553056, 4874.195757699939, 67933.0, 94004.0, 95435.52282238683, 96198.0, 97402.0, 88432.0, 88445.557772212, 89241.55379223192, 90246.0, 90594.0, 65164.34835651678, 73814.0, 74818.8777168343, 76990.0, 78219.60890195513, 9231.58457869384, 9303.441793492411, 9442.0, 10515.421651809223, 10812.891871081503, 42244.788776055924, 44748.77625611851, 45358.77320613376, 45949.0, 47452.8136796569, 60149.0, 66801.66396671942, 67131.99302010571, 67467.32532674611, 67563.3243667557, 12655.557055503014, 12823.422945967268, 13092.083554151119, 13154.013448991554, 13189.604311870658, 14544.49094281695, 14797.334119964413, 14891.404343826125, 15155.545333640008, 15362.539123826304, 11986.940065299617, 12265.202761820454, 13762.587122386345, 14042.368093436024, 14111.2944352784, 11619.376577096806, 13380.799288010492, 13778.0, 14064.648383790487, 14224.0, 13498.190108593515, 13679.316034198051, 13754.0, 13951.162930224218, 14213.147211167363, 9560.904390956, 10881.78236435251, 11305.773884522428, 11305.886941130813, 11816.645500634995, 8888.733337999613, 10825.945870270913, 10902.78194436091, 11011.064059555027, 11019.0], "value": 7476.237555130774, "unit": "score"}], "name": "dromaeo_css", "value": 7167.37780885219, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 114.0, 113.0, 103.0, 110.0, 113.0, 114.0, 115.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 110.0, 111.0, 146.0, 112.0, 110.0, 110.0, 112.0, 131.0, 108.0], "value": 119.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 183.0, 186.0, 185.0, 183.0, 181.0, 183.0, 185.0, 183.0], "value": 184.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 59.0, 58.0, 85.0, 60.0, 59.0, 59.0, 59.0, 75.0, 73.0], "value": 66.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 86.0, 70.0, 69.0, 70.0, 82.0, 69.0, 69.0, 83.0], "value": 75.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 100.0, 112.0, 84.0, 87.0, 85.0, 88.0, 84.0, 88.0, 85.0], "value": 90.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 102.0, 94.0, 94.0, 94.0, 93.0, 93.0, 110.0, 129.0, 145.0], "value": 104.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 112.0, 132.0, 130.0, 86.0, 87.0, 87.0, 85.0, 88.0], "value": 97.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 57.0, 57.0, 55.0, 55.0, 55.0, 56.0, 56.0, 56.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 75.0, 66.0, 76.0, 75.0, 69.0, 71.0, 71.0, 73.0, 72.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 85.0, 86.0, 87.0, 86.0, 84.0, 106.0, 107.0, 76.0], "value": 88.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 150.0, 148.0, 129.0, 146.0, 148.0, 145.0, 171.0, 199.0, 171.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 173.0, 174.0, 173.0, 172.0, 175.0, 172.0, 171.0, 172.0, 172.0], "value": 172.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 68.0, 67.0, 67.0, 66.0, 67.0, 65.0, 66.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1461.9, "alertThreshold": 2.0}]} 06:22:24 INFO - Return code: 0 06:22:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:22:24 ERROR - # TBPL SUCCESS # 06:22:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:22:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:22:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:22:24 INFO - 2017-01-18 06:22:24.153 screenresolution[1656:10088] starting screenresolution argv=screenresolution get 06:22:24 INFO - 2017-01-18 06:22:24.156 screenresolution[1656:10088] Display 0: 1600x1200x32@60 06:22:24 INFO - 2017-01-18 06:22:24.162 screenresolution[1657:10092] starting screenresolution argv=screenresolution list 06:22:24 INFO - Available Modes on Display 0 06:22:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:22:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:22:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:22:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:22:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:22:24 INFO - Intel Iris: 06:22:24 INFO - Chipset Model: Intel Iris 06:22:24 INFO - Type: GPU 06:22:24 INFO - Bus: Built-In 06:22:24 INFO - VRAM (Dynamic, Max): 1536 MB 06:22:24 INFO - Vendor: Intel (0x8086) 06:22:24 INFO - Device ID: 0x0a2e 06:22:24 INFO - Revision ID: 0x0009 06:22:24 INFO - Displays: 06:22:24 INFO - Display: 06:22:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:22:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:22:24 INFO - Display Serial Number: 1600x1200 60 06:22:24 INFO - Main Display: Yes 06:22:24 INFO - Mirror: Off 06:22:24 INFO - Online: Yes 06:22:24 INFO - Rotation: Supported 06:22:24 INFO - Return code: 0 06:22:24 INFO - Running post-action listener: _resource_record_post_action 06:22:24 INFO - [mozharness: 2017-01-18 14:22:24.399815Z] Finished run-tests step (success) 06:22:24 INFO - Running post-run listener: _resource_record_post_run 06:22:24 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 38781952; Write bytes: 554333184; Read time: 378; Write time: 1711 06:22:24 INFO - TinderboxPrint: CPU usage
53.8% 06:22:24 INFO - TinderboxPrint: I/O read bytes / time
38,781,952 / 378 06:22:24 INFO - TinderboxPrint: I/O write bytes / time
554,333,184 / 1,711 06:22:24 INFO - TinderboxPrint: CPU idle
2,218.4 (46.2%) 06:22:24 INFO - TinderboxPrint: CPU system
963.5 (20.1%) 06:22:24 INFO - TinderboxPrint: CPU user
1,619.7 (33.7%) 06:22:24 INFO - TinderboxPrint: Swap in / out
290,328,576 / 0 06:22:24 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 241961472; Write bytes: 236636160; Read time: 17462; Write time: 546 06:22:24 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 36783104; Write bytes: 298032128; Read time: 356; Write time: 1126 06:22:24 INFO - Running post-run listener: _upload_blobber_files 06:22:24 INFO - Blob upload gear active. 06:22:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:22:24 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 06:22:24 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:22:24 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:22:25 INFO - (blobuploader) - INFO - Open directory for files ... 06:22:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:22:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:22:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:22:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:22:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:22:26 INFO - (blobuploader) - INFO - Done attempting. 06:22:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:22:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:22:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:22:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:22:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:22:27 INFO - (blobuploader) - INFO - Done attempting. 06:22:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:22:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:22:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:22:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:22:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:22:28 INFO - (blobuploader) - INFO - Done attempting. 06:22:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:22:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:22:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:22:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:22:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:22:30 INFO - (blobuploader) - INFO - Done attempting. 06:22:30 INFO - (blobuploader) - INFO - Iteration through files over. 06:22:30 INFO - Return code: 0 06:22:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:22:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:22:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/efee19c05d1b2c22a4cab2c70a11e7babffef02d06888239142d43d8d7af833a824f2f75f0d161d1195a039951628bb24465545dab1cfba7a2e397af9802bece", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/fbe6947ede3dd147ab939615ac3f301ebb02bec5f41d8a0b65f1524ba0cd567ae2c7372a46cfa1fcf0c7481beba0cecdd4bda046fac8aa7ed87554aebb0f2a30", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4d9da137dbf96b728f7f0de6b551d398674c2965fd90cf7f68a4b03887adb97993d967ad892014190e29577968c8f6ebab92653503c384f7cfb80ae1ed8346c0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5af54243ec884cf17eea5e675a3c35b89f3a7969b9b53be2b5ea13d98e7d7ddb8e6b98528423f2a7123b6575c42c9e95dcc79b5e5ff3731d7ef82ec33e34fbbb"} 06:22:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:22:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:22:30 INFO - Contents: 06:22:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/efee19c05d1b2c22a4cab2c70a11e7babffef02d06888239142d43d8d7af833a824f2f75f0d161d1195a039951628bb24465545dab1cfba7a2e397af9802bece", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/fbe6947ede3dd147ab939615ac3f301ebb02bec5f41d8a0b65f1524ba0cd567ae2c7372a46cfa1fcf0c7481beba0cecdd4bda046fac8aa7ed87554aebb0f2a30", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4d9da137dbf96b728f7f0de6b551d398674c2965fd90cf7f68a4b03887adb97993d967ad892014190e29577968c8f6ebab92653503c384f7cfb80ae1ed8346c0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5af54243ec884cf17eea5e675a3c35b89f3a7969b9b53be2b5ea13d98e7d7ddb8e6b98528423f2a7123b6575c42c9e95dcc79b5e5ff3731d7ef82ec33e34fbbb"} 06:22:30 INFO - Running post-run listener: copy_logs_to_upload_dir 06:22:30 INFO - Copying logs to upload dir... 06:22:30 INFO - mkdir: /builds/slave/test/build/upload/logs 06:22:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.971656 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-18 06:22:30.396165) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-18 06:22:30.400315) ========= 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.uogyfgLNx6/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.kdfolJLwDw/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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/Graphics/sha512/efee19c05d1b2c22a4cab2c70a11e7babffef02d06888239142d43d8d7af833a824f2f75f0d161d1195a039951628bb24465545dab1cfba7a2e397af9802bece", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/fbe6947ede3dd147ab939615ac3f301ebb02bec5f41d8a0b65f1524ba0cd567ae2c7372a46cfa1fcf0c7481beba0cecdd4bda046fac8aa7ed87554aebb0f2a30", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4d9da137dbf96b728f7f0de6b551d398674c2965fd90cf7f68a4b03887adb97993d967ad892014190e29577968c8f6ebab92653503c384f7cfb80ae1ed8346c0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5af54243ec884cf17eea5e675a3c35b89f3a7969b9b53be2b5ea13d98e7d7ddb8e6b98528423f2a7123b6575c42c9e95dcc79b5e5ff3731d7ef82ec33e34fbbb"} build_url:https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010976 build_url: 'https://queue.taskcluster.net/v1/task/HaHq5S69Roi59vRIAd8-PA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/efee19c05d1b2c22a4cab2c70a11e7babffef02d06888239142d43d8d7af833a824f2f75f0d161d1195a039951628bb24465545dab1cfba7a2e397af9802bece", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/fbe6947ede3dd147ab939615ac3f301ebb02bec5f41d8a0b65f1524ba0cd567ae2c7372a46cfa1fcf0c7481beba0cecdd4bda046fac8aa7ed87554aebb0f2a30", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4d9da137dbf96b728f7f0de6b551d398674c2965fd90cf7f68a4b03887adb97993d967ad892014190e29577968c8f6ebab92653503c384f7cfb80ae1ed8346c0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5af54243ec884cf17eea5e675a3c35b89f3a7969b9b53be2b5ea13d98e7d7ddb8e6b98528423f2a7123b6575c42c9e95dcc79b5e5ff3731d7ef82ec33e34fbbb"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-18 06:22:30.437477) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 06:22:30.437843) ========= 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.uogyfgLNx6/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.kdfolJLwDw/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.005112 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 06:22:30.485370) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-18 06:22:30.485672) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-18 06:22:30.488972) ========= ========= Total master_lag: 0.20 =========