builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0100 starttime: 1491737853.42 results: success (0) buildid: 20170409035521 builduid: 743fa7a5496f43daa3b4a6ed26e146d0 revision: ee82facc7b9f03611b7a8c9e39f31168095ff7eb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-09 04:37:33.422038) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-09 04:37:33.422506) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-09 04:37:33.422782) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-09 04:37:33.471253) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 04:37:33.471641) ========= 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.sZ6m2fj9zC/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.DUl7J8zNsv/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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-09 04:37:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.10M=0.001s 2017-04-09 04:37:34 (8.10 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.636588 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 04:37:34.186083) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 04:37:34.186375) ========= 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.sZ6m2fj9zC/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.DUl7J8zNsv/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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.022073 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 04:37:34.231668) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 04:37:34.232099) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ee82facc7b9f03611b7a8c9e39f31168095ff7eb --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 ee82facc7b9f03611b7a8c9e39f31168095ff7eb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sZ6m2fj9zC/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.DUl7J8zNsv/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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-09 04:37:34,295 truncating revision to first 12 chars 2017-04-09 04:37:34,295 Setting DEBUG logging. 2017-04-09 04:37:34,295 attempt 1/10 2017-04-09 04:37:34,295 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ee82facc7b9f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-09 04:37:35,006 unpacking tar archive at: mozilla-beta-ee82facc7b9f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.957307 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 04:37:35.214732) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-09 04:37:35.215044) ========= script_repo_revision: ee82facc7b9f03611b7a8c9e39f31168095ff7eb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-09 04:37:35.215434) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-09 04:37:35.215696) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-09 04:37:35.235625) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-04-09 04:37:35.236016) ========= /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.sZ6m2fj9zC/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.DUl7J8zNsv/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 04:37:35 INFO - MultiFileLogger online at 20170409 04:37:35 in /builds/slave/test 04:37:35 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 04:37:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:37:35 INFO - {'append_to_log': False, 04:37:35 INFO - 'base_work_dir': '/builds/slave/test', 04:37:35 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:37:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:37:35 INFO - 'branch': 'Mozilla-Beta', 04:37:35 INFO - 'buildbot_json_path': 'buildprops.json', 04:37:35 INFO - 'config_files': ('talos/mac_config.py',), 04:37:35 INFO - 'default_actions': ('clobber', 04:37:35 INFO - 'read-buildbot-config', 04:37:35 INFO - 'download-and-extract', 04:37:35 INFO - 'populate-webroot', 04:37:35 INFO - 'create-virtualenv', 04:37:35 INFO - 'install', 04:37:35 INFO - 'run-tests'), 04:37:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:37:35 INFO - 'download_minidump_stackwalk': True, 04:37:35 INFO - 'download_symbols': 'ondemand', 04:37:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:37:35 INFO - 'tooltool.py': '/tools/tooltool.py', 04:37:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:37:35 INFO - '/tools/misc-python/virtualenv.py')}, 04:37:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:37:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:37:35 INFO - 'installer_path': 'installer.exe', 04:37:35 INFO - 'log_level': 'info', 04:37:35 INFO - 'log_name': 'talos', 04:37:35 INFO - 'log_to_console': True, 04:37:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:37:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:37:35 INFO - 'opt_config_files': (), 04:37:35 INFO - 'pip_index': False, 04:37:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:37:35 INFO - 'cmd': ('bash', 04:37:35 INFO - '-c', 04:37:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:37:35 INFO - 'enabled': True, 04:37:35 INFO - 'halt_on_failure': False, 04:37:35 INFO - 'name': 'check_screen_resolution'},), 04:37:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:37:35 INFO - 'cmd': ('bash', 04:37:35 INFO - '-c', 04:37:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:37:35 INFO - 'enabled': True, 04:37:35 INFO - 'halt_on_failure': False, 04:37:35 INFO - 'name': 'check_screen_resolution'},), 04:37:35 INFO - 'run_cmd_checks_enabled': True, 04:37:35 INFO - 'sps_profile': False, 04:37:35 INFO - 'sps_profile_interval': 0, 04:37:35 INFO - 'suite': 'dromaeojs', 04:37:35 INFO - 'system_bits': '32', 04:37:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:37:35 INFO - 'title': 't-yosemite-r7-0100', 04:37:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:37:35 INFO - 'use_talos_json': True, 04:37:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:37:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:37:35 INFO - 'work_dir': 'build'} 04:37:35 INFO - [mozharness: 2017-04-09 11:37:35.428330Z] Running clobber step. 04:37:35 INFO - Running pre-action listener: _resource_record_pre_action 04:37:35 INFO - Running main action method: clobber 04:37:35 INFO - rmtree: /builds/slave/test/build 04:37:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:37:37 INFO - Running post-action listener: _resource_record_post_action 04:37:37 INFO - [mozharness: 2017-04-09 11:37:37.336391Z] Finished clobber step (success) 04:37:37 INFO - [mozharness: 2017-04-09 11:37:37.336672Z] Running read-buildbot-config step. 04:37:37 INFO - Running pre-action listener: _resource_record_pre_action 04:37:37 INFO - Running main action method: read_buildbot_config 04:37:37 INFO - Using buildbot properties: 04:37:37 INFO - { 04:37:37 INFO - "project": "", 04:37:37 INFO - "product": "firefox", 04:37:37 INFO - "script_repo_revision": "production", 04:37:37 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 04:37:37 INFO - "repository": "", 04:37:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 04:37:37 INFO - "buildid": "20170409035521", 04:37:37 INFO - "pgo_build": "False", 04:37:37 INFO - "basedir": "/builds/slave/test", 04:37:37 INFO - "buildnumber": 18, 04:37:37 INFO - "slavename": "t-yosemite-r7-0100", 04:37:37 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:37:37 INFO - "platform": "yosemite_r7", 04:37:37 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 04:37:37 INFO - "branch": "mozilla-beta", 04:37:37 INFO - "repo_path": "releases/mozilla-beta", 04:37:37 INFO - "revision": "ee82facc7b9f03611b7a8c9e39f31168095ff7eb", 04:37:37 INFO - "stage_platform": "macosx64", 04:37:37 INFO - "builduid": "743fa7a5496f43daa3b4a6ed26e146d0", 04:37:37 INFO - "slavebuilddir": "test" 04:37:37 INFO - } 04:37:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/PJTq_tAQRwOtLE9ww20l9g/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 04:37:37 INFO - Running post-action listener: _resource_record_post_action 04:37:37 INFO - [mozharness: 2017-04-09 11:37:37.342391Z] Finished read-buildbot-config step (success) 04:37:37 INFO - [mozharness: 2017-04-09 11:37:37.342626Z] Running download-and-extract step. 04:37:37 INFO - Running pre-action listener: _resource_record_pre_action 04:37:37 INFO - Running main action method: download_and_extract 04:37:37 INFO - mkdir: /builds/slave/test/build/tests 04:37:37 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')]} 04:37:37 INFO - trying https://queue.taskcluster.net/v1/task/PJTq_tAQRwOtLE9ww20l9g/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 04:37:37 INFO - Downloading https://queue.taskcluster.net/v1/task/PJTq_tAQRwOtLE9ww20l9g/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 04:37:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PJTq_tAQRwOtLE9ww20l9g/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 04:37:38 INFO - Downloaded 1165 bytes. 04:37:38 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 04:37:38 INFO - Using the following test package requirements: 04:37:38 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 04:37:38 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:37:38 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 04:37:38 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:37:38 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 04:37:38 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 04:37:38 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:37:38 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 04:37:38 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 04:37:38 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:37:38 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 04:37:38 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:37:38 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 04:37:38 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:37:38 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 04:37:38 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:37:38 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 04:37:38 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 04:37:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PJTq_tAQRwOtLE9ww20l9g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 04:37:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PJTq_tAQRwOtLE9ww20l9g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 04:37:38 INFO - Fetch https://queue.taskcluster.net/v1/task/PJTq_tAQRwOtLE9ww20l9g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 04:37:40 INFO - Expected file size: 16116395 04:37:40 INFO - Obtained file size: 16116395 04:37:46 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 04:37:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PJTq_tAQRwOtLE9ww20l9g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 04:37:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PJTq_tAQRwOtLE9ww20l9g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 04:37:46 INFO - Fetch https://queue.taskcluster.net/v1/task/PJTq_tAQRwOtLE9ww20l9g/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 04:37:47 INFO - Expected file size: 16116395 04:37:47 INFO - Obtained file size: 16116395 04:37:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PJTq_tAQRwOtLE9ww20l9g/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 04:37:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PJTq_tAQRwOtLE9ww20l9g/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 04:37:54 INFO - Fetch https://queue.taskcluster.net/v1/task/PJTq_tAQRwOtLE9ww20l9g/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 04:37:55 INFO - Expected file size: 14403650 04:37:55 INFO - Obtained file size: 14403650 04:37:55 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')]} 04:37:55 INFO - trying https://queue.taskcluster.net/v1/task/PJTq_tAQRwOtLE9ww20l9g/artifacts/public/build/firefox-53.0.en-US.mac.dmg 04:37:55 INFO - Downloading https://queue.taskcluster.net/v1/task/PJTq_tAQRwOtLE9ww20l9g/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 04:37:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PJTq_tAQRwOtLE9ww20l9g/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 04:37:57 INFO - Downloaded 58735465 bytes. 04:37:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PJTq_tAQRwOtLE9ww20l9g/artifacts/public/build/firefox-53.0.en-US.mac.dmg 04:37:57 INFO - mkdir: /builds/slave/test/properties 04:37:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:37:57 INFO - Writing to file /builds/slave/test/properties/build_url 04:37:57 INFO - Contents: 04:37:57 INFO - build_url:https://queue.taskcluster.net/v1/task/PJTq_tAQRwOtLE9ww20l9g/artifacts/public/build/firefox-53.0.en-US.mac.dmg 04:37:58 INFO - Running post-action listener: _resource_record_post_action 04:37:58 INFO - Running post-action listener: set_extra_try_arguments 04:37:58 INFO - [mozharness: 2017-04-09 11:37:58.081658Z] Finished download-and-extract step (success) 04:37:58 INFO - [mozharness: 2017-04-09 11:37:58.081780Z] Running populate-webroot step. 04:37:58 INFO - Running pre-action listener: _resource_record_pre_action 04:37:58 INFO - Running main action method: populate_webroot 04:37:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:37:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:37:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:37:58 INFO - '--tppagecycles', 04:37:58 INFO - '7'], 04:37:58 INFO - 'tests': ['tsvgm']}}, 04:37:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:37:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:37:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:37:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:37:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:37:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:37:58 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:37:58 INFO - 'talos_options': ['--disable-e10s'], 04:37:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:37:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:37:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:37:58 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:37:58 INFO - 'talos_options': ['--disable-e10s'], 04:37:58 INFO - 'tests': ['damp', 'tps']}, 04:37:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:37:58 INFO - 'tests': ['damp', 'tps']}, 04:37:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:37:58 INFO - 'tests': ['dromaeo_dom']}, 04:37:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:37:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:37:58 INFO - 'tests': ['basic_compositor_video']}, 04:37:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:37:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:37:58 INFO - 'tests': ['a11yr', 04:37:58 INFO - 'ts_paint', 04:37:58 INFO - 'tpaint', 04:37:58 INFO - 'sessionrestore', 04:37:58 INFO - 'sessionrestore_no_auto_restore', 04:37:58 INFO - 'tabpaint']}, 04:37:58 INFO - 'other-e10s': {'tests': ['a11yr', 04:37:58 INFO - 'ts_paint', 04:37:58 INFO - 'tpaint', 04:37:58 INFO - 'sessionrestore', 04:37:58 INFO - 'sessionrestore_no_auto_restore', 04:37:58 INFO - 'tabpaint']}, 04:37:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:37:58 INFO - 'ts_paint', 04:37:58 INFO - 'tpaint', 04:37:58 INFO - 'sessionrestore', 04:37:58 INFO - 'sessionrestore_no_auto_restore', 04:37:58 INFO - 'tabpaint']}, 04:37:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:37:58 INFO - 'ts_paint', 04:37:58 INFO - 'tpaint', 04:37:58 INFO - 'sessionrestore', 04:37:58 INFO - 'sessionrestore_no_auto_restore', 04:37:58 INFO - 'tabpaint']}, 04:37:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:37:58 INFO - 'tests': ['a11yr', 04:37:58 INFO - 'ts_paint', 04:37:58 INFO - 'tpaint', 04:37:58 INFO - 'sessionrestore', 04:37:58 INFO - 'sessionrestore_no_auto_restore', 04:37:58 INFO - 'tabpaint']}, 04:37:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:37:58 INFO - 'tests': ['a11yr', 04:37:58 INFO - 'ts_paint', 04:37:58 INFO - 'tpaint', 04:37:58 INFO - 'sessionrestore', 04:37:58 INFO - 'sessionrestore_no_auto_restore', 04:37:58 INFO - 'tabpaint']}, 04:37:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:37:58 INFO - 'tests': ['tsvgx', 04:37:58 INFO - 'tsvgr_opacity', 04:37:58 INFO - 'tart', 04:37:58 INFO - 'tscrollx', 04:37:58 INFO - 'cart', 04:37:58 INFO - 'tsvg_static']}, 04:37:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:37:58 INFO - 'tsvgr_opacity', 04:37:58 INFO - 'tart', 04:37:58 INFO - 'tscrollx', 04:37:58 INFO - 'cart', 04:37:58 INFO - 'tsvg_static']}, 04:37:58 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:37:58 INFO - 'talos_options': ['--disable-e10s'], 04:37:58 INFO - 'tests': ['tp5o']}, 04:37:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:37:58 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:37:58 INFO - 'talos_options': ['--disable-e10s', 04:37:58 INFO - '--xperf_path', 04:37:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:37:58 INFO - 'tests': ['tp5n']}, 04:37:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:37:58 INFO - 'talos_options': ['--xperf_path', 04:37:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:37:58 INFO - 'tests': ['tp5n']}}, 04:37:58 INFO - 'talos.zip': {'path': '', 04:37:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:37:58 INFO - Running post-action listener: _resource_record_post_action 04:37:58 INFO - [mozharness: 2017-04-09 11:37:58.100742Z] Finished populate-webroot step (success) 04:37:58 INFO - [mozharness: 2017-04-09 11:37:58.100822Z] Running create-virtualenv step. 04:37:58 INFO - Running pre-action listener: _resource_record_pre_action 04:37:58 INFO - Running main action method: create_virtualenv 04:37:58 INFO - Creating virtualenv /builds/slave/test/build/venv 04:37:58 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 04:37:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:37:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:37:58 INFO - Using real prefix '/tools/python27' 04:37:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:37:58 INFO - Installing distribute.............................................................................................................................................................................................done. 04:38:01 INFO - Installing pip.................done. 04:38:01 INFO - Return code: 0 04:38:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:38:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:38:02 INFO - Reading from file tmpfile_stdout 04:38:02 INFO - Output received: 04:38:02 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) 04:38:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:38:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:02 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 0x106a72b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a75768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c5bccbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106850d30>, '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 0x106777db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106845be8>, '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.sZ6m2fj9zC/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.DUl7J8zNsv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 04:38:02 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 04:38:02 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 04:38:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sZ6m2fj9zC/Render', 04:38:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:02 INFO - 'HOME': '/Users/cltbld', 04:38:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:02 INFO - 'LOGNAME': 'cltbld', 04:38:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:02 INFO - 'MOZ_NO_REMOTE': '1', 04:38:02 INFO - 'NO_EM_RESTART': '1', 04:38:02 INFO - 'PAGER': '/bin/cat', 04:38:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:02 INFO - 'PWD': '/builds/slave/test', 04:38:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:02 INFO - 'SHELL': '/bin/bash', 04:38:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DUl7J8zNsv/Listeners', 04:38:02 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 04:38:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:02 INFO - 'USER': 'cltbld', 04:38:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:02 INFO - 'XPC_FLAGS': '0x0', 04:38:02 INFO - 'XPC_SERVICE_NAME': '0', 04:38:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:02 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 04:38:02 INFO - Cleaning up... 04:38:02 INFO - Return code: 0 04:38:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:38:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:02 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 0x106a72b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a75768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c5bccbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106850d30>, '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 0x106777db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106845be8>, '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.sZ6m2fj9zC/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.DUl7J8zNsv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 04:38:02 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 04:38:02 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 04:38:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sZ6m2fj9zC/Render', 04:38:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:02 INFO - 'HOME': '/Users/cltbld', 04:38:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:02 INFO - 'LOGNAME': 'cltbld', 04:38:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:02 INFO - 'MOZ_NO_REMOTE': '1', 04:38:02 INFO - 'NO_EM_RESTART': '1', 04:38:02 INFO - 'PAGER': '/bin/cat', 04:38:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:02 INFO - 'PWD': '/builds/slave/test', 04:38:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:02 INFO - 'SHELL': '/bin/bash', 04:38:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DUl7J8zNsv/Listeners', 04:38:02 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 04:38:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:02 INFO - 'USER': 'cltbld', 04:38:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:02 INFO - 'XPC_FLAGS': '0x0', 04:38:02 INFO - 'XPC_SERVICE_NAME': '0', 04:38:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:02 INFO - Downloading/unpacking psutil>=3.1.1 04:38:02 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 04:38:02 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 04:38:02 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 04:38:02 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 04:38:02 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 04:38:02 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 04:38:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:38:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:38:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:38:06 INFO - Installing collected packages: psutil 04:38:06 INFO - Running setup.py install for psutil 04:38:06 INFO - building 'psutil._psutil_osx' extension 04:38:06 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 04:38:06 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 04:38:06 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 04:38:06 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 04:38:06 INFO - building 'psutil._psutil_posix' extension 04:38:06 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 04:38:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:38:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:38:07 INFO - ^ 04:38:07 INFO - 1 warning generated. 04:38:07 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 04:38:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:38:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:38:07 INFO - Successfully installed psutil 04:38:07 INFO - Cleaning up... 04:38:07 INFO - Return code: 0 04:38:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:38:07 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')]} 04:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:07 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')]} 04:38:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:07 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 0x106a72b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a75768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c5bccbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106850d30>, '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 0x106777db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106845be8>, '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.sZ6m2fj9zC/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.DUl7J8zNsv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 04:38:07 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 04:38:07 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 04:38:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sZ6m2fj9zC/Render', 04:38:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:07 INFO - 'HOME': '/Users/cltbld', 04:38:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:07 INFO - 'LOGNAME': 'cltbld', 04:38:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:07 INFO - 'MOZ_NO_REMOTE': '1', 04:38:07 INFO - 'NO_EM_RESTART': '1', 04:38:07 INFO - 'PAGER': '/bin/cat', 04:38:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:07 INFO - 'PWD': '/builds/slave/test', 04:38:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:07 INFO - 'SHELL': '/bin/bash', 04:38:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DUl7J8zNsv/Listeners', 04:38:07 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 04:38:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:07 INFO - 'USER': 'cltbld', 04:38:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:07 INFO - 'XPC_FLAGS': '0x0', 04:38:07 INFO - 'XPC_SERVICE_NAME': '0', 04:38:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:38:07 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 04:38:07 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 04:38:07 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 04:38:07 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 04:38:07 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 04:38:07 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 04:38:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:38:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:38:10 INFO - Installing collected packages: mozsystemmonitor 04:38:10 INFO - Running setup.py install for mozsystemmonitor 04:38:10 INFO - Successfully installed mozsystemmonitor 04:38:10 INFO - Cleaning up... 04:38:10 INFO - Return code: 0 04:38:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106a72b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a75768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c5bccbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106850d30>, '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 0x106777db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106845be8>, '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.sZ6m2fj9zC/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.DUl7J8zNsv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 04:38:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:38:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:38:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sZ6m2fj9zC/Render', 04:38:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:10 INFO - 'HOME': '/Users/cltbld', 04:38:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:10 INFO - 'LOGNAME': 'cltbld', 04:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:10 INFO - 'MOZ_NO_REMOTE': '1', 04:38:10 INFO - 'NO_EM_RESTART': '1', 04:38:10 INFO - 'PAGER': '/bin/cat', 04:38:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:10 INFO - 'PWD': '/builds/slave/test', 04:38:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:10 INFO - 'SHELL': '/bin/bash', 04:38:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DUl7J8zNsv/Listeners', 04:38:10 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 04:38:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:10 INFO - 'USER': 'cltbld', 04:38:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:10 INFO - 'XPC_FLAGS': '0x0', 04:38:10 INFO - 'XPC_SERVICE_NAME': '0', 04:38:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:10 INFO - Downloading/unpacking jsonschema==2.5.1 04:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:38:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:13 INFO - Downloading functools32-3.2.3-2.tar.gz 04:38:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:38:13 INFO - warning: no files found matching '*.txt' 04:38:13 INFO - no previously-included directories found matching 'build' 04:38:13 INFO - no previously-included directories found matching 'dist' 04:38:13 INFO - no previously-included directories found matching '.git*' 04:38:13 INFO - Installing collected packages: jsonschema, functools32 04:38:13 INFO - Running setup.py install for functools32 04:38:14 INFO - warning: no files found matching '*.txt' 04:38:14 INFO - no previously-included directories found matching 'build' 04:38:14 INFO - no previously-included directories found matching 'dist' 04:38:14 INFO - no previously-included directories found matching '.git*' 04:38:14 INFO - Successfully installed jsonschema functools32 04:38:14 INFO - Cleaning up... 04:38:14 INFO - Return code: 0 04:38:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:38:14 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')]} 04:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:14 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')]} 04:38:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:14 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 0x106a72b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a75768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c5bccbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106850d30>, '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 0x106777db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106845be8>, '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.sZ6m2fj9zC/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.DUl7J8zNsv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 04:38:14 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 04:38:14 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 04:38:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sZ6m2fj9zC/Render', 04:38:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:14 INFO - 'HOME': '/Users/cltbld', 04:38:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:14 INFO - 'LOGNAME': 'cltbld', 04:38:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:14 INFO - 'MOZ_NO_REMOTE': '1', 04:38:14 INFO - 'NO_EM_RESTART': '1', 04:38:14 INFO - 'PAGER': '/bin/cat', 04:38:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:14 INFO - 'PWD': '/builds/slave/test', 04:38:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:14 INFO - 'SHELL': '/bin/bash', 04:38:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DUl7J8zNsv/Listeners', 04:38:14 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 04:38:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:14 INFO - 'USER': 'cltbld', 04:38:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:14 INFO - 'XPC_FLAGS': '0x0', 04:38:14 INFO - 'XPC_SERVICE_NAME': '0', 04:38:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:38:14 INFO - Cleaning up... 04:38:14 INFO - Return code: 0 04:38:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:38:14 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')]} 04:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:14 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')]} 04:38:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:14 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 0x106a72b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a75768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c5bccbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106850d30>, '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 0x106777db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106845be8>, '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.sZ6m2fj9zC/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.DUl7J8zNsv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 04:38:14 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 04:38:14 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 04:38:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sZ6m2fj9zC/Render', 04:38:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:14 INFO - 'HOME': '/Users/cltbld', 04:38:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:14 INFO - 'LOGNAME': 'cltbld', 04:38:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:14 INFO - 'MOZ_NO_REMOTE': '1', 04:38:14 INFO - 'NO_EM_RESTART': '1', 04:38:14 INFO - 'PAGER': '/bin/cat', 04:38:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:14 INFO - 'PWD': '/builds/slave/test', 04:38:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:14 INFO - 'SHELL': '/bin/bash', 04:38:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DUl7J8zNsv/Listeners', 04:38:14 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 04:38:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:14 INFO - 'USER': 'cltbld', 04:38:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:14 INFO - 'XPC_FLAGS': '0x0', 04:38:14 INFO - 'XPC_SERVICE_NAME': '0', 04:38:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:14 INFO - Downloading/unpacking blobuploader==1.2.4 04:38:14 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 04:38:14 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 04:38:14 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 04:38:14 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 04:38:14 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 04:38:14 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 04:38:17 INFO - Downloading blobuploader-1.2.4.tar.gz 04:38:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:38:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:38:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:38:18 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 04:38:18 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 04:38:18 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 04:38:18 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 04:38:18 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 04:38:18 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 04:38:18 INFO - Downloading docopt-0.6.1.tar.gz 04:38:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:38:18 INFO - Installing collected packages: blobuploader, requests, docopt 04:38:18 INFO - Running setup.py install for blobuploader 04:38:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:38:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:38:18 INFO - Running setup.py install for requests 04:38:19 INFO - Running setup.py install for docopt 04:38:19 INFO - Successfully installed blobuploader requests docopt 04:38:19 INFO - Cleaning up... 04:38:19 INFO - Return code: 0 04:38:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:19 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 0x106a72b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a75768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c5bccbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106850d30>, '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 0x106777db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106845be8>, '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.sZ6m2fj9zC/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.DUl7J8zNsv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 04:38:19 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 04:38:19 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 04:38:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sZ6m2fj9zC/Render', 04:38:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:19 INFO - 'HOME': '/Users/cltbld', 04:38:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:19 INFO - 'LOGNAME': 'cltbld', 04:38:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:19 INFO - 'MOZ_NO_REMOTE': '1', 04:38:19 INFO - 'NO_EM_RESTART': '1', 04:38:19 INFO - 'PAGER': '/bin/cat', 04:38:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:19 INFO - 'PWD': '/builds/slave/test', 04:38:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:19 INFO - 'SHELL': '/bin/bash', 04:38:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DUl7J8zNsv/Listeners', 04:38:19 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 04:38:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:19 INFO - 'USER': 'cltbld', 04:38:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:19 INFO - 'XPC_FLAGS': '0x0', 04:38:19 INFO - 'XPC_SERVICE_NAME': '0', 04:38:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:38:19 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-9Cs84o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:38:19 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-rbRJue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:38:19 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-His2E6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:38:20 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-0Utq7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:38:20 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-5JXFzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:38:20 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-GR58Qc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:38:20 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-i9fOX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:38:20 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-PxtK96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:38:20 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-emuy7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:38:20 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-kA1qPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:38:20 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-bzF1Gu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:38:20 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-GhQ_wL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:38:21 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-hdeN8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:38:21 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-tWH4u6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:21 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-d_wRFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:38:21 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-Omn6Lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:38:21 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-IU5Ayu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:38:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:38:21 INFO - Running setup.py install for manifestparser 04:38:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:38:21 INFO - Running setup.py install for mozcrash 04:38:21 INFO - Running setup.py install for mozdebug 04:38:22 INFO - Running setup.py install for mozdevice 04:38:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:38:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:38:22 INFO - Running setup.py install for mozfile 04:38:22 INFO - Running setup.py install for mozhttpd 04:38:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:38:22 INFO - Running setup.py install for mozinfo 04:38:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:38:22 INFO - Running setup.py install for mozInstall 04:38:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:38:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:38:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:38:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:38:22 INFO - Running setup.py install for mozleak 04:38:22 INFO - Running setup.py install for mozlog 04:38:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:38:23 INFO - Running setup.py install for moznetwork 04:38:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:38:23 INFO - Running setup.py install for mozprocess 04:38:23 INFO - Running setup.py install for mozprofile 04:38:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:38:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:38:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:38:23 INFO - Running setup.py install for mozrunner 04:38:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:38:23 INFO - Running setup.py install for mozscreenshot 04:38:23 INFO - Running setup.py install for moztest 04:38:24 INFO - Running setup.py install for mozversion 04:38:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:38:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:38:24 INFO - Cleaning up... 04:38:24 INFO - Return code: 0 04:38:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:38:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:24 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 0x106a72b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a75768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c5bccbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106850d30>, '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 0x106777db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106845be8>, '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.sZ6m2fj9zC/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.DUl7J8zNsv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 04:38:24 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 04:38:24 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 04:38:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sZ6m2fj9zC/Render', 04:38:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:24 INFO - 'HOME': '/Users/cltbld', 04:38:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:24 INFO - 'LOGNAME': 'cltbld', 04:38:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:24 INFO - 'MOZ_NO_REMOTE': '1', 04:38:24 INFO - 'NO_EM_RESTART': '1', 04:38:24 INFO - 'PAGER': '/bin/cat', 04:38:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:24 INFO - 'PWD': '/builds/slave/test', 04:38:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:24 INFO - 'SHELL': '/bin/bash', 04:38:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DUl7J8zNsv/Listeners', 04:38:24 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 04:38:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:24 INFO - 'USER': 'cltbld', 04:38:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:24 INFO - 'XPC_FLAGS': '0x0', 04:38:24 INFO - 'XPC_SERVICE_NAME': '0', 04:38:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:38:24 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-YZnH_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:38:24 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)) 04:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:38:24 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-6bwG8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:38:24 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)) 04:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:38:24 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-2Lwn5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:38:24 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)) 04:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:38:24 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-f03mkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:38:24 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)) 04:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:38:24 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-a1E8AN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:38:25 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)) 04:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:38:25 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-2lIACZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:38:25 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)) 04:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:38:25 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-5fZWfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:38:25 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)) 04:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:38:25 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-DKZKsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:38:25 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)) 04:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:38:25 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-G0Rf_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:38:25 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)) 04:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:38:25 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-bor4Se-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:38:25 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)) 04:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:38:25 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-rNRM0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:38:25 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)) 04:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:38:25 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-xdwJ00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:38:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:38:25 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-xLZB6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:38:25 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)) 04:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:38:25 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-a0b_z6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:38:26 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)) 04:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:26 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-oU1CBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:26 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)) 04:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:38:26 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-DRZvve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:38:26 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)) 04:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:38:26 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-pix4WW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:38:26 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)) 04:38:26 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)) 04:38:26 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)) 04:38:26 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)) 04:38:26 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)) 04:38:26 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)) 04:38:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38:28 INFO - Downloading blessings-1.6.tar.gz 04:38:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:38:29 INFO - Installing collected packages: blessings 04:38:29 INFO - Running setup.py install for blessings 04:38:29 INFO - Successfully installed blessings 04:38:29 INFO - Cleaning up... 04:38:29 INFO - Return code: 0 04:38:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:38:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:38:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:38:29 INFO - Reading from file tmpfile_stdout 04:38:29 INFO - Current package versions: 04:38:29 INFO - blessings == 1.6 04:38:29 INFO - blobuploader == 1.2.4 04:38:29 INFO - docopt == 0.6.1 04:38:29 INFO - functools32 == 3.2.3-2 04:38:29 INFO - jsonschema == 2.5.1 04:38:29 INFO - manifestparser == 1.1 04:38:29 INFO - mozInstall == 1.12 04:38:29 INFO - mozcrash == 1.0 04:38:29 INFO - mozdebug == 0.1 04:38:29 INFO - mozdevice == 0.49 04:38:29 INFO - mozfile == 1.2 04:38:29 INFO - mozhttpd == 0.7 04:38:29 INFO - mozinfo == 0.9 04:38:29 INFO - mozleak == 0.1 04:38:29 INFO - mozlog == 3.4 04:38:29 INFO - moznetwork == 0.27 04:38:29 INFO - mozprocess == 0.24 04:38:29 INFO - mozprofile == 0.28 04:38:29 INFO - mozrunner == 6.13 04:38:29 INFO - mozscreenshot == 0.1 04:38:29 INFO - mozsystemmonitor == 0.3 04:38:29 INFO - moztest == 0.8 04:38:29 INFO - mozversion == 1.4 04:38:29 INFO - psutil == 3.1.1 04:38:29 INFO - requests == 1.2.3 04:38:29 INFO - wsgiref == 0.1.2 04:38:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:38:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:29 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 0x106a72b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a75768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c5bccbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106850d30>, '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 0x106777db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106845be8>, '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.sZ6m2fj9zC/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.DUl7J8zNsv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 04:38:29 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 04:38:29 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 04:38:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sZ6m2fj9zC/Render', 04:38:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:29 INFO - 'HOME': '/Users/cltbld', 04:38:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:29 INFO - 'LOGNAME': 'cltbld', 04:38:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:29 INFO - 'MOZ_NO_REMOTE': '1', 04:38:29 INFO - 'NO_EM_RESTART': '1', 04:38:29 INFO - 'PAGER': '/bin/cat', 04:38:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:29 INFO - 'PWD': '/builds/slave/test', 04:38:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:29 INFO - 'SHELL': '/bin/bash', 04:38:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DUl7J8zNsv/Listeners', 04:38:29 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 04:38:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:29 INFO - 'USER': 'cltbld', 04:38:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:29 INFO - 'XPC_FLAGS': '0x0', 04:38:29 INFO - 'XPC_SERVICE_NAME': '0', 04:38:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:29 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)) 04:38:29 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)) 04:38:29 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)) 04:38:29 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)) 04:38:29 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)) 04:38:29 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)) 04:38:29 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)) 04:38:29 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)) 04:38:29 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)) 04:38:29 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)) 04:38:29 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)) 04:38:29 INFO - Cleaning up... 04:38:29 INFO - Return code: 0 04:38:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:38:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:29 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 0x106a72b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a75768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c5bccbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106850d30>, '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 0x106777db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106845be8>, '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.sZ6m2fj9zC/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.DUl7J8zNsv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 04:38:29 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 04:38:29 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 04:38:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sZ6m2fj9zC/Render', 04:38:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:29 INFO - 'HOME': '/Users/cltbld', 04:38:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:29 INFO - 'LOGNAME': 'cltbld', 04:38:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:29 INFO - 'MOZ_NO_REMOTE': '1', 04:38:29 INFO - 'NO_EM_RESTART': '1', 04:38:29 INFO - 'PAGER': '/bin/cat', 04:38:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:29 INFO - 'PWD': '/builds/slave/test', 04:38:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:29 INFO - 'SHELL': '/bin/bash', 04:38:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DUl7J8zNsv/Listeners', 04:38:29 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 04:38:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:29 INFO - 'USER': 'cltbld', 04:38:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:29 INFO - 'XPC_FLAGS': '0x0', 04:38:29 INFO - 'XPC_SERVICE_NAME': '0', 04:38:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:38:30 INFO - Cleaning up... 04:38:30 INFO - Return code: 0 04:38:30 INFO - Running post-action listener: _resource_record_post_action 04:38:30 INFO - Running post-action listener: _start_resource_monitoring 04:38:30 INFO - Starting resource monitoring. 04:38:30 INFO - [mozharness: 2017-04-09 11:38:30.202262Z] Finished create-virtualenv step (success) 04:38:30 INFO - [mozharness: 2017-04-09 11:38:30.203239Z] Running install step. 04:38:30 INFO - Running pre-action listener: _resource_record_pre_action 04:38:30 INFO - Running main action method: install 04:38:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:38:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:38:30 INFO - Reading from file tmpfile_stdout 04:38:30 INFO - Detecting whether we're running mozinstall >=1.0... 04:38:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:38:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:38:30 INFO - Reading from file tmpfile_stdout 04:38:30 INFO - Output received: 04:38:30 INFO - Usage: mozinstall [options] installer 04:38:30 INFO - Options: 04:38:30 INFO - -h, --help show this help message and exit 04:38:30 INFO - -d DEST, --destination=DEST 04:38:30 INFO - Directory to install application into. [default: 04:38:30 INFO - "/builds/slave/test"] 04:38:30 INFO - --app=APP Application being installed. [default: firefox] 04:38:30 INFO - mkdir: /builds/slave/test/build/application 04:38:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:38:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 04:38:45 INFO - Reading from file tmpfile_stdout 04:38:45 INFO - Output received: 04:38:45 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 04:38:45 INFO - Running post-action listener: _resource_record_post_action 04:38:45 INFO - [mozharness: 2017-04-09 11:38:45.238048Z] Finished install step (success) 04:38:45 INFO - [mozharness: 2017-04-09 11:38:45.238211Z] Running run-tests step. 04:38:45 INFO - Running pre-action listener: _resource_record_pre_action 04:38:45 INFO - Running main action method: run_tests 04:38:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:38:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:38:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:38:45 INFO - 2017-04-09 04:38:45.252 screenresolution[1939:20838] starting screenresolution argv=screenresolution get 04:38:45 INFO - 2017-04-09 04:38:45.254 screenresolution[1939:20838] Display 0: 1600x1200x32@60 04:38:45 INFO - 2017-04-09 04:38:45.259 screenresolution[1940:20840] starting screenresolution argv=screenresolution list 04:38:45 INFO - Available Modes on Display 0 04:38:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:38:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:38:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:38:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:38:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:38:45 INFO - Intel Iris: 04:38:45 INFO - Chipset Model: Intel Iris 04:38:45 INFO - Type: GPU 04:38:45 INFO - Bus: Built-In 04:38:45 INFO - VRAM (Dynamic, Max): 1536 MB 04:38:45 INFO - Vendor: Intel (0x8086) 04:38:45 INFO - Device ID: 0x0a2e 04:38:45 INFO - Revision ID: 0x0009 04:38:45 INFO - Displays: 04:38:45 INFO - Display: 04:38:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:38:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:38:45 INFO - Display Serial Number: 1600x1200 60 04:38:45 INFO - Main Display: Yes 04:38:45 INFO - Mirror: Off 04:38:45 INFO - Online: Yes 04:38:45 INFO - Rotation: Supported 04:38:45 INFO - Return code: 0 04:38:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:38:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:38:45 INFO - Python 2.7.3 04:38:45 INFO - Return code: 0 04:38:45 INFO - grabbing minidump binary from tooltool 04:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:38:45 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 0x106850d30>, '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 0x106777db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106845be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:38:45 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 04:38:45 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 04:38:45 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 04:38:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:38:45 INFO - Return code: 0 04:38:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:38:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:38:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:38:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:38:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:38:45 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/PJTq_tAQRwOtLE9ww20l9g/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0100', '--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 04:38:45 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/PJTq_tAQRwOtLE9ww20l9g/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0100 --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 04:38:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sZ6m2fj9zC/Render', 04:38:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:45 INFO - 'HOME': '/Users/cltbld', 04:38:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:45 INFO - 'LOGNAME': 'cltbld', 04:38:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:38:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:45 INFO - 'MOZ_NO_REMOTE': '1', 04:38:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:38:45 INFO - 'NO_EM_RESTART': '1', 04:38:45 INFO - 'PAGER': '/bin/cat', 04:38:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:45 INFO - 'PWD': '/builds/slave/test', 04:38:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:38:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:45 INFO - 'SHELL': '/bin/bash', 04:38:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DUl7J8zNsv/Listeners', 04:38:45 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 04:38:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:45 INFO - 'USER': 'cltbld', 04:38:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:45 INFO - 'XPC_FLAGS': '0x0', 04:38:45 INFO - 'XPC_SERVICE_NAME': '0', 04:38:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:45 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/PJTq_tAQRwOtLE9ww20l9g/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0100', '--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 04:38:45 INFO - mozversion application_buildid: 20170409035521 04:38:45 INFO - mozversion application_changeset: ee82facc7b9f03611b7a8c9e39f31168095ff7eb 04:38:45 INFO - mozversion application_display_name: Firefox 04:38:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:38:45 INFO - mozversion application_name: Firefox 04:38:45 INFO - mozversion application_remotingname: firefox 04:38:45 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:38:45 INFO - mozversion application_vendor: Mozilla 04:38:45 INFO - mozversion application_version: 53.0 04:38:45 INFO - mozversion platform_buildid: 20170409035521 04:38:45 INFO - mozversion platform_changeset: ee82facc7b9f03611b7a8c9e39f31168095ff7eb 04:38:45 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:38:45 INFO - mozversion platform_version: 53.0 04:38:45 INFO - using testdate: 1491737925 04:38:45 INFO - actual date: 1491737925 04:38:45 INFO - starting webserver on 'localhost:54648' 04:38:45 INFO - SUITE-START | Running 2 tests 04:38:45 INFO - TEST-START | dromaeo_css 04:38:45 INFO - operating with platform_type : mac_ 04:38:45 INFO - Initialising browser for dromaeo_css test... 04:38:45 INFO - TEST-INFO | started process 1950 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpWICOrH/profile http://localhost:54648/getInfo.html) 04:38:48 INFO - PROCESS | 1950 | __metrics Screen width/height:1600/1200 04:38:48 INFO - PROCESS | 1950 | colorDepth:24 04:38:48 INFO - PROCESS | 1950 | Browser inner width/height: 1024/689 04:38:48 INFO - PROCESS | 1950 | __metrics 04:38:48 INFO - PROCESS | 1950 | 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" 04:38:48 INFO - PROCESS | 1950 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:38:48 INFO - TEST-INFO | 1950: exit 0 04:38:48 INFO - Browser initialized. 04:38:48 INFO - Running cycle 1/1 for dromaeo_css test... 04:38:48 INFO - TEST-INFO | started process 1953 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpWICOrH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:39:01 INFO - PROCESS | 1953 | RSS: Main: 163459072 04:39:01 INFO - PROCESS | 1953 | 04:42:04 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:54648/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54648/tests/dromaeo/cssquery-ext.html) 04:42:06 INFO - PROCESS | 1953 | RSS: Main: 340254720 04:42:06 INFO - PROCESS | 1953 | 04:45:09 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:54648/tests/dromaeo/cssquery-ext.html (next: http://localhost:54648/tests/dromaeo/cssquery-jquery.html) 04:45:09 INFO - PROCESS | 1953 | RSS: Main: 307404800 04:45:09 INFO - PROCESS | 1953 | 04:48:11 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:54648/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54648/tests/dromaeo/cssquery-mootools.html) 04:48:12 INFO - PROCESS | 1953 | RSS: Main: 289681408 04:48:12 INFO - PROCESS | 1953 | 04:51:14 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:54648/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54648/tests/dromaeo/cssquery-prototype.html) 04:51:15 INFO - PROCESS | 1953 | RSS: Main: 291962880 04:51:15 INFO - PROCESS | 1953 | 04:54:18 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:54648/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54648/tests/dromaeo/cssquery-yui.html) 04:54:19 INFO - PROCESS | 1953 | RSS: Main: 265924608 04:54:19 INFO - PROCESS | 1953 | 04:57:22 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:54648/tests/dromaeo/cssquery-yui.html (next: http://localhost:54648/tests/dromaeo/cssquery-dojo.html) 04:57:22 INFO - PROCESS | 1953 | RSS: Main: 312082432 04:57:22 INFO - PROCESS | 1953 | 04:57:22 INFO - PROCESS | 1953 | __start_tp_report 04:57:22 INFO - PROCESS | 1953 | _x_x_mozilla_page_load 04:57:22 INFO - PROCESS | 1953 | _x_x_mozilla_page_load_details 04:57:22 INFO - PROCESS | 1953 | |i|pagename|runs| 04:57:22 INFO - PROCESS | 1953 | |0;dojo.html;3363.4114030044734;3502.2295095079076;3514.82425878706;3518.0852978225653;3559;5825.970870145648;5902.586818922677;5941.7029148542615;5947.970260148699;5951.494122999539;5810.970945145279;5883.117532370146;5998.88002239956;5999.100134979755;5999.640021598707;5305.973470132644;5316.654417462872;5356.288857006216;5425.945740542584;5432.548510229587;4468.352088947101;5252.290940722992;5252.395974462947;5257.86855328616;5412.296401467804;5308.628396012281;5364.758585863626;5372.811951581695;5401.810936617219;5416.079266524681;5385.057614917393;5398.676079435247;5400.513953744143;5400.891982160374;5410.188471729272;5204.713740744258;5260.395054568697;5322.680639161663;5334.946650533484;5402.648827826179;5783.62406443584;5814.418558144152;5863.442972917566;5902.8819423611285;5930.911036334458;6296.68516574174;6350.206224221973;6352.872942541169;6361.173047503795;6386.329435409261;4937.580305674022;6304.022876454157;6362.172917520739;6376.107344971708;6414.198225221848;5887.941120588825;5975;5983.790567330209;6035.064564992434;6128.938710612926;6459.192600924885;6509.641969691617;6559.704813283413;6568.67156642166;6576.671166441659;5176.534111929945;6329.651869147149;6340.714667839959;6358.904616430757;6359.491240700733;6288.622682639057;6304;6362.618242905441;6370.235571731329;6378.74485020594;5251.553617942442;6304.747810087545;6312.558120931582;6341.302456729756;6359.745610175633;6322.9051564226575;6334.049892516067;6335.809925702144;6339.144215530937;6355.745770169141;5075.847724568269;5169.663971841818;5186.818461353834;5190.792368305301;5202.401723801736;4559.316102584573;4580.839670611513;4595.471520775153;4631.421072365954;4660;6062.484688801413;6062.878742425127;6065.939340606537;6071.089336599545;6077.969610151921;6296.087067375205;6309.179806625201;6316.178896743394;6316.715747791361;6345.270293916166;6016.1878146450545;6062.454379105813;6068.878622427526;6095.329513753572;6126.326104128542;5670.603057785916;5677.801276955287;5701.144828275709;5701.657900525982;5716.142578613241;6556.626086090553;6569;6579.506537009744;6600.438962688129;6604.933950660528;6292.685365731787;6349.746010159727;6366.5225108118;6367.490600752021;6380.170577824853;6457.773977910939;6477.319881412573;6498.642574658439;6544.28012918569;6582.506312026521;6373.298937117006;6376.139221205078;6383.489320854414;6395.97664373698;6397.232332120176;6355.491560675227;6359.777407790705;6380;6380.649064301508;6387.712552935222;6057.42454466825;6137.171481849893;6214.25428948529;6259;6299.086632438362;6344.429001389897;6345.17512723343;6361.745530178741;6365.077063825812;6367.93632063692;6192.164057852132;6194.163787888578;6228.314885362697;6257.092721555258;6259.561830671809;6214.378562143749;6244.438000579969;6253.155823963707;6272.968635156795;6343.365663433619;6223.253209614875;6245.344238854855;6255.030470277115;6259.78090766821;6270.937290627217 04:57:22 INFO - PROCESS | 1953 | |1;ext.html;470.6093942028117;476.2356417949194;479.4414507099227;515.9509846564576;524.7507433968865;33338.166545836335;33831.66168338322;34049.319013619745;34070.318593628115;41204.79397603015;45135;45327.09345813082;45530.317045244345;45652.543474565326;45790.77104614481;9475.147236748691;9523.190528805042;9534.427934323929;9737.367071140388;9751.707448776548;9031.774205644879;9236.6305347786;9623;9757.560909759042;9767.560459779292;11730.824037639442;11942.641720748348;11955.940220298886;12110.697232569211;12165.513379464855;10062.144717698968;11921.821172682417;12017.87982120185;12018.278903265833;12048.939755301168;11555;11602.477888495037;11651.475683594259;11654.417279136009;11667.299962002307;41661.79169104135;41893.95265118366;41950.79024604857;41966.58033419657;42172.36741448881;4050.9594904050878;4111.814968326433;4115.218108559364;4128.710990230685;4142.875713728593;29690.703092969008;30336.938207162864;31238.843805781053;31311;32148.87478938226;3295.0114965510493;3328.8502017409032;3457.6369481204615;3502.036939841564;3512.262424890776;517188;519363;526568;526997;528252;58291.4170858286;59250.40749592535;60251;60634.69682651559;60667;63501.68249158725;63614.68192659007;63628.36371636224;63651;63724.044139337944;16607.252673629715;16754.07852568096;16810.495685129466;16815.075170865475;16846.32614695423;12994.935025324812;13050.54323098687;13054.869451305365;13073.280969546577;13102.410391532403;16240.431584894472;16623.584410389594;16673.999120105665;16840.005440449877;18773;7198.7840364789145;7625.389968802482;7698.461107722517;9120.58957346921;9215.124563166488;812.5937031484258;890.6481939633809;905.2260317428635;918.6233644205844;952.4618590496348;31420.057398278088;31604.683953160173;31734.523982140287;32056;32205.838970804994;1080.8702955645215;1086.4241951765578;1110.5446766825723;1114.1810769084716;1137.7496950670838;15177.6205594861;16391.83608163927;16420.1789910504;16618.919770214896;16736.916315418588;692398;695709;696739.5163024153;696819;698277;54644.45355546473;55548;63834.6808265965;64567.677161613894;64875;1455.8398576156615;1479.9186044767425;1490.3293517917198;1499.895007349475;1500.3248538157873;28691.029966165035;30536.236594085327;31612.683873160975;32213.677863221066;32704.67295327016;52652.21021684755;53201.99999999845;53283.46716532785;53286.66783330448;53443.465565343846;597897;784890;789785;790086;791677;28287.57568636431;28451.430971380043;28652;29432.55851162277;29476.557851631813;48877.2668409967;48882;48924;49756.75121624369;49815.50553483401;32832.1791955203;33481.49333280057;33718.325633486704;33763.98708038664;34039.829800850835;25954.610680840182;33566.83216583901;34007.659923400446;34378;34571;38914;39779.801100995464;40273.798631006655;40574.78275651735;40623.79688101659;33610.159746006546;33830.15424614404;34201;34220.82889585536;34251.82874085614;21756.564868702855;25356.746432535438;26011.869940650176;26162.476750464502;26210.344741381617 04:57:22 INFO - PROCESS | 1953 | |2;jquery.html;342.4025076241957;407.2140768317147;412.19210347718473;414.5440015982419;444.5754304639068;21076;21505.81718005509;21999.450013749665;22155.667664985038;22397.776022239774;22843.428914277152;22863.199788007423;22896.542069158608;23036.19373321934;23081.192158274465;6031.366706495832;6350.396712312323;6354.205724284465;6360.7455701772105;6379.5853269537565;5968.820935371946;6204.906926396107;6253.468455181315;6272.498200143978;6336.493080553568;6309.4636955858805;6311.558190926614;6312.779052733155;6319.273283572379;6324.968375158118;5825.679587622679;7024.89462658058;7058.682359293793;7065.540739851893;7076.504644674875;6020.6989650517735;6160.722767475474;6227.595206311576;6246.15676883624;6269.090981807658;14070.2964851757;14073.366698498592;14130.646733831634;14297.927655425885;14350.569482915529;2626.5534859074005;2702.7972902032425;2746.1075150576144;2746.3408781892404;2747.5603903375363;10303.690889273334;10873.293235939638;10957.671269861838;12549.058820588492;15616.843831561653;1499.8575135362123;1909.8749782516895;1924.3072493902184;1927.9036048197675;1938.3022112039655;111675;122328;124079;124761;127800.99999999907;9917.702468925943;10425.270231083903;11785.762494938079;11962.72708185442;12233.388330583435;16212.59468513273;16490.505284841474;16564;16580.502584922473;16597.58506037359;8604.268637165786;8857.158569935846;8900.42147260426;8997.100289971082;9056.230220431336;6792.3886850182735;8169.101398846122;8539.231469167804;8638.358711844729;8735.51954642488;4890.413150421972;4980.576650984634;4986.675866068694;4996.350474438373;5094.592432605383;1665.9083750393602;1957.6182644384494;2023.2802118199413;2034.6235946349677;2058.9176432942513;1005.4821766790109;1017.898210178991;1031.5358088860044;1043.087298613713;1053.899879511445;22528;23075.653865192035;23088.422789430064;23195.188168414024;23597.764022359555;1049.8477720730452;1057.645688694296;1060.3743791163251;1097.4183682648209;1109.7835921995134;11044.668659940215;11390.202685811913;11792.70518237051;11877.58428455;12080.87919120815;400421;426489;701369;710347;713784;153931;154154;155380.44619553658;156054;165210;933.6172169410509;1028.156911332715;1049.8477720730605;1074.4412905289205;1077.6443773554709;19419.51451213731;19739.901300493406;19841;19899.60200796005;19910.50223744418;57912.710436447545;59190.40809592021;59788.70105649618;60162;60593;85806.57096714477;87735;88090;90194.54902725444;91118.08881911096;8297.834043318979;8357.080721120794;8475.406721529434;8683.696070637498;8911.643534258816;9718.416894986323;10769.461526923465;12843.229406235656;13222.669433264246;13265;11246.775064498828;11262;11295.661130166109;11737.706557335794;11838.230515016496;10467.110295624652;10481.475926203811;10757.354558726502;10887.945560272148;11016.339019658846;11513;11559.479823407799;11636.650900473;11911.166218364979;11952.402379880798;8401.201885820838;8537.359698022548;8571.100034496289;8659.610317535851;8662.263707584674;8819.559022048743;11173;11249;11473.713157171138;11672.88327116718 04:57:22 INFO - PROCESS | 1953 | |3;mootools.html;1370;1456.1845366594707;1473.9778903316453;1477.3721168503387;1483.6513419346454;7663.5785031823225;8010.0788409332945;8028.197180281969;8034.718784842532;8046.557439340834;8243.258106770389;8418.031926328475;8484.787880302996;8607.053224145355;8615.483071015728;2382.1186161120368;2419.2863105383867;2419.588669926108;2421.7820396164343;2424;2107.2203284784573;2370.182287110944;2432.805375569959;2440.048381131351;2443.4502236996623;2138.6791981202787;2324.76752324767;2401.363638635763;2410.337157281744;2416.2630397728685;2362.4684445999683;2382.0828980842325;2388.6894703688495;2389.940251493709;2391.5695174868515;2409.3856066703056;2432.8200822601025;2436.0012394918176;2437.7440368761204;2439.9756002440104;8383.790405239857;8570.357223208222;8577.142285771373;8589.44168629037;8651.221390074923;5225.843224703265;5369.382521010095;5379.731013449312;5388.110961691316;5390.380106287788;3383.6278009418943;3500.2124521982605;3640.799756013418;3691.446283057563;3713.220223753015;1214.6416807041944;1256.1269917407406;1290.7224946636518;1308.2804457548405;1316.7037416581288;11102.44487775608;11164.497597608128;11172.664820055492;11178.664640060812;11179.608713695063;4019.8995025124023;4021.678265738734;4480.462344518679;4765.237561990065;4828.782704778293;9732.854007189897;9770.316077874622;9806.75483112928;9812.116909478182;9844.163246124017;5333.973330133324;5427.050266203399;5440.727963601804;5455.972720136453;5467.316585426822;4762.571368576775;4857.101436234308;4939.3084968104495;4963.875903102451;4977.552020318189;3943.7042221833476;3989.4614227078973;4012.057166565855;4054.959450405517;4073.572274911151;1210.9212901161397;1301.7656821771982;1303.8370203724535;1312.901532385075;1315.651352391617;702.7224246422635;915.3958387464241;929.7954450020984;939.6523286384082;1009.6012075230243;5613.691246981455;5807.680577568274;5905.4685078343155;5962.195103661037;6091;882.250087425683;1000.7097941596855;1011.4790882695418;1030.7732298894232;1061.4109169410897;3726.552813662324;3888.183481468867;3926.3521518949055;3947.0527073502153;4048.7368321059625;7721.498102623312;10185.592576296865;10294.639687610897;10306.227032972558;10328.741781455374;10044.949775251076;10277.845832312521;10282.126019288295;10283.228757843042;10305.433201173857;7741.651625676858;8041.6381262843315;8057.717979870794;8063.556504392314;8065.717699880476;5596.748146333506;5600.85997850057;5620.915686264628;5724.341700704473;5792.82621521355;9353.158215760614;9497.715068547956;9500.287478439282;9512.191463725385;9515.952420237854;9367;9494.192993595345;9589.568469419033;9651.227901767983;9771.511424428892;6866.862662746817;6999.12510936133;7001.334873187039;7007.579545227302;7009.579425234502;8068.1528439513;8124.106348301564;8130.983627046619;8131;8180.509169449852;6920.342567456084;6954.374106330252;7093.964530177523;7150.678219480032;7153;6953.895691564529;6987.091678081817;7001.194862590867;7014.859702806018;7033.859322813618;6339.5562310637815;6458.806235812933;6475.222973243241;6521.119648847534;6567.507436942153;4759.547842954914;4829.613630909448;4830.806767729392;4904.950950490449;4946.134426475424;5026.472220416804;5065.974670126626;5145.459726728789;5219.4780521947505;5241.08281050807 04:57:22 INFO - PROCESS | 1953 | |4;prototype.html;361.5137639874369;363.5873283822862;372.78937400368795;379.50474630607044;379.72090513472574;4882.780274887629;5522.861928451791;5557.833265002051;5565.469495888633;5630.380658127608;5240.240165176047;5262.947410517892;5291.550218231455;5382.703951282678;5388.865278368043;3666.578343490493;4203.07532342884;4233.597808208216;4312.611864932155;4324.11355672088;4241.491021077475;4243.766592837393;4277.700560960734;4280.828766849338;4313.28830742927;3222.6616205298455;3864.9613503864884;4099.979500102495;4105.938410923838;4119.711620186588;3352.597688277398;3478.165240342325;3605.242898991202;3952.023988005997;3957.920841583181;3089.8609562569736;3447.1554469154967;3515.2793677296095;3532.717382609411;3540.4689296605716;5059.74701264939;5082.74586270685;5235.869103272411;5251.505534870944;5282.313299271109;4475.165182275252;4693.7653117344;4694.57748802606;4721.1908914196;4767.451743049524;5598.5086636446795;5685.260916080924;5750.683712395817;5758.280214973129;5765.740541675593;3166.4458719723957;3469.8612055517747;3727.403615421547;3940.389239667856;3976.681865450757;5856.590038697293;6011.48902343297;6041.577089603729;6041.8187454376875;6078.574499785017;3408.8694565896317;3768.1898391845884;3960.742551734128;3961.7028722845903;3974.6224108709625;4052.3313653247474;4089.754614723126;4100.528439229467;4103.384492326175;4115.650169735606;4432.778361081933;4700.506446823103;4707.835225767081;4716.339712440261;4749.810007599726;4656.905627177611;5294.7617357219015;5559.944400555943;5826.650400975955;5871.383504732027;1159.1596092832629;1245.078641805076;1320.5510126556824;1326.1843965961057;1351.1624191100095;846.517485033525;879.4547380623926;888.8311220868014;899.0335389456361;906.4561263242002;5044.798208071636;5097.745112744348;5107.87230319245;5154.742262886841;5221.32122824038;5287;5396.83809485716;5611.551075913917;5648.717564121777;5708.400617935057;4843.878903027453;5021.221710634784;5073.51397815068;5073.568746656576;5184.366924418796;2675.665541807274;2926.6391128125524;2930.794844360917;2932.5601159826197;2956.8521573921216;5223.2948551945;5691.8861622768145;5817.818318130701;5882.646941223459;6078.635281883013;5545.417731138253;5613.943860561424;6089.142811442464;6100.267967843887;6159.29168145669;6179.794939986749;6191.318954914956;6224;6276;6289.433950944345;5166.715830629351;5225.546450134158;5929.673867937305;5971.880562388641;6000.189974353407;4925.285833554186;5291.550218231339;5627.803026894039;5950.583459157818;5979.312379076462;5890.587658863838;6073.635581865102;6143.416375444325;6150.538709596887;6289.96855015722;3336.3485074887117;3683.392240280431;3992.3688521315134;4018.598140185958;4030;5070.605583464577;5190.506901844319;5710.716338105689;5993.760249590142;6023.578349515492;5403.540699040625;5664.26364572603;5698.515626171822;5724.914126288192;5845.736941837543;4957.950420495749;5778.942210578009;5820.679862607597;5823.82528524145;5839.854003649943;5245.291885595396;5323.414424413234;5596.244506991504;5663.235463212413;5783.306003279633;5303.904957541827;5395.406505284494;5410.8637186191345;5428.118894990101;5747.965366234118;5013.924791128063;5661.18841970582;5718.22803921482;5722.914156287576;5747.275687445615 04:57:22 INFO - PROCESS | 1953 | |5;yui.html;733.2008111158835;773.3928865840317;798.269583331252;865.5109862927446;879.5250564695065;15303.158326292063;15741.60645983851;16129;16312.102834344107;16330.75503867443;12444.56444024457;14725.484608038721;14914.328855201515;15126.394944202246;15126.773098403533;907.1336873285996;917.9770505737376;918.6830543462495;918.8346097702411;926.666400095965;735.2427000189813;755.0938873351972;898.1781669772183;900.9953901399924;903.7198468474794;969.2875736333789;977.6480467031863;978.4227305889524;978.8189185000762;981.7594689301131;969.6460791811008;970.277143528069;976.1409959235898;977.3207620703614;981.3572110267714;730.5653136383896;730.6091241185993;730.6711979609197;731.3527528137637;733.2887099513464;15807.367705291774;16115.516534503866;16121.516354509384;16261.756073658904;16341.673166536602;15027.023243489139;15246.23768811555;15351.385944562204;15415.3833846646;15508.767368489482;11857.347845868473;11881.709218379137;12094.576689815902;12166.087543434278;12210.389480525939;3825.7895815730126;3835.5589107252463;3860.0542866997484;3938.3698608222835;4054.898627534306;115327;115783;116680.41659791731;117974.23038654427;119395;11561.30632162073;11808.52765889372;11944;11961.222520536137;12053.51785928553;24723.505529889662;25308;25498.745012549636;25545.489090218463;25600.615990760154;7732.536047837148;7825.295723384923;7951.165127661628;8109.675612975533;8214.4660597061;4403.141387429485;4414.3157810539415;4479.484859241164;4496.550344965477;4575.7483338416705;3571.196480791853;3671.100580357776;3673.687736542424;3677.0439685681918;3678.429843374281;644.5810223354763;682.7780971184385;683.6547543490506;685.6331862453563;686.7596341280612;635.885540602696;643.9034144878212;662.6156829039146;686.3891136888174;719.989200161998;8767.605457754416;9958.751031224278;10062;10232.693019209435;10258.58965641366;632.4971647540217;640.695669556966;687.5221720903924;696.2306651150406;706.0820932787356;4674.545337128609;4742.312364707098;4744.656291048052;4821.662483626113;4850.95149048512;79891;90918;99772.50113749385;107571;110028;73671;93120.06879931114;93395;96623.51688241654;97037;72078.27921720821;73947;74310;75195.62402188063;76358.6182069086;8964.641414343614;9056.230220431336;9110.316726245426;9121;9172.6789562365;52969.735151324;53032.93934121373;53865.73067134639;54639;55723.442765571825;70127.29872701412;71579.64210178916;71631.64184179046;72646.63676681794;74658;10963.451827408438;11287.661370158909;11303.152263580429;11977.760444791229;11999.340036298088;12061.035117190779;12116.697082573006;12210.328431936328;12259.448324825225;12719;13463.192208467523;13567.932160339134;14598.124112553282;14705.779413309023;14793.921938623584;13260.602181934557;13731.656708582366;14083.436662533384;14258.714825703635;14383.640408989859;13425.798613021008;14276.286185690466;14282.928585357007;14315;14349.713005740035;9412.247020238501;9797.118259356692;10196.745081372728;10356.844647330145;10647.414392208502;10659.520321585393;10827;11470.139739519402;11827.290362578273;11882.16824822254 04:57:22 INFO - PROCESS | 1953 | __end_tp_report 04:57:22 INFO - PROCESS | 1953 | __start_cc_report 04:57:22 INFO - PROCESS | 1953 | _x_x_mozilla_cycle_collect,1706 04:57:22 INFO - PROCESS | 1953 | __end_cc_report 04:57:22 INFO - PROCESS | 1953 | __startTimestamp1491739042429__endTimestamp 04:57:22 INFO - PROCESS | 1953 | 04:57:22 INFO - PROCESS | 1953 | ------- Summary: start ------- 04:57:22 INFO - PROCESS | 1953 | Number of tests: 6 04:57:22 INFO - PROCESS | 1953 | 04:57:22 INFO - PROCESS | 1953 | [#0] dojo.html Cycles:165 Average:5911.08 Median:6214.25 stddev:658.83 (10.6%) stddev-sans-first:629.81 04:57:22 INFO - PROCESS | 1953 | Values: 3363.4 3502.2 3514.8 3518.1 3559.0 5826.0 5902.6 5941.7 5948.0 5951.5 5811.0 5883.1 5998.9 5999.1 5999.6 5306.0 5316.7 5356.3 5425.9 5432.5 4468.4 5252.3 5252.4 5257.9 5412.3 5308.6 5364.8 5372.8 5401.8 5416.1 5385.1 5398.7 5400.5 5400.9 5410.2 5204.7 5260.4 5322.7 5334.9 5402.6 5783.6 5814.4 5863.4 5902.9 5930.9 6296.7 6350.2 6352.9 6361.2 6386.3 4937.6 6304.0 6362.2 6376.1 6414.2 5887.9 5975.0 5983.8 6035.1 6128.9 6459.2 6509.6 6559.7 6568.7 6576.7 5176.5 6329.7 6340.7 6358.9 6359.5 6288.6 6304.0 6362.6 6370.2 6378.7 5251.6 6304.7 6312.6 6341.3 6359.7 6322.9 6334.0 6335.8 6339.1 6355.7 5075.8 5169.7 5186.8 5190.8 5202.4 4559.3 4580.8 4595.5 4631.4 4660.0 6062.5 6062.9 6065.9 6071.1 6078.0 6296.1 6309.2 6316.2 6316.7 6345.3 6016.2 6062.5 6068.9 6095.3 6126.3 5670.6 5677.8 5701.1 5701.7 5716.1 6556.6 6569.0 6579.5 6600.4 6604.9 6292.7 6349.7 6366.5 6367.5 6380.2 6457.8 6477.3 6498.6 6544.3 6582.5 6373.3 6376.1 6383.5 6396.0 6397.2 6355.5 6359.8 6380.0 6380.6 6387.7 6057.4 6137.2 6214.3 6259.0 6299.1 6344.4 6345.2 6361.7 6365.1 6367.9 6192.2 6194.2 6228.3 6257.1 6259.6 6214.4 6244.4 6253.2 6273.0 6343.4 6223.3 6245.3 6255.0 6259.8 6270.9 04:57:22 INFO - PROCESS | 1953 | 04:57:22 INFO - PROCESS | 1953 | [#1] ext.html Cycles:180 Average:77913.79 Median:19014.32 stddev:178643.94 (939.5%) stddev-sans-first:179050.46 04:57:22 INFO - PROCESS | 1953 | Values: 470.6 476.2 479.4 516.0 524.8 33338.2 33831.7 34049.3 34070.3 41204.8 45135.0 45327.1 45530.3 45652.5 45790.8 9475.1 9523.2 9534.4 9737.4 9751.7 9031.8 9236.6 9623.0 9757.6 9767.6 11730.8 11942.6 11955.9 12110.7 12165.5 10062.1 11921.8 12017.9 12018.3 12048.9 11555.0 11602.5 11651.5 11654.4 11667.3 41661.8 41894.0 41950.8 41966.6 42172.4 4051.0 4111.8 4115.2 4128.7 4142.9 29690.7 30336.9 31238.8 31311.0 32148.9 3295.0 3328.9 3457.6 3502.0 3512.3 517188.0 519363.0 526568.0 526997.0 528252.0 58291.4 59250.4 60251.0 60634.7 60667.0 63501.7 63614.7 63628.4 63651.0 63724.0 16607.3 16754.1 16810.5 16815.1 16846.3 12994.9 13050.5 13054.9 13073.3 13102.4 16240.4 16623.6 16674.0 16840.0 18773.0 7198.8 7625.4 7698.5 9120.6 9215.1 812.6 890.6 905.2 918.6 952.5 31420.1 31604.7 31734.5 32056.0 32205.8 1080.9 1086.4 1110.5 1114.2 1137.7 15177.6 16391.8 16420.2 16618.9 16736.9 692398.0 695709.0 696739.5 696819.0 698277.0 54644.5 55548.0 63834.7 64567.7 64875.0 1455.8 1479.9 1490.3 1499.9 1500.3 28691.0 30536.2 31612.7 32213.7 32704.7 52652.2 53202.0 53283.5 53286.7 53443.5 597897.0 784890.0 789785.0 790086.0 791677.0 28287.6 28451.4 28652.0 29432.6 29476.6 48877.3 48882.0 48924.0 49756.8 49815.5 32832.2 33481.5 33718.3 33764.0 34039.8 25954.6 33566.8 34007.7 34378.0 34571.0 38914.0 39779.8 40273.8 40574.8 40623.8 33610.2 33830.2 34201.0 34220.8 34251.8 21756.6 25356.7 26011.9 26162.5 26210.3 04:57:22 INFO - PROCESS | 1953 | 04:57:22 INFO - PROCESS | 1953 | [#2] jquery.html Cycles:180 Average:36353.10 Median:22462.89 stddev:102627.76 (456.9%) stddev-sans-first:102880.03 04:57:22 INFO - PROCESS | 1953 | Values: 342.4 407.2 412.2 414.5 444.6 21076.0 21505.8 21999.5 22155.7 22397.8 22843.4 22863.2 22896.5 23036.2 23081.2 6031.4 6350.4 6354.2 6360.7 6379.6 5968.8 6204.9 6253.5 6272.5 6336.5 6309.5 6311.6 6312.8 6319.3 6325.0 5825.7 7024.9 7058.7 7065.5 7076.5 6020.7 6160.7 6227.6 6246.2 6269.1 14070.3 14073.4 14130.6 14297.9 14350.6 2626.6 2702.8 2746.1 2746.3 2747.6 10303.7 10873.3 10957.7 12549.1 15616.8 1499.9 1909.9 1924.3 1927.9 1938.3 111675.0 122328.0 124079.0 124761.0 127801.0 9917.7 10425.3 11785.8 11962.7 12233.4 16212.6 16490.5 16564.0 16580.5 16597.6 8604.3 8857.2 8900.4 8997.1 9056.2 6792.4 8169.1 8539.2 8638.4 8735.5 4890.4 4980.6 4986.7 4996.4 5094.6 1665.9 1957.6 2023.3 2034.6 2058.9 1005.5 1017.9 1031.5 1043.1 1053.9 22528.0 23075.7 23088.4 23195.2 23597.8 1049.8 1057.6 1060.4 1097.4 1109.8 11044.7 11390.2 11792.7 11877.6 12080.9 400421.0 426489.0 701369.0 710347.0 713784.0 153931.0 154154.0 155380.4 156054.0 165210.0 933.6 1028.2 1049.8 1074.4 1077.6 19419.5 19739.9 19841.0 19899.6 19910.5 57912.7 59190.4 59788.7 60162.0 60593.0 85806.6 87735.0 88090.0 90194.5 91118.1 8297.8 8357.1 8475.4 8683.7 8911.6 9718.4 10769.5 12843.2 13222.7 13265.0 11246.8 11262.0 11295.7 11737.7 11838.2 10467.1 10481.5 10757.4 10887.9 11016.3 11513.0 11559.5 11636.7 11911.2 11952.4 8401.2 8537.4 8571.1 8659.6 8662.3 8819.6 11173.0 11249.0 11473.7 11672.9 04:57:22 INFO - PROCESS | 1953 | 04:57:22 INFO - PROCESS | 1953 | [#3] mootools.html Cycles:180 Average:5544.47 Median:5105.72 stddev:3001.81 (58.8%) stddev-sans-first:2993.83 04:57:22 INFO - PROCESS | 1953 | Values: 1370.0 1456.2 1474.0 1477.4 1483.7 7663.6 8010.1 8028.2 8034.7 8046.6 8243.3 8418.0 8484.8 8607.1 8615.5 2382.1 2419.3 2419.6 2421.8 2424.0 2107.2 2370.2 2432.8 2440.0 2443.5 2138.7 2324.8 2401.4 2410.3 2416.3 2362.5 2382.1 2388.7 2389.9 2391.6 2409.4 2432.8 2436.0 2437.7 2440.0 8383.8 8570.4 8577.1 8589.4 8651.2 5225.8 5369.4 5379.7 5388.1 5390.4 3383.6 3500.2 3640.8 3691.4 3713.2 1214.6 1256.1 1290.7 1308.3 1316.7 11102.4 11164.5 11172.7 11178.7 11179.6 4019.9 4021.7 4480.5 4765.2 4828.8 9732.9 9770.3 9806.8 9812.1 9844.2 5334.0 5427.1 5440.7 5456.0 5467.3 4762.6 4857.1 4939.3 4963.9 4977.6 3943.7 3989.5 4012.1 4055.0 4073.6 1210.9 1301.8 1303.8 1312.9 1315.7 702.7 915.4 929.8 939.7 1009.6 5613.7 5807.7 5905.5 5962.2 6091.0 882.3 1000.7 1011.5 1030.8 1061.4 3726.6 3888.2 3926.4 3947.1 4048.7 7721.5 10185.6 10294.6 10306.2 10328.7 10044.9 10277.8 10282.1 10283.2 10305.4 7741.7 8041.6 8057.7 8063.6 8065.7 5596.7 5600.9 5620.9 5724.3 5792.8 9353.2 9497.7 9500.3 9512.2 9516.0 9367.0 9494.2 9589.6 9651.2 9771.5 6866.9 6999.1 7001.3 7007.6 7009.6 8068.2 8124.1 8131.0 8131.0 8180.5 6920.3 6954.4 7094.0 7150.7 7153.0 6953.9 6987.1 7001.2 7014.9 7033.9 6339.6 6458.8 6475.2 6521.1 6567.5 4759.5 4829.6 4830.8 4905.0 4946.1 5026.5 5066.0 5145.5 5219.5 5241.1 04:57:22 INFO - PROCESS | 1953 | 04:57:22 INFO - PROCESS | 1953 | [#4] prototype.html Cycles:180 Average:4637.89 Median:5224.42 stddev:1450.93 (27.8%) stddev-sans-first:1419.05 04:57:22 INFO - PROCESS | 1953 | Values: 361.5 363.6 372.8 379.5 379.7 4882.8 5522.9 5557.8 5565.5 5630.4 5240.2 5262.9 5291.6 5382.7 5388.9 3666.6 4203.1 4233.6 4312.6 4324.1 4241.5 4243.8 4277.7 4280.8 4313.3 3222.7 3865.0 4100.0 4105.9 4119.7 3352.6 3478.2 3605.2 3952.0 3957.9 3089.9 3447.2 3515.3 3532.7 3540.5 5059.7 5082.7 5235.9 5251.5 5282.3 4475.2 4693.8 4694.6 4721.2 4767.5 5598.5 5685.3 5750.7 5758.3 5765.7 3166.4 3469.9 3727.4 3940.4 3976.7 5856.6 6011.5 6041.6 6041.8 6078.6 3408.9 3768.2 3960.7 3961.7 3974.6 4052.3 4089.8 4100.5 4103.4 4115.7 4432.8 4700.5 4707.8 4716.3 4749.8 4656.9 5294.8 5559.9 5826.7 5871.4 1159.2 1245.1 1320.6 1326.2 1351.2 846.5 879.5 888.8 899.0 906.5 5044.8 5097.7 5107.9 5154.7 5221.3 5287.0 5396.8 5611.6 5648.7 5708.4 4843.9 5021.2 5073.5 5073.6 5184.4 2675.7 2926.6 2930.8 2932.6 2956.9 5223.3 5691.9 5817.8 5882.6 6078.6 5545.4 5613.9 6089.1 6100.3 6159.3 6179.8 6191.3 6224.0 6276.0 6289.4 5166.7 5225.5 5929.7 5971.9 6000.2 4925.3 5291.6 5627.8 5950.6 5979.3 5890.6 6073.6 6143.4 6150.5 6290.0 3336.3 3683.4 3992.4 4018.6 4030.0 5070.6 5190.5 5710.7 5993.8 6023.6 5403.5 5664.3 5698.5 5724.9 5845.7 4958.0 5778.9 5820.7 5823.8 5839.9 5245.3 5323.4 5596.2 5663.2 5783.3 5303.9 5395.4 5410.9 5428.1 5748.0 5013.9 5661.2 5718.2 5722.9 5747.3 04:57:22 INFO - PROCESS | 1953 | 04:57:22 INFO - PROCESS | 1953 | [#5] yui.html Cycles:180 Average:20988.11 Median:4488.02 stddev:30265.13 (674.4%) stddev-sans-first:30311.81 04:57:22 INFO - PROCESS | 1953 | Values: 733.2 773.4 798.3 865.5 879.5 15303.2 15741.6 16129.0 16312.1 16330.8 12444.6 14725.5 14914.3 15126.4 15126.8 907.1 918.0 918.7 918.8 926.7 735.2 755.1 898.2 901.0 903.7 969.3 977.6 978.4 978.8 981.8 969.6 970.3 976.1 977.3 981.4 730.6 730.6 730.7 731.4 733.3 15807.4 16115.5 16121.5 16261.8 16341.7 15027.0 15246.2 15351.4 15415.4 15508.8 11857.3 11881.7 12094.6 12166.1 12210.4 3825.8 3835.6 3860.1 3938.4 4054.9 115327.0 115783.0 116680.4 117974.2 119395.0 11561.3 11808.5 11944.0 11961.2 12053.5 24723.5 25308.0 25498.7 25545.5 25600.6 7732.5 7825.3 7951.2 8109.7 8214.5 4403.1 4414.3 4479.5 4496.6 4575.7 3571.2 3671.1 3673.7 3677.0 3678.4 644.6 682.8 683.7 685.6 686.8 635.9 643.9 662.6 686.4 720.0 8767.6 9958.8 10062.0 10232.7 10258.6 632.5 640.7 687.5 696.2 706.1 4674.5 4742.3 4744.7 4821.7 4851.0 79891.0 90918.0 99772.5 107571.0 110028.0 73671.0 93120.1 93395.0 96623.5 97037.0 72078.3 73947.0 74310.0 75195.6 76358.6 8964.6 9056.2 9110.3 9121.0 9172.7 52969.7 53032.9 53865.7 54639.0 55723.4 70127.3 71579.6 71631.6 72646.6 74658.0 10963.5 11287.7 11303.2 11977.8 11999.3 12061.0 12116.7 12210.3 12259.4 12719.0 13463.2 13567.9 14598.1 14705.8 14793.9 13260.6 13731.7 14083.4 14258.7 14383.6 13425.8 14276.3 14282.9 14315.0 14349.7 9412.2 9797.1 10196.7 10356.8 10647.4 10659.5 10827.0 11470.1 11827.3 11882.2 04:57:22 INFO - PROCESS | 1953 | -------- Summary: end -------- 04:57:22 INFO - PROCESS | 1953 | 04:57:22 INFO - TEST-INFO | 1953: exit 0 04:57:23 INFO - TEST-OK | dromaeo_css | took 1117182ms 04:57:23 INFO - TEST-START | kraken 04:57:23 INFO - operating with platform_type : mac_ 04:57:23 INFO - Initialising browser for kraken test... 04:57:23 INFO - TEST-INFO | started process 1956 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpyqoXIM/profile http://localhost:54648/getInfo.html) 04:57:25 INFO - PROCESS | 1956 | __metrics Screen width/height:1600/1200 04:57:25 INFO - PROCESS | 1956 | colorDepth:24 04:57:25 INFO - PROCESS | 1956 | Browser inner width/height: 1024/689 04:57:25 INFO - PROCESS | 1956 | __metrics 04:57:25 INFO - PROCESS | 1956 | 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" 04:57:25 INFO - PROCESS | 1956 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:57:25 INFO - TEST-INFO | 1956: exit 0 04:57:25 INFO - Browser initialized. 04:57:25 INFO - Running cycle 1/1 for kraken test... 04:57:25 INFO - TEST-INFO | started process 1958 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpyqoXIM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:57:37 INFO - PROCESS | 1958 | RSS: Main: 163815424 04:57:37 INFO - PROCESS | 1958 | 04:57:40 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:54648/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54648/tests/kraken/driver.html?testName=audio-beat-detection) 04:57:41 INFO - PROCESS | 1958 | RSS: Main: 214728704 04:57:41 INFO - PROCESS | 1958 | 04:57:43 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:54648/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54648/tests/kraken/driver.html?testName=audio-dft) 04:57:44 INFO - PROCESS | 1958 | RSS: Main: 227557376 04:57:44 INFO - PROCESS | 1958 | 04:57:47 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:54648/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54648/tests/kraken/driver.html?testName=audio-fft) 04:57:48 INFO - PROCESS | 1958 | RSS: Main: 324837376 04:57:48 INFO - PROCESS | 1958 | 04:57:50 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:54648/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54648/tests/kraken/driver.html?testName=audio-oscillator) 04:57:50 INFO - PROCESS | 1958 | RSS: Main: 228872192 04:57:50 INFO - PROCESS | 1958 | 04:57:52 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:54648/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54648/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:57:53 INFO - PROCESS | 1958 | RSS: Main: 230424576 04:57:53 INFO - PROCESS | 1958 | 04:57:56 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:54648/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54648/tests/kraken/driver.html?testName=imaging-darkroom) 04:57:56 INFO - PROCESS | 1958 | RSS: Main: 270159872 04:57:56 INFO - PROCESS | 1958 | 04:57:59 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:54648/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54648/tests/kraken/driver.html?testName=imaging-desaturate) 04:58:00 INFO - PROCESS | 1958 | RSS: Main: 271523840 04:58:00 INFO - PROCESS | 1958 | 04:58:03 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:54648/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54648/tests/kraken/driver.html?testName=json-parse-financial) 04:58:03 INFO - PROCESS | 1958 | RSS: Main: 268034048 04:58:03 INFO - PROCESS | 1958 | 04:58:05 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:54648/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54648/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:58:06 INFO - PROCESS | 1958 | RSS: Main: 244813824 04:58:06 INFO - PROCESS | 1958 | 04:58:07 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:54648/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54648/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:58:08 INFO - PROCESS | 1958 | RSS: Main: 246956032 04:58:08 INFO - PROCESS | 1958 | 04:58:10 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:54648/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54648/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:58:11 INFO - PROCESS | 1958 | RSS: Main: 254435328 04:58:11 INFO - PROCESS | 1958 | 04:58:14 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:54648/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54648/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:58:14 INFO - PROCESS | 1958 | RSS: Main: 267427840 04:58:14 INFO - PROCESS | 1958 | 04:58:17 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:54648/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54648/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:58:18 INFO - PROCESS | 1958 | RSS: Main: 261505024 04:58:18 INFO - PROCESS | 1958 | 04:58:19 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:54648/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54648/tests/kraken/driver.html?testName=ai-astar) 04:58:20 INFO - PROCESS | 1958 | RSS: Main: 305844224 04:58:20 INFO - PROCESS | 1958 | 04:58:20 INFO - PROCESS | 1958 | __start_tp_report 04:58:20 INFO - PROCESS | 1958 | _x_x_mozilla_page_load 04:58:20 INFO - PROCESS | 1958 | _x_x_mozilla_page_load_details 04:58:20 INFO - PROCESS | 1958 | |i|pagename|runs| 04:58:20 INFO - PROCESS | 1958 | |0;ai-astar;107;167;158;111;114;113;112;112;113;116 04:58:20 INFO - PROCESS | 1958 | |1;audio-beat-detection;140;107;107;142;107;108;107;106;125;118 04:58:20 INFO - PROCESS | 1958 | |2;audio-dft;184;179;179;183;182;183;182;181;184;182 04:58:20 INFO - PROCESS | 1958 | |3;audio-fft;81;58;58;88;63;58;57;75;94;57 04:58:20 INFO - PROCESS | 1958 | |4;audio-oscillator;85;70;86;69;68;67;94;98;68;82 04:58:20 INFO - PROCESS | 1958 | |5;imaging-gaussian-blur;90;130;88;86;88;85;89;86;88;84 04:58:20 INFO - PROCESS | 1958 | |6;imaging-darkroom;92;99;145;94;93;93;94;94;101;91 04:58:20 INFO - PROCESS | 1958 | |7;imaging-desaturate;84;85;88;94;88;85;86;87;86;84 04:58:20 INFO - PROCESS | 1958 | |8;json-parse-financial;56;53;53;55;56;56;57;57;56;56 04:58:20 INFO - PROCESS | 1958 | |9;json-stringify-tinderbox;63;71;80;74;72;66;67;69;67;67 04:58:20 INFO - PROCESS | 1958 | |10;stanford-crypto-aes;82;79;80;81;83;82;80;86;82;81 04:58:20 INFO - PROCESS | 1958 | |11;stanford-crypto-ccm;131;132;131;129;164;156;130;138;172;171 04:58:20 INFO - PROCESS | 1958 | |12;stanford-crypto-pbkdf2;158;163;161;163;154;161;165;220;164;161 04:58:20 INFO - PROCESS | 1958 | |13;stanford-crypto-sha256-iterative;63;65;64;64;65;62;64;64;62;62 04:58:20 INFO - PROCESS | 1958 | __end_tp_report 04:58:20 INFO - PROCESS | 1958 | __start_cc_report 04:58:20 INFO - PROCESS | 1958 | _x_x_mozilla_cycle_collect,2026 04:58:20 INFO - PROCESS | 1958 | __end_cc_report 04:58:20 INFO - PROCESS | 1958 | __startTimestamp1491739100230__endTimestamp 04:58:20 INFO - PROCESS | 1958 | 04:58:20 INFO - PROCESS | 1958 | ------- Summary: start ------- 04:58:20 INFO - PROCESS | 1958 | Number of tests: 14 04:58:20 INFO - PROCESS | 1958 | 04:58:20 INFO - PROCESS | 1958 | [#0] ai-astar Cycles:10 Average:122.30 Median:113.50 stddev:21.42 (18.9%) stddev-sans-first:21.99 04:58:20 INFO - PROCESS | 1958 | Values: 107.0 167.0 158.0 111.0 114.0 113.0 112.0 112.0 113.0 116.0 04:58:20 INFO - PROCESS | 1958 | 04:58:20 INFO - PROCESS | 1958 | [#1] audio-beat-detection Cycles:10 Average:116.70 Median:113.00 stddev:14.22 (12.6%) stddev-sans-first:12.33 04:58:20 INFO - PROCESS | 1958 | Values: 140.0 107.0 107.0 142.0 107.0 108.0 107.0 106.0 125.0 118.0 04:58:20 INFO - PROCESS | 1958 | 04:58:20 INFO - PROCESS | 1958 | [#2] audio-dft Cycles:10 Average:181.90 Median:182.50 stddev:1.79 (1.0%) stddev-sans-first:1.73 04:58:20 INFO - PROCESS | 1958 | Values: 184.0 179.0 179.0 183.0 182.0 183.0 182.0 181.0 184.0 182.0 04:58:20 INFO - PROCESS | 1958 | 04:58:20 INFO - PROCESS | 1958 | [#3] audio-fft Cycles:10 Average:68.90 Median:69.00 stddev:14.35 (20.8%) stddev-sans-first:14.54 04:58:20 INFO - PROCESS | 1958 | Values: 81.0 58.0 58.0 88.0 63.0 58.0 57.0 75.0 94.0 57.0 04:58:20 INFO - PROCESS | 1958 | 04:58:20 INFO - PROCESS | 1958 | [#4] audio-oscillator Cycles:10 Average:78.70 Median:83.50 stddev:11.77 (14.1%) stddev-sans-first:12.26 04:58:20 INFO - PROCESS | 1958 | Values: 85.0 70.0 86.0 69.0 68.0 67.0 94.0 98.0 68.0 82.0 04:58:20 INFO - PROCESS | 1958 | 04:58:20 INFO - PROCESS | 1958 | [#5] imaging-gaussian-blur Cycles:10 Average:91.40 Median:88.00 stddev:13.69 (15.6%) stddev-sans-first:14.51 04:58:20 INFO - PROCESS | 1958 | Values: 90.0 130.0 88.0 86.0 88.0 85.0 89.0 86.0 88.0 84.0 04:58:20 INFO - PROCESS | 1958 | 04:58:20 INFO - PROCESS | 1958 | [#6] imaging-darkroom Cycles:10 Average:99.60 Median:93.50 stddev:16.25 (17.4%) stddev-sans-first:17.00 04:58:20 INFO - PROCESS | 1958 | Values: 92.0 99.0 145.0 94.0 93.0 93.0 94.0 94.0 101.0 91.0 04:58:20 INFO - PROCESS | 1958 | 04:58:20 INFO - PROCESS | 1958 | [#7] imaging-desaturate Cycles:10 Average:86.70 Median:86.50 stddev:2.95 (3.4%) stddev-sans-first:2.96 04:58:20 INFO - PROCESS | 1958 | Values: 84.0 85.0 88.0 94.0 88.0 85.0 86.0 87.0 86.0 84.0 04:58:20 INFO - PROCESS | 1958 | 04:58:20 INFO - PROCESS | 1958 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:56.00 stddev:1.43 (2.6%) stddev-sans-first:1.51 04:58:20 INFO - PROCESS | 1958 | Values: 56.0 53.0 53.0 55.0 56.0 56.0 57.0 57.0 56.0 56.0 04:58:20 INFO - PROCESS | 1958 | 04:58:20 INFO - PROCESS | 1958 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:70.00 stddev:4.86 (6.9%) stddev-sans-first:4.53 04:58:20 INFO - PROCESS | 1958 | Values: 63.0 71.0 80.0 74.0 72.0 66.0 67.0 69.0 67.0 67.0 04:58:20 INFO - PROCESS | 1958 | 04:58:20 INFO - PROCESS | 1958 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:82.00 stddev:1.96 (2.4%) stddev-sans-first:2.07 04:58:20 INFO - PROCESS | 1958 | Values: 82.0 79.0 80.0 81.0 83.0 82.0 80.0 86.0 82.0 81.0 04:58:20 INFO - PROCESS | 1958 | 04:58:20 INFO - PROCESS | 1958 | [#11] stanford-crypto-ccm Cycles:10 Average:145.40 Median:147.00 stddev:18.19 (12.4%) stddev-sans-first:18.53 04:58:20 INFO - PROCESS | 1958 | Values: 131.0 132.0 131.0 129.0 164.0 156.0 130.0 138.0 172.0 171.0 04:58:20 INFO - PROCESS | 1958 | 04:58:20 INFO - PROCESS | 1958 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.00 Median:163.00 stddev:18.89 (11.6%) stddev-sans-first:19.75 04:58:20 INFO - PROCESS | 1958 | Values: 158.0 163.0 161.0 163.0 154.0 161.0 165.0 220.0 164.0 161.0 04:58:20 INFO - PROCESS | 1958 | 04:58:20 INFO - PROCESS | 1958 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:64.00 stddev:1.18 (1.8%) stddev-sans-first:1.24 04:58:20 INFO - PROCESS | 1958 | Values: 63.0 65.0 64.0 64.0 65.0 62.0 64.0 64.0 62.0 62.0 04:58:20 INFO - PROCESS | 1958 | -------- Summary: end -------- 04:58:20 INFO - PROCESS | 1958 | 04:58:21 INFO - TEST-INFO | 1958: exit 0 04:58:21 INFO - TEST-OK | kraken | took 58142ms 04:58:21 INFO - SUITE-END | took 1175s 04:58:21 INFO - Completed test suite (00:19:35) 04:58:21 INFO - javascript benchmark 04:58:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3363.4114030044734, 3502.2295095079076, 3514.82425878706, 3518.0852978225653, 3559.0, 5825.970870145648, 5902.586818922677, 5941.7029148542615, 5947.970260148699, 5951.494122999539, 5810.970945145279, 5883.117532370146, 5998.88002239956, 5999.100134979755, 5999.640021598707, 5305.973470132644, 5316.654417462872, 5356.288857006216, 5425.945740542584, 5432.548510229587, 4468.352088947101, 5252.290940722992, 5252.395974462947, 5257.86855328616, 5412.296401467804, 5308.628396012281, 5364.758585863626, 5372.811951581695, 5401.810936617219, 5416.079266524681, 5385.057614917393, 5398.676079435247, 5400.513953744143, 5400.891982160374, 5410.188471729272, 5204.713740744258, 5260.395054568697, 5322.680639161663, 5334.946650533484, 5402.648827826179, 5783.62406443584, 5814.418558144152, 5863.442972917566, 5902.8819423611285, 5930.911036334458, 6296.68516574174, 6350.206224221973, 6352.872942541169, 6361.173047503795, 6386.329435409261, 4937.580305674022, 6304.022876454157, 6362.172917520739, 6376.107344971708, 6414.198225221848, 5887.941120588825, 5975.0, 5983.790567330209, 6035.064564992434, 6128.938710612926, 6459.192600924885, 6509.641969691617, 6559.704813283413, 6568.67156642166, 6576.671166441659, 5176.534111929945, 6329.651869147149, 6340.714667839959, 6358.904616430757, 6359.491240700733, 6288.622682639057, 6304.0, 6362.618242905441, 6370.235571731329, 6378.74485020594, 5251.553617942442, 6304.747810087545, 6312.558120931582, 6341.302456729756, 6359.745610175633, 6322.9051564226575, 6334.049892516067, 6335.809925702144, 6339.144215530937, 6355.745770169141, 5075.847724568269, 5169.663971841818, 5186.818461353834, 5190.792368305301, 5202.401723801736, 4559.316102584573, 4580.839670611513, 4595.471520775153, 4631.421072365954, 4660.0, 6062.484688801413, 6062.878742425127, 6065.939340606537, 6071.089336599545, 6077.969610151921, 6296.087067375205, 6309.179806625201, 6316.178896743394, 6316.715747791361, 6345.270293916166, 6016.1878146450545, 6062.454379105813, 6068.878622427526, 6095.329513753572, 6126.326104128542, 5670.603057785916, 5677.801276955287, 5701.144828275709, 5701.657900525982, 5716.142578613241, 6556.626086090553, 6569.0, 6579.506537009744, 6600.438962688129, 6604.933950660528, 6292.685365731787, 6349.746010159727, 6366.5225108118, 6367.490600752021, 6380.170577824853, 6457.773977910939, 6477.319881412573, 6498.642574658439, 6544.28012918569, 6582.506312026521, 6373.298937117006, 6376.139221205078, 6383.489320854414, 6395.97664373698, 6397.232332120176, 6355.491560675227, 6359.777407790705, 6380.0, 6380.649064301508, 6387.712552935222, 6057.42454466825, 6137.171481849893, 6214.25428948529, 6259.0, 6299.086632438362, 6344.429001389897, 6345.17512723343, 6361.745530178741, 6365.077063825812, 6367.93632063692, 6192.164057852132, 6194.163787888578, 6228.314885362697, 6257.092721555258, 6259.561830671809, 6214.378562143749, 6244.438000579969, 6253.155823963707, 6272.968635156795, 6343.365663433619, 6223.253209614875, 6245.344238854855, 6255.030470277115, 6259.78090766821, 6270.937290627217], "value": 5870.229516399621, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [470.6093942028117, 476.2356417949194, 479.4414507099227, 515.9509846564576, 524.7507433968865, 33338.166545836335, 33831.66168338322, 34049.319013619745, 34070.318593628115, 41204.79397603015, 45135.0, 45327.09345813082, 45530.317045244345, 45652.543474565326, 45790.77104614481, 9475.147236748691, 9523.190528805042, 9534.427934323929, 9737.367071140388, 9751.707448776548, 9031.774205644879, 9236.6305347786, 9623.0, 9757.560909759042, 9767.560459779292, 11730.824037639442, 11942.641720748348, 11955.940220298886, 12110.697232569211, 12165.513379464855, 10062.144717698968, 11921.821172682417, 12017.87982120185, 12018.278903265833, 12048.939755301168, 11555.0, 11602.477888495037, 11651.475683594259, 11654.417279136009, 11667.299962002307, 41661.79169104135, 41893.95265118366, 41950.79024604857, 41966.58033419657, 42172.36741448881, 4050.9594904050878, 4111.814968326433, 4115.218108559364, 4128.710990230685, 4142.875713728593, 29690.703092969008, 30336.938207162864, 31238.843805781053, 31311.0, 32148.87478938226, 3295.0114965510493, 3328.8502017409032, 3457.6369481204615, 3502.036939841564, 3512.262424890776, 517188.0, 519363.0, 526568.0, 526997.0, 528252.0, 58291.4170858286, 59250.40749592535, 60251.0, 60634.69682651559, 60667.0, 63501.68249158725, 63614.68192659007, 63628.36371636224, 63651.0, 63724.044139337944, 16607.252673629715, 16754.07852568096, 16810.495685129466, 16815.075170865475, 16846.32614695423, 12994.935025324812, 13050.54323098687, 13054.869451305365, 13073.280969546577, 13102.410391532403, 16240.431584894472, 16623.584410389594, 16673.999120105665, 16840.005440449877, 18773.0, 7198.7840364789145, 7625.389968802482, 7698.461107722517, 9120.58957346921, 9215.124563166488, 812.5937031484258, 890.6481939633809, 905.2260317428635, 918.6233644205844, 952.4618590496348, 31420.057398278088, 31604.683953160173, 31734.523982140287, 32056.0, 32205.838970804994, 1080.8702955645215, 1086.4241951765578, 1110.5446766825723, 1114.1810769084716, 1137.7496950670838, 15177.6205594861, 16391.83608163927, 16420.1789910504, 16618.919770214896, 16736.916315418588, 692398.0, 695709.0, 696739.5163024153, 696819.0, 698277.0, 54644.45355546473, 55548.0, 63834.6808265965, 64567.677161613894, 64875.0, 1455.8398576156615, 1479.9186044767425, 1490.3293517917198, 1499.895007349475, 1500.3248538157873, 28691.029966165035, 30536.236594085327, 31612.683873160975, 32213.677863221066, 32704.67295327016, 52652.21021684755, 53201.99999999845, 53283.46716532785, 53286.66783330448, 53443.465565343846, 597897.0, 784890.0, 789785.0, 790086.0, 791677.0, 28287.57568636431, 28451.430971380043, 28652.0, 29432.55851162277, 29476.557851631813, 48877.2668409967, 48882.0, 48924.0, 49756.75121624369, 49815.50553483401, 32832.1791955203, 33481.49333280057, 33718.325633486704, 33763.98708038664, 34039.829800850835, 25954.610680840182, 33566.83216583901, 34007.659923400446, 34378.0, 34571.0, 38914.0, 39779.801100995464, 40273.798631006655, 40574.78275651735, 40623.79688101659, 33610.159746006546, 33830.15424614404, 34201.0, 34220.82889585536, 34251.82874085614, 21756.564868702855, 25356.746432535438, 26011.869940650176, 26162.476750464502, 26210.344741381617], "value": 20786.151349130174, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.4025076241957, 407.2140768317147, 412.19210347718473, 414.5440015982419, 444.5754304639068, 21076.0, 21505.81718005509, 21999.450013749665, 22155.667664985038, 22397.776022239774, 22843.428914277152, 22863.199788007423, 22896.542069158608, 23036.19373321934, 23081.192158274465, 6031.366706495832, 6350.396712312323, 6354.205724284465, 6360.7455701772105, 6379.5853269537565, 5968.820935371946, 6204.906926396107, 6253.468455181315, 6272.498200143978, 6336.493080553568, 6309.4636955858805, 6311.558190926614, 6312.779052733155, 6319.273283572379, 6324.968375158118, 5825.679587622679, 7024.89462658058, 7058.682359293793, 7065.540739851893, 7076.504644674875, 6020.6989650517735, 6160.722767475474, 6227.595206311576, 6246.15676883624, 6269.090981807658, 14070.2964851757, 14073.366698498592, 14130.646733831634, 14297.927655425885, 14350.569482915529, 2626.5534859074005, 2702.7972902032425, 2746.1075150576144, 2746.3408781892404, 2747.5603903375363, 10303.690889273334, 10873.293235939638, 10957.671269861838, 12549.058820588492, 15616.843831561653, 1499.8575135362123, 1909.8749782516895, 1924.3072493902184, 1927.9036048197675, 1938.3022112039655, 111675.0, 122328.0, 124079.0, 124761.0, 127800.99999999907, 9917.702468925943, 10425.270231083903, 11785.762494938079, 11962.72708185442, 12233.388330583435, 16212.59468513273, 16490.505284841474, 16564.0, 16580.502584922473, 16597.58506037359, 8604.268637165786, 8857.158569935846, 8900.42147260426, 8997.100289971082, 9056.230220431336, 6792.3886850182735, 8169.101398846122, 8539.231469167804, 8638.358711844729, 8735.51954642488, 4890.413150421972, 4980.576650984634, 4986.675866068694, 4996.350474438373, 5094.592432605383, 1665.9083750393602, 1957.6182644384494, 2023.2802118199413, 2034.6235946349677, 2058.9176432942513, 1005.4821766790109, 1017.898210178991, 1031.5358088860044, 1043.087298613713, 1053.899879511445, 22528.0, 23075.653865192035, 23088.422789430064, 23195.188168414024, 23597.764022359555, 1049.8477720730452, 1057.645688694296, 1060.3743791163251, 1097.4183682648209, 1109.7835921995134, 11044.668659940215, 11390.202685811913, 11792.70518237051, 11877.58428455, 12080.87919120815, 400421.0, 426489.0, 701369.0, 710347.0, 713784.0, 153931.0, 154154.0, 155380.44619553658, 156054.0, 165210.0, 933.6172169410509, 1028.156911332715, 1049.8477720730605, 1074.4412905289205, 1077.6443773554709, 19419.51451213731, 19739.901300493406, 19841.0, 19899.60200796005, 19910.50223744418, 57912.710436447545, 59190.40809592021, 59788.70105649618, 60162.0, 60593.0, 85806.57096714477, 87735.0, 88090.0, 90194.54902725444, 91118.08881911096, 8297.834043318979, 8357.080721120794, 8475.406721529434, 8683.696070637498, 8911.643534258816, 9718.416894986323, 10769.461526923465, 12843.229406235656, 13222.669433264246, 13265.0, 11246.775064498828, 11262.0, 11295.661130166109, 11737.706557335794, 11838.230515016496, 10467.110295624652, 10481.475926203811, 10757.354558726502, 10887.945560272148, 11016.339019658846, 11513.0, 11559.479823407799, 11636.650900473, 11911.166218364979, 11952.402379880798, 8401.201885820838, 8537.359698022548, 8571.100034496289, 8659.610317535851, 8662.263707584674, 8819.559022048743, 11173.0, 11249.0, 11473.713157171138, 11672.88327116718], "value": 10046.16546091441, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1370.0, 1456.1845366594707, 1473.9778903316453, 1477.3721168503387, 1483.6513419346454, 7663.5785031823225, 8010.0788409332945, 8028.197180281969, 8034.718784842532, 8046.557439340834, 8243.258106770389, 8418.031926328475, 8484.787880302996, 8607.053224145355, 8615.483071015728, 2382.1186161120368, 2419.2863105383867, 2419.588669926108, 2421.7820396164343, 2424.0, 2107.2203284784573, 2370.182287110944, 2432.805375569959, 2440.048381131351, 2443.4502236996623, 2138.6791981202787, 2324.76752324767, 2401.363638635763, 2410.337157281744, 2416.2630397728685, 2362.4684445999683, 2382.0828980842325, 2388.6894703688495, 2389.940251493709, 2391.5695174868515, 2409.3856066703056, 2432.8200822601025, 2436.0012394918176, 2437.7440368761204, 2439.9756002440104, 8383.790405239857, 8570.357223208222, 8577.142285771373, 8589.44168629037, 8651.221390074923, 5225.843224703265, 5369.382521010095, 5379.731013449312, 5388.110961691316, 5390.380106287788, 3383.6278009418943, 3500.2124521982605, 3640.799756013418, 3691.446283057563, 3713.220223753015, 1214.6416807041944, 1256.1269917407406, 1290.7224946636518, 1308.2804457548405, 1316.7037416581288, 11102.44487775608, 11164.497597608128, 11172.664820055492, 11178.664640060812, 11179.608713695063, 4019.8995025124023, 4021.678265738734, 4480.462344518679, 4765.237561990065, 4828.782704778293, 9732.854007189897, 9770.316077874622, 9806.75483112928, 9812.116909478182, 9844.163246124017, 5333.973330133324, 5427.050266203399, 5440.727963601804, 5455.972720136453, 5467.316585426822, 4762.571368576775, 4857.101436234308, 4939.3084968104495, 4963.875903102451, 4977.552020318189, 3943.7042221833476, 3989.4614227078973, 4012.057166565855, 4054.959450405517, 4073.572274911151, 1210.9212901161397, 1301.7656821771982, 1303.8370203724535, 1312.901532385075, 1315.651352391617, 702.7224246422635, 915.3958387464241, 929.7954450020984, 939.6523286384082, 1009.6012075230243, 5613.691246981455, 5807.680577568274, 5905.4685078343155, 5962.195103661037, 6091.0, 882.250087425683, 1000.7097941596855, 1011.4790882695418, 1030.7732298894232, 1061.4109169410897, 3726.552813662324, 3888.183481468867, 3926.3521518949055, 3947.0527073502153, 4048.7368321059625, 7721.498102623312, 10185.592576296865, 10294.639687610897, 10306.227032972558, 10328.741781455374, 10044.949775251076, 10277.845832312521, 10282.126019288295, 10283.228757843042, 10305.433201173857, 7741.651625676858, 8041.6381262843315, 8057.717979870794, 8063.556504392314, 8065.717699880476, 5596.748146333506, 5600.85997850057, 5620.915686264628, 5724.341700704473, 5792.82621521355, 9353.158215760614, 9497.715068547956, 9500.287478439282, 9512.191463725385, 9515.952420237854, 9367.0, 9494.192993595345, 9589.568469419033, 9651.227901767983, 9771.511424428892, 6866.862662746817, 6999.12510936133, 7001.334873187039, 7007.579545227302, 7009.579425234502, 8068.1528439513, 8124.106348301564, 8130.983627046619, 8131.0, 8180.509169449852, 6920.342567456084, 6954.374106330252, 7093.964530177523, 7150.678219480032, 7153.0, 6953.895691564529, 6987.091678081817, 7001.194862590867, 7014.859702806018, 7033.859322813618, 6339.5562310637815, 6458.806235812933, 6475.222973243241, 6521.119648847534, 6567.507436942153, 4759.547842954914, 4829.613630909448, 4830.806767729392, 4904.950950490449, 4946.134426475424, 5026.472220416804, 5065.974670126626, 5145.459726728789, 5219.4780521947505, 5241.08281050807], "value": 4526.156090728576, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.5137639874369, 363.5873283822862, 372.78937400368795, 379.50474630607044, 379.72090513472574, 4882.780274887629, 5522.861928451791, 5557.833265002051, 5565.469495888633, 5630.380658127608, 5240.240165176047, 5262.947410517892, 5291.550218231455, 5382.703951282678, 5388.865278368043, 3666.578343490493, 4203.07532342884, 4233.597808208216, 4312.611864932155, 4324.11355672088, 4241.491021077475, 4243.766592837393, 4277.700560960734, 4280.828766849338, 4313.28830742927, 3222.6616205298455, 3864.9613503864884, 4099.979500102495, 4105.938410923838, 4119.711620186588, 3352.597688277398, 3478.165240342325, 3605.242898991202, 3952.023988005997, 3957.920841583181, 3089.8609562569736, 3447.1554469154967, 3515.2793677296095, 3532.717382609411, 3540.4689296605716, 5059.74701264939, 5082.74586270685, 5235.869103272411, 5251.505534870944, 5282.313299271109, 4475.165182275252, 4693.7653117344, 4694.57748802606, 4721.1908914196, 4767.451743049524, 5598.5086636446795, 5685.260916080924, 5750.683712395817, 5758.280214973129, 5765.740541675593, 3166.4458719723957, 3469.8612055517747, 3727.403615421547, 3940.389239667856, 3976.681865450757, 5856.590038697293, 6011.48902343297, 6041.577089603729, 6041.8187454376875, 6078.574499785017, 3408.8694565896317, 3768.1898391845884, 3960.742551734128, 3961.7028722845903, 3974.6224108709625, 4052.3313653247474, 4089.754614723126, 4100.528439229467, 4103.384492326175, 4115.650169735606, 4432.778361081933, 4700.506446823103, 4707.835225767081, 4716.339712440261, 4749.810007599726, 4656.905627177611, 5294.7617357219015, 5559.944400555943, 5826.650400975955, 5871.383504732027, 1159.1596092832629, 1245.078641805076, 1320.5510126556824, 1326.1843965961057, 1351.1624191100095, 846.517485033525, 879.4547380623926, 888.8311220868014, 899.0335389456361, 906.4561263242002, 5044.798208071636, 5097.745112744348, 5107.87230319245, 5154.742262886841, 5221.32122824038, 5287.0, 5396.83809485716, 5611.551075913917, 5648.717564121777, 5708.400617935057, 4843.878903027453, 5021.221710634784, 5073.51397815068, 5073.568746656576, 5184.366924418796, 2675.665541807274, 2926.6391128125524, 2930.794844360917, 2932.5601159826197, 2956.8521573921216, 5223.2948551945, 5691.8861622768145, 5817.818318130701, 5882.646941223459, 6078.635281883013, 5545.417731138253, 5613.943860561424, 6089.142811442464, 6100.267967843887, 6159.29168145669, 6179.794939986749, 6191.318954914956, 6224.0, 6276.0, 6289.433950944345, 5166.715830629351, 5225.546450134158, 5929.673867937305, 5971.880562388641, 6000.189974353407, 4925.285833554186, 5291.550218231339, 5627.803026894039, 5950.583459157818, 5979.312379076462, 5890.587658863838, 6073.635581865102, 6143.416375444325, 6150.538709596887, 6289.96855015722, 3336.3485074887117, 3683.392240280431, 3992.3688521315134, 4018.598140185958, 4030.0, 5070.605583464577, 5190.506901844319, 5710.716338105689, 5993.760249590142, 6023.578349515492, 5403.540699040625, 5664.26364572603, 5698.515626171822, 5724.914126288192, 5845.736941837543, 4957.950420495749, 5778.942210578009, 5820.679862607597, 5823.82528524145, 5839.854003649943, 5245.291885595396, 5323.414424413234, 5596.244506991504, 5663.235463212413, 5783.306003279633, 5303.904957541827, 5395.406505284494, 5410.8637186191345, 5428.118894990101, 5747.965366234118, 5013.924791128063, 5661.18841970582, 5718.22803921482, 5722.914156287576, 5747.275687445615], "value": 4185.832109341639, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.2008111158835, 773.3928865840317, 798.269583331252, 865.5109862927446, 879.5250564695065, 15303.158326292063, 15741.60645983851, 16129.0, 16312.102834344107, 16330.75503867443, 12444.56444024457, 14725.484608038721, 14914.328855201515, 15126.394944202246, 15126.773098403533, 907.1336873285996, 917.9770505737376, 918.6830543462495, 918.8346097702411, 926.666400095965, 735.2427000189813, 755.0938873351972, 898.1781669772183, 900.9953901399924, 903.7198468474794, 969.2875736333789, 977.6480467031863, 978.4227305889524, 978.8189185000762, 981.7594689301131, 969.6460791811008, 970.277143528069, 976.1409959235898, 977.3207620703614, 981.3572110267714, 730.5653136383896, 730.6091241185993, 730.6711979609197, 731.3527528137637, 733.2887099513464, 15807.367705291774, 16115.516534503866, 16121.516354509384, 16261.756073658904, 16341.673166536602, 15027.023243489139, 15246.23768811555, 15351.385944562204, 15415.3833846646, 15508.767368489482, 11857.347845868473, 11881.709218379137, 12094.576689815902, 12166.087543434278, 12210.389480525939, 3825.7895815730126, 3835.5589107252463, 3860.0542866997484, 3938.3698608222835, 4054.898627534306, 115327.0, 115783.0, 116680.41659791731, 117974.23038654427, 119395.0, 11561.30632162073, 11808.52765889372, 11944.0, 11961.222520536137, 12053.51785928553, 24723.505529889662, 25308.0, 25498.745012549636, 25545.489090218463, 25600.615990760154, 7732.536047837148, 7825.295723384923, 7951.165127661628, 8109.675612975533, 8214.4660597061, 4403.141387429485, 4414.3157810539415, 4479.484859241164, 4496.550344965477, 4575.7483338416705, 3571.196480791853, 3671.100580357776, 3673.687736542424, 3677.0439685681918, 3678.429843374281, 644.5810223354763, 682.7780971184385, 683.6547543490506, 685.6331862453563, 686.7596341280612, 635.885540602696, 643.9034144878212, 662.6156829039146, 686.3891136888174, 719.989200161998, 8767.605457754416, 9958.751031224278, 10062.0, 10232.693019209435, 10258.58965641366, 632.4971647540217, 640.695669556966, 687.5221720903924, 696.2306651150406, 706.0820932787356, 4674.545337128609, 4742.312364707098, 4744.656291048052, 4821.662483626113, 4850.95149048512, 79891.0, 90918.0, 99772.50113749385, 107571.0, 110028.0, 73671.0, 93120.06879931114, 93395.0, 96623.51688241654, 97037.0, 72078.27921720821, 73947.0, 74310.0, 75195.62402188063, 76358.6182069086, 8964.641414343614, 9056.230220431336, 9110.316726245426, 9121.0, 9172.6789562365, 52969.735151324, 53032.93934121373, 53865.73067134639, 54639.0, 55723.442765571825, 70127.29872701412, 71579.64210178916, 71631.64184179046, 72646.63676681794, 74658.0, 10963.451827408438, 11287.661370158909, 11303.152263580429, 11977.760444791229, 11999.340036298088, 12061.035117190779, 12116.697082573006, 12210.328431936328, 12259.448324825225, 12719.0, 13463.192208467523, 13567.932160339134, 14598.124112553282, 14705.779413309023, 14793.921938623584, 13260.602181934557, 13731.656708582366, 14083.436662533384, 14258.714825703635, 14383.640408989859, 13425.798613021008, 14276.286185690466, 14282.928585357007, 14315.0, 14349.713005740035, 9412.247020238501, 9797.118259356692, 10196.745081372728, 10356.844647330145, 10647.414392208502, 10659.520321585393, 10827.0, 11470.139739519402, 11827.290362578273, 11882.16824822254], "value": 7698.5360900898995, "unit": "score"}], "name": "dromaeo_css", "value": 7505.840598364738, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 167.0, 158.0, 111.0, 114.0, 113.0, 112.0, 112.0, 113.0, 116.0], "value": 122.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 107.0, 107.0, 142.0, 107.0, 108.0, 107.0, 106.0, 125.0, 118.0], "value": 116.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 179.0, 179.0, 183.0, 182.0, 183.0, 182.0, 181.0, 184.0, 182.0], "value": 181.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 58.0, 88.0, 63.0, 58.0, 57.0, 75.0, 94.0, 57.0], "value": 68.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 86.0, 69.0, 68.0, 67.0, 94.0, 98.0, 68.0, 82.0], "value": 78.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 130.0, 88.0, 86.0, 88.0, 85.0, 89.0, 86.0, 88.0, 84.0], "value": 91.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 99.0, 145.0, 94.0, 93.0, 93.0, 94.0, 94.0, 101.0, 91.0], "value": 99.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 88.0, 94.0, 88.0, 85.0, 86.0, 87.0, 86.0, 84.0], "value": 86.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 53.0, 55.0, 56.0, 56.0, 57.0, 57.0, 56.0, 56.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 71.0, 80.0, 74.0, 72.0, 66.0, 67.0, 69.0, 67.0, 67.0], "value": 69.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 80.0, 81.0, 83.0, 82.0, 80.0, 86.0, 82.0, 81.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 132.0, 131.0, 129.0, 164.0, 156.0, 130.0, 138.0, 172.0, 171.0], "value": 145.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 163.0, 161.0, 163.0, 154.0, 161.0, 165.0, 220.0, 164.0, 161.0], "value": 167.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 64.0, 65.0, 62.0, 64.0, 64.0, 62.0, 62.0], "value": 63.5, "unit": "score"}], "name": "kraken", "value": 1428.8000000000002, "alertThreshold": 2.0}]} 04:58:21 INFO - Return code: 0 04:58:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:58:21 INFO - # TBPL SUCCESS # 04:58:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:58:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:58:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:58:21 INFO - 2017-04-09 04:58:21.558 screenresolution[1962:23029] starting screenresolution argv=screenresolution get 04:58:21 INFO - 2017-04-09 04:58:21.561 screenresolution[1962:23029] Display 0: 1600x1200x32@60 04:58:21 INFO - 2017-04-09 04:58:21.567 screenresolution[1963:23032] starting screenresolution argv=screenresolution list 04:58:21 INFO - Available Modes on Display 0 04:58:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:58:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:58:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:58:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:58:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:58:21 INFO - Intel Iris: 04:58:21 INFO - Chipset Model: Intel Iris 04:58:21 INFO - Type: GPU 04:58:21 INFO - Bus: Built-In 04:58:21 INFO - VRAM (Dynamic, Max): 1536 MB 04:58:21 INFO - Vendor: Intel (0x8086) 04:58:21 INFO - Device ID: 0x0a2e 04:58:21 INFO - Revision ID: 0x0009 04:58:21 INFO - Displays: 04:58:21 INFO - Display: 04:58:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:58:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:58:21 INFO - Display Serial Number: 1600x1200 60 04:58:21 INFO - Main Display: Yes 04:58:21 INFO - Mirror: Off 04:58:21 INFO - Online: Yes 04:58:21 INFO - Rotation: Supported 04:58:21 INFO - Return code: 0 04:58:21 INFO - Running post-action listener: _resource_record_post_action 04:58:21 INFO - [mozharness: 2017-04-09 11:58:21.802373Z] Finished run-tests step (success) 04:58:21 INFO - Running post-run listener: _resource_record_post_run 04:58:21 INFO - Total resource usage - Wall time: 1191s; CPU: 54.0%; Read bytes: 774144; Write bytes: 422465024; Read time: 8; Write time: 1663 04:58:21 INFO - TinderboxPrint: CPU usage
53.6% 04:58:21 INFO - TinderboxPrint: I/O read bytes / time
774,144 / 8 04:58:21 INFO - TinderboxPrint: I/O write bytes / time
422,465,024 / 1,663 04:58:21 INFO - TinderboxPrint: CPU idle
2,211.2 (46.4%) 04:58:21 INFO - TinderboxPrint: CPU system
953.6 (20.0%) 04:58:21 INFO - TinderboxPrint: CPU user
1,600.9 (33.6%) 04:58:21 INFO - TinderboxPrint: Swap in / out
122,400,768 / 0 04:58:21 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 122636800; Write bytes: 122769408; Read time: 11094; Write time: 245 04:58:21 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 610304; Write bytes: 298294784; Read time: 5; Write time: 1411 04:58:22 INFO - Running post-run listener: _upload_blobber_files 04:58:22 INFO - Blob upload gear active. 04:58:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:58:22 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 04:58:22 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'] 04:58:22 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 04:58:22 INFO - (blobuploader) - INFO - Open directory for files ... 04:58:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:58:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:58:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:58:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:58:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:58:23 INFO - (blobuploader) - INFO - Done attempting. 04:58:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:58:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:58:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:58:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:58:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:58:24 INFO - (blobuploader) - INFO - Done attempting. 04:58:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:58:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:58:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:58:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:58:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:58:26 INFO - (blobuploader) - INFO - Done attempting. 04:58:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:58:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:58:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:58:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:58:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:58:27 INFO - (blobuploader) - INFO - Done attempting. 04:58:27 INFO - (blobuploader) - INFO - Iteration through files over. 04:58:28 INFO - Return code: 0 04:58:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:58:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:58:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b44d642e006d67c7aaded04165b89af13186a2a02fd4be42062da00ef24b45cef3bc05d720cfe9edeb71cb1be86f3a7c013a080a29fb94bd1b0be2e7a3f96943", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f15aedb6b70c77f199821a796c404672b12fc27d1815b6887f490b41bfd2e26b74fff28c9fd9ddaf3faff1424c18346ca4017c9ae3b5a17fdf0822221dbd52be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/093fc6af7302c864cc317c27db6da2c9a640d5f0ddf2e6145540af17a5c049d88e41faf80caafbe43ebbab9837ab333f9eafd0a09129d337ae9a37bab4356e2f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d424962248354c00ff35c087caaabd51dafa1bc24449f340bde15ef8bd88ab043fa2d81f205bc4950c166436e1a0d80e981d29983530d7f6bda90d4aca57bef5"} 04:58:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:58:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:58:28 INFO - Contents: 04:58:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b44d642e006d67c7aaded04165b89af13186a2a02fd4be42062da00ef24b45cef3bc05d720cfe9edeb71cb1be86f3a7c013a080a29fb94bd1b0be2e7a3f96943", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f15aedb6b70c77f199821a796c404672b12fc27d1815b6887f490b41bfd2e26b74fff28c9fd9ddaf3faff1424c18346ca4017c9ae3b5a17fdf0822221dbd52be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/093fc6af7302c864cc317c27db6da2c9a640d5f0ddf2e6145540af17a5c049d88e41faf80caafbe43ebbab9837ab333f9eafd0a09129d337ae9a37bab4356e2f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d424962248354c00ff35c087caaabd51dafa1bc24449f340bde15ef8bd88ab043fa2d81f205bc4950c166436e1a0d80e981d29983530d7f6bda90d4aca57bef5"} 04:58:28 INFO - Running post-run listener: copy_logs_to_upload_dir 04:58:28 INFO - Copying logs to upload dir... 04:58:28 INFO - mkdir: /builds/slave/test/build/upload/logs 04:58:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.807431 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-04-09 04:58:28.094536) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-09 04:58:28.098508) ========= 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.sZ6m2fj9zC/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.DUl7J8zNsv/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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/b44d642e006d67c7aaded04165b89af13186a2a02fd4be42062da00ef24b45cef3bc05d720cfe9edeb71cb1be86f3a7c013a080a29fb94bd1b0be2e7a3f96943", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f15aedb6b70c77f199821a796c404672b12fc27d1815b6887f490b41bfd2e26b74fff28c9fd9ddaf3faff1424c18346ca4017c9ae3b5a17fdf0822221dbd52be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/093fc6af7302c864cc317c27db6da2c9a640d5f0ddf2e6145540af17a5c049d88e41faf80caafbe43ebbab9837ab333f9eafd0a09129d337ae9a37bab4356e2f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d424962248354c00ff35c087caaabd51dafa1bc24449f340bde15ef8bd88ab043fa2d81f205bc4950c166436e1a0d80e981d29983530d7f6bda90d4aca57bef5"} build_url:https://queue.taskcluster.net/v1/task/PJTq_tAQRwOtLE9ww20l9g/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011111 build_url: 'https://queue.taskcluster.net/v1/task/PJTq_tAQRwOtLE9ww20l9g/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b44d642e006d67c7aaded04165b89af13186a2a02fd4be42062da00ef24b45cef3bc05d720cfe9edeb71cb1be86f3a7c013a080a29fb94bd1b0be2e7a3f96943", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f15aedb6b70c77f199821a796c404672b12fc27d1815b6887f490b41bfd2e26b74fff28c9fd9ddaf3faff1424c18346ca4017c9ae3b5a17fdf0822221dbd52be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/093fc6af7302c864cc317c27db6da2c9a640d5f0ddf2e6145540af17a5c049d88e41faf80caafbe43ebbab9837ab333f9eafd0a09129d337ae9a37bab4356e2f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d424962248354c00ff35c087caaabd51dafa1bc24449f340bde15ef8bd88ab043fa2d81f205bc4950c166436e1a0d80e981d29983530d7f6bda90d4aca57bef5"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-09 04:58:28.136929) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 04:58:28.137270) ========= 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.sZ6m2fj9zC/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.DUl7J8zNsv/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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.005302 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 04:58:28.185849) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-09 04:58:28.186186) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-09 04:58:28.186561) ========= ========= Total master_lag: 0.25 =========