builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0039 starttime: 1493401461.76 results: success (0) buildid: 20170428091122 builduid: 7954f5dcc6664e13953cce3160151c18 revision: 016390ad9e5c1f43f8a51ff9e212bb46e28def3e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 10:44:21.755805) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 10:44:21.756296) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 10:44:21.756638) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 10:44:21.785069) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 10:44:21.785776) ========= 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.Wp9kd3u7V1/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.p4xSYcse9l/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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-04-28 10:44:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 63.8M=0s 2017-04-28 10:44:21 (63.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.097267 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 10:44:21.910190) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 10:44:21.910570) ========= 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.Wp9kd3u7V1/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.p4xSYcse9l/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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.027756 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 10:44:21.962999) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-28 10:44:21.963649) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 016390ad9e5c1f43f8a51ff9e212bb46e28def3e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 016390ad9e5c1f43f8a51ff9e212bb46e28def3e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Wp9kd3u7V1/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.p4xSYcse9l/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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-04-28 10:44:22,065 truncating revision to first 12 chars 2017-04-28 10:44:22,065 Setting DEBUG logging. 2017-04-28 10:44:22,065 attempt 1/10 2017-04-28 10:44:22,066 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/016390ad9e5c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-28 10:44:23,866 unpacking tar archive at: mozilla-beta-016390ad9e5c/testing/mozharness/ program finished with exit code 0 elapsedTime=2.060855 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-28 10:44:24.049537) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 10:44:24.049907) ========= script_repo_revision: 016390ad9e5c1f43f8a51ff9e212bb46e28def3e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 10:44:24.050359) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 10:44:24.050706) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 10:44:24.071598) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2017-04-28 10:44:24.071993) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Wp9kd3u7V1/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.p4xSYcse9l/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 10:44:24 INFO - MultiFileLogger online at 20170428 10:44:24 in /builds/slave/test 10:44:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:44:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:44:24 INFO - {'append_to_log': False, 10:44:24 INFO - 'base_work_dir': '/builds/slave/test', 10:44:24 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:44:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:44:24 INFO - 'branch': 'Mozilla-Beta', 10:44:24 INFO - 'buildbot_json_path': 'buildprops.json', 10:44:24 INFO - 'config_files': ('talos/mac_config.py',), 10:44:24 INFO - 'default_actions': ('clobber', 10:44:24 INFO - 'read-buildbot-config', 10:44:24 INFO - 'download-and-extract', 10:44:24 INFO - 'populate-webroot', 10:44:24 INFO - 'create-virtualenv', 10:44:24 INFO - 'install', 10:44:24 INFO - 'run-tests'), 10:44:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:44:24 INFO - 'download_minidump_stackwalk': True, 10:44:24 INFO - 'download_symbols': 'ondemand', 10:44:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:44:24 INFO - 'tooltool.py': '/tools/tooltool.py', 10:44:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:44:24 INFO - '/tools/misc-python/virtualenv.py')}, 10:44:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:44:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:44:24 INFO - 'gecko_profile': False, 10:44:24 INFO - 'gecko_profile_interval': 0, 10:44:24 INFO - 'installer_path': 'installer.exe', 10:44:24 INFO - 'log_level': 'info', 10:44:24 INFO - 'log_name': 'talos', 10:44:24 INFO - 'log_to_console': True, 10:44:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:44:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:44:24 INFO - 'opt_config_files': (), 10:44:24 INFO - 'pip_index': False, 10:44:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:44:24 INFO - 'cmd': ('bash', 10:44:24 INFO - '-c', 10:44:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:44:24 INFO - 'enabled': True, 10:44:24 INFO - 'halt_on_failure': False, 10:44:24 INFO - 'name': 'check_screen_resolution'},), 10:44:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:44:24 INFO - 'cmd': ('bash', 10:44:24 INFO - '-c', 10:44:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:44:24 INFO - 'enabled': True, 10:44:24 INFO - 'halt_on_failure': False, 10:44:24 INFO - 'name': 'check_screen_resolution'},), 10:44:24 INFO - 'run_cmd_checks_enabled': True, 10:44:24 INFO - 'suite': 'dromaeojs', 10:44:24 INFO - 'system_bits': '32', 10:44:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:44:24 INFO - 'title': 't-yosemite-r7-0039', 10:44:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:44:24 INFO - 'use_talos_json': True, 10:44:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:44:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:44:24 INFO - 'work_dir': 'build'} 10:44:24 INFO - [mozharness: 2017-04-28 17:44:24.288168Z] Running clobber step. 10:44:24 INFO - Running pre-action listener: _resource_record_pre_action 10:44:24 INFO - Running main action method: clobber 10:44:24 INFO - rmtree: /builds/slave/test/build 10:44:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:44:26 INFO - Running post-action listener: _resource_record_post_action 10:44:26 INFO - [mozharness: 2017-04-28 17:44:26.927940Z] Finished clobber step (success) 10:44:26 INFO - [mozharness: 2017-04-28 17:44:26.928066Z] Running read-buildbot-config step. 10:44:26 INFO - Running pre-action listener: _resource_record_pre_action 10:44:26 INFO - Running main action method: read_buildbot_config 10:44:26 INFO - Using buildbot properties: 10:44:26 INFO - { 10:44:26 INFO - "project": "", 10:44:26 INFO - "product": "firefox", 10:44:26 INFO - "script_repo_revision": "production", 10:44:26 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 10:44:26 INFO - "repository": "", 10:44:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 10:44:26 INFO - "buildid": "20170428091122", 10:44:26 INFO - "pgo_build": "False", 10:44:26 INFO - "basedir": "/builds/slave/test", 10:44:26 INFO - "buildnumber": 4, 10:44:26 INFO - "slavename": "t-yosemite-r7-0039", 10:44:26 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 10:44:26 INFO - "platform": "yosemite_r7", 10:44:26 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:44:26 INFO - "branch": "mozilla-beta", 10:44:26 INFO - "repo_path": "releases/mozilla-beta", 10:44:26 INFO - "revision": "016390ad9e5c1f43f8a51ff9e212bb46e28def3e", 10:44:26 INFO - "stage_platform": "macosx64", 10:44:26 INFO - "builduid": "7954f5dcc6664e13953cce3160151c18", 10:44:26 INFO - "slavebuilddir": "test" 10:44:26 INFO - } 10:44:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZZoVjBL0TqyzLHY8hv-T3g/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 10:44:26 INFO - Running post-action listener: _resource_record_post_action 10:44:26 INFO - [mozharness: 2017-04-28 17:44:26.931344Z] Finished read-buildbot-config step (success) 10:44:26 INFO - [mozharness: 2017-04-28 17:44:26.931475Z] Running download-and-extract step. 10:44:26 INFO - Running pre-action listener: _resource_record_pre_action 10:44:26 INFO - Running main action method: download_and_extract 10:44:26 INFO - mkdir: /builds/slave/test/build/tests 10:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:44:26 INFO - trying https://queue.taskcluster.net/v1/task/ZZoVjBL0TqyzLHY8hv-T3g/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 10:44:26 INFO - Downloading https://queue.taskcluster.net/v1/task/ZZoVjBL0TqyzLHY8hv-T3g/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 10:44:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZZoVjBL0TqyzLHY8hv-T3g/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 10:44:28 INFO - Downloaded 1165 bytes. 10:44:28 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 10:44:28 INFO - Using the following test package requirements: 10:44:28 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 10:44:28 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:44:28 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 10:44:28 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:44:28 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 10:44:28 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:44:28 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:44:28 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 10:44:28 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 10:44:28 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:44:28 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 10:44:28 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:44:28 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 10:44:28 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:44:28 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 10:44:28 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:44:28 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 10:44:28 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 10:44:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZZoVjBL0TqyzLHY8hv-T3g/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 10:44:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZZoVjBL0TqyzLHY8hv-T3g/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 10:44:28 INFO - Fetch https://queue.taskcluster.net/v1/task/ZZoVjBL0TqyzLHY8hv-T3g/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 10:44:29 INFO - Expected file size: 51225631 10:44:29 INFO - Obtained file size: 51225631 10:44:45 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 10:44:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZZoVjBL0TqyzLHY8hv-T3g/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 10:44:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZZoVjBL0TqyzLHY8hv-T3g/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 10:44:45 INFO - Fetch https://queue.taskcluster.net/v1/task/ZZoVjBL0TqyzLHY8hv-T3g/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 10:44:47 INFO - Expected file size: 51225631 10:44:47 INFO - Obtained file size: 51225631 10:45:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZZoVjBL0TqyzLHY8hv-T3g/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 10:45:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZZoVjBL0TqyzLHY8hv-T3g/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 10:45:02 INFO - Fetch https://queue.taskcluster.net/v1/task/ZZoVjBL0TqyzLHY8hv-T3g/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 10:45:03 INFO - Expected file size: 14404449 10:45:03 INFO - Obtained file size: 14404449 10:45:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:03 INFO - trying https://queue.taskcluster.net/v1/task/ZZoVjBL0TqyzLHY8hv-T3g/artifacts/public/build/firefox-54.0.en-US.mac.dmg 10:45:03 INFO - Downloading https://queue.taskcluster.net/v1/task/ZZoVjBL0TqyzLHY8hv-T3g/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 10:45:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZZoVjBL0TqyzLHY8hv-T3g/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 10:45:05 INFO - Downloaded 59540587 bytes. 10:45:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZZoVjBL0TqyzLHY8hv-T3g/artifacts/public/build/firefox-54.0.en-US.mac.dmg 10:45:05 INFO - mkdir: /builds/slave/test/properties 10:45:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:45:05 INFO - Writing to file /builds/slave/test/properties/build_url 10:45:05 INFO - Contents: 10:45:05 INFO - build_url:https://queue.taskcluster.net/v1/task/ZZoVjBL0TqyzLHY8hv-T3g/artifacts/public/build/firefox-54.0.en-US.mac.dmg 10:45:06 INFO - Running post-action listener: _resource_record_post_action 10:45:06 INFO - Running post-action listener: set_extra_try_arguments 10:45:06 INFO - [mozharness: 2017-04-28 17:45:06.421875Z] Finished download-and-extract step (success) 10:45:06 INFO - [mozharness: 2017-04-28 17:45:06.422013Z] Running populate-webroot step. 10:45:06 INFO - Running pre-action listener: _resource_record_pre_action 10:45:06 INFO - Running main action method: populate_webroot 10:45:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:45:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:45:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:45:06 INFO - '--tppagecycles', 10:45:06 INFO - '7'], 10:45:06 INFO - 'tests': ['tsvgm']}}, 10:45:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:45:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:45:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:45:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:45:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:45:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:45:06 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:45:06 INFO - 'talos_options': ['--disable-e10s'], 10:45:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:45:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:45:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:45:06 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:45:06 INFO - 'talos_options': ['--disable-e10s'], 10:45:06 INFO - 'tests': ['damp', 'tps']}, 10:45:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:45:06 INFO - 'tests': ['damp', 'tps']}, 10:45:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:45:06 INFO - 'tests': ['dromaeo_dom']}, 10:45:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:45:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:45:06 INFO - 'tests': ['basic_compositor_video']}, 10:45:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:45:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:45:06 INFO - 'tests': ['a11yr', 10:45:06 INFO - 'ts_paint', 10:45:06 INFO - 'tpaint', 10:45:06 INFO - 'sessionrestore', 10:45:06 INFO - 'sessionrestore_no_auto_restore', 10:45:06 INFO - 'tabpaint']}, 10:45:06 INFO - 'other-e10s': {'tests': ['a11yr', 10:45:06 INFO - 'ts_paint', 10:45:06 INFO - 'tpaint', 10:45:06 INFO - 'sessionrestore', 10:45:06 INFO - 'sessionrestore_no_auto_restore', 10:45:06 INFO - 'tabpaint']}, 10:45:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:45:06 INFO - 'ts_paint', 10:45:06 INFO - 'tpaint', 10:45:06 INFO - 'sessionrestore', 10:45:06 INFO - 'sessionrestore_no_auto_restore', 10:45:06 INFO - 'tabpaint']}, 10:45:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:45:06 INFO - 'ts_paint', 10:45:06 INFO - 'tpaint', 10:45:06 INFO - 'sessionrestore', 10:45:06 INFO - 'sessionrestore_no_auto_restore', 10:45:06 INFO - 'tabpaint']}, 10:45:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:45:06 INFO - 'tests': ['a11yr', 10:45:06 INFO - 'ts_paint', 10:45:06 INFO - 'tpaint', 10:45:06 INFO - 'sessionrestore', 10:45:06 INFO - 'sessionrestore_no_auto_restore', 10:45:06 INFO - 'tabpaint']}, 10:45:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:45:06 INFO - 'tests': ['a11yr', 10:45:06 INFO - 'ts_paint', 10:45:06 INFO - 'tpaint', 10:45:06 INFO - 'sessionrestore', 10:45:06 INFO - 'sessionrestore_no_auto_restore', 10:45:06 INFO - 'tabpaint']}, 10:45:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:45:06 INFO - 'tests': ['tsvgx', 10:45:06 INFO - 'tsvgr_opacity', 10:45:06 INFO - 'tart', 10:45:06 INFO - 'tscrollx', 10:45:06 INFO - 'cart', 10:45:06 INFO - 'tsvg_static']}, 10:45:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:45:06 INFO - 'tsvgr_opacity', 10:45:06 INFO - 'tart', 10:45:06 INFO - 'tscrollx', 10:45:06 INFO - 'cart', 10:45:06 INFO - 'tsvg_static']}, 10:45:06 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:45:06 INFO - 'talos_options': ['--disable-e10s'], 10:45:06 INFO - 'tests': ['tp5o']}, 10:45:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:45:06 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:45:06 INFO - 'talos_options': ['--disable-e10s', 10:45:06 INFO - '--xperf_path', 10:45:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:45:06 INFO - 'tests': ['tp5n']}, 10:45:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:45:06 INFO - 'talos_options': ['--xperf_path', 10:45:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:45:06 INFO - 'tests': ['tp5n']}}, 10:45:06 INFO - 'talos.zip': {'path': '', 10:45:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:45:06 INFO - Running post-action listener: _resource_record_post_action 10:45:06 INFO - [mozharness: 2017-04-28 17:45:06.440276Z] Finished populate-webroot step (success) 10:45:06 INFO - [mozharness: 2017-04-28 17:45:06.440390Z] Running create-virtualenv step. 10:45:06 INFO - Running pre-action listener: _resource_record_pre_action 10:45:06 INFO - Running main action method: create_virtualenv 10:45:06 INFO - Creating virtualenv /builds/slave/test/build/venv 10:45:06 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 10:45:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:45:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:45:06 INFO - Using real prefix '/tools/python27' 10:45:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:45:07 INFO - Installing distribute.............................................................................................................................................................................................done. 10:45:10 INFO - Installing pip.................done. 10:45:10 INFO - Return code: 0 10:45:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:45:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:45:10 INFO - Reading from file tmpfile_stdout 10:45:10 INFO - Output received: 10:45:10 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) 10:45:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:45:10 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')]} 10:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:10 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')]} 10:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:10 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 0x103821b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103824768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda81c6aec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035ffd30>, '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 0x103526db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035f4be8>, '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.Wp9kd3u7V1/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.p4xSYcse9l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 10:45:10 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 10:45:10 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 10:45:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wp9kd3u7V1/Render', 10:45:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:45:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:45:10 INFO - 'HOME': '/Users/cltbld', 10:45:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:45:10 INFO - 'LOGNAME': 'cltbld', 10:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:10 INFO - 'MOZ_NO_REMOTE': '1', 10:45:10 INFO - 'NO_EM_RESTART': '1', 10:45:10 INFO - 'PAGER': '/bin/cat', 10:45:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:10 INFO - 'PWD': '/builds/slave/test', 10:45:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:45:10 INFO - 'SHELL': '/bin/bash', 10:45:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p4xSYcse9l/Listeners', 10:45:10 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 10:45:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:45:10 INFO - 'USER': 'cltbld', 10:45:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:45:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:10 INFO - 'XPC_FLAGS': '0x0', 10:45:10 INFO - 'XPC_SERVICE_NAME': '0', 10:45:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:10 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 10:45:10 INFO - Cleaning up... 10:45:10 INFO - Return code: 0 10:45:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:45:10 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')]} 10:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:10 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')]} 10:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:10 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 0x103821b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103824768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda81c6aec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035ffd30>, '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 0x103526db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035f4be8>, '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.Wp9kd3u7V1/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.p4xSYcse9l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 10:45:10 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 10:45:10 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 10:45:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wp9kd3u7V1/Render', 10:45:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:45:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:45:10 INFO - 'HOME': '/Users/cltbld', 10:45:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:45:10 INFO - 'LOGNAME': 'cltbld', 10:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:10 INFO - 'MOZ_NO_REMOTE': '1', 10:45:10 INFO - 'NO_EM_RESTART': '1', 10:45:10 INFO - 'PAGER': '/bin/cat', 10:45:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:10 INFO - 'PWD': '/builds/slave/test', 10:45:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:45:10 INFO - 'SHELL': '/bin/bash', 10:45:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p4xSYcse9l/Listeners', 10:45:10 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 10:45:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:45:10 INFO - 'USER': 'cltbld', 10:45:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:45:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:10 INFO - 'XPC_FLAGS': '0x0', 10:45:10 INFO - 'XPC_SERVICE_NAME': '0', 10:45:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:10 INFO - Downloading/unpacking psutil>=3.1.1 10:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:45:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:45:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:45:14 INFO - Installing collected packages: psutil 10:45:14 INFO - Running setup.py install for psutil 10:45:14 INFO - building 'psutil._psutil_osx' extension 10:45:14 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 10:45:15 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 10:45:15 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 10:45:15 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 10:45:15 INFO - building 'psutil._psutil_posix' extension 10:45:15 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 10:45:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:45:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:45:15 INFO - ^ 10:45:15 INFO - 1 warning generated. 10:45:15 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 10:45:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:45:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:45:15 INFO - Successfully installed psutil 10:45:15 INFO - Cleaning up... 10:45:15 INFO - Return code: 0 10:45:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:45:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:15 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 0x103821b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103824768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda81c6aec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035ffd30>, '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 0x103526db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035f4be8>, '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.Wp9kd3u7V1/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.p4xSYcse9l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 10:45:15 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 10:45:15 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 10:45:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wp9kd3u7V1/Render', 10:45:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:45:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:45:15 INFO - 'HOME': '/Users/cltbld', 10:45:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:45:15 INFO - 'LOGNAME': 'cltbld', 10:45:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:15 INFO - 'MOZ_NO_REMOTE': '1', 10:45:15 INFO - 'NO_EM_RESTART': '1', 10:45:15 INFO - 'PAGER': '/bin/cat', 10:45:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:45:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:15 INFO - 'PWD': '/builds/slave/test', 10:45:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:45:15 INFO - 'SHELL': '/bin/bash', 10:45:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p4xSYcse9l/Listeners', 10:45:15 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 10:45:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:45:15 INFO - 'USER': 'cltbld', 10:45:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:45:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:45:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:15 INFO - 'XPC_FLAGS': '0x0', 10:45:15 INFO - 'XPC_SERVICE_NAME': '0', 10:45:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:45:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:45:16 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 10:45:16 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 10:45:16 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 10:45:16 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 10:45:16 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 10:45:16 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 10:45:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:45:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:45:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:45:18 INFO - Installing collected packages: mozsystemmonitor 10:45:18 INFO - Running setup.py install for mozsystemmonitor 10:45:18 INFO - Successfully installed mozsystemmonitor 10:45:18 INFO - Cleaning up... 10:45:19 INFO - Return code: 0 10:45:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:45:19 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')]} 10:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:19 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')]} 10:45:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:19 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 0x103821b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103824768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda81c6aec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035ffd30>, '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 0x103526db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035f4be8>, '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.Wp9kd3u7V1/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.p4xSYcse9l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 10:45:19 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 10:45:19 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 10:45:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wp9kd3u7V1/Render', 10:45:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:45:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:45:19 INFO - 'HOME': '/Users/cltbld', 10:45:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:45:19 INFO - 'LOGNAME': 'cltbld', 10:45:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:19 INFO - 'MOZ_NO_REMOTE': '1', 10:45:19 INFO - 'NO_EM_RESTART': '1', 10:45:19 INFO - 'PAGER': '/bin/cat', 10:45:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:45:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:19 INFO - 'PWD': '/builds/slave/test', 10:45:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:45:19 INFO - 'SHELL': '/bin/bash', 10:45:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p4xSYcse9l/Listeners', 10:45:19 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 10:45:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:45:19 INFO - 'USER': 'cltbld', 10:45:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:45:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:45:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:19 INFO - 'XPC_FLAGS': '0x0', 10:45:19 INFO - 'XPC_SERVICE_NAME': '0', 10:45:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:45:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:19 INFO - Downloading/unpacking jsonschema==2.5.1 10:45: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 10:45: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 10:45: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 10:45: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 10:45: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 10:45: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 10:45:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:45:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:45:22 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 10:45:22 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 10:45:22 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 10:45:22 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 10:45:22 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 10:45:22 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 10:45:22 INFO - Downloading functools32-3.2.3-2.tar.gz 10:45:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:45:23 INFO - warning: no files found matching '*.txt' 10:45:23 INFO - no previously-included directories found matching 'build' 10:45:23 INFO - no previously-included directories found matching 'dist' 10:45:23 INFO - no previously-included directories found matching '.git*' 10:45:23 INFO - Installing collected packages: jsonschema, functools32 10:45:23 INFO - Running setup.py install for functools32 10:45:23 INFO - warning: no files found matching '*.txt' 10:45:23 INFO - no previously-included directories found matching 'build' 10:45:23 INFO - no previously-included directories found matching 'dist' 10:45:23 INFO - no previously-included directories found matching '.git*' 10:45:23 INFO - Successfully installed jsonschema functools32 10:45:23 INFO - Cleaning up... 10:45:23 INFO - Return code: 0 10:45:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103821b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103824768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda81c6aec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035ffd30>, '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 0x103526db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035f4be8>, '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.Wp9kd3u7V1/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.p4xSYcse9l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 10:45:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:45:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:45:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wp9kd3u7V1/Render', 10:45:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:45:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:45:23 INFO - 'HOME': '/Users/cltbld', 10:45:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:45:23 INFO - 'LOGNAME': 'cltbld', 10:45:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:23 INFO - 'MOZ_NO_REMOTE': '1', 10:45:23 INFO - 'NO_EM_RESTART': '1', 10:45:23 INFO - 'PAGER': '/bin/cat', 10:45:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:45:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:23 INFO - 'PWD': '/builds/slave/test', 10:45:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:45:23 INFO - 'SHELL': '/bin/bash', 10:45:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p4xSYcse9l/Listeners', 10:45:23 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 10:45:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:45:23 INFO - 'USER': 'cltbld', 10:45:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:45:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:45:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:23 INFO - 'XPC_FLAGS': '0x0', 10:45:23 INFO - 'XPC_SERVICE_NAME': '0', 10:45:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:45:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:45:23 INFO - Cleaning up... 10:45:23 INFO - Return code: 0 10:45:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103821b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103824768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda81c6aec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035ffd30>, '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 0x103526db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035f4be8>, '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.Wp9kd3u7V1/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.p4xSYcse9l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 10:45:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:45:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:45:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wp9kd3u7V1/Render', 10:45:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:45:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:45:23 INFO - 'HOME': '/Users/cltbld', 10:45:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:45:23 INFO - 'LOGNAME': 'cltbld', 10:45:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:23 INFO - 'MOZ_NO_REMOTE': '1', 10:45:23 INFO - 'NO_EM_RESTART': '1', 10:45:23 INFO - 'PAGER': '/bin/cat', 10:45:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:45:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:23 INFO - 'PWD': '/builds/slave/test', 10:45:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:45:23 INFO - 'SHELL': '/bin/bash', 10:45:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p4xSYcse9l/Listeners', 10:45:23 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 10:45:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:45:23 INFO - 'USER': 'cltbld', 10:45:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:45:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:45:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:23 INFO - 'XPC_FLAGS': '0x0', 10:45:23 INFO - 'XPC_SERVICE_NAME': '0', 10:45:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:45:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:23 INFO - Downloading/unpacking blobuploader==1.2.4 10:45: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 10:45: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 10:45: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 10:45: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 10:45: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 10:45: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 10:45:26 INFO - Downloading blobuploader-1.2.4.tar.gz 10:45:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:45:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:45:26 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 10:45:26 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 10:45:26 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 10:45:26 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 10:45:26 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 10:45:26 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 10:45:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:45:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:27 INFO - Downloading docopt-0.6.1.tar.gz 10:45:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:45:27 INFO - Installing collected packages: blobuploader, requests, docopt 10:45:27 INFO - Running setup.py install for blobuploader 10:45:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:45:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:45:27 INFO - Running setup.py install for requests 10:45:28 INFO - Running setup.py install for docopt 10:45:28 INFO - Successfully installed blobuploader requests docopt 10:45:28 INFO - Cleaning up... 10:45:28 INFO - Return code: 0 10:45:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:45:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:28 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 0x103821b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103824768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda81c6aec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035ffd30>, '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 0x103526db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035f4be8>, '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.Wp9kd3u7V1/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.p4xSYcse9l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 10:45:28 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 10:45:28 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 10:45:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wp9kd3u7V1/Render', 10:45:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:45:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:45:28 INFO - 'HOME': '/Users/cltbld', 10:45:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:45:28 INFO - 'LOGNAME': 'cltbld', 10:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:28 INFO - 'MOZ_NO_REMOTE': '1', 10:45:28 INFO - 'NO_EM_RESTART': '1', 10:45:28 INFO - 'PAGER': '/bin/cat', 10:45:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:28 INFO - 'PWD': '/builds/slave/test', 10:45:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:45:28 INFO - 'SHELL': '/bin/bash', 10:45:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p4xSYcse9l/Listeners', 10:45:28 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 10:45:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:45:28 INFO - 'USER': 'cltbld', 10:45:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:45:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:28 INFO - 'XPC_FLAGS': '0x0', 10:45:28 INFO - 'XPC_SERVICE_NAME': '0', 10:45:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:45:28 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-vNlwRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:45:29 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-JWiRlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:45:29 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-9RwPbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:45:29 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-xpLruP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:45:29 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-4eYbIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:45:29 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-jxJbel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:45:29 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-p0DBFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:45:29 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-2aHrZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:45:29 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-BtqevA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:45:29 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-9UhDDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:45:29 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-iHfiLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:45:30 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-ExlE3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:45:30 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-HP8mJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:45:30 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-9GMD7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:45:30 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-7juUuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:45:30 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-l2ESjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:45:30 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-dmLHRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:45:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:45:30 INFO - Running setup.py install for manifestparser 10:45:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:45:30 INFO - Running setup.py install for mozcrash 10:45:30 INFO - Running setup.py install for mozdebug 10:45:31 INFO - Running setup.py install for mozdevice 10:45:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:45:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:45:31 INFO - Running setup.py install for mozfile 10:45:31 INFO - Running setup.py install for mozhttpd 10:45:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:45:31 INFO - Running setup.py install for mozinfo 10:45:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:45:31 INFO - Running setup.py install for mozInstall 10:45:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:45:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:45:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:45:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:45:31 INFO - Running setup.py install for mozleak 10:45:32 INFO - Running setup.py install for mozlog 10:45:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:45:32 INFO - Running setup.py install for moznetwork 10:45:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:45:32 INFO - Running setup.py install for mozprocess 10:45:32 INFO - Running setup.py install for mozprofile 10:45:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:45:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:45:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:45:32 INFO - Running setup.py install for mozrunner 10:45:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:45:32 INFO - Running setup.py install for mozscreenshot 10:45:32 INFO - Running setup.py install for moztest 10:45:33 INFO - Running setup.py install for mozversion 10:45:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:45:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:45:33 INFO - Cleaning up... 10:45:33 INFO - Return code: 0 10:45:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:45:33 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')]} 10:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:33 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')]} 10:45:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:33 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 0x103821b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103824768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda81c6aec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035ffd30>, '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 0x103526db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035f4be8>, '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.Wp9kd3u7V1/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.p4xSYcse9l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 10:45:33 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 10:45:33 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 10:45:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wp9kd3u7V1/Render', 10:45:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:45:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:45:33 INFO - 'HOME': '/Users/cltbld', 10:45:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:45:33 INFO - 'LOGNAME': 'cltbld', 10:45:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:33 INFO - 'MOZ_NO_REMOTE': '1', 10:45:33 INFO - 'NO_EM_RESTART': '1', 10:45:33 INFO - 'PAGER': '/bin/cat', 10:45:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:45:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:33 INFO - 'PWD': '/builds/slave/test', 10:45:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:45:33 INFO - 'SHELL': '/bin/bash', 10:45:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p4xSYcse9l/Listeners', 10:45:33 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 10:45:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:45:33 INFO - 'USER': 'cltbld', 10:45:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:45:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:45:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:33 INFO - 'XPC_FLAGS': '0x0', 10:45:33 INFO - 'XPC_SERVICE_NAME': '0', 10:45:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:45:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:45:33 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-fzzBi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:45:33 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)) 10:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:45:33 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-YjjO1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:45:33 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)) 10:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:45:33 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-oAKaG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:45:33 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)) 10:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:45:33 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-X6AXAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:45:34 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)) 10:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:45:34 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-eqPJKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:45:34 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)) 10:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:45:34 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-EJw2ZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:45:34 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)) 10:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:45:34 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-Xfioj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:45:34 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)) 10:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:45:34 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-5jCUDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:45:34 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)) 10:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:45:34 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-JGVVcO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:45:34 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)) 10:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:45:34 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-fhcFEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:45:34 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)) 10:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:45:34 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-9rCcea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:45:34 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)) 10:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:45:34 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-pK9yey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 10:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:45:34 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-7zy_LX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:45:34 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)) 10:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:45:34 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-F4fzyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:45:35 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)) 10:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:45:35 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-Eracin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:45:35 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)) 10:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:45:35 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-t9SiAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:45:35 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)) 10:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:45:35 INFO - Running setup.py (path:/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/pip-XdLLtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:45:35 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)) 10:45:35 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)) 10:45:35 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)) 10:45:35 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)) 10:45:35 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)) 10:45:35 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)) 10:45:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:38 INFO - Downloading blessings-1.6.tar.gz 10:45:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:45:38 INFO - Installing collected packages: blessings 10:45:38 INFO - Running setup.py install for blessings 10:45:38 INFO - Successfully installed blessings 10:45:38 INFO - Cleaning up... 10:45:38 INFO - Return code: 0 10:45:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:45:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:45:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:45:38 INFO - Reading from file tmpfile_stdout 10:45:38 INFO - Current package versions: 10:45:38 INFO - blessings == 1.6 10:45:38 INFO - blobuploader == 1.2.4 10:45:38 INFO - docopt == 0.6.1 10:45:38 INFO - functools32 == 3.2.3-2 10:45:38 INFO - jsonschema == 2.5.1 10:45:38 INFO - manifestparser == 1.1 10:45:38 INFO - mozInstall == 1.12 10:45:38 INFO - mozcrash == 1.0 10:45:38 INFO - mozdebug == 0.1 10:45:38 INFO - mozdevice == 0.49 10:45:38 INFO - mozfile == 1.2 10:45:38 INFO - mozhttpd == 0.7 10:45:38 INFO - mozinfo == 0.9 10:45:38 INFO - mozleak == 0.1 10:45:38 INFO - mozlog == 3.4 10:45:38 INFO - moznetwork == 0.27 10:45:38 INFO - mozprocess == 0.25 10:45:38 INFO - mozprofile == 0.28 10:45:38 INFO - mozrunner == 6.13 10:45:38 INFO - mozscreenshot == 0.1 10:45:38 INFO - mozsystemmonitor == 0.3 10:45:38 INFO - moztest == 0.8 10:45:38 INFO - mozversion == 1.4 10:45:38 INFO - psutil == 3.1.1 10:45:38 INFO - requests == 1.2.3 10:45:38 INFO - wsgiref == 0.1.2 10:45:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:45:38 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')]} 10:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:38 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')]} 10:45:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:38 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 0x103821b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103824768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda81c6aec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035ffd30>, '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 0x103526db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035f4be8>, '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.Wp9kd3u7V1/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.p4xSYcse9l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 10:45:38 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 10:45:38 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 10:45:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wp9kd3u7V1/Render', 10:45:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:45:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:45:38 INFO - 'HOME': '/Users/cltbld', 10:45:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:45:38 INFO - 'LOGNAME': 'cltbld', 10:45:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:38 INFO - 'MOZ_NO_REMOTE': '1', 10:45:38 INFO - 'NO_EM_RESTART': '1', 10:45:38 INFO - 'PAGER': '/bin/cat', 10:45:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:45:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:38 INFO - 'PWD': '/builds/slave/test', 10:45:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:45:38 INFO - 'SHELL': '/bin/bash', 10:45:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p4xSYcse9l/Listeners', 10:45:38 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 10:45:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:45:38 INFO - 'USER': 'cltbld', 10:45:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:45:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:45:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:38 INFO - 'XPC_FLAGS': '0x0', 10:45:38 INFO - 'XPC_SERVICE_NAME': '0', 10:45:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:45:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:38 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)) 10:45:38 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)) 10:45:38 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)) 10:45:38 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)) 10:45:38 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)) 10:45:38 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)) 10:45:38 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)) 10:45:38 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)) 10:45:38 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)) 10:45:38 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)) 10:45:38 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)) 10:45:38 INFO - Cleaning up... 10:45:38 INFO - Return code: 0 10:45:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:45:38 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')]} 10:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:38 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')]} 10:45:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:38 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 0x103821b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103824768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda81c6aec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035ffd30>, '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 0x103526db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035f4be8>, '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.Wp9kd3u7V1/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.p4xSYcse9l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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 10:45:38 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 10:45:38 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 10:45:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wp9kd3u7V1/Render', 10:45:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:45:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:45:39 INFO - 'HOME': '/Users/cltbld', 10:45:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:45:39 INFO - 'LOGNAME': 'cltbld', 10:45:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:39 INFO - 'MOZ_NO_REMOTE': '1', 10:45:39 INFO - 'NO_EM_RESTART': '1', 10:45:39 INFO - 'PAGER': '/bin/cat', 10:45:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:45:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:39 INFO - 'PWD': '/builds/slave/test', 10:45:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:45:39 INFO - 'SHELL': '/bin/bash', 10:45:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p4xSYcse9l/Listeners', 10:45:39 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 10:45:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:45:39 INFO - 'USER': 'cltbld', 10:45:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:45:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:45:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:39 INFO - 'XPC_FLAGS': '0x0', 10:45:39 INFO - 'XPC_SERVICE_NAME': '0', 10:45:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:45:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:45:39 INFO - Cleaning up... 10:45:39 INFO - Return code: 0 10:45:39 INFO - Running post-action listener: _resource_record_post_action 10:45:39 INFO - Running post-action listener: _start_resource_monitoring 10:45:39 INFO - Starting resource monitoring. 10:45:39 INFO - [mozharness: 2017-04-28 17:45:39.290548Z] Finished create-virtualenv step (success) 10:45:39 INFO - [mozharness: 2017-04-28 17:45:39.291512Z] Running install step. 10:45:39 INFO - Running pre-action listener: _resource_record_pre_action 10:45:39 INFO - Running main action method: install 10:45:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:45:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:45:39 INFO - Reading from file tmpfile_stdout 10:45:39 INFO - Detecting whether we're running mozinstall >=1.0... 10:45:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:45:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:45:39 INFO - Reading from file tmpfile_stdout 10:45:39 INFO - Output received: 10:45:39 INFO - Usage: mozinstall [options] installer 10:45:39 INFO - Options: 10:45:39 INFO - -h, --help show this help message and exit 10:45:39 INFO - -d DEST, --destination=DEST 10:45:39 INFO - Directory to install application into. [default: 10:45:39 INFO - "/builds/slave/test"] 10:45:39 INFO - --app=APP Application being installed. [default: firefox] 10:45:39 INFO - mkdir: /builds/slave/test/build/application 10:45:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:45:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 10:45:54 INFO - Reading from file tmpfile_stdout 10:45:54 INFO - Output received: 10:45:54 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:45:54 INFO - Running post-action listener: _resource_record_post_action 10:45:54 INFO - [mozharness: 2017-04-28 17:45:54.419194Z] Finished install step (success) 10:45:54 INFO - [mozharness: 2017-04-28 17:45:54.419338Z] Running run-tests step. 10:45:54 INFO - Running pre-action listener: _resource_record_pre_action 10:45:54 INFO - Running main action method: run_tests 10:45:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:45:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:45:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:45:54 INFO - 2017-04-28 10:45:54.434 screenresolution[1628:7391] starting screenresolution argv=screenresolution get 10:45:54 INFO - 2017-04-28 10:45:54.437 screenresolution[1628:7391] Display 0: 1600x1200x32@60 10:45:54 INFO - 2017-04-28 10:45:54.442 screenresolution[1629:7393] starting screenresolution argv=screenresolution list 10:45:54 INFO - Available Modes on Display 0 10:45:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:45:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:45:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:45:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:45:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:45:54 INFO - Intel Iris: 10:45:54 INFO - Chipset Model: Intel Iris 10:45:54 INFO - Type: GPU 10:45:54 INFO - Bus: Built-In 10:45:54 INFO - VRAM (Dynamic, Max): 1536 MB 10:45:54 INFO - Vendor: Intel (0x8086) 10:45:54 INFO - Device ID: 0x0a2e 10:45:54 INFO - Revision ID: 0x0009 10:45:54 INFO - Displays: 10:45:54 INFO - Display: 10:45:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:45:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:45:54 INFO - Display Serial Number: 1600x1200 60 10:45:54 INFO - Main Display: Yes 10:45:54 INFO - Mirror: Off 10:45:54 INFO - Online: Yes 10:45:54 INFO - Rotation: Supported 10:45:54 INFO - Return code: 0 10:45:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:45:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:45:54 INFO - Python 2.7.3 10:45:54 INFO - Return code: 0 10:45:54 INFO - grabbing minidump binary from tooltool 10:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:54 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 0x1035ffd30>, '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 0x103526db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035f4be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:45:54 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 10:45:54 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 10:45:54 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 10:45:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:45:54 INFO - Return code: 0 10:45:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:45:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:45:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:45:54 INFO - ENV: RUST_BACKTRACE is now 1 10:45:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:45:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:45:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZZoVjBL0TqyzLHY8hv-T3g/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0039', '--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 10:45:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZZoVjBL0TqyzLHY8hv-T3g/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0039 --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 10:45:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wp9kd3u7V1/Render', 10:45:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:45:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:45:54 INFO - 'HOME': '/Users/cltbld', 10:45:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:45:54 INFO - 'LOGNAME': 'cltbld', 10:45:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:45:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:45:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:54 INFO - 'MOZ_NO_REMOTE': '1', 10:45:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:45:54 INFO - 'NO_EM_RESTART': '1', 10:45:54 INFO - 'PAGER': '/bin/cat', 10:45:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:45:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:54 INFO - 'PWD': '/builds/slave/test', 10:45:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:45:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:45:54 INFO - 'RUST_BACKTRACE': '1', 10:45:54 INFO - 'SHELL': '/bin/bash', 10:45:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p4xSYcse9l/Listeners', 10:45:54 INFO - 'TMPDIR': '/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/', 10:45:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:45:54 INFO - 'USER': 'cltbld', 10:45:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:45:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:45:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:54 INFO - 'XPC_FLAGS': '0x0', 10:45:54 INFO - 'XPC_SERVICE_NAME': '0', 10:45:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:45:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZZoVjBL0TqyzLHY8hv-T3g/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0039', '--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 10:45:55 INFO - mozversion application_buildid: 20170428091122 10:45:55 INFO - mozversion application_changeset: 016390ad9e5c1f43f8a51ff9e212bb46e28def3e 10:45:55 INFO - mozversion application_display_name: Firefox 10:45:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:45:55 INFO - mozversion application_name: Firefox 10:45:55 INFO - mozversion application_remotingname: firefox 10:45:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:45:55 INFO - mozversion application_vendor: Mozilla 10:45:55 INFO - mozversion application_version: 54.0 10:45:55 INFO - mozversion platform_buildid: 20170428091122 10:45:55 INFO - mozversion platform_changeset: 016390ad9e5c1f43f8a51ff9e212bb46e28def3e 10:45:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:45:55 INFO - mozversion platform_version: 54.0 10:45:55 INFO - using testdate: 1493401555 10:45:55 INFO - actual date: 1493401555 10:45:55 INFO - starting webserver on 'localhost:49235' 10:45:55 INFO - SUITE-START | Running 2 tests 10:45:55 INFO - TEST-START | dromaeo_css 10:45:55 INFO - operating with platform_type : mac_ 10:45:55 INFO - Initialising browser for dromaeo_css test... 10:45:55 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/tmpp22tMQ/profile http://localhost:49235/getInfo.html) 10:45:57 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 10:45:57 INFO - PROCESS | 1639 | colorDepth:24 10:45:57 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 10:45:57 INFO - PROCESS | 1639 | __metrics 10:45:57 INFO - PROCESS | 1639 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:45:57 INFO - PROCESS | 1639 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:45:58 INFO - TEST-INFO | 1639: exit 0 10:45:58 INFO - Browser initialized. 10:45:58 INFO - Running cycle 1/1 for dromaeo_css test... 10:45:58 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/tmpp22tMQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:46:10 INFO - PROCESS | 1642 | RSS: Main: 169496576 10:46:10 INFO - PROCESS | 1642 | 10:49:13 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 10:49:15 INFO - PROCESS | 1642 | RSS: Main: 311300096 10:49:15 INFO - PROCESS | 1642 | 10:52:18 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 10:52:18 INFO - PROCESS | 1642 | RSS: Main: 299368448 10:52:18 INFO - PROCESS | 1642 | 10:55:21 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 10:55:21 INFO - PROCESS | 1642 | RSS: Main: 296550400 10:55:21 INFO - PROCESS | 1642 | 10:58:24 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 10:58:25 INFO - PROCESS | 1642 | RSS: Main: 281481216 10:58:25 INFO - PROCESS | 1642 | 11:01:28 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 11:01:28 INFO - PROCESS | 1642 | RSS: Main: 281718784 11:01:28 INFO - PROCESS | 1642 | 11:04:32 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 11:04:32 INFO - PROCESS | 1642 | RSS: Main: 322191360 11:04:32 INFO - PROCESS | 1642 | 11:04:32 INFO - PROCESS | 1642 | __start_tp_report 11:04:32 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 11:04:32 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 11:04:32 INFO - PROCESS | 1642 | |i|pagename|runs| 11:04:32 INFO - PROCESS | 1642 | |0;dojo.html;2891.927701807456;3477.913052173696;3486.843092060857;3508.386032444325;3545.2377738786154;5985.940140598593;6006.129111278862;6035.668038257894;6066.7876624318105;6087.11736798164;5957.344692083867;6012.398760123985;6014.398560143984;6030.909536356947;6031.72857221425;5298.708571028592;5306.548943339811;5326.201069839516;5331.386890507583;5447.373552041507;5180.274761533388;5195.766190521435;5199.636025478199;5429.0227759003365;5474.534664553517;5265.684058956455;5276.3668359796875;5281.551068159192;5282.867928301804;5283.392409872876;5245.711485868275;5246.658967167122;5249.107651699221;5255.054090263751;5256.710880901549;5133.230015497668;5216.947830521684;5226.947730522722;5233.947660523384;5263.315768950012;5904.143899134601;5913.8817223655715;5916.645001299893;5917.378675239081;5928.347881733006;6230.221222347207;6248.187735594343;6259.749610015594;6268.1851359323455;6270.561060725751;6353.872922541569;6370.745170193187;6374.139491168679;6384.744610215585;6388.872222555523;6028.457438830526;6031.517478601701;6033.607815491979;6052.455279024909;6056.000759874615;6279.215098112736;6318.7472501100365;6395.904061439082;6541.672916354163;6549.2468366137555;6221.2845522764555;6277.340879207617;6280.654563999024;6285.371462853678;6290.622562646256;6409.294977552466;6421.357864213542;6425;6428.228612566429;6429.003504456817;6186.1648677427975;6321.273053598803;6339;6345.333739957238;6354.682265886687;5180.248863914711;6107.977837958671;6205.410486003822;6219;6270.749170033238;5105;5121.129408000649;5123.103456895028;5128.435872054071;5148.613853960968;4544.431946006749;4550.226461501553;4566.95433045672;4573.885652858705;4574.4968053514085;5823.912641310384;5914;5949.1076338549565;5969.970150149222;5978.461938425563;6240.157578726905;6271.843203919847;6291.591046581958;6292.811215663537;6332.556721029576;6105.267367915879;6120.418560236771;6121.418465245794;6129.08063790435;6134.539909506805;5511.421300763443;5552.056150454432;5568.470995255444;5572.832815015556;5580.386157522669;6328.71520781566;6374.808755737336;6581;6618.933810661928;6637.2699003108655;6401.359864013748;6427.58220715652;6427.935720642734;6442.645654488861;6444.709988050456;6591.670416479253;6652.368025037614;6653.700583473658;6677.899831502435;6687.130673012477;6206.565540412128;6217.595856269328;6233.158523599256;6378.298387177314;6383.585066970632;6318.810435686937;6352.618842869442;6356.809295721136;6359.268684101387;6381.521385896169;6071.908921366271;6213.440790328892;6292.559520833498;6292.874142517216;6298.118263443213;6105.358937311518;6222.844428889314;6230.470410015018;6272.6236425814595;6288.056791481132;6039.5470339723815;6124.89972046314;6152.876942461216;6159.84600384994;6177.980633195652;6286.559940804283;6299.212598425197;6302.180716506825;6309.148264984168;6316.021016742412;5847.26909136358;5872.442117998783;5886.146508756292;6127.325994140552;6171.228596425447 11:04:32 INFO - PROCESS | 1642 | |1;ext.html;771.8764997600385;792.5918152151643;814.6904176412962;835.6657337065174;900.1403659505173;25501.872490637543;29671.109866704006;32485.67514324856;39166.60833391665;40112.39831402531;42306;42485.78757106218;42516.78741606288;42530.787346063305;42616;9583.760405989837;9748.220142388627;9748.415095094282;9748.90251097487;9769.316147869651;7906;8062.475939063971;9617.134457898788;11562.421878906021;11743.354115523643;11763.647090587254;11862.584809531669;11898.04815614753;11903.821442678367;11905.7618847623;11800.232984856;11818.940905295505;11836.171467997243;11840.703982400422;11850.40747962607;11400;11441.084713223005;11455.255408398427;11455.369954652491;11458.026067784249;40241.99395015119;40273.798631006954;40299.59700403017;40331.395029074585;40418.78743637696;3985.6811455083525;4039.4748682671066;4057.4116753070934;4063.5123785145674;4090.5091389033505;28193.577096343368;28311;29545.70454295451;30471;30543.69456305431;3179.6184457864974;3288.32589319189;3359.328134373135;3406.914827129317;3420.6921377075932;344238.9999999975;369582;372073;372884.1355793231;374293;54313.45686543163;54444.18333724918;54544.72727636416;54560.454395456334;54583;56602.7169864148;56645.7167714167;56711;56723.43276567264;56815;15648;15726.21368931549;15735.977161484696;15745.212739363214;15753.527394178192;13315.733685326239;13318.667033324244;13328.666783330495;13329.866701332863;13335.866641333656;10971.012608865081;11154.609588664358;11333.546658133582;12540.934020608169;14335;5175.430702622709;5229.405031465363;6252.124702541648;6252.468540174136;6299.842503937438;1146.3465824480134;1177.5937301630925;1181.1908842442954;1191.4876603060768;1228.2200802490484;27176.864115679295;27452.450950980867;27621.03326383567;27628.30929226745;27740.02909898144;854.9700760473354;1158.3802665574046;1190.3334132885611;1296.0992110483123;1356.8236129303127;14914.850851491346;15061.548153555412;15336.693266134615;15392.230388480755;15410.460633877761;399855;408864.9556752197;425667;428117;429629;46282.537174628495;46787.298190527166;56235.71882140563;57726.134107988415;58528;1521.9315130819139;1557.680675461505;1561.7423125184218;1576.3064251728972;1580.6048487878031;28383.716162838107;29891.103266902028;31340.216494587818;31500.89746858849;31519.527207091454;49073.75463122661;49193.75403122961;49194.75402622964;49327.753361232964;49342.25986610276;504516;514297;526674.3666281644;534697;653044;36167.095822603595;36694.8165259172;36799;37049.88850334494;37506.24987500289;45370.773146135376;45845.62463126112;46130;46626.53373466358;46901.530984689714;31237;31468.055958321285;31618.367632647678;32584.674153258165;32875.50686739653;31377;31555.52666709955;31574.368512630077;32200.516992244666;32478.837605812765;32767.344653106327;36036.81981590075;36054.4591831128;36851.262974740894;36992;27613;28288.00991965271;28881.277968050967;29826;29949.85025074861;23526.529469410172;23583.702896340867;24038.63942040836;24083.853018319976;24259.02963881425 11:04:32 INFO - PROCESS | 1642 | |2;jquery.html;430.86643140626387;438.0603605266703;445.1275500019961;450.6575002997721;452.4751288505334;20397.898010509965;21500.354989350304;22821.657675134888;22865.54268914621;22889.542209155807;23418.765812341873;23960;24344.174186936005;24525.77371131445;24768.504629907435;7078.973548835415;7106.467014973872;7203.81990450239;7253.129624445074;7329.450291228152;7124.109486314211;7251.7461888833905;7267;7271.309225623558;7275.527090739111;6205.720742566596;7118.430525557943;8312.542810145469;8316.459430137053;8319.875201871977;8013.639386227634;8122.675092996273;8125.187481251886;8159.143289954558;8234.258916697467;7527.924720752777;7678.117016543058;7932.801679957989;7953.045634523836;8002.119766825645;26712.46575068507;27649.447011059867;27972.300692482648;28038.579421308696;28191.295217619518;3037.2255074955965;3049.84750762461;3132.7650426217897;3159.1470303018286;3332.8333583320737;16304.83695163045;16421.01473911569;16669.24988375526;16684.249208785634;17221.225044873012;1663.8169801321844;2197.3517812245427;2241.652543855705;2294.7590502997277;2318.142287353673;172182.68534471944;174454.12772936054;177879;178852;180683.67607133687;20132.89269090185;20862.582748344947;20925;21069.683954740693;21083.051262693214;33294.66705332964;33304;33306.3338733224;33329.166770830925;33334.16664583405;8439.66241350339;10683.62607308756;10911.127109831194;10953.288036277616;11034.337939723482;9067.591958361889;9083.772905677411;9089.409188402733;9226.677066302782;9265.629374824932;9061.705524132296;9341.159295663423;9462.101100395452;9463.262011505554;9497.952510237405;3255.283837555734;3270.640229574745;3440.70753985909;3848.230353929225;3913.354296541039;917.417439925652;935.1350001248818;940;947.190152419685;948.9952550237205;20710.275140370013;20759;22561.323160304888;24765;24975.250742477754;1074.6829685242872;1123.9325640461598;1135.28477059452;1165.341582006164;1178.1988247991449;11186.32882027081;11447.942760286145;11686;11687.824682629767;11758.823617645741;739603;761091;788883;805833;812473;157370;163731;166174.50738238936;166416;168933;1293.7606542789426;1331.8534961154264;1359.9388027538587;1361.9727605447836;1363.3387806913638;18994.335198267996;19006.524836879187;19217.8078219216;19362.225510979966;19381.70927436118;64731.02903456358;66038.68864589909;66197.66901165464;67336.326636733;67580.66209668921;93369.13261734863;94635;96594.51702741442;96639.51680241554;96669.033309666;10605.522751476356;11403.942980285046;11812.940935295268;12161.635150945485;12289.446974885972;12906.548270810477;12945.28800915921;13352.332383380986;13534.93232533831;13670.93164534171;11624.011958983581;11875.228110172811;11937.328773971478;11995.76008479843;12036.819447708116;7000.47496437759;10828.837567436338;10893.400862952614;11028.944855275673;11079.83380249313;11683.766324673288;11915;11944.64166075019;12012.519499219934;12018;11684.766304674029;11761.470733816828;11993.520259189534;12074.577389791315;12088.75822483563;11503.769924601294;11564.768704626029;11572.958433741003;11934.52261909514;11943.76112477763 11:04:32 INFO - PROCESS | 1642 | |3;mootools.html;1342.3154191362403;1408.5774267719682;1644.465548696673;1649.9917500412503;1654.1067823375379;9580.185684216842;10005.649802256923;10021.799564008716;10198.286119971586;10199.18406527478;9943.850842237372;11044.558217671283;11336.943315283412;11461.31232126073;11536.826947595793;2475.7029156501244;2516.119358224625;2517.785988191006;2522.6216067589826;2528.5575024370755;2061.680439531875;2409.2531315292226;2473.802095832329;2481.6153496208026;2482.2801387597574;2104.7684754676975;2185.5956648020087;2393.3777217923293;2469.506098780242;2469.6663801547143;2457.2751038443703;2481.4292712676097;2486.105002199207;2488.315713178872;2491.3771557110813;2458.1887976967737;2465.654808326836;2466.7409921958297;2471.8146139039645;2473.3940184654693;11485.770284594262;11521.769564608745;11635.883641163564;11637.70905727355;11639.418029098595;5969.194158788551;6161.353057928943;6162.198914141178;6162.8767424651705;6173.259208894917;2790.8185967912023;3520.612732599412;3611.693006094485;3833.195029043904;3834.616538346171;1231.4950870143198;1252.843394575678;1272.580048583965;1280.4366078925243;1291.1349395904672;15942.043477391278;16043;16048.197590120448;16056.678866422722;16087.034777913363;4843.806247750051;5078.822241221539;5121.769520371592;5191.792328306826;5205.115130427836;13263.73472530544;13270.071095023255;13275.73448531024;13276.468941242241;13284;6187.102870083812;6188.381161883775;6188.907166392508;6192.659403732748;6194.287656919512;4556.681032327705;4737.3130896020575;5509.421510741395;5531.585131115183;5563.165525171256;3597.5143355647174;4131.607497287753;4219.240536703362;4300.397944287803;4352.717073390283;1164.67971307891;1164.714644912002;1165.9650210493699;1179.8112302031634;1181.7400171962154;918.1415376622746;921.7004473546124;981.2248323824242;991.8760154980628;1042.4475028235047;6799.524033317621;6855.245922948472;6912.55068420551;7014.824629384204;7045.330693584101;882.5410786391169;987.3878195518681;1004.7789486313;1012.6759436980095;1020.3979652005353;3673.0082877623427;4059.188162367538;4174.603412675791;4262.680298977527;4350.0212452198;13926.164430134224;14298.928505357615;14439.711205775826;14454.494092706705;14471.986960912634;13812;14019.579412617637;14319.997600167888;14338.784918226234;14387.92806035963;10308;10519.89480105189;10586.470676466146;10673.946630266799;10677.62628308021;6691.631960242234;6788.25329213796;6805.421539169226;6842.623655698984;6881.380675739208;12626.305553194295;12862;12871.935640321739;12887.742245155232;12888.291143987171;12818.61544153677;12882.67793305175;12905.290209038218;13161.802572961606;13272.469101235842;8193.221643943816;8434.198751118634;9118.726438206864;9253.352265341362;9453.763655908657;10732;10767.838482422614;10875.129989600971;10877.347359158475;10897.618583349546;9101.271898248257;9127.817443650956;9148.45109293418;9174.954125229331;9247.12152345526;7453.850922981618;8741.694040708544;8857.379983401357;8915.37592368528;8962.507062111386;8122.878156827534;8140.715074972348;8168.224018718212;8262.049864265686;8265.752027439186;5932.762689492372;6026.15633811258;6129.816105516842;6274.905876411949;6289.779857705142;6269.561130720988;6305.337939516285;6426.3573642635365;6468.5472016958365;6513.641749703622 11:04:32 INFO - PROCESS | 1642 | |4;prototype.html;372.8527231743463;389.4819889546903;389.6084435142681;397.8786470126612;399.3191608307835;4252.638525725313;4387.968827325576;5002.849914502566;5039.848804535861;5040.5211504907065;4142.647874930627;4753.287006948959;4830.188679245283;4874.756262186894;5059.468755780646;3374.476956071807;3631.6186800385976;3930.390789427629;3998.940280825569;4004.7597144171295;3372.162171616475;4008.4588580541545;4028.7179897407195;4032.072623296629;4037.919241615166;3251.7723759336855;4016.6184212499766;4020.7989600520004;4049.800657480587;4080.489938757655;3403.6596340366013;3748.8875333740166;3922.215556888605;3995.862213715648;4044.8179831907637;3372.274960883422;3380.171857894807;3507.7722797021092;3545.3618348697223;3580.5856686608904;4105.630493255621;4251.893702657428;4343.762962074534;4961.578265847371;5032.3961124665275;4439.911201775946;4572.933205786949;4576.588107070346;4605.976970115162;4643.822138315787;4390.626796722282;4808.975955120237;4941.455150597445;5273.965416456414;5397.410721869952;3303.653116422765;3995.7613139926716;4009.258287216874;4009.8195581198624;4022.2357752027315;4754;4967.243180035079;5550.72246387679;5638.830835074954;5660.462256085665;4286.72136311145;4652.62778977681;4792.305115758265;4859.299245264129;4894.412670479565;4934.593640812352;4951.925721114186;4957.801687932514;4963.776630051656;4971.701697898137;4553.385292985405;4919.7540122993705;5109.463506331856;5153.861147623769;5187.584993200535;4596.885787220419;4656.743879086683;4759.334772527396;4809.807607695653;5188.3162954302115;1457.6210185351672;1526.7099251142247;1534.4092524377972;1547.582152818755;1662.7755253040928;1192.9164958452825;1289.5164313382481;1338.136901698399;1338.380559522988;1381.6338670252392;4220.6412454941055;4306.0311429928015;4351.891202719958;5125.9743701282005;5174.223866419992;4829.9034019319415;5519.917201241985;5532.5297349724915;5589;5608.747606357723;4744.3595114659765;4895.657303988686;5076.36545431821;5151.97424012885;5165.151961788417;2588.951474652731;2624.2127361791386;2740.6026126211586;2779.444111177732;2814.3114131521334;4812.278158276286;5077.568406685399;5309.681419114865;5320.627556071116;5384.946150538444;5668.744906479218;5670.5463562914865;5706.514946229534;5775.6138526753275;5795;4641.6518761092375;4875.90248195027;5433.972830135824;5548.889022219614;5612.747426365823;5213.165893457029;5593.098346562188;5616.3260408749575;5652.689102099424;5669.448748063305;5030.899382012412;5166.535011848951;5310.044192045314;5521.723913804374;5541.972290138524;5602.299712535933;5755.97122014404;5783.739731712168;5919.868847215085;5937.150167919336;4826.469088400343;4903.901921961612;4929;4931.950680493293;4974.7512624369365;5280.673175899159;5571.415001424792;5610.877824435211;5639.574982757454;5725.885482290414;5459.890802184013;5504.6421982571;5509.641873278224;5529.751161197675;5539.833804985857;5241.711705856214;5280.5181564664545;5483.643563168382;5499.322706574533;5511.346596021258;5020.748962551785;5202.73986300691;5340.519353258225;5347.224652425454;5373.919391209213;4713.797981514692;5460.890782184413;5511.283533140666;5513.779448822002;5536.806211782568;4334.501532323697;4855.174620314626;4983.177775667119;5274.204671524099;5316.441773613869 11:04:32 INFO - PROCESS | 1642 | |5;yui.html;767.0526899279392;800.2837460472873;806.8103995561046;847.7922908887323;887.7248053103536;15379.384824607016;16623.418180363675;16632.417865374715;16634.916825415872;16661;15694.450694225705;15834.4457943972;16175.757363639555;16220.675586488263;16561.25474353654;951.6050838901847;979.0063085967713;979.8089372572351;981.9116279534841;981.950902454878;978.4569563892037;994.6170724271171;1002.6240159940022;1005.095414127284;1009.4195837393492;1071.201954543862;1073.88187299397;1074.1406874500408;1074.350018238966;1074.457399013497;1067.5516283161091;1068.2789117345799;1069.176733914889;1069.2141276162015;1069.4545781651375;793.0325003495726;793.1949071692237;794.7933537280348;795.2723258218723;795.3915254830059;17561;17573.20920558578;17654.911725441292;18358.449246522625;18681.972491512963;14854;14985.850141498555;15063.246837658184;15084.39662413502;15508.844911550967;11871.169018168732;12118.39408029595;12147.757044859054;12191.207571507824;12470;3783.375743002401;3837.597052309495;3993.221321842242;4081.69387295954;4090.6931980101613;48609;79752;107548.462257689;108278.91721082767;110168.4491577545;12046.277223366451;12286.569970051005;12295.815562766566;12416.408823235744;12934.805977910339;22013.66979495309;26775.86612066927;26987.190384288504;27614.033508827095;27629.861850690617;8217.517254401062;8259.463134896332;8354.665813367397;8519.914800852037;8537.231649151607;4662.109044591041;4734.881627959328;4766.285057241442;4797.616190704735;4921.975390123098;3297.1427428868665;3412.112850658797;3463.0303515015835;3479.251960828434;3482.8606855725993;629.197772839624;641.9197600299963;656.8522082531488;672.2336536348566;676.2358534855582;575.815738963536;689.4036658290543;713.375796178344;733.0690023670016;764.2739397572218;9549.474778887088;10730.463476826128;10899.727506812234;11039.503222355013;11466.94266528662;675.5001299038676;724.5942272327513;725.8301060407885;736.2159300345115;741.1365758890831;4832.879178020507;5072;5110.412302585176;5126.15418455958;5169.974150129226;93007.53496232476;110491.44754276177;115412;116414.41792790982;117470.8252917477;61516.38483615107;64477.355226448075;83349.58325208456;84517.57741211378;100436;77705.61147194228;78437.60781196058;80060.79908801372;81094.18905811102;81263.5936820312;10971.122310215324;11145.832812507657;11501.769964600828;11511.251768635011;11541.769164616493;50937;51213.74393128011;51940.48059519356;52381;53137.7343113282;52154.6530406125;64770.40879954032;65134;65793;67460;13697.315134243048;14042.78935815984;14270.71458570802;14822.110673359633;14982.850171498145;14686;14694.191819450032;15404.614884627974;15532.456364027204;15564.84435155634;14039.719205615625;14364.85635143677;14552.054116482395;14923;15231.466898658493;13782.821584211477;13943.651408714457;14519;14804.963652544218;14961.551153465414;14092.929535352258;14262.928685356506;14451.940551171218;14637.75579075748;14755.262236887898;10649.148068154374;10654.774011439582;10975.560977560808;11276.661700149009;11277.210595258253;10968.287061340987;11429.371384573928;11751.588694395656;11853.822192666945;11857 11:04:32 INFO - PROCESS | 1642 | __end_tp_report 11:04:32 INFO - PROCESS | 1642 | __start_cc_report 11:04:32 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,1424 11:04:32 INFO - PROCESS | 1642 | __end_cc_report 11:04:32 INFO - PROCESS | 1642 | __startTimestamp1493402672516__endTimestamp 11:04:32 INFO - PROCESS | 1642 | 11:04:32 INFO - PROCESS | 1642 | ------- Summary: start ------- 11:04:32 INFO - PROCESS | 1642 | Number of tests: 6 11:04:32 INFO - PROCESS | 1642 | 11:04:32 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5893.66 Median:6127.33 stddev:667.15 (10.9%) stddev-sans-first:626.26 11:04:32 INFO - PROCESS | 1642 | Values: 2891.9 3477.9 3486.8 3508.4 3545.2 5985.9 6006.1 6035.7 6066.8 6087.1 5957.3 6012.4 6014.4 6030.9 6031.7 5298.7 5306.5 5326.2 5331.4 5447.4 5180.3 5195.8 5199.6 5429.0 5474.5 5265.7 5276.4 5281.6 5282.9 5283.4 5245.7 5246.7 5249.1 5255.1 5256.7 5133.2 5216.9 5226.9 5233.9 5263.3 5904.1 5913.9 5916.6 5917.4 5928.3 6230.2 6248.2 6259.7 6268.2 6270.6 6353.9 6370.7 6374.1 6384.7 6388.9 6028.5 6031.5 6033.6 6052.5 6056.0 6279.2 6318.7 6395.9 6541.7 6549.2 6221.3 6277.3 6280.7 6285.4 6290.6 6409.3 6421.4 6425.0 6428.2 6429.0 6186.2 6321.3 6339.0 6345.3 6354.7 5180.2 6108.0 6205.4 6219.0 6270.7 5105.0 5121.1 5123.1 5128.4 5148.6 4544.4 4550.2 4567.0 4573.9 4574.5 5823.9 5914.0 5949.1 5970.0 5978.5 6240.2 6271.8 6291.6 6292.8 6332.6 6105.3 6120.4 6121.4 6129.1 6134.5 5511.4 5552.1 5568.5 5572.8 5580.4 6328.7 6374.8 6581.0 6618.9 6637.3 6401.4 6427.6 6427.9 6442.6 6444.7 6591.7 6652.4 6653.7 6677.9 6687.1 6206.6 6217.6 6233.2 6378.3 6383.6 6318.8 6352.6 6356.8 6359.3 6381.5 6071.9 6213.4 6292.6 6292.9 6298.1 6105.4 6222.8 6230.5 6272.6 6288.1 6039.5 6124.9 6152.9 6159.8 6178.0 6286.6 6299.2 6302.2 6309.1 6316.0 5847.3 5872.4 5886.1 6127.3 6171.2 11:04:32 INFO - PROCESS | 1642 | 11:04:32 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:58699.02 Median:18081.92 stddev:120027.20 (663.8%) stddev-sans-first:120285.11 11:04:32 INFO - PROCESS | 1642 | Values: 771.9 792.6 814.7 835.7 900.1 25501.9 29671.1 32485.7 39166.6 40112.4 42306.0 42485.8 42516.8 42530.8 42616.0 9583.8 9748.2 9748.4 9748.9 9769.3 7906.0 8062.5 9617.1 11562.4 11743.4 11763.6 11862.6 11898.0 11903.8 11905.8 11800.2 11818.9 11836.2 11840.7 11850.4 11400.0 11441.1 11455.3 11455.4 11458.0 40242.0 40273.8 40299.6 40331.4 40418.8 3985.7 4039.5 4057.4 4063.5 4090.5 28193.6 28311.0 29545.7 30471.0 30543.7 3179.6 3288.3 3359.3 3406.9 3420.7 344239.0 369582.0 372073.0 372884.1 374293.0 54313.5 54444.2 54544.7 54560.5 54583.0 56602.7 56645.7 56711.0 56723.4 56815.0 15648.0 15726.2 15736.0 15745.2 15753.5 13315.7 13318.7 13328.7 13329.9 13335.9 10971.0 11154.6 11333.5 12540.9 14335.0 5175.4 5229.4 6252.1 6252.5 6299.8 1146.3 1177.6 1181.2 1191.5 1228.2 27176.9 27452.5 27621.0 27628.3 27740.0 855.0 1158.4 1190.3 1296.1 1356.8 14914.9 15061.5 15336.7 15392.2 15410.5 399855.0 408865.0 425667.0 428117.0 429629.0 46282.5 46787.3 56235.7 57726.1 58528.0 1521.9 1557.7 1561.7 1576.3 1580.6 28383.7 29891.1 31340.2 31500.9 31519.5 49073.8 49193.8 49194.8 49327.8 49342.3 504516.0 514297.0 526674.4 534697.0 653044.0 36167.1 36694.8 36799.0 37049.9 37506.2 45370.8 45845.6 46130.0 46626.5 46901.5 31237.0 31468.1 31618.4 32584.7 32875.5 31377.0 31555.5 31574.4 32200.5 32478.8 32767.3 36036.8 36054.5 36851.3 36992.0 27613.0 28288.0 28881.3 29826.0 29949.9 23526.5 23583.7 24038.6 24083.9 24259.0 11:04:32 INFO - PROCESS | 1642 | 11:04:32 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:45704.14 Median:12868.45 stddev:131024.06 (1018.2%) stddev-sans-first:131347.52 11:04:32 INFO - PROCESS | 1642 | Values: 430.9 438.1 445.1 450.7 452.5 20397.9 21500.4 22821.7 22865.5 22889.5 23418.8 23960.0 24344.2 24525.8 24768.5 7079.0 7106.5 7203.8 7253.1 7329.5 7124.1 7251.7 7267.0 7271.3 7275.5 6205.7 7118.4 8312.5 8316.5 8319.9 8013.6 8122.7 8125.2 8159.1 8234.3 7527.9 7678.1 7932.8 7953.0 8002.1 26712.5 27649.4 27972.3 28038.6 28191.3 3037.2 3049.8 3132.8 3159.1 3332.8 16304.8 16421.0 16669.2 16684.2 17221.2 1663.8 2197.4 2241.7 2294.8 2318.1 172182.7 174454.1 177879.0 178852.0 180683.7 20132.9 20862.6 20925.0 21069.7 21083.1 33294.7 33304.0 33306.3 33329.2 33334.2 8439.7 10683.6 10911.1 10953.3 11034.3 9067.6 9083.8 9089.4 9226.7 9265.6 9061.7 9341.2 9462.1 9463.3 9498.0 3255.3 3270.6 3440.7 3848.2 3913.4 917.4 935.1 940.0 947.2 949.0 20710.3 20759.0 22561.3 24765.0 24975.3 1074.7 1123.9 1135.3 1165.3 1178.2 11186.3 11447.9 11686.0 11687.8 11758.8 739603.0 761091.0 788883.0 805833.0 812473.0 157370.0 163731.0 166174.5 166416.0 168933.0 1293.8 1331.9 1359.9 1362.0 1363.3 18994.3 19006.5 19217.8 19362.2 19381.7 64731.0 66038.7 66197.7 67336.3 67580.7 93369.1 94635.0 96594.5 96639.5 96669.0 10605.5 11403.9 11812.9 12161.6 12289.4 12906.5 12945.3 13352.3 13534.9 13670.9 11624.0 11875.2 11937.3 11995.8 12036.8 7000.5 10828.8 10893.4 11028.9 11079.8 11683.8 11915.0 11944.6 12012.5 12018.0 11684.8 11761.5 11993.5 12074.6 12088.8 11503.8 11564.8 11573.0 11934.5 11943.8 11:04:32 INFO - PROCESS | 1642 | 11:04:32 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:6977.16 Median:2487.21 stddev:4408.36 (177.2%) stddev-sans-first:4400.39 11:04:32 INFO - PROCESS | 1642 | Values: 1342.3 1408.6 1644.5 1650.0 1654.1 9580.2 10005.6 10021.8 10198.3 10199.2 9943.9 11044.6 11336.9 11461.3 11536.8 2475.7 2516.1 2517.8 2522.6 2528.6 2061.7 2409.3 2473.8 2481.6 2482.3 2104.8 2185.6 2393.4 2469.5 2469.7 2457.3 2481.4 2486.1 2488.3 2491.4 2458.2 2465.7 2466.7 2471.8 2473.4 11485.8 11521.8 11635.9 11637.7 11639.4 5969.2 6161.4 6162.2 6162.9 6173.3 2790.8 3520.6 3611.7 3833.2 3834.6 1231.5 1252.8 1272.6 1280.4 1291.1 15942.0 16043.0 16048.2 16056.7 16087.0 4843.8 5078.8 5121.8 5191.8 5205.1 13263.7 13270.1 13275.7 13276.5 13284.0 6187.1 6188.4 6188.9 6192.7 6194.3 4556.7 4737.3 5509.4 5531.6 5563.2 3597.5 4131.6 4219.2 4300.4 4352.7 1164.7 1164.7 1166.0 1179.8 1181.7 918.1 921.7 981.2 991.9 1042.4 6799.5 6855.2 6912.6 7014.8 7045.3 882.5 987.4 1004.8 1012.7 1020.4 3673.0 4059.2 4174.6 4262.7 4350.0 13926.2 14298.9 14439.7 14454.5 14472.0 13812.0 14019.6 14320.0 14338.8 14387.9 10308.0 10519.9 10586.5 10673.9 10677.6 6691.6 6788.3 6805.4 6842.6 6881.4 12626.3 12862.0 12871.9 12887.7 12888.3 12818.6 12882.7 12905.3 13161.8 13272.5 8193.2 8434.2 9118.7 9253.4 9453.8 10732.0 10767.8 10875.1 10877.3 10897.6 9101.3 9127.8 9148.5 9175.0 9247.1 7453.9 8741.7 8857.4 8915.4 8962.5 8122.9 8140.7 8168.2 8262.0 8265.8 5932.8 6026.2 6129.8 6274.9 6289.8 6269.6 6305.3 6426.4 6468.5 6513.6 11:04:32 INFO - PROCESS | 1642 | 11:04:32 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4494.07 Median:4911.83 stddev:1266.87 (25.8%) stddev-sans-first:1232.09 11:04:32 INFO - PROCESS | 1642 | Values: 372.9 389.5 389.6 397.9 399.3 4252.6 4388.0 5002.8 5039.8 5040.5 4142.6 4753.3 4830.2 4874.8 5059.5 3374.5 3631.6 3930.4 3998.9 4004.8 3372.2 4008.5 4028.7 4032.1 4037.9 3251.8 4016.6 4020.8 4049.8 4080.5 3403.7 3748.9 3922.2 3995.9 4044.8 3372.3 3380.2 3507.8 3545.4 3580.6 4105.6 4251.9 4343.8 4961.6 5032.4 4439.9 4572.9 4576.6 4606.0 4643.8 4390.6 4809.0 4941.5 5274.0 5397.4 3303.7 3995.8 4009.3 4009.8 4022.2 4754.0 4967.2 5550.7 5638.8 5660.5 4286.7 4652.6 4792.3 4859.3 4894.4 4934.6 4951.9 4957.8 4963.8 4971.7 4553.4 4919.8 5109.5 5153.9 5187.6 4596.9 4656.7 4759.3 4809.8 5188.3 1457.6 1526.7 1534.4 1547.6 1662.8 1192.9 1289.5 1338.1 1338.4 1381.6 4220.6 4306.0 4351.9 5126.0 5174.2 4829.9 5519.9 5532.5 5589.0 5608.7 4744.4 4895.7 5076.4 5152.0 5165.2 2589.0 2624.2 2740.6 2779.4 2814.3 4812.3 5077.6 5309.7 5320.6 5384.9 5668.7 5670.5 5706.5 5775.6 5795.0 4641.7 4875.9 5434.0 5548.9 5612.7 5213.2 5593.1 5616.3 5652.7 5669.4 5030.9 5166.5 5310.0 5521.7 5542.0 5602.3 5756.0 5783.7 5919.9 5937.2 4826.5 4903.9 4929.0 4932.0 4974.8 5280.7 5571.4 5610.9 5639.6 5725.9 5459.9 5504.6 5509.6 5529.8 5539.8 5241.7 5280.5 5483.6 5499.3 5511.3 5020.7 5202.7 5340.5 5347.2 5373.9 4713.8 5460.9 5511.3 5513.8 5536.8 4334.5 4855.2 4983.2 5274.2 5316.4 11:04:32 INFO - PROCESS | 1642 | 11:04:32 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:20619.82 Median:17567.10 stddev:28512.77 (162.3%) stddev-sans-first:28553.79 11:04:32 INFO - PROCESS | 1642 | Values: 767.1 800.3 806.8 847.8 887.7 15379.4 16623.4 16632.4 16634.9 16661.0 15694.5 15834.4 16175.8 16220.7 16561.3 951.6 979.0 979.8 981.9 982.0 978.5 994.6 1002.6 1005.1 1009.4 1071.2 1073.9 1074.1 1074.4 1074.5 1067.6 1068.3 1069.2 1069.2 1069.5 793.0 793.2 794.8 795.3 795.4 17561.0 17573.2 17654.9 18358.4 18682.0 14854.0 14985.9 15063.2 15084.4 15508.8 11871.2 12118.4 12147.8 12191.2 12470.0 3783.4 3837.6 3993.2 4081.7 4090.7 48609.0 79752.0 107548.5 108278.9 110168.4 12046.3 12286.6 12295.8 12416.4 12934.8 22013.7 26775.9 26987.2 27614.0 27629.9 8217.5 8259.5 8354.7 8519.9 8537.2 4662.1 4734.9 4766.3 4797.6 4922.0 3297.1 3412.1 3463.0 3479.3 3482.9 629.2 641.9 656.9 672.2 676.2 575.8 689.4 713.4 733.1 764.3 9549.5 10730.5 10899.7 11039.5 11466.9 675.5 724.6 725.8 736.2 741.1 4832.9 5072.0 5110.4 5126.2 5170.0 93007.5 110491.4 115412.0 116414.4 117470.8 61516.4 64477.4 83349.6 84517.6 100436.0 77705.6 78437.6 80060.8 81094.2 81263.6 10971.1 11145.8 11501.8 11511.3 11541.8 50937.0 51213.7 51940.5 52381.0 53137.7 52154.7 64770.4 65134.0 65793.0 67460.0 13697.3 14042.8 14270.7 14822.1 14982.9 14686.0 14694.2 15404.6 15532.5 15564.8 14039.7 14364.9 14552.1 14923.0 15231.5 13782.8 13943.7 14519.0 14805.0 14961.6 14092.9 14262.9 14451.9 14637.8 14755.3 10649.1 10654.8 10975.6 11276.7 11277.2 10968.3 11429.4 11751.6 11853.8 11857.0 11:04:32 INFO - PROCESS | 1642 | -------- Summary: end -------- 11:04:32 INFO - PROCESS | 1642 | 11:04:33 INFO - TEST-INFO | 1642: exit 0 11:04:33 INFO - TEST-OK | dromaeo_css | took 1118116ms 11:04:33 INFO - TEST-START | kraken 11:04:33 INFO - operating with platform_type : mac_ 11:04:33 INFO - Initialising browser for kraken test... 11:04:33 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/tmpUZzr4l/profile http://localhost:49235/getInfo.html) 11:04:35 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 11:04:35 INFO - PROCESS | 1653 | colorDepth:24 11:04:35 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 11:04:35 INFO - PROCESS | 1653 | __metrics 11:04:35 INFO - PROCESS | 1653 | 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" 11:04:35 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:04:36 INFO - TEST-INFO | 1653: exit 0 11:04:36 INFO - Browser initialized. 11:04:36 INFO - Running cycle 1/1 for kraken test... 11:04:36 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/T/tmpUZzr4l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:04:48 INFO - PROCESS | 1655 | RSS: Main: 165232640 11:04:48 INFO - PROCESS | 1655 | 11:04:50 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 11:04:51 INFO - PROCESS | 1655 | RSS: Main: 216281088 11:04:51 INFO - PROCESS | 1655 | 11:04:54 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 11:04:54 INFO - PROCESS | 1655 | RSS: Main: 231260160 11:04:54 INFO - PROCESS | 1655 | 11:04:58 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 11:04:58 INFO - PROCESS | 1655 | RSS: Main: 327606272 11:04:58 INFO - PROCESS | 1655 | 11:05:00 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 11:05:01 INFO - PROCESS | 1655 | RSS: Main: 230215680 11:05:01 INFO - PROCESS | 1655 | 11:05:03 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:05:03 INFO - PROCESS | 1655 | RSS: Main: 232099840 11:05:03 INFO - PROCESS | 1655 | 11:05:06 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 11:05:07 INFO - PROCESS | 1655 | RSS: Main: 273149952 11:05:07 INFO - PROCESS | 1655 | 11:05:10 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 11:05:11 INFO - PROCESS | 1655 | RSS: Main: 273014784 11:05:11 INFO - PROCESS | 1655 | 11:05:13 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 11:05:14 INFO - PROCESS | 1655 | RSS: Main: 270622720 11:05:14 INFO - PROCESS | 1655 | 11:05:16 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:05:16 INFO - PROCESS | 1655 | RSS: Main: 248692736 11:05:16 INFO - PROCESS | 1655 | 11:05:18 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:05:19 INFO - PROCESS | 1655 | RSS: Main: 251502592 11:05:19 INFO - PROCESS | 1655 | 11:05:21 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:05:22 INFO - PROCESS | 1655 | RSS: Main: 258703360 11:05:22 INFO - PROCESS | 1655 | 11:05:25 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:05:25 INFO - PROCESS | 1655 | RSS: Main: 274010112 11:05:25 INFO - PROCESS | 1655 | 11:05:28 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:05:29 INFO - PROCESS | 1655 | RSS: Main: 267235328 11:05:29 INFO - PROCESS | 1655 | 11:05:31 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 11:05:31 INFO - PROCESS | 1655 | RSS: Main: 312045568 11:05:31 INFO - PROCESS | 1655 | 11:05:31 INFO - PROCESS | 1655 | __start_tp_report 11:05:31 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 11:05:31 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 11:05:31 INFO - PROCESS | 1655 | |i|pagename|runs| 11:05:31 INFO - PROCESS | 1655 | |0;ai-astar;103;115;115;114;114;116;114;115;115;114 11:05:31 INFO - PROCESS | 1655 | |1;audio-beat-detection;141;108;108;144;109;106;104;112;151;136 11:05:31 INFO - PROCESS | 1655 | |2;audio-dft;182;183;182;185;184;185;182;185;184;186 11:05:31 INFO - PROCESS | 1655 | |3;audio-fft;82;58;58;91;62;62;74;82;74;50 11:05:31 INFO - PROCESS | 1655 | |4;audio-oscillator;89;70;86;69;68;68;81;70;68;82 11:05:31 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;87;86;86;86;86;85;87;86;90;118 11:05:31 INFO - PROCESS | 1655 | |6;imaging-darkroom;93;103;94;94;93;94;94;93;93;95 11:05:31 INFO - PROCESS | 1655 | |7;imaging-desaturate;87;83;83;86;83;83;84;83;84;83 11:05:31 INFO - PROCESS | 1655 | |8;json-parse-financial;60;59;58;59;61;64;62;63;62;63 11:05:31 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;55;60;69;76;90;84;84;84;81;59 11:05:31 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;80;80;81;83;83;90;101;97;78;84 11:05:31 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;142;140;142;134;134;132;138;121;189;165 11:05:31 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;161;161;158;162;163;161;162;162;164;160 11:05:31 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;64;65;65;64;63;63;62;66;62;62 11:05:31 INFO - PROCESS | 1655 | __end_tp_report 11:05:31 INFO - PROCESS | 1655 | __start_cc_report 11:05:31 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,2056 11:05:31 INFO - PROCESS | 1655 | __end_cc_report 11:05:31 INFO - PROCESS | 1655 | __startTimestamp1493402731258__endTimestamp 11:05:31 INFO - PROCESS | 1655 | 11:05:31 INFO - PROCESS | 1655 | ------- Summary: start ------- 11:05:31 INFO - PROCESS | 1655 | Number of tests: 14 11:05:31 INFO - PROCESS | 1655 | 11:05:31 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:113.50 Median:115.00 stddev:3.75 (3.3%) stddev-sans-first:0.71 11:05:31 INFO - PROCESS | 1655 | Values: 103.0 115.0 115.0 114.0 114.0 116.0 114.0 115.0 115.0 114.0 11:05:31 INFO - PROCESS | 1655 | 11:05:31 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:121.90 Median:124.00 stddev:18.63 (15.0%) stddev-sans-first:18.43 11:05:31 INFO - PROCESS | 1655 | Values: 141.0 108.0 108.0 144.0 109.0 106.0 104.0 112.0 151.0 136.0 11:05:31 INFO - PROCESS | 1655 | 11:05:31 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.50 stddev:1.48 (0.8%) stddev-sans-first:1.41 11:05:31 INFO - PROCESS | 1655 | Values: 182.0 183.0 182.0 185.0 184.0 185.0 182.0 185.0 184.0 186.0 11:05:31 INFO - PROCESS | 1655 | 11:05:31 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:69.30 Median:74.00 stddev:13.22 (17.9%) stddev-sans-first:13.20 11:05:31 INFO - PROCESS | 1655 | Values: 82.0 58.0 58.0 91.0 62.0 62.0 74.0 82.0 74.0 50.0 11:05:31 INFO - PROCESS | 1655 | 11:05:31 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:75.10 Median:75.50 stddev:8.40 (11.1%) stddev-sans-first:7.25 11:05:31 INFO - PROCESS | 1655 | Values: 89.0 70.0 86.0 69.0 68.0 68.0 81.0 70.0 68.0 82.0 11:05:31 INFO - PROCESS | 1655 | 11:05:31 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:89.70 Median:86.00 stddev:10.03 (11.7%) stddev-sans-first:10.59 11:05:31 INFO - PROCESS | 1655 | Values: 87.0 86.0 86.0 86.0 86.0 85.0 87.0 86.0 90.0 118.0 11:05:31 INFO - PROCESS | 1655 | 11:05:31 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:94.60 Median:94.00 stddev:3.03 (3.2%) stddev-sans-first:3.15 11:05:31 INFO - PROCESS | 1655 | Values: 93.0 103.0 94.0 94.0 93.0 94.0 94.0 93.0 93.0 95.0 11:05:31 INFO - PROCESS | 1655 | 11:05:31 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:83.90 Median:83.50 stddev:1.45 (1.7%) stddev-sans-first:1.01 11:05:31 INFO - PROCESS | 1655 | Values: 87.0 83.0 83.0 86.0 83.0 83.0 84.0 83.0 84.0 83.0 11:05:31 INFO - PROCESS | 1655 | 11:05:31 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:61.10 Median:62.00 stddev:2.02 (3.3%) stddev-sans-first:2.11 11:05:31 INFO - PROCESS | 1655 | Values: 60.0 59.0 58.0 59.0 61.0 64.0 62.0 63.0 62.0 63.0 11:05:31 INFO - PROCESS | 1655 | 11:05:31 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:74.20 Median:82.50 stddev:12.54 (15.2%) stddev-sans-first:11.21 11:05:31 INFO - PROCESS | 1655 | Values: 55.0 60.0 69.0 76.0 90.0 84.0 84.0 84.0 81.0 59.0 11:05:31 INFO - PROCESS | 1655 | 11:05:31 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:83.00 stddev:7.78 (9.4%) stddev-sans-first:7.97 11:05:31 INFO - PROCESS | 1655 | Values: 80.0 80.0 81.0 83.0 83.0 90.0 101.0 97.0 78.0 84.0 11:05:31 INFO - PROCESS | 1655 | 11:05:31 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:143.70 Median:141.00 stddev:19.43 (13.8%) stddev-sans-first:20.60 11:05:31 INFO - PROCESS | 1655 | Values: 142.0 140.0 142.0 134.0 134.0 132.0 138.0 121.0 189.0 165.0 11:05:31 INFO - PROCESS | 1655 | 11:05:31 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:162.00 stddev:1.65 (1.0%) stddev-sans-first:1.74 11:05:31 INFO - PROCESS | 1655 | Values: 161.0 161.0 158.0 162.0 163.0 161.0 162.0 162.0 164.0 160.0 11:05:31 INFO - PROCESS | 1655 | 11:05:31 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:64.00 stddev:1.43 (2.2%) stddev-sans-first:1.51 11:05:31 INFO - PROCESS | 1655 | Values: 64.0 65.0 65.0 64.0 63.0 63.0 62.0 66.0 62.0 62.0 11:05:31 INFO - PROCESS | 1655 | -------- Summary: end -------- 11:05:31 INFO - PROCESS | 1655 | 11:05:32 INFO - TEST-INFO | 1655: exit 0 11:05:32 INFO - TEST-OK | kraken | took 58958ms 11:05:32 INFO - SUITE-END | took 1177s 11:05:32 INFO - Completed test suite (00:19:37) 11:05:32 INFO - javascript benchmark 11:05:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7924.131894083459, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2891.927701807456, 3477.913052173696, 3486.843092060857, 3508.386032444325, 3545.2377738786154, 5985.940140598593, 6006.129111278862, 6035.668038257894, 6066.7876624318105, 6087.11736798164, 5957.344692083867, 6012.398760123985, 6014.398560143984, 6030.909536356947, 6031.72857221425, 5298.708571028592, 5306.548943339811, 5326.201069839516, 5331.386890507583, 5447.373552041507, 5180.274761533388, 5195.766190521435, 5199.636025478199, 5429.0227759003365, 5474.534664553517, 5265.684058956455, 5276.3668359796875, 5281.551068159192, 5282.867928301804, 5283.392409872876, 5245.711485868275, 5246.658967167122, 5249.107651699221, 5255.054090263751, 5256.710880901549, 5133.230015497668, 5216.947830521684, 5226.947730522722, 5233.947660523384, 5263.315768950012, 5904.143899134601, 5913.8817223655715, 5916.645001299893, 5917.378675239081, 5928.347881733006, 6230.221222347207, 6248.187735594343, 6259.749610015594, 6268.1851359323455, 6270.561060725751, 6353.872922541569, 6370.745170193187, 6374.139491168679, 6384.744610215585, 6388.872222555523, 6028.457438830526, 6031.517478601701, 6033.607815491979, 6052.455279024909, 6056.000759874615, 6279.215098112736, 6318.7472501100365, 6395.904061439082, 6541.672916354163, 6549.2468366137555, 6221.2845522764555, 6277.340879207617, 6280.654563999024, 6285.371462853678, 6290.622562646256, 6409.294977552466, 6421.357864213542, 6425.0, 6428.228612566429, 6429.003504456817, 6186.1648677427975, 6321.273053598803, 6339.0, 6345.333739957238, 6354.682265886687, 5180.248863914711, 6107.977837958671, 6205.410486003822, 6219.0, 6270.749170033238, 5105.0, 5121.129408000649, 5123.103456895028, 5128.435872054071, 5148.613853960968, 4544.431946006749, 4550.226461501553, 4566.95433045672, 4573.885652858705, 4574.4968053514085, 5823.912641310384, 5914.0, 5949.1076338549565, 5969.970150149222, 5978.461938425563, 6240.157578726905, 6271.843203919847, 6291.591046581958, 6292.811215663537, 6332.556721029576, 6105.267367915879, 6120.418560236771, 6121.418465245794, 6129.08063790435, 6134.539909506805, 5511.421300763443, 5552.056150454432, 5568.470995255444, 5572.832815015556, 5580.386157522669, 6328.71520781566, 6374.808755737336, 6581.0, 6618.933810661928, 6637.2699003108655, 6401.359864013748, 6427.58220715652, 6427.935720642734, 6442.645654488861, 6444.709988050456, 6591.670416479253, 6652.368025037614, 6653.700583473658, 6677.899831502435, 6687.130673012477, 6206.565540412128, 6217.595856269328, 6233.158523599256, 6378.298387177314, 6383.585066970632, 6318.810435686937, 6352.618842869442, 6356.809295721136, 6359.268684101387, 6381.521385896169, 6071.908921366271, 6213.440790328892, 6292.559520833498, 6292.874142517216, 6298.118263443213, 6105.358937311518, 6222.844428889314, 6230.470410015018, 6272.6236425814595, 6288.056791481132, 6039.5470339723815, 6124.89972046314, 6152.876942461216, 6159.84600384994, 6177.980633195652, 6286.559940804283, 6299.212598425197, 6302.180716506825, 6309.148264984168, 6316.021016742412, 5847.26909136358, 5872.442117998783, 5886.146508756292, 6127.325994140552, 6171.228596425447], "value": 5849.423065143249, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [771.8764997600385, 792.5918152151643, 814.6904176412962, 835.6657337065174, 900.1403659505173, 25501.872490637543, 29671.109866704006, 32485.67514324856, 39166.60833391665, 40112.39831402531, 42306.0, 42485.78757106218, 42516.78741606288, 42530.787346063305, 42616.0, 9583.760405989837, 9748.220142388627, 9748.415095094282, 9748.90251097487, 9769.316147869651, 7906.0, 8062.475939063971, 9617.134457898788, 11562.421878906021, 11743.354115523643, 11763.647090587254, 11862.584809531669, 11898.04815614753, 11903.821442678367, 11905.7618847623, 11800.232984856, 11818.940905295505, 11836.171467997243, 11840.703982400422, 11850.40747962607, 11400.0, 11441.084713223005, 11455.255408398427, 11455.369954652491, 11458.026067784249, 40241.99395015119, 40273.798631006954, 40299.59700403017, 40331.395029074585, 40418.78743637696, 3985.6811455083525, 4039.4748682671066, 4057.4116753070934, 4063.5123785145674, 4090.5091389033505, 28193.577096343368, 28311.0, 29545.70454295451, 30471.0, 30543.69456305431, 3179.6184457864974, 3288.32589319189, 3359.328134373135, 3406.914827129317, 3420.6921377075932, 344238.9999999975, 369582.0, 372073.0, 372884.1355793231, 374293.0, 54313.45686543163, 54444.18333724918, 54544.72727636416, 54560.454395456334, 54583.0, 56602.7169864148, 56645.7167714167, 56711.0, 56723.43276567264, 56815.0, 15648.0, 15726.21368931549, 15735.977161484696, 15745.212739363214, 15753.527394178192, 13315.733685326239, 13318.667033324244, 13328.666783330495, 13329.866701332863, 13335.866641333656, 10971.012608865081, 11154.609588664358, 11333.546658133582, 12540.934020608169, 14335.0, 5175.430702622709, 5229.405031465363, 6252.124702541648, 6252.468540174136, 6299.842503937438, 1146.3465824480134, 1177.5937301630925, 1181.1908842442954, 1191.4876603060768, 1228.2200802490484, 27176.864115679295, 27452.450950980867, 27621.03326383567, 27628.30929226745, 27740.02909898144, 854.9700760473354, 1158.3802665574046, 1190.3334132885611, 1296.0992110483123, 1356.8236129303127, 14914.850851491346, 15061.548153555412, 15336.693266134615, 15392.230388480755, 15410.460633877761, 399855.0, 408864.9556752197, 425667.0, 428117.0, 429629.0, 46282.537174628495, 46787.298190527166, 56235.71882140563, 57726.134107988415, 58528.0, 1521.9315130819139, 1557.680675461505, 1561.7423125184218, 1576.3064251728972, 1580.6048487878031, 28383.716162838107, 29891.103266902028, 31340.216494587818, 31500.89746858849, 31519.527207091454, 49073.75463122661, 49193.75403122961, 49194.75402622964, 49327.753361232964, 49342.25986610276, 504516.0, 514297.0, 526674.3666281644, 534697.0, 653044.0, 36167.095822603595, 36694.8165259172, 36799.0, 37049.88850334494, 37506.24987500289, 45370.773146135376, 45845.62463126112, 46130.0, 46626.53373466358, 46901.530984689714, 31237.0, 31468.055958321285, 31618.367632647678, 32584.674153258165, 32875.50686739653, 31377.0, 31555.52666709955, 31574.368512630077, 32200.516992244666, 32478.837605812765, 32767.344653106327, 36036.81981590075, 36054.4591831128, 36851.262974740894, 36992.0, 27613.0, 28288.00991965271, 28881.277968050967, 29826.0, 29949.85025074861, 23526.529469410172, 23583.702896340867, 24038.63942040836, 24083.853018319976, 24259.02963881425], "value": 19610.549997751674, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.86643140626387, 438.0603605266703, 445.1275500019961, 450.6575002997721, 452.4751288505334, 20397.898010509965, 21500.354989350304, 22821.657675134888, 22865.54268914621, 22889.542209155807, 23418.765812341873, 23960.0, 24344.174186936005, 24525.77371131445, 24768.504629907435, 7078.973548835415, 7106.467014973872, 7203.81990450239, 7253.129624445074, 7329.450291228152, 7124.109486314211, 7251.7461888833905, 7267.0, 7271.309225623558, 7275.527090739111, 6205.720742566596, 7118.430525557943, 8312.542810145469, 8316.459430137053, 8319.875201871977, 8013.639386227634, 8122.675092996273, 8125.187481251886, 8159.143289954558, 8234.258916697467, 7527.924720752777, 7678.117016543058, 7932.801679957989, 7953.045634523836, 8002.119766825645, 26712.46575068507, 27649.447011059867, 27972.300692482648, 28038.579421308696, 28191.295217619518, 3037.2255074955965, 3049.84750762461, 3132.7650426217897, 3159.1470303018286, 3332.8333583320737, 16304.83695163045, 16421.01473911569, 16669.24988375526, 16684.249208785634, 17221.225044873012, 1663.8169801321844, 2197.3517812245427, 2241.652543855705, 2294.7590502997277, 2318.142287353673, 172182.68534471944, 174454.12772936054, 177879.0, 178852.0, 180683.67607133687, 20132.89269090185, 20862.582748344947, 20925.0, 21069.683954740693, 21083.051262693214, 33294.66705332964, 33304.0, 33306.3338733224, 33329.166770830925, 33334.16664583405, 8439.66241350339, 10683.62607308756, 10911.127109831194, 10953.288036277616, 11034.337939723482, 9067.591958361889, 9083.772905677411, 9089.409188402733, 9226.677066302782, 9265.629374824932, 9061.705524132296, 9341.159295663423, 9462.101100395452, 9463.262011505554, 9497.952510237405, 3255.283837555734, 3270.640229574745, 3440.70753985909, 3848.230353929225, 3913.354296541039, 917.417439925652, 935.1350001248818, 940.0, 947.190152419685, 948.9952550237205, 20710.275140370013, 20759.0, 22561.323160304888, 24765.0, 24975.250742477754, 1074.6829685242872, 1123.9325640461598, 1135.28477059452, 1165.341582006164, 1178.1988247991449, 11186.32882027081, 11447.942760286145, 11686.0, 11687.824682629767, 11758.823617645741, 739603.0, 761091.0, 788883.0, 805833.0, 812473.0, 157370.0, 163731.0, 166174.50738238936, 166416.0, 168933.0, 1293.7606542789426, 1331.8534961154264, 1359.9388027538587, 1361.9727605447836, 1363.3387806913638, 18994.335198267996, 19006.524836879187, 19217.8078219216, 19362.225510979966, 19381.70927436118, 64731.02903456358, 66038.68864589909, 66197.66901165464, 67336.326636733, 67580.66209668921, 93369.13261734863, 94635.0, 96594.51702741442, 96639.51680241554, 96669.033309666, 10605.522751476356, 11403.942980285046, 11812.940935295268, 12161.635150945485, 12289.446974885972, 12906.548270810477, 12945.28800915921, 13352.332383380986, 13534.93232533831, 13670.93164534171, 11624.011958983581, 11875.228110172811, 11937.328773971478, 11995.76008479843, 12036.819447708116, 7000.47496437759, 10828.837567436338, 10893.400862952614, 11028.944855275673, 11079.83380249313, 11683.766324673288, 11915.0, 11944.64166075019, 12012.519499219934, 12018.0, 11684.766304674029, 11761.470733816828, 11993.520259189534, 12074.577389791315, 12088.75822483563, 11503.769924601294, 11564.768704626029, 11572.958433741003, 11934.52261909514, 11943.76112477763], "value": 12212.085356921903, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1342.3154191362403, 1408.5774267719682, 1644.465548696673, 1649.9917500412503, 1654.1067823375379, 9580.185684216842, 10005.649802256923, 10021.799564008716, 10198.286119971586, 10199.18406527478, 9943.850842237372, 11044.558217671283, 11336.943315283412, 11461.31232126073, 11536.826947595793, 2475.7029156501244, 2516.119358224625, 2517.785988191006, 2522.6216067589826, 2528.5575024370755, 2061.680439531875, 2409.2531315292226, 2473.802095832329, 2481.6153496208026, 2482.2801387597574, 2104.7684754676975, 2185.5956648020087, 2393.3777217923293, 2469.506098780242, 2469.6663801547143, 2457.2751038443703, 2481.4292712676097, 2486.105002199207, 2488.315713178872, 2491.3771557110813, 2458.1887976967737, 2465.654808326836, 2466.7409921958297, 2471.8146139039645, 2473.3940184654693, 11485.770284594262, 11521.769564608745, 11635.883641163564, 11637.70905727355, 11639.418029098595, 5969.194158788551, 6161.353057928943, 6162.198914141178, 6162.8767424651705, 6173.259208894917, 2790.8185967912023, 3520.612732599412, 3611.693006094485, 3833.195029043904, 3834.616538346171, 1231.4950870143198, 1252.843394575678, 1272.580048583965, 1280.4366078925243, 1291.1349395904672, 15942.043477391278, 16043.0, 16048.197590120448, 16056.678866422722, 16087.034777913363, 4843.806247750051, 5078.822241221539, 5121.769520371592, 5191.792328306826, 5205.115130427836, 13263.73472530544, 13270.071095023255, 13275.73448531024, 13276.468941242241, 13284.0, 6187.102870083812, 6188.381161883775, 6188.907166392508, 6192.659403732748, 6194.287656919512, 4556.681032327705, 4737.3130896020575, 5509.421510741395, 5531.585131115183, 5563.165525171256, 3597.5143355647174, 4131.607497287753, 4219.240536703362, 4300.397944287803, 4352.717073390283, 1164.67971307891, 1164.714644912002, 1165.9650210493699, 1179.8112302031634, 1181.7400171962154, 918.1415376622746, 921.7004473546124, 981.2248323824242, 991.8760154980628, 1042.4475028235047, 6799.524033317621, 6855.245922948472, 6912.55068420551, 7014.824629384204, 7045.330693584101, 882.5410786391169, 987.3878195518681, 1004.7789486313, 1012.6759436980095, 1020.3979652005353, 3673.0082877623427, 4059.188162367538, 4174.603412675791, 4262.680298977527, 4350.0212452198, 13926.164430134224, 14298.928505357615, 14439.711205775826, 14454.494092706705, 14471.986960912634, 13812.0, 14019.579412617637, 14319.997600167888, 14338.784918226234, 14387.92806035963, 10308.0, 10519.89480105189, 10586.470676466146, 10673.946630266799, 10677.62628308021, 6691.631960242234, 6788.25329213796, 6805.421539169226, 6842.623655698984, 6881.380675739208, 12626.305553194295, 12862.0, 12871.935640321739, 12887.742245155232, 12888.291143987171, 12818.61544153677, 12882.67793305175, 12905.290209038218, 13161.802572961606, 13272.469101235842, 8193.221643943816, 8434.198751118634, 9118.726438206864, 9253.352265341362, 9453.763655908657, 10732.0, 10767.838482422614, 10875.129989600971, 10877.347359158475, 10897.618583349546, 9101.271898248257, 9127.817443650956, 9148.45109293418, 9174.954125229331, 9247.12152345526, 7453.850922981618, 8741.694040708544, 8857.379983401357, 8915.37592368528, 8962.507062111386, 8122.878156827534, 8140.715074972348, 8168.224018718212, 8262.049864265686, 8265.752027439186, 5932.762689492372, 6026.15633811258, 6129.816105516842, 6274.905876411949, 6289.779857705142, 6269.561130720988, 6305.337939516285, 6426.3573642635365, 6468.5472016958365, 6513.641749703622], "value": 5305.982199606604, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.8527231743463, 389.4819889546903, 389.6084435142681, 397.8786470126612, 399.3191608307835, 4252.638525725313, 4387.968827325576, 5002.849914502566, 5039.848804535861, 5040.5211504907065, 4142.647874930627, 4753.287006948959, 4830.188679245283, 4874.756262186894, 5059.468755780646, 3374.476956071807, 3631.6186800385976, 3930.390789427629, 3998.940280825569, 4004.7597144171295, 3372.162171616475, 4008.4588580541545, 4028.7179897407195, 4032.072623296629, 4037.919241615166, 3251.7723759336855, 4016.6184212499766, 4020.7989600520004, 4049.800657480587, 4080.489938757655, 3403.6596340366013, 3748.8875333740166, 3922.215556888605, 3995.862213715648, 4044.8179831907637, 3372.274960883422, 3380.171857894807, 3507.7722797021092, 3545.3618348697223, 3580.5856686608904, 4105.630493255621, 4251.893702657428, 4343.762962074534, 4961.578265847371, 5032.3961124665275, 4439.911201775946, 4572.933205786949, 4576.588107070346, 4605.976970115162, 4643.822138315787, 4390.626796722282, 4808.975955120237, 4941.455150597445, 5273.965416456414, 5397.410721869952, 3303.653116422765, 3995.7613139926716, 4009.258287216874, 4009.8195581198624, 4022.2357752027315, 4754.0, 4967.243180035079, 5550.72246387679, 5638.830835074954, 5660.462256085665, 4286.72136311145, 4652.62778977681, 4792.305115758265, 4859.299245264129, 4894.412670479565, 4934.593640812352, 4951.925721114186, 4957.801687932514, 4963.776630051656, 4971.701697898137, 4553.385292985405, 4919.7540122993705, 5109.463506331856, 5153.861147623769, 5187.584993200535, 4596.885787220419, 4656.743879086683, 4759.334772527396, 4809.807607695653, 5188.3162954302115, 1457.6210185351672, 1526.7099251142247, 1534.4092524377972, 1547.582152818755, 1662.7755253040928, 1192.9164958452825, 1289.5164313382481, 1338.136901698399, 1338.380559522988, 1381.6338670252392, 4220.6412454941055, 4306.0311429928015, 4351.891202719958, 5125.9743701282005, 5174.223866419992, 4829.9034019319415, 5519.917201241985, 5532.5297349724915, 5589.0, 5608.747606357723, 4744.3595114659765, 4895.657303988686, 5076.36545431821, 5151.97424012885, 5165.151961788417, 2588.951474652731, 2624.2127361791386, 2740.6026126211586, 2779.444111177732, 2814.3114131521334, 4812.278158276286, 5077.568406685399, 5309.681419114865, 5320.627556071116, 5384.946150538444, 5668.744906479218, 5670.5463562914865, 5706.514946229534, 5775.6138526753275, 5795.0, 4641.6518761092375, 4875.90248195027, 5433.972830135824, 5548.889022219614, 5612.747426365823, 5213.165893457029, 5593.098346562188, 5616.3260408749575, 5652.689102099424, 5669.448748063305, 5030.899382012412, 5166.535011848951, 5310.044192045314, 5521.723913804374, 5541.972290138524, 5602.299712535933, 5755.97122014404, 5783.739731712168, 5919.868847215085, 5937.150167919336, 4826.469088400343, 4903.901921961612, 4929.0, 4931.950680493293, 4974.7512624369365, 5280.673175899159, 5571.415001424792, 5610.877824435211, 5639.574982757454, 5725.885482290414, 5459.890802184013, 5504.6421982571, 5509.641873278224, 5529.751161197675, 5539.833804985857, 5241.711705856214, 5280.5181564664545, 5483.643563168382, 5499.322706574533, 5511.346596021258, 5020.748962551785, 5202.73986300691, 5340.519353258225, 5347.224652425454, 5373.919391209213, 4713.797981514692, 5460.890782184413, 5511.283533140666, 5513.779448822002, 5536.806211782568, 4334.501532323697, 4855.174620314626, 4983.177775667119, 5274.204671524099, 5316.441773613869], "value": 4139.9521741533845, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [767.0526899279392, 800.2837460472873, 806.8103995561046, 847.7922908887323, 887.7248053103536, 15379.384824607016, 16623.418180363675, 16632.417865374715, 16634.916825415872, 16661.0, 15694.450694225705, 15834.4457943972, 16175.757363639555, 16220.675586488263, 16561.25474353654, 951.6050838901847, 979.0063085967713, 979.8089372572351, 981.9116279534841, 981.950902454878, 978.4569563892037, 994.6170724271171, 1002.6240159940022, 1005.095414127284, 1009.4195837393492, 1071.201954543862, 1073.88187299397, 1074.1406874500408, 1074.350018238966, 1074.457399013497, 1067.5516283161091, 1068.2789117345799, 1069.176733914889, 1069.2141276162015, 1069.4545781651375, 793.0325003495726, 793.1949071692237, 794.7933537280348, 795.2723258218723, 795.3915254830059, 17561.0, 17573.20920558578, 17654.911725441292, 18358.449246522625, 18681.972491512963, 14854.0, 14985.850141498555, 15063.246837658184, 15084.39662413502, 15508.844911550967, 11871.169018168732, 12118.39408029595, 12147.757044859054, 12191.207571507824, 12470.0, 3783.375743002401, 3837.597052309495, 3993.221321842242, 4081.69387295954, 4090.6931980101613, 48609.0, 79752.0, 107548.462257689, 108278.91721082767, 110168.4491577545, 12046.277223366451, 12286.569970051005, 12295.815562766566, 12416.408823235744, 12934.805977910339, 22013.66979495309, 26775.86612066927, 26987.190384288504, 27614.033508827095, 27629.861850690617, 8217.517254401062, 8259.463134896332, 8354.665813367397, 8519.914800852037, 8537.231649151607, 4662.109044591041, 4734.881627959328, 4766.285057241442, 4797.616190704735, 4921.975390123098, 3297.1427428868665, 3412.112850658797, 3463.0303515015835, 3479.251960828434, 3482.8606855725993, 629.197772839624, 641.9197600299963, 656.8522082531488, 672.2336536348566, 676.2358534855582, 575.815738963536, 689.4036658290543, 713.375796178344, 733.0690023670016, 764.2739397572218, 9549.474778887088, 10730.463476826128, 10899.727506812234, 11039.503222355013, 11466.94266528662, 675.5001299038676, 724.5942272327513, 725.8301060407885, 736.2159300345115, 741.1365758890831, 4832.879178020507, 5072.0, 5110.412302585176, 5126.15418455958, 5169.974150129226, 93007.53496232476, 110491.44754276177, 115412.0, 116414.41792790982, 117470.8252917477, 61516.38483615107, 64477.355226448075, 83349.58325208456, 84517.57741211378, 100436.0, 77705.61147194228, 78437.60781196058, 80060.79908801372, 81094.18905811102, 81263.5936820312, 10971.122310215324, 11145.832812507657, 11501.769964600828, 11511.251768635011, 11541.769164616493, 50937.0, 51213.74393128011, 51940.48059519356, 52381.0, 53137.7343113282, 52154.6530406125, 64770.40879954032, 65134.0, 65793.0, 67460.0, 13697.315134243048, 14042.78935815984, 14270.71458570802, 14822.110673359633, 14982.850171498145, 14686.0, 14694.191819450032, 15404.614884627974, 15532.456364027204, 15564.84435155634, 14039.719205615625, 14364.85635143677, 14552.054116482395, 14923.0, 15231.466898658493, 13782.821584211477, 13943.651408714457, 14519.0, 14804.963652544218, 14961.551153465414, 14092.929535352258, 14262.928685356506, 14451.940551171218, 14637.75579075748, 14755.262236887898, 10649.148068154374, 10654.774011439582, 10975.560977560808, 11276.661700149009, 11277.210595258253, 10968.287061340987, 11429.371384573928, 11751.588694395656, 11853.822192666945, 11857.0], "value": 8044.750522893432, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1421.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 115.0, 114.0, 114.0, 116.0, 114.0, 115.0, 115.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 108.0, 108.0, 144.0, 109.0, 106.0, 104.0, 112.0, 151.0, 136.0], "value": 121.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 182.0, 185.0, 184.0, 185.0, 182.0, 185.0, 184.0, 186.0], "value": 183.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 58.0, 91.0, 62.0, 62.0, 74.0, 82.0, 74.0, 50.0], "value": 69.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 86.0, 69.0, 68.0, 68.0, 81.0, 70.0, 68.0, 82.0], "value": 75.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 86.0, 86.0, 86.0, 85.0, 87.0, 86.0, 90.0, 118.0], "value": 89.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 103.0, 94.0, 94.0, 93.0, 94.0, 94.0, 93.0, 93.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 83.0, 86.0, 83.0, 83.0, 84.0, 83.0, 84.0, 83.0], "value": 83.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 58.0, 59.0, 61.0, 64.0, 62.0, 63.0, 62.0, 63.0], "value": 61.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 60.0, 69.0, 76.0, 90.0, 84.0, 84.0, 84.0, 81.0, 59.0], "value": 74.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 81.0, 83.0, 83.0, 90.0, 101.0, 97.0, 78.0, 84.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 140.0, 142.0, 134.0, 134.0, 132.0, 138.0, 121.0, 189.0, 165.0], "value": 143.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 158.0, 162.0, 163.0, 161.0, 162.0, 162.0, 164.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 63.0, 63.0, 62.0, 66.0, 62.0, 62.0], "value": 63.6, "unit": "score"}]}]} 11:05:32 INFO - Return code: 0 11:05:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:05:32 INFO - # TBPL SUCCESS # 11:05:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:05:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:05:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:05:32 INFO - 2017-04-28 11:05:32.596 screenresolution[1659:9865] starting screenresolution argv=screenresolution get 11:05:32 INFO - 2017-04-28 11:05:32.599 screenresolution[1659:9865] Display 0: 1600x1200x32@60 11:05:32 INFO - 2017-04-28 11:05:32.605 screenresolution[1660:9868] starting screenresolution argv=screenresolution list 11:05:32 INFO - Available Modes on Display 0 11:05:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:05:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:05:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:05:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:05:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:05:32 INFO - Intel Iris: 11:05:32 INFO - Chipset Model: Intel Iris 11:05:32 INFO - Type: GPU 11:05:32 INFO - Bus: Built-In 11:05:32 INFO - VRAM (Dynamic, Max): 1536 MB 11:05:32 INFO - Vendor: Intel (0x8086) 11:05:32 INFO - Device ID: 0x0a2e 11:05:32 INFO - Revision ID: 0x0009 11:05:32 INFO - Displays: 11:05:32 INFO - Display: 11:05:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:05:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:05:32 INFO - Display Serial Number: 1600x1200 60 11:05:32 INFO - Main Display: Yes 11:05:32 INFO - Mirror: Off 11:05:32 INFO - Online: Yes 11:05:32 INFO - Rotation: Supported 11:05:32 INFO - Return code: 0 11:05:32 INFO - Running post-action listener: _resource_record_post_action 11:05:32 INFO - [mozharness: 2017-04-28 18:05:32.842890Z] Finished run-tests step (success) 11:05:32 INFO - Running post-run listener: _resource_record_post_run 11:05:32 INFO - Total resource usage - Wall time: 1193s; CPU: 54.0%; Read bytes: 40416256; Write bytes: 423643136; Read time: 396; Write time: 1677 11:05:32 INFO - TinderboxPrint: CPU usage
53.7% 11:05:32 INFO - TinderboxPrint: I/O read bytes / time
40,416,256 / 396 11:05:32 INFO - TinderboxPrint: I/O write bytes / time
423,643,136 / 1,677 11:05:32 INFO - TinderboxPrint: CPU idle
2,209.0 (46.3%) 11:05:32 INFO - TinderboxPrint: CPU system
949.5 (19.9%) 11:05:32 INFO - TinderboxPrint: CPU user
1,615.2 (33.8%) 11:05:32 INFO - TinderboxPrint: Swap in / out
161,718,272 / 0 11:05:32 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 122978816; Write bytes: 123009024; Read time: 11100; Write time: 296 11:05:32 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 35296256; Write bytes: 296706048; Read time: 361; Write time: 1364 11:05:33 INFO - Running post-run listener: _upload_blobber_files 11:05:33 INFO - Blob upload gear active. 11:05:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:05:33 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 11:05:33 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:05:33 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:05:33 INFO - (blobuploader) - INFO - Open directory for files ... 11:05:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:05:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:05:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:05:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:05:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:05:35 INFO - (blobuploader) - INFO - Done attempting. 11:05:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:05:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:05:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:05:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:05:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:05:36 INFO - (blobuploader) - INFO - Done attempting. 11:05:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:05:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:05:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:05:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:05:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:05:37 INFO - (blobuploader) - INFO - Done attempting. 11:05:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:05:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:05:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:05:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:05:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:05:40 INFO - (blobuploader) - INFO - Done attempting. 11:05:40 INFO - (blobuploader) - INFO - Iteration through files over. 11:05:40 INFO - Return code: 0 11:05:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:05:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:05:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/50862d5ddd0185f1d9cd4e22cbcd13e16388e16c9eeaf73bf4d9f17af1d9d8aed715d76c651afd119a9b1b3ad5a4d923275b55d617273223e3dc43038fff0b65", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01849cee99f43dff011db6c69ff20e2be5c527bcd68038d7af13ed90dfb48d99bc24f2c4cb7f2d9e940bda83e24a066b5922efbdcc3ef68985fcd074d1e9ec12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e009385195644110b93923a65f4d021fc519859bed0b602d2d357a1d8a562763a1c9bd6d3a21649414828e68fefdfe75155e9dacfbba00fccf208ccdf7f15f09", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2077fdc8555340c693bc18334531d5d9fe689b84c8e04330b48e6e809db35e9817c2183ccd84a8ce928d3783fc208aecf616678e8c7aedd6531208ae7c8bcacd"} 11:05:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:05:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:05:40 INFO - Contents: 11:05:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/50862d5ddd0185f1d9cd4e22cbcd13e16388e16c9eeaf73bf4d9f17af1d9d8aed715d76c651afd119a9b1b3ad5a4d923275b55d617273223e3dc43038fff0b65", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01849cee99f43dff011db6c69ff20e2be5c527bcd68038d7af13ed90dfb48d99bc24f2c4cb7f2d9e940bda83e24a066b5922efbdcc3ef68985fcd074d1e9ec12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e009385195644110b93923a65f4d021fc519859bed0b602d2d357a1d8a562763a1c9bd6d3a21649414828e68fefdfe75155e9dacfbba00fccf208ccdf7f15f09", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2077fdc8555340c693bc18334531d5d9fe689b84c8e04330b48e6e809db35e9817c2183ccd84a8ce928d3783fc208aecf616678e8c7aedd6531208ae7c8bcacd"} 11:05:40 INFO - Running post-run listener: copy_logs_to_upload_dir 11:05:40 INFO - Copying logs to upload dir... 11:05:40 INFO - mkdir: /builds/slave/test/build/upload/logs 11:05:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.401164 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2017-04-28 11:05:40.551294) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 11:05:40.556694) ========= 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.Wp9kd3u7V1/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.p4xSYcse9l/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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/Mozilla-Beta/sha512/50862d5ddd0185f1d9cd4e22cbcd13e16388e16c9eeaf73bf4d9f17af1d9d8aed715d76c651afd119a9b1b3ad5a4d923275b55d617273223e3dc43038fff0b65", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01849cee99f43dff011db6c69ff20e2be5c527bcd68038d7af13ed90dfb48d99bc24f2c4cb7f2d9e940bda83e24a066b5922efbdcc3ef68985fcd074d1e9ec12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e009385195644110b93923a65f4d021fc519859bed0b602d2d357a1d8a562763a1c9bd6d3a21649414828e68fefdfe75155e9dacfbba00fccf208ccdf7f15f09", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2077fdc8555340c693bc18334531d5d9fe689b84c8e04330b48e6e809db35e9817c2183ccd84a8ce928d3783fc208aecf616678e8c7aedd6531208ae7c8bcacd"} build_url:https://queue.taskcluster.net/v1/task/ZZoVjBL0TqyzLHY8hv-T3g/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011299 build_url: 'https://queue.taskcluster.net/v1/task/ZZoVjBL0TqyzLHY8hv-T3g/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/50862d5ddd0185f1d9cd4e22cbcd13e16388e16c9eeaf73bf4d9f17af1d9d8aed715d76c651afd119a9b1b3ad5a4d923275b55d617273223e3dc43038fff0b65", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01849cee99f43dff011db6c69ff20e2be5c527bcd68038d7af13ed90dfb48d99bc24f2c4cb7f2d9e940bda83e24a066b5922efbdcc3ef68985fcd074d1e9ec12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e009385195644110b93923a65f4d021fc519859bed0b602d2d357a1d8a562763a1c9bd6d3a21649414828e68fefdfe75155e9dacfbba00fccf208ccdf7f15f09", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2077fdc8555340c693bc18334531d5d9fe689b84c8e04330b48e6e809db35e9817c2183ccd84a8ce928d3783fc208aecf616678e8c7aedd6531208ae7c8bcacd"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 11:05:40.601466) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 11:05:40.601857) ========= 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.Wp9kd3u7V1/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.p4xSYcse9l/Listeners TMPDIR=/var/folders/mj/1d_lzv6s5pd4r3qyy4sndkb000000w/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.005208 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 11:05:40.650211) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 11:05:40.653620) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 11:05:40.653983) ========= ========= Total master_lag: 0.23 =========