builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0234 starttime: 1493886708.85 results: success (0) buildid: 20170503233720 builduid: 60aaf9d2566a48e582bec511af4d4a34 revision: 5b0b0f86fd2624e1b5ca0f1fa04dcdaf8800edf9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 01:31:48.848630) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 01:31:48.849037) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2017-05-04 01:31:48.849307) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2017-05-04 01:31:51.881058) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 01:31:51.881797) ========= 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.A1PGQKau6P/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.MWCTJgnNF8/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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-05-04 01:31:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 92.9M=0s 2017-05-04 01:31:52 (92.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125757 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 01:31:52.034145) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 01:31:52.034470) ========= 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.A1PGQKau6P/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.MWCTJgnNF8/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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.026203 ========= master_lag: 0.74 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 01:31:52.800751) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-04 01:31:52.801089) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5b0b0f86fd2624e1b5ca0f1fa04dcdaf8800edf9 --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 5b0b0f86fd2624e1b5ca0f1fa04dcdaf8800edf9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.A1PGQKau6P/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.MWCTJgnNF8/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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-05-04 01:31:52,906 truncating revision to first 12 chars 2017-05-04 01:31:52,906 Setting DEBUG logging. 2017-05-04 01:31:52,906 attempt 1/10 2017-05-04 01:31:52,907 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5b0b0f86fd26?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-04 01:31:53,903 unpacking tar archive at: mozilla-beta-5b0b0f86fd26/testing/mozharness/ program finished with exit code 0 elapsedTime=1.272915 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-04 01:31:54.099164) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 01:31:54.099496) ========= script_repo_revision: 5b0b0f86fd2624e1b5ca0f1fa04dcdaf8800edf9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 01:31:54.099868) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 01:31:54.100128) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 01:31:54.131832) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-05-04 01:31:54.132179) ========= /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.A1PGQKau6P/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.MWCTJgnNF8/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 01:31:54 INFO - MultiFileLogger online at 20170504 01:31:54 in /builds/slave/test 01:31:54 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 01:31:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:31:54 INFO - {'append_to_log': False, 01:31:54 INFO - 'base_work_dir': '/builds/slave/test', 01:31:54 INFO - 'blob_upload_branch': 'Mozilla-Beta', 01:31:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:31:54 INFO - 'branch': 'Mozilla-Beta', 01:31:54 INFO - 'buildbot_json_path': 'buildprops.json', 01:31:54 INFO - 'config_files': ('talos/mac_config.py',), 01:31:54 INFO - 'default_actions': ('clobber', 01:31:54 INFO - 'read-buildbot-config', 01:31:54 INFO - 'download-and-extract', 01:31:54 INFO - 'populate-webroot', 01:31:54 INFO - 'create-virtualenv', 01:31:54 INFO - 'install', 01:31:54 INFO - 'run-tests'), 01:31:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:31:54 INFO - 'download_minidump_stackwalk': True, 01:31:54 INFO - 'download_symbols': 'ondemand', 01:31:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:31:54 INFO - 'tooltool.py': '/tools/tooltool.py', 01:31:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:31:54 INFO - '/tools/misc-python/virtualenv.py')}, 01:31:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:31:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:31:54 INFO - 'gecko_profile': False, 01:31:54 INFO - 'gecko_profile_interval': 0, 01:31:54 INFO - 'installer_path': 'installer.exe', 01:31:54 INFO - 'log_level': 'info', 01:31:54 INFO - 'log_name': 'talos', 01:31:54 INFO - 'log_to_console': True, 01:31:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:31:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:31:54 INFO - 'opt_config_files': (), 01:31:54 INFO - 'pip_index': False, 01:31:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:31:54 INFO - 'cmd': ('bash', 01:31:54 INFO - '-c', 01:31:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:31:54 INFO - 'enabled': True, 01:31:54 INFO - 'halt_on_failure': False, 01:31:54 INFO - 'name': 'check_screen_resolution'},), 01:31:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:31:54 INFO - 'cmd': ('bash', 01:31:54 INFO - '-c', 01:31:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:31:54 INFO - 'enabled': True, 01:31:54 INFO - 'halt_on_failure': False, 01:31:54 INFO - 'name': 'check_screen_resolution'},), 01:31:54 INFO - 'run_cmd_checks_enabled': True, 01:31:54 INFO - 'suite': 'dromaeojs', 01:31:54 INFO - 'system_bits': '32', 01:31:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:31:54 INFO - 'title': 't-yosemite-r7-0234', 01:31:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:31:54 INFO - 'use_talos_json': True, 01:31:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:31:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:31:54 INFO - 'work_dir': 'build'} 01:31:54 INFO - [mozharness: 2017-05-04 08:31:54.344575Z] Running clobber step. 01:31:54 INFO - Running pre-action listener: _resource_record_pre_action 01:31:54 INFO - Running main action method: clobber 01:31:54 INFO - rmtree: /builds/slave/test/build 01:31:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:31:56 INFO - Running post-action listener: _resource_record_post_action 01:31:56 INFO - [mozharness: 2017-05-04 08:31:56.819476Z] Finished clobber step (success) 01:31:56 INFO - [mozharness: 2017-05-04 08:31:56.819614Z] Running read-buildbot-config step. 01:31:56 INFO - Running pre-action listener: _resource_record_pre_action 01:31:56 INFO - Running main action method: read_buildbot_config 01:31:56 INFO - Using buildbot properties: 01:31:56 INFO - { 01:31:56 INFO - "project": "", 01:31:56 INFO - "product": "firefox", 01:31:56 INFO - "script_repo_revision": "production", 01:31:56 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 01:31:56 INFO - "repository": "", 01:31:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 01:31:56 INFO - "buildid": "20170503233720", 01:31:56 INFO - "pgo_build": "False", 01:31:56 INFO - "basedir": "/builds/slave/test", 01:31:56 INFO - "buildnumber": 23, 01:31:56 INFO - "slavename": "t-yosemite-r7-0234", 01:31:56 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 01:31:56 INFO - "platform": "yosemite_r7", 01:31:56 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 01:31:56 INFO - "branch": "mozilla-beta", 01:31:56 INFO - "repo_path": "releases/mozilla-beta", 01:31:56 INFO - "revision": "5b0b0f86fd2624e1b5ca0f1fa04dcdaf8800edf9", 01:31:56 INFO - "stage_platform": "macosx64", 01:31:56 INFO - "builduid": "60aaf9d2566a48e582bec511af4d4a34", 01:31:56 INFO - "slavebuilddir": "test" 01:31:56 INFO - } 01:31:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZzmhA1fZSn2NwhvHHbQg6w/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 01:31:56 INFO - Running post-action listener: _resource_record_post_action 01:31:56 INFO - [mozharness: 2017-05-04 08:31:56.822901Z] Finished read-buildbot-config step (success) 01:31:56 INFO - [mozharness: 2017-05-04 08:31:56.823033Z] Running download-and-extract step. 01:31:56 INFO - Running pre-action listener: _resource_record_pre_action 01:31:56 INFO - Running main action method: download_and_extract 01:31:56 INFO - mkdir: /builds/slave/test/build/tests 01:31:56 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')]} 01:31:56 INFO - trying https://queue.taskcluster.net/v1/task/ZzmhA1fZSn2NwhvHHbQg6w/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 01:31:56 INFO - Downloading https://queue.taskcluster.net/v1/task/ZzmhA1fZSn2NwhvHHbQg6w/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 01:31:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZzmhA1fZSn2NwhvHHbQg6w/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 01:31:57 INFO - Downloaded 1287 bytes. 01:31:57 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 01:31:57 INFO - Using the following test package requirements: 01:31:57 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 01:31:57 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 01:31:57 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 01:31:57 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 01:31:57 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 01:31:57 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 01:31:57 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 01:31:57 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 01:31:57 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 01:31:57 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 01:31:57 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 01:31:57 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 01:31:57 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 01:31:57 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 01:31:57 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 01:31:57 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 01:31:57 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 01:31:57 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 01:31:57 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 01:31:57 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 01:31:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZzmhA1fZSn2NwhvHHbQg6w/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 01:31:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZzmhA1fZSn2NwhvHHbQg6w/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 01:31:57 INFO - Fetch https://queue.taskcluster.net/v1/task/ZzmhA1fZSn2NwhvHHbQg6w/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 01:31:59 INFO - Expected file size: 51223605 01:31:59 INFO - Obtained file size: 51223605 01:32:15 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 01:32:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZzmhA1fZSn2NwhvHHbQg6w/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 01:32:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZzmhA1fZSn2NwhvHHbQg6w/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 01:32:15 INFO - Fetch https://queue.taskcluster.net/v1/task/ZzmhA1fZSn2NwhvHHbQg6w/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 01:32:16 INFO - Expected file size: 51223605 01:32:16 INFO - Obtained file size: 51223605 01:32:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZzmhA1fZSn2NwhvHHbQg6w/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 01:32:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZzmhA1fZSn2NwhvHHbQg6w/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 01:32:31 INFO - Fetch https://queue.taskcluster.net/v1/task/ZzmhA1fZSn2NwhvHHbQg6w/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 01:32:33 INFO - Expected file size: 14404449 01:32:33 INFO - Obtained file size: 14404449 01:32: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')]} 01:32:33 INFO - trying https://queue.taskcluster.net/v1/task/ZzmhA1fZSn2NwhvHHbQg6w/artifacts/public/build/firefox-54.0.en-US.mac.dmg 01:32:33 INFO - Downloading https://queue.taskcluster.net/v1/task/ZzmhA1fZSn2NwhvHHbQg6w/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 01:32:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZzmhA1fZSn2NwhvHHbQg6w/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 01:32:35 INFO - Downloaded 59548136 bytes. 01:32:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZzmhA1fZSn2NwhvHHbQg6w/artifacts/public/build/firefox-54.0.en-US.mac.dmg 01:32:35 INFO - mkdir: /builds/slave/test/properties 01:32:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:32:35 INFO - Writing to file /builds/slave/test/properties/build_url 01:32:35 INFO - Contents: 01:32:35 INFO - build_url:https://queue.taskcluster.net/v1/task/ZzmhA1fZSn2NwhvHHbQg6w/artifacts/public/build/firefox-54.0.en-US.mac.dmg 01:32:36 INFO - Running post-action listener: _resource_record_post_action 01:32:36 INFO - Running post-action listener: set_extra_try_arguments 01:32:36 INFO - [mozharness: 2017-05-04 08:32:36.191640Z] Finished download-and-extract step (success) 01:32:36 INFO - [mozharness: 2017-05-04 08:32:36.191799Z] Running populate-webroot step. 01:32:36 INFO - Running pre-action listener: _resource_record_pre_action 01:32:36 INFO - Running main action method: populate_webroot 01:32:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:32:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:32:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:32:36 INFO - '--tppagecycles', 01:32:36 INFO - '7'], 01:32:36 INFO - 'tests': ['tsvgm']}}, 01:32:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:32:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:32:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:32:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:32:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:32:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:32:36 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:32:36 INFO - 'talos_options': ['--disable-e10s'], 01:32:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:32:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:32:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:32:36 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:32:36 INFO - 'talos_options': ['--disable-e10s'], 01:32:36 INFO - 'tests': ['damp', 'tps']}, 01:32:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:32:36 INFO - 'tests': ['damp', 'tps']}, 01:32:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:32:36 INFO - 'tests': ['dromaeo_dom']}, 01:32:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:32:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:32:36 INFO - 'tests': ['basic_compositor_video']}, 01:32:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:32:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:32:36 INFO - 'tests': ['a11yr', 01:32:36 INFO - 'ts_paint', 01:32:36 INFO - 'tpaint', 01:32:36 INFO - 'sessionrestore', 01:32:36 INFO - 'sessionrestore_no_auto_restore', 01:32:36 INFO - 'tabpaint']}, 01:32:36 INFO - 'other-e10s': {'tests': ['a11yr', 01:32:36 INFO - 'ts_paint', 01:32:36 INFO - 'tpaint', 01:32:36 INFO - 'sessionrestore', 01:32:36 INFO - 'sessionrestore_no_auto_restore', 01:32:36 INFO - 'tabpaint']}, 01:32:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:32:36 INFO - 'ts_paint', 01:32:36 INFO - 'tpaint', 01:32:36 INFO - 'sessionrestore', 01:32:36 INFO - 'sessionrestore_no_auto_restore', 01:32:36 INFO - 'tabpaint']}, 01:32:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:32:36 INFO - 'ts_paint', 01:32:36 INFO - 'tpaint', 01:32:36 INFO - 'sessionrestore', 01:32:36 INFO - 'sessionrestore_no_auto_restore', 01:32:36 INFO - 'tabpaint']}, 01:32:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:32:36 INFO - 'tests': ['a11yr', 01:32:36 INFO - 'ts_paint', 01:32:36 INFO - 'tpaint', 01:32:36 INFO - 'sessionrestore', 01:32:36 INFO - 'sessionrestore_no_auto_restore', 01:32:36 INFO - 'tabpaint']}, 01:32:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:32:36 INFO - 'tests': ['a11yr', 01:32:36 INFO - 'ts_paint', 01:32:36 INFO - 'tpaint', 01:32:36 INFO - 'sessionrestore', 01:32:36 INFO - 'sessionrestore_no_auto_restore', 01:32:36 INFO - 'tabpaint']}, 01:32:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:32:36 INFO - 'tests': ['tsvgx', 01:32:36 INFO - 'tsvgr_opacity', 01:32:36 INFO - 'tart', 01:32:36 INFO - 'tscrollx', 01:32:36 INFO - 'cart', 01:32:36 INFO - 'tsvg_static']}, 01:32:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:32:36 INFO - 'tsvgr_opacity', 01:32:36 INFO - 'tart', 01:32:36 INFO - 'tscrollx', 01:32:36 INFO - 'cart', 01:32:36 INFO - 'tsvg_static']}, 01:32:36 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:32:36 INFO - 'talos_options': ['--disable-e10s'], 01:32:36 INFO - 'tests': ['tp5o']}, 01:32:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:32:36 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:32:36 INFO - 'talos_options': ['--disable-e10s', 01:32:36 INFO - '--xperf_path', 01:32:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:32:36 INFO - 'tests': ['tp5n']}, 01:32:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:32:36 INFO - 'talos_options': ['--xperf_path', 01:32:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:32:36 INFO - 'tests': ['tp5n']}}, 01:32:36 INFO - 'talos.zip': {'path': '', 01:32:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:32:36 INFO - Running post-action listener: _resource_record_post_action 01:32:36 INFO - [mozharness: 2017-05-04 08:32:36.210262Z] Finished populate-webroot step (success) 01:32:36 INFO - [mozharness: 2017-05-04 08:32:36.210399Z] Running create-virtualenv step. 01:32:36 INFO - Running pre-action listener: _resource_record_pre_action 01:32:36 INFO - Running main action method: create_virtualenv 01:32:36 INFO - Creating virtualenv /builds/slave/test/build/venv 01:32:36 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 01:32:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:32:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:32:36 INFO - Using real prefix '/tools/python27' 01:32:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:32:37 INFO - Installing distribute.............................................................................................................................................................................................done. 01:32:39 INFO - Installing pip.................done. 01:32:39 INFO - Return code: 0 01:32:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:32:40 INFO - Reading from file tmpfile_stdout 01:32:40 INFO - Output received: 01:32:40 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) 01:32:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106d0eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d11768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff953c937f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106aecd30>, '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 0x106a13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ae1be8>, '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.A1PGQKau6P/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.MWCTJgnNF8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 01:32:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:32:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A1PGQKau6P/Render', 01:32:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:32:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:32:40 INFO - 'HOME': '/Users/cltbld', 01:32:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:32:40 INFO - 'LOGNAME': 'cltbld', 01:32:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:40 INFO - 'MOZ_NO_REMOTE': '1', 01:32:40 INFO - 'NO_EM_RESTART': '1', 01:32:40 INFO - 'PAGER': '/bin/cat', 01:32:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:32:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:40 INFO - 'PWD': '/builds/slave/test', 01:32:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:32:40 INFO - 'SHELL': '/bin/bash', 01:32:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MWCTJgnNF8/Listeners', 01:32:40 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 01:32:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:32:40 INFO - 'USER': 'cltbld', 01:32:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:32:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:32:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:40 INFO - 'XPC_FLAGS': '0x0', 01:32:40 INFO - 'XPC_SERVICE_NAME': '0', 01:32:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:40 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 01:32:40 INFO - Cleaning up... 01:32:40 INFO - Return code: 0 01:32:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106d0eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d11768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff953c937f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106aecd30>, '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 0x106a13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ae1be8>, '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.A1PGQKau6P/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.MWCTJgnNF8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 01:32:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:32:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A1PGQKau6P/Render', 01:32:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:32:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:32:40 INFO - 'HOME': '/Users/cltbld', 01:32:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:32:40 INFO - 'LOGNAME': 'cltbld', 01:32:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:40 INFO - 'MOZ_NO_REMOTE': '1', 01:32:40 INFO - 'NO_EM_RESTART': '1', 01:32:40 INFO - 'PAGER': '/bin/cat', 01:32:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:32:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:40 INFO - 'PWD': '/builds/slave/test', 01:32:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:32:40 INFO - 'SHELL': '/bin/bash', 01:32:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MWCTJgnNF8/Listeners', 01:32:40 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 01:32:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:32:40 INFO - 'USER': 'cltbld', 01:32:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:32:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:32:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:40 INFO - 'XPC_FLAGS': '0x0', 01:32:40 INFO - 'XPC_SERVICE_NAME': '0', 01:32:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:40 INFO - Downloading/unpacking psutil>=3.1.1 01:32:40 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 01:32:40 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 01:32:40 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 01:32:40 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 01:32:40 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 01:32:40 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 01:32:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:32:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:32:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:32:43 INFO - Installing collected packages: psutil 01:32:43 INFO - Running setup.py install for psutil 01:32:43 INFO - building 'psutil._psutil_osx' extension 01:32:43 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 01:32:43 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 01:32:43 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 01:32:43 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 01:32:43 INFO - building 'psutil._psutil_posix' extension 01:32:43 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 01:32:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:32:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:32:43 INFO - ^ 01:32:43 INFO - 1 warning generated. 01:32:44 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 01:32:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:32:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:32:44 INFO - Successfully installed psutil 01:32:44 INFO - Cleaning up... 01:32:44 INFO - Return code: 0 01:32:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:44 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 0x106d0eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d11768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff953c937f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106aecd30>, '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 0x106a13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ae1be8>, '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.A1PGQKau6P/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.MWCTJgnNF8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 01:32:44 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 01:32:44 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 01:32:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A1PGQKau6P/Render', 01:32:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:32:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:32:44 INFO - 'HOME': '/Users/cltbld', 01:32:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:32:44 INFO - 'LOGNAME': 'cltbld', 01:32:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:44 INFO - 'MOZ_NO_REMOTE': '1', 01:32:44 INFO - 'NO_EM_RESTART': '1', 01:32:44 INFO - 'PAGER': '/bin/cat', 01:32:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:32:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:44 INFO - 'PWD': '/builds/slave/test', 01:32:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:32:44 INFO - 'SHELL': '/bin/bash', 01:32:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MWCTJgnNF8/Listeners', 01:32:44 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 01:32:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:32:44 INFO - 'USER': 'cltbld', 01:32:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:32:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:32:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:44 INFO - 'XPC_FLAGS': '0x0', 01:32:44 INFO - 'XPC_SERVICE_NAME': '0', 01:32:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:32:45 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 01:32:45 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 01:32:45 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 01:32:45 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 01:32:45 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 01:32:45 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 01:32:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:32:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:32:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:32:46 INFO - Installing collected packages: mozsystemmonitor 01:32:46 INFO - Running setup.py install for mozsystemmonitor 01:32:47 INFO - Successfully installed mozsystemmonitor 01:32:47 INFO - Cleaning up... 01:32:47 INFO - Return code: 0 01:32:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:32:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:47 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 0x106d0eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d11768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff953c937f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106aecd30>, '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 0x106a13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ae1be8>, '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.A1PGQKau6P/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.MWCTJgnNF8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 01:32:47 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 01:32:47 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 01:32:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A1PGQKau6P/Render', 01:32:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:32:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:32:47 INFO - 'HOME': '/Users/cltbld', 01:32:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:32:47 INFO - 'LOGNAME': 'cltbld', 01:32:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:47 INFO - 'MOZ_NO_REMOTE': '1', 01:32:47 INFO - 'NO_EM_RESTART': '1', 01:32:47 INFO - 'PAGER': '/bin/cat', 01:32:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:47 INFO - 'PWD': '/builds/slave/test', 01:32:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:32:47 INFO - 'SHELL': '/bin/bash', 01:32:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MWCTJgnNF8/Listeners', 01:32:47 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 01:32:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:32:47 INFO - 'USER': 'cltbld', 01:32:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:32:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:47 INFO - 'XPC_FLAGS': '0x0', 01:32:47 INFO - 'XPC_SERVICE_NAME': '0', 01:32:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:32:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:47 INFO - Downloading/unpacking jsonschema==2.5.1 01:32:47 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 01:32:47 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 01:32:47 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 01:32:47 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 01:32:47 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 01:32:47 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 01:32:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:32:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:32:48 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 01:32:48 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 01:32:48 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 01:32:48 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 01:32:48 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 01:32:48 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 01:32:48 INFO - Downloading functools32-3.2.3-2.tar.gz 01:32:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:32:49 INFO - warning: no files found matching '*.txt' 01:32:49 INFO - no previously-included directories found matching 'build' 01:32:49 INFO - no previously-included directories found matching 'dist' 01:32:49 INFO - no previously-included directories found matching '.git*' 01:32:49 INFO - Installing collected packages: jsonschema, functools32 01:32:49 INFO - Running setup.py install for functools32 01:32:49 INFO - warning: no files found matching '*.txt' 01:32:49 INFO - no previously-included directories found matching 'build' 01:32:49 INFO - no previously-included directories found matching 'dist' 01:32:49 INFO - no previously-included directories found matching '.git*' 01:32:49 INFO - Successfully installed jsonschema functools32 01:32:49 INFO - Cleaning up... 01:32:49 INFO - Return code: 0 01:32:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:32:49 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')]} 01:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:49 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')]} 01:32:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:49 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 0x106d0eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d11768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff953c937f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106aecd30>, '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 0x106a13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ae1be8>, '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.A1PGQKau6P/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.MWCTJgnNF8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 01:32:49 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 01:32:49 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 01:32:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A1PGQKau6P/Render', 01:32:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:32:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:32:49 INFO - 'HOME': '/Users/cltbld', 01:32:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:32:49 INFO - 'LOGNAME': 'cltbld', 01:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:49 INFO - 'MOZ_NO_REMOTE': '1', 01:32:49 INFO - 'NO_EM_RESTART': '1', 01:32:49 INFO - 'PAGER': '/bin/cat', 01:32:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:49 INFO - 'PWD': '/builds/slave/test', 01:32:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:32:49 INFO - 'SHELL': '/bin/bash', 01:32:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MWCTJgnNF8/Listeners', 01:32:49 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 01:32:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:32:49 INFO - 'USER': 'cltbld', 01:32:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:32:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:49 INFO - 'XPC_FLAGS': '0x0', 01:32:49 INFO - 'XPC_SERVICE_NAME': '0', 01:32:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:32:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:32:49 INFO - Cleaning up... 01:32:49 INFO - Return code: 0 01:32:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:32:49 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')]} 01:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:49 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')]} 01:32:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:49 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 0x106d0eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d11768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff953c937f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106aecd30>, '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 0x106a13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ae1be8>, '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.A1PGQKau6P/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.MWCTJgnNF8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 01:32:49 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 01:32:49 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 01:32:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A1PGQKau6P/Render', 01:32:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:32:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:32:49 INFO - 'HOME': '/Users/cltbld', 01:32:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:32:49 INFO - 'LOGNAME': 'cltbld', 01:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:49 INFO - 'MOZ_NO_REMOTE': '1', 01:32:49 INFO - 'NO_EM_RESTART': '1', 01:32:49 INFO - 'PAGER': '/bin/cat', 01:32:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:49 INFO - 'PWD': '/builds/slave/test', 01:32:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:32:49 INFO - 'SHELL': '/bin/bash', 01:32:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MWCTJgnNF8/Listeners', 01:32:49 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 01:32:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:32:49 INFO - 'USER': 'cltbld', 01:32:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:32:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:49 INFO - 'XPC_FLAGS': '0x0', 01:32:49 INFO - 'XPC_SERVICE_NAME': '0', 01:32:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:32:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:49 INFO - Downloading/unpacking blobuploader==1.2.4 01:32:49 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 01:32:49 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 01:32:49 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 01:32:49 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 01:32:49 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 01:32:49 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 01:32:51 INFO - Downloading blobuploader-1.2.4.tar.gz 01:32:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:32:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:32:51 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 01:32:51 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 01:32:51 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 01:32:51 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 01:32:51 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 01:32:51 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 01:32:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:32:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:32:51 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 01:32:51 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 01:32:51 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 01:32:51 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 01:32:51 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 01:32:51 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 01:32:52 INFO - Downloading docopt-0.6.1.tar.gz 01:32:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:32:52 INFO - Installing collected packages: blobuploader, requests, docopt 01:32:52 INFO - Running setup.py install for blobuploader 01:32:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:32:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:32:52 INFO - Running setup.py install for requests 01:32:52 INFO - Running setup.py install for docopt 01:32:52 INFO - Successfully installed blobuploader requests docopt 01:32:52 INFO - Cleaning up... 01:32:52 INFO - Return code: 0 01:32:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:32:52 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')]} 01:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:52 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')]} 01:32:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:52 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 0x106d0eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d11768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff953c937f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106aecd30>, '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 0x106a13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ae1be8>, '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.A1PGQKau6P/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.MWCTJgnNF8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 01:32:52 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 01:32:52 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 01:32:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A1PGQKau6P/Render', 01:32:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:32:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:32:52 INFO - 'HOME': '/Users/cltbld', 01:32:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:32:52 INFO - 'LOGNAME': 'cltbld', 01:32:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:52 INFO - 'MOZ_NO_REMOTE': '1', 01:32:52 INFO - 'NO_EM_RESTART': '1', 01:32:52 INFO - 'PAGER': '/bin/cat', 01:32:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:32:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:52 INFO - 'PWD': '/builds/slave/test', 01:32:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:32:52 INFO - 'SHELL': '/bin/bash', 01:32:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MWCTJgnNF8/Listeners', 01:32:52 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 01:32:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:32:52 INFO - 'USER': 'cltbld', 01:32:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:32:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:32:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:52 INFO - 'XPC_FLAGS': '0x0', 01:32:52 INFO - 'XPC_SERVICE_NAME': '0', 01:32:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:32:53 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-ucQbh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:32:53 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-B8WWAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:32:53 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-lj0Jmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:32:53 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-9Xh51i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:32:53 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-NxC9Gv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:32:53 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-pFECdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:32:53 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-Nq_U5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:32:53 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-BSzZUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:32:54 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-EDQSHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:32:54 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-WmtT_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:32:54 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-WF_7BI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:32:54 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-rRiMxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:32:54 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-nQhVrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:32:54 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-KYpG18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:32:54 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-29EZJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:32:54 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-klyZgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:32:54 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-mhPRMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:32:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:32:54 INFO - Running setup.py install for manifestparser 01:32:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:32:55 INFO - Running setup.py install for mozcrash 01:32:55 INFO - Running setup.py install for mozdebug 01:32:55 INFO - Running setup.py install for mozdevice 01:32:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:32:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:32:55 INFO - Running setup.py install for mozfile 01:32:55 INFO - Running setup.py install for mozhttpd 01:32:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:32:55 INFO - Running setup.py install for mozinfo 01:32:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:32:56 INFO - Running setup.py install for mozInstall 01:32:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:32:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:32:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:32:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:32:56 INFO - Running setup.py install for mozleak 01:32:56 INFO - Running setup.py install for mozlog 01:32:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:32:56 INFO - Running setup.py install for moznetwork 01:32:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:32:56 INFO - Running setup.py install for mozprocess 01:32:56 INFO - Running setup.py install for mozprofile 01:32:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:32:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:32:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:32:56 INFO - Running setup.py install for mozrunner 01:32:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:32:57 INFO - Running setup.py install for mozscreenshot 01:32:57 INFO - Running setup.py install for moztest 01:32:57 INFO - Running setup.py install for mozversion 01:32:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:32:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:32:57 INFO - Cleaning up... 01:32:57 INFO - Return code: 0 01:32:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:32:57 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')]} 01:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:57 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')]} 01:32:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:57 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 0x106d0eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d11768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff953c937f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106aecd30>, '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 0x106a13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ae1be8>, '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.A1PGQKau6P/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.MWCTJgnNF8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 01:32:57 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 01:32:57 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 01:32:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A1PGQKau6P/Render', 01:32:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:32:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:32:57 INFO - 'HOME': '/Users/cltbld', 01:32:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:32:57 INFO - 'LOGNAME': 'cltbld', 01:32:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:57 INFO - 'MOZ_NO_REMOTE': '1', 01:32:57 INFO - 'NO_EM_RESTART': '1', 01:32:57 INFO - 'PAGER': '/bin/cat', 01:32:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:32:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:57 INFO - 'PWD': '/builds/slave/test', 01:32:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:32:57 INFO - 'SHELL': '/bin/bash', 01:32:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MWCTJgnNF8/Listeners', 01:32:57 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 01:32:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:32:57 INFO - 'USER': 'cltbld', 01:32:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:32:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:32:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:57 INFO - 'XPC_FLAGS': '0x0', 01:32:57 INFO - 'XPC_SERVICE_NAME': '0', 01:32:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:32:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:32:57 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-mC9HGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:32:57 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)) 01:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:32:57 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-3cFV4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:32:58 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)) 01:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:32:58 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-zcyDDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:32:58 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)) 01:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:32:58 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-nPohJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:32:58 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)) 01:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:32:58 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-B9NqQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:32:58 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)) 01:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:32:58 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-6sFiVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:32:58 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)) 01:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:32:58 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-46Owdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:32:58 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)) 01:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:32:58 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-7Vy1CW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:32:58 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)) 01:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:32:58 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-n7QucH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:32:58 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)) 01:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:32:58 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-_5epQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:32:58 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)) 01:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:32:58 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-3YTgpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:32:59 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)) 01:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:32:59 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-u_0pbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:32:59 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)) 01:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:32:59 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-jZZX3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:32:59 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)) 01:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:32:59 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-W9rTPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:32:59 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)) 01:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:32:59 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-Vyj6Bw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:32:59 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)) 01:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:32:59 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-mJTTZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:32:59 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)) 01:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:32:59 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-Pqe3Y1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:32:59 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)) 01:32:59 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)) 01:32:59 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)) 01:32:59 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)) 01:32:59 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)) 01:32:59 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)) 01:32:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:00 INFO - Downloading blessings-1.6.tar.gz 01:33:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:33:01 INFO - Installing collected packages: blessings 01:33:01 INFO - Running setup.py install for blessings 01:33:01 INFO - Successfully installed blessings 01:33:01 INFO - Cleaning up... 01:33:01 INFO - Return code: 0 01:33:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:33:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:33:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:33:01 INFO - Reading from file tmpfile_stdout 01:33:01 INFO - Current package versions: 01:33:01 INFO - blessings == 1.6 01:33:01 INFO - blobuploader == 1.2.4 01:33:01 INFO - docopt == 0.6.1 01:33:01 INFO - functools32 == 3.2.3-2 01:33:01 INFO - jsonschema == 2.5.1 01:33:01 INFO - manifestparser == 1.1 01:33:01 INFO - mozInstall == 1.12 01:33:01 INFO - mozcrash == 1.0 01:33:01 INFO - mozdebug == 0.1 01:33:01 INFO - mozdevice == 0.49 01:33:01 INFO - mozfile == 1.2 01:33:01 INFO - mozhttpd == 0.7 01:33:01 INFO - mozinfo == 0.9 01:33:01 INFO - mozleak == 0.1 01:33:01 INFO - mozlog == 3.4 01:33:01 INFO - moznetwork == 0.27 01:33:01 INFO - mozprocess == 0.25 01:33:01 INFO - mozprofile == 0.28 01:33:01 INFO - mozrunner == 6.13 01:33:01 INFO - mozscreenshot == 0.1 01:33:01 INFO - mozsystemmonitor == 0.3 01:33:01 INFO - moztest == 0.8 01:33:01 INFO - mozversion == 1.4 01:33:01 INFO - psutil == 3.1.1 01:33:01 INFO - requests == 1.2.3 01:33:01 INFO - wsgiref == 0.1.2 01:33:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:33:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:01 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 0x106d0eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d11768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff953c937f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106aecd30>, '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 0x106a13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ae1be8>, '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.A1PGQKau6P/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.MWCTJgnNF8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 01:33:01 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 01:33:01 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 01:33:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A1PGQKau6P/Render', 01:33:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:33:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:33:01 INFO - 'HOME': '/Users/cltbld', 01:33:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:33:01 INFO - 'LOGNAME': 'cltbld', 01:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:01 INFO - 'MOZ_NO_REMOTE': '1', 01:33:01 INFO - 'NO_EM_RESTART': '1', 01:33:01 INFO - 'PAGER': '/bin/cat', 01:33:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:01 INFO - 'PWD': '/builds/slave/test', 01:33:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:33:01 INFO - 'SHELL': '/bin/bash', 01:33:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MWCTJgnNF8/Listeners', 01:33:01 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 01:33:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:33:01 INFO - 'USER': 'cltbld', 01:33:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:33:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:01 INFO - 'XPC_FLAGS': '0x0', 01:33:01 INFO - 'XPC_SERVICE_NAME': '0', 01:33:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:33:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:01 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)) 01:33:01 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)) 01:33:01 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)) 01:33:01 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)) 01:33:01 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)) 01:33:01 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)) 01:33:01 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)) 01:33:01 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)) 01:33:01 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)) 01:33:01 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)) 01:33:01 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)) 01:33:01 INFO - Cleaning up... 01:33:01 INFO - Return code: 0 01:33:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:33:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:01 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 0x106d0eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d11768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff953c937f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106aecd30>, '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 0x106a13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ae1be8>, '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.A1PGQKau6P/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.MWCTJgnNF8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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 01:33:01 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 01:33:01 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 01:33:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A1PGQKau6P/Render', 01:33:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:33:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:33:01 INFO - 'HOME': '/Users/cltbld', 01:33:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:33:01 INFO - 'LOGNAME': 'cltbld', 01:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:01 INFO - 'MOZ_NO_REMOTE': '1', 01:33:01 INFO - 'NO_EM_RESTART': '1', 01:33:01 INFO - 'PAGER': '/bin/cat', 01:33:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:01 INFO - 'PWD': '/builds/slave/test', 01:33:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:33:01 INFO - 'SHELL': '/bin/bash', 01:33:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MWCTJgnNF8/Listeners', 01:33:01 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 01:33:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:33:01 INFO - 'USER': 'cltbld', 01:33:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:33:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:01 INFO - 'XPC_FLAGS': '0x0', 01:33:01 INFO - 'XPC_SERVICE_NAME': '0', 01:33:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:33:02 INFO - Cleaning up... 01:33:02 INFO - Return code: 0 01:33:02 INFO - Running post-action listener: _resource_record_post_action 01:33:02 INFO - Running post-action listener: _start_resource_monitoring 01:33:02 INFO - Starting resource monitoring. 01:33:02 INFO - [mozharness: 2017-05-04 08:33:02.157205Z] Finished create-virtualenv step (success) 01:33:02 INFO - [mozharness: 2017-05-04 08:33:02.158208Z] Running install step. 01:33:02 INFO - Running pre-action listener: _resource_record_pre_action 01:33:02 INFO - Running main action method: install 01:33:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:33:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:33:02 INFO - Reading from file tmpfile_stdout 01:33:02 INFO - Detecting whether we're running mozinstall >=1.0... 01:33:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:33:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:33:02 INFO - Reading from file tmpfile_stdout 01:33:02 INFO - Output received: 01:33:02 INFO - Usage: mozinstall [options] installer 01:33:02 INFO - Options: 01:33:02 INFO - -h, --help show this help message and exit 01:33:02 INFO - -d DEST, --destination=DEST 01:33:02 INFO - Directory to install application into. [default: 01:33:02 INFO - "/builds/slave/test"] 01:33:02 INFO - --app=APP Application being installed. [default: firefox] 01:33:02 INFO - mkdir: /builds/slave/test/build/application 01:33:02 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'] 01:33:02 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 01:33:17 INFO - Reading from file tmpfile_stdout 01:33:17 INFO - Output received: 01:33:17 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 01:33:17 INFO - Running post-action listener: _resource_record_post_action 01:33:17 INFO - [mozharness: 2017-05-04 08:33:17.448279Z] Finished install step (success) 01:33:17 INFO - [mozharness: 2017-05-04 08:33:17.448400Z] Running run-tests step. 01:33:17 INFO - Running pre-action listener: _resource_record_pre_action 01:33:17 INFO - Running main action method: run_tests 01:33:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:33:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:33:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:33:17 INFO - 2017-05-04 01:33:17.461 screenresolution[1625:7462] starting screenresolution argv=screenresolution get 01:33:17 INFO - 2017-05-04 01:33:17.463 screenresolution[1625:7462] Display 0: 1600x1200x32@60 01:33:17 INFO - 2017-05-04 01:33:17.468 screenresolution[1626:7464] starting screenresolution argv=screenresolution list 01:33:17 INFO - Available Modes on Display 0 01:33:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:33:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:33:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:33:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:33:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:33:17 INFO - Intel Iris: 01:33:17 INFO - Chipset Model: Intel Iris 01:33:17 INFO - Type: GPU 01:33:17 INFO - Bus: Built-In 01:33:17 INFO - VRAM (Dynamic, Max): 1536 MB 01:33:17 INFO - Vendor: Intel (0x8086) 01:33:17 INFO - Device ID: 0x0a2e 01:33:17 INFO - Revision ID: 0x0009 01:33:17 INFO - Displays: 01:33:17 INFO - Display: 01:33:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:33:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:33:17 INFO - Display Serial Number: 1600x1200 60 01:33:17 INFO - Main Display: Yes 01:33:17 INFO - Mirror: Off 01:33:17 INFO - Online: Yes 01:33:17 INFO - Rotation: Supported 01:33:17 INFO - Return code: 0 01:33:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:33:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:33:17 INFO - Python 2.7.3 01:33:17 INFO - Return code: 0 01:33:17 INFO - grabbing minidump binary from tooltool 01:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:33:17 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 0x106aecd30>, '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 0x106a13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ae1be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:33:17 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 01:33:17 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 01:33:17 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 01:33:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:33:17 INFO - Return code: 0 01:33:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:33:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:33:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:33:17 INFO - ENV: RUST_BACKTRACE is now 1 01:33:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:33:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:33:17 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/ZzmhA1fZSn2NwhvHHbQg6w/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0234', '--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 01:33:17 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/ZzmhA1fZSn2NwhvHHbQg6w/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0234 --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 01:33:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A1PGQKau6P/Render', 01:33:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:33:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:33:17 INFO - 'HOME': '/Users/cltbld', 01:33:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:33:17 INFO - 'LOGNAME': 'cltbld', 01:33:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:33:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:33:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:17 INFO - 'MOZ_NO_REMOTE': '1', 01:33:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:33:17 INFO - 'NO_EM_RESTART': '1', 01:33:17 INFO - 'PAGER': '/bin/cat', 01:33:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:33:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:17 INFO - 'PWD': '/builds/slave/test', 01:33:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:33:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:33:17 INFO - 'RUST_BACKTRACE': '1', 01:33:17 INFO - 'SHELL': '/bin/bash', 01:33:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MWCTJgnNF8/Listeners', 01:33:17 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 01:33:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:33:17 INFO - 'USER': 'cltbld', 01:33:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:33:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:33:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:17 INFO - 'XPC_FLAGS': '0x0', 01:33:17 INFO - 'XPC_SERVICE_NAME': '0', 01:33:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:33:17 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/ZzmhA1fZSn2NwhvHHbQg6w/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0234', '--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 01:33:18 INFO - mozversion application_buildid: 20170503233720 01:33:18 INFO - mozversion application_changeset: 5b0b0f86fd2624e1b5ca0f1fa04dcdaf8800edf9 01:33:18 INFO - mozversion application_display_name: Firefox 01:33:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:33:18 INFO - mozversion application_name: Firefox 01:33:18 INFO - mozversion application_remotingname: firefox 01:33:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 01:33:18 INFO - mozversion application_vendor: Mozilla 01:33:18 INFO - mozversion application_version: 54.0 01:33:18 INFO - mozversion platform_buildid: 20170503233720 01:33:18 INFO - mozversion platform_changeset: 5b0b0f86fd2624e1b5ca0f1fa04dcdaf8800edf9 01:33:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 01:33:18 INFO - mozversion platform_version: 54.0 01:33:18 INFO - using testdate: 1493886798 01:33:18 INFO - actual date: 1493886798 01:33:18 INFO - starting webserver on 'localhost:49240' 01:33:18 INFO - SUITE-START | Running 2 tests 01:33:18 INFO - TEST-START | dromaeo_css 01:33:18 INFO - operating with platform_type : mac_ 01:33:18 INFO - Initialising browser for dromaeo_css test... 01:33:18 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/tmpNiOhU9/profile http://localhost:49240/getInfo.html) 01:33:20 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 01:33:20 INFO - PROCESS | 1636 | colorDepth:24 01:33:20 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 01:33:20 INFO - PROCESS | 1636 | __metrics 01:33:20 INFO - PROCESS | 1636 | 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" 01:33:20 INFO - PROCESS | 1636 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:33:21 INFO - TEST-INFO | 1636: exit 0 01:33:21 INFO - Browser initialized. 01:33:21 INFO - Running cycle 1/1 for dromaeo_css test... 01:33:21 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/tmpNiOhU9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:33:33 INFO - PROCESS | 1638 | RSS: Main: 165310464 01:33:33 INFO - PROCESS | 1638 | 01:36:37 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 01:36:39 INFO - PROCESS | 1638 | RSS: Main: 302600192 01:36:39 INFO - PROCESS | 1638 | 01:39:42 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 01:39:42 INFO - PROCESS | 1638 | RSS: Main: 306540544 01:39:42 INFO - PROCESS | 1638 | 01:42:45 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 01:42:45 INFO - PROCESS | 1638 | RSS: Main: 275959808 01:42:45 INFO - PROCESS | 1638 | 01:45:48 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 01:45:48 INFO - PROCESS | 1638 | RSS: Main: 297627648 01:45:48 INFO - PROCESS | 1638 | 01:48:52 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 01:48:52 INFO - PROCESS | 1638 | RSS: Main: 264314880 01:48:52 INFO - PROCESS | 1638 | 01:51:56 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 01:51:56 INFO - PROCESS | 1638 | RSS: Main: 395550720 01:51:56 INFO - PROCESS | 1638 | 01:51:56 INFO - PROCESS | 1638 | __start_tp_report 01:51:56 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 01:51:56 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 01:51:56 INFO - PROCESS | 1638 | |i|pagename|runs| 01:51:56 INFO - PROCESS | 1638 | |0;dojo.html;3037.468443022471;3477.72178225742;3489.1626009757665;3529.5588051493564;3534.24013837025;6046.576739628223;6107.694615269241;6119.6328220306705;6142.385761423855;6159.969200153999;6100.633961962285;6160.969195154018;6169.660668663222;6186.319504854474;6190.876182476348;5402.9729851350885;5413.756380962846;5431.619786614939;5431.83704488864;5553.111502159655;5313.628046036779;5314.256004159421;5320.388155362125;5499.697516636584;5505;5386.73066346683;5448.809291674792;5477.260569823083;5489.039418101836;5498.092814685572;5446.809361672323;5477.3427188737405;5497.642653227527;5498.835034948958;5507.091329930557;5315.893682126374;5387.218853266255;5424.105022671294;5465.125579907196;5469.015577196143;5845.415458454163;5865.501432378253;5894.440028197314;6160.6611636359985;6167.167432396659;6333.9683301583655;6374.776882809079;6383.744650213986;6388.520860935449;6397.48820094396;6456.451201647866;6487.57830741005;6496.512761542903;6524.249711283216;6528.281888992207;6182.474489668383;6250.468710159596;6261.029540421242;6290.591111577733;6295.779647712308;6355.459785918156;6397.584157029872;6524.445422139172;6564.638944857983;6641.701123449457;6402.327755585689;6406.135171751754;6407.519436042316;6408.327125651739;6416.358364163546;6331.4301712845145;6460.450861676716;6465;6467.805965821033;6472.838179045561;6348.206474190726;6350.841228969312;6382.968085159545;6405.583637063669;6458.257300410419;6313.147725057151;6323.988161894074;6397.840053998687;6424.036394540856;6428.871422571616;5097.388313402415;5099.6175286852895;5122.206058061007;5155.896882062338;5192.065428222956;4656.068786242698;4676.883077923079;4683.859484215479;4715.316279139505;4729.1014707206205;6182.474489668339;6206.472449841724;6209.379062093845;6216.409441103088;6225.968870155711;6309.400606942333;6362.77730279438;6435.678216089177;6474.255460622088;6534.542582019308;6225.470834978987;6233.844153896189;6236.719347629368;6249.9062514062325;6250.874982500324;5731.914021289684;5768.394318596487;5771.509421699203;5788.131780232999;5811.0411782056335;6371.267304260069;6392;6640.800775976729;6643.900341494785;6658.533902626769;6476.352364763675;6536.705848236746;6551.934480655323;6556.573822701509;6562.015697645392;6700.095487109178;6705.1283333166375;6705.463562914858;6724.697388617426;6733.0573719678305;6322.747090116528;6326.43062124411;6360.840978975378;6380.011098279774;6438.259600145856;6362.872742545216;6415.294317625151;6448.580842245239;6465.77369792055;6479.902801457888;6336.081268216175;6349.174607301206;6351;6352.872942541216;6369.713362898773;6235.875282494416;6268.059791031382;6295.370462953668;6333.1766870306565;6342.7145778441;5207.3751149862255;6294.685265736786;6302.464290535172;6337.9366206337345;6345.079963405373;6339.429451349401;6339.461145802658;6353.174087368612;6358.141650877257;6367.77712780069;6127.877442451215;6128.111423843607;6146.832101900624;6217.191765070693;6357.491400687842 01:51:56 INFO - PROCESS | 1638 | |1;ext.html;742.2206682982868;766.6128605054448;780.3445106110865;910.1171863292608;918.1231923513037;29662.555061674066;29978.400431991373;42168.367474487866;42457.57542424575;42530.36204456936;43894.780526097406;44100.55899441004;44102.33846492305;44140.33789493152;44142.558574414245;9620.134187923086;9761.804763904718;9772.511374431286;9794.755131121743;9842.9507852461;7946.562939038351;8114.513129212266;11851.407429628527;11977;12255.754884902297;11980.820287695647;12038.217515861485;12043.638690839289;12047.337396443192;12073.03415726744;11895.405229738522;11945.223560468541;11960.461779219955;11971.162018658653;11992.940035299855;11565.76868462626;11631.185816992815;11658.125640576991;11659.950604445556;11704.414779261004;41347.173056538704;41497;41550.58449415497;41572;41771.7911410441;3997.480327557428;3997.520297564282;4038.9192216155807;4082.9792551862033;4084.9183016339507;28777.28056798576;29016.564751528746;30170.84914575413;30310.696893031007;31065.689343106733;3296.670332966708;3309.4539400998806;3328.467445208755;3425.9314813703586;3447.5690538682666;357010;360419.38532151247;361395;362288;362613;54297.91404171894;54521.72739136358;54552;54600.180997285075;54694.453055469734;57169;57190.42809571934;57228.42771572231;57305.42694573084;57323;15411.383544658313;15887;15905.602359940862;15909.52271431859;15921.761173582405;13452.93273533626;13454.663633409244;13457.528986485622;13465.798013029616;13472.932635336761;10886.346819190874;11078.947499987487;11151.275167114112;12448.190867593577;12666.113372064052;4578.427696537933;5088.956763863399;5724.79963201286;5781.88436231273;5789.7709381887435;1131.9925266512646;1152.3661985907718;1154.4747140051256;1159.7390587117832;1216.2398500936915;27513.899444022416;27598.724012760016;28202.71797282001;28272.29319267035;28436.289092772433;1271.6375832887768;1272.5100836178137;1275.993620031894;1322.4842311498523;1329.1559859489294;14393.78409323861;14581.223781281507;14614.269286535631;14665.04677195979;14788.63028424298;471085;472793;473055;473163;473795;43361.69914902558;51435.742821285654;51859.48140518546;52370.73814630903;55009.724951374985;1449.3188201545256;1481.3185934470264;1490.0314795382872;1497.4010395841533;1498.685276092011;26464.8676756615;27671.72328276772;28134.01530946407;28135;28274.85862570674;42444.57555424406;42504.78747606242;42538.93652658708;42576.57423425726;42641.5075472357;423334;423455;423882;424178;424769;24921.37696557528;30039.549406759354;30145.547816783204;30440.934567290038;30481.237969050064;32709.836450817595;33153;35492;41497.79251103725;43524;20488.89755551213;28883.422331552832;28891.555422229227;29742.851285743433;30043.849780750956;24879.253622391356;25068.24795256145;29066.709332907245;29426.264343391587;29978.700212998465;34819;35710;36010;36042.63957360393;36072.27855442824;21311.78688213098;30064.09807705685;30424.93512727044;30439.086827395215;30613.693863061086;22491.650500969994;22803.88598056999;23759.881200593885;24211.63682544728;24514.14200502974 01:51:56 INFO - PROCESS | 1638 | |2;jquery.html;428.897064704471;437.5602519467934;438.8156974070889;446.4174252600356;449.06594283889496;20482.18071277149;21662;22767.772322276815;22969.4257643559;22986.965586548602;18959.431217063477;22429.887850560764;22588;22878.885605571948;24063.87968060157;6935.3411425914455;6936.063631409771;7014.508984371096;7226.674799634029;7245.094363204599;6921.446284297244;7028.297170282982;7080.929190708079;7091.680874360641;7094.609796461193;6749.392554670078;7030.332118448765;7080.256573059806;7132.179799323067;7145.642717864086;6749.751296010254;6925.272846351161;7081.433485321162;7154.678039488235;7163.997040414346;6833.180018397824;6840.3501667341525;6841.315868413169;6843;6852.657367131674;26121.82451789674;28665.57001644977;28786.856065719538;28875.278118047216;29032;3085.8457077146277;3124.5781819454537;3201.16769639893;3299.010296910917;3333.5499707539657;16419.6716065678;17283.74074388885;17613.29546818126;18110.818891811046;18317.17572709218;2060.958780824375;2082.3856962196187;2120.1731324783345;2133.626615342309;2220.944476388087;80623.67992681563;103266.48366758194;121600.39199804033;122088.38955805253;146778;18758.906205468884;18862.90568547176;22052.669209961863;23219.53560928772;23241.418964526023;35880.820595896854;36419.90740277796;36562.8171859139;36636.26727465489;36644;10281;11132.332060076422;11658;11901.88098119025;11905.380816220417;9675.03249675041;9678.70963871085;9698.75753106178;9873.358231714916;9897.109260166475;10902.400367979837;10921.071708904674;11031.448427578589;11164.9951504365;11203.470906664537;4155.937660935088;4274.487061552633;4286.778268193612;4303.462067241595;4315.805788739452;734.3390948146711;804.8169191288796;837.3008537870825;905.6830109461768;937.9437233765996;23012.76987230106;23487.943042562783;23492.76507234906;23497.412564685677;23515.764842351356;963.4893506441597;980.2745967983641;986.4771671014374;987.6987518806833;1004.542932965499;9630.422174669542;12371;12496.00031997438;12624.305663188428;12665.303408312631;769694;808804.6918357947;809661;820513;829204;92061.15877682409;115258.8133533993;117329.4133529327;144831.65505034867;174441;1256.704674401515;1266.4807428954268;1326.1380102932978;1327.1108357400565;1332.1807088640417;18987.810121898605;20683.896580517;21432.142714291254;21455.249066282606;21460.785392145877;59263;63440.68279658572;66213.66893165695;67868;68353.65823170853;91839.08160918573;94809;95622;96823.51588242014;97015;11381.715457113638;11767.293962362286;11876.881231187577;11900.702482438008;12242.449089791158;13411.798823017467;13577.389017494434;13883.583492495241;13958.371873265525;13966.58100256994;11611.6516504505;11768.764624707286;12069.456874440495;12124.696882577653;12175.75648487043;10901;11006.779864402828;11022.779544409228;11223.22991406817;11435;11760.294382337088;11763.294202347886;11932.880671193525;11981.64055078349;12139.75720485603;9696.466694331597;11774.116941229271;11793.233439826385;12144.089193310361;12158.392080396121;11700.824487632523;11748.823767643664;11822.586209482626;11844.526218951145;12111.878881211074 01:51:56 INFO - PROCESS | 1638 | |3;mootools.html;1591.1010279192249;1599.6080960164754;1621.246120553943;1628.0475921585876;1648.5796121988894;11142.665720028403;11904.166708330398;11920.701982450442;11922.403879806008;11933.940330298346;10928.398938058404;11197.72005699858;11395.544178232882;11443.542258309679;11492.942535287311;2316.976830231693;2348.753380895007;2352.8235382346306;2358.162852187466;2358.3160883343894;2069.668852983523;2368.988155059222;2452.141750387368;2453.55835949529;2464.4331803685163;2360.315508502541;2429;2437.731849496563;2442.9983706680264;2450.8774561271866;2344.167820423742;2411.8794060297005;2417.153996101368;2422.3701837522194;2425.9393515162087;2395.808335333169;2413.855168689884;2414.6015907375263;2425.818063645216;2427.0898413095088;11197.384143872085;11414.258073225214;11417.60038398652;11428.485718142703;11445.08439324852;5841.182234487175;6008.519318454513;6017.398260173992;6026.728797204137;6029.638221706711;3485.146139195888;3604.567451905762;3642.963570364289;3674.577423596294;3684.373656478405;1219.1405059433077;1224.4184012594035;1254.7490501899656;1264.9810252846214;1276.4702648400903;14032.43870245189;14285.78571321431;14690.412383504647;16145.757813632805;16323.26545305464;4040.616141466556;4291.506476755213;4404.933925991113;4414.249577571821;4445.533219011957;9683.176929960891;11875.88124118765;11901.464434100486;11903.404829758478;11918.165728399103;5954.136650185699;5954.672493012839;5960.0761881908375;5965.224520812267;5968.343482216953;5283.4452382499285;5344.038073146793;5408.702521361363;5481;5531.695756733418;3888.4556162137324;3970;3994.6418217805503;4058.918821623551;4078.938815917764;1019.1541020952592;1025.8307379282485;1027.306568066567;1042.718466014172;1046.874375074996;961.6056717759277;981.9459929703935;983.4492684096786;998.8152191844387;1009.6264382178641;6552.443042341359;6566.409023187936;6659.700313485905;6843.520953533205;6864.450843932474;978.8384916488842;986.6398764451068;999.3504222255592;1007.6573964851985;1027.244974943416;4143.606357396043;4229.323308270662;4233.618974292267;4297.333913243452;4379.693421460531;12658.493660253487;13744.450221991008;13858;14444.783328250085;14453;13517.66205844842;13882.236476993863;14412;14420.206888621227;14431.20628365429;8181.672733090729;8412.327013838878;10058.74853128663;10481.842772358421;10568.682939511827;5879.470847623735;5922.55580831448;6721.764738234138;7172.605506697182;7188.38898693596;12283.631491055283;12783.488660453479;12893.871061289643;12968.67578310512;13022.2837743925;13156.73686526245;13238.470461181445;13301.600951971457;13306.46774129024;13488.32558372097;9428.858567121635;9486.667966621411;9492;9640.469774162488;9640.614375424904;10406.47967601632;10501.78996420052;10590.152787777113;10614.787704246026;10646.627368042082;9053.366264361432;9063.365564410427;9086.091390860862;9108.225800807006;9151.908480915372;8708.433951793113;8821.955890220508;8864.468131912106;8877.156670116328;8947.418417802823;8089.797755056171;8126.471779334324;8213.671453141807;8247.463914845515;8284.212999765012;4913.77887995034;5916.171735956884;6015.699215039318;6211.254649442096;6263.968680156752;6105.511559075175;6132.41742034506;6153.138560601609;6210.7515699371515;6305.274893387319 01:51:56 INFO - PROCESS | 1638 | |4;prototype.html;377.0900389527045;387.5814120749591;398.1996187662798;398.6153362005664;400.1996007984032;4370.781460926957;4731.787069581868;4996.300517927493;5072.568831649305;5184.948150518499;4487.282034874421;4909.803607855691;4968.925466118011;4995.625328100389;5127.2309153626975;3789.1770630880033;3835.5972622874615;4171.332586786115;4193.804765641793;4241.342591898246;3762.1159027628487;4250.851220207293;4267.957320426787;4268.7225330353585;4274.40949602334;3425.845836937331;4088.4480595119726;4174.812133454002;4180.602842729936;4251.4685664291965;3629.364861149288;3943.797141871728;4224.155168966219;4254.574542545752;4258.787060646986;3568.377242726594;3918.3534716771696;3928.155446578999;3960.821763020671;3962.405639154121;3827.445020472016;4404.427424434835;4924.138275801756;4986.476177266099;5076.781572422592;4382.663287697251;4735.810567577293;4845.975770121162;4956.4547899731;4962.677425967337;4463.48241597855;5380.596455265871;5416.647917885325;5450.710701505338;5509.283793106911;3774.622262874059;3783.4892289541112;4374.759388233646;4409.426774519324;4419.911601767979;5405.864853378657;5662.85842853932;5711.228984087178;5720.542356611461;5777.393373695785;3870.974191839165;4494.4606647202545;4511.503734589192;4515.841945531891;4562.817487300537;4043.9081448008874;4584.770761461914;4588.95411045892;4677.859664210079;4693.732692173094;4289.418095737547;4627.791749371287;4715.528447155326;4812.230043193073;4829.806807727651;5265.8151915818635;5401.270828438111;5430.456954304617;5436.293281873332;5438;1425.9163036092643;1438.3886848089521;1477.4459577658379;1572.3239007227003;1599.2003998001;1053.7870472008874;1081.3187691754144;1114.3759494683004;1186.8013306560435;1191.0471622701805;4970.826021089317;5006.4730257271885;5011.373578302712;5034.0938631046765;5057.848264552069;5003.524665156804;5602.2717046783655;5623.6539259140745;5635.802037205493;5645.322561292671;4149.813258403379;4553.066621342617;4733.455652599995;4789.257665061921;4845.103655823684;2634.4335967767024;2813.5779633054794;2903.9419211616073;2904.782141339408;2912.4079569183446;5125.1799712045895;5377.865553361197;5545.750441230154;5725.885482290414;5828.88342233153;4994.101061808837;5210.847437300455;5405.324334458192;5499.945000550023;5527.462424048612;4780.498047704941;5297.125974214288;5409.756560954766;5638.859028524238;5690.5447564194765;5554.611177217556;5573.631206737039;5637.943620563742;5754.309482861916;5773.162891380643;4236.724612900151;5106.948930510647;5373.059714550016;5467.535259502987;5545.556355491632;5444.646098003617;5457.563394928476;5749.9712501437225;5773.9895518284975;5854.180414741854;4192.874213773592;4206.424539141827;4476.194285028726;4542.364069030405;4548.704334218398;5063.13926632466;5109.901371205208;5340.679559226459;5593.300837395325;5683.374828768915;5025.472325405926;5075.016112351786;5447.428020057995;5490.5607551395;5490.6980116094;4443.422355093947;5110.4123025852505;5377.3816011159215;5471.124620060771;5612.943870561406;4621.3530105785885;4831.864511839785;5356.634058315105;5414.675119492843;5428.91856622143;4688.835890743808;4868.367112275381;5517.172424136412;5538.723063846711;5556.16657501378;4453.309736990772;4541.772911354353;4991.950080499294;5318.813841515528;5420.430854760351 01:51:56 INFO - PROCESS | 1638 | |5;yui.html;717.5479447947793;738.2654259012284;766.3983772738397;884.0893879304317;891.1177933845495;14219;16352.672946541063;17311.740323895137;17328.56678583036;17329.30682772691;15909.2840822163;16017.11905845178;16033;16037.679246415064;16063.518094457157;982.4547376206202;983.7638966647988;1003.7289931718432;1023.1303392116679;1034.6740776655367;1027.1166796554958;1031;1031.3760175094073;1032.917366610673;1035.083950703625;1070.464767616192;1072.3565860483725;1072.5870539842178;1073.3452593917705;1073.5866691323859;1063.3460421840512;1065.323519565074;1065.3554599467366;1065.6589891234808;1067.909227715645;793.0245797668842;793.436659971421;793.5794029164553;794.0233512779314;795.0538858758059;16214.513564592962;16669.24988375526;17097.059661718602;17203;17296.82703172965;13788.586342409744;13967.65080872976;13970.371333290026;14031;14043.859561404357;11815;11868.228565143325;12110.697232569168;12221.572244971472;12630.74738505234;3789.0716774390175;3843.8270277837564;3893.157994663883;4064.4919385076864;4065.9390109148385;94796;110431;119498;120105;120214.21800006925;11264.718382040515;11289.943550282196;11452.198346115692;11549.191556591126;11684.240524365889;23820.404489887893;23841.165559205343;23851.284461466184;24323.78381080939;24370.512589748105;7742.264484873928;7997.520148791091;8155.062167850654;8250.46371985819;8302.792430189294;4540.228161212602;4543.4093567836635;4576.26779715244;4584.129015487047;4679.298105284234;3093.6906309368883;3628.32875917956;3703.6111208322736;3764.0966168120003;3810.580836108026;665.5041993714617;667.7495939022866;668.9197296324375;682.2529330383222;682.6416131530887;683.2074793239917;705.5555000349747;726.2954933714288;757.2087168908394;769.1616138409161;9533.16563217882;9981.251406144569;10444.73888152787;10787.690752204362;11057.889421105847;737.2737853214579;737.4616529933179;744.6016381236012;746.4252525555293;746.633660401464;4952.1581331173065;5198;5321.8935621287355;5331.200319952039;5335.359756829205;93399;94335;94684;95972.52013740026;96097;55247;60701.69649151726;88717;89612.5519372399;92740;75893.6205318981;76010;76261;77897.61051194821;79256.60371698104;10442.269041167348;11080.833787493355;11332;11335.829962550404;11474.827877582009;42906.92732681708;49136.50863491462;49332.50667493279;49367.753161233966;50765;59053;59329.11006334822;60680.39319606924;60854.69572652109;61232.693836532315;10554.577816887238;13168.934155329162;13414.798778018143;13428.39572219272;13470.865291347352;14497.710045799236;15287.312070956612;15304.234788260765;15393;15399.61500962485;13440.865591343962;13588.45646174142;13750.518731844337;14521.491747788778;15023.774643380139;13622.318884055956;14420.206888621227;14461.855381446472;14854.925725371304;14897.404103835725;12893.871061289266;13962.371693273624;14152.858471415155;14310.37219268289;14566.126032437664;9604.471754053595;10341.896581034394;10445.216608754221;10446.843297350697;10491.895081049397;10054.044865737744;10109.787059991426;10337.431441270803;11075.778484430428;11119 01:51:56 INFO - PROCESS | 1638 | __end_tp_report 01:51:56 INFO - PROCESS | 1638 | __start_cc_report 01:51:56 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,1360 01:51:56 INFO - PROCESS | 1638 | __end_cc_report 01:51:56 INFO - PROCESS | 1638 | __startTimestamp1493887916426__endTimestamp 01:51:56 INFO - PROCESS | 1638 | 01:51:56 INFO - PROCESS | 1638 | ------- Summary: start ------- 01:51:56 INFO - PROCESS | 1638 | Number of tests: 6 01:51:56 INFO - PROCESS | 1638 | 01:51:56 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:6014.18 Median:6295.37 stddev:666.73 (10.6%) stddev-sans-first:626.55 01:51:56 INFO - PROCESS | 1638 | Values: 3037.5 3477.7 3489.2 3529.6 3534.2 6046.6 6107.7 6119.6 6142.4 6160.0 6100.6 6161.0 6169.7 6186.3 6190.9 5403.0 5413.8 5431.6 5431.8 5553.1 5313.6 5314.3 5320.4 5499.7 5505.0 5386.7 5448.8 5477.3 5489.0 5498.1 5446.8 5477.3 5497.6 5498.8 5507.1 5315.9 5387.2 5424.1 5465.1 5469.0 5845.4 5865.5 5894.4 6160.7 6167.2 6334.0 6374.8 6383.7 6388.5 6397.5 6456.5 6487.6 6496.5 6524.2 6528.3 6182.5 6250.5 6261.0 6290.6 6295.8 6355.5 6397.6 6524.4 6564.6 6641.7 6402.3 6406.1 6407.5 6408.3 6416.4 6331.4 6460.5 6465.0 6467.8 6472.8 6348.2 6350.8 6383.0 6405.6 6458.3 6313.1 6324.0 6397.8 6424.0 6428.9 5097.4 5099.6 5122.2 5155.9 5192.1 4656.1 4676.9 4683.9 4715.3 4729.1 6182.5 6206.5 6209.4 6216.4 6226.0 6309.4 6362.8 6435.7 6474.3 6534.5 6225.5 6233.8 6236.7 6249.9 6250.9 5731.9 5768.4 5771.5 5788.1 5811.0 6371.3 6392.0 6640.8 6643.9 6658.5 6476.4 6536.7 6551.9 6556.6 6562.0 6700.1 6705.1 6705.5 6724.7 6733.1 6322.7 6326.4 6360.8 6380.0 6438.3 6362.9 6415.3 6448.6 6465.8 6479.9 6336.1 6349.2 6351.0 6352.9 6369.7 6235.9 6268.1 6295.4 6333.2 6342.7 5207.4 6294.7 6302.5 6337.9 6345.1 6339.4 6339.5 6353.2 6358.1 6367.8 6127.9 6128.1 6146.8 6217.2 6357.5 01:51:56 INFO - PROCESS | 1638 | 01:51:56 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:55824.99 Median:30440.01 stddev:111783.14 (367.2%) stddev-sans-first:112020.22 01:51:56 INFO - PROCESS | 1638 | Values: 742.2 766.6 780.3 910.1 918.1 29662.6 29978.4 42168.4 42457.6 42530.4 43894.8 44100.6 44102.3 44140.3 44142.6 9620.1 9761.8 9772.5 9794.8 9843.0 7946.6 8114.5 11851.4 11977.0 12255.8 11980.8 12038.2 12043.6 12047.3 12073.0 11895.4 11945.2 11960.5 11971.2 11992.9 11565.8 11631.2 11658.1 11660.0 11704.4 41347.2 41497.0 41550.6 41572.0 41771.8 3997.5 3997.5 4038.9 4083.0 4084.9 28777.3 29016.6 30170.8 30310.7 31065.7 3296.7 3309.5 3328.5 3425.9 3447.6 357010.0 360419.4 361395.0 362288.0 362613.0 54297.9 54521.7 54552.0 54600.2 54694.5 57169.0 57190.4 57228.4 57305.4 57323.0 15411.4 15887.0 15905.6 15909.5 15921.8 13452.9 13454.7 13457.5 13465.8 13472.9 10886.3 11078.9 11151.3 12448.2 12666.1 4578.4 5089.0 5724.8 5781.9 5789.8 1132.0 1152.4 1154.5 1159.7 1216.2 27513.9 27598.7 28202.7 28272.3 28436.3 1271.6 1272.5 1276.0 1322.5 1329.2 14393.8 14581.2 14614.3 14665.0 14788.6 471085.0 472793.0 473055.0 473163.0 473795.0 43361.7 51435.7 51859.5 52370.7 55009.7 1449.3 1481.3 1490.0 1497.4 1498.7 26464.9 27671.7 28134.0 28135.0 28274.9 42444.6 42504.8 42538.9 42576.6 42641.5 423334.0 423455.0 423882.0 424178.0 424769.0 24921.4 30039.5 30145.5 30440.9 30481.2 32709.8 33153.0 35492.0 41497.8 43524.0 20488.9 28883.4 28891.6 29742.9 30043.8 24879.3 25068.2 29066.7 29426.3 29978.7 34819.0 35710.0 36010.0 36042.6 36072.3 21311.8 30064.1 30424.9 30439.1 30613.7 22491.7 22803.9 23759.9 24211.6 24514.1 01:51:56 INFO - PROCESS | 1638 | 01:51:56 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:43883.13 Median:23230.48 stddev:133107.46 (573.0%) stddev-sans-first:133440.87 01:51:56 INFO - PROCESS | 1638 | Values: 428.9 437.6 438.8 446.4 449.1 20482.2 21662.0 22767.8 22969.4 22987.0 18959.4 22429.9 22588.0 22878.9 24063.9 6935.3 6936.1 7014.5 7226.7 7245.1 6921.4 7028.3 7080.9 7091.7 7094.6 6749.4 7030.3 7080.3 7132.2 7145.6 6749.8 6925.3 7081.4 7154.7 7164.0 6833.2 6840.4 6841.3 6843.0 6852.7 26121.8 28665.6 28786.9 28875.3 29032.0 3085.8 3124.6 3201.2 3299.0 3333.5 16419.7 17283.7 17613.3 18110.8 18317.2 2061.0 2082.4 2120.2 2133.6 2220.9 80623.7 103266.5 121600.4 122088.4 146778.0 18758.9 18862.9 22052.7 23219.5 23241.4 35880.8 36419.9 36562.8 36636.3 36644.0 10281.0 11132.3 11658.0 11901.9 11905.4 9675.0 9678.7 9698.8 9873.4 9897.1 10902.4 10921.1 11031.4 11165.0 11203.5 4155.9 4274.5 4286.8 4303.5 4315.8 734.3 804.8 837.3 905.7 937.9 23012.8 23487.9 23492.8 23497.4 23515.8 963.5 980.3 986.5 987.7 1004.5 9630.4 12371.0 12496.0 12624.3 12665.3 769694.0 808804.7 809661.0 820513.0 829204.0 92061.2 115258.8 117329.4 144831.7 174441.0 1256.7 1266.5 1326.1 1327.1 1332.2 18987.8 20683.9 21432.1 21455.2 21460.8 59263.0 63440.7 66213.7 67868.0 68353.7 91839.1 94809.0 95622.0 96823.5 97015.0 11381.7 11767.3 11876.9 11900.7 12242.4 13411.8 13577.4 13883.6 13958.4 13966.6 11611.7 11768.8 12069.5 12124.7 12175.8 10901.0 11006.8 11022.8 11223.2 11435.0 11760.3 11763.3 11932.9 11981.6 12139.8 9696.5 11774.1 11793.2 12144.1 12158.4 11700.8 11748.8 11822.6 11844.5 12111.9 01:51:56 INFO - PROCESS | 1638 | 01:51:56 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:6875.18 Median:2446.94 stddev:4335.65 (177.2%) stddev-sans-first:4329.63 01:51:56 INFO - PROCESS | 1638 | Values: 1591.1 1599.6 1621.2 1628.0 1648.6 11142.7 11904.2 11920.7 11922.4 11933.9 10928.4 11197.7 11395.5 11443.5 11492.9 2317.0 2348.8 2352.8 2358.2 2358.3 2069.7 2369.0 2452.1 2453.6 2464.4 2360.3 2429.0 2437.7 2443.0 2450.9 2344.2 2411.9 2417.2 2422.4 2425.9 2395.8 2413.9 2414.6 2425.8 2427.1 11197.4 11414.3 11417.6 11428.5 11445.1 5841.2 6008.5 6017.4 6026.7 6029.6 3485.1 3604.6 3643.0 3674.6 3684.4 1219.1 1224.4 1254.7 1265.0 1276.5 14032.4 14285.8 14690.4 16145.8 16323.3 4040.6 4291.5 4404.9 4414.2 4445.5 9683.2 11875.9 11901.5 11903.4 11918.2 5954.1 5954.7 5960.1 5965.2 5968.3 5283.4 5344.0 5408.7 5481.0 5531.7 3888.5 3970.0 3994.6 4058.9 4078.9 1019.2 1025.8 1027.3 1042.7 1046.9 961.6 981.9 983.4 998.8 1009.6 6552.4 6566.4 6659.7 6843.5 6864.5 978.8 986.6 999.4 1007.7 1027.2 4143.6 4229.3 4233.6 4297.3 4379.7 12658.5 13744.5 13858.0 14444.8 14453.0 13517.7 13882.2 14412.0 14420.2 14431.2 8181.7 8412.3 10058.7 10481.8 10568.7 5879.5 5922.6 6721.8 7172.6 7188.4 12283.6 12783.5 12893.9 12968.7 13022.3 13156.7 13238.5 13301.6 13306.5 13488.3 9428.9 9486.7 9492.0 9640.5 9640.6 10406.5 10501.8 10590.2 10614.8 10646.6 9053.4 9063.4 9086.1 9108.2 9151.9 8708.4 8822.0 8864.5 8877.2 8947.4 8089.8 8126.5 8213.7 8247.5 8284.2 4913.8 5916.2 6015.7 6211.3 6264.0 6105.5 6132.4 6153.1 6210.8 6305.3 01:51:56 INFO - PROCESS | 1638 | 01:51:56 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4516.51 Median:4845.54 stddev:1258.31 (26.0%) stddev-sans-first:1222.89 01:51:56 INFO - PROCESS | 1638 | Values: 377.1 387.6 398.2 398.6 400.2 4370.8 4731.8 4996.3 5072.6 5184.9 4487.3 4909.8 4968.9 4995.6 5127.2 3789.2 3835.6 4171.3 4193.8 4241.3 3762.1 4250.9 4268.0 4268.7 4274.4 3425.8 4088.4 4174.8 4180.6 4251.5 3629.4 3943.8 4224.2 4254.6 4258.8 3568.4 3918.4 3928.2 3960.8 3962.4 3827.4 4404.4 4924.1 4986.5 5076.8 4382.7 4735.8 4846.0 4956.5 4962.7 4463.5 5380.6 5416.6 5450.7 5509.3 3774.6 3783.5 4374.8 4409.4 4419.9 5405.9 5662.9 5711.2 5720.5 5777.4 3871.0 4494.5 4511.5 4515.8 4562.8 4043.9 4584.8 4589.0 4677.9 4693.7 4289.4 4627.8 4715.5 4812.2 4829.8 5265.8 5401.3 5430.5 5436.3 5438.0 1425.9 1438.4 1477.4 1572.3 1599.2 1053.8 1081.3 1114.4 1186.8 1191.0 4970.8 5006.5 5011.4 5034.1 5057.8 5003.5 5602.3 5623.7 5635.8 5645.3 4149.8 4553.1 4733.5 4789.3 4845.1 2634.4 2813.6 2903.9 2904.8 2912.4 5125.2 5377.9 5545.8 5725.9 5828.9 4994.1 5210.8 5405.3 5499.9 5527.5 4780.5 5297.1 5409.8 5638.9 5690.5 5554.6 5573.6 5637.9 5754.3 5773.2 4236.7 5106.9 5373.1 5467.5 5545.6 5444.6 5457.6 5750.0 5774.0 5854.2 4192.9 4206.4 4476.2 4542.4 4548.7 5063.1 5109.9 5340.7 5593.3 5683.4 5025.5 5075.0 5447.4 5490.6 5490.7 4443.4 5110.4 5377.4 5471.1 5612.9 4621.4 4831.9 5356.6 5414.7 5428.9 4688.8 4868.4 5517.2 5538.7 5556.2 4453.3 4541.8 4992.0 5318.8 5420.4 01:51:56 INFO - PROCESS | 1638 | 01:51:56 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:20222.88 Median:17304.28 stddev:28349.75 (163.8%) stddev-sans-first:28391.44 01:51:56 INFO - PROCESS | 1638 | Values: 717.5 738.3 766.4 884.1 891.1 14219.0 16352.7 17311.7 17328.6 17329.3 15909.3 16017.1 16033.0 16037.7 16063.5 982.5 983.8 1003.7 1023.1 1034.7 1027.1 1031.0 1031.4 1032.9 1035.1 1070.5 1072.4 1072.6 1073.3 1073.6 1063.3 1065.3 1065.4 1065.7 1067.9 793.0 793.4 793.6 794.0 795.1 16214.5 16669.2 17097.1 17203.0 17296.8 13788.6 13967.7 13970.4 14031.0 14043.9 11815.0 11868.2 12110.7 12221.6 12630.7 3789.1 3843.8 3893.2 4064.5 4065.9 94796.0 110431.0 119498.0 120105.0 120214.2 11264.7 11289.9 11452.2 11549.2 11684.2 23820.4 23841.2 23851.3 24323.8 24370.5 7742.3 7997.5 8155.1 8250.5 8302.8 4540.2 4543.4 4576.3 4584.1 4679.3 3093.7 3628.3 3703.6 3764.1 3810.6 665.5 667.7 668.9 682.3 682.6 683.2 705.6 726.3 757.2 769.2 9533.2 9981.3 10444.7 10787.7 11057.9 737.3 737.5 744.6 746.4 746.6 4952.2 5198.0 5321.9 5331.2 5335.4 93399.0 94335.0 94684.0 95972.5 96097.0 55247.0 60701.7 88717.0 89612.6 92740.0 75893.6 76010.0 76261.0 77897.6 79256.6 10442.3 11080.8 11332.0 11335.8 11474.8 42906.9 49136.5 49332.5 49367.8 50765.0 59053.0 59329.1 60680.4 60854.7 61232.7 10554.6 13168.9 13414.8 13428.4 13470.9 14497.7 15287.3 15304.2 15393.0 15399.6 13440.9 13588.5 13750.5 14521.5 15023.8 13622.3 14420.2 14461.9 14854.9 14897.4 12893.9 13962.4 14152.9 14310.4 14566.1 9604.5 10341.9 10445.2 10446.8 10491.9 10054.0 10109.8 10337.4 11075.8 11119.0 01:51:56 INFO - PROCESS | 1638 | -------- Summary: end -------- 01:51:56 INFO - PROCESS | 1638 | 01:51:57 INFO - TEST-INFO | 1638: exit 0 01:51:57 INFO - TEST-OK | dromaeo_css | took 1118995ms 01:51:57 INFO - TEST-START | kraken 01:51:57 INFO - operating with platform_type : mac_ 01:51:57 INFO - Initialising browser for kraken test... 01:51:57 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/tmpzM1aUh/profile http://localhost:49240/getInfo.html) 01:51:59 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 01:51:59 INFO - PROCESS | 1647 | colorDepth:24 01:51:59 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 01:51:59 INFO - PROCESS | 1647 | __metrics 01:51:59 INFO - PROCESS | 1647 | 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" 01:51:59 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:52:00 INFO - TEST-INFO | 1647: exit 0 01:52:00 INFO - Browser initialized. 01:52:00 INFO - Running cycle 1/1 for kraken test... 01:52:00 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/tmpzM1aUh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:52:12 INFO - PROCESS | 1649 | RSS: Main: 165269504 01:52:12 INFO - PROCESS | 1649 | 01:52:14 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 01:52:15 INFO - PROCESS | 1649 | RSS: Main: 216354816 01:52:15 INFO - PROCESS | 1649 | 01:52:18 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 01:52:18 INFO - PROCESS | 1649 | RSS: Main: 231014400 01:52:18 INFO - PROCESS | 1649 | 01:52:22 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 01:52:22 INFO - PROCESS | 1649 | RSS: Main: 329953280 01:52:22 INFO - PROCESS | 1649 | 01:52:24 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 01:52:25 INFO - PROCESS | 1649 | RSS: Main: 230592512 01:52:25 INFO - PROCESS | 1649 | 01:52:27 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:52:28 INFO - PROCESS | 1649 | RSS: Main: 232226816 01:52:28 INFO - PROCESS | 1649 | 01:52:31 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 01:52:31 INFO - PROCESS | 1649 | RSS: Main: 272744448 01:52:31 INFO - PROCESS | 1649 | 01:52:34 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 01:52:35 INFO - PROCESS | 1649 | RSS: Main: 272683008 01:52:35 INFO - PROCESS | 1649 | 01:52:38 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 01:52:38 INFO - PROCESS | 1649 | RSS: Main: 268333056 01:52:38 INFO - PROCESS | 1649 | 01:52:40 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:52:40 INFO - PROCESS | 1649 | RSS: Main: 247664640 01:52:40 INFO - PROCESS | 1649 | 01:52:42 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:52:43 INFO - PROCESS | 1649 | RSS: Main: 252051456 01:52:43 INFO - PROCESS | 1649 | 01:52:45 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:52:46 INFO - PROCESS | 1649 | RSS: Main: 258744320 01:52:46 INFO - PROCESS | 1649 | 01:52:49 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:52:49 INFO - PROCESS | 1649 | RSS: Main: 262221824 01:52:49 INFO - PROCESS | 1649 | 01:52:52 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:52:53 INFO - PROCESS | 1649 | RSS: Main: 263454720 01:52:53 INFO - PROCESS | 1649 | 01:52:55 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 01:52:55 INFO - PROCESS | 1649 | RSS: Main: 307703808 01:52:55 INFO - PROCESS | 1649 | 01:52:55 INFO - PROCESS | 1649 | __start_tp_report 01:52:55 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 01:52:55 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 01:52:55 INFO - PROCESS | 1649 | |i|pagename|runs| 01:52:55 INFO - PROCESS | 1649 | |0;ai-astar;103;114;114;115;115;115;115;115;115;114 01:52:55 INFO - PROCESS | 1649 | |1;audio-beat-detection;141;108;108;141;109;107;109;103;127;124 01:52:55 INFO - PROCESS | 1649 | |2;audio-dft;182;181;185;185;184;184;183;183;186;185 01:52:55 INFO - PROCESS | 1649 | |3;audio-fft;81;62;80;116;86;85;78;60;76;59 01:52:55 INFO - PROCESS | 1649 | |4;audio-oscillator;89;68;87;69;70;69;82;68;69;83 01:52:55 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;87;87;87;87;87;127;101;87;87;86 01:52:55 INFO - PROCESS | 1649 | |6;imaging-darkroom;94;94;94;95;94;95;94;94;94;95 01:52:55 INFO - PROCESS | 1649 | |7;imaging-desaturate;83;83;85;85;85;82;82;82;84;82 01:52:55 INFO - PROCESS | 1649 | |8;json-parse-financial;63;61;61;62;63;63;63;62;64;65 01:52:55 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;62;58;70;60;59;58;58;58;58;57 01:52:55 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;94;94;83;84;84;84;84;88;88;124 01:52:55 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;137;133;135;134;134;133;140;133;148;142 01:52:55 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;164;164;162;167;165;183;145;211;215;207 01:52:55 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;64;66;65;62;61;60;65;62;61;65 01:52:55 INFO - PROCESS | 1649 | __end_tp_report 01:52:55 INFO - PROCESS | 1649 | __start_cc_report 01:52:55 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,2111 01:52:55 INFO - PROCESS | 1649 | __end_cc_report 01:52:55 INFO - PROCESS | 1649 | __startTimestamp1493887975439__endTimestamp 01:52:55 INFO - PROCESS | 1649 | 01:52:55 INFO - PROCESS | 1649 | ------- Summary: start ------- 01:52:55 INFO - PROCESS | 1649 | Number of tests: 14 01:52:55 INFO - PROCESS | 1649 | 01:52:55 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:113.50 Median:115.00 stddev:3.72 (3.2%) stddev-sans-first:0.50 01:52:55 INFO - PROCESS | 1649 | Values: 103.0 114.0 114.0 115.0 115.0 115.0 115.0 115.0 115.0 114.0 01:52:55 INFO - PROCESS | 1649 | 01:52:55 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:117.70 Median:116.50 stddev:14.46 (12.4%) stddev-sans-first:12.64 01:52:55 INFO - PROCESS | 1649 | Values: 141.0 108.0 108.0 141.0 109.0 107.0 109.0 103.0 127.0 124.0 01:52:55 INFO - PROCESS | 1649 | 01:52:55 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.50 stddev:1.55 (0.8%) stddev-sans-first:1.50 01:52:55 INFO - PROCESS | 1649 | Values: 182.0 181.0 185.0 185.0 184.0 184.0 183.0 183.0 186.0 185.0 01:52:55 INFO - PROCESS | 1649 | 01:52:55 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:78.30 Median:79.00 stddev:16.71 (21.2%) stddev-sans-first:17.70 01:52:55 INFO - PROCESS | 1649 | Values: 81.0 62.0 80.0 116.0 86.0 85.0 78.0 60.0 76.0 59.0 01:52:55 INFO - PROCESS | 1649 | 01:52:55 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:75.40 Median:76.00 stddev:8.71 (11.5%) stddev-sans-first:7.72 01:52:55 INFO - PROCESS | 1649 | Values: 89.0 68.0 87.0 69.0 70.0 69.0 82.0 68.0 69.0 83.0 01:52:55 INFO - PROCESS | 1649 | 01:52:55 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:92.30 Median:87.00 stddev:12.98 (14.9%) stddev-sans-first:13.62 01:52:55 INFO - PROCESS | 1649 | Values: 87.0 87.0 87.0 87.0 87.0 127.0 101.0 87.0 87.0 86.0 01:52:55 INFO - PROCESS | 1649 | 01:52:55 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 01:52:55 INFO - PROCESS | 1649 | Values: 94.0 94.0 94.0 95.0 94.0 95.0 94.0 94.0 94.0 95.0 01:52:55 INFO - PROCESS | 1649 | 01:52:55 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:83.30 Median:83.50 stddev:1.34 (1.6%) stddev-sans-first:1.41 01:52:55 INFO - PROCESS | 1649 | Values: 83.0 83.0 85.0 85.0 85.0 82.0 82.0 82.0 84.0 82.0 01:52:55 INFO - PROCESS | 1649 | 01:52:55 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:63.00 stddev:1.25 (2.0%) stddev-sans-first:1.32 01:52:55 INFO - PROCESS | 1649 | Values: 63.0 61.0 61.0 62.0 63.0 63.0 63.0 62.0 64.0 65.0 01:52:55 INFO - PROCESS | 1649 | 01:52:55 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:58.50 stddev:3.85 (6.6%) stddev-sans-first:4.00 01:52:55 INFO - PROCESS | 1649 | Values: 62.0 58.0 70.0 60.0 59.0 58.0 58.0 58.0 58.0 57.0 01:52:55 INFO - PROCESS | 1649 | 01:52:55 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:90.70 Median:86.00 stddev:12.40 (14.4%) stddev-sans-first:13.10 01:52:55 INFO - PROCESS | 1649 | Values: 94.0 94.0 83.0 84.0 84.0 84.0 84.0 88.0 88.0 124.0 01:52:55 INFO - PROCESS | 1649 | 01:52:55 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:136.90 Median:136.00 stddev:5.00 (3.7%) stddev-sans-first:5.30 01:52:55 INFO - PROCESS | 1649 | Values: 137.0 133.0 135.0 134.0 134.0 133.0 140.0 133.0 148.0 142.0 01:52:55 INFO - PROCESS | 1649 | 01:52:55 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.30 Median:175.00 stddev:24.38 (13.9%) stddev-sans-first:25.31 01:52:55 INFO - PROCESS | 1649 | Values: 164.0 164.0 162.0 167.0 165.0 183.0 145.0 211.0 215.0 207.0 01:52:55 INFO - PROCESS | 1649 | 01:52:55 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:64.50 stddev:2.13 (3.3%) stddev-sans-first:2.24 01:52:55 INFO - PROCESS | 1649 | Values: 64.0 66.0 65.0 62.0 61.0 60.0 65.0 62.0 61.0 65.0 01:52:55 INFO - PROCESS | 1649 | -------- Summary: end -------- 01:52:55 INFO - PROCESS | 1649 | 01:52:56 INFO - TEST-INFO | 1649: exit 0 01:52:56 INFO - TEST-OK | kraken | took 59231ms 01:52:56 INFO - SUITE-END | took 1178s 01:52:56 INFO - Completed test suite (00:19:38) 01:52:56 INFO - javascript benchmark 01:52:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7858.998193980934, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3037.468443022471, 3477.72178225742, 3489.1626009757665, 3529.5588051493564, 3534.24013837025, 6046.576739628223, 6107.694615269241, 6119.6328220306705, 6142.385761423855, 6159.969200153999, 6100.633961962285, 6160.969195154018, 6169.660668663222, 6186.319504854474, 6190.876182476348, 5402.9729851350885, 5413.756380962846, 5431.619786614939, 5431.83704488864, 5553.111502159655, 5313.628046036779, 5314.256004159421, 5320.388155362125, 5499.697516636584, 5505.0, 5386.73066346683, 5448.809291674792, 5477.260569823083, 5489.039418101836, 5498.092814685572, 5446.809361672323, 5477.3427188737405, 5497.642653227527, 5498.835034948958, 5507.091329930557, 5315.893682126374, 5387.218853266255, 5424.105022671294, 5465.125579907196, 5469.015577196143, 5845.415458454163, 5865.501432378253, 5894.440028197314, 6160.6611636359985, 6167.167432396659, 6333.9683301583655, 6374.776882809079, 6383.744650213986, 6388.520860935449, 6397.48820094396, 6456.451201647866, 6487.57830741005, 6496.512761542903, 6524.249711283216, 6528.281888992207, 6182.474489668383, 6250.468710159596, 6261.029540421242, 6290.591111577733, 6295.779647712308, 6355.459785918156, 6397.584157029872, 6524.445422139172, 6564.638944857983, 6641.701123449457, 6402.327755585689, 6406.135171751754, 6407.519436042316, 6408.327125651739, 6416.358364163546, 6331.4301712845145, 6460.450861676716, 6465.0, 6467.805965821033, 6472.838179045561, 6348.206474190726, 6350.841228969312, 6382.968085159545, 6405.583637063669, 6458.257300410419, 6313.147725057151, 6323.988161894074, 6397.840053998687, 6424.036394540856, 6428.871422571616, 5097.388313402415, 5099.6175286852895, 5122.206058061007, 5155.896882062338, 5192.065428222956, 4656.068786242698, 4676.883077923079, 4683.859484215479, 4715.316279139505, 4729.1014707206205, 6182.474489668339, 6206.472449841724, 6209.379062093845, 6216.409441103088, 6225.968870155711, 6309.400606942333, 6362.77730279438, 6435.678216089177, 6474.255460622088, 6534.542582019308, 6225.470834978987, 6233.844153896189, 6236.719347629368, 6249.9062514062325, 6250.874982500324, 5731.914021289684, 5768.394318596487, 5771.509421699203, 5788.131780232999, 5811.0411782056335, 6371.267304260069, 6392.0, 6640.800775976729, 6643.900341494785, 6658.533902626769, 6476.352364763675, 6536.705848236746, 6551.934480655323, 6556.573822701509, 6562.015697645392, 6700.095487109178, 6705.1283333166375, 6705.463562914858, 6724.697388617426, 6733.0573719678305, 6322.747090116528, 6326.43062124411, 6360.840978975378, 6380.011098279774, 6438.259600145856, 6362.872742545216, 6415.294317625151, 6448.580842245239, 6465.77369792055, 6479.902801457888, 6336.081268216175, 6349.174607301206, 6351.0, 6352.872942541216, 6369.713362898773, 6235.875282494416, 6268.059791031382, 6295.370462953668, 6333.1766870306565, 6342.7145778441, 5207.3751149862255, 6294.685265736786, 6302.464290535172, 6337.9366206337345, 6345.079963405373, 6339.429451349401, 6339.461145802658, 6353.174087368612, 6358.141650877257, 6367.77712780069, 6127.877442451215, 6128.111423843607, 6146.832101900624, 6217.191765070693, 6357.491400687842], "value": 5970.192441507675, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.2206682982868, 766.6128605054448, 780.3445106110865, 910.1171863292608, 918.1231923513037, 29662.555061674066, 29978.400431991373, 42168.367474487866, 42457.57542424575, 42530.36204456936, 43894.780526097406, 44100.55899441004, 44102.33846492305, 44140.33789493152, 44142.558574414245, 9620.134187923086, 9761.804763904718, 9772.511374431286, 9794.755131121743, 9842.9507852461, 7946.562939038351, 8114.513129212266, 11851.407429628527, 11977.0, 12255.754884902297, 11980.820287695647, 12038.217515861485, 12043.638690839289, 12047.337396443192, 12073.03415726744, 11895.405229738522, 11945.223560468541, 11960.461779219955, 11971.162018658653, 11992.940035299855, 11565.76868462626, 11631.185816992815, 11658.125640576991, 11659.950604445556, 11704.414779261004, 41347.173056538704, 41497.0, 41550.58449415497, 41572.0, 41771.7911410441, 3997.480327557428, 3997.520297564282, 4038.9192216155807, 4082.9792551862033, 4084.9183016339507, 28777.28056798576, 29016.564751528746, 30170.84914575413, 30310.696893031007, 31065.689343106733, 3296.670332966708, 3309.4539400998806, 3328.467445208755, 3425.9314813703586, 3447.5690538682666, 357010.0, 360419.38532151247, 361395.0, 362288.0, 362613.0, 54297.91404171894, 54521.72739136358, 54552.0, 54600.180997285075, 54694.453055469734, 57169.0, 57190.42809571934, 57228.42771572231, 57305.42694573084, 57323.0, 15411.383544658313, 15887.0, 15905.602359940862, 15909.52271431859, 15921.761173582405, 13452.93273533626, 13454.663633409244, 13457.528986485622, 13465.798013029616, 13472.932635336761, 10886.346819190874, 11078.947499987487, 11151.275167114112, 12448.190867593577, 12666.113372064052, 4578.427696537933, 5088.956763863399, 5724.79963201286, 5781.88436231273, 5789.7709381887435, 1131.9925266512646, 1152.3661985907718, 1154.4747140051256, 1159.7390587117832, 1216.2398500936915, 27513.899444022416, 27598.724012760016, 28202.71797282001, 28272.29319267035, 28436.289092772433, 1271.6375832887768, 1272.5100836178137, 1275.993620031894, 1322.4842311498523, 1329.1559859489294, 14393.78409323861, 14581.223781281507, 14614.269286535631, 14665.04677195979, 14788.63028424298, 471085.0, 472793.0, 473055.0, 473163.0, 473795.0, 43361.69914902558, 51435.742821285654, 51859.48140518546, 52370.73814630903, 55009.724951374985, 1449.3188201545256, 1481.3185934470264, 1490.0314795382872, 1497.4010395841533, 1498.685276092011, 26464.8676756615, 27671.72328276772, 28134.01530946407, 28135.0, 28274.85862570674, 42444.57555424406, 42504.78747606242, 42538.93652658708, 42576.57423425726, 42641.5075472357, 423334.0, 423455.0, 423882.0, 424178.0, 424769.0, 24921.37696557528, 30039.549406759354, 30145.547816783204, 30440.934567290038, 30481.237969050064, 32709.836450817595, 33153.0, 35492.0, 41497.79251103725, 43524.0, 20488.89755551213, 28883.422331552832, 28891.555422229227, 29742.851285743433, 30043.849780750956, 24879.253622391356, 25068.24795256145, 29066.709332907245, 29426.264343391587, 29978.700212998465, 34819.0, 35710.0, 36010.0, 36042.63957360393, 36072.27855442824, 21311.78688213098, 30064.09807705685, 30424.93512727044, 30439.086827395215, 30613.693863061086, 22491.650500969994, 22803.88598056999, 23759.881200593885, 24211.63682544728, 24514.14200502974], "value": 19092.97003907227, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.897064704471, 437.5602519467934, 438.8156974070889, 446.4174252600356, 449.06594283889496, 20482.18071277149, 21662.0, 22767.772322276815, 22969.4257643559, 22986.965586548602, 18959.431217063477, 22429.887850560764, 22588.0, 22878.885605571948, 24063.87968060157, 6935.3411425914455, 6936.063631409771, 7014.508984371096, 7226.674799634029, 7245.094363204599, 6921.446284297244, 7028.297170282982, 7080.929190708079, 7091.680874360641, 7094.609796461193, 6749.392554670078, 7030.332118448765, 7080.256573059806, 7132.179799323067, 7145.642717864086, 6749.751296010254, 6925.272846351161, 7081.433485321162, 7154.678039488235, 7163.997040414346, 6833.180018397824, 6840.3501667341525, 6841.315868413169, 6843.0, 6852.657367131674, 26121.82451789674, 28665.57001644977, 28786.856065719538, 28875.278118047216, 29032.0, 3085.8457077146277, 3124.5781819454537, 3201.16769639893, 3299.010296910917, 3333.5499707539657, 16419.6716065678, 17283.74074388885, 17613.29546818126, 18110.818891811046, 18317.17572709218, 2060.958780824375, 2082.3856962196187, 2120.1731324783345, 2133.626615342309, 2220.944476388087, 80623.67992681563, 103266.48366758194, 121600.39199804033, 122088.38955805253, 146778.0, 18758.906205468884, 18862.90568547176, 22052.669209961863, 23219.53560928772, 23241.418964526023, 35880.820595896854, 36419.90740277796, 36562.8171859139, 36636.26727465489, 36644.0, 10281.0, 11132.332060076422, 11658.0, 11901.88098119025, 11905.380816220417, 9675.03249675041, 9678.70963871085, 9698.75753106178, 9873.358231714916, 9897.109260166475, 10902.400367979837, 10921.071708904674, 11031.448427578589, 11164.9951504365, 11203.470906664537, 4155.937660935088, 4274.487061552633, 4286.778268193612, 4303.462067241595, 4315.805788739452, 734.3390948146711, 804.8169191288796, 837.3008537870825, 905.6830109461768, 937.9437233765996, 23012.76987230106, 23487.943042562783, 23492.76507234906, 23497.412564685677, 23515.764842351356, 963.4893506441597, 980.2745967983641, 986.4771671014374, 987.6987518806833, 1004.542932965499, 9630.422174669542, 12371.0, 12496.00031997438, 12624.305663188428, 12665.303408312631, 769694.0, 808804.6918357947, 809661.0, 820513.0, 829204.0, 92061.15877682409, 115258.8133533993, 117329.4133529327, 144831.65505034867, 174441.0, 1256.704674401515, 1266.4807428954268, 1326.1380102932978, 1327.1108357400565, 1332.1807088640417, 18987.810121898605, 20683.896580517, 21432.142714291254, 21455.249066282606, 21460.785392145877, 59263.0, 63440.68279658572, 66213.66893165695, 67868.0, 68353.65823170853, 91839.08160918573, 94809.0, 95622.0, 96823.51588242014, 97015.0, 11381.715457113638, 11767.293962362286, 11876.881231187577, 11900.702482438008, 12242.449089791158, 13411.798823017467, 13577.389017494434, 13883.583492495241, 13958.371873265525, 13966.58100256994, 11611.6516504505, 11768.764624707286, 12069.456874440495, 12124.696882577653, 12175.75648487043, 10901.0, 11006.779864402828, 11022.779544409228, 11223.22991406817, 11435.0, 11760.294382337088, 11763.294202347886, 11932.880671193525, 11981.64055078349, 12139.75720485603, 9696.466694331597, 11774.116941229271, 11793.233439826385, 12144.089193310361, 12158.392080396121, 11700.824487632523, 11748.823767643664, 11822.586209482626, 11844.526218951145, 12111.878881211074], "value": 12048.802093194188, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1591.1010279192249, 1599.6080960164754, 1621.246120553943, 1628.0475921585876, 1648.5796121988894, 11142.665720028403, 11904.166708330398, 11920.701982450442, 11922.403879806008, 11933.940330298346, 10928.398938058404, 11197.72005699858, 11395.544178232882, 11443.542258309679, 11492.942535287311, 2316.976830231693, 2348.753380895007, 2352.8235382346306, 2358.162852187466, 2358.3160883343894, 2069.668852983523, 2368.988155059222, 2452.141750387368, 2453.55835949529, 2464.4331803685163, 2360.315508502541, 2429.0, 2437.731849496563, 2442.9983706680264, 2450.8774561271866, 2344.167820423742, 2411.8794060297005, 2417.153996101368, 2422.3701837522194, 2425.9393515162087, 2395.808335333169, 2413.855168689884, 2414.6015907375263, 2425.818063645216, 2427.0898413095088, 11197.384143872085, 11414.258073225214, 11417.60038398652, 11428.485718142703, 11445.08439324852, 5841.182234487175, 6008.519318454513, 6017.398260173992, 6026.728797204137, 6029.638221706711, 3485.146139195888, 3604.567451905762, 3642.963570364289, 3674.577423596294, 3684.373656478405, 1219.1405059433077, 1224.4184012594035, 1254.7490501899656, 1264.9810252846214, 1276.4702648400903, 14032.43870245189, 14285.78571321431, 14690.412383504647, 16145.757813632805, 16323.26545305464, 4040.616141466556, 4291.506476755213, 4404.933925991113, 4414.249577571821, 4445.533219011957, 9683.176929960891, 11875.88124118765, 11901.464434100486, 11903.404829758478, 11918.165728399103, 5954.136650185699, 5954.672493012839, 5960.0761881908375, 5965.224520812267, 5968.343482216953, 5283.4452382499285, 5344.038073146793, 5408.702521361363, 5481.0, 5531.695756733418, 3888.4556162137324, 3970.0, 3994.6418217805503, 4058.918821623551, 4078.938815917764, 1019.1541020952592, 1025.8307379282485, 1027.306568066567, 1042.718466014172, 1046.874375074996, 961.6056717759277, 981.9459929703935, 983.4492684096786, 998.8152191844387, 1009.6264382178641, 6552.443042341359, 6566.409023187936, 6659.700313485905, 6843.520953533205, 6864.450843932474, 978.8384916488842, 986.6398764451068, 999.3504222255592, 1007.6573964851985, 1027.244974943416, 4143.606357396043, 4229.323308270662, 4233.618974292267, 4297.333913243452, 4379.693421460531, 12658.493660253487, 13744.450221991008, 13858.0, 14444.783328250085, 14453.0, 13517.66205844842, 13882.236476993863, 14412.0, 14420.206888621227, 14431.20628365429, 8181.672733090729, 8412.327013838878, 10058.74853128663, 10481.842772358421, 10568.682939511827, 5879.470847623735, 5922.55580831448, 6721.764738234138, 7172.605506697182, 7188.38898693596, 12283.631491055283, 12783.488660453479, 12893.871061289643, 12968.67578310512, 13022.2837743925, 13156.73686526245, 13238.470461181445, 13301.600951971457, 13306.46774129024, 13488.32558372097, 9428.858567121635, 9486.667966621411, 9492.0, 9640.469774162488, 9640.614375424904, 10406.47967601632, 10501.78996420052, 10590.152787777113, 10614.787704246026, 10646.627368042082, 9053.366264361432, 9063.365564410427, 9086.091390860862, 9108.225800807006, 9151.908480915372, 8708.433951793113, 8821.955890220508, 8864.468131912106, 8877.156670116328, 8947.418417802823, 8089.797755056171, 8126.471779334324, 8213.671453141807, 8247.463914845515, 8284.212999765012, 4913.77887995034, 5916.171735956884, 6015.699215039318, 6211.254649442096, 6263.968680156752, 6105.511559075175, 6132.41742034506, 6153.138560601609, 6210.7515699371515, 6305.274893387319], "value": 5228.236880836659, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.0900389527045, 387.5814120749591, 398.1996187662798, 398.6153362005664, 400.1996007984032, 4370.781460926957, 4731.787069581868, 4996.300517927493, 5072.568831649305, 5184.948150518499, 4487.282034874421, 4909.803607855691, 4968.925466118011, 4995.625328100389, 5127.2309153626975, 3789.1770630880033, 3835.5972622874615, 4171.332586786115, 4193.804765641793, 4241.342591898246, 3762.1159027628487, 4250.851220207293, 4267.957320426787, 4268.7225330353585, 4274.40949602334, 3425.845836937331, 4088.4480595119726, 4174.812133454002, 4180.602842729936, 4251.4685664291965, 3629.364861149288, 3943.797141871728, 4224.155168966219, 4254.574542545752, 4258.787060646986, 3568.377242726594, 3918.3534716771696, 3928.155446578999, 3960.821763020671, 3962.405639154121, 3827.445020472016, 4404.427424434835, 4924.138275801756, 4986.476177266099, 5076.781572422592, 4382.663287697251, 4735.810567577293, 4845.975770121162, 4956.4547899731, 4962.677425967337, 4463.48241597855, 5380.596455265871, 5416.647917885325, 5450.710701505338, 5509.283793106911, 3774.622262874059, 3783.4892289541112, 4374.759388233646, 4409.426774519324, 4419.911601767979, 5405.864853378657, 5662.85842853932, 5711.228984087178, 5720.542356611461, 5777.393373695785, 3870.974191839165, 4494.4606647202545, 4511.503734589192, 4515.841945531891, 4562.817487300537, 4043.9081448008874, 4584.770761461914, 4588.95411045892, 4677.859664210079, 4693.732692173094, 4289.418095737547, 4627.791749371287, 4715.528447155326, 4812.230043193073, 4829.806807727651, 5265.8151915818635, 5401.270828438111, 5430.456954304617, 5436.293281873332, 5438.0, 1425.9163036092643, 1438.3886848089521, 1477.4459577658379, 1572.3239007227003, 1599.2003998001, 1053.7870472008874, 1081.3187691754144, 1114.3759494683004, 1186.8013306560435, 1191.0471622701805, 4970.826021089317, 5006.4730257271885, 5011.373578302712, 5034.0938631046765, 5057.848264552069, 5003.524665156804, 5602.2717046783655, 5623.6539259140745, 5635.802037205493, 5645.322561292671, 4149.813258403379, 4553.066621342617, 4733.455652599995, 4789.257665061921, 4845.103655823684, 2634.4335967767024, 2813.5779633054794, 2903.9419211616073, 2904.782141339408, 2912.4079569183446, 5125.1799712045895, 5377.865553361197, 5545.750441230154, 5725.885482290414, 5828.88342233153, 4994.101061808837, 5210.847437300455, 5405.324334458192, 5499.945000550023, 5527.462424048612, 4780.498047704941, 5297.125974214288, 5409.756560954766, 5638.859028524238, 5690.5447564194765, 5554.611177217556, 5573.631206737039, 5637.943620563742, 5754.309482861916, 5773.162891380643, 4236.724612900151, 5106.948930510647, 5373.059714550016, 5467.535259502987, 5545.556355491632, 5444.646098003617, 5457.563394928476, 5749.9712501437225, 5773.9895518284975, 5854.180414741854, 4192.874213773592, 4206.424539141827, 4476.194285028726, 4542.364069030405, 4548.704334218398, 5063.13926632466, 5109.901371205208, 5340.679559226459, 5593.300837395325, 5683.374828768915, 5025.472325405926, 5075.016112351786, 5447.428020057995, 5490.5607551395, 5490.6980116094, 4443.422355093947, 5110.4123025852505, 5377.3816011159215, 5471.124620060771, 5612.943870561406, 4621.3530105785885, 4831.864511839785, 5356.634058315105, 5414.675119492843, 5428.91856622143, 4688.835890743808, 4868.367112275381, 5517.172424136412, 5538.723063846711, 5556.16657501378, 4453.309736990772, 4541.772911354353, 4991.950080499294, 5318.813841515528, 5420.430854760351], "value": 4155.360526570759, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.5479447947793, 738.2654259012284, 766.3983772738397, 884.0893879304317, 891.1177933845495, 14219.0, 16352.672946541063, 17311.740323895137, 17328.56678583036, 17329.30682772691, 15909.2840822163, 16017.11905845178, 16033.0, 16037.679246415064, 16063.518094457157, 982.4547376206202, 983.7638966647988, 1003.7289931718432, 1023.1303392116679, 1034.6740776655367, 1027.1166796554958, 1031.0, 1031.3760175094073, 1032.917366610673, 1035.083950703625, 1070.464767616192, 1072.3565860483725, 1072.5870539842178, 1073.3452593917705, 1073.5866691323859, 1063.3460421840512, 1065.323519565074, 1065.3554599467366, 1065.6589891234808, 1067.909227715645, 793.0245797668842, 793.436659971421, 793.5794029164553, 794.0233512779314, 795.0538858758059, 16214.513564592962, 16669.24988375526, 17097.059661718602, 17203.0, 17296.82703172965, 13788.586342409744, 13967.65080872976, 13970.371333290026, 14031.0, 14043.859561404357, 11815.0, 11868.228565143325, 12110.697232569168, 12221.572244971472, 12630.74738505234, 3789.0716774390175, 3843.8270277837564, 3893.157994663883, 4064.4919385076864, 4065.9390109148385, 94796.0, 110431.0, 119498.0, 120105.0, 120214.21800006925, 11264.718382040515, 11289.943550282196, 11452.198346115692, 11549.191556591126, 11684.240524365889, 23820.404489887893, 23841.165559205343, 23851.284461466184, 24323.78381080939, 24370.512589748105, 7742.264484873928, 7997.520148791091, 8155.062167850654, 8250.46371985819, 8302.792430189294, 4540.228161212602, 4543.4093567836635, 4576.26779715244, 4584.129015487047, 4679.298105284234, 3093.6906309368883, 3628.32875917956, 3703.6111208322736, 3764.0966168120003, 3810.580836108026, 665.5041993714617, 667.7495939022866, 668.9197296324375, 682.2529330383222, 682.6416131530887, 683.2074793239917, 705.5555000349747, 726.2954933714288, 757.2087168908394, 769.1616138409161, 9533.16563217882, 9981.251406144569, 10444.73888152787, 10787.690752204362, 11057.889421105847, 737.2737853214579, 737.4616529933179, 744.6016381236012, 746.4252525555293, 746.633660401464, 4952.1581331173065, 5198.0, 5321.8935621287355, 5331.200319952039, 5335.359756829205, 93399.0, 94335.0, 94684.0, 95972.52013740026, 96097.0, 55247.0, 60701.69649151726, 88717.0, 89612.5519372399, 92740.0, 75893.6205318981, 76010.0, 76261.0, 77897.61051194821, 79256.60371698104, 10442.269041167348, 11080.833787493355, 11332.0, 11335.829962550404, 11474.827877582009, 42906.92732681708, 49136.50863491462, 49332.50667493279, 49367.753161233966, 50765.0, 59053.0, 59329.11006334822, 60680.39319606924, 60854.69572652109, 61232.693836532315, 10554.577816887238, 13168.934155329162, 13414.798778018143, 13428.39572219272, 13470.865291347352, 14497.710045799236, 15287.312070956612, 15304.234788260765, 15393.0, 15399.61500962485, 13440.865591343962, 13588.45646174142, 13750.518731844337, 14521.491747788778, 15023.774643380139, 13622.318884055956, 14420.206888621227, 14461.855381446472, 14854.925725371304, 14897.404103835725, 12893.871061289266, 13962.371693273624, 14152.858471415155, 14310.37219268289, 14566.126032437664, 9604.471754053595, 10341.896581034394, 10445.216608754221, 10446.843297350697, 10491.895081049397, 10054.044865737744, 10109.787059991426, 10337.431441270803, 11075.778484430428, 11119.0], "value": 7895.705314458058, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1430.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 114.0, 115.0, 115.0, 115.0, 115.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, 141.0, 109.0, 107.0, 109.0, 103.0, 127.0, 124.0], "value": 117.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 181.0, 185.0, 185.0, 184.0, 184.0, 183.0, 183.0, 186.0, 185.0], "value": 183.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 62.0, 80.0, 116.0, 86.0, 85.0, 78.0, 60.0, 76.0, 59.0], "value": 78.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 68.0, 87.0, 69.0, 70.0, 69.0, 82.0, 68.0, 69.0, 83.0], "value": 75.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 87.0, 87.0, 87.0, 127.0, 101.0, 87.0, 87.0, 86.0], "value": 92.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0], "value": 94.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 85.0, 85.0, 85.0, 82.0, 82.0, 82.0, 84.0, 82.0], "value": 83.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 61.0, 62.0, 63.0, 63.0, 63.0, 62.0, 64.0, 65.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 58.0, 70.0, 60.0, 59.0, 58.0, 58.0, 58.0, 58.0, 57.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 83.0, 84.0, 84.0, 84.0, 84.0, 88.0, 88.0, 124.0], "value": 90.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 133.0, 135.0, 134.0, 134.0, 133.0, 140.0, 133.0, 148.0, 142.0], "value": 136.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 162.0, 167.0, 165.0, 183.0, 145.0, 211.0, 215.0, 207.0], "value": 178.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 62.0, 61.0, 60.0, 65.0, 62.0, 61.0, 65.0], "value": 63.1, "unit": "score"}]}]} 01:52:56 INFO - Return code: 0 01:52:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:52:56 INFO - # TBPL SUCCESS # 01:52:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:52:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:52:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:52:56 INFO - 2017-05-04 01:52:56.755 screenresolution[1653:9780] starting screenresolution argv=screenresolution get 01:52:56 INFO - 2017-05-04 01:52:56.758 screenresolution[1653:9780] Display 0: 1600x1200x32@60 01:52:56 INFO - 2017-05-04 01:52:56.764 screenresolution[1654:9783] starting screenresolution argv=screenresolution list 01:52:56 INFO - Available Modes on Display 0 01:52:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:52:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:52:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:52:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:52:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:52:56 INFO - Intel Iris: 01:52:56 INFO - Chipset Model: Intel Iris 01:52:56 INFO - Type: GPU 01:52:56 INFO - Bus: Built-In 01:52:56 INFO - VRAM (Dynamic, Max): 1536 MB 01:52:56 INFO - Vendor: Intel (0x8086) 01:52:56 INFO - Device ID: 0x0a2e 01:52:56 INFO - Revision ID: 0x0009 01:52:56 INFO - Displays: 01:52:56 INFO - Display: 01:52:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:52:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:52:56 INFO - Display Serial Number: 1600x1200 60 01:52:56 INFO - Main Display: Yes 01:52:56 INFO - Mirror: Off 01:52:56 INFO - Online: Yes 01:52:56 INFO - Rotation: Supported 01:52:56 INFO - Return code: 0 01:52:56 INFO - Running post-action listener: _resource_record_post_action 01:52:56 INFO - [mozharness: 2017-05-04 08:52:56.998143Z] Finished run-tests step (success) 01:52:56 INFO - Running post-run listener: _resource_record_post_run 01:52:57 INFO - Total resource usage - Wall time: 1194s; CPU: 54.0%; Read bytes: 37143552; Write bytes: 421163008; Read time: 243; Write time: 1374 01:52:57 INFO - TinderboxPrint: CPU usage
53.7% 01:52:57 INFO - TinderboxPrint: I/O read bytes / time
37,143,552 / 243 01:52:57 INFO - TinderboxPrint: I/O write bytes / time
421,163,008 / 1,374 01:52:57 INFO - TinderboxPrint: CPU idle
2,212.9 (46.3%) 01:52:57 INFO - TinderboxPrint: CPU system
948.3 (19.8%) 01:52:57 INFO - TinderboxPrint: CPU user
1,616.3 (33.8%) 01:52:57 INFO - TinderboxPrint: Swap in / out
158,490,624 / 0 01:52:57 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 119624192; Write bytes: 115369472; Read time: 10915; Write time: 252 01:52:57 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 34956288; Write bytes: 294726144; Read time: 222; Write time: 1084 01:52:57 INFO - Running post-run listener: _upload_blobber_files 01:52:57 INFO - Blob upload gear active. 01:52:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:52:57 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 01:52:57 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'] 01:52:57 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 01:52:57 INFO - (blobuploader) - INFO - Open directory for files ... 01:52:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:52:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:52:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:52:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:52:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:52:59 INFO - (blobuploader) - INFO - Done attempting. 01:52:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:52:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:52:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:53:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:53:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:53:00 INFO - (blobuploader) - INFO - Done attempting. 01:53:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:53:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:53:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:53:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:53:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:53:00 INFO - (blobuploader) - INFO - Done attempting. 01:53:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:53:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:53:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:53:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:53:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:53:03 INFO - (blobuploader) - INFO - Done attempting. 01:53:03 INFO - (blobuploader) - INFO - Iteration through files over. 01:53:03 INFO - Return code: 0 01:53:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:53:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:53:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/638b7be5c975bebc7b7635c471b79df90746beb717a79c3fcb8c7437b945b44d7201ec2257cc56318c8e890431d2533ba6eca82241f442c7a9c7f9f20c9a8531", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/93571055a677e0a38c67775c7f74f827852691f359465518f98c608a0d17f1465e3a84e5d1ff30edf80614120efea3498c1bdefdcc0dec729d48ecaf2da147cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf0caa3f513453020728a75775f353144b7c833a49fc07c777f6a052bd365fd913b8327cae62994c9523a373706017268a5df07ceb2b9371971a1adcbcc9d879", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dafaa9c7195167870efebd6f38175a6b7e2f986e5e1fd3706cad5576cedaaeca817bb360491fb1cc0a784d4a0edad2c28a3e7c95bb9c277847150acaa4757de2"} 01:53:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:53:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:53:03 INFO - Contents: 01:53:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/638b7be5c975bebc7b7635c471b79df90746beb717a79c3fcb8c7437b945b44d7201ec2257cc56318c8e890431d2533ba6eca82241f442c7a9c7f9f20c9a8531", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/93571055a677e0a38c67775c7f74f827852691f359465518f98c608a0d17f1465e3a84e5d1ff30edf80614120efea3498c1bdefdcc0dec729d48ecaf2da147cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf0caa3f513453020728a75775f353144b7c833a49fc07c777f6a052bd365fd913b8327cae62994c9523a373706017268a5df07ceb2b9371971a1adcbcc9d879", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dafaa9c7195167870efebd6f38175a6b7e2f986e5e1fd3706cad5576cedaaeca817bb360491fb1cc0a784d4a0edad2c28a3e7c95bb9c277847150acaa4757de2"} 01:53:03 INFO - Running post-run listener: copy_logs_to_upload_dir 01:53:03 INFO - Copying logs to upload dir... 01:53:03 INFO - mkdir: /builds/slave/test/build/upload/logs 01:53:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.192606 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-05-04 01:53:03.365728) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 01:53:03.368799) ========= 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.A1PGQKau6P/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.MWCTJgnNF8/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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/638b7be5c975bebc7b7635c471b79df90746beb717a79c3fcb8c7437b945b44d7201ec2257cc56318c8e890431d2533ba6eca82241f442c7a9c7f9f20c9a8531", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/93571055a677e0a38c67775c7f74f827852691f359465518f98c608a0d17f1465e3a84e5d1ff30edf80614120efea3498c1bdefdcc0dec729d48ecaf2da147cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf0caa3f513453020728a75775f353144b7c833a49fc07c777f6a052bd365fd913b8327cae62994c9523a373706017268a5df07ceb2b9371971a1adcbcc9d879", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dafaa9c7195167870efebd6f38175a6b7e2f986e5e1fd3706cad5576cedaaeca817bb360491fb1cc0a784d4a0edad2c28a3e7c95bb9c277847150acaa4757de2"} build_url:https://queue.taskcluster.net/v1/task/ZzmhA1fZSn2NwhvHHbQg6w/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011096 build_url: 'https://queue.taskcluster.net/v1/task/ZzmhA1fZSn2NwhvHHbQg6w/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/638b7be5c975bebc7b7635c471b79df90746beb717a79c3fcb8c7437b945b44d7201ec2257cc56318c8e890431d2533ba6eca82241f442c7a9c7f9f20c9a8531", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/93571055a677e0a38c67775c7f74f827852691f359465518f98c608a0d17f1465e3a84e5d1ff30edf80614120efea3498c1bdefdcc0dec729d48ecaf2da147cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf0caa3f513453020728a75775f353144b7c833a49fc07c777f6a052bd365fd913b8327cae62994c9523a373706017268a5df07ceb2b9371971a1adcbcc9d879", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dafaa9c7195167870efebd6f38175a6b7e2f986e5e1fd3706cad5576cedaaeca817bb360491fb1cc0a784d4a0edad2c28a3e7c95bb9c277847150acaa4757de2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 01:53:03.404811) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 01:53:03.405166) ========= 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.A1PGQKau6P/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.MWCTJgnNF8/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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.005269 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 01:53:03.454358) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 01:53:03.454719) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 01:53:03.455048) ========= ========= Total master_lag: 0.90 =========