builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0032 starttime: 1493067396.68 results: success (0) buildid: 20170424123625 builduid: 645e414e1c7e4ddea995583f2a4b0a28 revision: a236801aa0225218df1f74cc365bd68b6305a5db ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-24 13:56:36.677879) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-24 13:56:36.678402) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-24 13:56:36.678684) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-24 13:56:36.706616) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 13:56:36.707004) ========= 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.OYW7qBWfoz/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.ZNYeZLSpga/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-24 13:56:36-- 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% 142M=0s 2017-04-24 13:56:36 (142 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.163069 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 13:56:36.895555) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 13:56:36.895887) ========= 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.OYW7qBWfoz/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.ZNYeZLSpga/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.029110 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 13:56:36.947947) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 13:56:36.948383) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a236801aa0225218df1f74cc365bd68b6305a5db --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 a236801aa0225218df1f74cc365bd68b6305a5db --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OYW7qBWfoz/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.ZNYeZLSpga/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-24 13:56:37,051 truncating revision to first 12 chars 2017-04-24 13:56:37,051 Setting DEBUG logging. 2017-04-24 13:56:37,051 attempt 1/10 2017-04-24 13:56:37,051 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a236801aa022?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-24 13:56:37,581 unpacking tar archive at: mozilla-beta-a236801aa022/testing/mozharness/ program finished with exit code 0 elapsedTime=0.818966 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 13:56:37.791728) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-24 13:56:37.792054) ========= script_repo_revision: a236801aa0225218df1f74cc365bd68b6305a5db ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-24 13:56:37.792463) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-24 13:56:37.792751) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-24 13:56:37.813347) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-04-24 13:56:37.813730) ========= /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.OYW7qBWfoz/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.ZNYeZLSpga/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 13:56:38 INFO - MultiFileLogger online at 20170424 13:56:38 in /builds/slave/test 13:56:38 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 13:56:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:56:38 INFO - {'append_to_log': False, 13:56:38 INFO - 'base_work_dir': '/builds/slave/test', 13:56:38 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:56:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:56:38 INFO - 'branch': 'Mozilla-Beta', 13:56:38 INFO - 'buildbot_json_path': 'buildprops.json', 13:56:38 INFO - 'config_files': ('talos/mac_config.py',), 13:56:38 INFO - 'default_actions': ('clobber', 13:56:38 INFO - 'read-buildbot-config', 13:56:38 INFO - 'download-and-extract', 13:56:38 INFO - 'populate-webroot', 13:56:38 INFO - 'create-virtualenv', 13:56:38 INFO - 'install', 13:56:38 INFO - 'run-tests'), 13:56:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:56:38 INFO - 'download_minidump_stackwalk': True, 13:56:38 INFO - 'download_symbols': 'ondemand', 13:56:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:56:38 INFO - 'tooltool.py': '/tools/tooltool.py', 13:56:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:56:38 INFO - '/tools/misc-python/virtualenv.py')}, 13:56:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:56:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:56:38 INFO - 'gecko_profile': False, 13:56:38 INFO - 'gecko_profile_interval': 0, 13:56:38 INFO - 'installer_path': 'installer.exe', 13:56:38 INFO - 'log_level': 'info', 13:56:38 INFO - 'log_name': 'talos', 13:56:38 INFO - 'log_to_console': True, 13:56:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:56:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:56:38 INFO - 'opt_config_files': (), 13:56:38 INFO - 'pip_index': False, 13:56:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:56:38 INFO - 'cmd': ('bash', 13:56:38 INFO - '-c', 13:56:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:56:38 INFO - 'enabled': True, 13:56:38 INFO - 'halt_on_failure': False, 13:56:38 INFO - 'name': 'check_screen_resolution'},), 13:56:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:56:38 INFO - 'cmd': ('bash', 13:56:38 INFO - '-c', 13:56:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:56:38 INFO - 'enabled': True, 13:56:38 INFO - 'halt_on_failure': False, 13:56:38 INFO - 'name': 'check_screen_resolution'},), 13:56:38 INFO - 'run_cmd_checks_enabled': True, 13:56:38 INFO - 'suite': 'dromaeojs', 13:56:38 INFO - 'system_bits': '32', 13:56:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:56:38 INFO - 'title': 't-yosemite-r7-0032', 13:56:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:56:38 INFO - 'use_talos_json': True, 13:56:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:56:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:56:38 INFO - 'work_dir': 'build'} 13:56:38 INFO - [mozharness: 2017-04-24 20:56:38.029293Z] Running clobber step. 13:56:38 INFO - Running pre-action listener: _resource_record_pre_action 13:56:38 INFO - Running main action method: clobber 13:56:38 INFO - rmtree: /builds/slave/test/build 13:56:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:56:40 INFO - Running post-action listener: _resource_record_post_action 13:56:40 INFO - [mozharness: 2017-04-24 20:56:40.451809Z] Finished clobber step (success) 13:56:40 INFO - [mozharness: 2017-04-24 20:56:40.451995Z] Running read-buildbot-config step. 13:56:40 INFO - Running pre-action listener: _resource_record_pre_action 13:56:40 INFO - Running main action method: read_buildbot_config 13:56:40 INFO - Using buildbot properties: 13:56:40 INFO - { 13:56:40 INFO - "project": "", 13:56:40 INFO - "product": "firefox", 13:56:40 INFO - "script_repo_revision": "production", 13:56:40 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 13:56:40 INFO - "repository": "", 13:56:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 13:56:40 INFO - "buildid": "20170424123625", 13:56:40 INFO - "pgo_build": "False", 13:56:40 INFO - "basedir": "/builds/slave/test", 13:56:40 INFO - "buildnumber": 3, 13:56:40 INFO - "slavename": "t-yosemite-r7-0032", 13:56:40 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 13:56:40 INFO - "platform": "yosemite_r7", 13:56:40 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 13:56:40 INFO - "branch": "mozilla-beta", 13:56:40 INFO - "repo_path": "releases/mozilla-beta", 13:56:40 INFO - "revision": "a236801aa0225218df1f74cc365bd68b6305a5db", 13:56:40 INFO - "stage_platform": "macosx64", 13:56:40 INFO - "builduid": "645e414e1c7e4ddea995583f2a4b0a28", 13:56:40 INFO - "slavebuilddir": "test" 13:56:40 INFO - } 13:56:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/c5HQkDTIQ8OQ5eOS1dsjsA/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 13:56:40 INFO - Running post-action listener: _resource_record_post_action 13:56:40 INFO - [mozharness: 2017-04-24 20:56:40.455301Z] Finished read-buildbot-config step (success) 13:56:40 INFO - [mozharness: 2017-04-24 20:56:40.455416Z] Running download-and-extract step. 13:56:40 INFO - Running pre-action listener: _resource_record_pre_action 13:56:40 INFO - Running main action method: download_and_extract 13:56:40 INFO - mkdir: /builds/slave/test/build/tests 13:56: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')]} 13:56:40 INFO - trying https://queue.taskcluster.net/v1/task/c5HQkDTIQ8OQ5eOS1dsjsA/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 13:56:40 INFO - Downloading https://queue.taskcluster.net/v1/task/c5HQkDTIQ8OQ5eOS1dsjsA/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 13:56:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c5HQkDTIQ8OQ5eOS1dsjsA/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 13:56:41 INFO - Downloaded 1165 bytes. 13:56:41 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 13:56:41 INFO - Using the following test package requirements: 13:56:41 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 13:56:41 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:56:41 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 13:56:41 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:56:41 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 13:56:41 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 13:56:41 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:56:41 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 13:56:41 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 13:56:41 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:56:41 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 13:56:41 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:56:41 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 13:56:41 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:56:41 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 13:56:41 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:56:41 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 13:56:41 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 13:56:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c5HQkDTIQ8OQ5eOS1dsjsA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 13:56:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c5HQkDTIQ8OQ5eOS1dsjsA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 13:56:41 INFO - Fetch https://queue.taskcluster.net/v1/task/c5HQkDTIQ8OQ5eOS1dsjsA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 13:56:44 INFO - Expected file size: 51220919 13:56:44 INFO - Obtained file size: 51220919 13:57:00 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 13:57:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c5HQkDTIQ8OQ5eOS1dsjsA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 13:57:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c5HQkDTIQ8OQ5eOS1dsjsA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 13:57:00 INFO - Fetch https://queue.taskcluster.net/v1/task/c5HQkDTIQ8OQ5eOS1dsjsA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 13:57:01 INFO - Expected file size: 51220919 13:57:01 INFO - Obtained file size: 51220919 13:57:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c5HQkDTIQ8OQ5eOS1dsjsA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 13:57:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c5HQkDTIQ8OQ5eOS1dsjsA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 13:57:16 INFO - Fetch https://queue.taskcluster.net/v1/task/c5HQkDTIQ8OQ5eOS1dsjsA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 13:57:18 INFO - Expected file size: 14404449 13:57:18 INFO - Obtained file size: 14404449 13:57:18 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')]} 13:57:18 INFO - trying https://queue.taskcluster.net/v1/task/c5HQkDTIQ8OQ5eOS1dsjsA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 13:57:18 INFO - Downloading https://queue.taskcluster.net/v1/task/c5HQkDTIQ8OQ5eOS1dsjsA/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 13:57:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c5HQkDTIQ8OQ5eOS1dsjsA/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 13:57:20 INFO - Downloaded 59532854 bytes. 13:57:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c5HQkDTIQ8OQ5eOS1dsjsA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 13:57:20 INFO - mkdir: /builds/slave/test/properties 13:57:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:57:20 INFO - Writing to file /builds/slave/test/properties/build_url 13:57:20 INFO - Contents: 13:57:20 INFO - build_url:https://queue.taskcluster.net/v1/task/c5HQkDTIQ8OQ5eOS1dsjsA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 13:57:20 INFO - Running post-action listener: _resource_record_post_action 13:57:20 INFO - Running post-action listener: set_extra_try_arguments 13:57:20 INFO - [mozharness: 2017-04-24 20:57:20.995425Z] Finished download-and-extract step (success) 13:57:20 INFO - [mozharness: 2017-04-24 20:57:20.995544Z] Running populate-webroot step. 13:57:20 INFO - Running pre-action listener: _resource_record_pre_action 13:57:20 INFO - Running main action method: populate_webroot 13:57:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:57:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:57:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:57:21 INFO - '--tppagecycles', 13:57:21 INFO - '7'], 13:57:21 INFO - 'tests': ['tsvgm']}}, 13:57:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:57:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:57:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:57:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:57:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:57:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:57:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:57:21 INFO - 'talos_options': ['--disable-e10s'], 13:57:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:57:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:57:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:57:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:57:21 INFO - 'talos_options': ['--disable-e10s'], 13:57:21 INFO - 'tests': ['damp', 'tps']}, 13:57:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:57:21 INFO - 'tests': ['damp', 'tps']}, 13:57:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:57:21 INFO - 'tests': ['dromaeo_dom']}, 13:57:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:57:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:57:21 INFO - 'tests': ['basic_compositor_video']}, 13:57:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:57:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:57:21 INFO - 'tests': ['a11yr', 13:57:21 INFO - 'ts_paint', 13:57:21 INFO - 'tpaint', 13:57:21 INFO - 'sessionrestore', 13:57:21 INFO - 'sessionrestore_no_auto_restore', 13:57:21 INFO - 'tabpaint']}, 13:57:21 INFO - 'other-e10s': {'tests': ['a11yr', 13:57:21 INFO - 'ts_paint', 13:57:21 INFO - 'tpaint', 13:57:21 INFO - 'sessionrestore', 13:57:21 INFO - 'sessionrestore_no_auto_restore', 13:57:21 INFO - 'tabpaint']}, 13:57:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:57:21 INFO - 'ts_paint', 13:57:21 INFO - 'tpaint', 13:57:21 INFO - 'sessionrestore', 13:57:21 INFO - 'sessionrestore_no_auto_restore', 13:57:21 INFO - 'tabpaint']}, 13:57:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:57:21 INFO - 'ts_paint', 13:57:21 INFO - 'tpaint', 13:57:21 INFO - 'sessionrestore', 13:57:21 INFO - 'sessionrestore_no_auto_restore', 13:57:21 INFO - 'tabpaint']}, 13:57:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:57:21 INFO - 'tests': ['a11yr', 13:57:21 INFO - 'ts_paint', 13:57:21 INFO - 'tpaint', 13:57:21 INFO - 'sessionrestore', 13:57:21 INFO - 'sessionrestore_no_auto_restore', 13:57:21 INFO - 'tabpaint']}, 13:57:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:57:21 INFO - 'tests': ['a11yr', 13:57:21 INFO - 'ts_paint', 13:57:21 INFO - 'tpaint', 13:57:21 INFO - 'sessionrestore', 13:57:21 INFO - 'sessionrestore_no_auto_restore', 13:57:21 INFO - 'tabpaint']}, 13:57:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:57:21 INFO - 'tests': ['tsvgx', 13:57:21 INFO - 'tsvgr_opacity', 13:57:21 INFO - 'tart', 13:57:21 INFO - 'tscrollx', 13:57:21 INFO - 'cart', 13:57:21 INFO - 'tsvg_static']}, 13:57:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:57:21 INFO - 'tsvgr_opacity', 13:57:21 INFO - 'tart', 13:57:21 INFO - 'tscrollx', 13:57:21 INFO - 'cart', 13:57:21 INFO - 'tsvg_static']}, 13:57:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:57:21 INFO - 'talos_options': ['--disable-e10s'], 13:57:21 INFO - 'tests': ['tp5o']}, 13:57:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:57:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:57:21 INFO - 'talos_options': ['--disable-e10s', 13:57:21 INFO - '--xperf_path', 13:57:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:57:21 INFO - 'tests': ['tp5n']}, 13:57:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:57:21 INFO - 'talos_options': ['--xperf_path', 13:57:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:57:21 INFO - 'tests': ['tp5n']}}, 13:57:21 INFO - 'talos.zip': {'path': '', 13:57:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:57:21 INFO - Running post-action listener: _resource_record_post_action 13:57:21 INFO - [mozharness: 2017-04-24 20:57:21.013607Z] Finished populate-webroot step (success) 13:57:21 INFO - [mozharness: 2017-04-24 20:57:21.013727Z] Running create-virtualenv step. 13:57:21 INFO - Running pre-action listener: _resource_record_pre_action 13:57:21 INFO - Running main action method: create_virtualenv 13:57:21 INFO - Creating virtualenv /builds/slave/test/build/venv 13:57:21 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 13:57:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:57:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:57:21 INFO - Using real prefix '/tools/python27' 13:57:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:57:21 INFO - Installing distribute.............................................................................................................................................................................................done. 13:57:24 INFO - Installing pip.................done. 13:57:24 INFO - Return code: 0 13:57:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:57:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:57:25 INFO - Reading from file tmpfile_stdout 13:57:25 INFO - Output received: 13:57:25 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) 13:57:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:25 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 0x1032f0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032f3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7c9c9d950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030ced30>, '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 0x102ff5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1030c3be8>, '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.OYW7qBWfoz/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.ZNYeZLSpga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 13:57:25 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 13:57:25 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 13:57:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OYW7qBWfoz/Render', 13:57:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:25 INFO - 'HOME': '/Users/cltbld', 13:57:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:25 INFO - 'LOGNAME': 'cltbld', 13:57:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:25 INFO - 'MOZ_NO_REMOTE': '1', 13:57:25 INFO - 'NO_EM_RESTART': '1', 13:57:25 INFO - 'PAGER': '/bin/cat', 13:57:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:25 INFO - 'PWD': '/builds/slave/test', 13:57:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:25 INFO - 'SHELL': '/bin/bash', 13:57:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZNYeZLSpga/Listeners', 13:57:25 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:57:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:25 INFO - 'USER': 'cltbld', 13:57:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:25 INFO - 'XPC_FLAGS': '0x0', 13:57:25 INFO - 'XPC_SERVICE_NAME': '0', 13:57:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:26 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 13:57:26 INFO - Cleaning up... 13:57:26 INFO - Return code: 0 13:57:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:26 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 0x1032f0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032f3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7c9c9d950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030ced30>, '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 0x102ff5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1030c3be8>, '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.OYW7qBWfoz/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.ZNYeZLSpga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 13:57:26 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 13:57:26 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 13:57:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OYW7qBWfoz/Render', 13:57:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:26 INFO - 'HOME': '/Users/cltbld', 13:57:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:26 INFO - 'LOGNAME': 'cltbld', 13:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:26 INFO - 'MOZ_NO_REMOTE': '1', 13:57:26 INFO - 'NO_EM_RESTART': '1', 13:57:26 INFO - 'PAGER': '/bin/cat', 13:57:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:26 INFO - 'PWD': '/builds/slave/test', 13:57:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:26 INFO - 'SHELL': '/bin/bash', 13:57:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZNYeZLSpga/Listeners', 13:57:26 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:57:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:26 INFO - 'USER': 'cltbld', 13:57:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:26 INFO - 'XPC_FLAGS': '0x0', 13:57:26 INFO - 'XPC_SERVICE_NAME': '0', 13:57:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:26 INFO - Downloading/unpacking psutil>=3.1.1 13:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:57:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:57:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:57:30 INFO - Installing collected packages: psutil 13:57:30 INFO - Running setup.py install for psutil 13:57:30 INFO - building 'psutil._psutil_osx' extension 13:57:30 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 13:57:31 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 13:57:31 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 13:57:31 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 13:57:31 INFO - building 'psutil._psutil_posix' extension 13:57:31 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 13:57:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:57:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:57:31 INFO - ^ 13:57:31 INFO - 1 warning generated. 13:57:31 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 13:57:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:57:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:57:31 INFO - Successfully installed psutil 13:57:31 INFO - Cleaning up... 13:57:31 INFO - Return code: 0 13:57:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:57:31 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')]} 13:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:31 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')]} 13:57:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:31 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 0x1032f0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032f3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7c9c9d950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030ced30>, '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 0x102ff5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1030c3be8>, '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.OYW7qBWfoz/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.ZNYeZLSpga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 13:57:31 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 13:57:31 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 13:57:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OYW7qBWfoz/Render', 13:57:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:31 INFO - 'HOME': '/Users/cltbld', 13:57:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:31 INFO - 'LOGNAME': 'cltbld', 13:57:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:31 INFO - 'MOZ_NO_REMOTE': '1', 13:57:31 INFO - 'NO_EM_RESTART': '1', 13:57:31 INFO - 'PAGER': '/bin/cat', 13:57:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:31 INFO - 'PWD': '/builds/slave/test', 13:57:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:31 INFO - 'SHELL': '/bin/bash', 13:57:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZNYeZLSpga/Listeners', 13:57:31 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:57:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:31 INFO - 'USER': 'cltbld', 13:57:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:31 INFO - 'XPC_FLAGS': '0x0', 13:57:31 INFO - 'XPC_SERVICE_NAME': '0', 13:57:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:57:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:57:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:57:34 INFO - Installing collected packages: mozsystemmonitor 13:57:34 INFO - Running setup.py install for mozsystemmonitor 13:57:34 INFO - Successfully installed mozsystemmonitor 13:57:34 INFO - Cleaning up... 13:57:35 INFO - Return code: 0 13:57:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:57:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1032f0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032f3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7c9c9d950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030ced30>, '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 0x102ff5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1030c3be8>, '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.OYW7qBWfoz/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.ZNYeZLSpga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 13:57:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:57:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:57:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OYW7qBWfoz/Render', 13:57:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:35 INFO - 'HOME': '/Users/cltbld', 13:57:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:35 INFO - 'LOGNAME': 'cltbld', 13:57:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:35 INFO - 'MOZ_NO_REMOTE': '1', 13:57:35 INFO - 'NO_EM_RESTART': '1', 13:57:35 INFO - 'PAGER': '/bin/cat', 13:57:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:35 INFO - 'PWD': '/builds/slave/test', 13:57:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:35 INFO - 'SHELL': '/bin/bash', 13:57:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZNYeZLSpga/Listeners', 13:57:35 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:57:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:35 INFO - 'USER': 'cltbld', 13:57:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:35 INFO - 'XPC_FLAGS': '0x0', 13:57:35 INFO - 'XPC_SERVICE_NAME': '0', 13:57:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:35 INFO - Downloading/unpacking jsonschema==2.5.1 13:57:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:57:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:57:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:57:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:57:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:57:37 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 13:57:37 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 13:57:37 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 13:57:37 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 13:57:37 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 13:57:37 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 13:57:38 INFO - Downloading functools32-3.2.3-2.tar.gz 13:57:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:57:38 INFO - warning: no files found matching '*.txt' 13:57:38 INFO - no previously-included directories found matching 'build' 13:57:38 INFO - no previously-included directories found matching 'dist' 13:57:38 INFO - no previously-included directories found matching '.git*' 13:57:38 INFO - Installing collected packages: jsonschema, functools32 13:57:38 INFO - Running setup.py install for functools32 13:57:38 INFO - warning: no files found matching '*.txt' 13:57:38 INFO - no previously-included directories found matching 'build' 13:57:38 INFO - no previously-included directories found matching 'dist' 13:57:38 INFO - no previously-included directories found matching '.git*' 13:57:38 INFO - Successfully installed jsonschema functools32 13:57:38 INFO - Cleaning up... 13:57:38 INFO - Return code: 0 13:57:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:57:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1032f0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032f3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7c9c9d950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030ced30>, '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 0x102ff5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1030c3be8>, '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.OYW7qBWfoz/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.ZNYeZLSpga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 13:57:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:57:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:57:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OYW7qBWfoz/Render', 13:57:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:38 INFO - 'HOME': '/Users/cltbld', 13:57:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:38 INFO - 'LOGNAME': 'cltbld', 13:57:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:38 INFO - 'MOZ_NO_REMOTE': '1', 13:57:38 INFO - 'NO_EM_RESTART': '1', 13:57:38 INFO - 'PAGER': '/bin/cat', 13:57:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:38 INFO - 'PWD': '/builds/slave/test', 13:57:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:38 INFO - 'SHELL': '/bin/bash', 13:57:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZNYeZLSpga/Listeners', 13:57:38 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:57:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:38 INFO - 'USER': 'cltbld', 13:57:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:38 INFO - 'XPC_FLAGS': '0x0', 13:57:38 INFO - 'XPC_SERVICE_NAME': '0', 13:57:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:57:38 INFO - Cleaning up... 13:57:39 INFO - Return code: 0 13:57:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:57:39 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')]} 13:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:39 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')]} 13:57:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:39 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 0x1032f0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032f3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7c9c9d950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030ced30>, '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 0x102ff5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1030c3be8>, '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.OYW7qBWfoz/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.ZNYeZLSpga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 13:57:39 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 13:57:39 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 13:57:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OYW7qBWfoz/Render', 13:57:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:39 INFO - 'HOME': '/Users/cltbld', 13:57:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:39 INFO - 'LOGNAME': 'cltbld', 13:57:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:39 INFO - 'MOZ_NO_REMOTE': '1', 13:57:39 INFO - 'NO_EM_RESTART': '1', 13:57:39 INFO - 'PAGER': '/bin/cat', 13:57:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:39 INFO - 'PWD': '/builds/slave/test', 13:57:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:39 INFO - 'SHELL': '/bin/bash', 13:57:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZNYeZLSpga/Listeners', 13:57:39 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:57:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:39 INFO - 'USER': 'cltbld', 13:57:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:39 INFO - 'XPC_FLAGS': '0x0', 13:57:39 INFO - 'XPC_SERVICE_NAME': '0', 13:57:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:39 INFO - Downloading/unpacking blobuploader==1.2.4 13:57:39 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 13:57:39 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 13:57:39 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 13:57:39 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 13:57:39 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 13:57:39 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 13:57:41 INFO - Downloading blobuploader-1.2.4.tar.gz 13:57:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:57:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:57:41 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 13:57:41 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 13:57:41 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 13:57:41 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 13:57:41 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 13:57:41 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 13:57:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:57:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:57:42 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 13:57:42 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 13:57:42 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 13:57:42 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 13:57:42 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 13:57:42 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 13:57:43 INFO - Downloading docopt-0.6.1.tar.gz 13:57:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:57:43 INFO - Installing collected packages: blobuploader, requests, docopt 13:57:43 INFO - Running setup.py install for blobuploader 13:57:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:57:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:57:43 INFO - Running setup.py install for requests 13:57:43 INFO - Running setup.py install for docopt 13:57:43 INFO - Successfully installed blobuploader requests docopt 13:57:43 INFO - Cleaning up... 13:57:44 INFO - Return code: 0 13:57:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:57: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')]} 13:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57: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')]} 13:57:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:44 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 0x1032f0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032f3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7c9c9d950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030ced30>, '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 0x102ff5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1030c3be8>, '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.OYW7qBWfoz/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.ZNYeZLSpga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 13:57:44 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 13:57:44 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 13:57:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OYW7qBWfoz/Render', 13:57:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:44 INFO - 'HOME': '/Users/cltbld', 13:57:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:44 INFO - 'LOGNAME': 'cltbld', 13:57:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:44 INFO - 'MOZ_NO_REMOTE': '1', 13:57:44 INFO - 'NO_EM_RESTART': '1', 13:57:44 INFO - 'PAGER': '/bin/cat', 13:57:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:44 INFO - 'PWD': '/builds/slave/test', 13:57:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:44 INFO - 'SHELL': '/bin/bash', 13:57:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZNYeZLSpga/Listeners', 13:57:44 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:57:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:44 INFO - 'USER': 'cltbld', 13:57:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:44 INFO - 'XPC_FLAGS': '0x0', 13:57:44 INFO - 'XPC_SERVICE_NAME': '0', 13:57:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:57:44 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-uRcELf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:57:44 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-myh2ZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:57:44 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-J6IDB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:57:44 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-bBbsd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:57:44 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-8xBLGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:57:44 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-xdP7Xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:57:44 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-bO7Bz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:57:45 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-cXawcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:57:45 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-Zh6ogK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:57:45 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-zNO1KD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:57:45 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-DU13Ph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:57:45 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-iTmIok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:57:45 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-luGymd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:57:45 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-1qJJY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:57:45 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-8ZBbh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:57:45 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-g6oVtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:57:45 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-gbt97x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:57:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:57:46 INFO - Running setup.py install for manifestparser 13:57:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:57:46 INFO - Running setup.py install for mozcrash 13:57:46 INFO - Running setup.py install for mozdebug 13:57:46 INFO - Running setup.py install for mozdevice 13:57:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:57:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:57:46 INFO - Running setup.py install for mozfile 13:57:46 INFO - Running setup.py install for mozhttpd 13:57:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:57:46 INFO - Running setup.py install for mozinfo 13:57:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:57:47 INFO - Running setup.py install for mozInstall 13:57:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:57:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:57:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:57:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:57:47 INFO - Running setup.py install for mozleak 13:57:47 INFO - Running setup.py install for mozlog 13:57:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:57:47 INFO - Running setup.py install for moznetwork 13:57:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:57:47 INFO - Running setup.py install for mozprocess 13:57:47 INFO - Running setup.py install for mozprofile 13:57:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:57:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:57:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:57:48 INFO - Running setup.py install for mozrunner 13:57:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:57:48 INFO - Running setup.py install for mozscreenshot 13:57:48 INFO - Running setup.py install for moztest 13:57:48 INFO - Running setup.py install for mozversion 13:57:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:57:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:57:48 INFO - Cleaning up... 13:57:48 INFO - Return code: 0 13:57:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:48 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 0x1032f0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032f3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7c9c9d950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030ced30>, '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 0x102ff5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1030c3be8>, '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.OYW7qBWfoz/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.ZNYeZLSpga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 13:57:48 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 13:57:48 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 13:57:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OYW7qBWfoz/Render', 13:57:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:48 INFO - 'HOME': '/Users/cltbld', 13:57:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:48 INFO - 'LOGNAME': 'cltbld', 13:57:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:48 INFO - 'MOZ_NO_REMOTE': '1', 13:57:48 INFO - 'NO_EM_RESTART': '1', 13:57:48 INFO - 'PAGER': '/bin/cat', 13:57:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:48 INFO - 'PWD': '/builds/slave/test', 13:57:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:48 INFO - 'SHELL': '/bin/bash', 13:57:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZNYeZLSpga/Listeners', 13:57:48 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:57:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:48 INFO - 'USER': 'cltbld', 13:57:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:48 INFO - 'XPC_FLAGS': '0x0', 13:57:48 INFO - 'XPC_SERVICE_NAME': '0', 13:57:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:57:48 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-vmIUgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:57:49 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)) 13:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:57:49 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-UeGJG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:57:49 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)) 13:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:57:49 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-6QJcfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:57:49 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)) 13:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:57:49 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-u8h7Pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:57:49 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)) 13:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:57:49 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-2jKBJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:57:49 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)) 13:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:57:49 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-p00VtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:57:49 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)) 13:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:57:49 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-pWIuzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:57:49 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)) 13:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:57:49 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-_tlVzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:57:49 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)) 13:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:57:49 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-GZFaVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:57:49 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)) 13:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:57:49 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-DkyRuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:57:50 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)) 13:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:57:50 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-UTJ6Tv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:57:50 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)) 13:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:57:50 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-b6Y9n7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:57:50 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)) 13:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:57:50 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-ajF03f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:57:50 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)) 13:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:57:50 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-8k_GNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:57:50 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)) 13:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:57:50 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-tDmhnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:57:50 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)) 13:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:57:50 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-CKHig0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:57:50 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)) 13:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:57:50 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-Nc6MLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:57:50 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)) 13:57:50 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)) 13:57:50 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)) 13:57:50 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)) 13:57:50 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)) 13:57:50 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)) 13:57:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:57:50 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 13:57:50 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 13:57:50 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 13:57:50 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 13:57:50 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 13:57:50 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 13:57:53 INFO - Downloading blessings-1.6.tar.gz 13:57:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:57:53 INFO - Installing collected packages: blessings 13:57:53 INFO - Running setup.py install for blessings 13:57:53 INFO - Successfully installed blessings 13:57:53 INFO - Cleaning up... 13:57:53 INFO - Return code: 0 13:57:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:57:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:57:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:57:54 INFO - Reading from file tmpfile_stdout 13:57:54 INFO - Current package versions: 13:57:54 INFO - blessings == 1.6 13:57:54 INFO - blobuploader == 1.2.4 13:57:54 INFO - docopt == 0.6.1 13:57:54 INFO - functools32 == 3.2.3-2 13:57:54 INFO - jsonschema == 2.5.1 13:57:54 INFO - manifestparser == 1.1 13:57:54 INFO - mozInstall == 1.12 13:57:54 INFO - mozcrash == 1.0 13:57:54 INFO - mozdebug == 0.1 13:57:54 INFO - mozdevice == 0.49 13:57:54 INFO - mozfile == 1.2 13:57:54 INFO - mozhttpd == 0.7 13:57:54 INFO - mozinfo == 0.9 13:57:54 INFO - mozleak == 0.1 13:57:54 INFO - mozlog == 3.4 13:57:54 INFO - moznetwork == 0.27 13:57:54 INFO - mozprocess == 0.25 13:57:54 INFO - mozprofile == 0.28 13:57:54 INFO - mozrunner == 6.13 13:57:54 INFO - mozscreenshot == 0.1 13:57:54 INFO - mozsystemmonitor == 0.3 13:57:54 INFO - moztest == 0.8 13:57:54 INFO - mozversion == 1.4 13:57:54 INFO - psutil == 3.1.1 13:57:54 INFO - requests == 1.2.3 13:57:54 INFO - wsgiref == 0.1.2 13:57:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:57:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:54 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 0x1032f0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032f3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7c9c9d950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030ced30>, '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 0x102ff5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1030c3be8>, '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.OYW7qBWfoz/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.ZNYeZLSpga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 13:57:54 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 13:57:54 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 13:57:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OYW7qBWfoz/Render', 13:57:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:54 INFO - 'HOME': '/Users/cltbld', 13:57:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:54 INFO - 'LOGNAME': 'cltbld', 13:57:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:54 INFO - 'MOZ_NO_REMOTE': '1', 13:57:54 INFO - 'NO_EM_RESTART': '1', 13:57:54 INFO - 'PAGER': '/bin/cat', 13:57:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:54 INFO - 'PWD': '/builds/slave/test', 13:57:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:54 INFO - 'SHELL': '/bin/bash', 13:57:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZNYeZLSpga/Listeners', 13:57:54 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:57:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:54 INFO - 'USER': 'cltbld', 13:57:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:54 INFO - 'XPC_FLAGS': '0x0', 13:57:54 INFO - 'XPC_SERVICE_NAME': '0', 13:57:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:54 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)) 13:57:54 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)) 13:57:54 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)) 13:57:54 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)) 13:57:54 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)) 13:57:54 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)) 13:57:54 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)) 13:57:54 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)) 13:57:54 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)) 13:57:54 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)) 13:57:54 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)) 13:57:54 INFO - Cleaning up... 13:57:54 INFO - Return code: 0 13:57:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:57:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1032f0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032f3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7c9c9d950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030ced30>, '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 0x102ff5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1030c3be8>, '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.OYW7qBWfoz/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.ZNYeZLSpga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 13:57:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:57:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:57:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OYW7qBWfoz/Render', 13:57:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:54 INFO - 'HOME': '/Users/cltbld', 13:57:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:54 INFO - 'LOGNAME': 'cltbld', 13:57:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:54 INFO - 'MOZ_NO_REMOTE': '1', 13:57:54 INFO - 'NO_EM_RESTART': '1', 13:57:54 INFO - 'PAGER': '/bin/cat', 13:57:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:54 INFO - 'PWD': '/builds/slave/test', 13:57:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:54 INFO - 'SHELL': '/bin/bash', 13:57:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZNYeZLSpga/Listeners', 13:57:54 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:57:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:54 INFO - 'USER': 'cltbld', 13:57:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:54 INFO - 'XPC_FLAGS': '0x0', 13:57:54 INFO - 'XPC_SERVICE_NAME': '0', 13:57:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:57:54 INFO - Cleaning up... 13:57:54 INFO - Return code: 0 13:57:54 INFO - Running post-action listener: _resource_record_post_action 13:57:54 INFO - Running post-action listener: _start_resource_monitoring 13:57:54 INFO - Starting resource monitoring. 13:57:54 INFO - [mozharness: 2017-04-24 20:57:54.660780Z] Finished create-virtualenv step (success) 13:57:54 INFO - [mozharness: 2017-04-24 20:57:54.661827Z] Running install step. 13:57:54 INFO - Running pre-action listener: _resource_record_pre_action 13:57:54 INFO - Running main action method: install 13:57:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:57:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:57:54 INFO - Reading from file tmpfile_stdout 13:57:54 INFO - Detecting whether we're running mozinstall >=1.0... 13:57:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:57:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:57:55 INFO - Reading from file tmpfile_stdout 13:57:55 INFO - Output received: 13:57:55 INFO - Usage: mozinstall [options] installer 13:57:55 INFO - Options: 13:57:55 INFO - -h, --help show this help message and exit 13:57:55 INFO - -d DEST, --destination=DEST 13:57:55 INFO - Directory to install application into. [default: 13:57:55 INFO - "/builds/slave/test"] 13:57:55 INFO - --app=APP Application being installed. [default: firefox] 13:57:55 INFO - mkdir: /builds/slave/test/build/application 13:57:55 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'] 13:57:55 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 13:58:09 INFO - Reading from file tmpfile_stdout 13:58:09 INFO - Output received: 13:58:09 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 13:58:09 INFO - Running post-action listener: _resource_record_post_action 13:58:09 INFO - [mozharness: 2017-04-24 20:58:09.703555Z] Finished install step (success) 13:58:09 INFO - [mozharness: 2017-04-24 20:58:09.703699Z] Running run-tests step. 13:58:09 INFO - Running pre-action listener: _resource_record_pre_action 13:58:09 INFO - Running main action method: run_tests 13:58:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:58:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:58:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:58:09 INFO - 2017-04-24 13:58:09.718 screenresolution[1629:7487] starting screenresolution argv=screenresolution get 13:58:09 INFO - 2017-04-24 13:58:09.721 screenresolution[1629:7487] Display 0: 1600x1200x32@60 13:58:09 INFO - 2017-04-24 13:58:09.727 screenresolution[1630:7489] starting screenresolution argv=screenresolution list 13:58:09 INFO - Available Modes on Display 0 13:58:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:58:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:58:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:58:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:58:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:58:09 INFO - Intel Iris: 13:58:09 INFO - Chipset Model: Intel Iris 13:58:09 INFO - Type: GPU 13:58:09 INFO - Bus: Built-In 13:58:09 INFO - VRAM (Dynamic, Max): 1536 MB 13:58:09 INFO - Vendor: Intel (0x8086) 13:58:09 INFO - Device ID: 0x0a2e 13:58:09 INFO - Revision ID: 0x0009 13:58:09 INFO - Displays: 13:58:09 INFO - Display: 13:58:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:58:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:58:09 INFO - Display Serial Number: 1600x1200 60 13:58:09 INFO - Main Display: Yes 13:58:09 INFO - Mirror: Off 13:58:09 INFO - Online: Yes 13:58:09 INFO - Rotation: Supported 13:58:09 INFO - Return code: 0 13:58:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:58:09 INFO - Python 2.7.3 13:58:09 INFO - Return code: 0 13:58:09 INFO - grabbing minidump binary from tooltool 13:58:09 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')]} 13:58:09 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 0x1030ced30>, '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 0x102ff5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1030c3be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:58:09 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 13:58:09 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 13:58:09 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 13:58:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:58:10 INFO - Return code: 0 13:58:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:58:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:58:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:58:10 INFO - ENV: RUST_BACKTRACE is now 1 13:58:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:58:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:58:10 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/c5HQkDTIQ8OQ5eOS1dsjsA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--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 13:58:10 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/c5HQkDTIQ8OQ5eOS1dsjsA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0032 --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 13:58:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OYW7qBWfoz/Render', 13:58:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:58:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:58:10 INFO - 'HOME': '/Users/cltbld', 13:58:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:58:10 INFO - 'LOGNAME': 'cltbld', 13:58:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:58:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:58:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:10 INFO - 'MOZ_NO_REMOTE': '1', 13:58:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:58:10 INFO - 'NO_EM_RESTART': '1', 13:58:10 INFO - 'PAGER': '/bin/cat', 13:58:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:58:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:10 INFO - 'PWD': '/builds/slave/test', 13:58:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:58:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:58:10 INFO - 'RUST_BACKTRACE': '1', 13:58:10 INFO - 'SHELL': '/bin/bash', 13:58:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZNYeZLSpga/Listeners', 13:58:10 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 13:58:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:58:10 INFO - 'USER': 'cltbld', 13:58:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:58:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:58:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:10 INFO - 'XPC_FLAGS': '0x0', 13:58:10 INFO - 'XPC_SERVICE_NAME': '0', 13:58:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:58:10 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/c5HQkDTIQ8OQ5eOS1dsjsA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--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 13:58:10 INFO - mozversion application_buildid: 20170424123625 13:58:10 INFO - mozversion application_changeset: a236801aa0225218df1f74cc365bd68b6305a5db 13:58:10 INFO - mozversion application_display_name: Firefox 13:58:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:58:10 INFO - mozversion application_name: Firefox 13:58:10 INFO - mozversion application_remotingname: firefox 13:58:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:58:10 INFO - mozversion application_vendor: Mozilla 13:58:10 INFO - mozversion application_version: 54.0 13:58:10 INFO - mozversion platform_buildid: 20170424123625 13:58:10 INFO - mozversion platform_changeset: a236801aa0225218df1f74cc365bd68b6305a5db 13:58:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:58:10 INFO - mozversion platform_version: 54.0 13:58:10 INFO - using testdate: 1493067490 13:58:10 INFO - actual date: 1493067490 13:58:10 INFO - starting webserver on 'localhost:49247' 13:58:10 INFO - SUITE-START | Running 2 tests 13:58:10 INFO - TEST-START | dromaeo_css 13:58:10 INFO - operating with platform_type : mac_ 13:58:10 INFO - Initialising browser for dromaeo_css test... 13:58:10 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmp7zqasI/profile http://localhost:49247/getInfo.html) 13:58:12 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 13:58:12 INFO - PROCESS | 1640 | colorDepth:24 13:58:12 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 13:58:12 INFO - PROCESS | 1640 | __metrics 13:58:12 INFO - PROCESS | 1640 | 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" 13:58:12 INFO - PROCESS | 1640 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:58:13 INFO - TEST-INFO | 1640: exit 0 13:58:13 INFO - Browser initialized. 13:58:13 INFO - Running cycle 1/1 for dromaeo_css test... 13:58:13 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmp7zqasI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:58:25 INFO - PROCESS | 1643 | RSS: Main: 165179392 13:58:25 INFO - PROCESS | 1643 | 14:01:28 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49247/tests/dromaeo/cssquery-ext.html) 14:01:31 INFO - PROCESS | 1643 | RSS: Main: 382316544 14:01:31 INFO - PROCESS | 1643 | 14:04:34 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-ext.html (next: http://localhost:49247/tests/dromaeo/cssquery-jquery.html) 14:04:34 INFO - PROCESS | 1643 | RSS: Main: 301670400 14:04:34 INFO - PROCESS | 1643 | 14:07:37 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49247/tests/dromaeo/cssquery-mootools.html) 14:07:38 INFO - PROCESS | 1643 | RSS: Main: 285192192 14:07:38 INFO - PROCESS | 1643 | 14:10:40 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49247/tests/dromaeo/cssquery-prototype.html) 14:10:41 INFO - PROCESS | 1643 | RSS: Main: 274567168 14:10:41 INFO - PROCESS | 1643 | 14:13:44 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49247/tests/dromaeo/cssquery-yui.html) 14:13:45 INFO - PROCESS | 1643 | RSS: Main: 270602240 14:13:45 INFO - PROCESS | 1643 | 14:16:48 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-yui.html (next: http://localhost:49247/tests/dromaeo/cssquery-dojo.html) 14:16:49 INFO - PROCESS | 1643 | RSS: Main: 444862464 14:16:49 INFO - PROCESS | 1643 | 14:16:49 INFO - PROCESS | 1643 | __start_tp_report 14:16:49 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 14:16:49 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 14:16:49 INFO - PROCESS | 1643 | |i|pagename|runs| 14:16:49 INFO - PROCESS | 1643 | |0;dojo.html;3382.8985130446085;3469.51426800248;3476.1657202271454;3502.6497350264963;3528.5765708115014;4744.762761861902;5776.480116789488;5781.566382521307;5886.764529418829;5904.88190236195;5849.2980842298875;5921.319048309446;5925.792597259086;5930.377310382401;5939.168516407695;5360.115580929142;5395.352557693072;5396.460353964611;5428.83713488596;5449.863753406157;5278.3138192034985;5283.233931079991;5295.947040529603;5460.290162278918;5470.91793623096;5356.491133342326;5365.195220716904;5378.46215378463;5379.919301210485;5386.434424385442;5361.303030606015;5372.301600791872;5374.27447294618;5384.811531596414;5387.380451248097;5227.660202086852;5330.173823057432;5333.066713325153;5334.759935802898;5360.651557648779;5884.558658100659;5890.145928840294;5890.734916928748;5891.882162356772;5894.705264736746;6252.06219067139;6255.030470277115;6259.687015649245;6323.778667746653;6360.93639063608;6362.395572420613;6369.681515924185;6375.776847810304;6390.233172019387;6393.7442502299855;5929.1995580596495;5933.258342707161;5965.284165900076;5966.2840459144745;5972.940270597282;6314.810555683337;6350.396712312323;6354.269259035178;6435.324290949383;6438.774642887476;6180.196574445294;6217.129601855744;6227.750889964442;6240.843978900564;6244.406781355764;6394.648294343856;6416.903746443807;6429.935700642934;6430.742770289229;6435.163428754326;4605.792739326738;6000.849978750566;6375.617462952145;6382.042693595998;6384.904226436607;6121.87979361315;6290.21372328459;6308.589941653778;6319;6330.177076979963;5049.974750126225;5052.823151189691;5072.137736584716;5089;5097.337346145052;4431.246688063037;4471.8434854779925;4480.574345437179;4494.438195225597;4519.480259770168;5746.109353050284;5835.44563266489;6020.096985452217;6069.726862291208;6090.969545152246;5287.497687719738;6330.05049242608;6345;6351.04734289851;6359.713812878432;6032.668203248863;6034.969825150846;6039.7282122304605;6044.15381846533;6052.394760524;5515.227868098469;5537.280153580009;5556.305461817273;5560.77756889728;5573.916391254134;6286.9056964145575;6325.240971083499;6405.295417503978;6432.774852880127;6475.061116138134;6345.524085693683;6372.617642941438;6378.808635740936;6392.4246817786625;6409.9038514423255;6378.536225600727;6504.544681872224;6516.706748196248;6521.315261897433;6538.411542961157;6122.825106970275;6202.2867370253;6237.563370564017;6424.9036264455135;6427.357264273535;4952.356193694941;6022.548308876764;6317.115603815378;6318.715657795502;6340.714667839866;6180.289266734383;6195.256569211723;6290.402411770874;6294.937050629618;6313.084602732486;6231.813045608639;6250.718717657807;6283.71723272463;6285.057241413824;6290.21372328459;6138.0179171332375;6151.200343955257;6153.292371377349;6156.445919867234;6165.784197553064;5935.465808077293;5956.374580668968;6025.517958563392;6061.36355682647;6119.663418511846;5863.677497737665;5882.264716910387;5923.170756094237;5935;6036.3058248302 14:16:49 INFO - PROCESS | 1643 | |1;ext.html;806.8951036365273;830.2071521696778;895.5835536475541;913.8857642794651;914.5655813488589;36161.276774464495;40571;42708;42809.92975175622;42819;41767.37348939761;42004;42020;42067.789661051655;42113.57886421135;7899;8025.879611805827;9488.810223795503;9639;9642.469664168468;9838.45888476137;11556.47995840185;11932;11943.9847612953;11945.402729863516;11741.354225517593;11750.706232344175;11760.882716141952;11818.231814932045;11830.7633847323;11713.945744882916;11718.765624687501;11728.003119734833;11746.94126529366;11778.469968851423;11419.942900285529;11470.541178352856;11476.827847582294;11481.368524731137;11503.597374091867;39521.40717889234;39547.81356559308;39680.60319396798;39701.80149099265;39718.80140599307;3913.5303763548272;4038.757674539537;4043.2722110020186;4060.512738471373;4072.3891416287497;23991.960683341764;28520.572191417144;28521.57217641737;30499.542506862414;30634.84682576573;3251.561039259717;3265.232670322472;3265.951010734841;3294.8352582370785;3404.3872103021445;338054;341792;342348;342753;342895;42689;43460;45432;50778.73053173626;50943.745281274096;45342.54657453383;45365.319520207224;45430.545694542634;52910;53814;15314;15471.303791329417;15517.5344739658;15546.76679849803;15556.299966501309;13163.341832908316;13266.872315853068;13272.867271327355;13274.402651880688;13277.136986095873;12121.878781212252;12128.332941688292;12132;12238.632841014783;12273.69315767113;5563.415841336682;5568.888622227614;5569.693666848281;5590.692511911884;5594.468525490153;932.5756780664781;951.9952400237954;964.1419136968104;978.8678528398575;1009.7327853543756;28105.578416323773;28321.858390707916;28357.858210708815;28846.567301490493;28887.56668649972;672.7040102354948;1088.0425225801243;1150.3500522204927;1169.4094482286391;1197.9101567382481;14741.525847415387;14976.775348369783;14993.550193494213;15304.387824486896;15310.464133755266;487109;487851;487966;489987;491269;57951;58050;58071;58133;58245.835083298094;1360.211077575004;1415.4126037694448;1418.2058047493642;1425;1430.9856901430853;24089.156879509836;27028.91884324605;28213.858930705213;28712.712872871838;28891.5666265002;46317.220966742105;46346.609601712;46384.7680761594;46455.303170453146;46510.53489465062;364896;366630;451209;451595;454120;31682.841585791924;31809.363812724077;31950.840245798623;31976.68023319737;32042;43771.12457750891;44295;44307.77846110749;44609.55390446184;45261.77369113133;27494.0377086801;29952.850235748683;30537.694623054373;31073.912413065435;31249.8437507811;25085.498290034462;30301.848490757406;30329.393412131194;30438.391232175676;31382;28544.714552854206;28852.711472885003;29043.419131617673;37274;37378.06554836151;26919.327016823954;31077.223069423446;31234.531482028244;32228;32349.51475727819;23817;24603.876980614983;25201.73991300391;25334.87332563399;25400.85696143641 14:16:49 INFO - PROCESS | 1643 | |2;jquery.html;383.61706049690883;431.5464407316493;434.4829652713272;437.1890143783281;442.36299728391117;15049.924750376247;21523.24668636598;22276.777232227672;22353;22597.77402225977;17519.73720394195;21511.81685007328;22361.776382236174;22880.771192288074;23117.537649247046;6694.933050669491;6888.345607167311;6911.447084233275;7428.702851885918;7808;4348.5216626171095;7749.457537972344;7777.02787151606;7802.063752349726;7803.76588702337;4367.842521731744;7466.104067511879;7760.456768026241;7918.485298455611;7921;7584.886226706604;7634.389248860133;7728.111267204287;7799.688012479494;7867.291943725064;6739.2249891262645;7015.508914375945;7294.708211671526;7589;7594.734184303523;26854.46291074187;26894.19317420461;26936.730632693812;27297.317567060785;27458.038968636203;3054.4501989641853;3061.9081427557207;3168.6197656281392;3221.4362486564755;3257.2345498807763;15800.92099539495;17059.402920897708;17096.34456090669;17182.39861604838;17377.826221737872;1961.695937129747;1985.1364656374524;1996.5807180492113;2008.1918320276825;2039.6838490034067;136379;146786;152216;155537;167097.16451417786;15338.463153789564;16952.915235423745;17782.844115132735;20056.69914951277;20268.29060982888;30431.847840760656;30789;30803.383932321227;31441;31845;8039.839203215903;8153.510789352657;9636.566354514063;9757.365771224848;10976.835347469794;7138.785836424916;8893.73318800424;8896.8665470018;8996.190342869173;9004.144606262395;9484.573194206278;9567.90432095684;9617.759556011155;9661.32370734056;9684.70945871625;4089.4683691119963;4171.624553790173;4171.885250790226;4200.122915802685;4211.4525111735275;1057.1384321777728;1068.428390810928;1068.8289873620338;1069.919756018286;1130.5477808876515;19435.611287774165;22937.311880643607;22968.196113136295;22995.425114372276;23052.65421018686;910.3900386740767;1105.9336439813637;1110.294962698676;1120.4117838134882;1135.6706555098929;11045.502952367162;11696.473658685209;11841.644750657493;11868.703282418008;11906.404679765978;650675;670536;687209;747422;781079;156597.2170139142;158362;161795.5730664041;163137;166994;1174.8825117488354;1251.6870782304425;1290.6128161551685;1350.257358452847;1360.5578187089236;20238.39284821458;20405.59188816245;20912.790872091085;20962;20971.37085887426;66323.66838165779;66535;67375;68690;69124.30875691179;96172.51913740387;96693.5165324197;96783.03216968021;97472;98638.5068074655;11559.884401155881;11699.23954942926;11911.3448760319;12118.636440906786;12212.08409369283;11159.888401115884;12648.620541383772;13205.273709946045;13240.53658121961;13468.730625387241;11660.18378713482;11667.241629294069;11735.178537502294;11767;12039.75920481568;9685.176759975198;9735.9026409735;10531;10907.836382454429;10932.14153593875;11556.537738490366;11853.11101667361;11958.58144964922;11995.940020300191;12113.878861211628;11677.76644467123;11708.47311870985;12045.939770301444;12111.45498452554;12119.636410907688;11539.19225654196;11781.469833857669;11845;12013.879861201276;12018.519259229883 14:16:49 INFO - PROCESS | 1643 | |3;mootools.html;1290.9160904541197;1612.2583611538691;1630.69832081065;1653.0247154179033;1667.3497336038947;9459.290553208511;11026.228164028511;11315.264507806987;11547.96068353848;11552.01807846332;11197.832032519518;11261.943690281538;11285.717857053578;11305.886941130586;11319.603813866517;2084.8749075055543;2451.4729333193313;2494.1769216158714;2494.3514686181634;2500.4499010217814;2032.928847490338;2419.358869899478;2494.0896572750908;2499.912503062384;2511.5855883779154;2433.6471211674384;2466.432720474292;2471.270975062361;2472.3695457658273;2473.134402958959;2397.0172229386044;2426.963595546068;2430.21018169094;2432.0636554926305;2433.7201221859536;2420.7337192908767;2422.733499315074;2425.333033415807;2425.6967879015124;2429.1133736186343;11105.500252488577;11190.272632278877;11225.719357016058;11235;11267.718307042389;5998.670073145975;6190.84522886927;6195.19462469876;6198.659073750942;6201.534884883652;3520.718342532591;3605.3149901518627;3798.2213646202463;3801.486799282089;3816.1985982943615;1201.3212534917743;1248.5692436109528;1274.898008159345;1284.1460428814828;1290.5096063495812;16078.276477558538;16131.596710082224;16153;16165.595860103474;16182;4789.185838407479;5164.3802743671;5216.478352164829;5224.216367544898;5256.737163141904;13493.865061349261;13516.256605886574;13549.051566390455;13553.322333883463;13560.525381611793;6252.624842509464;6255.874882502416;6259.467945224706;6262.937370626236;6282.528810339243;4693.95306046942;4847;5530.668159910419;5599.412061733541;5626.634268772598;3767.7927713975446;4174.540800511942;4175.97912010438;4291.806868690916;4334.306510958231;1176.847009888726;1179.8348231247633;1182.5683625476638;1193.6359410379744;1194.5759255464359;981.6453294453609;995.1044060345747;1005.1807776661997;1008;1020.9387436753818;6649.135612370361;6768.661566921733;6867.769294746355;6871.6564171791215;6993.160820701549;950.8716323296267;1014.8380104780133;1048.6853943816825;1087.7552550676035;1124.4658787076237;3725.4784330193793;4091.8363265469047;4236.894077648022;4361.302191649321;4501.68488205829;13317.267550284634;13959.511417100555;13960.86039139616;13985.650358741113;13999.230042347768;12992.285424301754;13516.324183790772;13830.031897767261;13853.792193117111;13883.444662213398;8062.717804876801;9974.650887218913;9983.850242246226;9987.101160895554;9997.100260976547;6553.627368107082;6805.659717014229;6911.723531058902;7054.470914681522;7072.469564782559;12362.629121126382;12785.16896401731;12797.616071517868;12825.871741282841;12841.486340546273;12610.873891261337;12847.03647226443;12870.485180593047;12959.157654752411;13015.958723301923;8255.174482551936;9289.581968811284;9435.433873967584;9537.952310238405;9576.090271424204;9431.528423578931;10157.984201579782;10431.478426078818;10605.045545900906;10605.151587872797;8615.91384086151;8771.868421973548;8844.867326989972;8873.334499912662;8882.511461869659;8635.87046194295;8710.782230444289;8727.781805454915;8795;8796.692115775917;8188.058373287148;8365.749027529184;8371.623276952674;8375.706850260212;8379.874301885598;6078.787242446493;6082.148499210202;6143;6276.027215781562;6328.683565821599;6010.459058684739;6038.8792224154395;6198.543342314642;6227.346128656607;6258.593191442724 14:16:49 INFO - PROCESS | 1643 | |4;prototype.html;382.9751066180696;384.25071111332903;387.37439035956936;391.0477986103837;393.8444314495774;4740.345406572317;4795.978533523879;4926.595920162755;4988.958943255965;5038.060346766494;4162.625363717265;4773.809047638099;4878.365812444386;4934.457209706939;4988.675736077153;3707.9073023174365;3918.8243526941947;3942.9748265450976;4209.705320627558;4250.744955302676;3651.922682808565;4161.83352665893;4236.216299984498;4333.374984380857;4345.608895199432;4305.956940430603;4323.848665296715;4327.4374331336885;4345.9348109778375;4381.3208952612395;3576.570811502623;3628.4194528875387;3977.4033894915706;4232.661387089025;4344.869653910388;3467.254540273828;4097.569755175723;4146.875593732193;4147;4181.247375472413;3859.614038596146;4315.762633055212;4434.889127771799;4483.4843992940905;4879.634027447955;4319.423410455192;4373.387725718402;4383.495897971742;4595.839145629887;5029.698218106925;4431.593455983695;4579.977100114478;4780.991983366995;5169.534741873212;5273.947260527422;4128.566500517462;4211.515675697304;4506.774661266923;4632.822573390501;4656.4877863434995;4648.488666246744;4909.582685471739;4942.35749352589;5283.577313814885;5593;3869.690424766012;3942.3495123304333;4139.234241665302;4529.6376289896725;4716.481187069419;4405.625521830616;4458.8439404620685;4783.425988881357;4842.297866809364;4849.175640141185;4374.834456943833;4631.652626053059;4763.785234765182;4947.229551451199;4979.551840334388;4499.055198408371;4923.803047878045;4932.950670493321;4946.777395017233;5130.8973820524125;1409.654634614526;1480.8079496005603;1482.2292407947807;1494.454524098696;1630.1986305132893;1089.8121048057496;1161.895429411357;1170.73658426855;1246.376811594203;1371.8285214348207;4004.9199016019516;4130.752154870717;4699.365585645963;4930.5069493050405;4933.6793108448555;4506.752128632957;4953.405591329064;5262;5266.0257852297445;5470.152126420411;3580.6598373154507;4934.9013019739405;4953.925691114636;4962.975185124052;5016.523430274118;2356.587597170488;2521.962170567443;2597.5584150694426;2702.6756789185424;2856.5429531274895;4645.814167433265;4810;4835.516448355136;5058.4435712071645;5641.746121424546;4824.744495793543;4998.2759396129195;5541.428321634587;5550.195221692832;5610.943890561124;5330.280412144389;5439.80324328647;5441.0074459048155;5572.832815015556;5615.18579805934;4560.566746159109;4912.140375434214;5337.678110022152;5375.596830237826;5460.2355670207;4489.595936365743;4909.361782968334;4945.876353091202;4954.8761280968265;5157.793688252428;4427.114577084531;5250.663454762594;5552.861178470571;5585.888282234414;5644;3766.303233901737;4317.55361953749;4344.587264209895;4362.847300344472;4377.0808130293;4572.359869618323;4760.381150450419;5435.2934118564335;5497.917531236954;5508.394076651645;4972.922203792855;5109.565686916654;5237.869053273546;5294.338207724035;5303.798923446727;4639.582437580634;4682.508336624742;4936.370997570722;5179.378474583074;5247.947520524898;4743.691660042086;4788.808447662054;5116.948830511797;5134;5148.794048238028;4631.374764406762;5193.480651934777;5218.8956220876125;5239.659422137549;5248.643625790661;4428.844990425319;4709.317149013443;4727.4708031203145;5089.720065396439;5152 14:16:49 INFO - PROCESS | 1643 | |5;yui.html;749.8751872191713;774.7985523763823;794.051108924835;852.1010334097526;856.8757530158127;15194.924025379885;15777.422257774217;16019.679606407879;16913.23890424931;16922.746158807597;15600.297986590602;15641.139737314443;15777.974431661934;15820.920895395535;15835.287412066456;988.471167925162;989.3717489394214;1015.9339642923223;1060.2260349944545;1065.0787069185137;1038.8545603615462;1052.0741747262398;1053.752368193474;1055.8310670292756;1055.9841602375932;1083.8374243863443;1084.8426978088173;1086.277625379122;1086.8858769829174;1089.3028461784463;1078.8813230544633;1079.13129930406;1079.9784004319947;1081.7890511350329;1082.2045796339685;797.3581267079999;800.8998875140608;801.7634797734624;802.3460879383342;802.470369556096;16550.172491375382;16930.238139283763;16954;16978.915105424516;17430.215640296217;14587.781183282259;14779.926100369537;14861.331240094221;14892.106473611619;15328.23358832065;11737.882621173765;11962.521499140024;12509.687257818536;12715.93642031784;12748.681282967907;3777.3389656810223;3829.3107240696663;3930.8427662893737;3934.1148241645687;4065.1869626074904;116242;121020.39489802583;124990;125335.74664253333;127880.3605981964;10691.305065170895;11422.543098275975;11667.88332116685;11682.474288657031;11983.460744266355;23883.40291492692;24282.27153185372;24460.755392446204;24495.897684604235;24562.631560526606;8058.1538938411795;8071.717489887826;8121.390895682847;8212.260896519341;8237.917620823715;4374.321980093091;4400.625946794495;4403.493598236179;4498.5501449854755;4626.21354369758;3644.362236608583;3708.5364329458816;3723.1809002019513;3756.6055564165367;3756.887293381203;669.3841665667597;669.5647828911247;674.750342373325;688.3323176518769;688.5971706551724;693.299767235086;693.7675878580732;706.6713978000255;745.3701622129292;761.7866997240782;10827.563798145511;10929.781404372026;10982.450877456095;11010.669679909615;11051.336919784679;659.6932426421737;736.2351208858441;739.7558805594249;742.5210739073267;766.5247546521192;5076;5162.432132465426;5237.476252374809;5268.6575372600655;5276.234945932818;92311;95057.04942950621;108177;112970.30544541839;114236.42881785538;57869.8426031477;59968;73208;78692.81960770593;91089.54455227814;79461.60269198618;83613;87797.56101219454;87961.5601921999;91162;9701;11349.602763903224;11409.201355905006;11508.251963622337;11539.88460115388;53517;54113.458865410845;54736.452635473135;55353.723231383585;55524.72237638786;60538;65153.67423162854;65624.34375656182;66682.66634667183;67385;14265.072770269899;14545.85454145445;14750.704985900436;14848.7772683412;14874.033187842755;14964.326605302569;15874.2062896857;15963.760543592087;16036.278367473258;16048.358065677709;14319.498817541336;14658.706825863635;14783.852161478248;14817.555473335817;15375.538733838002;13512.324383780575;13930.512432064828;14609.123452592878;14748.115113093249;15259.855510836509;13789.586312410644;14208.218547979961;14405.42378304856;14535.055221410998;14558.708825823636;9306.395084319498;10188;10469.31949423285;10730.517126729472;10897.891021089688;10612;10796.460176991277;11589.072874170215;11823.70440738954;11834.349110798988 14:16:49 INFO - PROCESS | 1643 | __end_tp_report 14:16:49 INFO - PROCESS | 1643 | __start_cc_report 14:16:49 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,2480 14:16:49 INFO - PROCESS | 1643 | __end_cc_report 14:16:49 INFO - PROCESS | 1643 | __startTimestamp1493068609056__endTimestamp 14:16:49 INFO - PROCESS | 1643 | 14:16:49 INFO - PROCESS | 1643 | ------- Summary: start ------- 14:16:49 INFO - PROCESS | 1643 | Number of tests: 6 14:16:49 INFO - PROCESS | 1643 | 14:16:49 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:5847.74 Median:6036.31 stddev:650.34 (10.8%) stddev-sans-first:622.92 14:16:49 INFO - PROCESS | 1643 | Values: 3382.9 3469.5 3476.2 3502.6 3528.6 4744.8 5776.5 5781.6 5886.8 5904.9 5849.3 5921.3 5925.8 5930.4 5939.2 5360.1 5395.4 5396.5 5428.8 5449.9 5278.3 5283.2 5295.9 5460.3 5470.9 5356.5 5365.2 5378.5 5379.9 5386.4 5361.3 5372.3 5374.3 5384.8 5387.4 5227.7 5330.2 5333.1 5334.8 5360.7 5884.6 5890.1 5890.7 5891.9 5894.7 6252.1 6255.0 6259.7 6323.8 6360.9 6362.4 6369.7 6375.8 6390.2 6393.7 5929.2 5933.3 5965.3 5966.3 5972.9 6314.8 6350.4 6354.3 6435.3 6438.8 6180.2 6217.1 6227.8 6240.8 6244.4 6394.6 6416.9 6429.9 6430.7 6435.2 4605.8 6000.8 6375.6 6382.0 6384.9 6121.9 6290.2 6308.6 6319.0 6330.2 5050.0 5052.8 5072.1 5089.0 5097.3 4431.2 4471.8 4480.6 4494.4 4519.5 5746.1 5835.4 6020.1 6069.7 6091.0 5287.5 6330.1 6345.0 6351.0 6359.7 6032.7 6035.0 6039.7 6044.2 6052.4 5515.2 5537.3 5556.3 5560.8 5573.9 6286.9 6325.2 6405.3 6432.8 6475.1 6345.5 6372.6 6378.8 6392.4 6409.9 6378.5 6504.5 6516.7 6521.3 6538.4 6122.8 6202.3 6237.6 6424.9 6427.4 4952.4 6022.5 6317.1 6318.7 6340.7 6180.3 6195.3 6290.4 6294.9 6313.1 6231.8 6250.7 6283.7 6285.1 6290.2 6138.0 6151.2 6153.3 6156.4 6165.8 5935.5 5956.4 6025.5 6061.4 6119.7 5863.7 5882.3 5923.2 5935.0 6036.3 14:16:49 INFO - PROCESS | 1643 | 14:16:49 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:55752.84 Median:32288.76 stddev:111661.66 (345.8%) stddev-sans-first:111898.69 14:16:49 INFO - PROCESS | 1643 | Values: 806.9 830.2 895.6 913.9 914.6 36161.3 40571.0 42708.0 42809.9 42819.0 41767.4 42004.0 42020.0 42067.8 42113.6 7899.0 8025.9 9488.8 9639.0 9642.5 9838.5 11556.5 11932.0 11944.0 11945.4 11741.4 11750.7 11760.9 11818.2 11830.8 11713.9 11718.8 11728.0 11746.9 11778.5 11419.9 11470.5 11476.8 11481.4 11503.6 39521.4 39547.8 39680.6 39701.8 39718.8 3913.5 4038.8 4043.3 4060.5 4072.4 23992.0 28520.6 28521.6 30499.5 30634.8 3251.6 3265.2 3266.0 3294.8 3404.4 338054.0 341792.0 342348.0 342753.0 342895.0 42689.0 43460.0 45432.0 50778.7 50943.7 45342.5 45365.3 45430.5 52910.0 53814.0 15314.0 15471.3 15517.5 15546.8 15556.3 13163.3 13266.9 13272.9 13274.4 13277.1 12121.9 12128.3 12132.0 12238.6 12273.7 5563.4 5568.9 5569.7 5590.7 5594.5 932.6 952.0 964.1 978.9 1009.7 28105.6 28321.9 28357.9 28846.6 28887.6 672.7 1088.0 1150.4 1169.4 1197.9 14741.5 14976.8 14993.6 15304.4 15310.5 487109.0 487851.0 487966.0 489987.0 491269.0 57951.0 58050.0 58071.0 58133.0 58245.8 1360.2 1415.4 1418.2 1425.0 1431.0 24089.2 27028.9 28213.9 28712.7 28891.6 46317.2 46346.6 46384.8 46455.3 46510.5 364896.0 366630.0 451209.0 451595.0 454120.0 31682.8 31809.4 31950.8 31976.7 32042.0 43771.1 44295.0 44307.8 44609.6 45261.8 27494.0 29952.9 30537.7 31073.9 31249.8 25085.5 30301.8 30329.4 30438.4 31382.0 28544.7 28852.7 29043.4 37274.0 37378.1 26919.3 31077.2 31234.5 32228.0 32349.5 23817.0 24603.9 25201.7 25334.9 25400.9 14:16:49 INFO - PROCESS | 1643 | 14:16:49 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:42627.17 Median:22479.78 stddev:118927.95 (529.0%) stddev-sans-first:119219.28 14:16:49 INFO - PROCESS | 1643 | Values: 383.6 431.5 434.5 437.2 442.4 15049.9 21523.2 22276.8 22353.0 22597.8 17519.7 21511.8 22361.8 22880.8 23117.5 6694.9 6888.3 6911.4 7428.7 7808.0 4348.5 7749.5 7777.0 7802.1 7803.8 4367.8 7466.1 7760.5 7918.5 7921.0 7584.9 7634.4 7728.1 7799.7 7867.3 6739.2 7015.5 7294.7 7589.0 7594.7 26854.5 26894.2 26936.7 27297.3 27458.0 3054.5 3061.9 3168.6 3221.4 3257.2 15800.9 17059.4 17096.3 17182.4 17377.8 1961.7 1985.1 1996.6 2008.2 2039.7 136379.0 146786.0 152216.0 155537.0 167097.2 15338.5 16952.9 17782.8 20056.7 20268.3 30431.8 30789.0 30803.4 31441.0 31845.0 8039.8 8153.5 9636.6 9757.4 10976.8 7138.8 8893.7 8896.9 8996.2 9004.1 9484.6 9567.9 9617.8 9661.3 9684.7 4089.5 4171.6 4171.9 4200.1 4211.5 1057.1 1068.4 1068.8 1069.9 1130.5 19435.6 22937.3 22968.2 22995.4 23052.7 910.4 1105.9 1110.3 1120.4 1135.7 11045.5 11696.5 11841.6 11868.7 11906.4 650675.0 670536.0 687209.0 747422.0 781079.0 156597.2 158362.0 161795.6 163137.0 166994.0 1174.9 1251.7 1290.6 1350.3 1360.6 20238.4 20405.6 20912.8 20962.0 20971.4 66323.7 66535.0 67375.0 68690.0 69124.3 96172.5 96693.5 96783.0 97472.0 98638.5 11559.9 11699.2 11911.3 12118.6 12212.1 11159.9 12648.6 13205.3 13240.5 13468.7 11660.2 11667.2 11735.2 11767.0 12039.8 9685.2 9735.9 10531.0 10907.8 10932.1 11556.5 11853.1 11958.6 11995.9 12113.9 11677.8 11708.5 12045.9 12111.5 12119.6 11539.2 11781.5 11845.0 12013.9 12018.5 14:16:49 INFO - PROCESS | 1643 | 14:16:49 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:6949.25 Median:2494.26 stddev:4348.31 (174.3%) stddev-sans-first:4339.72 14:16:49 INFO - PROCESS | 1643 | Values: 1290.9 1612.3 1630.7 1653.0 1667.3 9459.3 11026.2 11315.3 11548.0 11552.0 11197.8 11261.9 11285.7 11305.9 11319.6 2084.9 2451.5 2494.2 2494.4 2500.4 2032.9 2419.4 2494.1 2499.9 2511.6 2433.6 2466.4 2471.3 2472.4 2473.1 2397.0 2427.0 2430.2 2432.1 2433.7 2420.7 2422.7 2425.3 2425.7 2429.1 11105.5 11190.3 11225.7 11235.0 11267.7 5998.7 6190.8 6195.2 6198.7 6201.5 3520.7 3605.3 3798.2 3801.5 3816.2 1201.3 1248.6 1274.9 1284.1 1290.5 16078.3 16131.6 16153.0 16165.6 16182.0 4789.2 5164.4 5216.5 5224.2 5256.7 13493.9 13516.3 13549.1 13553.3 13560.5 6252.6 6255.9 6259.5 6262.9 6282.5 4694.0 4847.0 5530.7 5599.4 5626.6 3767.8 4174.5 4176.0 4291.8 4334.3 1176.8 1179.8 1182.6 1193.6 1194.6 981.6 995.1 1005.2 1008.0 1020.9 6649.1 6768.7 6867.8 6871.7 6993.2 950.9 1014.8 1048.7 1087.8 1124.5 3725.5 4091.8 4236.9 4361.3 4501.7 13317.3 13959.5 13960.9 13985.7 13999.2 12992.3 13516.3 13830.0 13853.8 13883.4 8062.7 9974.7 9983.9 9987.1 9997.1 6553.6 6805.7 6911.7 7054.5 7072.5 12362.6 12785.2 12797.6 12825.9 12841.5 12610.9 12847.0 12870.5 12959.2 13016.0 8255.2 9289.6 9435.4 9538.0 9576.1 9431.5 10158.0 10431.5 10605.0 10605.2 8615.9 8771.9 8844.9 8873.3 8882.5 8635.9 8710.8 8727.8 8795.0 8796.7 8188.1 8365.7 8371.6 8375.7 8379.9 6078.8 6082.1 6143.0 6276.0 6328.7 6010.5 6038.9 6198.5 6227.3 6258.6 14:16:49 INFO - PROCESS | 1643 | 14:16:49 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4373.79 Median:4712.90 stddev:1178.49 (25.0%) stddev-sans-first:1143.09 14:16:49 INFO - PROCESS | 1643 | Values: 383.0 384.3 387.4 391.0 393.8 4740.3 4796.0 4926.6 4989.0 5038.1 4162.6 4773.8 4878.4 4934.5 4988.7 3707.9 3918.8 3943.0 4209.7 4250.7 3651.9 4161.8 4236.2 4333.4 4345.6 4306.0 4323.8 4327.4 4345.9 4381.3 3576.6 3628.4 3977.4 4232.7 4344.9 3467.3 4097.6 4146.9 4147.0 4181.2 3859.6 4315.8 4434.9 4483.5 4879.6 4319.4 4373.4 4383.5 4595.8 5029.7 4431.6 4580.0 4781.0 5169.5 5273.9 4128.6 4211.5 4506.8 4632.8 4656.5 4648.5 4909.6 4942.4 5283.6 5593.0 3869.7 3942.3 4139.2 4529.6 4716.5 4405.6 4458.8 4783.4 4842.3 4849.2 4374.8 4631.7 4763.8 4947.2 4979.6 4499.1 4923.8 4933.0 4946.8 5130.9 1409.7 1480.8 1482.2 1494.5 1630.2 1089.8 1161.9 1170.7 1246.4 1371.8 4004.9 4130.8 4699.4 4930.5 4933.7 4506.8 4953.4 5262.0 5266.0 5470.2 3580.7 4934.9 4953.9 4963.0 5016.5 2356.6 2522.0 2597.6 2702.7 2856.5 4645.8 4810.0 4835.5 5058.4 5641.7 4824.7 4998.3 5541.4 5550.2 5610.9 5330.3 5439.8 5441.0 5572.8 5615.2 4560.6 4912.1 5337.7 5375.6 5460.2 4489.6 4909.4 4945.9 4954.9 5157.8 4427.1 5250.7 5552.9 5585.9 5644.0 3766.3 4317.6 4344.6 4362.8 4377.1 4572.4 4760.4 5435.3 5497.9 5508.4 4972.9 5109.6 5237.9 5294.3 5303.8 4639.6 4682.5 4936.4 5179.4 5247.9 4743.7 4788.8 5116.9 5134.0 5148.8 4631.4 5193.5 5218.9 5239.7 5248.6 4428.8 4709.3 4727.5 5089.7 5152.0 14:16:49 INFO - PROCESS | 1643 | 14:16:49 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:21347.49 Median:16042.32 stddev:30542.91 (190.4%) stddev-sans-first:30589.44 14:16:49 INFO - PROCESS | 1643 | Values: 749.9 774.8 794.1 852.1 856.9 15194.9 15777.4 16019.7 16913.2 16922.7 15600.3 15641.1 15778.0 15820.9 15835.3 988.5 989.4 1015.9 1060.2 1065.1 1038.9 1052.1 1053.8 1055.8 1056.0 1083.8 1084.8 1086.3 1086.9 1089.3 1078.9 1079.1 1080.0 1081.8 1082.2 797.4 800.9 801.8 802.3 802.5 16550.2 16930.2 16954.0 16978.9 17430.2 14587.8 14779.9 14861.3 14892.1 15328.2 11737.9 11962.5 12509.7 12715.9 12748.7 3777.3 3829.3 3930.8 3934.1 4065.2 116242.0 121020.4 124990.0 125335.7 127880.4 10691.3 11422.5 11667.9 11682.5 11983.5 23883.4 24282.3 24460.8 24495.9 24562.6 8058.2 8071.7 8121.4 8212.3 8237.9 4374.3 4400.6 4403.5 4498.6 4626.2 3644.4 3708.5 3723.2 3756.6 3756.9 669.4 669.6 674.8 688.3 688.6 693.3 693.8 706.7 745.4 761.8 10827.6 10929.8 10982.5 11010.7 11051.3 659.7 736.2 739.8 742.5 766.5 5076.0 5162.4 5237.5 5268.7 5276.2 92311.0 95057.0 108177.0 112970.3 114236.4 57869.8 59968.0 73208.0 78692.8 91089.5 79461.6 83613.0 87797.6 87961.6 91162.0 9701.0 11349.6 11409.2 11508.3 11539.9 53517.0 54113.5 54736.5 55353.7 55524.7 60538.0 65153.7 65624.3 66682.7 67385.0 14265.1 14545.9 14750.7 14848.8 14874.0 14964.3 15874.2 15963.8 16036.3 16048.4 14319.5 14658.7 14783.9 14817.6 15375.5 13512.3 13930.5 14609.1 14748.1 15259.9 13789.6 14208.2 14405.4 14535.1 14558.7 9306.4 10188.0 10469.3 10730.5 10897.9 10612.0 10796.5 11589.1 11823.7 11834.3 14:16:49 INFO - PROCESS | 1643 | -------- Summary: end -------- 14:16:49 INFO - PROCESS | 1643 | 14:16:49 INFO - TEST-INFO | 1643: exit 0 14:16:49 INFO - TEST-OK | dromaeo_css | took 1119321ms 14:16:49 INFO - TEST-START | kraken 14:16:49 INFO - operating with platform_type : mac_ 14:16:49 INFO - Initialising browser for kraken test... 14:16:49 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpEXY4tf/profile http://localhost:49247/getInfo.html) 14:16:51 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 14:16:51 INFO - PROCESS | 1653 | colorDepth:24 14:16:51 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 14:16:51 INFO - PROCESS | 1653 | __metrics 14:16:51 INFO - PROCESS | 1653 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:16:51 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:16:52 INFO - TEST-INFO | 1653: exit 0 14:16:52 INFO - Browser initialized. 14:16:52 INFO - Running cycle 1/1 for kraken test... 14:16:52 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpEXY4tf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:17:04 INFO - PROCESS | 1655 | RSS: Main: 165261312 14:17:04 INFO - PROCESS | 1655 | 14:17:07 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection) 14:17:08 INFO - PROCESS | 1655 | RSS: Main: 216199168 14:17:08 INFO - PROCESS | 1655 | 14:17:11 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-dft) 14:17:11 INFO - PROCESS | 1655 | RSS: Main: 233127936 14:17:11 INFO - PROCESS | 1655 | 14:17:14 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-fft) 14:17:15 INFO - PROCESS | 1655 | RSS: Main: 328814592 14:17:15 INFO - PROCESS | 1655 | 14:17:17 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator) 14:17:18 INFO - PROCESS | 1655 | RSS: Main: 229826560 14:17:18 INFO - PROCESS | 1655 | 14:17:20 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:17:20 INFO - PROCESS | 1655 | RSS: Main: 231034880 14:17:20 INFO - PROCESS | 1655 | 14:17:23 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom) 14:17:24 INFO - PROCESS | 1655 | RSS: Main: 271233024 14:17:24 INFO - PROCESS | 1655 | 14:17:27 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate) 14:17:27 INFO - PROCESS | 1655 | RSS: Main: 272666624 14:17:27 INFO - PROCESS | 1655 | 14:17:30 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial) 14:17:31 INFO - PROCESS | 1655 | RSS: Main: 270741504 14:17:31 INFO - PROCESS | 1655 | 14:17:33 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:17:33 INFO - PROCESS | 1655 | RSS: Main: 248930304 14:17:33 INFO - PROCESS | 1655 | 14:17:35 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:17:36 INFO - PROCESS | 1655 | RSS: Main: 253546496 14:17:36 INFO - PROCESS | 1655 | 14:17:38 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:17:38 INFO - PROCESS | 1655 | RSS: Main: 257142784 14:17:38 INFO - PROCESS | 1655 | 14:17:41 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:17:42 INFO - PROCESS | 1655 | RSS: Main: 273694720 14:17:42 INFO - PROCESS | 1655 | 14:17:45 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:17:46 INFO - PROCESS | 1655 | RSS: Main: 267194368 14:17:46 INFO - PROCESS | 1655 | 14:17:47 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49247/tests/kraken/driver.html?testName=ai-astar) 14:17:48 INFO - PROCESS | 1655 | RSS: Main: 311365632 14:17:48 INFO - PROCESS | 1655 | 14:17:48 INFO - PROCESS | 1655 | __start_tp_report 14:17:48 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 14:17:48 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 14:17:48 INFO - PROCESS | 1655 | |i|pagename|runs| 14:17:48 INFO - PROCESS | 1655 | |0;ai-astar;106;116;116;117;116;116;116;116;119;173 14:17:48 INFO - PROCESS | 1655 | |1;audio-beat-detection;133;107;105;139;105;108;105;104;127;107 14:17:48 INFO - PROCESS | 1655 | |2;audio-dft;184;183;184;183;193;262;208;185;188;183 14:17:48 INFO - PROCESS | 1655 | |3;audio-fft;82;59;57;91;62;60;58;60;75;59 14:17:48 INFO - PROCESS | 1655 | |4;audio-oscillator;83;68;86;69;69;66;81;67;67;81 14:17:48 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;109;135;89;88;89;88;88;88;89;88 14:17:48 INFO - PROCESS | 1655 | |6;imaging-darkroom;94;93;101;145;95;93;94;95;94;95 14:17:48 INFO - PROCESS | 1655 | |7;imaging-desaturate;83;84;84;85;84;84;86;84;84;99 14:17:48 INFO - PROCESS | 1655 | |8;json-parse-financial;62;61;62;64;64;62;62;62;64;62 14:17:48 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;60;64;63;64;63;58;58;56;57;57 14:17:48 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;82;83;82;84;84;83;83;81;81;80 14:17:48 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;135;144;133;131;120;127;147;162;197;170 14:17:48 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;162;174;204;164;163;163;163;162;162;214 14:17:48 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;65;69;79;80;72;64;66;73;77;80 14:17:48 INFO - PROCESS | 1655 | __end_tp_report 14:17:48 INFO - PROCESS | 1655 | __start_cc_report 14:17:48 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,2110 14:17:48 INFO - PROCESS | 1655 | __end_cc_report 14:17:48 INFO - PROCESS | 1655 | __startTimestamp1493068668243__endTimestamp 14:17:48 INFO - PROCESS | 1655 | 14:17:48 INFO - PROCESS | 1655 | ------- Summary: start ------- 14:17:48 INFO - PROCESS | 1655 | Number of tests: 14 14:17:48 INFO - PROCESS | 1655 | 14:17:48 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:121.10 Median:116.00 stddev:18.56 (16.0%) stddev-sans-first:18.86 14:17:48 INFO - PROCESS | 1655 | Values: 106.0 116.0 116.0 117.0 116.0 116.0 116.0 116.0 119.0 173.0 14:17:48 INFO - PROCESS | 1655 | 14:17:48 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:114.00 Median:107.50 stddev:13.47 (12.5%) stddev-sans-first:12.40 14:17:48 INFO - PROCESS | 1655 | Values: 133.0 107.0 105.0 139.0 105.0 108.0 105.0 104.0 127.0 107.0 14:17:48 INFO - PROCESS | 1655 | 14:17:48 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:195.30 Median:186.50 stddev:24.68 (13.2%) stddev-sans-first:25.84 14:17:48 INFO - PROCESS | 1655 | Values: 184.0 183.0 184.0 183.0 193.0 262.0 208.0 185.0 188.0 183.0 14:17:48 INFO - PROCESS | 1655 | 14:17:48 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:66.30 Median:61.00 stddev:11.98 (19.6%) stddev-sans-first:11.28 14:17:48 INFO - PROCESS | 1655 | Values: 82.0 59.0 57.0 91.0 62.0 60.0 58.0 60.0 75.0 59.0 14:17:48 INFO - PROCESS | 1655 | 14:17:48 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:73.70 Median:75.00 stddev:7.96 (10.6%) stddev-sans-first:7.70 14:17:48 INFO - PROCESS | 1655 | Values: 83.0 68.0 86.0 69.0 69.0 66.0 81.0 67.0 67.0 81.0 14:17:48 INFO - PROCESS | 1655 | 14:17:48 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:95.10 Median:88.00 stddev:15.45 (17.6%) stddev-sans-first:15.55 14:17:48 INFO - PROCESS | 1655 | Values: 109.0 135.0 89.0 88.0 89.0 88.0 88.0 88.0 89.0 88.0 14:17:48 INFO - PROCESS | 1655 | 14:17:48 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:99.90 Median:94.00 stddev:16.01 (17.0%) stddev-sans-first:16.84 14:17:48 INFO - PROCESS | 1655 | Values: 94.0 93.0 101.0 145.0 95.0 93.0 94.0 95.0 94.0 95.0 14:17:48 INFO - PROCESS | 1655 | 14:17:48 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:84.00 stddev:4.74 (5.6%) stddev-sans-first:4.92 14:17:48 INFO - PROCESS | 1655 | Values: 83.0 84.0 84.0 85.0 84.0 84.0 86.0 84.0 84.0 99.0 14:17:48 INFO - PROCESS | 1655 | 14:17:48 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:62.00 stddev:1.08 (1.7%) stddev-sans-first:1.13 14:17:48 INFO - PROCESS | 1655 | Values: 62.0 61.0 62.0 64.0 64.0 62.0 62.0 62.0 64.0 62.0 14:17:48 INFO - PROCESS | 1655 | 14:17:48 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:61.50 stddev:3.20 (5.2%) stddev-sans-first:3.39 14:17:48 INFO - PROCESS | 1655 | Values: 60.0 64.0 63.0 64.0 63.0 58.0 58.0 56.0 57.0 57.0 14:17:48 INFO - PROCESS | 1655 | 14:17:48 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:83.00 stddev:1.34 (1.6%) stddev-sans-first:1.41 14:17:48 INFO - PROCESS | 1655 | Values: 82.0 83.0 82.0 84.0 84.0 83.0 83.0 81.0 81.0 80.0 14:17:48 INFO - PROCESS | 1655 | 14:17:48 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:146.60 Median:145.50 stddev:23.54 (16.2%) stddev-sans-first:24.59 14:17:48 INFO - PROCESS | 1655 | Values: 135.0 144.0 133.0 131.0 120.0 127.0 147.0 162.0 197.0 170.0 14:17:48 INFO - PROCESS | 1655 | 14:17:48 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.10 Median:163.50 stddev:19.40 (11.9%) stddev-sans-first:20.16 14:17:48 INFO - PROCESS | 1655 | Values: 162.0 174.0 204.0 164.0 163.0 163.0 163.0 162.0 162.0 214.0 14:17:48 INFO - PROCESS | 1655 | 14:17:48 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:75.00 stddev:6.31 (8.4%) stddev-sans-first:6.08 14:17:48 INFO - PROCESS | 1655 | Values: 65.0 69.0 79.0 80.0 72.0 64.0 66.0 73.0 77.0 80.0 14:17:48 INFO - PROCESS | 1655 | -------- Summary: end -------- 14:17:48 INFO - PROCESS | 1655 | 14:17:49 INFO - TEST-INFO | 1655: exit 0 14:17:49 INFO - TEST-OK | kraken | took 59477ms 14:17:49 INFO - SUITE-END | took 1178s 14:17:49 INFO - Completed test suite (00:19:39) 14:17:49 INFO - javascript benchmark 14:17:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7824.74723327239, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3382.8985130446085, 3469.51426800248, 3476.1657202271454, 3502.6497350264963, 3528.5765708115014, 4744.762761861902, 5776.480116789488, 5781.566382521307, 5886.764529418829, 5904.88190236195, 5849.2980842298875, 5921.319048309446, 5925.792597259086, 5930.377310382401, 5939.168516407695, 5360.115580929142, 5395.352557693072, 5396.460353964611, 5428.83713488596, 5449.863753406157, 5278.3138192034985, 5283.233931079991, 5295.947040529603, 5460.290162278918, 5470.91793623096, 5356.491133342326, 5365.195220716904, 5378.46215378463, 5379.919301210485, 5386.434424385442, 5361.303030606015, 5372.301600791872, 5374.27447294618, 5384.811531596414, 5387.380451248097, 5227.660202086852, 5330.173823057432, 5333.066713325153, 5334.759935802898, 5360.651557648779, 5884.558658100659, 5890.145928840294, 5890.734916928748, 5891.882162356772, 5894.705264736746, 6252.06219067139, 6255.030470277115, 6259.687015649245, 6323.778667746653, 6360.93639063608, 6362.395572420613, 6369.681515924185, 6375.776847810304, 6390.233172019387, 6393.7442502299855, 5929.1995580596495, 5933.258342707161, 5965.284165900076, 5966.2840459144745, 5972.940270597282, 6314.810555683337, 6350.396712312323, 6354.269259035178, 6435.324290949383, 6438.774642887476, 6180.196574445294, 6217.129601855744, 6227.750889964442, 6240.843978900564, 6244.406781355764, 6394.648294343856, 6416.903746443807, 6429.935700642934, 6430.742770289229, 6435.163428754326, 4605.792739326738, 6000.849978750566, 6375.617462952145, 6382.042693595998, 6384.904226436607, 6121.87979361315, 6290.21372328459, 6308.589941653778, 6319.0, 6330.177076979963, 5049.974750126225, 5052.823151189691, 5072.137736584716, 5089.0, 5097.337346145052, 4431.246688063037, 4471.8434854779925, 4480.574345437179, 4494.438195225597, 4519.480259770168, 5746.109353050284, 5835.44563266489, 6020.096985452217, 6069.726862291208, 6090.969545152246, 5287.497687719738, 6330.05049242608, 6345.0, 6351.04734289851, 6359.713812878432, 6032.668203248863, 6034.969825150846, 6039.7282122304605, 6044.15381846533, 6052.394760524, 5515.227868098469, 5537.280153580009, 5556.305461817273, 5560.77756889728, 5573.916391254134, 6286.9056964145575, 6325.240971083499, 6405.295417503978, 6432.774852880127, 6475.061116138134, 6345.524085693683, 6372.617642941438, 6378.808635740936, 6392.4246817786625, 6409.9038514423255, 6378.536225600727, 6504.544681872224, 6516.706748196248, 6521.315261897433, 6538.411542961157, 6122.825106970275, 6202.2867370253, 6237.563370564017, 6424.9036264455135, 6427.357264273535, 4952.356193694941, 6022.548308876764, 6317.115603815378, 6318.715657795502, 6340.714667839866, 6180.289266734383, 6195.256569211723, 6290.402411770874, 6294.937050629618, 6313.084602732486, 6231.813045608639, 6250.718717657807, 6283.71723272463, 6285.057241413824, 6290.21372328459, 6138.0179171332375, 6151.200343955257, 6153.292371377349, 6156.445919867234, 6165.784197553064, 5935.465808077293, 5956.374580668968, 6025.517958563392, 6061.36355682647, 6119.663418511846, 5863.677497737665, 5882.264716910387, 5923.170756094237, 5935.0, 6036.3058248302], "value": 5808.481702405521, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [806.8951036365273, 830.2071521696778, 895.5835536475541, 913.8857642794651, 914.5655813488589, 36161.276774464495, 40571.0, 42708.0, 42809.92975175622, 42819.0, 41767.37348939761, 42004.0, 42020.0, 42067.789661051655, 42113.57886421135, 7899.0, 8025.879611805827, 9488.810223795503, 9639.0, 9642.469664168468, 9838.45888476137, 11556.47995840185, 11932.0, 11943.9847612953, 11945.402729863516, 11741.354225517593, 11750.706232344175, 11760.882716141952, 11818.231814932045, 11830.7633847323, 11713.945744882916, 11718.765624687501, 11728.003119734833, 11746.94126529366, 11778.469968851423, 11419.942900285529, 11470.541178352856, 11476.827847582294, 11481.368524731137, 11503.597374091867, 39521.40717889234, 39547.81356559308, 39680.60319396798, 39701.80149099265, 39718.80140599307, 3913.5303763548272, 4038.757674539537, 4043.2722110020186, 4060.512738471373, 4072.3891416287497, 23991.960683341764, 28520.572191417144, 28521.57217641737, 30499.542506862414, 30634.84682576573, 3251.561039259717, 3265.232670322472, 3265.951010734841, 3294.8352582370785, 3404.3872103021445, 338054.0, 341792.0, 342348.0, 342753.0, 342895.0, 42689.0, 43460.0, 45432.0, 50778.73053173626, 50943.745281274096, 45342.54657453383, 45365.319520207224, 45430.545694542634, 52910.0, 53814.0, 15314.0, 15471.303791329417, 15517.5344739658, 15546.76679849803, 15556.299966501309, 13163.341832908316, 13266.872315853068, 13272.867271327355, 13274.402651880688, 13277.136986095873, 12121.878781212252, 12128.332941688292, 12132.0, 12238.632841014783, 12273.69315767113, 5563.415841336682, 5568.888622227614, 5569.693666848281, 5590.692511911884, 5594.468525490153, 932.5756780664781, 951.9952400237954, 964.1419136968104, 978.8678528398575, 1009.7327853543756, 28105.578416323773, 28321.858390707916, 28357.858210708815, 28846.567301490493, 28887.56668649972, 672.7040102354948, 1088.0425225801243, 1150.3500522204927, 1169.4094482286391, 1197.9101567382481, 14741.525847415387, 14976.775348369783, 14993.550193494213, 15304.387824486896, 15310.464133755266, 487109.0, 487851.0, 487966.0, 489987.0, 491269.0, 57951.0, 58050.0, 58071.0, 58133.0, 58245.835083298094, 1360.211077575004, 1415.4126037694448, 1418.2058047493642, 1425.0, 1430.9856901430853, 24089.156879509836, 27028.91884324605, 28213.858930705213, 28712.712872871838, 28891.5666265002, 46317.220966742105, 46346.609601712, 46384.7680761594, 46455.303170453146, 46510.53489465062, 364896.0, 366630.0, 451209.0, 451595.0, 454120.0, 31682.841585791924, 31809.363812724077, 31950.840245798623, 31976.68023319737, 32042.0, 43771.12457750891, 44295.0, 44307.77846110749, 44609.55390446184, 45261.77369113133, 27494.0377086801, 29952.850235748683, 30537.694623054373, 31073.912413065435, 31249.8437507811, 25085.498290034462, 30301.848490757406, 30329.393412131194, 30438.391232175676, 31382.0, 28544.714552854206, 28852.711472885003, 29043.419131617673, 37274.0, 37378.06554836151, 26919.327016823954, 31077.223069423446, 31234.531482028244, 32228.0, 32349.51475727819, 23817.0, 24603.876980614983, 25201.73991300391, 25334.87332563399, 25400.85696143641], "value": 19026.69329177535, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.61706049690883, 431.5464407316493, 434.4829652713272, 437.1890143783281, 442.36299728391117, 15049.924750376247, 21523.24668636598, 22276.777232227672, 22353.0, 22597.77402225977, 17519.73720394195, 21511.81685007328, 22361.776382236174, 22880.771192288074, 23117.537649247046, 6694.933050669491, 6888.345607167311, 6911.447084233275, 7428.702851885918, 7808.0, 4348.5216626171095, 7749.457537972344, 7777.02787151606, 7802.063752349726, 7803.76588702337, 4367.842521731744, 7466.104067511879, 7760.456768026241, 7918.485298455611, 7921.0, 7584.886226706604, 7634.389248860133, 7728.111267204287, 7799.688012479494, 7867.291943725064, 6739.2249891262645, 7015.508914375945, 7294.708211671526, 7589.0, 7594.734184303523, 26854.46291074187, 26894.19317420461, 26936.730632693812, 27297.317567060785, 27458.038968636203, 3054.4501989641853, 3061.9081427557207, 3168.6197656281392, 3221.4362486564755, 3257.2345498807763, 15800.92099539495, 17059.402920897708, 17096.34456090669, 17182.39861604838, 17377.826221737872, 1961.695937129747, 1985.1364656374524, 1996.5807180492113, 2008.1918320276825, 2039.6838490034067, 136379.0, 146786.0, 152216.0, 155537.0, 167097.16451417786, 15338.463153789564, 16952.915235423745, 17782.844115132735, 20056.69914951277, 20268.29060982888, 30431.847840760656, 30789.0, 30803.383932321227, 31441.0, 31845.0, 8039.839203215903, 8153.510789352657, 9636.566354514063, 9757.365771224848, 10976.835347469794, 7138.785836424916, 8893.73318800424, 8896.8665470018, 8996.190342869173, 9004.144606262395, 9484.573194206278, 9567.90432095684, 9617.759556011155, 9661.32370734056, 9684.70945871625, 4089.4683691119963, 4171.624553790173, 4171.885250790226, 4200.122915802685, 4211.4525111735275, 1057.1384321777728, 1068.428390810928, 1068.8289873620338, 1069.919756018286, 1130.5477808876515, 19435.611287774165, 22937.311880643607, 22968.196113136295, 22995.425114372276, 23052.65421018686, 910.3900386740767, 1105.9336439813637, 1110.294962698676, 1120.4117838134882, 1135.6706555098929, 11045.502952367162, 11696.473658685209, 11841.644750657493, 11868.703282418008, 11906.404679765978, 650675.0, 670536.0, 687209.0, 747422.0, 781079.0, 156597.2170139142, 158362.0, 161795.5730664041, 163137.0, 166994.0, 1174.8825117488354, 1251.6870782304425, 1290.6128161551685, 1350.257358452847, 1360.5578187089236, 20238.39284821458, 20405.59188816245, 20912.790872091085, 20962.0, 20971.37085887426, 66323.66838165779, 66535.0, 67375.0, 68690.0, 69124.30875691179, 96172.51913740387, 96693.5165324197, 96783.03216968021, 97472.0, 98638.5068074655, 11559.884401155881, 11699.23954942926, 11911.3448760319, 12118.636440906786, 12212.08409369283, 11159.888401115884, 12648.620541383772, 13205.273709946045, 13240.53658121961, 13468.730625387241, 11660.18378713482, 11667.241629294069, 11735.178537502294, 11767.0, 12039.75920481568, 9685.176759975198, 9735.9026409735, 10531.0, 10907.836382454429, 10932.14153593875, 11556.537738490366, 11853.11101667361, 11958.58144964922, 11995.940020300191, 12113.878861211628, 11677.76644467123, 11708.47311870985, 12045.939770301444, 12111.45498452554, 12119.636410907688, 11539.19225654196, 11781.469833857669, 11845.0, 12013.879861201276, 12018.519259229883], "value": 11924.848439143589, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1290.9160904541197, 1612.2583611538691, 1630.69832081065, 1653.0247154179033, 1667.3497336038947, 9459.290553208511, 11026.228164028511, 11315.264507806987, 11547.96068353848, 11552.01807846332, 11197.832032519518, 11261.943690281538, 11285.717857053578, 11305.886941130586, 11319.603813866517, 2084.8749075055543, 2451.4729333193313, 2494.1769216158714, 2494.3514686181634, 2500.4499010217814, 2032.928847490338, 2419.358869899478, 2494.0896572750908, 2499.912503062384, 2511.5855883779154, 2433.6471211674384, 2466.432720474292, 2471.270975062361, 2472.3695457658273, 2473.134402958959, 2397.0172229386044, 2426.963595546068, 2430.21018169094, 2432.0636554926305, 2433.7201221859536, 2420.7337192908767, 2422.733499315074, 2425.333033415807, 2425.6967879015124, 2429.1133736186343, 11105.500252488577, 11190.272632278877, 11225.719357016058, 11235.0, 11267.718307042389, 5998.670073145975, 6190.84522886927, 6195.19462469876, 6198.659073750942, 6201.534884883652, 3520.718342532591, 3605.3149901518627, 3798.2213646202463, 3801.486799282089, 3816.1985982943615, 1201.3212534917743, 1248.5692436109528, 1274.898008159345, 1284.1460428814828, 1290.5096063495812, 16078.276477558538, 16131.596710082224, 16153.0, 16165.595860103474, 16182.0, 4789.185838407479, 5164.3802743671, 5216.478352164829, 5224.216367544898, 5256.737163141904, 13493.865061349261, 13516.256605886574, 13549.051566390455, 13553.322333883463, 13560.525381611793, 6252.624842509464, 6255.874882502416, 6259.467945224706, 6262.937370626236, 6282.528810339243, 4693.95306046942, 4847.0, 5530.668159910419, 5599.412061733541, 5626.634268772598, 3767.7927713975446, 4174.540800511942, 4175.97912010438, 4291.806868690916, 4334.306510958231, 1176.847009888726, 1179.8348231247633, 1182.5683625476638, 1193.6359410379744, 1194.5759255464359, 981.6453294453609, 995.1044060345747, 1005.1807776661997, 1008.0, 1020.9387436753818, 6649.135612370361, 6768.661566921733, 6867.769294746355, 6871.6564171791215, 6993.160820701549, 950.8716323296267, 1014.8380104780133, 1048.6853943816825, 1087.7552550676035, 1124.4658787076237, 3725.4784330193793, 4091.8363265469047, 4236.894077648022, 4361.302191649321, 4501.68488205829, 13317.267550284634, 13959.511417100555, 13960.86039139616, 13985.650358741113, 13999.230042347768, 12992.285424301754, 13516.324183790772, 13830.031897767261, 13853.792193117111, 13883.444662213398, 8062.717804876801, 9974.650887218913, 9983.850242246226, 9987.101160895554, 9997.100260976547, 6553.627368107082, 6805.659717014229, 6911.723531058902, 7054.470914681522, 7072.469564782559, 12362.629121126382, 12785.16896401731, 12797.616071517868, 12825.871741282841, 12841.486340546273, 12610.873891261337, 12847.03647226443, 12870.485180593047, 12959.157654752411, 13015.958723301923, 8255.174482551936, 9289.581968811284, 9435.433873967584, 9537.952310238405, 9576.090271424204, 9431.528423578931, 10157.984201579782, 10431.478426078818, 10605.045545900906, 10605.151587872797, 8615.91384086151, 8771.868421973548, 8844.867326989972, 8873.334499912662, 8882.511461869659, 8635.87046194295, 8710.782230444289, 8727.781805454915, 8795.0, 8796.692115775917, 8188.058373287148, 8365.749027529184, 8371.623276952674, 8375.706850260212, 8379.874301885598, 6078.787242446493, 6082.148499210202, 6143.0, 6276.027215781562, 6328.683565821599, 6010.459058684739, 6038.8792224154395, 6198.543342314642, 6227.346128656607, 6258.593191442724], "value": 5317.238679942595, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.9751066180696, 384.25071111332903, 387.37439035956936, 391.0477986103837, 393.8444314495774, 4740.345406572317, 4795.978533523879, 4926.595920162755, 4988.958943255965, 5038.060346766494, 4162.625363717265, 4773.809047638099, 4878.365812444386, 4934.457209706939, 4988.675736077153, 3707.9073023174365, 3918.8243526941947, 3942.9748265450976, 4209.705320627558, 4250.744955302676, 3651.922682808565, 4161.83352665893, 4236.216299984498, 4333.374984380857, 4345.608895199432, 4305.956940430603, 4323.848665296715, 4327.4374331336885, 4345.9348109778375, 4381.3208952612395, 3576.570811502623, 3628.4194528875387, 3977.4033894915706, 4232.661387089025, 4344.869653910388, 3467.254540273828, 4097.569755175723, 4146.875593732193, 4147.0, 4181.247375472413, 3859.614038596146, 4315.762633055212, 4434.889127771799, 4483.4843992940905, 4879.634027447955, 4319.423410455192, 4373.387725718402, 4383.495897971742, 4595.839145629887, 5029.698218106925, 4431.593455983695, 4579.977100114478, 4780.991983366995, 5169.534741873212, 5273.947260527422, 4128.566500517462, 4211.515675697304, 4506.774661266923, 4632.822573390501, 4656.4877863434995, 4648.488666246744, 4909.582685471739, 4942.35749352589, 5283.577313814885, 5593.0, 3869.690424766012, 3942.3495123304333, 4139.234241665302, 4529.6376289896725, 4716.481187069419, 4405.625521830616, 4458.8439404620685, 4783.425988881357, 4842.297866809364, 4849.175640141185, 4374.834456943833, 4631.652626053059, 4763.785234765182, 4947.229551451199, 4979.551840334388, 4499.055198408371, 4923.803047878045, 4932.950670493321, 4946.777395017233, 5130.8973820524125, 1409.654634614526, 1480.8079496005603, 1482.2292407947807, 1494.454524098696, 1630.1986305132893, 1089.8121048057496, 1161.895429411357, 1170.73658426855, 1246.376811594203, 1371.8285214348207, 4004.9199016019516, 4130.752154870717, 4699.365585645963, 4930.5069493050405, 4933.6793108448555, 4506.752128632957, 4953.405591329064, 5262.0, 5266.0257852297445, 5470.152126420411, 3580.6598373154507, 4934.9013019739405, 4953.925691114636, 4962.975185124052, 5016.523430274118, 2356.587597170488, 2521.962170567443, 2597.5584150694426, 2702.6756789185424, 2856.5429531274895, 4645.814167433265, 4810.0, 4835.516448355136, 5058.4435712071645, 5641.746121424546, 4824.744495793543, 4998.2759396129195, 5541.428321634587, 5550.195221692832, 5610.943890561124, 5330.280412144389, 5439.80324328647, 5441.0074459048155, 5572.832815015556, 5615.18579805934, 4560.566746159109, 4912.140375434214, 5337.678110022152, 5375.596830237826, 5460.2355670207, 4489.595936365743, 4909.361782968334, 4945.876353091202, 4954.8761280968265, 5157.793688252428, 4427.114577084531, 5250.663454762594, 5552.861178470571, 5585.888282234414, 5644.0, 3766.303233901737, 4317.55361953749, 4344.587264209895, 4362.847300344472, 4377.0808130293, 4572.359869618323, 4760.381150450419, 5435.2934118564335, 5497.917531236954, 5508.394076651645, 4972.922203792855, 5109.565686916654, 5237.869053273546, 5294.338207724035, 5303.798923446727, 4639.582437580634, 4682.508336624742, 4936.370997570722, 5179.378474583074, 5247.947520524898, 4743.691660042086, 4788.808447662054, 5116.948830511797, 5134.0, 5148.794048238028, 4631.374764406762, 5193.480651934777, 5218.8956220876125, 5239.659422137549, 5248.643625790661, 4428.844990425319, 4709.317149013443, 4727.4708031203145, 5089.720065396439, 5152.0], "value": 4043.317007883744, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.8751872191713, 774.7985523763823, 794.051108924835, 852.1010334097526, 856.8757530158127, 15194.924025379885, 15777.422257774217, 16019.679606407879, 16913.23890424931, 16922.746158807597, 15600.297986590602, 15641.139737314443, 15777.974431661934, 15820.920895395535, 15835.287412066456, 988.471167925162, 989.3717489394214, 1015.9339642923223, 1060.2260349944545, 1065.0787069185137, 1038.8545603615462, 1052.0741747262398, 1053.752368193474, 1055.8310670292756, 1055.9841602375932, 1083.8374243863443, 1084.8426978088173, 1086.277625379122, 1086.8858769829174, 1089.3028461784463, 1078.8813230544633, 1079.13129930406, 1079.9784004319947, 1081.7890511350329, 1082.2045796339685, 797.3581267079999, 800.8998875140608, 801.7634797734624, 802.3460879383342, 802.470369556096, 16550.172491375382, 16930.238139283763, 16954.0, 16978.915105424516, 17430.215640296217, 14587.781183282259, 14779.926100369537, 14861.331240094221, 14892.106473611619, 15328.23358832065, 11737.882621173765, 11962.521499140024, 12509.687257818536, 12715.93642031784, 12748.681282967907, 3777.3389656810223, 3829.3107240696663, 3930.8427662893737, 3934.1148241645687, 4065.1869626074904, 116242.0, 121020.39489802583, 124990.0, 125335.74664253333, 127880.3605981964, 10691.305065170895, 11422.543098275975, 11667.88332116685, 11682.474288657031, 11983.460744266355, 23883.40291492692, 24282.27153185372, 24460.755392446204, 24495.897684604235, 24562.631560526606, 8058.1538938411795, 8071.717489887826, 8121.390895682847, 8212.260896519341, 8237.917620823715, 4374.321980093091, 4400.625946794495, 4403.493598236179, 4498.5501449854755, 4626.21354369758, 3644.362236608583, 3708.5364329458816, 3723.1809002019513, 3756.6055564165367, 3756.887293381203, 669.3841665667597, 669.5647828911247, 674.750342373325, 688.3323176518769, 688.5971706551724, 693.299767235086, 693.7675878580732, 706.6713978000255, 745.3701622129292, 761.7866997240782, 10827.563798145511, 10929.781404372026, 10982.450877456095, 11010.669679909615, 11051.336919784679, 659.6932426421737, 736.2351208858441, 739.7558805594249, 742.5210739073267, 766.5247546521192, 5076.0, 5162.432132465426, 5237.476252374809, 5268.6575372600655, 5276.234945932818, 92311.0, 95057.04942950621, 108177.0, 112970.30544541839, 114236.42881785538, 57869.8426031477, 59968.0, 73208.0, 78692.81960770593, 91089.54455227814, 79461.60269198618, 83613.0, 87797.56101219454, 87961.5601921999, 91162.0, 9701.0, 11349.602763903224, 11409.201355905006, 11508.251963622337, 11539.88460115388, 53517.0, 54113.458865410845, 54736.452635473135, 55353.723231383585, 55524.72237638786, 60538.0, 65153.67423162854, 65624.34375656182, 66682.66634667183, 67385.0, 14265.072770269899, 14545.85454145445, 14750.704985900436, 14848.7772683412, 14874.033187842755, 14964.326605302569, 15874.2062896857, 15963.760543592087, 16036.278367473258, 16048.358065677709, 14319.498817541336, 14658.706825863635, 14783.852161478248, 14817.555473335817, 15375.538733838002, 13512.324383780575, 13930.512432064828, 14609.123452592878, 14748.115113093249, 15259.855510836509, 13789.586312410644, 14208.218547979961, 14405.42378304856, 14535.055221410998, 14558.708825823636, 9306.395084319498, 10188.0, 10469.31949423285, 10730.517126729472, 10897.891021089688, 10612.0, 10796.460176991277, 11589.072874170215, 11823.70440738954, 11834.349110798988], "value": 8099.821591964418, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1448.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 116.0, 117.0, 116.0, 116.0, 116.0, 116.0, 119.0, 173.0], "value": 121.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 107.0, 105.0, 139.0, 105.0, 108.0, 105.0, 104.0, 127.0, 107.0], "value": 114.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 184.0, 183.0, 193.0, 262.0, 208.0, 185.0, 188.0, 183.0], "value": 195.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 57.0, 91.0, 62.0, 60.0, 58.0, 60.0, 75.0, 59.0], "value": 66.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 68.0, 86.0, 69.0, 69.0, 66.0, 81.0, 67.0, 67.0, 81.0], "value": 73.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 135.0, 89.0, 88.0, 89.0, 88.0, 88.0, 88.0, 89.0, 88.0], "value": 95.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 101.0, 145.0, 95.0, 93.0, 94.0, 95.0, 94.0, 95.0], "value": 99.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 84.0, 85.0, 84.0, 84.0, 86.0, 84.0, 84.0, 99.0], "value": 85.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 64.0, 64.0, 62.0, 62.0, 62.0, 64.0, 62.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 64.0, 63.0, 64.0, 63.0, 58.0, 58.0, 56.0, 57.0, 57.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 82.0, 84.0, 84.0, 83.0, 83.0, 81.0, 81.0, 80.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 144.0, 133.0, 131.0, 120.0, 127.0, 147.0, 162.0, 197.0, 170.0], "value": 146.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 174.0, 204.0, 164.0, 163.0, 163.0, 163.0, 162.0, 162.0, 214.0], "value": 173.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 79.0, 80.0, 72.0, 64.0, 66.0, 73.0, 77.0, 80.0], "value": 72.5, "unit": "score"}]}]} 14:17:49 INFO - Return code: 0 14:17:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:17:49 INFO - # TBPL SUCCESS # 14:17:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:17:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:17:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:17:49 INFO - 2017-04-24 14:17:49.530 screenresolution[1659:9879] starting screenresolution argv=screenresolution get 14:17:49 INFO - 2017-04-24 14:17:49.533 screenresolution[1659:9879] Display 0: 1600x1200x32@60 14:17:49 INFO - 2017-04-24 14:17:49.540 screenresolution[1660:9882] starting screenresolution argv=screenresolution list 14:17:49 INFO - Available Modes on Display 0 14:17:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:17:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:17:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:17:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:17:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:17:49 INFO - Intel Iris: 14:17:49 INFO - Chipset Model: Intel Iris 14:17:49 INFO - Type: GPU 14:17:49 INFO - Bus: Built-In 14:17:49 INFO - VRAM (Dynamic, Max): 1536 MB 14:17:49 INFO - Vendor: Intel (0x8086) 14:17:49 INFO - Device ID: 0x0a2e 14:17:49 INFO - Revision ID: 0x0009 14:17:49 INFO - Displays: 14:17:49 INFO - Display: 14:17:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:17:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:17:49 INFO - Display Serial Number: 1600x1200 60 14:17:49 INFO - Main Display: Yes 14:17:49 INFO - Mirror: Off 14:17:49 INFO - Online: Yes 14:17:49 INFO - Rotation: Supported 14:17:49 INFO - Return code: 0 14:17:49 INFO - Running post-action listener: _resource_record_post_action 14:17:49 INFO - [mozharness: 2017-04-24 21:17:49.784321Z] Finished run-tests step (success) 14:17:49 INFO - Running post-run listener: _resource_record_post_run 14:17:49 INFO - Total resource usage - Wall time: 1194s; CPU: 54.0%; Read bytes: 45954048; Write bytes: 422966784; Read time: 494; Write time: 1711 14:17:49 INFO - TinderboxPrint: CPU usage
53.9% 14:17:49 INFO - TinderboxPrint: I/O read bytes / time
45,954,048 / 494 14:17:49 INFO - TinderboxPrint: I/O write bytes / time
422,966,784 / 1,711 14:17:49 INFO - TinderboxPrint: CPU idle
2,203.2 (46.1%) 14:17:49 INFO - TinderboxPrint: CPU system
959.5 (20.1%) 14:17:49 INFO - TinderboxPrint: CPU user
1,615.0 (33.8%) 14:17:49 INFO - TinderboxPrint: Swap in / out
161,738,752 / 0 14:17:49 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 123161088; Write bytes: 122781696; Read time: 11052; Write time: 262 14:17:49 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 40731648; Write bytes: 298714624; Read time: 454; Write time: 1443 14:17:50 INFO - Running post-run listener: _upload_blobber_files 14:17:50 INFO - Blob upload gear active. 14:17:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:17:50 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 14:17:50 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'] 14:17:50 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 14:17:50 INFO - (blobuploader) - INFO - Open directory for files ... 14:17:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:17:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:17:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:17:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:17:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:17:51 INFO - (blobuploader) - INFO - Done attempting. 14:17:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:17:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:17:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:17:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:17:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:17:52 INFO - (blobuploader) - INFO - Done attempting. 14:17:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:17:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:17:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:17:53 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:17:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:17:53 INFO - (blobuploader) - INFO - Done attempting. 14:17:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:17:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:17:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:17:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:17:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:17:55 INFO - (blobuploader) - INFO - Done attempting. 14:17:55 INFO - (blobuploader) - INFO - Iteration through files over. 14:17:55 INFO - Return code: 0 14:17:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:17:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:17:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6266408d1bf9cfea4aaed2f44f3de931525678450ab4d74a1ac9131e31509c10023f7595613d6629fc93d7af7986f62b530a36ffedcc6b11fdd13472ba4dd3ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/767c7688143d35a04609176f7b002ff6adc008af355597d88441b8eb4f60c1b8dfa6c821f7efe723040d083a32541dfa51153428e4ac42e72f34bb620c9ad517", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5fb1b632822895dad19528d6ee4997e14c96c900cc48dff74fb8c7ffdb814383515ae597c110d6faf4088260bd10359ff73257f4683c521b1e60ab2077369a35", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/62be2be8c08ce9c97bfef4a93273d05a4ce86a623a2fcc6c91b55e0442ff6a7d6f664f652c929f7b133c13d5955c83c2c28e9e11f01f829405d304de9d042b88"} 14:17:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:17:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:17:55 INFO - Contents: 14:17:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6266408d1bf9cfea4aaed2f44f3de931525678450ab4d74a1ac9131e31509c10023f7595613d6629fc93d7af7986f62b530a36ffedcc6b11fdd13472ba4dd3ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/767c7688143d35a04609176f7b002ff6adc008af355597d88441b8eb4f60c1b8dfa6c821f7efe723040d083a32541dfa51153428e4ac42e72f34bb620c9ad517", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5fb1b632822895dad19528d6ee4997e14c96c900cc48dff74fb8c7ffdb814383515ae597c110d6faf4088260bd10359ff73257f4683c521b1e60ab2077369a35", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/62be2be8c08ce9c97bfef4a93273d05a4ce86a623a2fcc6c91b55e0442ff6a7d6f664f652c929f7b133c13d5955c83c2c28e9e11f01f829405d304de9d042b88"} 14:17:55 INFO - Running post-run listener: copy_logs_to_upload_dir 14:17:55 INFO - Copying logs to upload dir... 14:17:55 INFO - mkdir: /builds/slave/test/build/upload/logs 14:17:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.538288 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-04-24 14:17:55.391025) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-24 14:17:55.394678) ========= 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.OYW7qBWfoz/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.ZNYeZLSpga/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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/6266408d1bf9cfea4aaed2f44f3de931525678450ab4d74a1ac9131e31509c10023f7595613d6629fc93d7af7986f62b530a36ffedcc6b11fdd13472ba4dd3ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/767c7688143d35a04609176f7b002ff6adc008af355597d88441b8eb4f60c1b8dfa6c821f7efe723040d083a32541dfa51153428e4ac42e72f34bb620c9ad517", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5fb1b632822895dad19528d6ee4997e14c96c900cc48dff74fb8c7ffdb814383515ae597c110d6faf4088260bd10359ff73257f4683c521b1e60ab2077369a35", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/62be2be8c08ce9c97bfef4a93273d05a4ce86a623a2fcc6c91b55e0442ff6a7d6f664f652c929f7b133c13d5955c83c2c28e9e11f01f829405d304de9d042b88"} build_url:https://queue.taskcluster.net/v1/task/c5HQkDTIQ8OQ5eOS1dsjsA/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011162 build_url: 'https://queue.taskcluster.net/v1/task/c5HQkDTIQ8OQ5eOS1dsjsA/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/6266408d1bf9cfea4aaed2f44f3de931525678450ab4d74a1ac9131e31509c10023f7595613d6629fc93d7af7986f62b530a36ffedcc6b11fdd13472ba4dd3ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/767c7688143d35a04609176f7b002ff6adc008af355597d88441b8eb4f60c1b8dfa6c821f7efe723040d083a32541dfa51153428e4ac42e72f34bb620c9ad517", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5fb1b632822895dad19528d6ee4997e14c96c900cc48dff74fb8c7ffdb814383515ae597c110d6faf4088260bd10359ff73257f4683c521b1e60ab2077369a35", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/62be2be8c08ce9c97bfef4a93273d05a4ce86a623a2fcc6c91b55e0442ff6a7d6f664f652c929f7b133c13d5955c83c2c28e9e11f01f829405d304de9d042b88"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-24 14:17:55.432361) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 14:17:55.432855) ========= 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.OYW7qBWfoz/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.ZNYeZLSpga/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.005151 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 14:17:55.483490) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-24 14:17:55.483970) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-24 14:17:55.484535) ========= ========= Total master_lag: 0.18 =========