builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0219 starttime: 1482350921.93 results: success (0) buildid: 20161221075354 builduid: 9ccf4e2c071042749c4908a6ff1b0832 revision: 8a362f5c65fbe14a6976beb15905e20fca53d3ac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 12:08:41.933878) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 12:08:41.934319) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 12:08:41.934588) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 12:08:41.961114) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 12:08:41.961478) ========= 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.wTvCMElAkW/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.19bGU1TyIP/Listeners TMPDIR=/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-21 12:08:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 35.1M=0s 2016-12-21 12:08:42 (35.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130653 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 12:08:42.116322) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 12:08:42.116672) ========= 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.wTvCMElAkW/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.19bGU1TyIP/Listeners TMPDIR=/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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.026018 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 12:08:42.164618) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-21 12:08:42.168102) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 8a362f5c65fbe14a6976beb15905e20fca53d3ac --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 8a362f5c65fbe14a6976beb15905e20fca53d3ac --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wTvCMElAkW/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.19bGU1TyIP/Listeners TMPDIR=/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-21 12:08:42,267 truncating revision to first 12 chars 2016-12-21 12:08:42,267 Setting DEBUG logging. 2016-12-21 12:08:42,267 attempt 1/10 2016-12-21 12:08:42,267 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/8a362f5c65fb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-21 12:08:42,970 unpacking tar archive at: graphics-8a362f5c65fb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.982537 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-21 12:08:43.174196) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 12:08:43.174516) ========= script_repo_revision: 8a362f5c65fbe14a6976beb15905e20fca53d3ac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 12:08:43.178051) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 12:08:43.178439) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 12:08:43.197786) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-12-21 12:08:43.198165) ========= /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.wTvCMElAkW/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.19bGU1TyIP/Listeners TMPDIR=/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 12:08:43 INFO - MultiFileLogger online at 20161221 12:08:43 in /builds/slave/test 12:08:43 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 12:08:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:08:43 INFO - {'append_to_log': False, 12:08:43 INFO - 'base_work_dir': '/builds/slave/test', 12:08:43 INFO - 'blob_upload_branch': 'Graphics', 12:08:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:08:43 INFO - 'branch': 'Graphics', 12:08:43 INFO - 'buildbot_json_path': 'buildprops.json', 12:08:43 INFO - 'config_files': ('talos/mac_config.py',), 12:08:43 INFO - 'default_actions': ('clobber', 12:08:43 INFO - 'read-buildbot-config', 12:08:43 INFO - 'download-and-extract', 12:08:43 INFO - 'populate-webroot', 12:08:43 INFO - 'create-virtualenv', 12:08:43 INFO - 'install', 12:08:43 INFO - 'run-tests'), 12:08:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:08:43 INFO - 'download_minidump_stackwalk': True, 12:08:43 INFO - 'download_symbols': 'ondemand', 12:08:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:08:43 INFO - 'tooltool.py': '/tools/tooltool.py', 12:08:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:08:43 INFO - '/tools/misc-python/virtualenv.py')}, 12:08:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:08:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:08:43 INFO - 'installer_path': 'installer.exe', 12:08:43 INFO - 'log_level': 'info', 12:08:43 INFO - 'log_name': 'talos', 12:08:43 INFO - 'log_to_console': True, 12:08:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:08:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:08:43 INFO - 'opt_config_files': (), 12:08:43 INFO - 'pip_index': False, 12:08:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:08:43 INFO - 'cmd': ('bash', 12:08:43 INFO - '-c', 12:08:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:08:43 INFO - 'enabled': True, 12:08:43 INFO - 'halt_on_failure': False, 12:08:43 INFO - 'name': 'check_screen_resolution'},), 12:08:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:08:43 INFO - 'cmd': ('bash', 12:08:43 INFO - '-c', 12:08:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:08:43 INFO - 'enabled': True, 12:08:43 INFO - 'halt_on_failure': False, 12:08:43 INFO - 'name': 'check_screen_resolution'},), 12:08:43 INFO - 'run_cmd_checks_enabled': True, 12:08:43 INFO - 'sps_profile': False, 12:08:43 INFO - 'sps_profile_interval': 0, 12:08:43 INFO - 'suite': 'dromaeojs', 12:08:43 INFO - 'system_bits': '32', 12:08:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:08:43 INFO - 'title': 't-yosemite-r7-0219', 12:08:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:08:43 INFO - 'use_talos_json': True, 12:08:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:08:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:08:43 INFO - 'work_dir': 'build'} 12:08:43 INFO - [mozharness: 2016-12-21 20:08:43.405507Z] Running clobber step. 12:08:43 INFO - Running pre-action listener: _resource_record_pre_action 12:08:43 INFO - Running main action method: clobber 12:08:43 INFO - rmtree: /builds/slave/test/build 12:08:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:08:45 INFO - Running post-action listener: _resource_record_post_action 12:08:45 INFO - [mozharness: 2016-12-21 20:08:45.434172Z] Finished clobber step (success) 12:08:45 INFO - [mozharness: 2016-12-21 20:08:45.434293Z] Running read-buildbot-config step. 12:08:45 INFO - Running pre-action listener: _resource_record_pre_action 12:08:45 INFO - Running main action method: read_buildbot_config 12:08:45 INFO - Using buildbot properties: 12:08:45 INFO - { 12:08:45 INFO - "project": "", 12:08:45 INFO - "product": "firefox", 12:08:45 INFO - "script_repo_revision": "default", 12:08:45 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 12:08:45 INFO - "repository": "", 12:08:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 12:08:45 INFO - "buildid": "20161221075354", 12:08:45 INFO - "pgo_build": "False", 12:08:45 INFO - "basedir": "/builds/slave/test", 12:08:45 INFO - "buildnumber": 2, 12:08:45 INFO - "slavename": "t-yosemite-r7-0219", 12:08:45 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 12:08:45 INFO - "platform": "yosemite_r7", 12:08:45 INFO - "scheduler": "tests-graphics-macosx64-talos", 12:08:45 INFO - "branch": "graphics", 12:08:45 INFO - "repo_path": "projects/graphics", 12:08:45 INFO - "revision": "8a362f5c65fbe14a6976beb15905e20fca53d3ac", 12:08:45 INFO - "stage_platform": "macosx64", 12:08:45 INFO - "builduid": "9ccf4e2c071042749c4908a6ff1b0832", 12:08:45 INFO - "slavebuilddir": "test" 12:08:45 INFO - } 12:08:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/bU7UfBx0Ra2yQrxHXJZc-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 12:08:45 INFO - Running post-action listener: _resource_record_post_action 12:08:45 INFO - [mozharness: 2016-12-21 20:08:45.437620Z] Finished read-buildbot-config step (success) 12:08:45 INFO - [mozharness: 2016-12-21 20:08:45.437711Z] Running download-and-extract step. 12:08:45 INFO - Running pre-action listener: _resource_record_pre_action 12:08:45 INFO - Running main action method: download_and_extract 12:08:45 INFO - mkdir: /builds/slave/test/build/tests 12:08:45 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')]} 12:08:45 INFO - trying https://queue.taskcluster.net/v1/task/bU7UfBx0Ra2yQrxHXJZc-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 12:08:45 INFO - Downloading https://queue.taskcluster.net/v1/task/bU7UfBx0Ra2yQrxHXJZc-Q/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 12:08:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bU7UfBx0Ra2yQrxHXJZc-Q/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 12:08:46 INFO - Downloaded 1199 bytes. 12:08:46 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 12:08:46 INFO - Using the following test package requirements: 12:08:46 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 12:08:46 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:08:46 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 12:08:46 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:08:46 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 12:08:46 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:08:46 INFO - u'jsshell-mac.zip'], 12:08:46 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:08:46 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 12:08:46 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 12:08:46 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:08:46 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 12:08:46 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:08:46 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 12:08:46 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:08:46 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 12:08:46 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:08:46 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 12:08:46 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:08:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bU7UfBx0Ra2yQrxHXJZc-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 12:08:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bU7UfBx0Ra2yQrxHXJZc-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:08:46 INFO - Fetch https://queue.taskcluster.net/v1/task/bU7UfBx0Ra2yQrxHXJZc-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 12:08:47 INFO - Expected file size: 16277709 12:08:47 INFO - Obtained file size: 16277709 12:08:54 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 12:08:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bU7UfBx0Ra2yQrxHXJZc-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 12:08:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bU7UfBx0Ra2yQrxHXJZc-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:08:54 INFO - Fetch https://queue.taskcluster.net/v1/task/bU7UfBx0Ra2yQrxHXJZc-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 12:08:55 INFO - Expected file size: 16277709 12:08:55 INFO - Obtained file size: 16277709 12:09:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bU7UfBx0Ra2yQrxHXJZc-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 12:09:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bU7UfBx0Ra2yQrxHXJZc-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:09:01 INFO - Fetch https://queue.taskcluster.net/v1/task/bU7UfBx0Ra2yQrxHXJZc-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 12:09:02 INFO - Expected file size: 14409734 12:09:02 INFO - Obtained file size: 14409734 12:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:02 INFO - trying https://queue.taskcluster.net/v1/task/bU7UfBx0Ra2yQrxHXJZc-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 12:09:02 INFO - Downloading https://queue.taskcluster.net/v1/task/bU7UfBx0Ra2yQrxHXJZc-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 12:09:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bU7UfBx0Ra2yQrxHXJZc-Q/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 12:09:07 INFO - Downloaded 69589991 bytes. 12:09:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bU7UfBx0Ra2yQrxHXJZc-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 12:09:07 INFO - mkdir: /builds/slave/test/properties 12:09:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:09:07 INFO - Writing to file /builds/slave/test/properties/build_url 12:09:07 INFO - Contents: 12:09:07 INFO - build_url:https://queue.taskcluster.net/v1/task/bU7UfBx0Ra2yQrxHXJZc-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 12:09:08 INFO - Running post-action listener: _resource_record_post_action 12:09:08 INFO - Running post-action listener: set_extra_try_arguments 12:09:08 INFO - [mozharness: 2016-12-21 20:09:08.226405Z] Finished download-and-extract step (success) 12:09:08 INFO - [mozharness: 2016-12-21 20:09:08.226550Z] Running populate-webroot step. 12:09:08 INFO - Running pre-action listener: _resource_record_pre_action 12:09:08 INFO - Running main action method: populate_webroot 12:09:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:09:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:09:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:09:08 INFO - '--tppagecycles', 12:09:08 INFO - '7'], 12:09:08 INFO - 'tests': ['tsvgm']}}, 12:09:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:09:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:09:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:09:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:09:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:09:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:09:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:09:08 INFO - 'talos_options': ['--disable-e10s'], 12:09:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:09:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:09:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:09:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:09:08 INFO - 'talos_options': ['--disable-e10s'], 12:09:08 INFO - 'tests': ['damp', 'tps']}, 12:09:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:09:08 INFO - 'tests': ['damp', 'tps']}, 12:09:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:09:08 INFO - 'tests': ['dromaeo_dom']}, 12:09:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:09:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:09:08 INFO - 'tests': ['basic_compositor_video']}, 12:09:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:09:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:09:08 INFO - 'tests': ['a11yr', 12:09:08 INFO - 'ts_paint', 12:09:08 INFO - 'tpaint', 12:09:08 INFO - 'sessionrestore', 12:09:08 INFO - 'sessionrestore_no_auto_restore', 12:09:08 INFO - 'tabpaint']}, 12:09:08 INFO - 'other-e10s': {'tests': ['a11yr', 12:09:08 INFO - 'ts_paint', 12:09:08 INFO - 'tpaint', 12:09:08 INFO - 'sessionrestore', 12:09:08 INFO - 'sessionrestore_no_auto_restore', 12:09:08 INFO - 'tabpaint']}, 12:09:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:09:08 INFO - 'ts_paint', 12:09:08 INFO - 'tpaint', 12:09:08 INFO - 'sessionrestore', 12:09:08 INFO - 'sessionrestore_no_auto_restore', 12:09:08 INFO - 'tabpaint']}, 12:09:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:09:08 INFO - 'ts_paint', 12:09:08 INFO - 'tpaint', 12:09:08 INFO - 'sessionrestore', 12:09:08 INFO - 'sessionrestore_no_auto_restore', 12:09:08 INFO - 'tabpaint']}, 12:09:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:09:08 INFO - 'tests': ['a11yr', 12:09:08 INFO - 'ts_paint', 12:09:08 INFO - 'tpaint', 12:09:08 INFO - 'sessionrestore', 12:09:08 INFO - 'sessionrestore_no_auto_restore', 12:09:08 INFO - 'tabpaint']}, 12:09:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:09:08 INFO - 'tests': ['a11yr', 12:09:08 INFO - 'ts_paint', 12:09:08 INFO - 'tpaint', 12:09:08 INFO - 'sessionrestore', 12:09:08 INFO - 'sessionrestore_no_auto_restore', 12:09:08 INFO - 'tabpaint']}, 12:09:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:09:08 INFO - 'tests': ['tsvgx', 12:09:08 INFO - 'tsvgr_opacity', 12:09:08 INFO - 'tart', 12:09:08 INFO - 'tscrollx', 12:09:08 INFO - 'cart', 12:09:08 INFO - 'tsvg_static']}, 12:09:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:09:08 INFO - 'tsvgr_opacity', 12:09:08 INFO - 'tart', 12:09:08 INFO - 'tscrollx', 12:09:08 INFO - 'cart', 12:09:08 INFO - 'tsvg_static']}, 12:09:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:09:08 INFO - 'talos_options': ['--disable-e10s'], 12:09:08 INFO - 'tests': ['tp5o']}, 12:09:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:09:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:09:08 INFO - 'talos_options': ['--disable-e10s', 12:09:08 INFO - '--xperf_path', 12:09:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:09:08 INFO - 'tests': ['tp5n']}, 12:09:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:09:08 INFO - 'talos_options': ['--xperf_path', 12:09:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:09:08 INFO - 'tests': ['tp5n']}}, 12:09:08 INFO - 'talos.zip': {'path': '', 12:09:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:09:08 INFO - Running post-action listener: _resource_record_post_action 12:09:08 INFO - [mozharness: 2016-12-21 20:09:08.246875Z] Finished populate-webroot step (success) 12:09:08 INFO - [mozharness: 2016-12-21 20:09:08.246991Z] Running create-virtualenv step. 12:09:08 INFO - Running pre-action listener: _resource_record_pre_action 12:09:08 INFO - Running main action method: create_virtualenv 12:09:08 INFO - Creating virtualenv /builds/slave/test/build/venv 12:09:08 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 12:09:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:09:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:09:08 INFO - Using real prefix '/tools/python27' 12:09:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:09:09 INFO - Installing distribute.............................................................................................................................................................................................done. 12:09:12 INFO - Installing pip.................done. 12:09:12 INFO - Return code: 0 12:09:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:09:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:09:12 INFO - Reading from file tmpfile_stdout 12:09:12 INFO - Output received: 12:09:12 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) 12:09:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:09: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')]} 12:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09: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')]} 12:09:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f544b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f547768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeb9cdc6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f322d30>, '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 0x10f249db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f317be8>, '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.wTvCMElAkW/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.19bGU1TyIP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 12:09:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:09:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:09:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTvCMElAkW/Render', 12:09:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:12 INFO - 'HOME': '/Users/cltbld', 12:09:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:12 INFO - 'LOGNAME': 'cltbld', 12:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:12 INFO - 'MOZ_NO_REMOTE': '1', 12:09:12 INFO - 'NO_EM_RESTART': '1', 12:09:12 INFO - 'PAGER': '/bin/cat', 12:09:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:12 INFO - 'PWD': '/builds/slave/test', 12:09:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:12 INFO - 'SHELL': '/bin/bash', 12:09:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.19bGU1TyIP/Listeners', 12:09:12 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 12:09:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:12 INFO - 'USER': 'cltbld', 12:09:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:12 INFO - 'XPC_FLAGS': '0x0', 12:09:12 INFO - 'XPC_SERVICE_NAME': '0', 12:09:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:12 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 12:09:12 INFO - Cleaning up... 12:09:12 INFO - Return code: 0 12:09:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:09: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')]} 12:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09: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')]} 12:09:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f544b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f547768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeb9cdc6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f322d30>, '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 0x10f249db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f317be8>, '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.wTvCMElAkW/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.19bGU1TyIP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 12:09:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:09:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:09:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTvCMElAkW/Render', 12:09:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:12 INFO - 'HOME': '/Users/cltbld', 12:09:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:12 INFO - 'LOGNAME': 'cltbld', 12:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:12 INFO - 'MOZ_NO_REMOTE': '1', 12:09:12 INFO - 'NO_EM_RESTART': '1', 12:09:12 INFO - 'PAGER': '/bin/cat', 12:09:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:12 INFO - 'PWD': '/builds/slave/test', 12:09:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:12 INFO - 'SHELL': '/bin/bash', 12:09:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.19bGU1TyIP/Listeners', 12:09:12 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 12:09:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:12 INFO - 'USER': 'cltbld', 12:09:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:12 INFO - 'XPC_FLAGS': '0x0', 12:09:12 INFO - 'XPC_SERVICE_NAME': '0', 12:09:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:12 INFO - Downloading/unpacking psutil>=3.1.1 12:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:09:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:09:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:09:16 INFO - Installing collected packages: psutil 12:09:16 INFO - Running setup.py install for psutil 12:09:16 INFO - building 'psutil._psutil_osx' extension 12:09:16 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 12:09:16 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 12:09:16 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 12:09:16 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 12:09:17 INFO - building 'psutil._psutil_posix' extension 12:09:17 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 12:09:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:09:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:09:17 INFO - ^ 12:09:17 INFO - 1 warning generated. 12:09:17 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 12:09:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:09:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:09:17 INFO - Successfully installed psutil 12:09:17 INFO - Cleaning up... 12:09:17 INFO - Return code: 0 12:09:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:09:17 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')]} 12:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:17 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')]} 12:09:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:17 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 0x10f544b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f547768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeb9cdc6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f322d30>, '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 0x10f249db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f317be8>, '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.wTvCMElAkW/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.19bGU1TyIP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 12:09:17 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 12:09:17 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 12:09:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTvCMElAkW/Render', 12:09:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:17 INFO - 'HOME': '/Users/cltbld', 12:09:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:17 INFO - 'LOGNAME': 'cltbld', 12:09:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:17 INFO - 'MOZ_NO_REMOTE': '1', 12:09:17 INFO - 'NO_EM_RESTART': '1', 12:09:17 INFO - 'PAGER': '/bin/cat', 12:09:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:17 INFO - 'PWD': '/builds/slave/test', 12:09:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:17 INFO - 'SHELL': '/bin/bash', 12:09:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.19bGU1TyIP/Listeners', 12:09:17 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 12:09:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:17 INFO - 'USER': 'cltbld', 12:09:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:17 INFO - 'XPC_FLAGS': '0x0', 12:09:17 INFO - 'XPC_SERVICE_NAME': '0', 12:09:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:09:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:09:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:09:20 INFO - Installing collected packages: mozsystemmonitor 12:09:20 INFO - Running setup.py install for mozsystemmonitor 12:09:20 INFO - Successfully installed mozsystemmonitor 12:09:20 INFO - Cleaning up... 12:09:20 INFO - Return code: 0 12:09:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:20 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 0x10f544b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f547768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeb9cdc6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f322d30>, '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 0x10f249db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f317be8>, '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.wTvCMElAkW/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.19bGU1TyIP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 12:09:20 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 12:09:20 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 12:09:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTvCMElAkW/Render', 12:09:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:20 INFO - 'HOME': '/Users/cltbld', 12:09:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:20 INFO - 'LOGNAME': 'cltbld', 12:09:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:20 INFO - 'MOZ_NO_REMOTE': '1', 12:09:20 INFO - 'NO_EM_RESTART': '1', 12:09:20 INFO - 'PAGER': '/bin/cat', 12:09:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:20 INFO - 'PWD': '/builds/slave/test', 12:09:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:20 INFO - 'SHELL': '/bin/bash', 12:09:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.19bGU1TyIP/Listeners', 12:09:20 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 12:09:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:20 INFO - 'USER': 'cltbld', 12:09:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:20 INFO - 'XPC_FLAGS': '0x0', 12:09:20 INFO - 'XPC_SERVICE_NAME': '0', 12:09:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:20 INFO - Downloading/unpacking jsonschema==2.5.1 12:09:20 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 12:09:20 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 12:09:20 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 12:09:20 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 12:09:20 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 12:09:20 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 12:09:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:09:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:09:23 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 12:09:23 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 12:09:23 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 12:09:23 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 12:09:23 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 12:09:23 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 12:09:23 INFO - Downloading functools32-3.2.3-2.tar.gz 12:09:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:09:24 INFO - warning: no files found matching '*.txt' 12:09:24 INFO - no previously-included directories found matching 'build' 12:09:24 INFO - no previously-included directories found matching 'dist' 12:09:24 INFO - no previously-included directories found matching '.git*' 12:09:24 INFO - Installing collected packages: jsonschema, functools32 12:09:24 INFO - Running setup.py install for functools32 12:09:24 INFO - warning: no files found matching '*.txt' 12:09:24 INFO - no previously-included directories found matching 'build' 12:09:24 INFO - no previously-included directories found matching 'dist' 12:09:24 INFO - no previously-included directories found matching '.git*' 12:09:24 INFO - Successfully installed jsonschema functools32 12:09:24 INFO - Cleaning up... 12:09:24 INFO - Return code: 0 12:09:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:09:24 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')]} 12:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:24 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')]} 12:09:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:24 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 0x10f544b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f547768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeb9cdc6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f322d30>, '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 0x10f249db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f317be8>, '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.wTvCMElAkW/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.19bGU1TyIP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 12:09:24 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 12:09:24 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 12:09:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTvCMElAkW/Render', 12:09:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:24 INFO - 'HOME': '/Users/cltbld', 12:09:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:24 INFO - 'LOGNAME': 'cltbld', 12:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:24 INFO - 'MOZ_NO_REMOTE': '1', 12:09:24 INFO - 'NO_EM_RESTART': '1', 12:09:24 INFO - 'PAGER': '/bin/cat', 12:09:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:24 INFO - 'PWD': '/builds/slave/test', 12:09:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:24 INFO - 'SHELL': '/bin/bash', 12:09:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.19bGU1TyIP/Listeners', 12:09:24 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 12:09:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:24 INFO - 'USER': 'cltbld', 12:09:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:24 INFO - 'XPC_FLAGS': '0x0', 12:09:24 INFO - 'XPC_SERVICE_NAME': '0', 12:09:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:09:24 INFO - Cleaning up... 12:09:24 INFO - Return code: 0 12:09:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:09:24 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')]} 12:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:24 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')]} 12:09:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:24 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 0x10f544b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f547768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeb9cdc6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f322d30>, '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 0x10f249db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f317be8>, '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.wTvCMElAkW/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.19bGU1TyIP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 12:09:24 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 12:09:24 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 12:09:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTvCMElAkW/Render', 12:09:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:24 INFO - 'HOME': '/Users/cltbld', 12:09:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:24 INFO - 'LOGNAME': 'cltbld', 12:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:24 INFO - 'MOZ_NO_REMOTE': '1', 12:09:24 INFO - 'NO_EM_RESTART': '1', 12:09:24 INFO - 'PAGER': '/bin/cat', 12:09:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:24 INFO - 'PWD': '/builds/slave/test', 12:09:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:24 INFO - 'SHELL': '/bin/bash', 12:09:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.19bGU1TyIP/Listeners', 12:09:24 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 12:09:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:24 INFO - 'USER': 'cltbld', 12:09:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:24 INFO - 'XPC_FLAGS': '0x0', 12:09:24 INFO - 'XPC_SERVICE_NAME': '0', 12:09:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:24 INFO - Downloading/unpacking blobuploader==1.2.4 12:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:27 INFO - Downloading blobuploader-1.2.4.tar.gz 12:09:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:09:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:09:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:09:28 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 12:09:28 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 12:09:28 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 12:09:28 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 12:09:28 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 12:09:28 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 12:09:28 INFO - Downloading docopt-0.6.1.tar.gz 12:09:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:09:28 INFO - Installing collected packages: blobuploader, requests, docopt 12:09:28 INFO - Running setup.py install for blobuploader 12:09:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:09:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:09:28 INFO - Running setup.py install for requests 12:09:29 INFO - Running setup.py install for docopt 12:09:29 INFO - Successfully installed blobuploader requests docopt 12:09:29 INFO - Cleaning up... 12:09:29 INFO - Return code: 0 12:09:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:09: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')]} 12:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09: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')]} 12:09:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:29 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 0x10f544b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f547768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeb9cdc6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f322d30>, '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 0x10f249db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f317be8>, '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.wTvCMElAkW/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.19bGU1TyIP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 12:09:29 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 12:09:29 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 12:09:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTvCMElAkW/Render', 12:09:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:29 INFO - 'HOME': '/Users/cltbld', 12:09:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:29 INFO - 'LOGNAME': 'cltbld', 12:09:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:29 INFO - 'MOZ_NO_REMOTE': '1', 12:09:29 INFO - 'NO_EM_RESTART': '1', 12:09:29 INFO - 'PAGER': '/bin/cat', 12:09:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:29 INFO - 'PWD': '/builds/slave/test', 12:09:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:29 INFO - 'SHELL': '/bin/bash', 12:09:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.19bGU1TyIP/Listeners', 12:09:29 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 12:09:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:29 INFO - 'USER': 'cltbld', 12:09:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:29 INFO - 'XPC_FLAGS': '0x0', 12:09:29 INFO - 'XPC_SERVICE_NAME': '0', 12:09:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:09:30 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-BRmZCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:09:30 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-DloaoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:09:30 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-9lsGwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:09:30 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-j5wWTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:09:30 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-UFZ9dX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:09:30 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-ZqQQRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:09:30 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-7rTlWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:09:30 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-RvhqHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:09:30 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-Fyke9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:09:30 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-doK1nl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:09:31 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-TJ_GaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:09:31 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-t5ktUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:09:31 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-IX5v6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:09:31 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-1X25Qh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:09:31 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-PvJxFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:09:31 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-Wf4Gxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:09:31 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-AdUEDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:09:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:09:31 INFO - Running setup.py install for manifestparser 12:09:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:09:32 INFO - Running setup.py install for mozcrash 12:09:32 INFO - Running setup.py install for mozdebug 12:09:32 INFO - Running setup.py install for mozdevice 12:09:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:09:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:09:32 INFO - Running setup.py install for mozfile 12:09:32 INFO - Running setup.py install for mozhttpd 12:09:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:09:32 INFO - Running setup.py install for mozinfo 12:09:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:09:32 INFO - Running setup.py install for mozInstall 12:09:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:09:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:09:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:09:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:09:33 INFO - Running setup.py install for mozleak 12:09:33 INFO - Running setup.py install for mozlog 12:09:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:09:33 INFO - Running setup.py install for moznetwork 12:09:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:09:33 INFO - Running setup.py install for mozprocess 12:09:33 INFO - Running setup.py install for mozprofile 12:09:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:09:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:09:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:09:33 INFO - Running setup.py install for mozrunner 12:09:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:09:33 INFO - Running setup.py install for mozscreenshot 12:09:34 INFO - Running setup.py install for moztest 12:09:34 INFO - Running setup.py install for mozversion 12:09:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:09:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:09:34 INFO - Cleaning up... 12:09:34 INFO - Return code: 0 12:09:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:09:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:34 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 0x10f544b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f547768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeb9cdc6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f322d30>, '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 0x10f249db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f317be8>, '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.wTvCMElAkW/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.19bGU1TyIP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 12:09:34 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 12:09:34 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 12:09:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTvCMElAkW/Render', 12:09:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:34 INFO - 'HOME': '/Users/cltbld', 12:09:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:34 INFO - 'LOGNAME': 'cltbld', 12:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:34 INFO - 'MOZ_NO_REMOTE': '1', 12:09:34 INFO - 'NO_EM_RESTART': '1', 12:09:34 INFO - 'PAGER': '/bin/cat', 12:09:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:34 INFO - 'PWD': '/builds/slave/test', 12:09:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:34 INFO - 'SHELL': '/bin/bash', 12:09:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.19bGU1TyIP/Listeners', 12:09:34 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 12:09:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:34 INFO - 'USER': 'cltbld', 12:09:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:34 INFO - 'XPC_FLAGS': '0x0', 12:09:34 INFO - 'XPC_SERVICE_NAME': '0', 12:09:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:09:34 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-vBQlC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:09:34 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)) 12:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:09:34 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-I0CCfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:09:34 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)) 12:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:09:34 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-5pAIXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:09:35 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)) 12:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:09:35 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-Q79cSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:09:35 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)) 12:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:09:35 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-Db6bsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:09:35 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)) 12:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:09:35 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-V7y1fJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:09:35 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)) 12:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:09:35 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-XBb3H2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:09:35 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)) 12:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:09:35 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-urAZYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:09:35 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)) 12:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:09:35 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-XgkhY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:09:35 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)) 12:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:09:35 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-LpiDFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:09:35 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)) 12:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:09:35 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-0IGoAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:09:35 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)) 12:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:09:35 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-KuGeF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:09:35 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-cIbd_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:09:36 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)) 12:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:09:36 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-aeWkPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:09:36 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)) 12:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:09:36 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-QvsPGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:09:36 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)) 12:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:09:36 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-gYJAAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:09:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:09:36 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-ps4kgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:09:36 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)) 12:09:36 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)) 12:09:36 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)) 12:09:36 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)) 12:09:36 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)) 12:09:36 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)) 12:09:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:09:36 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 12:09:36 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 12:09:36 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 12:09:36 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 12:09:36 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 12:09:36 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 12:09:39 INFO - Downloading blessings-1.6.tar.gz 12:09:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:09:39 INFO - Installing collected packages: blessings 12:09:39 INFO - Running setup.py install for blessings 12:09:39 INFO - Successfully installed blessings 12:09:39 INFO - Cleaning up... 12:09:39 INFO - Return code: 0 12:09:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:09:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:09:40 INFO - Reading from file tmpfile_stdout 12:09:40 INFO - Current package versions: 12:09:40 INFO - blessings == 1.6 12:09:40 INFO - blobuploader == 1.2.4 12:09:40 INFO - docopt == 0.6.1 12:09:40 INFO - functools32 == 3.2.3-2 12:09:40 INFO - jsonschema == 2.5.1 12:09:40 INFO - manifestparser == 1.1 12:09:40 INFO - mozInstall == 1.12 12:09:40 INFO - mozcrash == 1.0 12:09:40 INFO - mozdebug == 0.1 12:09:40 INFO - mozdevice == 0.49 12:09:40 INFO - mozfile == 1.2 12:09:40 INFO - mozhttpd == 0.7 12:09:40 INFO - mozinfo == 0.9 12:09:40 INFO - mozleak == 0.1 12:09:40 INFO - mozlog == 3.4 12:09:40 INFO - moznetwork == 0.27 12:09:40 INFO - mozprocess == 0.23 12:09:40 INFO - mozprofile == 0.28 12:09:40 INFO - mozrunner == 6.13 12:09:40 INFO - mozscreenshot == 0.1 12:09:40 INFO - mozsystemmonitor == 0.3 12:09:40 INFO - moztest == 0.7 12:09:40 INFO - mozversion == 1.4 12:09:40 INFO - psutil == 3.1.1 12:09:40 INFO - requests == 1.2.3 12:09:40 INFO - wsgiref == 0.1.2 12:09:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:40 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 0x10f544b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f547768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeb9cdc6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f322d30>, '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 0x10f249db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f317be8>, '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.wTvCMElAkW/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.19bGU1TyIP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 12:09:40 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 12:09:40 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 12:09:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTvCMElAkW/Render', 12:09:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:40 INFO - 'HOME': '/Users/cltbld', 12:09:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:40 INFO - 'LOGNAME': 'cltbld', 12:09:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:40 INFO - 'MOZ_NO_REMOTE': '1', 12:09:40 INFO - 'NO_EM_RESTART': '1', 12:09:40 INFO - 'PAGER': '/bin/cat', 12:09:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:40 INFO - 'PWD': '/builds/slave/test', 12:09:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:40 INFO - 'SHELL': '/bin/bash', 12:09:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.19bGU1TyIP/Listeners', 12:09:40 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 12:09:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:40 INFO - 'USER': 'cltbld', 12:09:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:40 INFO - 'XPC_FLAGS': '0x0', 12:09:40 INFO - 'XPC_SERVICE_NAME': '0', 12:09:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:40 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)) 12:09:40 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)) 12:09:40 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)) 12:09:40 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)) 12:09:40 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)) 12:09:40 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)) 12:09:40 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)) 12:09:40 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)) 12:09:40 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)) 12:09:40 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)) 12:09:40 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)) 12:09:40 INFO - Cleaning up... 12:09:40 INFO - Return code: 0 12:09:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:40 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 0x10f544b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f547768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdeb9cdc6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f322d30>, '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 0x10f249db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f317be8>, '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.wTvCMElAkW/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.19bGU1TyIP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 12:09:40 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 12:09:40 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 12:09:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTvCMElAkW/Render', 12:09:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:40 INFO - 'HOME': '/Users/cltbld', 12:09:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:40 INFO - 'LOGNAME': 'cltbld', 12:09:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:40 INFO - 'MOZ_NO_REMOTE': '1', 12:09:40 INFO - 'NO_EM_RESTART': '1', 12:09:40 INFO - 'PAGER': '/bin/cat', 12:09:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:40 INFO - 'PWD': '/builds/slave/test', 12:09:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:40 INFO - 'SHELL': '/bin/bash', 12:09:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.19bGU1TyIP/Listeners', 12:09:40 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 12:09:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:40 INFO - 'USER': 'cltbld', 12:09:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:40 INFO - 'XPC_FLAGS': '0x0', 12:09:40 INFO - 'XPC_SERVICE_NAME': '0', 12:09:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:09:40 INFO - Cleaning up... 12:09:40 INFO - Return code: 0 12:09:40 INFO - Running post-action listener: _resource_record_post_action 12:09:40 INFO - Running post-action listener: _start_resource_monitoring 12:09:41 INFO - Starting resource monitoring. 12:09:41 INFO - [mozharness: 2016-12-21 20:09:41.023511Z] Finished create-virtualenv step (success) 12:09:41 INFO - [mozharness: 2016-12-21 20:09:41.024434Z] Running install step. 12:09:41 INFO - Running pre-action listener: _resource_record_pre_action 12:09:41 INFO - Running main action method: install 12:09:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:09:41 INFO - Reading from file tmpfile_stdout 12:09:41 INFO - Detecting whether we're running mozinstall >=1.0... 12:09:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:09:41 INFO - Reading from file tmpfile_stdout 12:09:41 INFO - Output received: 12:09:41 INFO - Usage: mozinstall [options] installer 12:09:41 INFO - Options: 12:09:41 INFO - -h, --help show this help message and exit 12:09:41 INFO - -d DEST, --destination=DEST 12:09:41 INFO - Directory to install application into. [default: 12:09:41 INFO - "/builds/slave/test"] 12:09:41 INFO - --app=APP Application being installed. [default: firefox] 12:09:41 INFO - mkdir: /builds/slave/test/build/application 12:09:41 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'] 12:09:41 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 12:10:04 INFO - Reading from file tmpfile_stdout 12:10:04 INFO - Output received: 12:10:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:10:04 INFO - Running post-action listener: _resource_record_post_action 12:10:04 INFO - [mozharness: 2016-12-21 20:10:04.024601Z] Finished install step (success) 12:10:04 INFO - [mozharness: 2016-12-21 20:10:04.024776Z] Running run-tests step. 12:10:04 INFO - Running pre-action listener: _resource_record_pre_action 12:10:04 INFO - Running main action method: run_tests 12:10:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:10:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:10:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:10:04 INFO - 2016-12-21 12:10:04.039 screenresolution[1628:7291] starting screenresolution argv=screenresolution get 12:10:04 INFO - 2016-12-21 12:10:04.041 screenresolution[1628:7291] Display 0: 1600x1200x32@60 12:10:04 INFO - 2016-12-21 12:10:04.047 screenresolution[1629:7293] starting screenresolution argv=screenresolution list 12:10:04 INFO - Available Modes on Display 0 12:10:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:10:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:10:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:10:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:10:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:10:04 INFO - Intel Iris: 12:10:04 INFO - Chipset Model: Intel Iris 12:10:04 INFO - Type: GPU 12:10:04 INFO - Bus: Built-In 12:10:04 INFO - VRAM (Dynamic, Max): 1536 MB 12:10:04 INFO - Vendor: Intel (0x8086) 12:10:04 INFO - Device ID: 0x0a2e 12:10:04 INFO - Revision ID: 0x0009 12:10:04 INFO - Displays: 12:10:04 INFO - Display: 12:10:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:10:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:10:04 INFO - Display Serial Number: 1600x1200 60 12:10:04 INFO - Main Display: Yes 12:10:04 INFO - Mirror: Off 12:10:04 INFO - Online: Yes 12:10:04 INFO - Rotation: Supported 12:10:04 INFO - Return code: 0 12:10:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:10:04 INFO - Python 2.7.3 12:10:04 INFO - Return code: 0 12:10:04 INFO - grabbing minidump binary from tooltool 12:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:10:04 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 0x10f322d30>, '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 0x10f249db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f317be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:10:04 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 12:10:04 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 12:10:04 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 12:10:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:10:04 INFO - Return code: 0 12:10:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:10:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:10:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:10:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:10:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:10:04 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/bU7UfBx0Ra2yQrxHXJZc-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0219', '--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 12:10:04 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/bU7UfBx0Ra2yQrxHXJZc-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0219 --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 12:10:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTvCMElAkW/Render', 12:10:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:10:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:10:04 INFO - 'HOME': '/Users/cltbld', 12:10:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:10:04 INFO - 'LOGNAME': 'cltbld', 12:10:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:10:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:10:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:04 INFO - 'MOZ_NO_REMOTE': '1', 12:10:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:10:04 INFO - 'NO_EM_RESTART': '1', 12:10:04 INFO - 'PAGER': '/bin/cat', 12:10:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:10:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:04 INFO - 'PWD': '/builds/slave/test', 12:10:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:10:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:10:04 INFO - 'SHELL': '/bin/bash', 12:10:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.19bGU1TyIP/Listeners', 12:10:04 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 12:10:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:10:04 INFO - 'USER': 'cltbld', 12:10:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:10:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:10:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:04 INFO - 'XPC_FLAGS': '0x0', 12:10:04 INFO - 'XPC_SERVICE_NAME': '0', 12:10:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:10:04 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/bU7UfBx0Ra2yQrxHXJZc-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0219', '--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 12:10:04 INFO - mozversion application_buildid: 20161221075354 12:10:04 INFO - mozversion application_changeset: 8a362f5c65fbe14a6976beb15905e20fca53d3ac 12:10:04 INFO - mozversion application_display_name: Nightly 12:10:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:10:04 INFO - mozversion application_name: Firefox 12:10:04 INFO - mozversion application_remotingname: firefox 12:10:04 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 12:10:04 INFO - mozversion application_vendor: Mozilla 12:10:04 INFO - mozversion application_version: 53.0a1 12:10:04 INFO - mozversion platform_buildid: 20161221075354 12:10:04 INFO - mozversion platform_changeset: 8a362f5c65fbe14a6976beb15905e20fca53d3ac 12:10:04 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 12:10:04 INFO - mozversion platform_version: 53.0a1 12:10:04 INFO - using testdate: 1482351004 12:10:04 INFO - actual date: 1482351004 12:10:04 INFO - starting webserver on 'localhost:49236' 12:10:04 INFO - SUITE-START | Running 2 tests 12:10:04 INFO - TEST-START | dromaeo_css 12:10:04 INFO - operating with platform_type : mac_ 12:10:04 INFO - Initialising browser for dromaeo_css test... 12:10:04 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/tmpgPCIbP/profile http://localhost:49236/getInfo.html) 12:10:07 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 12:10:07 INFO - PROCESS | 1639 | colorDepth:24 12:10:07 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 12:10:07 INFO - PROCESS | 1639 | __metrics 12:10:07 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" 12:10:07 INFO - PROCESS | 1639 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:10:07 INFO - TEST-INFO | 1639: exit 0 12:10:07 INFO - Browser initialized. 12:10:07 INFO - Running cycle 1/1 for dromaeo_css test... 12:10:07 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/tmpgPCIbP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:10:19 INFO - PROCESS | 1641 | RSS: Main: 254582784 12:10:19 INFO - PROCESS | 1641 | 12:11:10 INFO - PROCESS | 1641 | 1482351070976 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:13:25 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 12:13:26 INFO - PROCESS | 1641 | RSS: Main: 400195584 12:13:26 INFO - PROCESS | 1641 | 12:16:29 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 12:16:30 INFO - PROCESS | 1641 | RSS: Main: 385740800 12:16:30 INFO - PROCESS | 1641 | 12:19:32 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 12:19:33 INFO - PROCESS | 1641 | RSS: Main: 368726016 12:19:33 INFO - PROCESS | 1641 | 12:22:36 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 12:22:36 INFO - PROCESS | 1641 | RSS: Main: 356573184 12:22:36 INFO - PROCESS | 1641 | 12:25:40 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 12:25:40 INFO - PROCESS | 1641 | RSS: Main: 349421568 12:25:40 INFO - PROCESS | 1641 | 12:28:44 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 12:28:44 INFO - PROCESS | 1641 | RSS: Main: 457785344 12:28:44 INFO - PROCESS | 1641 | 12:28:44 INFO - PROCESS | 1641 | __start_tp_report 12:28:44 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 12:28:44 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 12:28:44 INFO - PROCESS | 1641 | |i|pagename|runs| 12:28:44 INFO - PROCESS | 1641 | |0;dojo.html;3350.43042682744;3362.613299470561;3368.848401821916;3409.3863104641187;3428.0744199066253;4357.825686972521;5533.806316778913;5551.500364967153;5626.54987600992;5684.919865225609;5588.580856435773;5658.490735833774;5662.801801936933;5706.828795136153;5723.370429252789;5133.255677926699;5159.251908473269;5171.922421163686;5200.479952004807;5212.139996900507;5192.117340052181;5313.9734301328435;5316.5215130638235;5326.680399176062;5329.600279978998;4363.432753741993;4973.875653108665;5158.174692049254;5260;5322.787088516455;4851.369321988154;4902.534259245366;5201.479852014768;5235.842924712265;5298.894022119536;4265.957340426618;5137.717425541594;5192.948070519285;5199.428062913076;5268.473152684739;5687.289088863892;5710.514606258473;5737.110747834051;5739.626924249952;5760.654360738369;5981.132735753335;6071.332153463116;6093.268807743055;6241.251049873998;6257.843553911143;6137.8187520601;6188.195534580521;6198.163247961513;6200.968995155041;6202.348753380875;5642.576806739511;5730.570207234391;5739.540836733051;5746.827595172152;5754.625949313281;5223.216517522402;6267.2165979252595;6313.905291420632;6323.336049714806;6333.524985626096;6129.172561704202;6143.170671959318;6143.662098584621;6151.138840562325;6156.476699480594;6046.5767396281835;6094.878102438015;6269.8746025079245;6275.341089185661;6277.7175027123885;6081.452669259788;6121.696863452088;6137.693115344215;6154.046122850965;6233.376662333731;6243.937560624427;6255.343188965184;6257.593256438408;6266.436020758154;6268.404501572343;4915.410150781929;4919.99140176263;4920.188168952154;4929.211326187793;4942.40691117061;4296.011917259048;4316.5467625899455;4360.694751367374;4436.511983681792;4473.261911784584;4734.479207287196;5658.547316214693;5716.399778023331;5724.542036637059;5734.827955161351;6200.751969921243;6226.40849119333;6227.346128656426;6234.5635805494085;6239.095331176954;5718.1136923776885;5741.540676745851;5741.813293621996;5755.65466072037;5763.740631671585;5262.736863156827;5302.973485132627;5304.336957880265;5304.628675992643;5338.9466105339225;6305.464035557029;6321.209848768812;6334;6334.113224148531;6349.0476428536085;6113.174721412553;6254.6247225166635;6254.687265636791;6263.6241825490615;6279.843003924756;6227.906581401192;6330;6339.619622822645;6349.841253968688;6374.840628984127;6024.3975602439405;6030.6080104793045;6047.455728984412;6050.183225264533;6136.140940268455;6159.907601386072;6185.84535386601;6190.442860142609;6215.06773983906;6224.657643829451;5924.140999555127;5945.048792193228;5975.521958243243;5982.52139828804;6037.939620603738;5901.734421950937;5951.642901425928;5968.522518198447;6037;6042.697865106639;5902.055671092605;5949.940500594938;5961.642301461753;5979.880402391841;5986.341502434641;6105.9694701526205;6127.234095738033;6129.233845769279;6137.355577664281;6141.324454309933;4859.3682821233015;5695.174199741097;5810.564207684525;5862.560307976833;5955.67243801595 12:28:44 INFO - PROCESS | 1641 | |1;ext.html;445.7993902743766;445.8238995596739;454.02837926836554;492.0822665728418;513.2634669249626;30630;39945.20109597806;41352.586474135285;41497.792511037405;43763;43001.78499107508;43423.348649770276;43506.7824660877;43548.3467747984;43789;8408.957955210246;9400.529973501314;9616.519174041305;9628.903710962872;9635.18100961419;8499.277561407287;11186.944065279662;11421.25761825483;11436.313821170756;11657.591984280552;11263.21157518974;11409.37248451335;11417.885821141806;11426.542938282459;11476.942615286913;11385.373804440753;11474.655760327203;11478.827817582744;11488.425578721031;11490.253133546334;11074.280171788809;11108.61119860809;11290.266132701348;11397.088232941345;11424.657260282205;40104.79947600273;40208.798956005034;40565;40571.39142912829;40630.39054414186;2503.699556053267;3316.2041110133637;3364.4785058315756;3410.744194185446;3488;23482.067704935158;26628.86685566579;27469.31326716848;27634.032808851593;28542.714572854213;2593.2998090515644;3110.875564977398;3231.3375757969793;3253.2842774589553;3274.787138835968;334773;429654.85172573937;429908;431383.84308078256;431391;51407.971840563725;51639.96720065653;51698.96602068013;51778.964420711374;51784.74107629438;58291.708541457025;58327.708361457924;58373;58401.415985840446;58442.70778646079;15241.247256565637;15489.070655760464;15503.224838758017;15519.612009699847;15544.922275388551;10678.145748340114;10965;11010.559577616805;11841.526338946518;11979.041676665845;12704;15354.692906141814;15460.458883939009;15467.613309667347;17525;7383.852322953619;7725.961370193113;7731.188225236382;7742.722450795555;7798.532088074734;863.3352318714554;901.7970956534728;913.5249670171473;1044.3159730376615;1080.3679847289266;28325.858370708014;28595.57106643402;30102;30546.639770254238;31018.22454438612;1042.4943902207424;1055.5988724284723;1088.3089238333714;1103.8399432082304;1129.6046383765781;15213.163276019704;15489.302981365865;15603.843961560466;15770.842291577166;16137;610200;615138;615277;615649;616040.5563499307;58496.415035849095;58762.53093672607;58831.411685882595;58952;58985;1375.5735721926235;1403.3404299978993;1417.8723914847712;1418.8793952514152;1423.6369725719876;23793.881030594737;25671.871640642425;26548.469030618893;29198.56202156927;29577.556336654536;51175;51798.48201517937;51943.74028129986;52001;52029.7398513005;572495;579631;579978;580892;581087;37913.24173516459;38073.048173795876;38648;38648.32840880112;38712.6128738709;35783;35882.4617630741;40322.59677403188;42339.94150146271;43398;35066.649333506335;35783.92648220558;35870.8206458966;35941.460878087375;36880;29445.791565632237;35573;36069.45895811617;36368.63631363758;36972.26055478929;34924.30151397009;35242.82378588091;35723.28553428969;36058.27883442264;36080.45879311865;31031.84484077565;32108.839455802572;32282.192945176557;32405.35189296154;32440.351192975537;23612.29163125109;23894.402639934142;23916.976956320163;24214.394640134138;24387.26838194857 12:28:44 INFO - PROCESS | 1641 | |2;jquery.html;347.16506801143225;369.13069720807516;377.5016977589582;379.73608342202164;400.7395193124469;11881.227720198192;14931.925340373296;15172.39310427583;19693;20367.694484582742;19200.039998000113;19501.902490487526;20012.599748005032;20206.19175232989;20824;5669.291338582667;5935.169076329317;5936.3173235077875;5939.198208241897;5939.821805345847;4448.488423831269;5932.911006334887;5937.910931336012;5942.64344139353;5971.701414929258;5463.3717122530825;5866.823995280127;5879.32387775407;5885.264341957255;5891.116332550109;5191.351081114861;5802.361740208574;5838.941610583882;5843.415658434165;5867.559933004999;4605.815767369301;4889.535494128052;4951.975240123812;5094;5109;25093.498130037297;25098.870550825257;25208.495830083295;25228.49543009148;25596.616050759254;2367.360812580611;2858.5855051017693;3025.5007923692565;3080.2607374230247;3118.2827949571497;12081.275123492618;13280.53518126861;14147.646308842259;15012.549623511311;15673.608159795982;1442.87735542479;1608.8873778835487;1795.1921635264052;1826.7351234070986;1832.1572076844668;95829.52085239529;105346;115550;119918.4004079974;120321;11432.371219583003;11503.654890353302;11669.766604667859;11688;11702.531898723955;14059.85940140606;14543.418263269563;14555.490557830424;14591.124532528082;14615;8104;8429.747107586782;8442.113578074337;8530.488170709777;8544.145585441405;8231.753047408587;8290.502569845828;8305;8456.78858028542;8499.575021248913;3731.7014638828828;4549.704269222556;4551.678643891639;4572.359869618256;4629.259318509023;1691.9492415227562;1858.927296064878;1873.981260187408;1921.9711704324445;1931.169597073272;756.6973210715757;770.8535378278109;901.963921443135;960.7646126698863;1058.5871510111062;19581.314653987043;20824.47938801542;20955.790442095386;21053.05261263247;21066.894665526575;899.5906862377602;905.6558507767006;914.6341463414687;940.7177846645978;1006.9949650251701;8311.210435008665;9971.800563988825;10782.67651970442;10848.620298289521;10869.45652717361;533903;547018;547577;548985.25507373;552099;124410.37794810969;131012;133851;137260;137877;980.4117529482254;1029.0584115534202;1049.496241803923;1053.431147180514;1057.5188289328337;18156;18920.52698682544;18987.90506047516;19015.144318505976;19037.90685002731;52991.675208120105;53494.46505534895;53624.195637064695;54271.45728542664;54690.453095470126;77197;77517;78248.21751782409;79815;80245;6883.518153729191;7019.262977387505;7317.926820731725;7373.115226172894;7727.652255648397;10539.367637941748;11150.609728659458;12147.542294924666;12533.749325013267;13019.934900325437;10765.838512422164;10822.945885270523;11231.26996745209;11262.831057534308;11283.266587671775;10443.791124177626;10784.137269018616;10939.726506837393;11040.447977600927;11283.153763467608;11012;11210.49552770111;11400.657980260605;11446.599369022044;11545;5277.709725965109;7158.248383919614;7256.129264488295;7370.299821516947;7438.888416673646;10558.366498010144;10805.297655652357;10998.670039898816;11194.720131996439;11279.887201127884 12:28:44 INFO - PROCESS | 1641 | |3;mootools.html;1161.756031233441;1421.9502317418892;1510.3807438950032;1531.3032570180562;1902.3151665400453;7414.518056326335;7795.220477952209;7949.2845643892115;8270.21432963869;8282.710105146321;8177.223163799445;8272.007359116915;8285.461445006085;8293.336533077354;8293.626786794608;2052.5381789097482;2239.4065572623226;2287.359539328982;2292.919747808827;2294.4149241943283;1940.8253257206918;2078.688196770481;2276.7381751098587;2350.0364850411333;2356.681847950522;2297.4026753044245;2301.390131615123;2310.387747246981;2316.154603569702;2323.082382458928;2187.4141247595526;2269.614165591853;2281.315605318406;2309.180241014449;2311.202635090891;2076.968845467319;2336.4742932840145;2337.3689103941842;2345.542619189259;2352.1297120065515;8239.546824924626;8278.172182781735;8332.250097491195;8371.665133394657;8373.539455329954;4996.675216110941;5129.12804823181;5150.407703114152;5160.690358578498;5164.6384753067305;3336.5328853960464;3422.5528746945806;3495.1436897959907;3576.946345804815;3581.71346292296;1042.796654652343;1064.8775390830076;1079.0558261521169;1081.6214324986192;1083.9458027098613;10350.741231469197;10620.734481637943;10622;10770.353778773298;10777.83833242502;4184.727992680466;4241.024564350155;4411.779411029435;4422.624076953431;4424.836242086923;8412.537310447862;8436.620352084172;8451.197136272045;8565.52889591066;8575.099614540508;5050.621203409685;5054.7978080876355;5060.240963855451;5075.441701412916;5086.669366491166;4110.691698122653;4447.08834688888;4749.548792864742;4769.713817170981;4783.4499032611;2914.6793852676187;3616.9638303617153;3699.130704284491;3701.3892707703467;3704.3517384457614;1109.8945600167972;1136.9886301137049;1142.868570114431;1144.5292798753728;1146.3064845768356;641.9967900160563;785.7407055671615;860.6084231674573;921.4195057113975;928.3223247029706;5260.684358938476;5341.759620817073;5398.1093119634825;5653.717314134276;5723.112917497794;406.43302592882765;416.7478675401399;427.0711203133235;427.1712877018574;442.50660513527185;3785.37541305687;3810.2760475509563;3812.790296533717;3897.415387691812;3918.5101862267215;9431.198348140484;9873.950630246947;9984.20126389887;10022.749431264278;10024.448655324028;9971.650992215238;9975.25185611082;9988.900110998942;9992.750181245527;10048.09567138961;7432.293932076444;7660.961695191489;7772.533647981026;7837.9216207838335;7838.882416763753;5428.7557059931605;5455.781768729206;5485.862853428696;5528.281323427928;5685.144301369596;9175;9189.632414703337;9259.72220833376;9300.534973251446;9303;9348.345615806827;9400.388974716621;9411.152996230372;9532.189763870148;9537.666181683608;6193.690315484298;6431.646259455775;6633.70148343316;6717.193936727624;6719.428848547928;6495.837604059747;7411.8147046324275;7581.810454738676;7759.7672069838;7921;6980.476464265099;7069.469789765891;7083.291670832876;7123.643817809192;7207.270255138834;6959.478039146983;6984.301569842975;6993.930060699531;7025.859482810418;7051.6474176292;6385.8722825544155;6491.870162596816;6502.512311576746;6533.118029066015;6622.668866556749;4757.833475828329;4773.76131193432;4801.51984801517;4809.5430934061205;4924.72913989734;4180.979095104505;4606.838760643362;4768.332433459249;4844.370231869834;5006.7246301452315 12:28:44 INFO - PROCESS | 1641 | |4;prototype.html;284.9145256423073;340.98465569049375;353.3145697347147;354.7109106078546;358.3495954841963;4676.906461870764;5191.351081114865;5248.973755131224;5297.576193904488;5302.390225124112;4271.786410679461;4341.069777899921;4659.906801863961;5052.0906236877345;5173.793048278074;3506.246157076228;3575.678188962993;4042.4138499917494;4097.180563887227;4117.608827161415;3407.9488807667904;3664.9450258246147;4000.6997725739106;4101.692373072016;4116.732412393185;3616.65641764032;3696.704263658901;3990.4812374391436;4031.778252196128;4072.9592704072875;4075.8981025474454;4096.283150448675;4104.445899803518;4106.404571337169;4123.3196522573735;3021.8640161192798;3605;3605.837737301828;3609.62098979606;3662.15061393997;4185.97907010466;4299.109306078004;5135.717535535544;5161.200013997836;5167.638265321429;3782.56500502443;4514.503404625489;4609.893625529882;4688.226442636961;4698.976505117486;4391.5827996340295;4477.574630410106;5527.668339899578;5564.304461942257;5587.888242235133;3509.5613048368955;3515.525404070469;3691.837071322525;3892.275407214961;4003.077753240122;4633.30500424939;5442.700651464168;5485.957668043059;5755.568332375046;5851.678157701324;3244.902652920416;3362.7309815214726;3607.909802254912;3964.365701487806;4020.3969404589548;4068.7355321903983;4105.4252404662775;4117.547069822317;4130.56629053951;4150.086980864205;3916.74541154824;4107.363358679409;4511.278195488706;4697.600703940135;4716.434027916604;4157.521884983205;5293.241798323156;5398.4871437213405;5413.131040548436;5620.313905828235;1197.9640610781692;1330.9419011885382;1333.8799508044322;1334.2994927663055;1347.3667376333108;917.2845180758885;924.2605915267759;934.7101000619102;946.7964387656549;963.325672029582;4842.297866809293;5149.176131818891;5310.92033619496;5315.202719592015;5319.388270348882;4744.881377965509;4926.96533727914;5637.351704553947;5732.283464566929;5748.19525266463;4289.62731925787;5072.163093089599;5250.527452529291;5284.497972692588;5286.735663216824;2821.8871245150376;2835.9149225523265;2836.375997280595;2841.7300356466103;2849.458602865449;4394.978025109854;4771.069641419959;4810.6632535722165;5097.617678674114;5588.022096133161;4808.471068182497;5103.545489535464;5569.916451253234;5576.358718747396;5587.357453892773;4804.8318308859025;5051.898962020812;5067.770181120295;5686.516646085129;5714.257146570919;4469.5530446955045;5340.732963351895;5407.378151512627;5425.647332923348;5442.591805614674;4637.93043104347;4780.330753694416;5352.625316227826;5444.3466783984595;5703.429657034263;5210.609204309768;5374.596905232202;5932.406759324033;5973.940260597338;6019.856227316795;3737.981310093432;3837.3092843288478;3850.9037274068373;3873.593272706325;3875.3024455597138;5743.885122297447;5753.395893431297;5769.60561367028;5789.6104934816185;5841.532677385714;4946.925796112989;5326.627136100436;5600.85997850057;5623.465770751772;5626.043572592751;4832.395950506187;5033.949660503348;5430.782768689208;5487.396386397413;5554.666719996813;4978.701277923336;5436.53789427903;5485.177223416519;5521.723913804374;5527.806526771544;4855.611551075976;5006.222790909321;5371.758270877742;5435.994341046919;5500.6424582403615;4638.512956139557;5500.4224556420995;5502.80740174092;5502.944970550243;5505.724713764376 12:28:44 INFO - PROCESS | 1641 | |5;yui.html;702.6486756621689;736.4807810493603;753.284379839153;792.7304716396424;816.9223923727245;15157.014794038394;15785.684286314267;15818.76271855923;15838.762418563716;15868.682626347481;14284.428622855074;14465.132092074484;14471.276436178176;14490.420383184686;14498.710025799477;679.2121139478206;696.3837004251224;697.9546329488593;842.8356470488258;851.9105493923141;867.5055218525443;877.7761670773943;878.6221924572432;886.6453418632534;887.6138879587401;912.3795818843184;925.9259259259277;926.986095208569;928.9071092890724;929.0616477357884;896.9416987895765;923.0953665407905;923.1922068190333;923.2752289452781;924.2005665099707;524.0723918663981;541.3233458177278;661.7915356662684;668.7091115364832;684.4011489946297;14918.552443426715;15568;15601;15604;15643.90492665514;13894.722105557934;13940.860591394057;13975.371108300049;13995.230262335568;14184.43262269508;12910.160839545399;12998.805017924738;13076.215427074407;13203.933980330134;13617;4481.820727170909;4504.256797628387;4531.728096314232;4577.9771101144615;4719.4100737407825;114319;114692;115967.42016289949;119680.40159799233;123517.14724279143;11124.721881953015;11154.888451115385;11175.608853690082;11258;11566.884331156582;22448.551028979327;22485.775142248694;22777.08891644349;22883.427914302276;23127.53744925092;7481.438892083115;7676.539407635448;7710.498817576839;7751.806204844924;7810.726624568113;4173.937390939138;4190.643795277375;4259.446271984622;4277.957220427756;4384.495782984934;3321.4187517184396;3399.5240666306736;3409.079548521885;3438.3123375325035;3449.706774924109;619.9783007594802;623.0902881792543;628.5662892604089;642.5791106825037;651.791426743447;551.61387029079;604.4046614085123;620.3796203796204;622.8909940760349;623.432676264597;6927.3419025192525;7747.2640099190485;8167.509949403055;8500.44747091437;8784.824303513893;561.5779647503362;583.5215123598693;600.3090700162397;613.2640831002815;613.8680183760513;4176.561461046607;4183.247015537232;4217.493900731932;4330.870073897788;4340.47914250292;102458;106592.09507877518;109460;109846.45076774566;116277.83722162839;93762.53118734363;94834.0516594839;96363;97150.0284997141;98719.50640246752;65913.67043164754;82689.99999999879;82814.58592706997;85670;88584;6527.5430719849155;7182.748603799051;7724.382049436144;7950.24472675095;8527.829443410972;45950.77024614855;46344.7682761584;47533.524664754295;47819.76090119527;48553.514464854896;62492.37507625047;63231;64797.35202647913;69282.65358673174;76196;11135.665930022113;11223.808622356137;11369.43152842338;11444.771104577696;11450.656480305604;11969.521219151136;12140.39298035077;12175.086868485076;12551.246925184518;12588.433520491782;10858;11659.358735269641;11850.822237666269;12005.939970300093;12046.216995895238;10665.542551081011;11667;11681.532738690697;11747.765044698886;12324.198927069712;8767.430117042371;11368.090552755595;11436.142289328167;11536.134789890624;11845.526178952745;9136.132067453582;9324.160825525736;9392.060793920553;9510.47692376926;9821.754456138653;8390.70632527883;9159.809224800732;9426.24590032782;9741.464219467998;9764.951175244078 12:28:44 INFO - PROCESS | 1641 | __end_tp_report 12:28:44 INFO - PROCESS | 1641 | __start_cc_report 12:28:44 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,1562 12:28:44 INFO - PROCESS | 1641 | __end_cc_report 12:28:44 INFO - PROCESS | 1641 | __startTimestamp1482352124662__endTimestamp 12:28:44 INFO - PROCESS | 1641 | 12:28:44 INFO - PROCESS | 1641 | ------- Summary: start ------- 12:28:44 INFO - PROCESS | 1641 | Number of tests: 6 12:28:44 INFO - PROCESS | 1641 | 12:28:44 INFO - PROCESS | 1641 | [#0] dojo.html Cycles:165 Average:5681.84 Median:5924.14 stddev:665.18 (11.2%) stddev-sans-first:641.58 12:28:44 INFO - PROCESS | 1641 | Values: 3350.4 3362.6 3368.8 3409.4 3428.1 4357.8 5533.8 5551.5 5626.5 5684.9 5588.6 5658.5 5662.8 5706.8 5723.4 5133.3 5159.3 5171.9 5200.5 5212.1 5192.1 5314.0 5316.5 5326.7 5329.6 4363.4 4973.9 5158.2 5260.0 5322.8 4851.4 4902.5 5201.5 5235.8 5298.9 4266.0 5137.7 5192.9 5199.4 5268.5 5687.3 5710.5 5737.1 5739.6 5760.7 5981.1 6071.3 6093.3 6241.3 6257.8 6137.8 6188.2 6198.2 6201.0 6202.3 5642.6 5730.6 5739.5 5746.8 5754.6 5223.2 6267.2 6313.9 6323.3 6333.5 6129.2 6143.2 6143.7 6151.1 6156.5 6046.6 6094.9 6269.9 6275.3 6277.7 6081.5 6121.7 6137.7 6154.0 6233.4 6243.9 6255.3 6257.6 6266.4 6268.4 4915.4 4920.0 4920.2 4929.2 4942.4 4296.0 4316.5 4360.7 4436.5 4473.3 4734.5 5658.5 5716.4 5724.5 5734.8 6200.8 6226.4 6227.3 6234.6 6239.1 5718.1 5741.5 5741.8 5755.7 5763.7 5262.7 5303.0 5304.3 5304.6 5338.9 6305.5 6321.2 6334.0 6334.1 6349.0 6113.2 6254.6 6254.7 6263.6 6279.8 6227.9 6330.0 6339.6 6349.8 6374.8 6024.4 6030.6 6047.5 6050.2 6136.1 6159.9 6185.8 6190.4 6215.1 6224.7 5924.1 5945.0 5975.5 5982.5 6037.9 5901.7 5951.6 5968.5 6037.0 6042.7 5902.1 5949.9 5961.6 5979.9 5986.3 6106.0 6127.2 6129.2 6137.4 6141.3 4859.4 5695.2 5810.6 5862.6 5955.7 12:28:44 INFO - PROCESS | 1641 | 12:28:44 INFO - PROCESS | 1641 | [#1] ext.html Cycles:180 Average:66732.50 Median:35154.74 stddev:144994.38 (412.4%) stddev-sans-first:145315.72 12:28:44 INFO - PROCESS | 1641 | Values: 445.8 445.8 454.0 492.1 513.3 30630.0 39945.2 41352.6 41497.8 43763.0 43001.8 43423.3 43506.8 43548.3 43789.0 8409.0 9400.5 9616.5 9628.9 9635.2 8499.3 11186.9 11421.3 11436.3 11657.6 11263.2 11409.4 11417.9 11426.5 11476.9 11385.4 11474.7 11478.8 11488.4 11490.3 11074.3 11108.6 11290.3 11397.1 11424.7 40104.8 40208.8 40565.0 40571.4 40630.4 2503.7 3316.2 3364.5 3410.7 3488.0 23482.1 26628.9 27469.3 27634.0 28542.7 2593.3 3110.9 3231.3 3253.3 3274.8 334773.0 429654.9 429908.0 431383.8 431391.0 51408.0 51640.0 51699.0 51779.0 51784.7 58291.7 58327.7 58373.0 58401.4 58442.7 15241.2 15489.1 15503.2 15519.6 15544.9 10678.1 10965.0 11010.6 11841.5 11979.0 12704.0 15354.7 15460.5 15467.6 17525.0 7383.9 7726.0 7731.2 7742.7 7798.5 863.3 901.8 913.5 1044.3 1080.4 28325.9 28595.6 30102.0 30546.6 31018.2 1042.5 1055.6 1088.3 1103.8 1129.6 15213.2 15489.3 15603.8 15770.8 16137.0 610200.0 615138.0 615277.0 615649.0 616040.6 58496.4 58762.5 58831.4 58952.0 58985.0 1375.6 1403.3 1417.9 1418.9 1423.6 23793.9 25671.9 26548.5 29198.6 29577.6 51175.0 51798.5 51943.7 52001.0 52029.7 572495.0 579631.0 579978.0 580892.0 581087.0 37913.2 38073.0 38648.0 38648.3 38712.6 35783.0 35882.5 40322.6 42339.9 43398.0 35066.6 35783.9 35870.8 35941.5 36880.0 29445.8 35573.0 36069.5 36368.6 36972.3 34924.3 35242.8 35723.3 36058.3 36080.5 31031.8 32108.8 32282.2 32405.4 32440.4 23612.3 23894.4 23917.0 24214.4 24387.3 12:28:44 INFO - PROCESS | 1641 | 12:28:44 INFO - PROCESS | 1641 | [#2] jquery.html Cycles:180 Average:33420.16 Median:25153.68 stddev:91682.77 (364.5%) stddev-sans-first:91906.33 12:28:44 INFO - PROCESS | 1641 | Values: 347.2 369.1 377.5 379.7 400.7 11881.2 14931.9 15172.4 19693.0 20367.7 19200.0 19501.9 20012.6 20206.2 20824.0 5669.3 5935.2 5936.3 5939.2 5939.8 4448.5 5932.9 5937.9 5942.6 5971.7 5463.4 5866.8 5879.3 5885.3 5891.1 5191.4 5802.4 5838.9 5843.4 5867.6 4605.8 4889.5 4952.0 5094.0 5109.0 25093.5 25098.9 25208.5 25228.5 25596.6 2367.4 2858.6 3025.5 3080.3 3118.3 12081.3 13280.5 14147.6 15012.5 15673.6 1442.9 1608.9 1795.2 1826.7 1832.2 95829.5 105346.0 115550.0 119918.4 120321.0 11432.4 11503.7 11669.8 11688.0 11702.5 14059.9 14543.4 14555.5 14591.1 14615.0 8104.0 8429.7 8442.1 8530.5 8544.1 8231.8 8290.5 8305.0 8456.8 8499.6 3731.7 4549.7 4551.7 4572.4 4629.3 1691.9 1858.9 1874.0 1922.0 1931.2 756.7 770.9 902.0 960.8 1058.6 19581.3 20824.5 20955.8 21053.1 21066.9 899.6 905.7 914.6 940.7 1007.0 8311.2 9971.8 10782.7 10848.6 10869.5 533903.0 547018.0 547577.0 548985.3 552099.0 124410.4 131012.0 133851.0 137260.0 137877.0 980.4 1029.1 1049.5 1053.4 1057.5 18156.0 18920.5 18987.9 19015.1 19037.9 52991.7 53494.5 53624.2 54271.5 54690.5 77197.0 77517.0 78248.2 79815.0 80245.0 6883.5 7019.3 7317.9 7373.1 7727.7 10539.4 11150.6 12147.5 12533.7 13019.9 10765.8 10822.9 11231.3 11262.8 11283.3 10443.8 10784.1 10939.7 11040.4 11283.2 11012.0 11210.5 11400.7 11446.6 11545.0 5277.7 7158.2 7256.1 7370.3 7438.9 10558.4 10805.3 10998.7 11194.7 11279.9 12:28:44 INFO - PROCESS | 1641 | 12:28:44 INFO - PROCESS | 1641 | [#3] mootools.html Cycles:180 Average:5310.75 Median:5057.52 stddev:2942.22 (58.2%) stddev-sans-first:2933.94 12:28:44 INFO - PROCESS | 1641 | Values: 1161.8 1422.0 1510.4 1531.3 1902.3 7414.5 7795.2 7949.3 8270.2 8282.7 8177.2 8272.0 8285.5 8293.3 8293.6 2052.5 2239.4 2287.4 2292.9 2294.4 1940.8 2078.7 2276.7 2350.0 2356.7 2297.4 2301.4 2310.4 2316.2 2323.1 2187.4 2269.6 2281.3 2309.2 2311.2 2077.0 2336.5 2337.4 2345.5 2352.1 8239.5 8278.2 8332.3 8371.7 8373.5 4996.7 5129.1 5150.4 5160.7 5164.6 3336.5 3422.6 3495.1 3576.9 3581.7 1042.8 1064.9 1079.1 1081.6 1083.9 10350.7 10620.7 10622.0 10770.4 10777.8 4184.7 4241.0 4411.8 4422.6 4424.8 8412.5 8436.6 8451.2 8565.5 8575.1 5050.6 5054.8 5060.2 5075.4 5086.7 4110.7 4447.1 4749.5 4769.7 4783.4 2914.7 3617.0 3699.1 3701.4 3704.4 1109.9 1137.0 1142.9 1144.5 1146.3 642.0 785.7 860.6 921.4 928.3 5260.7 5341.8 5398.1 5653.7 5723.1 406.4 416.7 427.1 427.2 442.5 3785.4 3810.3 3812.8 3897.4 3918.5 9431.2 9874.0 9984.2 10022.7 10024.4 9971.7 9975.3 9988.9 9992.8 10048.1 7432.3 7661.0 7772.5 7837.9 7838.9 5428.8 5455.8 5485.9 5528.3 5685.1 9175.0 9189.6 9259.7 9300.5 9303.0 9348.3 9400.4 9411.2 9532.2 9537.7 6193.7 6431.6 6633.7 6717.2 6719.4 6495.8 7411.8 7581.8 7759.8 7921.0 6980.5 7069.5 7083.3 7123.6 7207.3 6959.5 6984.3 6993.9 7025.9 7051.6 6385.9 6491.9 6502.5 6533.1 6622.7 4757.8 4773.8 4801.5 4809.5 4924.7 4181.0 4606.8 4768.3 4844.4 5006.7 12:28:44 INFO - PROCESS | 1641 | 12:28:44 INFO - PROCESS | 1641 | [#4] prototype.html Cycles:180 Average:4410.67 Median:4821.53 stddev:1326.75 (27.5%) stddev-sans-first:1293.83 12:28:44 INFO - PROCESS | 1641 | Values: 284.9 341.0 353.3 354.7 358.3 4676.9 5191.4 5249.0 5297.6 5302.4 4271.8 4341.1 4659.9 5052.1 5173.8 3506.2 3575.7 4042.4 4097.2 4117.6 3407.9 3664.9 4000.7 4101.7 4116.7 3616.7 3696.7 3990.5 4031.8 4073.0 4075.9 4096.3 4104.4 4106.4 4123.3 3021.9 3605.0 3605.8 3609.6 3662.2 4186.0 4299.1 5135.7 5161.2 5167.6 3782.6 4514.5 4609.9 4688.2 4699.0 4391.6 4477.6 5527.7 5564.3 5587.9 3509.6 3515.5 3691.8 3892.3 4003.1 4633.3 5442.7 5486.0 5755.6 5851.7 3244.9 3362.7 3607.9 3964.4 4020.4 4068.7 4105.4 4117.5 4130.6 4150.1 3916.7 4107.4 4511.3 4697.6 4716.4 4157.5 5293.2 5398.5 5413.1 5620.3 1198.0 1330.9 1333.9 1334.3 1347.4 917.3 924.3 934.7 946.8 963.3 4842.3 5149.2 5310.9 5315.2 5319.4 4744.9 4927.0 5637.4 5732.3 5748.2 4289.6 5072.2 5250.5 5284.5 5286.7 2821.9 2835.9 2836.4 2841.7 2849.5 4395.0 4771.1 4810.7 5097.6 5588.0 4808.5 5103.5 5569.9 5576.4 5587.4 4804.8 5051.9 5067.8 5686.5 5714.3 4469.6 5340.7 5407.4 5425.6 5442.6 4637.9 4780.3 5352.6 5444.3 5703.4 5210.6 5374.6 5932.4 5973.9 6019.9 3738.0 3837.3 3850.9 3873.6 3875.3 5743.9 5753.4 5769.6 5789.6 5841.5 4946.9 5326.6 5600.9 5623.5 5626.0 4832.4 5033.9 5430.8 5487.4 5554.7 4978.7 5436.5 5485.2 5521.7 5527.8 4855.6 5006.2 5371.8 5436.0 5500.6 4638.5 5500.4 5502.8 5502.9 5505.7 12:28:44 INFO - PROCESS | 1641 | 12:28:44 INFO - PROCESS | 1641 | [#5] yui.html Cycles:180 Average:20782.04 Median:26126.47 stddev:31565.49 (120.8%) stddev-sans-first:31618.04 12:28:44 INFO - PROCESS | 1641 | Values: 702.6 736.5 753.3 792.7 816.9 15157.0 15785.7 15818.8 15838.8 15868.7 14284.4 14465.1 14471.3 14490.4 14498.7 679.2 696.4 698.0 842.8 851.9 867.5 877.8 878.6 886.6 887.6 912.4 925.9 927.0 928.9 929.1 896.9 923.1 923.2 923.3 924.2 524.1 541.3 661.8 668.7 684.4 14918.6 15568.0 15601.0 15604.0 15643.9 13894.7 13940.9 13975.4 13995.2 14184.4 12910.2 12998.8 13076.2 13203.9 13617.0 4481.8 4504.3 4531.7 4578.0 4719.4 114319.0 114692.0 115967.4 119680.4 123517.1 11124.7 11154.9 11175.6 11258.0 11566.9 22448.6 22485.8 22777.1 22883.4 23127.5 7481.4 7676.5 7710.5 7751.8 7810.7 4173.9 4190.6 4259.4 4278.0 4384.5 3321.4 3399.5 3409.1 3438.3 3449.7 620.0 623.1 628.6 642.6 651.8 551.6 604.4 620.4 622.9 623.4 6927.3 7747.3 8167.5 8500.4 8784.8 561.6 583.5 600.3 613.3 613.9 4176.6 4183.2 4217.5 4330.9 4340.5 102458.0 106592.1 109460.0 109846.5 116277.8 93762.5 94834.1 96363.0 97150.0 98719.5 65913.7 82690.0 82814.6 85670.0 88584.0 6527.5 7182.7 7724.4 7950.2 8527.8 45950.8 46344.8 47533.5 47819.8 48553.5 62492.4 63231.0 64797.4 69282.7 76196.0 11135.7 11223.8 11369.4 11444.8 11450.7 11969.5 12140.4 12175.1 12551.2 12588.4 10858.0 11659.4 11850.8 12005.9 12046.2 10665.5 11667.0 11681.5 11747.8 12324.2 8767.4 11368.1 11436.1 11536.1 11845.5 9136.1 9324.2 9392.1 9510.5 9821.8 8390.7 9159.8 9426.2 9741.5 9765.0 12:28:44 INFO - PROCESS | 1641 | -------- Summary: end -------- 12:28:44 INFO - PROCESS | 1641 | 12:28:45 INFO - TEST-INFO | 1641: exit 0 12:28:45 INFO - TEST-OK | dromaeo_css | took 1120683ms 12:28:45 INFO - TEST-START | kraken 12:28:45 INFO - operating with platform_type : mac_ 12:28:45 INFO - Initialising browser for kraken test... 12:28:45 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/tmpNQ5_FO/profile http://localhost:49236/getInfo.html) 12:28:47 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 12:28:47 INFO - PROCESS | 1651 | colorDepth:24 12:28:47 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 12:28:47 INFO - PROCESS | 1651 | __metrics 12:28:47 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" 12:28:47 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:28:48 INFO - TEST-INFO | 1651: exit 0 12:28:48 INFO - Browser initialized. 12:28:48 INFO - Running cycle 1/1 for kraken test... 12:28:48 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/tmpNQ5_FO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:29:00 INFO - PROCESS | 1652 | RSS: Main: 256716800 12:29:00 INFO - PROCESS | 1652 | 12:29:03 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 12:29:04 INFO - PROCESS | 1652 | RSS: Main: 305750016 12:29:04 INFO - PROCESS | 1652 | 12:29:07 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 12:29:07 INFO - PROCESS | 1652 | RSS: Main: 306745344 12:29:07 INFO - PROCESS | 1652 | 12:29:10 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 12:29:11 INFO - PROCESS | 1652 | RSS: Main: 397324288 12:29:11 INFO - PROCESS | 1652 | 12:29:13 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 12:29:14 INFO - PROCESS | 1652 | RSS: Main: 298643456 12:29:14 INFO - PROCESS | 1652 | 12:29:16 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:29:16 INFO - PROCESS | 1652 | RSS: Main: 301916160 12:29:16 INFO - PROCESS | 1652 | 12:29:19 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 12:29:20 INFO - PROCESS | 1652 | RSS: Main: 344399872 12:29:20 INFO - PROCESS | 1652 | 12:29:23 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 12:29:24 INFO - PROCESS | 1652 | RSS: Main: 346566656 12:29:24 INFO - PROCESS | 1652 | 12:29:26 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 12:29:27 INFO - PROCESS | 1652 | RSS: Main: 344346624 12:29:27 INFO - PROCESS | 1652 | 12:29:29 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:29:29 INFO - PROCESS | 1652 | RSS: Main: 315928576 12:29:29 INFO - PROCESS | 1652 | 12:29:31 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:29:32 INFO - PROCESS | 1652 | RSS: Main: 321630208 12:29:32 INFO - PROCESS | 1652 | 12:29:34 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:29:35 INFO - PROCESS | 1652 | RSS: Main: 327921664 12:29:35 INFO - PROCESS | 1652 | 12:29:38 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:29:39 INFO - PROCESS | 1652 | RSS: Main: 340418560 12:29:39 INFO - PROCESS | 1652 | 12:29:42 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:29:42 INFO - PROCESS | 1652 | RSS: Main: 334737408 12:29:42 INFO - PROCESS | 1652 | 12:29:44 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 12:29:44 INFO - PROCESS | 1652 | RSS: Main: 378253312 12:29:44 INFO - PROCESS | 1652 | 12:29:44 INFO - PROCESS | 1652 | __start_tp_report 12:29:44 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 12:29:44 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 12:29:44 INFO - PROCESS | 1652 | |i|pagename|runs| 12:29:44 INFO - PROCESS | 1652 | |0;ai-astar;114;115;114;118;163;169;114;113;114;115 12:29:44 INFO - PROCESS | 1652 | |1;audio-beat-detection;143;106;109;145;123;115;141;140;153;109 12:29:44 INFO - PROCESS | 1652 | |2;audio-dft;184;185;183;184;181;183;182;182;186;181 12:29:44 INFO - PROCESS | 1652 | |3;audio-fft;80;60;60;86;65;75;60;58;74;58 12:29:44 INFO - PROCESS | 1652 | |4;audio-oscillator;87;70;86;69;69;69;84;69;69;84 12:29:44 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;92;89;92;91;135;130;92;89;92;88 12:29:44 INFO - PROCESS | 1652 | |6;imaging-darkroom;97;97;96;96;96;96;110;152;150;96 12:29:44 INFO - PROCESS | 1652 | |7;imaging-desaturate;84;86;71;138;141;91;86;86;87;86 12:29:44 INFO - PROCESS | 1652 | |8;json-parse-financial;57;56;55;55;57;57;58;54;55;54 12:29:44 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;73;69;78;74;75;73;71;70;74;71 12:29:44 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;91;86;90;102;108;90;90;86;86;92 12:29:44 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;148;157;142;144;153;152;151;152;197;149 12:29:44 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;173;172;173;173;171;174;170;171;231;207 12:29:44 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;69;66;79;91;88;89;88;74;65;65 12:29:44 INFO - PROCESS | 1652 | __end_tp_report 12:29:44 INFO - PROCESS | 1652 | __start_cc_report 12:29:44 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,2034 12:29:44 INFO - PROCESS | 1652 | __end_cc_report 12:29:44 INFO - PROCESS | 1652 | __startTimestamp1482352184857__endTimestamp 12:29:44 INFO - PROCESS | 1652 | 12:29:44 INFO - PROCESS | 1652 | ------- Summary: start ------- 12:29:44 INFO - PROCESS | 1652 | Number of tests: 14 12:29:44 INFO - PROCESS | 1652 | 12:29:44 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:124.90 Median:115.00 stddev:21.75 (18.9%) stddev-sans-first:22.71 12:29:44 INFO - PROCESS | 1652 | Values: 114.0 115.0 114.0 118.0 163.0 169.0 114.0 113.0 114.0 115.0 12:29:44 INFO - PROCESS | 1652 | 12:29:44 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:128.40 Median:140.50 stddev:17.80 (12.7%) stddev-sans-first:18.07 12:29:44 INFO - PROCESS | 1652 | Values: 143.0 106.0 109.0 145.0 123.0 115.0 141.0 140.0 153.0 109.0 12:29:44 INFO - PROCESS | 1652 | 12:29:44 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:183.10 Median:183.50 stddev:1.66 (0.9%) stddev-sans-first:1.73 12:29:44 INFO - PROCESS | 1652 | Values: 184.0 185.0 183.0 184.0 181.0 183.0 182.0 182.0 186.0 181.0 12:29:44 INFO - PROCESS | 1652 | 12:29:44 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:67.60 Median:69.50 stddev:10.29 (14.8%) stddev-sans-first:9.88 12:29:44 INFO - PROCESS | 1652 | Values: 80.0 60.0 60.0 86.0 65.0 75.0 60.0 58.0 74.0 58.0 12:29:44 INFO - PROCESS | 1652 | 12:29:44 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:75.60 Median:77.00 stddev:8.36 (10.9%) stddev-sans-first:7.78 12:29:44 INFO - PROCESS | 1652 | Values: 87.0 70.0 86.0 69.0 69.0 69.0 84.0 69.0 69.0 84.0 12:29:44 INFO - PROCESS | 1652 | 12:29:44 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:99.00 Median:91.50 stddev:17.76 (19.4%) stddev-sans-first:18.65 12:29:44 INFO - PROCESS | 1652 | Values: 92.0 89.0 92.0 91.0 135.0 130.0 92.0 89.0 92.0 88.0 12:29:44 INFO - PROCESS | 1652 | 12:29:44 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:108.60 Median:96.00 stddev:22.76 (23.7%) stddev-sans-first:23.75 12:29:44 INFO - PROCESS | 1652 | Values: 97.0 97.0 96.0 96.0 96.0 96.0 110.0 152.0 150.0 96.0 12:29:44 INFO - PROCESS | 1652 | 12:29:44 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:86.00 stddev:23.72 (27.6%) stddev-sans-first:24.78 12:29:44 INFO - PROCESS | 1652 | Values: 84.0 86.0 71.0 138.0 141.0 91.0 86.0 86.0 87.0 86.0 12:29:44 INFO - PROCESS | 1652 | 12:29:44 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.50 stddev:1.40 (2.5%) stddev-sans-first:1.41 12:29:44 INFO - PROCESS | 1652 | Values: 57.0 56.0 55.0 55.0 57.0 57.0 58.0 54.0 55.0 54.0 12:29:44 INFO - PROCESS | 1652 | 12:29:44 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:72.80 Median:73.50 stddev:2.66 (3.6%) stddev-sans-first:2.82 12:29:44 INFO - PROCESS | 1652 | Values: 73.0 69.0 78.0 74.0 75.0 73.0 71.0 70.0 74.0 71.0 12:29:44 INFO - PROCESS | 1652 | 12:29:44 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:92.10 Median:90.00 stddev:7.28 (8.1%) stddev-sans-first:7.71 12:29:44 INFO - PROCESS | 1652 | Values: 91.0 86.0 90.0 102.0 108.0 90.0 90.0 86.0 86.0 92.0 12:29:44 INFO - PROCESS | 1652 | 12:29:44 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:154.50 Median:152.00 stddev:15.56 (10.2%) stddev-sans-first:16.32 12:29:44 INFO - PROCESS | 1652 | Values: 148.0 157.0 142.0 144.0 153.0 152.0 151.0 152.0 197.0 149.0 12:29:44 INFO - PROCESS | 1652 | 12:29:44 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.50 Median:173.00 stddev:20.59 (11.9%) stddev-sans-first:21.61 12:29:44 INFO - PROCESS | 1652 | Values: 173.0 172.0 173.0 173.0 171.0 174.0 170.0 171.0 231.0 207.0 12:29:44 INFO - PROCESS | 1652 | 12:29:44 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.40 Median:83.50 stddev:10.89 (13.0%) stddev-sans-first:11.11 12:29:44 INFO - PROCESS | 1652 | Values: 69.0 66.0 79.0 91.0 88.0 89.0 88.0 74.0 65.0 65.0 12:29:44 INFO - PROCESS | 1652 | -------- Summary: end -------- 12:29:44 INFO - PROCESS | 1652 | 12:29:45 INFO - TEST-INFO | 1652: exit 0 12:29:45 INFO - TEST-OK | kraken | took 60446ms 12:29:45 INFO - SUITE-END | took 1181s 12:29:46 INFO - Completed test suite (00:19:41) 12:29:46 INFO - javascript benchmark 12:29:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3350.43042682744, 3362.613299470561, 3368.848401821916, 3409.3863104641187, 3428.0744199066253, 4357.825686972521, 5533.806316778913, 5551.500364967153, 5626.54987600992, 5684.919865225609, 5588.580856435773, 5658.490735833774, 5662.801801936933, 5706.828795136153, 5723.370429252789, 5133.255677926699, 5159.251908473269, 5171.922421163686, 5200.479952004807, 5212.139996900507, 5192.117340052181, 5313.9734301328435, 5316.5215130638235, 5326.680399176062, 5329.600279978998, 4363.432753741993, 4973.875653108665, 5158.174692049254, 5260.0, 5322.787088516455, 4851.369321988154, 4902.534259245366, 5201.479852014768, 5235.842924712265, 5298.894022119536, 4265.957340426618, 5137.717425541594, 5192.948070519285, 5199.428062913076, 5268.473152684739, 5687.289088863892, 5710.514606258473, 5737.110747834051, 5739.626924249952, 5760.654360738369, 5981.132735753335, 6071.332153463116, 6093.268807743055, 6241.251049873998, 6257.843553911143, 6137.8187520601, 6188.195534580521, 6198.163247961513, 6200.968995155041, 6202.348753380875, 5642.576806739511, 5730.570207234391, 5739.540836733051, 5746.827595172152, 5754.625949313281, 5223.216517522402, 6267.2165979252595, 6313.905291420632, 6323.336049714806, 6333.524985626096, 6129.172561704202, 6143.170671959318, 6143.662098584621, 6151.138840562325, 6156.476699480594, 6046.5767396281835, 6094.878102438015, 6269.8746025079245, 6275.341089185661, 6277.7175027123885, 6081.452669259788, 6121.696863452088, 6137.693115344215, 6154.046122850965, 6233.376662333731, 6243.937560624427, 6255.343188965184, 6257.593256438408, 6266.436020758154, 6268.404501572343, 4915.410150781929, 4919.99140176263, 4920.188168952154, 4929.211326187793, 4942.40691117061, 4296.011917259048, 4316.5467625899455, 4360.694751367374, 4436.511983681792, 4473.261911784584, 4734.479207287196, 5658.547316214693, 5716.399778023331, 5724.542036637059, 5734.827955161351, 6200.751969921243, 6226.40849119333, 6227.346128656426, 6234.5635805494085, 6239.095331176954, 5718.1136923776885, 5741.540676745851, 5741.813293621996, 5755.65466072037, 5763.740631671585, 5262.736863156827, 5302.973485132627, 5304.336957880265, 5304.628675992643, 5338.9466105339225, 6305.464035557029, 6321.209848768812, 6334.0, 6334.113224148531, 6349.0476428536085, 6113.174721412553, 6254.6247225166635, 6254.687265636791, 6263.6241825490615, 6279.843003924756, 6227.906581401192, 6330.0, 6339.619622822645, 6349.841253968688, 6374.840628984127, 6024.3975602439405, 6030.6080104793045, 6047.455728984412, 6050.183225264533, 6136.140940268455, 6159.907601386072, 6185.84535386601, 6190.442860142609, 6215.06773983906, 6224.657643829451, 5924.140999555127, 5945.048792193228, 5975.521958243243, 5982.52139828804, 6037.939620603738, 5901.734421950937, 5951.642901425928, 5968.522518198447, 6037.0, 6042.697865106639, 5902.055671092605, 5949.940500594938, 5961.642301461753, 5979.880402391841, 5986.341502434641, 6105.9694701526205, 6127.234095738033, 6129.233845769279, 6137.355577664281, 6141.324454309933, 4859.3682821233015, 5695.174199741097, 5810.564207684525, 5862.560307976833, 5955.67243801595], "value": 5639.948182148513, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [445.7993902743766, 445.8238995596739, 454.02837926836554, 492.0822665728418, 513.2634669249626, 30630.0, 39945.20109597806, 41352.586474135285, 41497.792511037405, 43763.0, 43001.78499107508, 43423.348649770276, 43506.7824660877, 43548.3467747984, 43789.0, 8408.957955210246, 9400.529973501314, 9616.519174041305, 9628.903710962872, 9635.18100961419, 8499.277561407287, 11186.944065279662, 11421.25761825483, 11436.313821170756, 11657.591984280552, 11263.21157518974, 11409.37248451335, 11417.885821141806, 11426.542938282459, 11476.942615286913, 11385.373804440753, 11474.655760327203, 11478.827817582744, 11488.425578721031, 11490.253133546334, 11074.280171788809, 11108.61119860809, 11290.266132701348, 11397.088232941345, 11424.657260282205, 40104.79947600273, 40208.798956005034, 40565.0, 40571.39142912829, 40630.39054414186, 2503.699556053267, 3316.2041110133637, 3364.4785058315756, 3410.744194185446, 3488.0, 23482.067704935158, 26628.86685566579, 27469.31326716848, 27634.032808851593, 28542.714572854213, 2593.2998090515644, 3110.875564977398, 3231.3375757969793, 3253.2842774589553, 3274.787138835968, 334773.0, 429654.85172573937, 429908.0, 431383.84308078256, 431391.0, 51407.971840563725, 51639.96720065653, 51698.96602068013, 51778.964420711374, 51784.74107629438, 58291.708541457025, 58327.708361457924, 58373.0, 58401.415985840446, 58442.70778646079, 15241.247256565637, 15489.070655760464, 15503.224838758017, 15519.612009699847, 15544.922275388551, 10678.145748340114, 10965.0, 11010.559577616805, 11841.526338946518, 11979.041676665845, 12704.0, 15354.692906141814, 15460.458883939009, 15467.613309667347, 17525.0, 7383.852322953619, 7725.961370193113, 7731.188225236382, 7742.722450795555, 7798.532088074734, 863.3352318714554, 901.7970956534728, 913.5249670171473, 1044.3159730376615, 1080.3679847289266, 28325.858370708014, 28595.57106643402, 30102.0, 30546.639770254238, 31018.22454438612, 1042.4943902207424, 1055.5988724284723, 1088.3089238333714, 1103.8399432082304, 1129.6046383765781, 15213.163276019704, 15489.302981365865, 15603.843961560466, 15770.842291577166, 16137.0, 610200.0, 615138.0, 615277.0, 615649.0, 616040.5563499307, 58496.415035849095, 58762.53093672607, 58831.411685882595, 58952.0, 58985.0, 1375.5735721926235, 1403.3404299978993, 1417.8723914847712, 1418.8793952514152, 1423.6369725719876, 23793.881030594737, 25671.871640642425, 26548.469030618893, 29198.56202156927, 29577.556336654536, 51175.0, 51798.48201517937, 51943.74028129986, 52001.0, 52029.7398513005, 572495.0, 579631.0, 579978.0, 580892.0, 581087.0, 37913.24173516459, 38073.048173795876, 38648.0, 38648.32840880112, 38712.6128738709, 35783.0, 35882.4617630741, 40322.59677403188, 42339.94150146271, 43398.0, 35066.649333506335, 35783.92648220558, 35870.8206458966, 35941.460878087375, 36880.0, 29445.791565632237, 35573.0, 36069.45895811617, 36368.63631363758, 36972.26055478929, 34924.30151397009, 35242.82378588091, 35723.28553428969, 36058.27883442264, 36080.45879311865, 31031.84484077565, 32108.839455802572, 32282.192945176557, 32405.35189296154, 32440.351192975537, 23612.29163125109, 23894.402639934142, 23916.976956320163, 24214.394640134138, 24387.26838194857], "value": 19616.575817737154, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.16506801143225, 369.13069720807516, 377.5016977589582, 379.73608342202164, 400.7395193124469, 11881.227720198192, 14931.925340373296, 15172.39310427583, 19693.0, 20367.694484582742, 19200.039998000113, 19501.902490487526, 20012.599748005032, 20206.19175232989, 20824.0, 5669.291338582667, 5935.169076329317, 5936.3173235077875, 5939.198208241897, 5939.821805345847, 4448.488423831269, 5932.911006334887, 5937.910931336012, 5942.64344139353, 5971.701414929258, 5463.3717122530825, 5866.823995280127, 5879.32387775407, 5885.264341957255, 5891.116332550109, 5191.351081114861, 5802.361740208574, 5838.941610583882, 5843.415658434165, 5867.559933004999, 4605.815767369301, 4889.535494128052, 4951.975240123812, 5094.0, 5109.0, 25093.498130037297, 25098.870550825257, 25208.495830083295, 25228.49543009148, 25596.616050759254, 2367.360812580611, 2858.5855051017693, 3025.5007923692565, 3080.2607374230247, 3118.2827949571497, 12081.275123492618, 13280.53518126861, 14147.646308842259, 15012.549623511311, 15673.608159795982, 1442.87735542479, 1608.8873778835487, 1795.1921635264052, 1826.7351234070986, 1832.1572076844668, 95829.52085239529, 105346.0, 115550.0, 119918.4004079974, 120321.0, 11432.371219583003, 11503.654890353302, 11669.766604667859, 11688.0, 11702.531898723955, 14059.85940140606, 14543.418263269563, 14555.490557830424, 14591.124532528082, 14615.0, 8104.0, 8429.747107586782, 8442.113578074337, 8530.488170709777, 8544.145585441405, 8231.753047408587, 8290.502569845828, 8305.0, 8456.78858028542, 8499.575021248913, 3731.7014638828828, 4549.704269222556, 4551.678643891639, 4572.359869618256, 4629.259318509023, 1691.9492415227562, 1858.927296064878, 1873.981260187408, 1921.9711704324445, 1931.169597073272, 756.6973210715757, 770.8535378278109, 901.963921443135, 960.7646126698863, 1058.5871510111062, 19581.314653987043, 20824.47938801542, 20955.790442095386, 21053.05261263247, 21066.894665526575, 899.5906862377602, 905.6558507767006, 914.6341463414687, 940.7177846645978, 1006.9949650251701, 8311.210435008665, 9971.800563988825, 10782.67651970442, 10848.620298289521, 10869.45652717361, 533903.0, 547018.0, 547577.0, 548985.25507373, 552099.0, 124410.37794810969, 131012.0, 133851.0, 137260.0, 137877.0, 980.4117529482254, 1029.0584115534202, 1049.496241803923, 1053.431147180514, 1057.5188289328337, 18156.0, 18920.52698682544, 18987.90506047516, 19015.144318505976, 19037.90685002731, 52991.675208120105, 53494.46505534895, 53624.195637064695, 54271.45728542664, 54690.453095470126, 77197.0, 77517.0, 78248.21751782409, 79815.0, 80245.0, 6883.518153729191, 7019.262977387505, 7317.926820731725, 7373.115226172894, 7727.652255648397, 10539.367637941748, 11150.609728659458, 12147.542294924666, 12533.749325013267, 13019.934900325437, 10765.838512422164, 10822.945885270523, 11231.26996745209, 11262.831057534308, 11283.266587671775, 10443.791124177626, 10784.137269018616, 10939.726506837393, 11040.447977600927, 11283.153763467608, 11012.0, 11210.49552770111, 11400.657980260605, 11446.599369022044, 11545.0, 5277.709725965109, 7158.248383919614, 7256.129264488295, 7370.299821516947, 7438.888416673646, 10558.366498010144, 10805.297655652357, 10998.670039898816, 11194.720131996439, 11279.887201127884], "value": 9420.59076680542, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1161.756031233441, 1421.9502317418892, 1510.3807438950032, 1531.3032570180562, 1902.3151665400453, 7414.518056326335, 7795.220477952209, 7949.2845643892115, 8270.21432963869, 8282.710105146321, 8177.223163799445, 8272.007359116915, 8285.461445006085, 8293.336533077354, 8293.626786794608, 2052.5381789097482, 2239.4065572623226, 2287.359539328982, 2292.919747808827, 2294.4149241943283, 1940.8253257206918, 2078.688196770481, 2276.7381751098587, 2350.0364850411333, 2356.681847950522, 2297.4026753044245, 2301.390131615123, 2310.387747246981, 2316.154603569702, 2323.082382458928, 2187.4141247595526, 2269.614165591853, 2281.315605318406, 2309.180241014449, 2311.202635090891, 2076.968845467319, 2336.4742932840145, 2337.3689103941842, 2345.542619189259, 2352.1297120065515, 8239.546824924626, 8278.172182781735, 8332.250097491195, 8371.665133394657, 8373.539455329954, 4996.675216110941, 5129.12804823181, 5150.407703114152, 5160.690358578498, 5164.6384753067305, 3336.5328853960464, 3422.5528746945806, 3495.1436897959907, 3576.946345804815, 3581.71346292296, 1042.796654652343, 1064.8775390830076, 1079.0558261521169, 1081.6214324986192, 1083.9458027098613, 10350.741231469197, 10620.734481637943, 10622.0, 10770.353778773298, 10777.83833242502, 4184.727992680466, 4241.024564350155, 4411.779411029435, 4422.624076953431, 4424.836242086923, 8412.537310447862, 8436.620352084172, 8451.197136272045, 8565.52889591066, 8575.099614540508, 5050.621203409685, 5054.7978080876355, 5060.240963855451, 5075.441701412916, 5086.669366491166, 4110.691698122653, 4447.08834688888, 4749.548792864742, 4769.713817170981, 4783.4499032611, 2914.6793852676187, 3616.9638303617153, 3699.130704284491, 3701.3892707703467, 3704.3517384457614, 1109.8945600167972, 1136.9886301137049, 1142.868570114431, 1144.5292798753728, 1146.3064845768356, 641.9967900160563, 785.7407055671615, 860.6084231674573, 921.4195057113975, 928.3223247029706, 5260.684358938476, 5341.759620817073, 5398.1093119634825, 5653.717314134276, 5723.112917497794, 406.43302592882765, 416.7478675401399, 427.0711203133235, 427.1712877018574, 442.50660513527185, 3785.37541305687, 3810.2760475509563, 3812.790296533717, 3897.415387691812, 3918.5101862267215, 9431.198348140484, 9873.950630246947, 9984.20126389887, 10022.749431264278, 10024.448655324028, 9971.650992215238, 9975.25185611082, 9988.900110998942, 9992.750181245527, 10048.09567138961, 7432.293932076444, 7660.961695191489, 7772.533647981026, 7837.9216207838335, 7838.882416763753, 5428.7557059931605, 5455.781768729206, 5485.862853428696, 5528.281323427928, 5685.144301369596, 9175.0, 9189.632414703337, 9259.72220833376, 9300.534973251446, 9303.0, 9348.345615806827, 9400.388974716621, 9411.152996230372, 9532.189763870148, 9537.666181683608, 6193.690315484298, 6431.646259455775, 6633.70148343316, 6717.193936727624, 6719.428848547928, 6495.837604059747, 7411.8147046324275, 7581.810454738676, 7759.7672069838, 7921.0, 6980.476464265099, 7069.469789765891, 7083.291670832876, 7123.643817809192, 7207.270255138834, 6959.478039146983, 6984.301569842975, 6993.930060699531, 7025.859482810418, 7051.6474176292, 6385.8722825544155, 6491.870162596816, 6502.512311576746, 6533.118029066015, 6622.668866556749, 4757.833475828329, 4773.76131193432, 4801.51984801517, 4809.5430934061205, 4924.72913989734, 4180.979095104505, 4606.838760643362, 4768.332433459249, 4844.370231869834, 5006.7246301452315], "value": 4219.6911651516175, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.9145256423073, 340.98465569049375, 353.3145697347147, 354.7109106078546, 358.3495954841963, 4676.906461870764, 5191.351081114865, 5248.973755131224, 5297.576193904488, 5302.390225124112, 4271.786410679461, 4341.069777899921, 4659.906801863961, 5052.0906236877345, 5173.793048278074, 3506.246157076228, 3575.678188962993, 4042.4138499917494, 4097.180563887227, 4117.608827161415, 3407.9488807667904, 3664.9450258246147, 4000.6997725739106, 4101.692373072016, 4116.732412393185, 3616.65641764032, 3696.704263658901, 3990.4812374391436, 4031.778252196128, 4072.9592704072875, 4075.8981025474454, 4096.283150448675, 4104.445899803518, 4106.404571337169, 4123.3196522573735, 3021.8640161192798, 3605.0, 3605.837737301828, 3609.62098979606, 3662.15061393997, 4185.97907010466, 4299.109306078004, 5135.717535535544, 5161.200013997836, 5167.638265321429, 3782.56500502443, 4514.503404625489, 4609.893625529882, 4688.226442636961, 4698.976505117486, 4391.5827996340295, 4477.574630410106, 5527.668339899578, 5564.304461942257, 5587.888242235133, 3509.5613048368955, 3515.525404070469, 3691.837071322525, 3892.275407214961, 4003.077753240122, 4633.30500424939, 5442.700651464168, 5485.957668043059, 5755.568332375046, 5851.678157701324, 3244.902652920416, 3362.7309815214726, 3607.909802254912, 3964.365701487806, 4020.3969404589548, 4068.7355321903983, 4105.4252404662775, 4117.547069822317, 4130.56629053951, 4150.086980864205, 3916.74541154824, 4107.363358679409, 4511.278195488706, 4697.600703940135, 4716.434027916604, 4157.521884983205, 5293.241798323156, 5398.4871437213405, 5413.131040548436, 5620.313905828235, 1197.9640610781692, 1330.9419011885382, 1333.8799508044322, 1334.2994927663055, 1347.3667376333108, 917.2845180758885, 924.2605915267759, 934.7101000619102, 946.7964387656549, 963.325672029582, 4842.297866809293, 5149.176131818891, 5310.92033619496, 5315.202719592015, 5319.388270348882, 4744.881377965509, 4926.96533727914, 5637.351704553947, 5732.283464566929, 5748.19525266463, 4289.62731925787, 5072.163093089599, 5250.527452529291, 5284.497972692588, 5286.735663216824, 2821.8871245150376, 2835.9149225523265, 2836.375997280595, 2841.7300356466103, 2849.458602865449, 4394.978025109854, 4771.069641419959, 4810.6632535722165, 5097.617678674114, 5588.022096133161, 4808.471068182497, 5103.545489535464, 5569.916451253234, 5576.358718747396, 5587.357453892773, 4804.8318308859025, 5051.898962020812, 5067.770181120295, 5686.516646085129, 5714.257146570919, 4469.5530446955045, 5340.732963351895, 5407.378151512627, 5425.647332923348, 5442.591805614674, 4637.93043104347, 4780.330753694416, 5352.625316227826, 5444.3466783984595, 5703.429657034263, 5210.609204309768, 5374.596905232202, 5932.406759324033, 5973.940260597338, 6019.856227316795, 3737.981310093432, 3837.3092843288478, 3850.9037274068373, 3873.593272706325, 3875.3024455597138, 5743.885122297447, 5753.395893431297, 5769.60561367028, 5789.6104934816185, 5841.532677385714, 4946.925796112989, 5326.627136100436, 5600.85997850057, 5623.465770751772, 5626.043572592751, 4832.395950506187, 5033.949660503348, 5430.782768689208, 5487.396386397413, 5554.666719996813, 4978.701277923336, 5436.53789427903, 5485.177223416519, 5521.723913804374, 5527.806526771544, 4855.611551075976, 5006.222790909321, 5371.758270877742, 5435.994341046919, 5500.6424582403615, 4638.512956139557, 5500.4224556420995, 5502.80740174092, 5502.944970550243, 5505.724713764376], "value": 4008.0894617270046, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.6486756621689, 736.4807810493603, 753.284379839153, 792.7304716396424, 816.9223923727245, 15157.014794038394, 15785.684286314267, 15818.76271855923, 15838.762418563716, 15868.682626347481, 14284.428622855074, 14465.132092074484, 14471.276436178176, 14490.420383184686, 14498.710025799477, 679.2121139478206, 696.3837004251224, 697.9546329488593, 842.8356470488258, 851.9105493923141, 867.5055218525443, 877.7761670773943, 878.6221924572432, 886.6453418632534, 887.6138879587401, 912.3795818843184, 925.9259259259277, 926.986095208569, 928.9071092890724, 929.0616477357884, 896.9416987895765, 923.0953665407905, 923.1922068190333, 923.2752289452781, 924.2005665099707, 524.0723918663981, 541.3233458177278, 661.7915356662684, 668.7091115364832, 684.4011489946297, 14918.552443426715, 15568.0, 15601.0, 15604.0, 15643.90492665514, 13894.722105557934, 13940.860591394057, 13975.371108300049, 13995.230262335568, 14184.43262269508, 12910.160839545399, 12998.805017924738, 13076.215427074407, 13203.933980330134, 13617.0, 4481.820727170909, 4504.256797628387, 4531.728096314232, 4577.9771101144615, 4719.4100737407825, 114319.0, 114692.0, 115967.42016289949, 119680.40159799233, 123517.14724279143, 11124.721881953015, 11154.888451115385, 11175.608853690082, 11258.0, 11566.884331156582, 22448.551028979327, 22485.775142248694, 22777.08891644349, 22883.427914302276, 23127.53744925092, 7481.438892083115, 7676.539407635448, 7710.498817576839, 7751.806204844924, 7810.726624568113, 4173.937390939138, 4190.643795277375, 4259.446271984622, 4277.957220427756, 4384.495782984934, 3321.4187517184396, 3399.5240666306736, 3409.079548521885, 3438.3123375325035, 3449.706774924109, 619.9783007594802, 623.0902881792543, 628.5662892604089, 642.5791106825037, 651.791426743447, 551.61387029079, 604.4046614085123, 620.3796203796204, 622.8909940760349, 623.432676264597, 6927.3419025192525, 7747.2640099190485, 8167.509949403055, 8500.44747091437, 8784.824303513893, 561.5779647503362, 583.5215123598693, 600.3090700162397, 613.2640831002815, 613.8680183760513, 4176.561461046607, 4183.247015537232, 4217.493900731932, 4330.870073897788, 4340.47914250292, 102458.0, 106592.09507877518, 109460.0, 109846.45076774566, 116277.83722162839, 93762.53118734363, 94834.0516594839, 96363.0, 97150.0284997141, 98719.50640246752, 65913.67043164754, 82689.99999999879, 82814.58592706997, 85670.0, 88584.0, 6527.5430719849155, 7182.748603799051, 7724.382049436144, 7950.24472675095, 8527.829443410972, 45950.77024614855, 46344.7682761584, 47533.524664754295, 47819.76090119527, 48553.514464854896, 62492.37507625047, 63231.0, 64797.35202647913, 69282.65358673174, 76196.0, 11135.665930022113, 11223.808622356137, 11369.43152842338, 11444.771104577696, 11450.656480305604, 11969.521219151136, 12140.39298035077, 12175.086868485076, 12551.246925184518, 12588.433520491782, 10858.0, 11659.358735269641, 11850.822237666269, 12005.939970300093, 12046.216995895238, 10665.542551081011, 11667.0, 11681.532738690697, 11747.765044698886, 12324.198927069712, 8767.430117042371, 11368.090552755595, 11436.142289328167, 11536.134789890624, 11845.526178952745, 9136.132067453582, 9324.160825525736, 9392.060793920553, 9510.47692376926, 9821.754456138653, 8390.70632527883, 9159.809224800732, 9426.24590032782, 9741.464219467998, 9764.951175244078], "value": 7208.064016794559, "unit": "score"}], "name": "dromaeo_css", "value": 7090.503396366485, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 118.0, 163.0, 169.0, 114.0, 113.0, 114.0, 115.0], "value": 124.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 106.0, 109.0, 145.0, 123.0, 115.0, 141.0, 140.0, 153.0, 109.0], "value": 128.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 183.0, 184.0, 181.0, 183.0, 182.0, 182.0, 186.0, 181.0], "value": 183.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 60.0, 86.0, 65.0, 75.0, 60.0, 58.0, 74.0, 58.0], "value": 67.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 86.0, 69.0, 69.0, 69.0, 84.0, 69.0, 69.0, 84.0], "value": 75.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 89.0, 92.0, 91.0, 135.0, 130.0, 92.0, 89.0, 92.0, 88.0], "value": 99.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 110.0, 152.0, 150.0, 96.0], "value": 108.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 71.0, 138.0, 141.0, 91.0, 86.0, 86.0, 87.0, 86.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 55.0, 55.0, 57.0, 57.0, 58.0, 54.0, 55.0, 54.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 69.0, 78.0, 74.0, 75.0, 73.0, 71.0, 70.0, 74.0, 71.0], "value": 72.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 86.0, 90.0, 102.0, 108.0, 90.0, 90.0, 86.0, 86.0, 92.0], "value": 92.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 157.0, 142.0, 144.0, 153.0, 152.0, 151.0, 152.0, 197.0, 149.0], "value": 154.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 173.0, 173.0, 171.0, 174.0, 170.0, 171.0, 231.0, 207.0], "value": 181.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 79.0, 91.0, 88.0, 89.0, 88.0, 74.0, 65.0, 65.0], "value": 77.4, "unit": "score"}], "name": "kraken", "value": 1516.9, "alertThreshold": 2.0}]} 12:29:46 INFO - Return code: 0 12:29:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:29:46 INFO - # TBPL SUCCESS # 12:29:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:29:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:29:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:29:46 INFO - 2016-12-21 12:29:46.192 screenresolution[1656:9675] starting screenresolution argv=screenresolution get 12:29:46 INFO - 2016-12-21 12:29:46.195 screenresolution[1656:9675] Display 0: 1600x1200x32@60 12:29:46 INFO - 2016-12-21 12:29:46.201 screenresolution[1657:9678] starting screenresolution argv=screenresolution list 12:29:46 INFO - Available Modes on Display 0 12:29:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:29:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:29:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:29:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:29:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:29:46 INFO - Intel Iris: 12:29:46 INFO - Chipset Model: Intel Iris 12:29:46 INFO - Type: GPU 12:29:46 INFO - Bus: Built-In 12:29:46 INFO - VRAM (Dynamic, Max): 1536 MB 12:29:46 INFO - Vendor: Intel (0x8086) 12:29:46 INFO - Device ID: 0x0a2e 12:29:46 INFO - Revision ID: 0x0009 12:29:46 INFO - Displays: 12:29:46 INFO - Display: 12:29:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:29:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:29:46 INFO - Display Serial Number: 1600x1200 60 12:29:46 INFO - Main Display: Yes 12:29:46 INFO - Mirror: Off 12:29:46 INFO - Online: Yes 12:29:46 INFO - Rotation: Supported 12:29:46 INFO - Return code: 0 12:29:46 INFO - Running post-action listener: _resource_record_post_action 12:29:46 INFO - [mozharness: 2016-12-21 20:29:46.437934Z] Finished run-tests step (success) 12:29:46 INFO - Running post-run listener: _resource_record_post_run 12:29:46 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 37704704; Write bytes: 548496896; Read time: 309; Write time: 1648 12:29:46 INFO - TinderboxPrint: CPU usage
53.6% 12:29:46 INFO - TinderboxPrint: I/O read bytes / time
37,704,704 / 309 12:29:46 INFO - TinderboxPrint: I/O write bytes / time
548,496,896 / 1,648 12:29:46 INFO - TinderboxPrint: CPU idle
2,236.1 (46.4%) 12:29:46 INFO - TinderboxPrint: CPU system
964.8 (20.0%) 12:29:46 INFO - TinderboxPrint: CPU user
1,616.8 (33.6%) 12:29:46 INFO - TinderboxPrint: Swap in / out
287,571,968 / 0 12:29:46 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 229038592; Write bytes: 220299264; Read time: 17584; Write time: 472 12:29:46 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 36721664; Write bytes: 295702528; Read time: 294; Write time: 1094 12:29:46 INFO - Running post-run listener: _upload_blobber_files 12:29:46 INFO - Blob upload gear active. 12:29:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:29:46 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 12:29:46 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'] 12:29:46 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 12:29:47 INFO - (blobuploader) - INFO - Open directory for files ... 12:29:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:29:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:29:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:29:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:29:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:29:48 INFO - (blobuploader) - INFO - Done attempting. 12:29:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:29:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:29:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:29:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:29:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:29:49 INFO - (blobuploader) - INFO - Done attempting. 12:29:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:29:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:29:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:29:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:29:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:29:50 INFO - (blobuploader) - INFO - Done attempting. 12:29:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:29:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:29:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:29:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:29:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:29:52 INFO - (blobuploader) - INFO - Done attempting. 12:29:52 INFO - (blobuploader) - INFO - Iteration through files over. 12:29:52 INFO - Return code: 0 12:29:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:29:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:29:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/619d02e42c79ed4770c420d289c3611856072bf65e5e4e2154a6b6b464b69c186445641c9a756007aa51318e45ead8eb42dbe4cd45b25e3f50baee1ea3fa4af7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/abaa39fb6c68a32c064ead80201775125f39cca7fbe124a998c815c4ac562e0c1e74b176ff5f309c49c2cd4b5f824f97038441953e711abd05ae5c693fde5eae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1d7321654ddb3dc76444f027deb0ebe3218a1d3dbf4b958f3b7d679ef0fb8113cae875ed24bfd528e360dd2ec34189fb9717715cd4f6ae06c92b14cec060738a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d86248a3d7ffa00b07ecf9b6716c30dcc36ff70fb4b6bf115ca4fa5e376a7c99960f690a96d71caa2d06f2db505979c529ba8072353c62c5902cae283ba0b313"} 12:29:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:29:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:29:52 INFO - Contents: 12:29:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/619d02e42c79ed4770c420d289c3611856072bf65e5e4e2154a6b6b464b69c186445641c9a756007aa51318e45ead8eb42dbe4cd45b25e3f50baee1ea3fa4af7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/abaa39fb6c68a32c064ead80201775125f39cca7fbe124a998c815c4ac562e0c1e74b176ff5f309c49c2cd4b5f824f97038441953e711abd05ae5c693fde5eae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1d7321654ddb3dc76444f027deb0ebe3218a1d3dbf4b958f3b7d679ef0fb8113cae875ed24bfd528e360dd2ec34189fb9717715cd4f6ae06c92b14cec060738a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d86248a3d7ffa00b07ecf9b6716c30dcc36ff70fb4b6bf115ca4fa5e376a7c99960f690a96d71caa2d06f2db505979c529ba8072353c62c5902cae283ba0b313"} 12:29:52 INFO - Running post-run listener: copy_logs_to_upload_dir 12:29:52 INFO - Copying logs to upload dir... 12:29:52 INFO - mkdir: /builds/slave/test/build/upload/logs 12:29:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.731768 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-12-21 12:29:52.967737) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 12:29:52.971254) ========= 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.wTvCMElAkW/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.19bGU1TyIP/Listeners TMPDIR=/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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/619d02e42c79ed4770c420d289c3611856072bf65e5e4e2154a6b6b464b69c186445641c9a756007aa51318e45ead8eb42dbe4cd45b25e3f50baee1ea3fa4af7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/abaa39fb6c68a32c064ead80201775125f39cca7fbe124a998c815c4ac562e0c1e74b176ff5f309c49c2cd4b5f824f97038441953e711abd05ae5c693fde5eae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1d7321654ddb3dc76444f027deb0ebe3218a1d3dbf4b958f3b7d679ef0fb8113cae875ed24bfd528e360dd2ec34189fb9717715cd4f6ae06c92b14cec060738a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d86248a3d7ffa00b07ecf9b6716c30dcc36ff70fb4b6bf115ca4fa5e376a7c99960f690a96d71caa2d06f2db505979c529ba8072353c62c5902cae283ba0b313"} build_url:https://queue.taskcluster.net/v1/task/bU7UfBx0Ra2yQrxHXJZc-Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010742 build_url: 'https://queue.taskcluster.net/v1/task/bU7UfBx0Ra2yQrxHXJZc-Q/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/619d02e42c79ed4770c420d289c3611856072bf65e5e4e2154a6b6b464b69c186445641c9a756007aa51318e45ead8eb42dbe4cd45b25e3f50baee1ea3fa4af7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/abaa39fb6c68a32c064ead80201775125f39cca7fbe124a998c815c4ac562e0c1e74b176ff5f309c49c2cd4b5f824f97038441953e711abd05ae5c693fde5eae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1d7321654ddb3dc76444f027deb0ebe3218a1d3dbf4b958f3b7d679ef0fb8113cae875ed24bfd528e360dd2ec34189fb9717715cd4f6ae06c92b14cec060738a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d86248a3d7ffa00b07ecf9b6716c30dcc36ff70fb4b6bf115ca4fa5e376a7c99960f690a96d71caa2d06f2db505979c529ba8072353c62c5902cae283ba0b313"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 12:29:53.005019) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 12:29:53.005358) ========= 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.wTvCMElAkW/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.19bGU1TyIP/Listeners TMPDIR=/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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.005254 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 12:29:53.053710) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 12:29:53.054040) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 12:29:53.054405) ========= ========= Total master_lag: 0.17 =========