builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0353 starttime: 1484241040.52 results: success (0) buildid: 20170112063609 builduid: 1a067bb928044afdbb5e6828c8070361 revision: 0be9aa8742dcdae97b0d594c7d5f5b517dc5107a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 09:10:40.515786) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 09:10:40.516257) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 09:10:40.516532) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 09:10:40.543593) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 09:10:40.544031) ========= 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.2fC5bEcT8X/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.6gSGASo5TN/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-12 09:10:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 140M=0s 2017-01-12 09:10:40 (140 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122252 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 09:10:40.690229) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 09:10:40.690541) ========= 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.2fC5bEcT8X/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.6gSGASo5TN/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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.026478 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 09:10:40.739296) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-12 09:10:40.739647) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 0be9aa8742dcdae97b0d594c7d5f5b517dc5107a --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 0be9aa8742dcdae97b0d594c7d5f5b517dc5107a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2fC5bEcT8X/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.6gSGASo5TN/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-12 09:10:40,840 truncating revision to first 12 chars 2017-01-12 09:10:40,840 Setting DEBUG logging. 2017-01-12 09:10:40,840 attempt 1/10 2017-01-12 09:10:40,840 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/0be9aa8742dc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-12 09:10:41,886 unpacking tar archive at: graphics-0be9aa8742dc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.334977 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-12 09:10:42.098203) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 09:10:42.098527) ========= script_repo_revision: 0be9aa8742dcdae97b0d594c7d5f5b517dc5107a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 09:10:42.098920) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 09:10:42.099184) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 09:10:42.119074) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-12 09:10:42.119480) ========= /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.2fC5bEcT8X/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.6gSGASo5TN/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 09:10:42 INFO - MultiFileLogger online at 20170112 09:10:42 in /builds/slave/test 09:10:42 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 09:10:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:10:42 INFO - {'append_to_log': False, 09:10:42 INFO - 'base_work_dir': '/builds/slave/test', 09:10:42 INFO - 'blob_upload_branch': 'Graphics', 09:10:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:10:42 INFO - 'branch': 'Graphics', 09:10:42 INFO - 'buildbot_json_path': 'buildprops.json', 09:10:42 INFO - 'config_files': ('talos/mac_config.py',), 09:10:42 INFO - 'default_actions': ('clobber', 09:10:42 INFO - 'read-buildbot-config', 09:10:42 INFO - 'download-and-extract', 09:10:42 INFO - 'populate-webroot', 09:10:42 INFO - 'create-virtualenv', 09:10:42 INFO - 'install', 09:10:42 INFO - 'run-tests'), 09:10:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:10:42 INFO - 'download_minidump_stackwalk': True, 09:10:42 INFO - 'download_symbols': 'ondemand', 09:10:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:10:42 INFO - 'tooltool.py': '/tools/tooltool.py', 09:10:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:10:42 INFO - '/tools/misc-python/virtualenv.py')}, 09:10:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:10:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:10:42 INFO - 'installer_path': 'installer.exe', 09:10:42 INFO - 'log_level': 'info', 09:10:42 INFO - 'log_name': 'talos', 09:10:42 INFO - 'log_to_console': True, 09:10:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:10:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:10:42 INFO - 'opt_config_files': (), 09:10:42 INFO - 'pip_index': False, 09:10:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:10:42 INFO - 'cmd': ('bash', 09:10:42 INFO - '-c', 09:10:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:10:42 INFO - 'enabled': True, 09:10:42 INFO - 'halt_on_failure': False, 09:10:42 INFO - 'name': 'check_screen_resolution'},), 09:10:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:10:42 INFO - 'cmd': ('bash', 09:10:42 INFO - '-c', 09:10:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:10:42 INFO - 'enabled': True, 09:10:42 INFO - 'halt_on_failure': False, 09:10:42 INFO - 'name': 'check_screen_resolution'},), 09:10:42 INFO - 'run_cmd_checks_enabled': True, 09:10:42 INFO - 'sps_profile': False, 09:10:42 INFO - 'sps_profile_interval': 0, 09:10:42 INFO - 'suite': 'dromaeojs', 09:10:42 INFO - 'system_bits': '32', 09:10:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:10:42 INFO - 'title': 't-yosemite-r7-0353', 09:10:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:10:42 INFO - 'use_talos_json': True, 09:10:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:10:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:10:42 INFO - 'work_dir': 'build'} 09:10:42 INFO - [mozharness: 2017-01-12 17:10:42.327049Z] Running clobber step. 09:10:42 INFO - Running pre-action listener: _resource_record_pre_action 09:10:42 INFO - Running main action method: clobber 09:10:42 INFO - rmtree: /builds/slave/test/build 09:10:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:10:44 INFO - Running post-action listener: _resource_record_post_action 09:10:44 INFO - [mozharness: 2017-01-12 17:10:44.396009Z] Finished clobber step (success) 09:10:44 INFO - [mozharness: 2017-01-12 17:10:44.396234Z] Running read-buildbot-config step. 09:10:44 INFO - Running pre-action listener: _resource_record_pre_action 09:10:44 INFO - Running main action method: read_buildbot_config 09:10:44 INFO - Using buildbot properties: 09:10:44 INFO - { 09:10:44 INFO - "project": "", 09:10:44 INFO - "product": "firefox", 09:10:44 INFO - "script_repo_revision": "default", 09:10:44 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 09:10:44 INFO - "repository": "", 09:10:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 09:10:44 INFO - "buildid": "20170112063609", 09:10:44 INFO - "pgo_build": "False", 09:10:44 INFO - "basedir": "/builds/slave/test", 09:10:44 INFO - "buildnumber": 24, 09:10:44 INFO - "slavename": "t-yosemite-r7-0353", 09:10:44 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:10:44 INFO - "platform": "yosemite_r7", 09:10:44 INFO - "scheduler": "tests-graphics-macosx64-talos", 09:10:44 INFO - "branch": "graphics", 09:10:44 INFO - "repo_path": "projects/graphics", 09:10:44 INFO - "revision": "0be9aa8742dcdae97b0d594c7d5f5b517dc5107a", 09:10:44 INFO - "stage_platform": "macosx64", 09:10:44 INFO - "builduid": "1a067bb928044afdbb5e6828c8070361", 09:10:44 INFO - "slavebuilddir": "test" 09:10:44 INFO - } 09:10:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vjy2c9c5TKWZBMI0GYtXLg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 09:10:44 INFO - Running post-action listener: _resource_record_post_action 09:10:44 INFO - [mozharness: 2017-01-12 17:10:44.399894Z] Finished read-buildbot-config step (success) 09:10:44 INFO - [mozharness: 2017-01-12 17:10:44.400002Z] Running download-and-extract step. 09:10:44 INFO - Running pre-action listener: _resource_record_pre_action 09:10:44 INFO - Running main action method: download_and_extract 09:10:44 INFO - mkdir: /builds/slave/test/build/tests 09:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:10:44 INFO - trying https://queue.taskcluster.net/v1/task/Vjy2c9c5TKWZBMI0GYtXLg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 09:10:44 INFO - Downloading https://queue.taskcluster.net/v1/task/Vjy2c9c5TKWZBMI0GYtXLg/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 09:10:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vjy2c9c5TKWZBMI0GYtXLg/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 09:10:45 INFO - Downloaded 1199 bytes. 09:10:45 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 09:10:45 INFO - Using the following test package requirements: 09:10:45 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 09:10:45 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:10:45 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 09:10:45 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:10:45 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 09:10:45 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:10:45 INFO - u'jsshell-mac.zip'], 09:10:45 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:10:45 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 09:10:45 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 09:10:45 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:10:45 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 09:10:45 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:10:45 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 09:10:45 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:10:45 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 09:10:45 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:10:45 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 09:10:45 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:10:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vjy2c9c5TKWZBMI0GYtXLg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 09:10:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vjy2c9c5TKWZBMI0GYtXLg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:10:45 INFO - Fetch https://queue.taskcluster.net/v1/task/Vjy2c9c5TKWZBMI0GYtXLg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 09:10:46 INFO - Expected file size: 16311451 09:10:46 INFO - Obtained file size: 16311451 09:10:53 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 09:10:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vjy2c9c5TKWZBMI0GYtXLg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 09:10:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vjy2c9c5TKWZBMI0GYtXLg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:10:53 INFO - Fetch https://queue.taskcluster.net/v1/task/Vjy2c9c5TKWZBMI0GYtXLg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 09:10:54 INFO - Expected file size: 16311451 09:10:54 INFO - Obtained file size: 16311451 09:11:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vjy2c9c5TKWZBMI0GYtXLg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 09:11:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vjy2c9c5TKWZBMI0GYtXLg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:11:00 INFO - Fetch https://queue.taskcluster.net/v1/task/Vjy2c9c5TKWZBMI0GYtXLg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 09:11:01 INFO - Expected file size: 14403529 09:11:01 INFO - Obtained file size: 14403529 09:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:01 INFO - trying https://queue.taskcluster.net/v1/task/Vjy2c9c5TKWZBMI0GYtXLg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:11:01 INFO - Downloading https://queue.taskcluster.net/v1/task/Vjy2c9c5TKWZBMI0GYtXLg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 09:11:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vjy2c9c5TKWZBMI0GYtXLg/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 09:11:03 INFO - Downloaded 69923695 bytes. 09:11:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vjy2c9c5TKWZBMI0GYtXLg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:11:03 INFO - mkdir: /builds/slave/test/properties 09:11:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:11:03 INFO - Writing to file /builds/slave/test/properties/build_url 09:11:03 INFO - Contents: 09:11:03 INFO - build_url:https://queue.taskcluster.net/v1/task/Vjy2c9c5TKWZBMI0GYtXLg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:11:04 INFO - Running post-action listener: _resource_record_post_action 09:11:04 INFO - Running post-action listener: set_extra_try_arguments 09:11:04 INFO - [mozharness: 2017-01-12 17:11:04.247391Z] Finished download-and-extract step (success) 09:11:04 INFO - [mozharness: 2017-01-12 17:11:04.247538Z] Running populate-webroot step. 09:11:04 INFO - Running pre-action listener: _resource_record_pre_action 09:11:04 INFO - Running main action method: populate_webroot 09:11:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:11:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:11:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:11:04 INFO - '--tppagecycles', 09:11:04 INFO - '7'], 09:11:04 INFO - 'tests': ['tsvgm']}}, 09:11:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:11:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:11:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:11:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:11:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:11:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:11:04 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:11:04 INFO - 'talos_options': ['--disable-e10s'], 09:11:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:11:04 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:11:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:11:04 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:11:04 INFO - 'talos_options': ['--disable-e10s'], 09:11:04 INFO - 'tests': ['damp', 'tps']}, 09:11:04 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:11:04 INFO - 'tests': ['damp', 'tps']}, 09:11:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:11:04 INFO - 'tests': ['dromaeo_dom']}, 09:11:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:11:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:11:04 INFO - 'tests': ['basic_compositor_video']}, 09:11:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:11:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:11:04 INFO - 'tests': ['a11yr', 09:11:04 INFO - 'ts_paint', 09:11:04 INFO - 'tpaint', 09:11:04 INFO - 'sessionrestore', 09:11:04 INFO - 'sessionrestore_no_auto_restore', 09:11:04 INFO - 'tabpaint']}, 09:11:04 INFO - 'other-e10s': {'tests': ['a11yr', 09:11:04 INFO - 'ts_paint', 09:11:04 INFO - 'tpaint', 09:11:04 INFO - 'sessionrestore', 09:11:04 INFO - 'sessionrestore_no_auto_restore', 09:11:04 INFO - 'tabpaint']}, 09:11:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:11:04 INFO - 'ts_paint', 09:11:04 INFO - 'tpaint', 09:11:04 INFO - 'sessionrestore', 09:11:04 INFO - 'sessionrestore_no_auto_restore', 09:11:04 INFO - 'tabpaint']}, 09:11:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:11:04 INFO - 'ts_paint', 09:11:04 INFO - 'tpaint', 09:11:04 INFO - 'sessionrestore', 09:11:04 INFO - 'sessionrestore_no_auto_restore', 09:11:04 INFO - 'tabpaint']}, 09:11:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:11:04 INFO - 'tests': ['a11yr', 09:11:04 INFO - 'ts_paint', 09:11:04 INFO - 'tpaint', 09:11:04 INFO - 'sessionrestore', 09:11:04 INFO - 'sessionrestore_no_auto_restore', 09:11:04 INFO - 'tabpaint']}, 09:11:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:11:04 INFO - 'tests': ['a11yr', 09:11:04 INFO - 'ts_paint', 09:11:04 INFO - 'tpaint', 09:11:04 INFO - 'sessionrestore', 09:11:04 INFO - 'sessionrestore_no_auto_restore', 09:11:04 INFO - 'tabpaint']}, 09:11:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:11:04 INFO - 'tests': ['tsvgx', 09:11:04 INFO - 'tsvgr_opacity', 09:11:04 INFO - 'tart', 09:11:04 INFO - 'tscrollx', 09:11:04 INFO - 'cart', 09:11:04 INFO - 'tsvg_static']}, 09:11:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:11:04 INFO - 'tsvgr_opacity', 09:11:04 INFO - 'tart', 09:11:04 INFO - 'tscrollx', 09:11:04 INFO - 'cart', 09:11:04 INFO - 'tsvg_static']}, 09:11:04 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:11:04 INFO - 'talos_options': ['--disable-e10s'], 09:11:04 INFO - 'tests': ['tp5o']}, 09:11:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:11:04 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:11:04 INFO - 'talos_options': ['--disable-e10s', 09:11:04 INFO - '--xperf_path', 09:11:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:11:04 INFO - 'tests': ['tp5n']}, 09:11:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:11:04 INFO - 'talos_options': ['--xperf_path', 09:11:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:11:04 INFO - 'tests': ['tp5n']}}, 09:11:04 INFO - 'talos.zip': {'path': '', 09:11:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:11:04 INFO - Running post-action listener: _resource_record_post_action 09:11:04 INFO - [mozharness: 2017-01-12 17:11:04.265763Z] Finished populate-webroot step (success) 09:11:04 INFO - [mozharness: 2017-01-12 17:11:04.265874Z] Running create-virtualenv step. 09:11:04 INFO - Running pre-action listener: _resource_record_pre_action 09:11:04 INFO - Running main action method: create_virtualenv 09:11:04 INFO - Creating virtualenv /builds/slave/test/build/venv 09:11:04 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 09:11:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:11:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:11:04 INFO - Using real prefix '/tools/python27' 09:11:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:11:05 INFO - Installing distribute.............................................................................................................................................................................................done. 09:11:08 INFO - Installing pip.................done. 09:11:08 INFO - Return code: 0 09:11:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:11:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:11:08 INFO - Reading from file tmpfile_stdout 09:11:08 INFO - Output received: 09:11:08 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) 09:11:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:11:08 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')]} 09:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:08 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')]} 09:11:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:08 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 0x10a62fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a632768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5a3d98700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a40dd30>, '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 0x10a334db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a402be8>, '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.2fC5bEcT8X/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.6gSGASo5TN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 09:11:08 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 09:11:08 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 09:11:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2fC5bEcT8X/Render', 09:11:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:11:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:11:08 INFO - 'HOME': '/Users/cltbld', 09:11:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:11:08 INFO - 'LOGNAME': 'cltbld', 09:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:08 INFO - 'MOZ_NO_REMOTE': '1', 09:11:08 INFO - 'NO_EM_RESTART': '1', 09:11:08 INFO - 'PAGER': '/bin/cat', 09:11:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:08 INFO - 'PWD': '/builds/slave/test', 09:11:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:11:08 INFO - 'SHELL': '/bin/bash', 09:11:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gSGASo5TN/Listeners', 09:11:08 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 09:11:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:11:08 INFO - 'USER': 'cltbld', 09:11:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:11:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:08 INFO - 'XPC_FLAGS': '0x0', 09:11:08 INFO - 'XPC_SERVICE_NAME': '0', 09:11:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:11:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:08 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 09:11:08 INFO - Cleaning up... 09:11:08 INFO - Return code: 0 09:11:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:11:08 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')]} 09:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:08 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')]} 09:11:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:08 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 0x10a62fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a632768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5a3d98700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a40dd30>, '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 0x10a334db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a402be8>, '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.2fC5bEcT8X/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.6gSGASo5TN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 09:11:08 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 09:11:08 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 09:11:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2fC5bEcT8X/Render', 09:11:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:11:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:11:08 INFO - 'HOME': '/Users/cltbld', 09:11:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:11:08 INFO - 'LOGNAME': 'cltbld', 09:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:08 INFO - 'MOZ_NO_REMOTE': '1', 09:11:08 INFO - 'NO_EM_RESTART': '1', 09:11:08 INFO - 'PAGER': '/bin/cat', 09:11:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:08 INFO - 'PWD': '/builds/slave/test', 09:11:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:11:08 INFO - 'SHELL': '/bin/bash', 09:11:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gSGASo5TN/Listeners', 09:11:08 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 09:11:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:11:08 INFO - 'USER': 'cltbld', 09:11:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:11:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:08 INFO - 'XPC_FLAGS': '0x0', 09:11:08 INFO - 'XPC_SERVICE_NAME': '0', 09:11:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:11:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:08 INFO - Downloading/unpacking psutil>=3.1.1 09:11:08 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 09:11:08 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 09:11:08 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 09:11:08 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 09:11:08 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 09:11:08 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 09:11:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:11:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:11:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:11:12 INFO - Installing collected packages: psutil 09:11:12 INFO - Running setup.py install for psutil 09:11:12 INFO - building 'psutil._psutil_osx' extension 09:11:12 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 09:11:13 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 09:11:13 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 09:11:13 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 09:11:13 INFO - building 'psutil._psutil_posix' extension 09:11:13 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 09:11:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:11:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:11:13 INFO - ^ 09:11:13 INFO - 1 warning generated. 09:11:13 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 09:11:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:11:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:11:13 INFO - Successfully installed psutil 09:11:13 INFO - Cleaning up... 09:11:13 INFO - Return code: 0 09:11:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:11:13 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')]} 09:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:13 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')]} 09:11:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:13 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 0x10a62fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a632768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5a3d98700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a40dd30>, '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 0x10a334db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a402be8>, '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.2fC5bEcT8X/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.6gSGASo5TN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 09:11:13 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 09:11:13 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 09:11:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2fC5bEcT8X/Render', 09:11:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:11:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:11:13 INFO - 'HOME': '/Users/cltbld', 09:11:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:11:13 INFO - 'LOGNAME': 'cltbld', 09:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:13 INFO - 'MOZ_NO_REMOTE': '1', 09:11:13 INFO - 'NO_EM_RESTART': '1', 09:11:13 INFO - 'PAGER': '/bin/cat', 09:11:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:13 INFO - 'PWD': '/builds/slave/test', 09:11:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:11:13 INFO - 'SHELL': '/bin/bash', 09:11:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gSGASo5TN/Listeners', 09:11:13 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 09:11:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:11:13 INFO - 'USER': 'cltbld', 09:11:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:11:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:13 INFO - 'XPC_FLAGS': '0x0', 09:11:13 INFO - 'XPC_SERVICE_NAME': '0', 09:11:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:11:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:11:13 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 09:11:13 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 09:11:13 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 09:11:13 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 09:11:13 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 09:11:13 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 09:11:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:11:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:11:16 INFO - Installing collected packages: mozsystemmonitor 09:11:16 INFO - Running setup.py install for mozsystemmonitor 09:11:16 INFO - Successfully installed mozsystemmonitor 09:11:16 INFO - Cleaning up... 09:11:16 INFO - Return code: 0 09:11:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:11:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:16 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 0x10a62fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a632768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5a3d98700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a40dd30>, '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 0x10a334db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a402be8>, '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.2fC5bEcT8X/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.6gSGASo5TN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 09:11:16 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 09:11:16 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 09:11:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2fC5bEcT8X/Render', 09:11:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:11:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:11:16 INFO - 'HOME': '/Users/cltbld', 09:11:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:11:16 INFO - 'LOGNAME': 'cltbld', 09:11:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:16 INFO - 'MOZ_NO_REMOTE': '1', 09:11:16 INFO - 'NO_EM_RESTART': '1', 09:11:16 INFO - 'PAGER': '/bin/cat', 09:11:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:11:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:16 INFO - 'PWD': '/builds/slave/test', 09:11:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:11:16 INFO - 'SHELL': '/bin/bash', 09:11:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gSGASo5TN/Listeners', 09:11:16 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 09:11:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:11:16 INFO - 'USER': 'cltbld', 09:11:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:11:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:11:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:16 INFO - 'XPC_FLAGS': '0x0', 09:11:16 INFO - 'XPC_SERVICE_NAME': '0', 09:11:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:11:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:17 INFO - Downloading/unpacking jsonschema==2.5.1 09:11: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 09:11: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 09:11: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 09:11: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 09:11: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 09:11: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 09:11:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:11:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:11:19 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 09:11:19 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 09:11:19 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 09:11:19 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 09:11:19 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 09:11:19 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 09:11:20 INFO - Downloading functools32-3.2.3-2.tar.gz 09:11:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:11:20 INFO - warning: no files found matching '*.txt' 09:11:20 INFO - no previously-included directories found matching 'build' 09:11:20 INFO - no previously-included directories found matching 'dist' 09:11:20 INFO - no previously-included directories found matching '.git*' 09:11:20 INFO - Installing collected packages: jsonschema, functools32 09:11:20 INFO - Running setup.py install for functools32 09:11:20 INFO - warning: no files found matching '*.txt' 09:11:20 INFO - no previously-included directories found matching 'build' 09:11:20 INFO - no previously-included directories found matching 'dist' 09:11:20 INFO - no previously-included directories found matching '.git*' 09:11:20 INFO - Successfully installed jsonschema functools32 09:11:20 INFO - Cleaning up... 09:11:20 INFO - Return code: 0 09:11:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:11: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')]} 09:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11: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')]} 09:11:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11: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', '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 0x10a62fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a632768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5a3d98700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a40dd30>, '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 0x10a334db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a402be8>, '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.2fC5bEcT8X/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.6gSGASo5TN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 09:11: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:11: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 functools32==3.2.3-2 09:11:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2fC5bEcT8X/Render', 09:11:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:11:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:11:20 INFO - 'HOME': '/Users/cltbld', 09:11:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:11:20 INFO - 'LOGNAME': 'cltbld', 09:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:20 INFO - 'MOZ_NO_REMOTE': '1', 09:11:20 INFO - 'NO_EM_RESTART': '1', 09:11:20 INFO - 'PAGER': '/bin/cat', 09:11:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:20 INFO - 'PWD': '/builds/slave/test', 09:11:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:11:20 INFO - 'SHELL': '/bin/bash', 09:11:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gSGASo5TN/Listeners', 09:11:20 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 09:11:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:11:20 INFO - 'USER': 'cltbld', 09:11:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:11:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:20 INFO - 'XPC_FLAGS': '0x0', 09:11:20 INFO - 'XPC_SERVICE_NAME': '0', 09:11:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:11:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:11:20 INFO - Cleaning up... 09:11:20 INFO - Return code: 0 09:11:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:11: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')]} 09:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11: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')]} 09:11:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11: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', '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 0x10a62fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a632768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5a3d98700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a40dd30>, '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 0x10a334db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a402be8>, '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.2fC5bEcT8X/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.6gSGASo5TN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 09:11: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:11: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 blobuploader==1.2.4 09:11:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2fC5bEcT8X/Render', 09:11:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:11:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:11:20 INFO - 'HOME': '/Users/cltbld', 09:11:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:11:20 INFO - 'LOGNAME': 'cltbld', 09:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:20 INFO - 'MOZ_NO_REMOTE': '1', 09:11:20 INFO - 'NO_EM_RESTART': '1', 09:11:20 INFO - 'PAGER': '/bin/cat', 09:11:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:20 INFO - 'PWD': '/builds/slave/test', 09:11:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:11:20 INFO - 'SHELL': '/bin/bash', 09:11:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gSGASo5TN/Listeners', 09:11:20 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 09:11:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:11:20 INFO - 'USER': 'cltbld', 09:11:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:11:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:20 INFO - 'XPC_FLAGS': '0x0', 09:11:20 INFO - 'XPC_SERVICE_NAME': '0', 09:11:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:11:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:20 INFO - Downloading/unpacking blobuploader==1.2.4 09:11: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 09:11: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 09:11: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 09:11: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 09:11: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 09:11: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 09:11:23 INFO - Downloading blobuploader-1.2.4.tar.gz 09:11:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:11:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:11: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 09:11: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 09:11: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 09:11: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 09:11: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 09:11: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 09:11:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:11:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:11: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 09:11: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 09:11: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 09:11: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 09:11: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 09:11: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 09:11:24 INFO - Downloading docopt-0.6.1.tar.gz 09:11:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:11:24 INFO - Installing collected packages: blobuploader, requests, docopt 09:11:24 INFO - Running setup.py install for blobuploader 09:11:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:11:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:11:25 INFO - Running setup.py install for requests 09:11:25 INFO - Running setup.py install for docopt 09:11:25 INFO - Successfully installed blobuploader requests docopt 09:11:25 INFO - Cleaning up... 09:11:25 INFO - Return code: 0 09:11:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:25 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 0x10a62fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a632768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5a3d98700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a40dd30>, '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 0x10a334db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a402be8>, '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.2fC5bEcT8X/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.6gSGASo5TN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 09:11:25 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 09:11:25 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 09:11:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2fC5bEcT8X/Render', 09:11:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:11:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:11:25 INFO - 'HOME': '/Users/cltbld', 09:11:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:11:25 INFO - 'LOGNAME': 'cltbld', 09:11:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:25 INFO - 'MOZ_NO_REMOTE': '1', 09:11:25 INFO - 'NO_EM_RESTART': '1', 09:11:25 INFO - 'PAGER': '/bin/cat', 09:11:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:11:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:25 INFO - 'PWD': '/builds/slave/test', 09:11:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:11:25 INFO - 'SHELL': '/bin/bash', 09:11:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gSGASo5TN/Listeners', 09:11:25 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 09:11:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:11:25 INFO - 'USER': 'cltbld', 09:11:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:11:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:11:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:25 INFO - 'XPC_FLAGS': '0x0', 09:11:25 INFO - 'XPC_SERVICE_NAME': '0', 09:11:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:11:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:11:26 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-QwRYSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:11:26 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-8g4QAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:11:26 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-lxUOrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:11:26 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-pTDMTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:11:26 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-abO2T2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:11:26 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-0k7VYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:11:26 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-2qGIe7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:11:26 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-2CvzHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:11:26 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-r41sua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:11:26 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-1MfPka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:11:27 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-Tgc0qc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:11:27 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-gU3gMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:11:27 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-ShLuR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:11:27 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-yRM8m6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:27 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-ocaAEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:11:27 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-1tsfre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:11:27 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-5StzLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:11:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:11:27 INFO - Running setup.py install for manifestparser 09:11:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:11:27 INFO - Running setup.py install for mozcrash 09:11:28 INFO - Running setup.py install for mozdebug 09:11:28 INFO - Running setup.py install for mozdevice 09:11:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:11:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:11:28 INFO - Running setup.py install for mozfile 09:11:28 INFO - Running setup.py install for mozhttpd 09:11:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:11:28 INFO - Running setup.py install for mozinfo 09:11:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:11:28 INFO - Running setup.py install for mozInstall 09:11:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:11:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:11:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:11:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:11:28 INFO - Running setup.py install for mozleak 09:11:29 INFO - Running setup.py install for mozlog 09:11:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:11:29 INFO - Running setup.py install for moznetwork 09:11:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:11:29 INFO - Running setup.py install for mozprocess 09:11:29 INFO - Running setup.py install for mozprofile 09:11:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:11:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:11:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:11:29 INFO - Running setup.py install for mozrunner 09:11:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:11:29 INFO - Running setup.py install for mozscreenshot 09:11:30 INFO - Running setup.py install for moztest 09:11:30 INFO - Running setup.py install for mozversion 09:11:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:11:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:11:30 INFO - Cleaning up... 09:11:30 INFO - Return code: 0 09:11:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:11:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:30 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 0x10a62fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a632768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5a3d98700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a40dd30>, '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 0x10a334db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a402be8>, '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.2fC5bEcT8X/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.6gSGASo5TN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 09:11:30 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 09:11:30 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 09:11:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2fC5bEcT8X/Render', 09:11:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:11:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:11:30 INFO - 'HOME': '/Users/cltbld', 09:11:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:11:30 INFO - 'LOGNAME': 'cltbld', 09:11:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:30 INFO - 'MOZ_NO_REMOTE': '1', 09:11:30 INFO - 'NO_EM_RESTART': '1', 09:11:30 INFO - 'PAGER': '/bin/cat', 09:11:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:11:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:30 INFO - 'PWD': '/builds/slave/test', 09:11:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:11:30 INFO - 'SHELL': '/bin/bash', 09:11:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gSGASo5TN/Listeners', 09:11:30 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 09:11:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:11:30 INFO - 'USER': 'cltbld', 09:11:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:11:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:11:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:30 INFO - 'XPC_FLAGS': '0x0', 09:11:30 INFO - 'XPC_SERVICE_NAME': '0', 09:11:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:11:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:11:30 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-dvFpzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:11:30 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)) 09:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:11:30 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-dKTg0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:11:30 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)) 09:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:11:30 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-I5ku4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:11:30 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)) 09:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:11:30 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-YKHnQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:11:31 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)) 09:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:11:31 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-aVbJ8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:11:31 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)) 09:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:11:31 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-79RKZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:11:31 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)) 09:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:11:31 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-F7jBDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:11:31 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)) 09:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:11:31 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-ovFYHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:11:31 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)) 09:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:11:31 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-3nCxNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:11:31 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)) 09:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:11:31 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-3pO9Ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:11:31 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)) 09:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:11:31 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-j7hnoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:11:31 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)) 09:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:11:31 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-a2NO0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:11:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:11:31 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-7uCdww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:11:31 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)) 09:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:11:31 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-3_o5Qc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:11:32 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)) 09:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:32 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-wr5Lur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:32 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)) 09:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:11:32 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-C_d2mE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:11:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:11:32 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-IbYUcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:11:32 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)) 09:11:32 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)) 09:11:32 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)) 09:11:32 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)) 09:11:32 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)) 09:11:32 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)) 09:11:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:34 INFO - Downloading blessings-1.6.tar.gz 09:11:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:11:35 INFO - Installing collected packages: blessings 09:11:35 INFO - Running setup.py install for blessings 09:11:35 INFO - Successfully installed blessings 09:11:35 INFO - Cleaning up... 09:11:35 INFO - Return code: 0 09:11:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:11:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:11:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:11:35 INFO - Reading from file tmpfile_stdout 09:11:35 INFO - Current package versions: 09:11:35 INFO - blessings == 1.6 09:11:35 INFO - blobuploader == 1.2.4 09:11:35 INFO - docopt == 0.6.1 09:11:35 INFO - functools32 == 3.2.3-2 09:11:35 INFO - jsonschema == 2.5.1 09:11:35 INFO - manifestparser == 1.1 09:11:35 INFO - mozInstall == 1.12 09:11:35 INFO - mozcrash == 1.0 09:11:35 INFO - mozdebug == 0.1 09:11:35 INFO - mozdevice == 0.49 09:11:35 INFO - mozfile == 1.2 09:11:35 INFO - mozhttpd == 0.7 09:11:35 INFO - mozinfo == 0.9 09:11:35 INFO - mozleak == 0.1 09:11:35 INFO - mozlog == 3.4 09:11:35 INFO - moznetwork == 0.27 09:11:35 INFO - mozprocess == 0.24 09:11:35 INFO - mozprofile == 0.28 09:11:35 INFO - mozrunner == 6.13 09:11:35 INFO - mozscreenshot == 0.1 09:11:35 INFO - mozsystemmonitor == 0.3 09:11:35 INFO - moztest == 0.8 09:11:35 INFO - mozversion == 1.4 09:11:35 INFO - psutil == 3.1.1 09:11:35 INFO - requests == 1.2.3 09:11:35 INFO - wsgiref == 0.1.2 09:11:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:11:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:35 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 0x10a62fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a632768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5a3d98700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a40dd30>, '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 0x10a334db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a402be8>, '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.2fC5bEcT8X/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.6gSGASo5TN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 09:11:35 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 09:11:35 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 09:11:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2fC5bEcT8X/Render', 09:11:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:11:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:11:35 INFO - 'HOME': '/Users/cltbld', 09:11:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:11:35 INFO - 'LOGNAME': 'cltbld', 09:11:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:35 INFO - 'MOZ_NO_REMOTE': '1', 09:11:35 INFO - 'NO_EM_RESTART': '1', 09:11:35 INFO - 'PAGER': '/bin/cat', 09:11:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:11:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:35 INFO - 'PWD': '/builds/slave/test', 09:11:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:11:35 INFO - 'SHELL': '/bin/bash', 09:11:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gSGASo5TN/Listeners', 09:11:35 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 09:11:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:11:35 INFO - 'USER': 'cltbld', 09:11:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:11:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:11:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:35 INFO - 'XPC_FLAGS': '0x0', 09:11:35 INFO - 'XPC_SERVICE_NAME': '0', 09:11:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:11:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:35 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)) 09:11:35 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)) 09:11:35 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)) 09:11:35 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)) 09:11:35 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)) 09:11:35 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)) 09:11:35 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)) 09:11:35 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)) 09:11:35 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)) 09:11:35 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)) 09:11:35 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)) 09:11:35 INFO - Cleaning up... 09:11:35 INFO - Return code: 0 09:11:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:11:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:11:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a62fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a632768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5a3d98700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a40dd30>, '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 0x10a334db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a402be8>, '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.2fC5bEcT8X/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.6gSGASo5TN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 09:11:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:11:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:11:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2fC5bEcT8X/Render', 09:11:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:11:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:11:35 INFO - 'HOME': '/Users/cltbld', 09:11:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:11:35 INFO - 'LOGNAME': 'cltbld', 09:11:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:35 INFO - 'MOZ_NO_REMOTE': '1', 09:11:35 INFO - 'NO_EM_RESTART': '1', 09:11:35 INFO - 'PAGER': '/bin/cat', 09:11:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:11:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:35 INFO - 'PWD': '/builds/slave/test', 09:11:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:11:35 INFO - 'SHELL': '/bin/bash', 09:11:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gSGASo5TN/Listeners', 09:11:35 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 09:11:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:11:35 INFO - 'USER': 'cltbld', 09:11:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:11:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:11:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:35 INFO - 'XPC_FLAGS': '0x0', 09:11:35 INFO - 'XPC_SERVICE_NAME': '0', 09:11:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:11:36 INFO - Cleaning up... 09:11:36 INFO - Return code: 0 09:11:36 INFO - Running post-action listener: _resource_record_post_action 09:11:36 INFO - Running post-action listener: _start_resource_monitoring 09:11:36 INFO - Starting resource monitoring. 09:11:36 INFO - [mozharness: 2017-01-12 17:11:36.161176Z] Finished create-virtualenv step (success) 09:11:36 INFO - [mozharness: 2017-01-12 17:11:36.162144Z] Running install step. 09:11:36 INFO - Running pre-action listener: _resource_record_pre_action 09:11:36 INFO - Running main action method: install 09:11:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:11:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:11:36 INFO - Reading from file tmpfile_stdout 09:11:36 INFO - Detecting whether we're running mozinstall >=1.0... 09:11:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:11:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:11:36 INFO - Reading from file tmpfile_stdout 09:11:36 INFO - Output received: 09:11:36 INFO - Usage: mozinstall [options] installer 09:11:36 INFO - Options: 09:11:36 INFO - -h, --help show this help message and exit 09:11:36 INFO - -d DEST, --destination=DEST 09:11:36 INFO - Directory to install application into. [default: 09:11:36 INFO - "/builds/slave/test"] 09:11:36 INFO - --app=APP Application being installed. [default: firefox] 09:11:36 INFO - mkdir: /builds/slave/test/build/application 09:11:36 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'] 09:11:36 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 09:11:58 INFO - Reading from file tmpfile_stdout 09:11:58 INFO - Output received: 09:11:58 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:11:58 INFO - Running post-action listener: _resource_record_post_action 09:11:58 INFO - [mozharness: 2017-01-12 17:11:58.329924Z] Finished install step (success) 09:11:58 INFO - [mozharness: 2017-01-12 17:11:58.330033Z] Running run-tests step. 09:11:58 INFO - Running pre-action listener: _resource_record_pre_action 09:11:58 INFO - Running main action method: run_tests 09:11:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:11:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:11:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:11:58 INFO - 2017-01-12 09:11:58.344 screenresolution[1626:7491] starting screenresolution argv=screenresolution get 09:11:58 INFO - 2017-01-12 09:11:58.346 screenresolution[1626:7491] Display 0: 1600x1200x32@60 09:11:58 INFO - 2017-01-12 09:11:58.352 screenresolution[1627:7493] starting screenresolution argv=screenresolution list 09:11:58 INFO - Available Modes on Display 0 09:11:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:11:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:11:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:11:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:11:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:11:58 INFO - Intel Iris: 09:11:58 INFO - Chipset Model: Intel Iris 09:11:58 INFO - Type: GPU 09:11:58 INFO - Bus: Built-In 09:11:58 INFO - VRAM (Dynamic, Max): 1536 MB 09:11:58 INFO - Vendor: Intel (0x8086) 09:11:58 INFO - Device ID: 0x0a2e 09:11:58 INFO - Revision ID: 0x0009 09:11:58 INFO - Displays: 09:11:58 INFO - Display: 09:11:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:11:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:11:58 INFO - Display Serial Number: 1600x1200 60 09:11:58 INFO - Main Display: Yes 09:11:58 INFO - Mirror: Off 09:11:58 INFO - Online: Yes 09:11:58 INFO - Rotation: Supported 09:11:58 INFO - Return code: 0 09:11:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:11:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:11:58 INFO - Python 2.7.3 09:11:58 INFO - Return code: 0 09:11:58 INFO - grabbing minidump binary from tooltool 09:11:58 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')]} 09:11:58 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 0x10a40dd30>, '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 0x10a334db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a402be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:11:58 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 09:11:58 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 09:11:58 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 09:11:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:11:58 INFO - Return code: 0 09:11:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:11:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:11:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:11:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:11:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:11:58 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/Vjy2c9c5TKWZBMI0GYtXLg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0353', '--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 09:11:58 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/Vjy2c9c5TKWZBMI0GYtXLg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0353 --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 09:11:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2fC5bEcT8X/Render', 09:11:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:11:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:11:58 INFO - 'HOME': '/Users/cltbld', 09:11:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:11:58 INFO - 'LOGNAME': 'cltbld', 09:11:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:11:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:11:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:58 INFO - 'MOZ_NO_REMOTE': '1', 09:11:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:11:58 INFO - 'NO_EM_RESTART': '1', 09:11:58 INFO - 'PAGER': '/bin/cat', 09:11:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:11:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:58 INFO - 'PWD': '/builds/slave/test', 09:11:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:11:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:11:58 INFO - 'SHELL': '/bin/bash', 09:11:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gSGASo5TN/Listeners', 09:11:58 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 09:11:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:11:58 INFO - 'USER': 'cltbld', 09:11:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:11:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:11:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:58 INFO - 'XPC_FLAGS': '0x0', 09:11:58 INFO - 'XPC_SERVICE_NAME': '0', 09:11:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:11:58 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/Vjy2c9c5TKWZBMI0GYtXLg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0353', '--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 09:11:58 INFO - mozversion application_buildid: 20170112063609 09:11:58 INFO - mozversion application_changeset: 0be9aa8742dcdae97b0d594c7d5f5b517dc5107a 09:11:58 INFO - mozversion application_display_name: Nightly 09:11:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:11:58 INFO - mozversion application_name: Firefox 09:11:58 INFO - mozversion application_remotingname: firefox 09:11:58 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 09:11:58 INFO - mozversion application_vendor: Mozilla 09:11:58 INFO - mozversion application_version: 53.0a1 09:11:58 INFO - mozversion platform_buildid: 20170112063609 09:11:58 INFO - mozversion platform_changeset: 0be9aa8742dcdae97b0d594c7d5f5b517dc5107a 09:11:58 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 09:11:58 INFO - mozversion platform_version: 53.0a1 09:11:58 INFO - using testdate: 1484241118 09:11:58 INFO - actual date: 1484241118 09:11:58 INFO - starting webserver on 'localhost:49246' 09:11:58 INFO - SUITE-START | Running 2 tests 09:11:58 INFO - TEST-START | dromaeo_css 09:11:58 INFO - operating with platform_type : mac_ 09:11:58 INFO - Initialising browser for dromaeo_css test... 09:11:58 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/tmpMcLr7V/profile http://localhost:49246/getInfo.html) 09:12:01 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 09:12:01 INFO - PROCESS | 1637 | colorDepth:24 09:12:01 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 09:12:01 INFO - PROCESS | 1637 | __metrics 09:12:01 INFO - PROCESS | 1637 | 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" 09:12:01 INFO - PROCESS | 1637 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:12:02 INFO - TEST-INFO | 1637: exit 0 09:12:02 INFO - Browser initialized. 09:12:02 INFO - Running cycle 1/1 for dromaeo_css test... 09:12:02 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/tmpMcLr7V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:12:14 INFO - PROCESS | 1639 | RSS: Main: 234328064 09:12:14 INFO - PROCESS | 1639 | 09:15:17 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49246/tests/dromaeo/cssquery-ext.html) 09:15:19 INFO - PROCESS | 1639 | RSS: Main: 407097344 09:15:19 INFO - PROCESS | 1639 | 09:17:02 INFO - PROCESS | 1639 | ************************* 09:17:02 INFO - PROCESS | 1639 | A coding exception was thrown and uncaught in a Task. 09:17:02 INFO - PROCESS | 1639 | 09:17:02 INFO - PROCESS | 1639 | Full message: ReferenceError: fetch is not defined 09:17:02 INFO - PROCESS | 1639 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 09:17:02 INFO - PROCESS | 1639 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 09:17:02 INFO - PROCESS | 1639 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 09:17:02 INFO - PROCESS | 1639 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 09:17:02 INFO - PROCESS | 1639 | TaskImpl@resource://gre/modules/Task.jsm:277:3 09:17:02 INFO - PROCESS | 1639 | asyncFunction@resource://gre/modules/Task.jsm:252:14 09:17:02 INFO - PROCESS | 1639 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 09:17:02 INFO - PROCESS | 1639 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 09:17:02 INFO - PROCESS | 1639 | TaskImpl@resource://gre/modules/Task.jsm:277:3 09:17:02 INFO - PROCESS | 1639 | asyncFunction@resource://gre/modules/Task.jsm:252:14 09:17:02 INFO - PROCESS | 1639 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 09:17:02 INFO - PROCESS | 1639 | 09:17:02 INFO - PROCESS | 1639 | ************************* 09:18:22 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-ext.html (next: http://localhost:49246/tests/dromaeo/cssquery-jquery.html) 09:18:23 INFO - PROCESS | 1639 | RSS: Main: 365342720 09:18:23 INFO - PROCESS | 1639 | 09:21:25 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49246/tests/dromaeo/cssquery-mootools.html) 09:21:26 INFO - PROCESS | 1639 | RSS: Main: 334270464 09:21:26 INFO - PROCESS | 1639 | 09:24:28 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49246/tests/dromaeo/cssquery-prototype.html) 09:24:29 INFO - PROCESS | 1639 | RSS: Main: 330076160 09:24:29 INFO - PROCESS | 1639 | 09:27:32 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49246/tests/dromaeo/cssquery-yui.html) 09:27:33 INFO - PROCESS | 1639 | RSS: Main: 327507968 09:27:33 INFO - PROCESS | 1639 | 09:30:36 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-yui.html (next: http://localhost:49246/tests/dromaeo/cssquery-dojo.html) 09:30:37 INFO - PROCESS | 1639 | RSS: Main: 456171520 09:30:37 INFO - PROCESS | 1639 | 09:30:37 INFO - PROCESS | 1639 | __start_tp_report 09:30:37 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 09:30:37 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 09:30:37 INFO - PROCESS | 1639 | |i|pagename|runs| 09:30:37 INFO - PROCESS | 1639 | |0;dojo.html;3302;3314.585676790401;3314.867405303788;3338.298957218984;3364.293498365343;5515.889682206353;5547.084731019377;5564.415736347686;5572.3034620672415;5613.298337707786;5551.7224138793;5571.275734154554;5660.3490598581175;5660.632058916178;5685.687287199203;3997.9200415991663;5098.821541246057;5111.028904508132;5138.203578445347;5185.377754669445;5029.949700502984;5210.817621383252;5223.373195216579;5226.634135610509;5286.365636123671;5047.0915235257635;5198.16829307309;5199.948000520003;5218.660787048868;5233.03188910051;4193.601607847249;5040.445550989388;5074.898502029939;5121.539061484485;5129.871753206163;5081.79672813087;5102.056119617882;5125.718085505296;5133.897322053538;5172.405173405069;5572.331320241557;5584.832455026356;5626.887462250773;5638.295213098363;5668.943310566883;6017.789377371771;6046.818595442144;6048.213732214828;6057.515398768088;6171.9691401542705;6151.446369826693;6163.691815409212;6203.937960620381;6225.159603453521;6240.219972503437;5712.685802280831;5716;5717.942180696585;5729.312482502043;5733.799317023884;6156.722947467375;6211.81364559064;6236.282827474898;6305.936940630627;6313.463355614824;5919.822405327847;5931.90259801938;5935.554833387513;5992.041273396236;6059.212302400748;6016.909746353808;6149.354317796657;6151.507879369639;6162.969185154046;6186.752529898844;5921.052631578927;5954.702264886739;5970.940290597038;6045.063015232646;6050.939490605126;6125.672244547043;6126.3955342902;6148.647297594522;6150.538709596798;6156.445919867234;4805.711657300573;4868.245421959602;4873.561379475864;4891.144049791344;4914.459409464956;4001.559828418872;4111.773852438145;4364.803583838735;4381.474223093185;4441.644668426518;5700.686462244616;5725.198472213893;5728.083506638918;5734.627249228787;5744.885102297931;6163.7842675506145;6192.566520343533;6212.9068063979075;6215.12988181655;6227.346128656426;5557.166425036196;5618.775248989995;5624.409437009137;5658.632188907708;5680.857978550569;5341.3857406398765;5412.107002344648;5413.242146099549;5417.512423881791;5419.376771671308;6197.628142311476;6244.594101383395;6296.6851657417865;6297.055441683784;6306.3378345274;6036.336003039574;6219.0982307564245;6226.564140510302;6229.034499652561;6231.906521402092;6211.565190436626;6229.96885015572;6258.217722784652;6271.090691849748;6294.685265736786;5266.605004624592;5872.060470324898;6092.573519853568;6105.419985101408;6143.508519318533;6087.421694938974;6196.0705894116245;6215.782447614311;6222.968885155546;6247.344028877084;5793.073108302651;5888.146218798336;5898.94101058984;5965.403459654173;6038.63768173911;5858.853528661647;5869.031609784338;5879.941200587939;5893.970530147321;5902.498287645427;4811.78346974394;5769.365369809234;5770.221020162225;5773.884522309614;5778.8266352009505;5882.264716910387;6029.969850150721;6041.6375017499095;6047.516198704181;6054.697265136638;5770.076787713946;5771.018926782541;5775.422457754191;5791.102379131242;5796.362400136066 09:30:37 INFO - PROCESS | 1639 | |1;ext.html;391.09461596404327;438.97061391038017;477.21259921130155;477.55110196415364;480.09022901601486;25840.87079564602;32370.144478328264;33546.496802547954;33634.66365336346;41465.17069658612;43281.13437731243;44102.33846492305;44152.77923610377;44185.7790711046;44295.335569966475;9382.0148884367;9512.524373781318;9525.476098814563;9543.379680320757;9556.235501159925;8597.484150950932;8775.824483510325;9462.101100395452;9576.281778866613;9586.328956973015;11396.829047564293;11658.708532286675;11686.357250351228;11832;11846.052315814757;11396.886031139707;11455.484503197293;11491.712707182345;11508.539658413654;11510.482028308747;8437.535935523543;8662.740117796477;11064.114870810316;11267.774644507064;11352.943235283854;40218.9945251371;42235.57764422347;42448;42575.57424425747;42621.57378426238;4069.125138095294;4074.6129117733767;4080.6327430531096;4099.118689481776;4107.445494858216;28671.569926450913;30125.246868828453;30445.23886902823;31620.525692114636;31945.680543194736;3101.829399383033;3190.6649801770714;3286.967130328714;3338.7162091222276;3341.983290083534;481752;483696;483801;484203.99999999645;485385;65648;65726.784151981;66062;66120.66939665271;66120.66939665367;66880;68650.65674671595;69373.65313173503;69457;69533.95699064518;16258.918705406397;16575.585610359838;16580.75128873068;16595.6680866382;16618;12179.964703000343;12198;12247.081468889868;12622.747545049047;12739.299338536284;15659.765103523456;16714.91642541804;16889.071101089314;16892.733045021672;19013.42959711211;6280.780172694025;6477.611343319416;6516.641584712792;6533.968843990196;6552.246491653425;780.8008957715746;866.8687362991357;882.8455020371409;889.1597440418742;912.1516989199976;29735.85132074369;30386.69613303883;30400.54399184014;31171.908983185935;31188.844055779577;1049.3074570783247;1063.6064656077147;1095.769888323445;1105.165599972032;1220.5239956416826;15137.601001818804;15843.366265349487;16000.919995399949;16040.518784436486;16219.51341459758;557628;558699;559996;562016;563212;61441.69279153576;61482.38517614767;61622;61793;62132;1404.8595140486075;1443.0187472518578;1464.7290251303543;1464.8535146485478;1468.8163979502563;28024.43951121007;29645.555316669837;29845.70154298516;30088.504336118618;30199.396012080077;53276;53422.73288633532;53564;53748.46251537435;53754.193687093946;494583;495315;496726;497082;500344;25030.874845625654;25672.229833105037;25684.743152568237;41125.588744112174;41333.58666413297;37219;39584.40623390709;42341.94145146396;43823;44562.777186115156;31616.841915790275;33726.650933962366;36648.63351366559;36682.63317366899;37525.62474375221;31134.754609815354;34567;36256;36717.63282367249;36881.26237475289;35178;35564.11089722778;36010.63989360178;36147.45778813267;36276.45585316169;31117.68882311148;32161.67838321587;32525;32612.51081233736;32639.510407344384;23798.858102770835;24078.87960560186;24131.638025429984;24389.02443902224;24618.015279388623 09:30:37 INFO - PROCESS | 1639 | |2;jquery.html;345.6526191177866;358.26913097281545;388.32043923134535;402.51697962445076;409.8790856697274;19080.713789293153;21386.679199811977;21587.13651453942;21693.67459488107;21757.891210543927;17216.82783172168;20606;20726.37820865373;21073.367798966057;21643.783562164375;5618.129189975561;5698.8005419810315;6021.698915054251;6024.427679370475;6097.2073630427985;3435.7251419886347;5970.79102231422;5980.192673989021;6036.547258955574;6042.274927008765;4221.469874464461;4310.547392523787;4368.912621747563;6368.586041907284;6374.266959299694;5325.695204674841;6420.839479013062;6425.1647285853005;6437.163168788027;6441.323661015596;5387.78448862045;5581.2186293918885;5585.692786896719;5585.8603534911545;5586.329640443132;26548.60177097345;26557.937682492677;26593.734062659318;26598.601020984508;26676.866615666993;2764.101666958247;2797.062983900396;2804.4531316393313;2813.240425085236;2829.9717002829916;12796.680082997906;15033.473828415952;15434.38262469511;15464;15532.301046452936;1772.8936263824212;1840.9907950460297;1844.62185252023;1845.086682092373;1847.316492897623;108791;123267;126994.36502817519;127708;128396;9228.95385523068;11130.332180069221;11558.422078896021;11574.88425115738;11714.94142529299;14398.928005359907;14402;14433.35049922756;14435.422583096768;14450.783238251435;8385.371097167737;8668.263197628272;8699.304055675531;8798.384113112148;8828.690995815115;8602.268807151462;8625.008124065813;8670.176333248332;8787.956060219785;8828.823423531494;6845.623490707959;6970.163580370287;6982.2319544850025;7021.22766495685;7024.171826354649;1586.3337398292745;1596.4651841633183;1876.9718454223198;1917.2522716140716;1918.9520261993562;1040.360178490223;1046.764817515324;1059.1156384418941;1091.5742860284495;1118.8098023336051;19539.706904396444;22098.23214142865;22761.772382276296;22786.886065569564;22873.428164295692;1061.9628313009162;1081.7241603391085;1111.4609414433994;1114.7436089699415;1120.506976930148;10270.127039201752;11163.995240428238;11718.23831450953;11787;11811.409429528489;723688;731399;738062;747457;759328;69973;99251;117538;127827.05210635353;136858;1060.4644654449453;1076.494047797534;1097.9890201098046;1103.9558417663204;1105.0662190449057;18673.439796806117;20777.688334675295;20879.30215701455;20980.685289720972;20988.055537500542;53252.40242792568;53454;54308.728456359044;54601.1809822845;56294.71852640711;73830.52338953299;82963;84501;85767;94250.05749942413;6217.409346112112;8000.319972802377;8262.504249745034;8362;8388.916110838814;7593.012908321883;10319.845202321821;10376.740581485523;12840.972722182016;13392.129511581716;9844.114029737359;11194.66416007521;11243.831342529706;11424.257423267461;11513.424328783694;10654.73363165927;11287.830682539605;11304.417381566424;11344.262622929484;11700.88299116998;11190.94404527972;11207.271527350696;11427.60003399877;11868.584599538975;11894.167408281683;7896.565688887166;7958.243966823143;8282.71010514629;8410.074891761778;8412.116727743743;6722.764703235363;9417.811643767223;11321.603743868925;11450.599229026944;11474.885251147716 09:30:37 INFO - PROCESS | 1639 | |3;mootools.html;1446.8336141343748;1452.4262916148123;1453.7746649269354;1470.4632809024708;1480.3116550803875;7934.325582325502;8333.791655208623;8344.3741719371;8356.582170891454;8360.540170290631;7418.146913104994;7647.311741943224;7648.732294369698;7953.483023603461;8123.268905798477;2248.022110381985;2299.7240331160283;2300.309907027885;2301.171578231835;2305.9769402306015;2274.795268425841;2282.2924893283052;2296.9885150574223;2304.158981971585;2335.976640233593;1875.5498680316693;2268.0474200835606;2297.827662925279;2301.620232661609;2307.9653805192934;2239.8432109752325;2255.740589832166;2281.6007198740153;2283.8743869087193;2287.2909398086645;2260.276711452336;2279.7150356205475;2281.327008532487;2281.7147856517936;2285.714285714286;6943.652817359111;8237.382196335238;8325.125861784547;8335.83328333436;8347.624356903954;4961.479044700291;5145.819896303611;5152;5155.664881782672;5168.689878607295;3276.5904261967253;3316.1875340541483;3426.109211605001;3489.092835862694;3491.5286436331025;1179.3159967218992;1181.438816562126;1209.1838009343658;1227.5948936850818;1235.147748053849;10634.893651063468;10689.786204275872;10756.677299680943;10763.730906727238;10774.030337269684;4379.912401752011;4562.270036794163;4631.120087183424;4672.813087476531;4675.251959686434;9323.813523729488;9326.580303886341;9338.57976391064;9341.813163736822;9344.90655093454;5175.53420192177;5177;5188.014277287379;5196.298499702568;5212.192110222845;4218.0720241546815;4447.933281000723;4618.884527886763;4681.695689780154;4739.454962679336;3753.9436908446396;3783.243351329745;3813.7139714521522;3889.397143442771;3916.373380259145;1040.484959944832;1224.4122821045949;1230.9507619695291;1235.5860786636576;1244.035872199053;793.2860425616991;804.65399878053;810.546094187257;819.4714409206148;822.8436597046542;5566.137248726453;5607.7476513556985;5663.943360566424;5700.657960522382;5715.399883012307;538.4561592791231;556.5047108073818;588.0767195503105;591.9171316015761;594.313567829158;3756.887293381203;3777.7166712496673;3903.843846246118;3925.685311361136;3968.305546529346;6985.336393042653;9650.613975440903;9731.513424328756;9810.166135878388;9860.964598717175;8029.879551806727;9790.314677972474;9823.557939892722;9826.263030272758;9838.458884761263;7583.431242656823;7751.3411360035025;7767.417443691746;7864.4888082274465;7895.60521973899;5245.842624721265;5261.158214685632;5349.117395629678;5352.00987817255;5437.075697131418;7353.338199562065;9009.729708108767;9040.457572545669;9141.405808622418;9221.308401870021;7686.3466605336935;9134.588943497425;9164;9259.629614815332;9322.720318390458;6296.181496405438;6986.54587451814;7057.329553692391;7185.06594142779;7187.209406965125;7748.380129589732;7829.804254893673;7842.764717058498;7851.489653172525;7857.9214207857185;6860;6919.37725604698;7047.541909776053;7075.71697132109;7161.928380716126;6901.067046505114;6955.408790252885;6998.230194678683;7101.899205623136;7117.288271172842;6231.2834024086;6261.467775239155;6327.17746692927;6349.841253968688;6423.646699431576;4854;4921.6062714982;4943.431505376928;4947.109520286383;5007.449180590205;4890.6087512998165;4916.92624610624;4963.602911766978;5020.548150666457;5029.290041385946 09:30:37 INFO - PROCESS | 1639 | |4;prototype.html;332.13810162628005;352.70901506257337;356.4083621188827;361.87696183297675;376.314112774769;5002.374703162105;5007.799688012479;5059.5193456621655;5077.289179514871;5129.025165404066;4946.3917012861;5115;5143.996920600484;5158.613104017204;5201.8439446816565;3202.45558255096;4062.6749860011128;4072.8981775455627;4088.9591104089022;4114.218298523286;3781.413880848459;4091.363454618147;4094.529129150141;4095.1400205956784;4108.52751933527;3854.730168888179;4009.418634298025;4023.4166045923325;4032.254033003889;4052.7365721228025;3239.8293143593733;3352.8155951422664;3567.3400420921953;3972.384280436508;3995.680345572347;3622.4023036198996;3629.421201777235;3642.344378011957;3649.562052553684;3664.3587372210022;4037.97981010096;4718.551737584924;4997.700137991732;5090.847274581768;5118.513741194581;4186.723049469911;4239.491261048694;4690.343351930733;4709.915005671257;4747.406574178228;4618.729849291438;4816.879578010543;4862.659613827033;5379.811706590251;5413.918791218135;3178.6503484616674;3730.4031354983344;3747.868824591126;3748.4189950557434;3759;5516.3380394352935;5684.63049901755;5714.857028594256;5732.398098199671;5766.855828604276;3384.813835239036;3748.306563285801;3791.450239715226;3806.8477260909253;3834.559025712023;3246.805191688506;3864.9371422858376;3880.9611903881164;3888.4834914383414;3888.7083468739957;3617.0957260684827;4229.873103806891;4341.34879768031;4354.934675979863;4512.165249428801;4631.166390049756;5295.828710228788;5383.604296088203;5522.972385138049;5526.861828454321;1107.4850194659523;1162.9476673549711;1173.8826117388194;1343.9798403023963;1353.4586165533865;851.3317046118891;885.2563846369081;956.3926906414338;973.6446197138135;973.756560859785;4180.895477613084;4201.138766552849;4343.804528796211;4905.558499735041;4923.187674033816;4579.908401832011;5195.740212989335;5258.2638430619745;5273.683578985273;5350.652207606493;4355.60799528044;4391.165678521071;4473.932891006572;4609.838655647036;4840.491748366441;2490.6139548370033;2542.631318458813;2675.799315051379;2784.136917555564;2803.7897157713255;4661.463931647836;4943.085529177114;5352.581565885043;5503.3120859892515;5567.886422715473;4665.923663969569;4866.880617458004;5150.819721309811;5297.496737809902;5409.918851217235;4784.378030856105;4967.90064198714;5466.824632703988;5509.669419834742;5559.471850174227;4612.469565999953;5284.656497327662;5294.629375943647;5314;5323.973380133075;4601.803531081876;4975.61170638103;5049.9495005049475;5211.426743058185;5295.920561191509;5410.97294513525;5424.880693601274;5446.727663616724;5504.284443022381;5521.668699878021;3815.04623844039;3854.9036274093373;3866.516685414323;3886.9222615546964;3898.4347269645177;4905.258633185311;4960.925586116139;5094.898102038012;5181.3782346118705;5271.947280527299;4532.546745325441;5153;5173.922391164211;5203.661761985459;5208.85405210853;4440.425457506738;4824.855254342376;4980.501949805135;4980.800767969386;5181.53366197044;4548.658850586286;4594.88512787183;4689.6717229793585;5049.31834202378;5378.300820893259;4602.378678878308;5588.524975377139;5588.608797384144;5590.972045139748;5593.580481463825;4754.572088512051;5275.048232154128;5391.595630327663;5403.486668766461;5432.103702888979 09:30:37 INFO - PROCESS | 1639 | |5;yui.html;693.9424606043082;711.6619605687296;774.5468900693094;812.5368539932238;827.148037521353;14986.325615347308;15803.367865285389;15808.44670436535;15832.208389580532;15841.207939603002;14251.50119745809;14360.281985900689;14703;14706.926465367686;14708.852911470909;829.4567058576612;847.7499137754362;864.7621903976425;866.5104216117874;870.8345414371281;675.8749631318221;695.2317688953709;864.3344624639025;864.5245115186653;865.0398058155442;735.8822588385859;882.5410786391072;915.702396721065;920.282179899676;929.2565947242213;914.7987442762582;915.1169121797498;915.4278575890069;916.7983043730369;917.0187898948128;676.4419354032893;677.1062197898775;679.2562144451817;679.3037136934632;681.4718593090395;10828.458577071115;11924.46339914706;12552;14920.477783277533;15447.691046179014;14318.212498312589;14334.49829255971;14552.345144468418;14741.484048058373;14764.926175369055;11922;12051.638450846402;12239.75520489594;12241.387930603523;12477.688057798538;3626.437902125175;3678.9448158277646;3858.8070596470066;3902.7268091233627;3903.5901230370687;87000;105585.47207263991;109780.451097744;111155;111930;10865.674029779118;11246.887531124585;11291.54833806655;11314.830277545843;11430.881648299053;23729.842421347752;23977;24068.51862962766;24144.517109657707;24177.51644967126;6735.865282694319;6847.931520684829;7679.654415551314;7745.883811742829;8032.919670803217;4185.518665353523;4219.261629214875;4250.362445633118;4272.46594175728;4442;3376.206591451007;3487.1805125795418;3496.3881320768764;3504.491848681927;3511.3328467591077;641.7144370754969;650.2294780684904;654.1855390039432;654.5221987948729;659.9076129341896;662.3508961218033;665.4510029225908;691.9342662447059;714.7891372045259;724.1563578431173;9191.236864505938;9574.372356699378;9624.278179136452;9900.900990989998;10254.48727563619;558.7373934250895;610.7587502936316;632.8006677896448;689.1076056506836;696.9686364113526;4996.255536103085;5002.699838009731;5040.84877453677;5063.924041139386;5091.414487334004;104745.42881856779;105603;109510.90489095007;110911;111698;93724;93852.53073734588;94811.0518894816;95643;97397.5390369145;66828.66585667137;72869.63565182246;80770.59614702007;81663.59168204121;82202.94492637731;9649.131578158;9751.951240243754;9752.512374381395;9774.218062554837;9788.265880058882;53537;53562.464375357304;54722;55097.44902550923;55358.89282214414;67594.66202668955;72517.6374118126;75989.10027249363;76503.25649939747;76691.61654191917;11441.485133169193;11653.59212427561;11776.293422394683;11868.643940681794;12397.380130993233;12780.680482988;12857.357132143168;12970.22178669283;13015.284159371326;13468.663283417602;12379.93810030944;13494.32528373597;13925.23411212393;14261.572152835432;14706.338214780575;12535.498580056696;13282.203067815963;13491.257980810757;13639.522616708367;13766.587002389944;12372.876271237172;13257.270850102952;13431.328433578477;13770.449182032606;14341.713165736835;10949.45252737344;11081.83377249358;11367.431628418712;11543.942280288546;11551;10893.618723344645;11183.440827958408;11294.94352528232;11522.366269855238;11723.120765942418 09:30:37 INFO - PROCESS | 1639 | __end_tp_report 09:30:37 INFO - PROCESS | 1639 | __start_cc_report 09:30:37 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,2409 09:30:37 INFO - PROCESS | 1639 | __end_cc_report 09:30:37 INFO - PROCESS | 1639 | __startTimestamp1484242237098__endTimestamp 09:30:37 INFO - PROCESS | 1639 | 09:30:37 INFO - PROCESS | 1639 | ------- Summary: start ------- 09:30:37 INFO - PROCESS | 1639 | Number of tests: 6 09:30:37 INFO - PROCESS | 1639 | 09:30:37 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5635.53 Median:5775.42 stddev:653.19 (11.3%) stddev-sans-first:629.02 09:30:37 INFO - PROCESS | 1639 | Values: 3302.0 3314.6 3314.9 3338.3 3364.3 5515.9 5547.1 5564.4 5572.3 5613.3 5551.7 5571.3 5660.3 5660.6 5685.7 3997.9 5098.8 5111.0 5138.2 5185.4 5029.9 5210.8 5223.4 5226.6 5286.4 5047.1 5198.2 5199.9 5218.7 5233.0 4193.6 5040.4 5074.9 5121.5 5129.9 5081.8 5102.1 5125.7 5133.9 5172.4 5572.3 5584.8 5626.9 5638.3 5668.9 6017.8 6046.8 6048.2 6057.5 6172.0 6151.4 6163.7 6203.9 6225.2 6240.2 5712.7 5716.0 5717.9 5729.3 5733.8 6156.7 6211.8 6236.3 6305.9 6313.5 5919.8 5931.9 5935.6 5992.0 6059.2 6016.9 6149.4 6151.5 6163.0 6186.8 5921.1 5954.7 5970.9 6045.1 6050.9 6125.7 6126.4 6148.6 6150.5 6156.4 4805.7 4868.2 4873.6 4891.1 4914.5 4001.6 4111.8 4364.8 4381.5 4441.6 5700.7 5725.2 5728.1 5734.6 5744.9 6163.8 6192.6 6212.9 6215.1 6227.3 5557.2 5618.8 5624.4 5658.6 5680.9 5341.4 5412.1 5413.2 5417.5 5419.4 6197.6 6244.6 6296.7 6297.1 6306.3 6036.3 6219.1 6226.6 6229.0 6231.9 6211.6 6230.0 6258.2 6271.1 6294.7 5266.6 5872.1 6092.6 6105.4 6143.5 6087.4 6196.1 6215.8 6223.0 6247.3 5793.1 5888.1 5898.9 5965.4 6038.6 5858.9 5869.0 5879.9 5894.0 5902.5 4811.8 5769.4 5770.2 5773.9 5778.8 5882.3 6030.0 6041.6 6047.5 6054.7 5770.1 5771.0 5775.4 5791.1 5796.4 09:30:37 INFO - PROCESS | 1639 | 09:30:37 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:65786.93 Median:36665.63 stddev:137019.93 (373.7%) stddev-sans-first:137316.34 09:30:37 INFO - PROCESS | 1639 | Values: 391.1 439.0 477.2 477.6 480.1 25840.9 32370.1 33546.5 33634.7 41465.2 43281.1 44102.3 44152.8 44185.8 44295.3 9382.0 9512.5 9525.5 9543.4 9556.2 8597.5 8775.8 9462.1 9576.3 9586.3 11396.8 11658.7 11686.4 11832.0 11846.1 11396.9 11455.5 11491.7 11508.5 11510.5 8437.5 8662.7 11064.1 11267.8 11352.9 40219.0 42235.6 42448.0 42575.6 42621.6 4069.1 4074.6 4080.6 4099.1 4107.4 28671.6 30125.2 30445.2 31620.5 31945.7 3101.8 3190.7 3287.0 3338.7 3342.0 481752.0 483696.0 483801.0 484204.0 485385.0 65648.0 65726.8 66062.0 66120.7 66120.7 66880.0 68650.7 69373.7 69457.0 69534.0 16258.9 16575.6 16580.8 16595.7 16618.0 12180.0 12198.0 12247.1 12622.7 12739.3 15659.8 16714.9 16889.1 16892.7 19013.4 6280.8 6477.6 6516.6 6534.0 6552.2 780.8 866.9 882.8 889.2 912.2 29735.9 30386.7 30400.5 31171.9 31188.8 1049.3 1063.6 1095.8 1105.2 1220.5 15137.6 15843.4 16000.9 16040.5 16219.5 557628.0 558699.0 559996.0 562016.0 563212.0 61441.7 61482.4 61622.0 61793.0 62132.0 1404.9 1443.0 1464.7 1464.9 1468.8 28024.4 29645.6 29845.7 30088.5 30199.4 53276.0 53422.7 53564.0 53748.5 53754.2 494583.0 495315.0 496726.0 497082.0 500344.0 25030.9 25672.2 25684.7 41125.6 41333.6 37219.0 39584.4 42341.9 43823.0 44562.8 31616.8 33726.7 36648.6 36682.6 37525.6 31134.8 34567.0 36256.0 36717.6 36881.3 35178.0 35564.1 36010.6 36147.5 36276.5 31117.7 32161.7 32525.0 32612.5 32639.5 23798.9 24078.9 24131.6 24389.0 24618.0 09:30:37 INFO - PROCESS | 1639 | 09:30:37 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:39098.58 Median:22774.33 stddev:122245.47 (536.8%) stddev-sans-first:122553.77 09:30:37 INFO - PROCESS | 1639 | Values: 345.7 358.3 388.3 402.5 409.9 19080.7 21386.7 21587.1 21693.7 21757.9 17216.8 20606.0 20726.4 21073.4 21643.8 5618.1 5698.8 6021.7 6024.4 6097.2 3435.7 5970.8 5980.2 6036.5 6042.3 4221.5 4310.5 4368.9 6368.6 6374.3 5325.7 6420.8 6425.2 6437.2 6441.3 5387.8 5581.2 5585.7 5585.9 5586.3 26548.6 26557.9 26593.7 26598.6 26676.9 2764.1 2797.1 2804.5 2813.2 2830.0 12796.7 15033.5 15434.4 15464.0 15532.3 1772.9 1841.0 1844.6 1845.1 1847.3 108791.0 123267.0 126994.4 127708.0 128396.0 9229.0 11130.3 11558.4 11574.9 11714.9 14398.9 14402.0 14433.4 14435.4 14450.8 8385.4 8668.3 8699.3 8798.4 8828.7 8602.3 8625.0 8670.2 8788.0 8828.8 6845.6 6970.2 6982.2 7021.2 7024.2 1586.3 1596.5 1877.0 1917.3 1919.0 1040.4 1046.8 1059.1 1091.6 1118.8 19539.7 22098.2 22761.8 22786.9 22873.4 1062.0 1081.7 1111.5 1114.7 1120.5 10270.1 11164.0 11718.2 11787.0 11811.4 723688.0 731399.0 738062.0 747457.0 759328.0 69973.0 99251.0 117538.0 127827.1 136858.0 1060.5 1076.5 1098.0 1104.0 1105.1 18673.4 20777.7 20879.3 20980.7 20988.1 53252.4 53454.0 54308.7 54601.2 56294.7 73830.5 82963.0 84501.0 85767.0 94250.1 6217.4 8000.3 8262.5 8362.0 8388.9 7593.0 10319.8 10376.7 12841.0 13392.1 9844.1 11194.7 11243.8 11424.3 11513.4 10654.7 11287.8 11304.4 11344.3 11700.9 11190.9 11207.3 11427.6 11868.6 11894.2 7896.6 7958.2 8282.7 8410.1 8412.1 6722.8 9417.8 11321.6 11450.6 11474.9 09:30:37 INFO - PROCESS | 1639 | 09:30:37 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5315.19 Median:5253.50 stddev:2880.72 (54.8%) stddev-sans-first:2874.14 09:30:37 INFO - PROCESS | 1639 | Values: 1446.8 1452.4 1453.8 1470.5 1480.3 7934.3 8333.8 8344.4 8356.6 8360.5 7418.1 7647.3 7648.7 7953.5 8123.3 2248.0 2299.7 2300.3 2301.2 2306.0 2274.8 2282.3 2297.0 2304.2 2336.0 1875.5 2268.0 2297.8 2301.6 2308.0 2239.8 2255.7 2281.6 2283.9 2287.3 2260.3 2279.7 2281.3 2281.7 2285.7 6943.7 8237.4 8325.1 8335.8 8347.6 4961.5 5145.8 5152.0 5155.7 5168.7 3276.6 3316.2 3426.1 3489.1 3491.5 1179.3 1181.4 1209.2 1227.6 1235.1 10634.9 10689.8 10756.7 10763.7 10774.0 4379.9 4562.3 4631.1 4672.8 4675.3 9323.8 9326.6 9338.6 9341.8 9344.9 5175.5 5177.0 5188.0 5196.3 5212.2 4218.1 4447.9 4618.9 4681.7 4739.5 3753.9 3783.2 3813.7 3889.4 3916.4 1040.5 1224.4 1231.0 1235.6 1244.0 793.3 804.7 810.5 819.5 822.8 5566.1 5607.7 5663.9 5700.7 5715.4 538.5 556.5 588.1 591.9 594.3 3756.9 3777.7 3903.8 3925.7 3968.3 6985.3 9650.6 9731.5 9810.2 9861.0 8029.9 9790.3 9823.6 9826.3 9838.5 7583.4 7751.3 7767.4 7864.5 7895.6 5245.8 5261.2 5349.1 5352.0 5437.1 7353.3 9009.7 9040.5 9141.4 9221.3 7686.3 9134.6 9164.0 9259.6 9322.7 6296.2 6986.5 7057.3 7185.1 7187.2 7748.4 7829.8 7842.8 7851.5 7857.9 6860.0 6919.4 7047.5 7075.7 7161.9 6901.1 6955.4 6998.2 7101.9 7117.3 6231.3 6261.5 6327.2 6349.8 6423.6 4854.0 4921.6 4943.4 4947.1 5007.4 4890.6 4916.9 4963.6 5020.5 5029.3 09:30:37 INFO - PROCESS | 1639 | 09:30:37 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4302.47 Median:4732.98 stddev:1275.20 (26.9%) stddev-sans-first:1243.47 09:30:37 INFO - PROCESS | 1639 | Values: 332.1 352.7 356.4 361.9 376.3 5002.4 5007.8 5059.5 5077.3 5129.0 4946.4 5115.0 5144.0 5158.6 5201.8 3202.5 4062.7 4072.9 4089.0 4114.2 3781.4 4091.4 4094.5 4095.1 4108.5 3854.7 4009.4 4023.4 4032.3 4052.7 3239.8 3352.8 3567.3 3972.4 3995.7 3622.4 3629.4 3642.3 3649.6 3664.4 4038.0 4718.6 4997.7 5090.8 5118.5 4186.7 4239.5 4690.3 4709.9 4747.4 4618.7 4816.9 4862.7 5379.8 5413.9 3178.7 3730.4 3747.9 3748.4 3759.0 5516.3 5684.6 5714.9 5732.4 5766.9 3384.8 3748.3 3791.5 3806.8 3834.6 3246.8 3864.9 3881.0 3888.5 3888.7 3617.1 4229.9 4341.3 4354.9 4512.2 4631.2 5295.8 5383.6 5523.0 5526.9 1107.5 1162.9 1173.9 1344.0 1353.5 851.3 885.3 956.4 973.6 973.8 4180.9 4201.1 4343.8 4905.6 4923.2 4579.9 5195.7 5258.3 5273.7 5350.7 4355.6 4391.2 4473.9 4609.8 4840.5 2490.6 2542.6 2675.8 2784.1 2803.8 4661.5 4943.1 5352.6 5503.3 5567.9 4665.9 4866.9 5150.8 5297.5 5409.9 4784.4 4967.9 5466.8 5509.7 5559.5 4612.5 5284.7 5294.6 5314.0 5324.0 4601.8 4975.6 5049.9 5211.4 5295.9 5411.0 5424.9 5446.7 5504.3 5521.7 3815.0 3854.9 3866.5 3886.9 3898.4 4905.3 4960.9 5094.9 5181.4 5271.9 4532.5 5153.0 5173.9 5203.7 5208.9 4440.4 4824.9 4980.5 4980.8 5181.5 4548.7 4594.9 4689.7 5049.3 5378.3 4602.4 5588.5 5588.6 5591.0 5593.6 4754.6 5275.0 5391.6 5403.5 5432.1 09:30:37 INFO - PROCESS | 1639 | 09:30:37 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:21040.90 Median:4202.39 stddev:30600.67 (728.2%) stddev-sans-first:30648.37 09:30:37 INFO - PROCESS | 1639 | Values: 693.9 711.7 774.5 812.5 827.1 14986.3 15803.4 15808.4 15832.2 15841.2 14251.5 14360.3 14703.0 14706.9 14708.9 829.5 847.7 864.8 866.5 870.8 675.9 695.2 864.3 864.5 865.0 735.9 882.5 915.7 920.3 929.3 914.8 915.1 915.4 916.8 917.0 676.4 677.1 679.3 679.3 681.5 10828.5 11924.5 12552.0 14920.5 15447.7 14318.2 14334.5 14552.3 14741.5 14764.9 11922.0 12051.6 12239.8 12241.4 12477.7 3626.4 3678.9 3858.8 3902.7 3903.6 87000.0 105585.5 109780.5 111155.0 111930.0 10865.7 11246.9 11291.5 11314.8 11430.9 23729.8 23977.0 24068.5 24144.5 24177.5 6735.9 6847.9 7679.7 7745.9 8032.9 4185.5 4219.3 4250.4 4272.5 4442.0 3376.2 3487.2 3496.4 3504.5 3511.3 641.7 650.2 654.2 654.5 659.9 662.4 665.5 691.9 714.8 724.2 9191.2 9574.4 9624.3 9900.9 10254.5 558.7 610.8 632.8 689.1 697.0 4996.3 5002.7 5040.8 5063.9 5091.4 104745.4 105603.0 109510.9 110911.0 111698.0 93724.0 93852.5 94811.1 95643.0 97397.5 66828.7 72869.6 80770.6 81663.6 82202.9 9649.1 9752.0 9752.5 9774.2 9788.3 53537.0 53562.5 54722.0 55097.4 55358.9 67594.7 72517.6 75989.1 76503.3 76691.6 11441.5 11653.6 11776.3 11868.6 12397.4 12780.7 12857.4 12970.2 13015.3 13468.7 12379.9 13494.3 13925.2 14261.6 14706.3 12535.5 13282.2 13491.3 13639.5 13766.6 12372.9 13257.3 13431.3 13770.4 14341.7 10949.5 11081.8 11367.4 11543.9 11551.0 10893.6 11183.4 11294.9 11522.4 11723.1 09:30:37 INFO - PROCESS | 1639 | -------- Summary: end -------- 09:30:37 INFO - PROCESS | 1639 | 09:30:37 INFO - TEST-INFO | 1639: exit 0 09:30:37 INFO - TEST-OK | dromaeo_css | took 1118805ms 09:30:37 INFO - TEST-START | kraken 09:30:37 INFO - operating with platform_type : mac_ 09:30:37 INFO - Initialising browser for kraken test... 09:30:37 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/tmp4UUPts/profile http://localhost:49246/getInfo.html) 09:30:40 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 09:30:40 INFO - PROCESS | 1649 | colorDepth:24 09:30:40 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 09:30:40 INFO - PROCESS | 1649 | __metrics 09:30:40 INFO - PROCESS | 1649 | 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" 09:30:40 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:30:41 INFO - TEST-INFO | 1649: exit 0 09:30:41 INFO - Browser initialized. 09:30:41 INFO - Running cycle 1/1 for kraken test... 09:30:41 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/tmp4UUPts/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:30:53 INFO - PROCESS | 1650 | RSS: Main: 235245568 09:30:53 INFO - PROCESS | 1650 | 09:30:55 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection) 09:30:56 INFO - PROCESS | 1650 | RSS: Main: 287059968 09:30:56 INFO - PROCESS | 1650 | 09:30:59 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-dft) 09:31:00 INFO - PROCESS | 1650 | RSS: Main: 286601216 09:31:00 INFO - PROCESS | 1650 | 09:31:03 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-fft) 09:31:04 INFO - PROCESS | 1650 | RSS: Main: 380940288 09:31:04 INFO - PROCESS | 1650 | 09:31:06 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator) 09:31:06 INFO - PROCESS | 1650 | RSS: Main: 281780224 09:31:06 INFO - PROCESS | 1650 | 09:31:08 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:31:09 INFO - PROCESS | 1650 | RSS: Main: 286584832 09:31:09 INFO - PROCESS | 1650 | 09:31:12 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom) 09:31:12 INFO - PROCESS | 1650 | RSS: Main: 328179712 09:31:12 INFO - PROCESS | 1650 | 09:31:15 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate) 09:31:16 INFO - PROCESS | 1650 | RSS: Main: 329629696 09:31:16 INFO - PROCESS | 1650 | 09:31:19 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial) 09:31:20 INFO - PROCESS | 1650 | RSS: Main: 328105984 09:31:20 INFO - PROCESS | 1650 | 09:31:21 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:31:22 INFO - PROCESS | 1650 | RSS: Main: 303001600 09:31:22 INFO - PROCESS | 1650 | 09:31:24 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:31:24 INFO - PROCESS | 1650 | RSS: Main: 306556928 09:31:24 INFO - PROCESS | 1650 | 09:31:27 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:31:27 INFO - PROCESS | 1650 | RSS: Main: 308355072 09:31:27 INFO - PROCESS | 1650 | 09:31:30 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:31:31 INFO - PROCESS | 1650 | RSS: Main: 325099520 09:31:31 INFO - PROCESS | 1650 | 09:31:34 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:31:35 INFO - PROCESS | 1650 | RSS: Main: 319352832 09:31:35 INFO - PROCESS | 1650 | 09:31:36 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49246/tests/kraken/driver.html?testName=ai-astar) 09:31:37 INFO - PROCESS | 1650 | RSS: Main: 363626496 09:31:37 INFO - PROCESS | 1650 | 09:31:37 INFO - PROCESS | 1650 | __start_tp_report 09:31:37 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 09:31:37 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 09:31:37 INFO - PROCESS | 1650 | |i|pagename|runs| 09:31:37 INFO - PROCESS | 1650 | |0;ai-astar;113;114;114;113;113;113;111;114;113;113 09:31:37 INFO - PROCESS | 1650 | |1;audio-beat-detection;143;109;116;127;132;141;141;108;128;109 09:31:37 INFO - PROCESS | 1650 | |2;audio-dft;184;183;183;185;183;182;181;185;238;254 09:31:37 INFO - PROCESS | 1650 | |3;audio-fft;82;58;58;87;58;58;59;59;74;58 09:31:37 INFO - PROCESS | 1650 | |4;audio-oscillator;89;70;87;69;69;69;83;69;69;85 09:31:37 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;88;85;91;131;134;86;90;87;88;86 09:31:37 INFO - PROCESS | 1650 | |6;imaging-darkroom;95;96;97;97;119;167;97;98;97;97 09:31:37 INFO - PROCESS | 1650 | |7;imaging-desaturate;88;103;132;134;86;87;84;85;87;83 09:31:37 INFO - PROCESS | 1650 | |8;json-parse-financial;56;56;57;57;57;57;55;57;55;56 09:31:37 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;68;76;80;73;72;71;72;70;71;71 09:31:37 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;87;87;86;87;86;85;90;89;89;87 09:31:37 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;139;151;149;146;143;161;141;150;205;177 09:31:37 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;174;179;175;172;173;172;173;172;170;172 09:31:37 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;67;67;67;66;67;68;67;65;67;65 09:31:37 INFO - PROCESS | 1650 | __end_tp_report 09:31:37 INFO - PROCESS | 1650 | __start_cc_report 09:31:37 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1993 09:31:37 INFO - PROCESS | 1650 | __end_cc_report 09:31:37 INFO - PROCESS | 1650 | __startTimestamp1484242297105__endTimestamp 09:31:37 INFO - PROCESS | 1650 | 09:31:37 INFO - PROCESS | 1650 | ------- Summary: start ------- 09:31:37 INFO - PROCESS | 1650 | Number of tests: 14 09:31:37 INFO - PROCESS | 1650 | 09:31:37 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.00 stddev:0.88 (0.8%) stddev-sans-first:0.93 09:31:37 INFO - PROCESS | 1650 | Values: 113.0 114.0 114.0 113.0 113.0 113.0 111.0 114.0 113.0 113.0 09:31:37 INFO - PROCESS | 1650 | 09:31:37 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:125.40 Median:130.00 stddev:14.06 (10.8%) stddev-sans-first:13.39 09:31:37 INFO - PROCESS | 1650 | Values: 143.0 109.0 116.0 127.0 132.0 141.0 141.0 108.0 128.0 109.0 09:31:37 INFO - PROCESS | 1650 | 09:31:37 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:195.80 Median:184.50 stddev:26.75 (14.5%) stddev-sans-first:28.03 09:31:37 INFO - PROCESS | 1650 | Values: 184.0 183.0 183.0 185.0 183.0 182.0 181.0 185.0 238.0 254.0 09:31:37 INFO - PROCESS | 1650 | 09:31:37 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:65.10 Median:59.00 stddev:11.41 (19.3%) stddev-sans-first:10.33 09:31:37 INFO - PROCESS | 1650 | Values: 82.0 58.0 58.0 87.0 58.0 58.0 59.0 59.0 74.0 58.0 09:31:37 INFO - PROCESS | 1650 | 09:31:37 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:75.90 Median:76.50 stddev:8.82 (11.5%) stddev-sans-first:7.99 09:31:37 INFO - PROCESS | 1650 | Values: 89.0 70.0 87.0 69.0 69.0 69.0 83.0 69.0 69.0 85.0 09:31:37 INFO - PROCESS | 1650 | 09:31:37 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:96.60 Median:87.50 stddev:19.02 (21.7%) stddev-sans-first:19.92 09:31:37 INFO - PROCESS | 1650 | Values: 88.0 85.0 91.0 131.0 134.0 86.0 90.0 87.0 88.0 86.0 09:31:37 INFO - PROCESS | 1650 | 09:31:37 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:106.00 Median:97.00 stddev:22.56 (23.3%) stddev-sans-first:23.57 09:31:37 INFO - PROCESS | 1650 | Values: 95.0 96.0 97.0 97.0 119.0 167.0 97.0 98.0 97.0 97.0 09:31:37 INFO - PROCESS | 1650 | 09:31:37 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:85.50 stddev:19.84 (23.2%) stddev-sans-first:20.78 09:31:37 INFO - PROCESS | 1650 | Values: 88.0 103.0 132.0 134.0 86.0 87.0 84.0 85.0 87.0 83.0 09:31:37 INFO - PROCESS | 1650 | 09:31:37 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:57.00 stddev:0.82 (1.4%) stddev-sans-first:0.87 09:31:37 INFO - PROCESS | 1650 | Values: 56.0 56.0 57.0 57.0 57.0 57.0 55.0 57.0 55.0 56.0 09:31:37 INFO - PROCESS | 1650 | 09:31:37 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:72.40 Median:72.00 stddev:3.37 (4.7%) stddev-sans-first:3.18 09:31:37 INFO - PROCESS | 1650 | Values: 68.0 76.0 80.0 73.0 72.0 71.0 72.0 70.0 71.0 71.0 09:31:37 INFO - PROCESS | 1650 | 09:31:37 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:87.00 stddev:1.57 (1.8%) stddev-sans-first:1.66 09:31:37 INFO - PROCESS | 1650 | Values: 87.0 87.0 86.0 87.0 86.0 85.0 90.0 89.0 89.0 87.0 09:31:37 INFO - PROCESS | 1650 | 09:31:37 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:156.20 Median:150.50 stddev:20.44 (13.6%) stddev-sans-first:20.71 09:31:37 INFO - PROCESS | 1650 | Values: 139.0 151.0 149.0 146.0 143.0 161.0 141.0 150.0 205.0 177.0 09:31:37 INFO - PROCESS | 1650 | 09:31:37 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:173.00 stddev:2.44 (1.4%) stddev-sans-first:2.57 09:31:37 INFO - PROCESS | 1650 | Values: 174.0 179.0 175.0 172.0 173.0 172.0 173.0 172.0 170.0 172.0 09:31:37 INFO - PROCESS | 1650 | 09:31:37 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 09:31:37 INFO - PROCESS | 1650 | Values: 67.0 67.0 67.0 66.0 67.0 68.0 67.0 65.0 67.0 65.0 09:31:37 INFO - PROCESS | 1650 | -------- Summary: end -------- 09:31:37 INFO - PROCESS | 1650 | 09:31:37 INFO - TEST-INFO | 1650: exit 0 09:31:38 INFO - TEST-OK | kraken | took 60271ms 09:31:38 INFO - SUITE-END | took 1179s 09:31:38 INFO - Completed test suite (00:19:39) 09:31:38 INFO - javascript benchmark 09:31:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3302.0, 3314.585676790401, 3314.867405303788, 3338.298957218984, 3364.293498365343, 5515.889682206353, 5547.084731019377, 5564.415736347686, 5572.3034620672415, 5613.298337707786, 5551.7224138793, 5571.275734154554, 5660.3490598581175, 5660.632058916178, 5685.687287199203, 3997.9200415991663, 5098.821541246057, 5111.028904508132, 5138.203578445347, 5185.377754669445, 5029.949700502984, 5210.817621383252, 5223.373195216579, 5226.634135610509, 5286.365636123671, 5047.0915235257635, 5198.16829307309, 5199.948000520003, 5218.660787048868, 5233.03188910051, 4193.601607847249, 5040.445550989388, 5074.898502029939, 5121.539061484485, 5129.871753206163, 5081.79672813087, 5102.056119617882, 5125.718085505296, 5133.897322053538, 5172.405173405069, 5572.331320241557, 5584.832455026356, 5626.887462250773, 5638.295213098363, 5668.943310566883, 6017.789377371771, 6046.818595442144, 6048.213732214828, 6057.515398768088, 6171.9691401542705, 6151.446369826693, 6163.691815409212, 6203.937960620381, 6225.159603453521, 6240.219972503437, 5712.685802280831, 5716.0, 5717.942180696585, 5729.312482502043, 5733.799317023884, 6156.722947467375, 6211.81364559064, 6236.282827474898, 6305.936940630627, 6313.463355614824, 5919.822405327847, 5931.90259801938, 5935.554833387513, 5992.041273396236, 6059.212302400748, 6016.909746353808, 6149.354317796657, 6151.507879369639, 6162.969185154046, 6186.752529898844, 5921.052631578927, 5954.702264886739, 5970.940290597038, 6045.063015232646, 6050.939490605126, 6125.672244547043, 6126.3955342902, 6148.647297594522, 6150.538709596798, 6156.445919867234, 4805.711657300573, 4868.245421959602, 4873.561379475864, 4891.144049791344, 4914.459409464956, 4001.559828418872, 4111.773852438145, 4364.803583838735, 4381.474223093185, 4441.644668426518, 5700.686462244616, 5725.198472213893, 5728.083506638918, 5734.627249228787, 5744.885102297931, 6163.7842675506145, 6192.566520343533, 6212.9068063979075, 6215.12988181655, 6227.346128656426, 5557.166425036196, 5618.775248989995, 5624.409437009137, 5658.632188907708, 5680.857978550569, 5341.3857406398765, 5412.107002344648, 5413.242146099549, 5417.512423881791, 5419.376771671308, 6197.628142311476, 6244.594101383395, 6296.6851657417865, 6297.055441683784, 6306.3378345274, 6036.336003039574, 6219.0982307564245, 6226.564140510302, 6229.034499652561, 6231.906521402092, 6211.565190436626, 6229.96885015572, 6258.217722784652, 6271.090691849748, 6294.685265736786, 5266.605004624592, 5872.060470324898, 6092.573519853568, 6105.419985101408, 6143.508519318533, 6087.421694938974, 6196.0705894116245, 6215.782447614311, 6222.968885155546, 6247.344028877084, 5793.073108302651, 5888.146218798336, 5898.94101058984, 5965.403459654173, 6038.63768173911, 5858.853528661647, 5869.031609784338, 5879.941200587939, 5893.970530147321, 5902.498287645427, 4811.78346974394, 5769.365369809234, 5770.221020162225, 5773.884522309614, 5778.8266352009505, 5882.264716910387, 6029.969850150721, 6041.6375017499095, 6047.516198704181, 6054.697265136638, 5770.076787713946, 5771.018926782541, 5775.422457754191, 5791.102379131242, 5796.362400136066], "value": 5593.221795204187, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.09461596404327, 438.97061391038017, 477.21259921130155, 477.55110196415364, 480.09022901601486, 25840.87079564602, 32370.144478328264, 33546.496802547954, 33634.66365336346, 41465.17069658612, 43281.13437731243, 44102.33846492305, 44152.77923610377, 44185.7790711046, 44295.335569966475, 9382.0148884367, 9512.524373781318, 9525.476098814563, 9543.379680320757, 9556.235501159925, 8597.484150950932, 8775.824483510325, 9462.101100395452, 9576.281778866613, 9586.328956973015, 11396.829047564293, 11658.708532286675, 11686.357250351228, 11832.0, 11846.052315814757, 11396.886031139707, 11455.484503197293, 11491.712707182345, 11508.539658413654, 11510.482028308747, 8437.535935523543, 8662.740117796477, 11064.114870810316, 11267.774644507064, 11352.943235283854, 40218.9945251371, 42235.57764422347, 42448.0, 42575.57424425747, 42621.57378426238, 4069.125138095294, 4074.6129117733767, 4080.6327430531096, 4099.118689481776, 4107.445494858216, 28671.569926450913, 30125.246868828453, 30445.23886902823, 31620.525692114636, 31945.680543194736, 3101.829399383033, 3190.6649801770714, 3286.967130328714, 3338.7162091222276, 3341.983290083534, 481752.0, 483696.0, 483801.0, 484203.99999999645, 485385.0, 65648.0, 65726.784151981, 66062.0, 66120.66939665271, 66120.66939665367, 66880.0, 68650.65674671595, 69373.65313173503, 69457.0, 69533.95699064518, 16258.918705406397, 16575.585610359838, 16580.75128873068, 16595.6680866382, 16618.0, 12179.964703000343, 12198.0, 12247.081468889868, 12622.747545049047, 12739.299338536284, 15659.765103523456, 16714.91642541804, 16889.071101089314, 16892.733045021672, 19013.42959711211, 6280.780172694025, 6477.611343319416, 6516.641584712792, 6533.968843990196, 6552.246491653425, 780.8008957715746, 866.8687362991357, 882.8455020371409, 889.1597440418742, 912.1516989199976, 29735.85132074369, 30386.69613303883, 30400.54399184014, 31171.908983185935, 31188.844055779577, 1049.3074570783247, 1063.6064656077147, 1095.769888323445, 1105.165599972032, 1220.5239956416826, 15137.601001818804, 15843.366265349487, 16000.919995399949, 16040.518784436486, 16219.51341459758, 557628.0, 558699.0, 559996.0, 562016.0, 563212.0, 61441.69279153576, 61482.38517614767, 61622.0, 61793.0, 62132.0, 1404.8595140486075, 1443.0187472518578, 1464.7290251303543, 1464.8535146485478, 1468.8163979502563, 28024.43951121007, 29645.555316669837, 29845.70154298516, 30088.504336118618, 30199.396012080077, 53276.0, 53422.73288633532, 53564.0, 53748.46251537435, 53754.193687093946, 494583.0, 495315.0, 496726.0, 497082.0, 500344.0, 25030.874845625654, 25672.229833105037, 25684.743152568237, 41125.588744112174, 41333.58666413297, 37219.0, 39584.40623390709, 42341.94145146396, 43823.0, 44562.777186115156, 31616.841915790275, 33726.650933962366, 36648.63351366559, 36682.63317366899, 37525.62474375221, 31134.754609815354, 34567.0, 36256.0, 36717.63282367249, 36881.26237475289, 35178.0, 35564.11089722778, 36010.63989360178, 36147.45778813267, 36276.45585316169, 31117.68882311148, 32161.67838321587, 32525.0, 32612.51081233736, 32639.510407344384, 23798.858102770835, 24078.87960560186, 24131.638025429984, 24389.02443902224, 24618.015279388623], "value": 19888.279757859476, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.6526191177866, 358.26913097281545, 388.32043923134535, 402.51697962445076, 409.8790856697274, 19080.713789293153, 21386.679199811977, 21587.13651453942, 21693.67459488107, 21757.891210543927, 17216.82783172168, 20606.0, 20726.37820865373, 21073.367798966057, 21643.783562164375, 5618.129189975561, 5698.8005419810315, 6021.698915054251, 6024.427679370475, 6097.2073630427985, 3435.7251419886347, 5970.79102231422, 5980.192673989021, 6036.547258955574, 6042.274927008765, 4221.469874464461, 4310.547392523787, 4368.912621747563, 6368.586041907284, 6374.266959299694, 5325.695204674841, 6420.839479013062, 6425.1647285853005, 6437.163168788027, 6441.323661015596, 5387.78448862045, 5581.2186293918885, 5585.692786896719, 5585.8603534911545, 5586.329640443132, 26548.60177097345, 26557.937682492677, 26593.734062659318, 26598.601020984508, 26676.866615666993, 2764.101666958247, 2797.062983900396, 2804.4531316393313, 2813.240425085236, 2829.9717002829916, 12796.680082997906, 15033.473828415952, 15434.38262469511, 15464.0, 15532.301046452936, 1772.8936263824212, 1840.9907950460297, 1844.62185252023, 1845.086682092373, 1847.316492897623, 108791.0, 123267.0, 126994.36502817519, 127708.0, 128396.0, 9228.95385523068, 11130.332180069221, 11558.422078896021, 11574.88425115738, 11714.94142529299, 14398.928005359907, 14402.0, 14433.35049922756, 14435.422583096768, 14450.783238251435, 8385.371097167737, 8668.263197628272, 8699.304055675531, 8798.384113112148, 8828.690995815115, 8602.268807151462, 8625.008124065813, 8670.176333248332, 8787.956060219785, 8828.823423531494, 6845.623490707959, 6970.163580370287, 6982.2319544850025, 7021.22766495685, 7024.171826354649, 1586.3337398292745, 1596.4651841633183, 1876.9718454223198, 1917.2522716140716, 1918.9520261993562, 1040.360178490223, 1046.764817515324, 1059.1156384418941, 1091.5742860284495, 1118.8098023336051, 19539.706904396444, 22098.23214142865, 22761.772382276296, 22786.886065569564, 22873.428164295692, 1061.9628313009162, 1081.7241603391085, 1111.4609414433994, 1114.7436089699415, 1120.506976930148, 10270.127039201752, 11163.995240428238, 11718.23831450953, 11787.0, 11811.409429528489, 723688.0, 731399.0, 738062.0, 747457.0, 759328.0, 69973.0, 99251.0, 117538.0, 127827.05210635353, 136858.0, 1060.4644654449453, 1076.494047797534, 1097.9890201098046, 1103.9558417663204, 1105.0662190449057, 18673.439796806117, 20777.688334675295, 20879.30215701455, 20980.685289720972, 20988.055537500542, 53252.40242792568, 53454.0, 54308.728456359044, 54601.1809822845, 56294.71852640711, 73830.52338953299, 82963.0, 84501.0, 85767.0, 94250.05749942413, 6217.409346112112, 8000.319972802377, 8262.504249745034, 8362.0, 8388.916110838814, 7593.012908321883, 10319.845202321821, 10376.740581485523, 12840.972722182016, 13392.129511581716, 9844.114029737359, 11194.66416007521, 11243.831342529706, 11424.257423267461, 11513.424328783694, 10654.73363165927, 11287.830682539605, 11304.417381566424, 11344.262622929484, 11700.88299116998, 11190.94404527972, 11207.271527350696, 11427.60003399877, 11868.584599538975, 11894.167408281683, 7896.565688887166, 7958.243966823143, 8282.71010514629, 8410.074891761778, 8412.116727743743, 6722.764703235363, 9417.811643767223, 11321.603743868925, 11450.599229026944, 11474.885251147716], "value": 9958.62916696983, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1446.8336141343748, 1452.4262916148123, 1453.7746649269354, 1470.4632809024708, 1480.3116550803875, 7934.325582325502, 8333.791655208623, 8344.3741719371, 8356.582170891454, 8360.540170290631, 7418.146913104994, 7647.311741943224, 7648.732294369698, 7953.483023603461, 8123.268905798477, 2248.022110381985, 2299.7240331160283, 2300.309907027885, 2301.171578231835, 2305.9769402306015, 2274.795268425841, 2282.2924893283052, 2296.9885150574223, 2304.158981971585, 2335.976640233593, 1875.5498680316693, 2268.0474200835606, 2297.827662925279, 2301.620232661609, 2307.9653805192934, 2239.8432109752325, 2255.740589832166, 2281.6007198740153, 2283.8743869087193, 2287.2909398086645, 2260.276711452336, 2279.7150356205475, 2281.327008532487, 2281.7147856517936, 2285.714285714286, 6943.652817359111, 8237.382196335238, 8325.125861784547, 8335.83328333436, 8347.624356903954, 4961.479044700291, 5145.819896303611, 5152.0, 5155.664881782672, 5168.689878607295, 3276.5904261967253, 3316.1875340541483, 3426.109211605001, 3489.092835862694, 3491.5286436331025, 1179.3159967218992, 1181.438816562126, 1209.1838009343658, 1227.5948936850818, 1235.147748053849, 10634.893651063468, 10689.786204275872, 10756.677299680943, 10763.730906727238, 10774.030337269684, 4379.912401752011, 4562.270036794163, 4631.120087183424, 4672.813087476531, 4675.251959686434, 9323.813523729488, 9326.580303886341, 9338.57976391064, 9341.813163736822, 9344.90655093454, 5175.53420192177, 5177.0, 5188.014277287379, 5196.298499702568, 5212.192110222845, 4218.0720241546815, 4447.933281000723, 4618.884527886763, 4681.695689780154, 4739.454962679336, 3753.9436908446396, 3783.243351329745, 3813.7139714521522, 3889.397143442771, 3916.373380259145, 1040.484959944832, 1224.4122821045949, 1230.9507619695291, 1235.5860786636576, 1244.035872199053, 793.2860425616991, 804.65399878053, 810.546094187257, 819.4714409206148, 822.8436597046542, 5566.137248726453, 5607.7476513556985, 5663.943360566424, 5700.657960522382, 5715.399883012307, 538.4561592791231, 556.5047108073818, 588.0767195503105, 591.9171316015761, 594.313567829158, 3756.887293381203, 3777.7166712496673, 3903.843846246118, 3925.685311361136, 3968.305546529346, 6985.336393042653, 9650.613975440903, 9731.513424328756, 9810.166135878388, 9860.964598717175, 8029.879551806727, 9790.314677972474, 9823.557939892722, 9826.263030272758, 9838.458884761263, 7583.431242656823, 7751.3411360035025, 7767.417443691746, 7864.4888082274465, 7895.60521973899, 5245.842624721265, 5261.158214685632, 5349.117395629678, 5352.00987817255, 5437.075697131418, 7353.338199562065, 9009.729708108767, 9040.457572545669, 9141.405808622418, 9221.308401870021, 7686.3466605336935, 9134.588943497425, 9164.0, 9259.629614815332, 9322.720318390458, 6296.181496405438, 6986.54587451814, 7057.329553692391, 7185.06594142779, 7187.209406965125, 7748.380129589732, 7829.804254893673, 7842.764717058498, 7851.489653172525, 7857.9214207857185, 6860.0, 6919.37725604698, 7047.541909776053, 7075.71697132109, 7161.928380716126, 6901.067046505114, 6955.408790252885, 6998.230194678683, 7101.899205623136, 7117.288271172842, 6231.2834024086, 6261.467775239155, 6327.17746692927, 6349.841253968688, 6423.646699431576, 4854.0, 4921.6062714982, 4943.431505376928, 4947.109520286383, 5007.449180590205, 4890.6087512998165, 4916.92624610624, 4963.602911766978, 5020.548150666457, 5029.290041385946], "value": 4284.2669582506, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.13810162628005, 352.70901506257337, 356.4083621188827, 361.87696183297675, 376.314112774769, 5002.374703162105, 5007.799688012479, 5059.5193456621655, 5077.289179514871, 5129.025165404066, 4946.3917012861, 5115.0, 5143.996920600484, 5158.613104017204, 5201.8439446816565, 3202.45558255096, 4062.6749860011128, 4072.8981775455627, 4088.9591104089022, 4114.218298523286, 3781.413880848459, 4091.363454618147, 4094.529129150141, 4095.1400205956784, 4108.52751933527, 3854.730168888179, 4009.418634298025, 4023.4166045923325, 4032.254033003889, 4052.7365721228025, 3239.8293143593733, 3352.8155951422664, 3567.3400420921953, 3972.384280436508, 3995.680345572347, 3622.4023036198996, 3629.421201777235, 3642.344378011957, 3649.562052553684, 3664.3587372210022, 4037.97981010096, 4718.551737584924, 4997.700137991732, 5090.847274581768, 5118.513741194581, 4186.723049469911, 4239.491261048694, 4690.343351930733, 4709.915005671257, 4747.406574178228, 4618.729849291438, 4816.879578010543, 4862.659613827033, 5379.811706590251, 5413.918791218135, 3178.6503484616674, 3730.4031354983344, 3747.868824591126, 3748.4189950557434, 3759.0, 5516.3380394352935, 5684.63049901755, 5714.857028594256, 5732.398098199671, 5766.855828604276, 3384.813835239036, 3748.306563285801, 3791.450239715226, 3806.8477260909253, 3834.559025712023, 3246.805191688506, 3864.9371422858376, 3880.9611903881164, 3888.4834914383414, 3888.7083468739957, 3617.0957260684827, 4229.873103806891, 4341.34879768031, 4354.934675979863, 4512.165249428801, 4631.166390049756, 5295.828710228788, 5383.604296088203, 5522.972385138049, 5526.861828454321, 1107.4850194659523, 1162.9476673549711, 1173.8826117388194, 1343.9798403023963, 1353.4586165533865, 851.3317046118891, 885.2563846369081, 956.3926906414338, 973.6446197138135, 973.756560859785, 4180.895477613084, 4201.138766552849, 4343.804528796211, 4905.558499735041, 4923.187674033816, 4579.908401832011, 5195.740212989335, 5258.2638430619745, 5273.683578985273, 5350.652207606493, 4355.60799528044, 4391.165678521071, 4473.932891006572, 4609.838655647036, 4840.491748366441, 2490.6139548370033, 2542.631318458813, 2675.799315051379, 2784.136917555564, 2803.7897157713255, 4661.463931647836, 4943.085529177114, 5352.581565885043, 5503.3120859892515, 5567.886422715473, 4665.923663969569, 4866.880617458004, 5150.819721309811, 5297.496737809902, 5409.918851217235, 4784.378030856105, 4967.90064198714, 5466.824632703988, 5509.669419834742, 5559.471850174227, 4612.469565999953, 5284.656497327662, 5294.629375943647, 5314.0, 5323.973380133075, 4601.803531081876, 4975.61170638103, 5049.9495005049475, 5211.426743058185, 5295.920561191509, 5410.97294513525, 5424.880693601274, 5446.727663616724, 5504.284443022381, 5521.668699878021, 3815.04623844039, 3854.9036274093373, 3866.516685414323, 3886.9222615546964, 3898.4347269645177, 4905.258633185311, 4960.925586116139, 5094.898102038012, 5181.3782346118705, 5271.947280527299, 4532.546745325441, 5153.0, 5173.922391164211, 5203.661761985459, 5208.85405210853, 4440.425457506738, 4824.855254342376, 4980.501949805135, 4980.800767969386, 5181.53366197044, 4548.658850586286, 4594.88512787183, 4689.6717229793585, 5049.31834202378, 5378.300820893259, 4602.378678878308, 5588.524975377139, 5588.608797384144, 5590.972045139748, 5593.580481463825, 4754.572088512051, 5275.048232154128, 5391.595630327663, 5403.486668766461, 5432.103702888979], "value": 3917.1698501996284, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.9424606043082, 711.6619605687296, 774.5468900693094, 812.5368539932238, 827.148037521353, 14986.325615347308, 15803.367865285389, 15808.44670436535, 15832.208389580532, 15841.207939603002, 14251.50119745809, 14360.281985900689, 14703.0, 14706.926465367686, 14708.852911470909, 829.4567058576612, 847.7499137754362, 864.7621903976425, 866.5104216117874, 870.8345414371281, 675.8749631318221, 695.2317688953709, 864.3344624639025, 864.5245115186653, 865.0398058155442, 735.8822588385859, 882.5410786391072, 915.702396721065, 920.282179899676, 929.2565947242213, 914.7987442762582, 915.1169121797498, 915.4278575890069, 916.7983043730369, 917.0187898948128, 676.4419354032893, 677.1062197898775, 679.2562144451817, 679.3037136934632, 681.4718593090395, 10828.458577071115, 11924.46339914706, 12552.0, 14920.477783277533, 15447.691046179014, 14318.212498312589, 14334.49829255971, 14552.345144468418, 14741.484048058373, 14764.926175369055, 11922.0, 12051.638450846402, 12239.75520489594, 12241.387930603523, 12477.688057798538, 3626.437902125175, 3678.9448158277646, 3858.8070596470066, 3902.7268091233627, 3903.5901230370687, 87000.0, 105585.47207263991, 109780.451097744, 111155.0, 111930.0, 10865.674029779118, 11246.887531124585, 11291.54833806655, 11314.830277545843, 11430.881648299053, 23729.842421347752, 23977.0, 24068.51862962766, 24144.517109657707, 24177.51644967126, 6735.865282694319, 6847.931520684829, 7679.654415551314, 7745.883811742829, 8032.919670803217, 4185.518665353523, 4219.261629214875, 4250.362445633118, 4272.46594175728, 4442.0, 3376.206591451007, 3487.1805125795418, 3496.3881320768764, 3504.491848681927, 3511.3328467591077, 641.7144370754969, 650.2294780684904, 654.1855390039432, 654.5221987948729, 659.9076129341896, 662.3508961218033, 665.4510029225908, 691.9342662447059, 714.7891372045259, 724.1563578431173, 9191.236864505938, 9574.372356699378, 9624.278179136452, 9900.900990989998, 10254.48727563619, 558.7373934250895, 610.7587502936316, 632.8006677896448, 689.1076056506836, 696.9686364113526, 4996.255536103085, 5002.699838009731, 5040.84877453677, 5063.924041139386, 5091.414487334004, 104745.42881856779, 105603.0, 109510.90489095007, 110911.0, 111698.0, 93724.0, 93852.53073734588, 94811.0518894816, 95643.0, 97397.5390369145, 66828.66585667137, 72869.63565182246, 80770.59614702007, 81663.59168204121, 82202.94492637731, 9649.131578158, 9751.951240243754, 9752.512374381395, 9774.218062554837, 9788.265880058882, 53537.0, 53562.464375357304, 54722.0, 55097.44902550923, 55358.89282214414, 67594.66202668955, 72517.6374118126, 75989.10027249363, 76503.25649939747, 76691.61654191917, 11441.485133169193, 11653.59212427561, 11776.293422394683, 11868.643940681794, 12397.380130993233, 12780.680482988, 12857.357132143168, 12970.22178669283, 13015.284159371326, 13468.663283417602, 12379.93810030944, 13494.32528373597, 13925.23411212393, 14261.572152835432, 14706.338214780575, 12535.498580056696, 13282.203067815963, 13491.257980810757, 13639.522616708367, 13766.587002389944, 12372.876271237172, 13257.270850102952, 13431.328433578477, 13770.449182032606, 14341.713165736835, 10949.45252737344, 11081.83377249358, 11367.431628418712, 11543.942280288546, 11551.0, 10893.618723344645, 11183.440827958408, 11294.94352528232, 11522.366269855238, 11723.120765942418], "value": 7537.371039725435, "unit": "score"}], "name": "dromaeo_css", "value": 7207.143533521441, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 113.0, 113.0, 113.0, 111.0, 114.0, 113.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 109.0, 116.0, 127.0, 132.0, 141.0, 141.0, 108.0, 128.0, 109.0], "value": 125.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 183.0, 185.0, 183.0, 182.0, 181.0, 185.0, 238.0, 254.0], "value": 195.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 58.0, 87.0, 58.0, 58.0, 59.0, 59.0, 74.0, 58.0], "value": 65.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 87.0, 69.0, 69.0, 69.0, 83.0, 69.0, 69.0, 85.0], "value": 75.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 91.0, 131.0, 134.0, 86.0, 90.0, 87.0, 88.0, 86.0], "value": 96.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 97.0, 119.0, 167.0, 97.0, 98.0, 97.0, 97.0], "value": 106.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 103.0, 132.0, 134.0, 86.0, 87.0, 84.0, 85.0, 87.0, 83.0], "value": 96.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 57.0, 57.0, 57.0, 55.0, 57.0, 55.0, 56.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 76.0, 80.0, 73.0, 72.0, 71.0, 72.0, 70.0, 71.0, 71.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 86.0, 87.0, 86.0, 85.0, 90.0, 89.0, 89.0, 87.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 151.0, 149.0, 146.0, 143.0, 161.0, 141.0, 150.0, 205.0, 177.0], "value": 156.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 179.0, 175.0, 172.0, 173.0, 172.0, 173.0, 172.0, 170.0, 172.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 67.0, 68.0, 67.0, 65.0, 67.0, 65.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1486.8, "alertThreshold": 2.0}]} 09:31:38 INFO - Return code: 0 09:31:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:31:38 INFO - # TBPL SUCCESS # 09:31:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:31:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:31:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:31:38 INFO - 2017-01-12 09:31:38.453 screenresolution[1654:9833] starting screenresolution argv=screenresolution get 09:31:38 INFO - 2017-01-12 09:31:38.456 screenresolution[1654:9833] Display 0: 1600x1200x32@60 09:31:38 INFO - 2017-01-12 09:31:38.462 screenresolution[1655:9836] starting screenresolution argv=screenresolution list 09:31:38 INFO - Available Modes on Display 0 09:31:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:31:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:31:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:31:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:31:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:31:38 INFO - Intel Iris: 09:31:38 INFO - Chipset Model: Intel Iris 09:31:38 INFO - Type: GPU 09:31:38 INFO - Bus: Built-In 09:31:38 INFO - VRAM (Dynamic, Max): 1536 MB 09:31:38 INFO - Vendor: Intel (0x8086) 09:31:38 INFO - Device ID: 0x0a2e 09:31:38 INFO - Revision ID: 0x0009 09:31:38 INFO - Displays: 09:31:38 INFO - Display: 09:31:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:31:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:31:38 INFO - Display Serial Number: 1600x1200 60 09:31:38 INFO - Main Display: Yes 09:31:38 INFO - Mirror: Off 09:31:38 INFO - Online: Yes 09:31:38 INFO - Rotation: Supported 09:31:38 INFO - Return code: 0 09:31:38 INFO - Running post-action listener: _resource_record_post_action 09:31:38 INFO - [mozharness: 2017-01-12 17:31:38.704768Z] Finished run-tests step (success) 09:31:38 INFO - Running post-run listener: _resource_record_post_run 09:31:38 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 37843968; Write bytes: 552585728; Read time: 245; Write time: 1684 09:31:38 INFO - TinderboxPrint: CPU usage
53.8% 09:31:38 INFO - TinderboxPrint: I/O read bytes / time
37,843,968 / 245 09:31:38 INFO - TinderboxPrint: I/O write bytes / time
552,585,728 / 1,684 09:31:38 INFO - TinderboxPrint: CPU idle
2,222.7 (46.2%) 09:31:38 INFO - TinderboxPrint: CPU system
962.7 (20.0%) 09:31:38 INFO - TinderboxPrint: CPU user
1,624.3 (33.8%) 09:31:38 INFO - TinderboxPrint: Swap in / out
288,043,008 / 0 09:31:38 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 248998400; Write bytes: 241213440; Read time: 18087; Write time: 517 09:31:38 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 34354176; Write bytes: 297914880; Read time: 220; Write time: 1120 09:31:39 INFO - Running post-run listener: _upload_blobber_files 09:31:39 INFO - Blob upload gear active. 09:31:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:31:39 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 09:31:39 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'] 09:31:39 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 09:31:39 INFO - (blobuploader) - INFO - Open directory for files ... 09:31:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:31:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:31:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:31:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:31:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:31:40 INFO - (blobuploader) - INFO - Done attempting. 09:31:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:31:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:31:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:31:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:31:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:31:41 INFO - (blobuploader) - INFO - Done attempting. 09:31:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:31:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:31:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:31:42 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:31:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:31:42 INFO - (blobuploader) - INFO - Done attempting. 09:31:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:31:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:31:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:31:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:31:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:31:44 INFO - (blobuploader) - INFO - Done attempting. 09:31:44 INFO - (blobuploader) - INFO - Iteration through files over. 09:31:44 INFO - Return code: 0 09:31:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:31:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:31:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1f9365a816e0008f551b37a2934d7bfac8a54bd0cd66017de62f96389196a6152d4e5c03cc1867abd22e4c56d0e7b3e87814b7b92bd4cb9026bfb8cdf6542c7a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d4cc480086bb43b8fa14f33e48392fcd6dbd13443752a4456778ee3539ec4be02dfacb592f15d5eef857e391cbdb82f838cb1dc4be68374d2903b9628cc5df4d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9b027db41bcd0738a981784b1b74d672596fe644fbc777de6fefa8625170984e5e97660a2308b3725a976ce1aa88be8c9b754086f04203657d82cbc676158a47", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d35e4724a62a5d25410bc8203f43ed4d9dc4d35d065557a7318c94ec4aa2f63c68846639c191efd7f936d40429860e7104a0e7d479d0d999626a6fb886010ca1"} 09:31:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:31:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:31:44 INFO - Contents: 09:31:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1f9365a816e0008f551b37a2934d7bfac8a54bd0cd66017de62f96389196a6152d4e5c03cc1867abd22e4c56d0e7b3e87814b7b92bd4cb9026bfb8cdf6542c7a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d4cc480086bb43b8fa14f33e48392fcd6dbd13443752a4456778ee3539ec4be02dfacb592f15d5eef857e391cbdb82f838cb1dc4be68374d2903b9628cc5df4d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9b027db41bcd0738a981784b1b74d672596fe644fbc777de6fefa8625170984e5e97660a2308b3725a976ce1aa88be8c9b754086f04203657d82cbc676158a47", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d35e4724a62a5d25410bc8203f43ed4d9dc4d35d065557a7318c94ec4aa2f63c68846639c191efd7f936d40429860e7104a0e7d479d0d999626a6fb886010ca1"} 09:31:44 INFO - Running post-run listener: copy_logs_to_upload_dir 09:31:44 INFO - Copying logs to upload dir... 09:31:44 INFO - mkdir: /builds/slave/test/build/upload/logs 09:31:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.592073 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-12 09:31:44.751863) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 09:31:44.755303) ========= 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.2fC5bEcT8X/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.6gSGASo5TN/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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/1f9365a816e0008f551b37a2934d7bfac8a54bd0cd66017de62f96389196a6152d4e5c03cc1867abd22e4c56d0e7b3e87814b7b92bd4cb9026bfb8cdf6542c7a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d4cc480086bb43b8fa14f33e48392fcd6dbd13443752a4456778ee3539ec4be02dfacb592f15d5eef857e391cbdb82f838cb1dc4be68374d2903b9628cc5df4d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9b027db41bcd0738a981784b1b74d672596fe644fbc777de6fefa8625170984e5e97660a2308b3725a976ce1aa88be8c9b754086f04203657d82cbc676158a47", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d35e4724a62a5d25410bc8203f43ed4d9dc4d35d065557a7318c94ec4aa2f63c68846639c191efd7f936d40429860e7104a0e7d479d0d999626a6fb886010ca1"} build_url:https://queue.taskcluster.net/v1/task/Vjy2c9c5TKWZBMI0GYtXLg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011321 build_url: 'https://queue.taskcluster.net/v1/task/Vjy2c9c5TKWZBMI0GYtXLg/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/1f9365a816e0008f551b37a2934d7bfac8a54bd0cd66017de62f96389196a6152d4e5c03cc1867abd22e4c56d0e7b3e87814b7b92bd4cb9026bfb8cdf6542c7a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d4cc480086bb43b8fa14f33e48392fcd6dbd13443752a4456778ee3539ec4be02dfacb592f15d5eef857e391cbdb82f838cb1dc4be68374d2903b9628cc5df4d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9b027db41bcd0738a981784b1b74d672596fe644fbc777de6fefa8625170984e5e97660a2308b3725a976ce1aa88be8c9b754086f04203657d82cbc676158a47", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d35e4724a62a5d25410bc8203f43ed4d9dc4d35d065557a7318c94ec4aa2f63c68846639c191efd7f936d40429860e7104a0e7d479d0d999626a6fb886010ca1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 09:31:44.788999) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 09:31:44.789305) ========= 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.2fC5bEcT8X/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.6gSGASo5TN/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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.005095 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 09:31:44.837600) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 09:31:44.837918) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 09:31:44.838238) ========= ========= Total master_lag: 0.18 =========