builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0335 starttime: 1481988591.45 results: success (0) buildid: 20161217062449 builduid: fddecde21baf4099b4dc1e2e9ddeac44 revision: 56a8ce2bf0876fc9315407676e2db35e238e510d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-17 07:29:51.458164) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-17 07:29:51.458793) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-17 07:29:51.459077) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-17 07:29:51.485944) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 07:29:51.486332) ========= 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.J44IH4ziXi/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.RxH2Y9fCpg/Listeners TMPDIR=/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 --2016-12-17 07:29:51-- 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% 20.1M=0.001s 2016-12-17 07:29:51 (20.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117954 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 07:29:51.627995) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 07:29:51.628428) ========= 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.J44IH4ziXi/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.RxH2Y9fCpg/Listeners TMPDIR=/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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.026163 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 07:29:51.678948) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-17 07:29:51.679552) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 56a8ce2bf0876fc9315407676e2db35e238e510d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 56a8ce2bf0876fc9315407676e2db35e238e510d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.J44IH4ziXi/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.RxH2Y9fCpg/Listeners TMPDIR=/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 2016-12-17 07:29:51,778 truncating revision to first 12 chars 2016-12-17 07:29:51,778 Setting DEBUG logging. 2016-12-17 07:29:51,778 attempt 1/10 2016-12-17 07:29:51,778 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/56a8ce2bf087?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-17 07:29:53,442 unpacking tar archive at: mozilla-central-56a8ce2bf087/testing/mozharness/ program finished with exit code 0 elapsedTime=1.945542 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-17 07:29:53.650984) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-17 07:29:53.651306) ========= script_repo_revision: 56a8ce2bf0876fc9315407676e2db35e238e510d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-17 07:29:53.651771) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-17 07:29:53.652085) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-17 07:29:53.672021) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-12-17 07:29:53.672412) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.J44IH4ziXi/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.RxH2Y9fCpg/Listeners TMPDIR=/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 07:29:53 INFO - MultiFileLogger online at 20161217 07:29:53 in /builds/slave/test 07:29:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:29:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:29:53 INFO - {'append_to_log': False, 07:29:53 INFO - 'base_work_dir': '/builds/slave/test', 07:29:53 INFO - 'blob_upload_branch': 'Firefox', 07:29:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:29:53 INFO - 'branch': 'Firefox', 07:29:53 INFO - 'buildbot_json_path': 'buildprops.json', 07:29:53 INFO - 'config_files': ('talos/mac_config.py',), 07:29:53 INFO - 'default_actions': ('clobber', 07:29:53 INFO - 'read-buildbot-config', 07:29:53 INFO - 'download-and-extract', 07:29:53 INFO - 'populate-webroot', 07:29:53 INFO - 'create-virtualenv', 07:29:53 INFO - 'install', 07:29:53 INFO - 'run-tests'), 07:29:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:29:53 INFO - 'download_minidump_stackwalk': True, 07:29:53 INFO - 'download_symbols': 'ondemand', 07:29:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:29:53 INFO - 'tooltool.py': '/tools/tooltool.py', 07:29:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:29:53 INFO - '/tools/misc-python/virtualenv.py')}, 07:29:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:29:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:29:53 INFO - 'installer_path': 'installer.exe', 07:29:53 INFO - 'log_level': 'info', 07:29:53 INFO - 'log_name': 'talos', 07:29:53 INFO - 'log_to_console': True, 07:29:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:29:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:29:53 INFO - 'opt_config_files': (), 07:29:53 INFO - 'pip_index': False, 07:29:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:29:53 INFO - 'cmd': ('bash', 07:29:53 INFO - '-c', 07:29:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:29:53 INFO - 'enabled': True, 07:29:53 INFO - 'halt_on_failure': False, 07:29:53 INFO - 'name': 'check_screen_resolution'},), 07:29:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:29:53 INFO - 'cmd': ('bash', 07:29:53 INFO - '-c', 07:29:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:29:53 INFO - 'enabled': True, 07:29:53 INFO - 'halt_on_failure': False, 07:29:53 INFO - 'name': 'check_screen_resolution'},), 07:29:53 INFO - 'run_cmd_checks_enabled': True, 07:29:53 INFO - 'sps_profile': False, 07:29:53 INFO - 'sps_profile_interval': 0, 07:29:53 INFO - 'suite': 'dromaeojs', 07:29:53 INFO - 'system_bits': '32', 07:29:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:29:53 INFO - 'title': 't-yosemite-r7-0335', 07:29:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:29:53 INFO - 'use_talos_json': True, 07:29:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:29:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:29:53 INFO - 'work_dir': 'build'} 07:29:53 INFO - [mozharness: 2016-12-17 15:29:53.875137Z] Running clobber step. 07:29:53 INFO - Running pre-action listener: _resource_record_pre_action 07:29:53 INFO - Running main action method: clobber 07:29:53 INFO - rmtree: /builds/slave/test/build 07:29:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:29:55 INFO - Running post-action listener: _resource_record_post_action 07:29:55 INFO - [mozharness: 2016-12-17 15:29:55.217909Z] Finished clobber step (success) 07:29:55 INFO - [mozharness: 2016-12-17 15:29:55.218035Z] Running read-buildbot-config step. 07:29:55 INFO - Running pre-action listener: _resource_record_pre_action 07:29:55 INFO - Running main action method: read_buildbot_config 07:29:55 INFO - Using buildbot properties: 07:29:55 INFO - { 07:29:55 INFO - "project": "", 07:29:55 INFO - "product": "firefox", 07:29:55 INFO - "script_repo_revision": "production", 07:29:55 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 07:29:55 INFO - "repository": "", 07:29:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 07:29:55 INFO - "buildid": "20161217062449", 07:29:55 INFO - "pgo_build": "False", 07:29:55 INFO - "basedir": "/builds/slave/test", 07:29:55 INFO - "buildnumber": 47, 07:29:55 INFO - "slavename": "t-yosemite-r7-0335", 07:29:55 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 07:29:55 INFO - "platform": "yosemite_r7", 07:29:55 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:29:55 INFO - "branch": "mozilla-central", 07:29:55 INFO - "repo_path": "mozilla-central", 07:29:55 INFO - "revision": "56a8ce2bf0876fc9315407676e2db35e238e510d", 07:29:55 INFO - "stage_platform": "macosx64", 07:29:55 INFO - "builduid": "fddecde21baf4099b4dc1e2e9ddeac44", 07:29:55 INFO - "slavebuilddir": "test" 07:29:55 INFO - } 07:29:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/K_tOI8VjQ8qRENhmOc-Vug/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 07:29:55 INFO - Running post-action listener: _resource_record_post_action 07:29:55 INFO - [mozharness: 2016-12-17 15:29:55.221241Z] Finished read-buildbot-config step (success) 07:29:55 INFO - [mozharness: 2016-12-17 15:29:55.221327Z] Running download-and-extract step. 07:29:55 INFO - Running pre-action listener: _resource_record_pre_action 07:29:55 INFO - Running main action method: download_and_extract 07:29:55 INFO - mkdir: /builds/slave/test/build/tests 07:29: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')]} 07:29:55 INFO - trying https://queue.taskcluster.net/v1/task/K_tOI8VjQ8qRENhmOc-Vug/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 07:29:55 INFO - Downloading https://queue.taskcluster.net/v1/task/K_tOI8VjQ8qRENhmOc-Vug/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:29:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K_tOI8VjQ8qRENhmOc-Vug/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 07:29:56 INFO - Downloaded 1199 bytes. 07:29:56 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:29:56 INFO - Using the following test package requirements: 07:29:56 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:29:56 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:29:56 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 07:29:56 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:29:56 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 07:29:56 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:29:56 INFO - u'jsshell-mac.zip'], 07:29:56 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:29:56 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 07:29:56 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:29:56 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:29:56 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 07:29:56 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:29:56 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 07:29:56 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:29:56 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 07:29:56 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:29:56 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 07:29:56 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:29:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K_tOI8VjQ8qRENhmOc-Vug/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:29:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K_tOI8VjQ8qRENhmOc-Vug/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:29:56 INFO - Fetch https://queue.taskcluster.net/v1/task/K_tOI8VjQ8qRENhmOc-Vug/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:29:57 INFO - Expected file size: 16278009 07:29:57 INFO - Obtained file size: 16278009 07:30:03 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:30:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K_tOI8VjQ8qRENhmOc-Vug/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:30:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K_tOI8VjQ8qRENhmOc-Vug/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:30:03 INFO - Fetch https://queue.taskcluster.net/v1/task/K_tOI8VjQ8qRENhmOc-Vug/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:30:04 INFO - Expected file size: 16278009 07:30:04 INFO - Obtained file size: 16278009 07:30:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K_tOI8VjQ8qRENhmOc-Vug/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 07:30:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K_tOI8VjQ8qRENhmOc-Vug/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:30:11 INFO - Fetch https://queue.taskcluster.net/v1/task/K_tOI8VjQ8qRENhmOc-Vug/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 07:30:13 INFO - Expected file size: 14409734 07:30:13 INFO - Obtained file size: 14409734 07:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:13 INFO - trying https://queue.taskcluster.net/v1/task/K_tOI8VjQ8qRENhmOc-Vug/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:30:13 INFO - Downloading https://queue.taskcluster.net/v1/task/K_tOI8VjQ8qRENhmOc-Vug/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 07:30:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K_tOI8VjQ8qRENhmOc-Vug/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 07:30:16 INFO - Downloaded 69566688 bytes. 07:30:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K_tOI8VjQ8qRENhmOc-Vug/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:30:16 INFO - mkdir: /builds/slave/test/properties 07:30:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:30:16 INFO - Writing to file /builds/slave/test/properties/build_url 07:30:16 INFO - Contents: 07:30:16 INFO - build_url:https://queue.taskcluster.net/v1/task/K_tOI8VjQ8qRENhmOc-Vug/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:30:17 INFO - Running post-action listener: _resource_record_post_action 07:30:17 INFO - Running post-action listener: set_extra_try_arguments 07:30:17 INFO - [mozharness: 2016-12-17 15:30:17.131033Z] Finished download-and-extract step (success) 07:30:17 INFO - [mozharness: 2016-12-17 15:30:17.131182Z] Running populate-webroot step. 07:30:17 INFO - Running pre-action listener: _resource_record_pre_action 07:30:17 INFO - Running main action method: populate_webroot 07:30:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:30:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:30:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:30:17 INFO - '--tppagecycles', 07:30:17 INFO - '7'], 07:30:17 INFO - 'tests': ['tsvgm']}}, 07:30:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:30:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:30:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:30:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:30:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:30:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:30:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:30:17 INFO - 'talos_options': ['--disable-e10s'], 07:30:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:30:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:30:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:30:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:30:17 INFO - 'talos_options': ['--disable-e10s'], 07:30:17 INFO - 'tests': ['damp', 'tps']}, 07:30:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:30:17 INFO - 'tests': ['damp', 'tps']}, 07:30:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:30:17 INFO - 'tests': ['dromaeo_dom']}, 07:30:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:30:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:30:17 INFO - 'tests': ['basic_compositor_video']}, 07:30:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:30:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:30:17 INFO - 'tests': ['a11yr', 07:30:17 INFO - 'ts_paint', 07:30:17 INFO - 'tpaint', 07:30:17 INFO - 'sessionrestore', 07:30:17 INFO - 'sessionrestore_no_auto_restore', 07:30:17 INFO - 'tabpaint']}, 07:30:17 INFO - 'other-e10s': {'tests': ['a11yr', 07:30:17 INFO - 'ts_paint', 07:30:17 INFO - 'tpaint', 07:30:17 INFO - 'sessionrestore', 07:30:17 INFO - 'sessionrestore_no_auto_restore', 07:30:17 INFO - 'tabpaint']}, 07:30:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:30:17 INFO - 'ts_paint', 07:30:17 INFO - 'tpaint', 07:30:17 INFO - 'sessionrestore', 07:30:17 INFO - 'sessionrestore_no_auto_restore', 07:30:17 INFO - 'tabpaint']}, 07:30:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:30:17 INFO - 'ts_paint', 07:30:17 INFO - 'tpaint', 07:30:17 INFO - 'sessionrestore', 07:30:17 INFO - 'sessionrestore_no_auto_restore', 07:30:17 INFO - 'tabpaint']}, 07:30:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:30:17 INFO - 'tests': ['a11yr', 07:30:17 INFO - 'ts_paint', 07:30:17 INFO - 'tpaint', 07:30:17 INFO - 'sessionrestore', 07:30:17 INFO - 'sessionrestore_no_auto_restore', 07:30:17 INFO - 'tabpaint']}, 07:30:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:30:17 INFO - 'tests': ['a11yr', 07:30:17 INFO - 'ts_paint', 07:30:17 INFO - 'tpaint', 07:30:17 INFO - 'sessionrestore', 07:30:17 INFO - 'sessionrestore_no_auto_restore', 07:30:17 INFO - 'tabpaint']}, 07:30:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:30:17 INFO - 'tests': ['tsvgx', 07:30:17 INFO - 'tsvgr_opacity', 07:30:17 INFO - 'tart', 07:30:17 INFO - 'tscrollx', 07:30:17 INFO - 'cart', 07:30:17 INFO - 'tsvg_static']}, 07:30:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:30:17 INFO - 'tsvgr_opacity', 07:30:17 INFO - 'tart', 07:30:17 INFO - 'tscrollx', 07:30:17 INFO - 'cart', 07:30:17 INFO - 'tsvg_static']}, 07:30:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:30:17 INFO - 'talos_options': ['--disable-e10s'], 07:30:17 INFO - 'tests': ['tp5o']}, 07:30:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:30:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:30:17 INFO - 'talos_options': ['--disable-e10s', 07:30:17 INFO - '--xperf_path', 07:30:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:30:17 INFO - 'tests': ['tp5n']}, 07:30:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:30:17 INFO - 'talos_options': ['--xperf_path', 07:30:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:30:17 INFO - 'tests': ['tp5n']}}, 07:30:17 INFO - 'talos.zip': {'path': '', 07:30:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:30:17 INFO - Running post-action listener: _resource_record_post_action 07:30:17 INFO - [mozharness: 2016-12-17 15:30:17.149374Z] Finished populate-webroot step (success) 07:30:17 INFO - [mozharness: 2016-12-17 15:30:17.149468Z] Running create-virtualenv step. 07:30:17 INFO - Running pre-action listener: _resource_record_pre_action 07:30:17 INFO - Running main action method: create_virtualenv 07:30:17 INFO - Creating virtualenv /builds/slave/test/build/venv 07:30:17 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 07:30:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:30:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:30:17 INFO - Using real prefix '/tools/python27' 07:30:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:30:18 INFO - Installing distribute.............................................................................................................................................................................................done. 07:30:20 INFO - Installing pip.................done. 07:30:20 INFO - Return code: 0 07:30:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:30:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:30:21 INFO - Reading from file tmpfile_stdout 07:30:21 INFO - Output received: 07:30:21 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) 07:30:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:30:21 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')]} 07:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:21 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')]} 07:30:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:21 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 0x104e193f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d8f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bab593910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c2ed30>, '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 0x104a95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c26b20>, '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.J44IH4ziXi/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.RxH2Y9fCpg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 07:30:21 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 07:30:21 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 07:30:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J44IH4ziXi/Render', 07:30:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:30:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:30:21 INFO - 'HOME': '/Users/cltbld', 07:30:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:30:21 INFO - 'LOGNAME': 'cltbld', 07:30:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:21 INFO - 'MOZ_NO_REMOTE': '1', 07:30:21 INFO - 'NO_EM_RESTART': '1', 07:30:21 INFO - 'PAGER': '/bin/cat', 07:30:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:30:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:21 INFO - 'PWD': '/builds/slave/test', 07:30:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:30:21 INFO - 'SHELL': '/bin/bash', 07:30:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RxH2Y9fCpg/Listeners', 07:30:21 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 07:30:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:30:21 INFO - 'USER': 'cltbld', 07:30:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:30:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:30:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:21 INFO - 'XPC_FLAGS': '0x0', 07:30:21 INFO - 'XPC_SERVICE_NAME': '0', 07:30:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:30:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:21 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 07:30:21 INFO - Cleaning up... 07:30:21 INFO - Return code: 0 07:30:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:30:21 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')]} 07:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:21 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')]} 07:30:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:21 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 0x104e193f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d8f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bab593910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c2ed30>, '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 0x104a95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c26b20>, '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.J44IH4ziXi/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.RxH2Y9fCpg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 07:30:21 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 07:30:21 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 07:30:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J44IH4ziXi/Render', 07:30:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:30:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:30:21 INFO - 'HOME': '/Users/cltbld', 07:30:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:30:21 INFO - 'LOGNAME': 'cltbld', 07:30:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:21 INFO - 'MOZ_NO_REMOTE': '1', 07:30:21 INFO - 'NO_EM_RESTART': '1', 07:30:21 INFO - 'PAGER': '/bin/cat', 07:30:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:30:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:21 INFO - 'PWD': '/builds/slave/test', 07:30:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:30:21 INFO - 'SHELL': '/bin/bash', 07:30:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RxH2Y9fCpg/Listeners', 07:30:21 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 07:30:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:30:21 INFO - 'USER': 'cltbld', 07:30:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:30:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:30:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:21 INFO - 'XPC_FLAGS': '0x0', 07:30:21 INFO - 'XPC_SERVICE_NAME': '0', 07:30:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:30:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:21 INFO - Downloading/unpacking psutil>=3.1.1 07:30:21 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 07:30:21 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 07:30:21 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 07:30:21 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 07:30:21 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 07:30:21 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 07:30:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:30:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:30:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:30:25 INFO - Installing collected packages: psutil 07:30:25 INFO - Running setup.py install for psutil 07:30:25 INFO - building 'psutil._psutil_osx' extension 07:30:25 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 07:30:25 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 07:30:25 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 07:30:26 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 07:30:26 INFO - building 'psutil._psutil_posix' extension 07:30:26 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 07:30:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:30:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:30:26 INFO - ^ 07:30:26 INFO - 1 warning generated. 07:30:26 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 07:30:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:30:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:30:26 INFO - Successfully installed psutil 07:30:26 INFO - Cleaning up... 07:30:26 INFO - Return code: 0 07:30:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104e193f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d8f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bab593910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c2ed30>, '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 0x104a95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c26b20>, '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.J44IH4ziXi/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.RxH2Y9fCpg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 07:30:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:30:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:30:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J44IH4ziXi/Render', 07:30:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:30:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:30:26 INFO - 'HOME': '/Users/cltbld', 07:30:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:30:26 INFO - 'LOGNAME': 'cltbld', 07:30:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:26 INFO - 'MOZ_NO_REMOTE': '1', 07:30:26 INFO - 'NO_EM_RESTART': '1', 07:30:26 INFO - 'PAGER': '/bin/cat', 07:30:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:30:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:26 INFO - 'PWD': '/builds/slave/test', 07:30:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:30:26 INFO - 'SHELL': '/bin/bash', 07:30:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RxH2Y9fCpg/Listeners', 07:30:26 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 07:30:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:30:26 INFO - 'USER': 'cltbld', 07:30:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:30:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:30:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:26 INFO - 'XPC_FLAGS': '0x0', 07:30:26 INFO - 'XPC_SERVICE_NAME': '0', 07:30:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:30:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:30: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 07:30: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 07:30: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 07:30: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 07:30: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 07:30: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 07:30:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:30:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:30:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:30:29 INFO - Installing collected packages: mozsystemmonitor 07:30:29 INFO - Running setup.py install for mozsystemmonitor 07:30:29 INFO - Successfully installed mozsystemmonitor 07:30:29 INFO - Cleaning up... 07:30:29 INFO - Return code: 0 07:30:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:30: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')]} 07:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30: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')]} 07:30:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104e193f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d8f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bab593910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c2ed30>, '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 0x104a95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c26b20>, '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.J44IH4ziXi/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.RxH2Y9fCpg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 07:30: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==2.5.1'] in /builds/slave/test/build 07:30: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==2.5.1 07:30:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J44IH4ziXi/Render', 07:30:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:30:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:30:29 INFO - 'HOME': '/Users/cltbld', 07:30:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:30:29 INFO - 'LOGNAME': 'cltbld', 07:30:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:29 INFO - 'MOZ_NO_REMOTE': '1', 07:30:29 INFO - 'NO_EM_RESTART': '1', 07:30:29 INFO - 'PAGER': '/bin/cat', 07:30:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:30:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:29 INFO - 'PWD': '/builds/slave/test', 07:30:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:30:29 INFO - 'SHELL': '/bin/bash', 07:30:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RxH2Y9fCpg/Listeners', 07:30:29 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 07:30:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:30:29 INFO - 'USER': 'cltbld', 07:30:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:30:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:30:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:29 INFO - 'XPC_FLAGS': '0x0', 07:30:29 INFO - 'XPC_SERVICE_NAME': '0', 07:30:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:30:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:30 INFO - Downloading/unpacking jsonschema==2.5.1 07:30:30 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 07:30:30 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 07:30:30 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 07:30:30 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 07:30:30 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 07:30:30 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 07:30:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:30:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:33 INFO - Downloading functools32-3.2.3-2.tar.gz 07:30:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:30:33 INFO - warning: no files found matching '*.txt' 07:30:33 INFO - no previously-included directories found matching 'build' 07:30:33 INFO - no previously-included directories found matching 'dist' 07:30:33 INFO - no previously-included directories found matching '.git*' 07:30:33 INFO - Installing collected packages: jsonschema, functools32 07:30:33 INFO - Running setup.py install for functools32 07:30:33 INFO - warning: no files found matching '*.txt' 07:30:33 INFO - no previously-included directories found matching 'build' 07:30:33 INFO - no previously-included directories found matching 'dist' 07:30:33 INFO - no previously-included directories found matching '.git*' 07:30:33 INFO - Successfully installed jsonschema functools32 07:30:33 INFO - Cleaning up... 07:30:33 INFO - Return code: 0 07:30:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:33 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 0x104e193f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d8f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bab593910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c2ed30>, '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 0x104a95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c26b20>, '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.J44IH4ziXi/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.RxH2Y9fCpg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 07:30:33 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 07:30:33 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 07:30:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J44IH4ziXi/Render', 07:30:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:30:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:30:33 INFO - 'HOME': '/Users/cltbld', 07:30:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:30:33 INFO - 'LOGNAME': 'cltbld', 07:30:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:33 INFO - 'MOZ_NO_REMOTE': '1', 07:30:33 INFO - 'NO_EM_RESTART': '1', 07:30:33 INFO - 'PAGER': '/bin/cat', 07:30:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:30:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:33 INFO - 'PWD': '/builds/slave/test', 07:30:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:30:33 INFO - 'SHELL': '/bin/bash', 07:30:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RxH2Y9fCpg/Listeners', 07:30:33 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 07:30:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:30:33 INFO - 'USER': 'cltbld', 07:30:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:30:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:30:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:33 INFO - 'XPC_FLAGS': '0x0', 07:30:33 INFO - 'XPC_SERVICE_NAME': '0', 07:30:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:30:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:30:33 INFO - Cleaning up... 07:30:33 INFO - Return code: 0 07:30:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:33 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 0x104e193f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d8f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bab593910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c2ed30>, '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 0x104a95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c26b20>, '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.J44IH4ziXi/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.RxH2Y9fCpg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 07:30:33 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 07:30:33 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 07:30:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J44IH4ziXi/Render', 07:30:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:30:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:30:33 INFO - 'HOME': '/Users/cltbld', 07:30:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:30:33 INFO - 'LOGNAME': 'cltbld', 07:30:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:33 INFO - 'MOZ_NO_REMOTE': '1', 07:30:33 INFO - 'NO_EM_RESTART': '1', 07:30:33 INFO - 'PAGER': '/bin/cat', 07:30:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:30:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:33 INFO - 'PWD': '/builds/slave/test', 07:30:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:30:33 INFO - 'SHELL': '/bin/bash', 07:30:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RxH2Y9fCpg/Listeners', 07:30:33 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 07:30:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:30:33 INFO - 'USER': 'cltbld', 07:30:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:30:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:30:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:33 INFO - 'XPC_FLAGS': '0x0', 07:30:33 INFO - 'XPC_SERVICE_NAME': '0', 07:30:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:30:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:33 INFO - Downloading/unpacking blobuploader==1.2.4 07:30:33 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 07:30:33 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 07:30:33 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 07:30:33 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 07:30:33 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 07:30:33 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 07:30:36 INFO - Downloading blobuploader-1.2.4.tar.gz 07:30:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:30:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:30:36 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 07:30:36 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 07:30:36 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 07:30:36 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 07:30:36 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 07:30:36 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 07:30:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:30:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:37 INFO - Downloading docopt-0.6.1.tar.gz 07:30:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:30:37 INFO - Installing collected packages: blobuploader, requests, docopt 07:30:37 INFO - Running setup.py install for blobuploader 07:30:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:30:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:30:37 INFO - Running setup.py install for requests 07:30:38 INFO - Running setup.py install for docopt 07:30:38 INFO - Successfully installed blobuploader requests docopt 07:30:38 INFO - Cleaning up... 07:30:38 INFO - Return code: 0 07:30:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:38 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 0x104e193f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d8f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bab593910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c2ed30>, '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 0x104a95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c26b20>, '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.J44IH4ziXi/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.RxH2Y9fCpg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 07:30:38 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 07:30:38 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 07:30:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J44IH4ziXi/Render', 07:30:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:30:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:30:38 INFO - 'HOME': '/Users/cltbld', 07:30:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:30:38 INFO - 'LOGNAME': 'cltbld', 07:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:38 INFO - 'MOZ_NO_REMOTE': '1', 07:30:38 INFO - 'NO_EM_RESTART': '1', 07:30:38 INFO - 'PAGER': '/bin/cat', 07:30:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:38 INFO - 'PWD': '/builds/slave/test', 07:30:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:30:38 INFO - 'SHELL': '/bin/bash', 07:30:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RxH2Y9fCpg/Listeners', 07:30:38 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 07:30:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:30:38 INFO - 'USER': 'cltbld', 07:30:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:30:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:38 INFO - 'XPC_FLAGS': '0x0', 07:30:38 INFO - 'XPC_SERVICE_NAME': '0', 07:30:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:30:39 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-MUGZ55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:30:39 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-LxROrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:30:39 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-BL667Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:30:39 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-jTnFVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:30:39 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-VjeYa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:30:39 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-MHvkms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:30:39 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-lsEAWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:30:39 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-N8l0E9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:30:39 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-puJ_OF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:30:39 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-B_a2Fz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:30:40 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-ZAXrbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:30:40 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-v9sCWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:30:40 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-sfu5Kp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:30:40 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-3Pl0SW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:30:40 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-4oDl1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:30:40 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-97IiqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:30:40 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-WpG2gF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:30:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:30:40 INFO - Running setup.py install for manifestparser 07:30:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:30:40 INFO - Running setup.py install for mozcrash 07:30:41 INFO - Running setup.py install for mozdebug 07:30:41 INFO - Running setup.py install for mozdevice 07:30:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:30:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:30:41 INFO - Running setup.py install for mozfile 07:30:41 INFO - Running setup.py install for mozhttpd 07:30:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:30:41 INFO - Running setup.py install for mozinfo 07:30:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:30:41 INFO - Running setup.py install for mozInstall 07:30:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:30:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:30:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:30:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:30:41 INFO - Running setup.py install for mozleak 07:30:42 INFO - Running setup.py install for mozlog 07:30:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:30:42 INFO - Running setup.py install for moznetwork 07:30:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:30:42 INFO - Running setup.py install for mozprocess 07:30:42 INFO - Running setup.py install for mozprofile 07:30:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:30:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:30:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:30:42 INFO - Running setup.py install for mozrunner 07:30:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:30:42 INFO - Running setup.py install for mozscreenshot 07:30:43 INFO - Running setup.py install for moztest 07:30:43 INFO - Running setup.py install for mozversion 07:30:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:30:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:30:43 INFO - Cleaning up... 07:30:43 INFO - Return code: 0 07:30:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:30:43 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')]} 07:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:43 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')]} 07:30:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:43 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 0x104e193f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d8f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bab593910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c2ed30>, '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 0x104a95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c26b20>, '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.J44IH4ziXi/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.RxH2Y9fCpg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 07:30:43 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 07:30:43 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 07:30:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J44IH4ziXi/Render', 07:30:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:30:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:30:43 INFO - 'HOME': '/Users/cltbld', 07:30:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:30:43 INFO - 'LOGNAME': 'cltbld', 07:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:43 INFO - 'MOZ_NO_REMOTE': '1', 07:30:43 INFO - 'NO_EM_RESTART': '1', 07:30:43 INFO - 'PAGER': '/bin/cat', 07:30:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:43 INFO - 'PWD': '/builds/slave/test', 07:30:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:30:43 INFO - 'SHELL': '/bin/bash', 07:30:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RxH2Y9fCpg/Listeners', 07:30:43 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 07:30:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:30:43 INFO - 'USER': 'cltbld', 07:30:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:30:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:43 INFO - 'XPC_FLAGS': '0x0', 07:30:43 INFO - 'XPC_SERVICE_NAME': '0', 07:30:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:30:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:30:43 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-l1Rrjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:30:43 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)) 07:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:30:43 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-PJaLIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:30:43 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)) 07:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:30:43 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-kywa34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:30:43 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)) 07:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:30:43 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-xhgdpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:30:44 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)) 07:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:30:44 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-Ly6CvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:30:44 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)) 07:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:30:44 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-ROcQOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:30:44 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)) 07:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:30:44 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-Psh7Hy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:30:44 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)) 07:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:30:44 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-ccXej8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:30:44 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)) 07:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:30:44 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-GoiGVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:30:44 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)) 07:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:30:44 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-q61unU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:30:44 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)) 07:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:30:44 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-857hj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:30:44 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)) 07:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:30:44 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-jq1mwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:30:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 07:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:30:44 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-2OBkHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:30:45 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)) 07:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:30:45 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-C2pTLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:30:45 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)) 07:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:30:45 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-xKAb1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:30:45 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)) 07:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:30:45 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-l7AMOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:30:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 07:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:30:45 INFO - Running setup.py (path:/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/pip-8Sc2lz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:30:45 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)) 07:30:45 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)) 07:30:45 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)) 07:30:45 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)) 07:30:45 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)) 07:30:45 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)) 07:30:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:48 INFO - Downloading blessings-1.6.tar.gz 07:30:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:30:48 INFO - Installing collected packages: blessings 07:30:48 INFO - Running setup.py install for blessings 07:30:48 INFO - Successfully installed blessings 07:30:48 INFO - Cleaning up... 07:30:48 INFO - Return code: 0 07:30:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:30:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:30:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:30:48 INFO - Reading from file tmpfile_stdout 07:30:48 INFO - Current package versions: 07:30:48 INFO - blessings == 1.6 07:30:48 INFO - blobuploader == 1.2.4 07:30:48 INFO - docopt == 0.6.1 07:30:48 INFO - functools32 == 3.2.3-2 07:30:48 INFO - jsonschema == 2.5.1 07:30:48 INFO - manifestparser == 1.1 07:30:48 INFO - mozInstall == 1.12 07:30:48 INFO - mozcrash == 1.0 07:30:48 INFO - mozdebug == 0.1 07:30:48 INFO - mozdevice == 0.49 07:30:48 INFO - mozfile == 1.2 07:30:48 INFO - mozhttpd == 0.7 07:30:48 INFO - mozinfo == 0.9 07:30:48 INFO - mozleak == 0.1 07:30:48 INFO - mozlog == 3.4 07:30:48 INFO - moznetwork == 0.27 07:30:48 INFO - mozprocess == 0.23 07:30:48 INFO - mozprofile == 0.28 07:30:48 INFO - mozrunner == 6.13 07:30:48 INFO - mozscreenshot == 0.1 07:30:48 INFO - mozsystemmonitor == 0.3 07:30:48 INFO - moztest == 0.7 07:30:48 INFO - mozversion == 1.4 07:30:48 INFO - psutil == 3.1.1 07:30:48 INFO - requests == 1.2.3 07:30:48 INFO - wsgiref == 0.1.2 07:30:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:49 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 0x104e193f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d8f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bab593910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c2ed30>, '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 0x104a95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c26b20>, '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.J44IH4ziXi/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.RxH2Y9fCpg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 07:30:49 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 07:30:49 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 07:30:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J44IH4ziXi/Render', 07:30:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:30:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:30:49 INFO - 'HOME': '/Users/cltbld', 07:30:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:30:49 INFO - 'LOGNAME': 'cltbld', 07:30:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:49 INFO - 'MOZ_NO_REMOTE': '1', 07:30:49 INFO - 'NO_EM_RESTART': '1', 07:30:49 INFO - 'PAGER': '/bin/cat', 07:30:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:30:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:49 INFO - 'PWD': '/builds/slave/test', 07:30:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:30:49 INFO - 'SHELL': '/bin/bash', 07:30:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RxH2Y9fCpg/Listeners', 07:30:49 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 07:30:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:30:49 INFO - 'USER': 'cltbld', 07:30:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:30:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:30:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:49 INFO - 'XPC_FLAGS': '0x0', 07:30:49 INFO - 'XPC_SERVICE_NAME': '0', 07:30:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:30:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:49 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)) 07:30:49 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)) 07:30:49 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)) 07:30:49 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)) 07:30:49 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)) 07:30:49 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)) 07:30:49 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)) 07:30:49 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)) 07:30:49 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)) 07:30:49 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)) 07:30:49 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)) 07:30:49 INFO - Cleaning up... 07:30:49 INFO - Return code: 0 07:30:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104e193f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d8f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bab593910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c2ed30>, '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 0x104a95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c26b20>, '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.J44IH4ziXi/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.RxH2Y9fCpg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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 07:30:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:30:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:30:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J44IH4ziXi/Render', 07:30:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:30:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:30:49 INFO - 'HOME': '/Users/cltbld', 07:30:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:30:49 INFO - 'LOGNAME': 'cltbld', 07:30:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:49 INFO - 'MOZ_NO_REMOTE': '1', 07:30:49 INFO - 'NO_EM_RESTART': '1', 07:30:49 INFO - 'PAGER': '/bin/cat', 07:30:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:30:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:49 INFO - 'PWD': '/builds/slave/test', 07:30:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:30:49 INFO - 'SHELL': '/bin/bash', 07:30:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RxH2Y9fCpg/Listeners', 07:30:49 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 07:30:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:30:49 INFO - 'USER': 'cltbld', 07:30:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:30:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:30:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:49 INFO - 'XPC_FLAGS': '0x0', 07:30:49 INFO - 'XPC_SERVICE_NAME': '0', 07:30:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:30:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:30:49 INFO - Cleaning up... 07:30:49 INFO - Return code: 0 07:30:49 INFO - Running post-action listener: _resource_record_post_action 07:30:49 INFO - Running post-action listener: _start_resource_monitoring 07:30:49 INFO - Starting resource monitoring. 07:30:49 INFO - [mozharness: 2016-12-17 15:30:49.861870Z] Finished create-virtualenv step (success) 07:30:49 INFO - [mozharness: 2016-12-17 15:30:49.862840Z] Running install step. 07:30:49 INFO - Running pre-action listener: _resource_record_pre_action 07:30:49 INFO - Running main action method: install 07:30:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:30:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:30:50 INFO - Reading from file tmpfile_stdout 07:30:50 INFO - Detecting whether we're running mozinstall >=1.0... 07:30:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:30:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:30:50 INFO - Reading from file tmpfile_stdout 07:30:50 INFO - Output received: 07:30:50 INFO - Usage: mozinstall [options] installer 07:30:50 INFO - Options: 07:30:50 INFO - -h, --help show this help message and exit 07:30:50 INFO - -d DEST, --destination=DEST 07:30:50 INFO - Directory to install application into. [default: 07:30:50 INFO - "/builds/slave/test"] 07:30:50 INFO - --app=APP Application being installed. [default: firefox] 07:30:50 INFO - mkdir: /builds/slave/test/build/application 07:30:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:30:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:31:11 INFO - Reading from file tmpfile_stdout 07:31:11 INFO - Output received: 07:31:11 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:31:11 INFO - Running post-action listener: _resource_record_post_action 07:31:11 INFO - [mozharness: 2016-12-17 15:31:11.954816Z] Finished install step (success) 07:31:11 INFO - [mozharness: 2016-12-17 15:31:11.954980Z] Running run-tests step. 07:31:11 INFO - Running pre-action listener: _resource_record_pre_action 07:31:11 INFO - Running main action method: run_tests 07:31:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:31:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:31:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:31:11 INFO - 2016-12-17 07:31:11.969 screenresolution[1633:7358] starting screenresolution argv=screenresolution get 07:31:11 INFO - 2016-12-17 07:31:11.972 screenresolution[1633:7358] Display 0: 1600x1200x32@60 07:31:11 INFO - 2016-12-17 07:31:11.978 screenresolution[1634:7360] starting screenresolution argv=screenresolution list 07:31:11 INFO - Available Modes on Display 0 07:31:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:31:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:31:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:31:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:31:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:31:12 INFO - Intel Iris: 07:31:12 INFO - Chipset Model: Intel Iris 07:31:12 INFO - Type: GPU 07:31:12 INFO - Bus: Built-In 07:31:12 INFO - VRAM (Dynamic, Max): 1536 MB 07:31:12 INFO - Vendor: Intel (0x8086) 07:31:12 INFO - Device ID: 0x0a2e 07:31:12 INFO - Revision ID: 0x0009 07:31:12 INFO - Displays: 07:31:12 INFO - Display: 07:31:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:31:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:31:12 INFO - Display Serial Number: 1600x1200 60 07:31:12 INFO - Main Display: Yes 07:31:12 INFO - Mirror: Off 07:31:12 INFO - Online: Yes 07:31:12 INFO - Rotation: Supported 07:31:12 INFO - Return code: 0 07:31:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:31:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:31:12 INFO - Python 2.7.3 07:31:12 INFO - Return code: 0 07:31:12 INFO - grabbing minidump binary from tooltool 07:31:12 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')]} 07:31:12 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 0x104c2ed30>, '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 0x104a95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104c26b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:31:12 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 07:31:12 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 07:31:12 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 07:31:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:31:12 INFO - Return code: 0 07:31:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:31:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:31:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:31:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:31:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:31:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K_tOI8VjQ8qRENhmOc-Vug/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0335', '--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 07:31:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K_tOI8VjQ8qRENhmOc-Vug/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0335 --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 07:31:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J44IH4ziXi/Render', 07:31:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:12 INFO - 'HOME': '/Users/cltbld', 07:31:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:12 INFO - 'LOGNAME': 'cltbld', 07:31:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:31:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:31:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:12 INFO - 'MOZ_NO_REMOTE': '1', 07:31:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:31:12 INFO - 'NO_EM_RESTART': '1', 07:31:12 INFO - 'PAGER': '/bin/cat', 07:31:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:12 INFO - 'PWD': '/builds/slave/test', 07:31:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:31:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:12 INFO - 'SHELL': '/bin/bash', 07:31:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RxH2Y9fCpg/Listeners', 07:31:12 INFO - 'TMPDIR': '/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/', 07:31:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:12 INFO - 'USER': 'cltbld', 07:31:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:12 INFO - 'XPC_FLAGS': '0x0', 07:31:12 INFO - 'XPC_SERVICE_NAME': '0', 07:31:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K_tOI8VjQ8qRENhmOc-Vug/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0335', '--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 07:31:12 INFO - mozversion application_buildid: 20161217062449 07:31:12 INFO - mozversion application_changeset: 56a8ce2bf0876fc9315407676e2db35e238e510d 07:31:12 INFO - mozversion application_display_name: Nightly 07:31:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:31:12 INFO - mozversion application_name: Firefox 07:31:12 INFO - mozversion application_remotingname: firefox 07:31:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:31:12 INFO - mozversion application_vendor: Mozilla 07:31:12 INFO - mozversion application_version: 53.0a1 07:31:12 INFO - mozversion platform_buildid: 20161217062449 07:31:12 INFO - mozversion platform_changeset: 56a8ce2bf0876fc9315407676e2db35e238e510d 07:31:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:31:12 INFO - mozversion platform_version: 53.0a1 07:31:12 INFO - using testdate: 1481988672 07:31:12 INFO - actual date: 1481988672 07:31:12 INFO - starting webserver on 'localhost:49243' 07:31:12 INFO - SUITE-START | Running 2 tests 07:31:12 INFO - TEST-START | dromaeo_css 07:31:12 INFO - operating with platform_type : mac_ 07:31:12 INFO - Initialising browser for dromaeo_css test... 07:31:12 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/tmp2GqdgA/profile http://localhost:49243/getInfo.html) 07:31:15 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 07:31:15 INFO - PROCESS | 1644 | colorDepth:24 07:31:15 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 07:31:15 INFO - PROCESS | 1644 | __metrics 07:31:15 INFO - PROCESS | 1644 | 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" 07:31:15 INFO - PROCESS | 1644 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:31:16 INFO - TEST-INFO | 1644: exit 0 07:31:16 INFO - Browser initialized. 07:31:16 INFO - Running cycle 1/1 for dromaeo_css test... 07:31:16 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/tmp2GqdgA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:31:28 INFO - PROCESS | 1646 | RSS: Main: 237355008 07:31:28 INFO - PROCESS | 1646 | 07:32:18 INFO - PROCESS | 1646 | 1481988738992 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:34:31 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 07:34:33 INFO - PROCESS | 1646 | RSS: Main: 407142400 07:34:33 INFO - PROCESS | 1646 | 07:37:36 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 07:37:37 INFO - PROCESS | 1646 | RSS: Main: 373710848 07:37:37 INFO - PROCESS | 1646 | 07:40:39 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 07:40:40 INFO - PROCESS | 1646 | RSS: Main: 351543296 07:40:40 INFO - PROCESS | 1646 | 07:43:42 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 07:43:43 INFO - PROCESS | 1646 | RSS: Main: 335388672 07:43:43 INFO - PROCESS | 1646 | 07:46:46 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 07:46:47 INFO - PROCESS | 1646 | RSS: Main: 327409664 07:46:47 INFO - PROCESS | 1646 | 07:49:50 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 07:49:51 INFO - PROCESS | 1646 | RSS: Main: 381739008 07:49:51 INFO - PROCESS | 1646 | 07:49:51 INFO - PROCESS | 1646 | __start_tp_report 07:49:51 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 07:49:51 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 07:49:51 INFO - PROCESS | 1646 | |i|pagename|runs| 07:49:51 INFO - PROCESS | 1646 | |0;dojo.html;3278.4918337657673;3279.131030276976;3284.7043766061056;3298.455754800458;3353.4299169141245;5446.373667028293;5535.363433205182;5540.307461567304;5571.58213134015;5585.916211256829;4424.225760491917;5314.734263286829;5520.199571062193;5528.917066244009;5607;5144.151215049513;5150.3047088642925;5151.995360904634;5162.535371816536;5167.302414174094;5060.392752869642;5150.227465880129;5186.948130518703;5218.504242096995;5219.269302297681;4366.432363792703;5160.638755287131;5202.479752024805;5208.895822083556;5222.112240919053;4903.019396120754;5155.690658560461;5159.097157997336;5198.92201616976;5231.372235331765;4056.2090392373498;5005.02402031604;5058.7976480940715;5099.46455622158;5113.207452844815;5535.6955367454775;5554.91667624986;5556.91664625031;5575;5644.238027866227;5473.781048758085;6095.573309868311;6105.206323178003;6115.4190351916495;6127.632342059491;6027.367126451703;6034.456898879078;6066.6663333516635;6103.034636161418;6199.690015499207;5661.716914154317;5663.32040155184;5667.234923285304;5701.800436984686;5738.713064346766;6270.905936410957;6282.685865706696;6283.717232724538;6287.088372186007;6290.528210384239;5787.913181302284;5826.126081087871;5946.07835785454;5994.490468310155;6003.3996600339615;6018.3680713524445;6116.3883611638485;6124.663143527148;6131.8966377332845;6180.3201647818705;6073.558648111332;6073.817785466443;6079.513638908877;6086.878262434727;6115.235595550556;6024.1265016573225;6079.604825686316;6094.8171554853425;6099.603525770811;6106.908396374058;4734;4771.832985845548;4787.61699064074;4787.80304923769;4792.688475249168;4313.568643135662;4315.5900189481945;4320.3519472078815;4360.171567402183;4360.978195109067;5558.360788509373;5565.610407271533;5593.412691667398;5620.241267428926;5623.297087864017;5969.522438204933;5993.190919225849;6022.608530445507;6191;6199.070139479114;5585.497305242467;5623.803166889139;5624.521915637135;5630.8029218977135;5665.660060396307;5199.6880187188135;5212.921806172911;5284.841454756363;5292.603054770908;5315.548178404879;6163.568550201622;6304.842378940563;6311.116443697978;6314.684265786784;6328;6053.939460605337;6084.452399283909;6137.7851775187655;6139.508839292756;6142.262928448615;6224.719887604978;6227.159333489921;6275.748970041147;6287.528435367274;6324.620522768649;6056.242969628796;6087.086936959491;6087.640516563359;6087.695615219132;6137.508999279958;6115.00784866965;6141.754329826936;6154.415330543591;6170.722317495633;6172.074188871705;4136.048708797054;5722.599418040697;5728.083506638918;5775.422457754191;5875.706214689334;5846.327672317738;5874.03078492044;5875.706214689163;5884.588078834612;5935.169076329231;5754.05058165398;5818.185454036354;5845.298564172326;5848.824535263949;5887.764489420375;6005.669688167018;6016.969915150396;6024.8795024100145;6026.969865150646;6028.306744724237;5652.802151924663;5871.295444546682;5881.353051164283;5883.29400471929;5915.37888521699 07:49:51 INFO - PROCESS | 1646 | |1;ext.html;382.98851034468964;481.04752589872055;493.56073094945526;493.5903200343713;493.7481884239037;30744;37870.24259514811;39310.80344598277;39493.605063949355;41541;40855.59144408555;41200.79399602998;41239;41326.58673413265;41386;9297.488638124918;9522.80954380912;9523.95238023809;9524.476153811538;9534.80930381392;8538.786530336729;8758;11127;11373.260738052042;11397;11377.431128443544;11459.59891403801;11476.311421314747;11485.712857178554;11560.537578496893;8479.660813567512;11271;11327;11329.71675708114;11351.772964540745;8474.788130296793;8627.309815214769;8637.870431943526;8638.870416943751;9242.353035287533;37411.81294093539;38968;39004.21991560153;39019.60980390188;39022.80488597539;2984.5373967035143;3217.517372394136;3320.1367644412626;3356.597208334991;3416.538767266412;27317.863410683018;27563.72436275652;27564.724352756417;27841.86079069612;28206.153815385573;3075;3179.6979286967703;3193.5209718542174;3204.7115759581516;3246.2858171202533;396022.01988990157;480176;482709;483175.9999999965;483737;53020.14429494949;53378.73310633422;53386;53438;53517;48325;55112.62218444491;55204.723976379864;55298;55299.723501382236;14507.492237771627;15006.02460840042;15016.849831501546;15034.323455444532;15040.247987600576;10520.263581549218;10784;11706.239094459002;11794.705132371588;11809.11431642613;13967.37146828395;14096.85903140976;14097.647558810906;14111.71776564463;15894.92052539753;7229.277072292729;7567.918822323795;7570.129435115033;7583.165851756303;7594.126675432396;858.3690987124459;860.8249739106075;934.2806039349663;973.4889183178888;983.6901376066517;28586.85706571454;29290.7070929288;29529.409411812074;29739.006219805957;30276;1052.310736467615;1067.2049323254225;1071.164491696478;1082.577794660083;1121.5233525751523;12449.875501245053;14692.118472891661;15077.773833392508;15208.543743687485;15213.239338033054;177588;178213;179026.10486947742;651565;831012;47540.76229618899;48074.759626201645;48789.26816097761;56500;57749;1356.5184359552218;1379.3723855645658;1403.1300593632013;1403.5438482493025;1403.6561042544847;24380.26859194227;28702.282442939093;29344.85327573434;29780.55329170021;30753.231169220948;48453.75773121112;49277.01445970989;49332.50667493279;49370.75314623404;49429.76425589245;596717.0164149151;602996;603540;603545;605993;36473.45289820708;36615;37101.814490927376;37151.81424092862;37365.4395184067;40665.39001914914;40773.79613102034;41808.1638367237;42020.73937781872;42103;33913.98258052262;34794.478082828275;35000.12499687528;35801.64198357983;36109;34149;34243.65756342404;34343.96968090961;35176.296474069866;35327.82336088406;33780.891998686464;34156.658433415345;34728.30543389067;34869;34883.9534813956;28756.42487150287;29556.852215738785;31004.379912402077;31019.224519387197;31205.219869503446;23332;23658.053677853382;23697.881510592335;23782.405439864142;23792.286231413087 07:49:51 INFO - PROCESS | 1646 | |2;jquery.html;323.53895698629464;350.85439542589825;371.7230663155949;378.56465065175047;381.43928425214943;14699.26503674816;14925.029873058258;16419.83580164198;20602.38192854213;20774.714781374038;19358.22567097318;19975.700364494543;20453.38639840807;20751.377458676227;20827.583448331025;5732.656040637565;5812.258227552822;5983.461488466037;6014.8195554133445;6019.5485338599565;4595.379623750801;5884.08796636522;5951.464368206861;5953.345132035494;5978.611390259619;5603.187537807015;5899.469047785698;5903.4686878180955;5906.763729450817;5908.084246941731;5758.971205143968;5779.797707080253;5824.53403727705;5837.766489340422;5847.9415205848245;5118.872028199287;5129.410117836459;5131.281620573122;6806.897896531556;7094.11323584552;27223.591646125325;27706.56694928822;27833;27874.16377508678;28114.437711245864;2304.2626359564947;2486.117682213206;2490.003998400636;3019.290466740314;3313.9834300828343;15033.849661503355;16297.51107466766;16602.75095873563;16851.241694123793;16904.915475422666;1874.831265186126;1971.3297478857114;1973.6052789442026;2018.5155562665002;2130.38218916514;112713.43643281813;115874;116564;117091;118268.40865795701;16174.530187924689;18299.34659474369;19100.426987190407;20330.186792528133;20754.688679669816;34119.31761364759;34124.658753412645;34139.51349243636;34223.82888085594;34234.31531369359;8202.425830191949;10403.895961040444;10580.25938184335;10723.410212438392;10769.78460430787;8654.394192406471;8678.739637810875;8684.392092553588;8810.691625793066;8861.202491775772;7915.683372665144;7948.244916732901;9244.214241789388;9663.226941844636;9664.855027174597;3160.9812628939308;3168.429682657144;3414.9413681758733;3444.51776751255;3717.70258379329;899.9325050621229;930.8091841172679;949.2880339745191;971.3734641156556;1036.2538971940191;19934.50163745918;20873.895630522053;21157.499050247046;21286.574268514854;21396.893015535134;909.9863502047475;946.4084946908182;966.8453047512364;968.2931460034074;1020.550957578663;9049.77375565616;10684.51919663617;10738.624148154777;11111.833322500008;11199.104071674246;511809;521753.8246175428;531911;534607;534793;110927;111339.44330278297;111431.47795386337;115481.42259288649;121027;969.3311614985637;977.2914636888199;994.0308199505424;1000.0399616368222;1000.9549570269355;14186.361613727613;18633.347832825784;18759.249630014645;18859.528511787314;19204.807951920302;39948.60051399449;48483.51516484931;52705.472945270056;53571.19643205433;53635.46364536461;67507.32492675011;70875;72036.9194462094;72589.6370518144;73617;7747.573883436465;7765.7670269892;8044.436889417684;8090.433669643304;8237.135100814568;11362.261453005529;12222;12590.307533085768;12644.178128421623;12655.177413468095;8948.702438146562;10317.535710892878;10726.372038850532;11015.28400653987;11028.22802403856;5215.009148261818;7806.92193078062;10522.526846241379;10634.042936135476;10958.068564172134;10760.677179684622;10879.292845964987;11163.553457861595;11245;11261.831072533754;7869.8819517708425;8034.959825200836;8074.111847696631;8077.596120193849;8085.312748416451;8886.644534218818;10551.788964220827;10975.945120274348;11007.119430445386;11008.559657613927 07:49:51 INFO - PROCESS | 1646 | |3;mootools.html;1342.0471465259666;1350.2438634364753;1494.0214159725376;1640.3930545698092;1833.569111258854;7503.69985200592;7874.92125078749;8154.918450815498;8425.620847061882;8444.986601607816;8284.544350060743;8369.748907532768;8372.874406883902;8377.16228377162;8388.454750441217;2024.959500809983;2114.6827975803676;2219.289827255279;2261.6607508873717;2267.716535433071;1888.6411581799482;2115.016517319446;2127.617028934799;2131.2007997001124;2332.102140675835;2293.9770602294016;2304.83866129371;2306.642470417088;2310.0182422470466;2313.248194336839;2215.1360969222014;2219.8668079915255;2231.8326125540566;2246.84272100953;2253.43664083979;1999.2203040814095;2273.693051438051;2273.954520909589;2301.505176387068;2306.8039216666602;8258.25675689191;8288.627011784483;8349.624266907944;8385.832283354359;8395.99248090227;5032.169692000815;5169.896602067975;5179.818706345298;5189.896202075937;5190;3438.933930481534;3439.9828000860084;3440.4839274108836;3493.9650603494147;3517;847.7117779954783;1031.793641271741;1041.5989843910074;1044.926855120142;1069.8609180806523;10618.097461715763;10756.946215268874;10769.407682577455;10769.784604307948;10786.46067696612;4401.40581021558;4508.481524624644;4609.262517997105;4616.0998605272325;4666.183417901853;9335.206507446943;9357;9358.766030849283;9359.29805264608;9364.62541498346;5190.039842629126;5219.765110570033;5239.476052394806;5245.816396426107;5252.816151434681;4592.104539614743;4696.225122854691;4734.171519983989;4804.567588917014;4805.903881922342;3541.5218945442552;3651.3975194092677;3730.515033045687;3776.735628506033;3794.3739283017994;1245.514249442718;1250.9687257818628;1254.3226657604791;1264.8861602455822;1275.0755702116078;826.8506775581945;845.564534264854;894.5124906925741;895.5477483870603;930.4742820306641;5402.677857713813;5434.510894019557;5637.9718101409235;5703.914441283384;5839.883202336015;900.1898291537537;900.7479603351347;916.7478943290648;934.8457504511815;946.0208684012015;2910.519764238877;3242.5460435539044;3335.4996750487135;3356.14418323326;3572.464130380412;9718.416894986323;9994.300398972147;10067.748306292402;10074.042965918226;10101.14140298083;10034.397936123856;10045.246606504541;10047.196224302184;10070.093691567794;10079.445630490394;7400;7612.467127301035;7717.880907268414;7780.727674531364;7868.527888326718;5440.6735595864375;5556.861078472909;5559.777608895761;5573.916391254215;5737.627054241461;9168.174864262248;9225.49259790718;9347.813043739223;9434;9439.433633981984;8990.145936136056;9374.203192728695;9447.52762361893;9559;9580.95209523948;6881.621510816954;7176.677049532888;7184.784456466315;7186.856262874609;7195.71217151329;7462.179160292472;7644.273793989562;7730.7680769577;7762.379009679099;7848.450608457353;7015.894761578683;7045.084139062094;7070.292970702889;7074.71701131949;7111.075560177143;6927.653617319214;6966.233714291525;6986.441084713312;7043.401310888426;7081;5579.944200558105;6489;6550.377714117151;6614.900776488453;6623.801285961429;4731.905361892674;4754.31062495943;4819.349387832598;4827.686200396963;4870.09903167915;4693.296005599051;4810.5670489656095;4850.1269771441475;4904.215325547895;4965.453800081916 07:49:51 INFO - PROCESS | 1646 | |4;prototype.html;307.79839205320513;351.3201954218587;363.46933477123406;369.9926001479969;371.9683826874717;4371.153385021181;4669.743164125972;4947.406311242651;5197.636165468419;5307.25698402223;4350.630196433307;4569.4745104313015;4657.556157591141;4977.850664480072;5176.275321454999;3925.8429662813523;4044.413560033793;4112.712110152291;4131.0584025508115;4133.875983720493;3402;3426.8800591979284;3658.6890114340313;4095.7542547447247;4171.833126674929;3280.9179770505807;3941.783201923893;4134.400511925769;4135.379693046037;4178.603032711888;3488.8081155536433;3943.9211215775813;3949.7630142191274;3958.247932892741;3989.4866234272367;2879.3809330993936;3280.0979730574045;3396.1679388549965;3413.3887576004377;3422.8801991930163;4053.9594604053877;4231.61915427613;4610.608098311647;4642;5122.206058061007;3995.36074228125;4248.957510424918;4417.0564951421275;4510.007798284372;4513.345564893105;4534.7052441591195;4798.880027999293;5152.381714194284;5437.945620543823;5443.945560544384;3682.6317368263226;3756.849726010956;3770.6606405423645;3779.811009449544;3781.7920014399197;5442.863928401782;5480.944645757841;5815.255423372972;5822.563307751935;5826.563007774434;3366.8316584170693;3797.715171362159;3798.5631652360335;3818.1218319786603;3855.6722678572073;3227.596550431196;3838.84834549634;3882.8058597070035;3884.864029758945;3900.2004589059175;4159.604837540429;4338.522762496123;4433.977830110894;4502.144592527475;4552.20188025728;4204.4352944704315;4546.61353784932;4666.346711460398;5552.305961754781;5600.831975040755;1115.760111576015;1116.7492408502528;1127.461015713545;1211.660734994203;1254.494606472237;734.7942576078707;756.0360540311037;798.9320907722793;812.1918690902589;822.457178262344;4628.490866004737;4821.783019764119;4839.9188349010265;5077.644564880497;5294.788208471695;5738.254026976467;5738.393249890038;5747.626404283708;5760.695721711265;5783.2288362101435;4229.619334259932;4458.286674132123;5000.399952005782;5033.723145226974;5311.787528498817;2463.721058021323;2623.462190251032;2812.9578056329174;2842.5025620516326;2880.495913215179;4877.951280449719;4997;5056.140456122468;5303.6928935913;5333.1600597793695;4698.483166851644;5376.4085950545405;5391.272178255964;5632.690202038927;5646.334331372255;5126.69239845603;5643.322801263875;5671.347795003545;5676.716164191774;5741.942580574141;4447.911041779082;4465.933011004772;4806.197675871548;4963.486136728333;5122.564582010571;4790.4251489821445;5332.373626044094;5352.384475785178;5384.946150538444;5397.514223719884;5592.888142237051;5593.664380137205;5624.943750562442;5652.802151924828;5691.3170419549915;3872.825722842535;3874.4188371744463;3929.6835560086547;3937.853869640995;3963.286608410514;5599.692016939108;5623.522000629992;5629.352624448241;5658.575606829422;5698.800541981177;4770.165221086366;4812.157872372391;5339.065663508948;5468.183885298995;5542.812882592606;4738.620910327235;5061.215511595708;5175.715335656575;5239.554637855825;5377.784888604412;4535.387722657399;4601.838935637371;5411.918821217763;5454.154606036071;5456.781728730806;5410.889752996256;5441.673499590037;5462.3445186577865;5608.38307786135;5644.322681278109;4694.178518759135;4858.757062146808;5305.1776974569;5434.510894019557;5453.045716999589 07:49:51 INFO - PROCESS | 1646 | |5;yui.html;730.266082587;747.7868807389895;779.8557266905623;822.1408627983757;833.5332213960181;12729.236245825234;14451.855481445182;15353.84646153538;15416.383344666214;15436.91941564091;13986.860131398684;14167.362468688909;14178.716425671506;14188.929055354734;14224.502142425017;685.25649670108;706.3431009161478;837.969297763751;862.0474375814713;867.5185272173941;875.5928493250638;877.8814859993915;878.8637761147032;886.6896586194813;888.5424006636588;929.3262384771054;929.4934260827865;931.8276118918022;932.4638332958542;935.0509233128346;721.942244620429;888.2272422992038;888.4358432395476;889.0531583863198;902.5757893789909;556.7633755653872;667.6461475418037;688.4595592459895;697.4106879686657;700.1528150937372;14503.41986320546;14538.781918271234;14548.709025819424;14559.636009099751;14573.344199511048;12351;13015.088943773939;13177.670558236025;13247.602571922858;13520.391582378816;10823.404712740796;11081.667549973434;11509.730053514064;12334.691632709164;12453.875461245361;4361.847335343279;4410.16206920684;4419.226635338803;4572.285392977634;4590.150822097889;101462.99999999926;102915.48542257315;103825;104186;104910;10663.680089597325;10689.893101069045;10831.67504974852;10842.295250808673;11003.284786488852;20647.967601619857;21005.36983890486;21087.68368474474;21149.57700846005;21615.56768864614;7220.4584656151;7464.850702986018;7553.884912224586;7728.613569321511;7753.418493613001;4308.719933204332;4324.372965919924;4325;4327.891802704958;4351.325544540601;3328.134684981922;3395.8981230562626;3401.523786669868;3412.7781694190294;3418.6410426905313;626.5269721360344;633.3571425003626;636.9713362898681;639.6769631336145;644.3588629313863;506.8428787076018;578.9768409263667;616.0778371480918;642.6626021338834;656.0159760359461;7630.7710768677025;8829;8835.779105522413;9951.480443039245;9955.153811925922;480.16930709872116;518.6239976017357;583.2854752927715;589.4930359890491;630.706721374563;4230.259704551691;4392.231359512072;4500.122476117126;4547.7498737569085;4588.403507543998;78693.60653196697;92605.53697231605;95605.52197238969;96563;100252;71010.64494677493;73649.26350736425;79915;83784.16215837763;85552.57223713842;73633.63183184157;73702.63148684437;75266.24733752702;76692.84960725594;76995.61502192453;8318.45930014547;8791.208791208823;8813;8906.910930890608;8926.608987551681;47391.763041184575;48297.82341355131;48331.51668483411;48497.5150248493;49436.86544258346;63512.09463716096;67228.32771672221;67613;68649.3135068663;70771.64614176896;11591;11697.23967942115;11763.353015584225;11807.409629518661;11905.940470297593;12798.744025119631;12871.356432178167;13066.346682665639;13103.396565944442;13457.461701531829;11061.834072488758;11644.184907056424;11813.586524471602;11861.169718119649;12261.14172007951;11782.705432364259;12214.38928053576;12371.13402061847;12405.069619778373;12485.93757031209;11655.41722913834;12003.939980300043;12246.571370002008;12325.198862073936;12393.814092788796;9968.850467243143;10044;10105.848412273968;10290.073893349634;10412.114970227616;7538.811529711801;7919.08930473003;8235.34117270605;9824.65613703517;10376.584936602452 07:49:51 INFO - PROCESS | 1646 | __end_tp_report 07:49:51 INFO - PROCESS | 1646 | __start_cc_report 07:49:51 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,1865 07:49:51 INFO - PROCESS | 1646 | __end_cc_report 07:49:51 INFO - PROCESS | 1646 | __startTimestamp1481989791185__endTimestamp 07:49:51 INFO - PROCESS | 1646 | 07:49:51 INFO - PROCESS | 1646 | ------- Summary: start ------- 07:49:51 INFO - PROCESS | 1646 | Number of tests: 6 07:49:51 INFO - PROCESS | 1646 | 07:49:51 INFO - PROCESS | 1646 | [#0] dojo.html Cycles:165 Average:5601.88 Median:5787.91 stddev:661.04 (11.4%) stddev-sans-first:637.45 07:49:51 INFO - PROCESS | 1646 | Values: 3278.5 3279.1 3284.7 3298.5 3353.4 5446.4 5535.4 5540.3 5571.6 5585.9 4424.2 5314.7 5520.2 5528.9 5607.0 5144.2 5150.3 5152.0 5162.5 5167.3 5060.4 5150.2 5186.9 5218.5 5219.3 4366.4 5160.6 5202.5 5208.9 5222.1 4903.0 5155.7 5159.1 5198.9 5231.4 4056.2 5005.0 5058.8 5099.5 5113.2 5535.7 5554.9 5556.9 5575.0 5644.2 5473.8 6095.6 6105.2 6115.4 6127.6 6027.4 6034.5 6066.7 6103.0 6199.7 5661.7 5663.3 5667.2 5701.8 5738.7 6270.9 6282.7 6283.7 6287.1 6290.5 5787.9 5826.1 5946.1 5994.5 6003.4 6018.4 6116.4 6124.7 6131.9 6180.3 6073.6 6073.8 6079.5 6086.9 6115.2 6024.1 6079.6 6094.8 6099.6 6106.9 4734.0 4771.8 4787.6 4787.8 4792.7 4313.6 4315.6 4320.4 4360.2 4361.0 5558.4 5565.6 5593.4 5620.2 5623.3 5969.5 5993.2 6022.6 6191.0 6199.1 5585.5 5623.8 5624.5 5630.8 5665.7 5199.7 5212.9 5284.8 5292.6 5315.5 6163.6 6304.8 6311.1 6314.7 6328.0 6053.9 6084.5 6137.8 6139.5 6142.3 6224.7 6227.2 6275.7 6287.5 6324.6 6056.2 6087.1 6087.6 6087.7 6137.5 6115.0 6141.8 6154.4 6170.7 6172.1 4136.0 5722.6 5728.1 5775.4 5875.7 5846.3 5874.0 5875.7 5884.6 5935.2 5754.1 5818.2 5845.3 5848.8 5887.8 6005.7 6017.0 6024.9 6027.0 6028.3 5652.8 5871.3 5881.4 5883.3 5915.4 07:49:51 INFO - PROCESS | 1646 | 07:49:51 INFO - PROCESS | 1646 | [#1] ext.html Cycles:180 Average:62307.49 Median:34942.04 stddev:140879.09 (403.2%) stddev-sans-first:141197.57 07:49:51 INFO - PROCESS | 1646 | Values: 383.0 481.0 493.6 493.6 493.7 30744.0 37870.2 39310.8 39493.6 41541.0 40855.6 41200.8 41239.0 41326.6 41386.0 9297.5 9522.8 9524.0 9524.5 9534.8 8538.8 8758.0 11127.0 11373.3 11397.0 11377.4 11459.6 11476.3 11485.7 11560.5 8479.7 11271.0 11327.0 11329.7 11351.8 8474.8 8627.3 8637.9 8638.9 9242.4 37411.8 38968.0 39004.2 39019.6 39022.8 2984.5 3217.5 3320.1 3356.6 3416.5 27317.9 27563.7 27564.7 27841.9 28206.2 3075.0 3179.7 3193.5 3204.7 3246.3 396022.0 480176.0 482709.0 483176.0 483737.0 53020.1 53378.7 53386.0 53438.0 53517.0 48325.0 55112.6 55204.7 55298.0 55299.7 14507.5 15006.0 15016.8 15034.3 15040.2 10520.3 10784.0 11706.2 11794.7 11809.1 13967.4 14096.9 14097.6 14111.7 15894.9 7229.3 7567.9 7570.1 7583.2 7594.1 858.4 860.8 934.3 973.5 983.7 28586.9 29290.7 29529.4 29739.0 30276.0 1052.3 1067.2 1071.2 1082.6 1121.5 12449.9 14692.1 15077.8 15208.5 15213.2 177588.0 178213.0 179026.1 651565.0 831012.0 47540.8 48074.8 48789.3 56500.0 57749.0 1356.5 1379.4 1403.1 1403.5 1403.7 24380.3 28702.3 29344.9 29780.6 30753.2 48453.8 49277.0 49332.5 49370.8 49429.8 596717.0 602996.0 603540.0 603545.0 605993.0 36473.5 36615.0 37101.8 37151.8 37365.4 40665.4 40773.8 41808.2 42020.7 42103.0 33914.0 34794.5 35000.1 35801.6 36109.0 34149.0 34243.7 34344.0 35176.3 35327.8 33780.9 34156.7 34728.3 34869.0 34884.0 28756.4 29556.9 31004.4 31019.2 31205.2 23332.0 23658.1 23697.9 23782.4 23792.3 07:49:51 INFO - PROCESS | 1646 | 07:49:51 INFO - PROCESS | 1646 | [#2] jquery.html Cycles:180 Average:33332.78 Median:18716.65 stddev:87994.90 (470.1%) stddev-sans-first:88206.85 07:49:51 INFO - PROCESS | 1646 | Values: 323.5 350.9 371.7 378.6 381.4 14699.3 14925.0 16419.8 20602.4 20774.7 19358.2 19975.7 20453.4 20751.4 20827.6 5732.7 5812.3 5983.5 6014.8 6019.5 4595.4 5884.1 5951.5 5953.3 5978.6 5603.2 5899.5 5903.5 5906.8 5908.1 5759.0 5779.8 5824.5 5837.8 5847.9 5118.9 5129.4 5131.3 6806.9 7094.1 27223.6 27706.6 27833.0 27874.2 28114.4 2304.3 2486.1 2490.0 3019.3 3314.0 15033.8 16297.5 16602.8 16851.2 16904.9 1874.8 1971.3 1973.6 2018.5 2130.4 112713.4 115874.0 116564.0 117091.0 118268.4 16174.5 18299.3 19100.4 20330.2 20754.7 34119.3 34124.7 34139.5 34223.8 34234.3 8202.4 10403.9 10580.3 10723.4 10769.8 8654.4 8678.7 8684.4 8810.7 8861.2 7915.7 7948.2 9244.2 9663.2 9664.9 3161.0 3168.4 3414.9 3444.5 3717.7 899.9 930.8 949.3 971.4 1036.3 19934.5 20873.9 21157.5 21286.6 21396.9 910.0 946.4 966.8 968.3 1020.6 9049.8 10684.5 10738.6 11111.8 11199.1 511809.0 521753.8 531911.0 534607.0 534793.0 110927.0 111339.4 111431.5 115481.4 121027.0 969.3 977.3 994.0 1000.0 1001.0 14186.4 18633.3 18759.2 18859.5 19204.8 39948.6 48483.5 52705.5 53571.2 53635.5 67507.3 70875.0 72036.9 72589.6 73617.0 7747.6 7765.8 8044.4 8090.4 8237.1 11362.3 12222.0 12590.3 12644.2 12655.2 8948.7 10317.5 10726.4 11015.3 11028.2 5215.0 7806.9 10522.5 10634.0 10958.1 10760.7 10879.3 11163.6 11245.0 11261.8 7869.9 8035.0 8074.1 8077.6 8085.3 8886.6 10551.8 10975.9 11007.1 11008.6 07:49:51 INFO - PROCESS | 1646 | 07:49:51 INFO - PROCESS | 1646 | [#3] mootools.html Cycles:180 Average:5393.31 Median:5189.95 stddev:2984.67 (57.5%) stddev-sans-first:2977.52 07:49:51 INFO - PROCESS | 1646 | Values: 1342.0 1350.2 1494.0 1640.4 1833.6 7503.7 7874.9 8154.9 8425.6 8445.0 8284.5 8369.7 8372.9 8377.2 8388.5 2025.0 2114.7 2219.3 2261.7 2267.7 1888.6 2115.0 2127.6 2131.2 2332.1 2294.0 2304.8 2306.6 2310.0 2313.2 2215.1 2219.9 2231.8 2246.8 2253.4 1999.2 2273.7 2274.0 2301.5 2306.8 8258.3 8288.6 8349.6 8385.8 8396.0 5032.2 5169.9 5179.8 5189.9 5190.0 3438.9 3440.0 3440.5 3494.0 3517.0 847.7 1031.8 1041.6 1044.9 1069.9 10618.1 10756.9 10769.4 10769.8 10786.5 4401.4 4508.5 4609.3 4616.1 4666.2 9335.2 9357.0 9358.8 9359.3 9364.6 5190.0 5219.8 5239.5 5245.8 5252.8 4592.1 4696.2 4734.2 4804.6 4805.9 3541.5 3651.4 3730.5 3776.7 3794.4 1245.5 1251.0 1254.3 1264.9 1275.1 826.9 845.6 894.5 895.5 930.5 5402.7 5434.5 5638.0 5703.9 5839.9 900.2 900.7 916.7 934.8 946.0 2910.5 3242.5 3335.5 3356.1 3572.5 9718.4 9994.3 10067.7 10074.0 10101.1 10034.4 10045.2 10047.2 10070.1 10079.4 7400.0 7612.5 7717.9 7780.7 7868.5 5440.7 5556.9 5559.8 5573.9 5737.6 9168.2 9225.5 9347.8 9434.0 9439.4 8990.1 9374.2 9447.5 9559.0 9581.0 6881.6 7176.7 7184.8 7186.9 7195.7 7462.2 7644.3 7730.8 7762.4 7848.5 7015.9 7045.1 7070.3 7074.7 7111.1 6927.7 6966.2 6986.4 7043.4 7081.0 5579.9 6489.0 6550.4 6614.9 6623.8 4731.9 4754.3 4819.3 4827.7 4870.1 4693.3 4810.6 4850.1 4904.2 4965.5 07:49:51 INFO - PROCESS | 1646 | 07:49:51 INFO - PROCESS | 1646 | [#4] prototype.html Cycles:180 Average:4347.80 Median:4696.33 stddev:1335.75 (28.4%) stddev-sans-first:1304.62 07:49:51 INFO - PROCESS | 1646 | Values: 307.8 351.3 363.5 370.0 372.0 4371.2 4669.7 4947.4 5197.6 5307.3 4350.6 4569.5 4657.6 4977.9 5176.3 3925.8 4044.4 4112.7 4131.1 4133.9 3402.0 3426.9 3658.7 4095.8 4171.8 3280.9 3941.8 4134.4 4135.4 4178.6 3488.8 3943.9 3949.8 3958.2 3989.5 2879.4 3280.1 3396.2 3413.4 3422.9 4054.0 4231.6 4610.6 4642.0 5122.2 3995.4 4249.0 4417.1 4510.0 4513.3 4534.7 4798.9 5152.4 5437.9 5443.9 3682.6 3756.8 3770.7 3779.8 3781.8 5442.9 5480.9 5815.3 5822.6 5826.6 3366.8 3797.7 3798.6 3818.1 3855.7 3227.6 3838.8 3882.8 3884.9 3900.2 4159.6 4338.5 4434.0 4502.1 4552.2 4204.4 4546.6 4666.3 5552.3 5600.8 1115.8 1116.7 1127.5 1211.7 1254.5 734.8 756.0 798.9 812.2 822.5 4628.5 4821.8 4839.9 5077.6 5294.8 5738.3 5738.4 5747.6 5760.7 5783.2 4229.6 4458.3 5000.4 5033.7 5311.8 2463.7 2623.5 2813.0 2842.5 2880.5 4878.0 4997.0 5056.1 5303.7 5333.2 4698.5 5376.4 5391.3 5632.7 5646.3 5126.7 5643.3 5671.3 5676.7 5741.9 4447.9 4465.9 4806.2 4963.5 5122.6 4790.4 5332.4 5352.4 5384.9 5397.5 5592.9 5593.7 5624.9 5652.8 5691.3 3872.8 3874.4 3929.7 3937.9 3963.3 5599.7 5623.5 5629.4 5658.6 5698.8 4770.2 4812.2 5339.1 5468.2 5542.8 4738.6 5061.2 5175.7 5239.6 5377.8 4535.4 4601.8 5411.9 5454.2 5456.8 5410.9 5441.7 5462.3 5608.4 5644.3 4694.2 4858.8 5305.2 5434.5 5453.0 07:49:51 INFO - PROCESS | 1646 | 07:49:51 INFO - PROCESS | 1646 | [#5] yui.html Cycles:180 Average:19297.64 Median:25990.96 stddev:27708.16 (106.6%) stddev-sans-first:27750.82 07:49:51 INFO - PROCESS | 1646 | Values: 730.3 747.8 779.9 822.1 833.5 12729.2 14451.9 15353.8 15416.4 15436.9 13986.9 14167.4 14178.7 14188.9 14224.5 685.3 706.3 838.0 862.0 867.5 875.6 877.9 878.9 886.7 888.5 929.3 929.5 931.8 932.5 935.1 721.9 888.2 888.4 889.1 902.6 556.8 667.6 688.5 697.4 700.2 14503.4 14538.8 14548.7 14559.6 14573.3 12351.0 13015.1 13177.7 13247.6 13520.4 10823.4 11081.7 11509.7 12334.7 12453.9 4361.8 4410.2 4419.2 4572.3 4590.2 101463.0 102915.5 103825.0 104186.0 104910.0 10663.7 10689.9 10831.7 10842.3 11003.3 20648.0 21005.4 21087.7 21149.6 21615.6 7220.5 7464.9 7553.9 7728.6 7753.4 4308.7 4324.4 4325.0 4327.9 4351.3 3328.1 3395.9 3401.5 3412.8 3418.6 626.5 633.4 637.0 639.7 644.4 506.8 579.0 616.1 642.7 656.0 7630.8 8829.0 8835.8 9951.5 9955.2 480.2 518.6 583.3 589.5 630.7 4230.3 4392.2 4500.1 4547.7 4588.4 78693.6 92605.5 95605.5 96563.0 100252.0 71010.6 73649.3 79915.0 83784.2 85552.6 73633.6 73702.6 75266.2 76692.8 76995.6 8318.5 8791.2 8813.0 8906.9 8926.6 47391.8 48297.8 48331.5 48497.5 49436.9 63512.1 67228.3 67613.0 68649.3 70771.6 11591.0 11697.2 11763.4 11807.4 11905.9 12798.7 12871.4 13066.3 13103.4 13457.5 11061.8 11644.2 11813.6 11861.2 12261.1 11782.7 12214.4 12371.1 12405.1 12485.9 11655.4 12003.9 12246.6 12325.2 12393.8 9968.9 10044.0 10105.8 10290.1 10412.1 7538.8 7919.1 8235.3 9824.7 10376.6 07:49:51 INFO - PROCESS | 1646 | -------- Summary: end -------- 07:49:51 INFO - PROCESS | 1646 | 07:49:51 INFO - TEST-INFO | 1646: exit 0 07:49:51 INFO - TEST-OK | dromaeo_css | took 1119244ms 07:49:51 INFO - TEST-START | kraken 07:49:51 INFO - operating with platform_type : mac_ 07:49:51 INFO - Initialising browser for kraken test... 07:49:51 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/tmp2pN3CB/profile http://localhost:49243/getInfo.html) 07:49:53 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 07:49:53 INFO - PROCESS | 1655 | colorDepth:24 07:49:53 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 07:49:53 INFO - PROCESS | 1655 | __metrics 07:49:54 INFO - PROCESS | 1655 | 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" 07:49:54 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:49:54 INFO - TEST-INFO | 1655: exit 0 07:49:54 INFO - Browser initialized. 07:49:54 INFO - Running cycle 1/1 for kraken test... 07:49:54 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/T/tmp2pN3CB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:50:06 INFO - PROCESS | 1656 | RSS: Main: 238092288 07:50:06 INFO - PROCESS | 1656 | 07:50:09 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 07:50:10 INFO - PROCESS | 1656 | RSS: Main: 290144256 07:50:10 INFO - PROCESS | 1656 | 07:50:13 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 07:50:13 INFO - PROCESS | 1656 | RSS: Main: 292216832 07:50:13 INFO - PROCESS | 1656 | 07:50:17 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 07:50:17 INFO - PROCESS | 1656 | RSS: Main: 382296064 07:50:17 INFO - PROCESS | 1656 | 07:50:19 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 07:50:20 INFO - PROCESS | 1656 | RSS: Main: 286507008 07:50:20 INFO - PROCESS | 1656 | 07:50:22 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:50:22 INFO - PROCESS | 1656 | RSS: Main: 290107392 07:50:22 INFO - PROCESS | 1656 | 07:50:25 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 07:50:26 INFO - PROCESS | 1656 | RSS: Main: 331837440 07:50:26 INFO - PROCESS | 1656 | 07:50:29 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 07:50:30 INFO - PROCESS | 1656 | RSS: Main: 335687680 07:50:30 INFO - PROCESS | 1656 | 07:50:32 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 07:50:33 INFO - PROCESS | 1656 | RSS: Main: 331771904 07:50:33 INFO - PROCESS | 1656 | 07:50:35 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:50:35 INFO - PROCESS | 1656 | RSS: Main: 306487296 07:50:35 INFO - PROCESS | 1656 | 07:50:37 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:50:38 INFO - PROCESS | 1656 | RSS: Main: 309698560 07:50:38 INFO - PROCESS | 1656 | 07:50:40 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:50:41 INFO - PROCESS | 1656 | RSS: Main: 311046144 07:50:41 INFO - PROCESS | 1656 | 07:50:43 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:50:44 INFO - PROCESS | 1656 | RSS: Main: 328773632 07:50:44 INFO - PROCESS | 1656 | 07:50:47 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:50:48 INFO - PROCESS | 1656 | RSS: Main: 323432448 07:50:48 INFO - PROCESS | 1656 | 07:50:50 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 07:50:50 INFO - PROCESS | 1656 | RSS: Main: 367501312 07:50:50 INFO - PROCESS | 1656 | 07:50:50 INFO - PROCESS | 1656 | __start_tp_report 07:50:50 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 07:50:50 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 07:50:50 INFO - PROCESS | 1656 | |i|pagename|runs| 07:50:50 INFO - PROCESS | 1656 | |0;ai-astar;113;112;114;113;112;115;114;113;114;112 07:50:50 INFO - PROCESS | 1656 | |1;audio-beat-detection;135;115;135;171;116;109;108;109;129;107 07:50:50 INFO - PROCESS | 1656 | |2;audio-dft;185;184;182;183;185;179;183;181;186;182 07:50:50 INFO - PROCESS | 1656 | |3;audio-fft;80;58;60;86;62;59;59;58;75;58 07:50:50 INFO - PROCESS | 1656 | |4;audio-oscillator;87;70;87;81;99;98;99;69;68;84 07:50:50 INFO - PROCESS | 1656 | |5;imaging-gaussian-blur;109;109;108;109;109;111;106;111;109;110 07:50:50 INFO - PROCESS | 1656 | |6;imaging-darkroom;94;93;94;93;93;93;95;94;93;93 07:50:50 INFO - PROCESS | 1656 | |7;imaging-desaturate;88;85;88;84;83;87;86;86;85;86 07:50:50 INFO - PROCESS | 1656 | |8;json-parse-financial;56;56;56;56;55;55;54;55;56;54 07:50:50 INFO - PROCESS | 1656 | |9;json-stringify-tinderbox;64;66;77;77;73;70;69;70;69;71 07:50:50 INFO - PROCESS | 1656 | |10;stanford-crypto-aes;87;88;86;86;85;86;86;88;90;88 07:50:50 INFO - PROCESS | 1656 | |11;stanford-crypto-ccm;141;141;138;144;146;151;144;146;209;155 07:50:50 INFO - PROCESS | 1656 | |12;stanford-crypto-pbkdf2;169;171;171;170;171;170;172;170;182;222 07:50:50 INFO - PROCESS | 1656 | |13;stanford-crypto-sha256-iterative;67;68;67;68;67;68;66;66;66;66 07:50:50 INFO - PROCESS | 1656 | __end_tp_report 07:50:50 INFO - PROCESS | 1656 | __start_cc_report 07:50:50 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,2012 07:50:50 INFO - PROCESS | 1656 | __end_cc_report 07:50:50 INFO - PROCESS | 1656 | __startTimestamp1481989850363__endTimestamp 07:50:50 INFO - PROCESS | 1656 | 07:50:50 INFO - PROCESS | 1656 | ------- Summary: start ------- 07:50:50 INFO - PROCESS | 1656 | Number of tests: 14 07:50:50 INFO - PROCESS | 1656 | 07:50:50 INFO - PROCESS | 1656 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.50 stddev:1.03 (0.9%) stddev-sans-first:1.09 07:50:50 INFO - PROCESS | 1656 | Values: 113.0 112.0 114.0 113.0 112.0 115.0 114.0 113.0 114.0 112.0 07:50:50 INFO - PROCESS | 1656 | 07:50:50 INFO - PROCESS | 1656 | [#1] audio-beat-detection Cycles:10 Average:123.40 Median:122.50 stddev:20.03 (16.4%) stddev-sans-first:20.81 07:50:50 INFO - PROCESS | 1656 | Values: 135.0 115.0 135.0 171.0 116.0 109.0 108.0 109.0 129.0 107.0 07:50:50 INFO - PROCESS | 1656 | 07:50:50 INFO - PROCESS | 1656 | [#2] audio-dft Cycles:10 Average:183.00 Median:183.50 stddev:2.11 (1.1%) stddev-sans-first:2.11 07:50:50 INFO - PROCESS | 1656 | Values: 185.0 184.0 182.0 183.0 185.0 179.0 183.0 181.0 186.0 182.0 07:50:50 INFO - PROCESS | 1656 | 07:50:50 INFO - PROCESS | 1656 | [#3] audio-fft Cycles:10 Average:65.50 Median:61.00 stddev:10.63 (17.4%) stddev-sans-first:9.89 07:50:50 INFO - PROCESS | 1656 | Values: 80.0 58.0 60.0 86.0 62.0 59.0 59.0 58.0 75.0 58.0 07:50:50 INFO - PROCESS | 1656 | 07:50:50 INFO - PROCESS | 1656 | [#4] audio-oscillator Cycles:10 Average:84.20 Median:87.00 stddev:12.25 (14.1%) stddev-sans-first:12.95 07:50:50 INFO - PROCESS | 1656 | Values: 87.0 70.0 87.0 81.0 99.0 98.0 99.0 69.0 68.0 84.0 07:50:50 INFO - PROCESS | 1656 | 07:50:50 INFO - PROCESS | 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:1.45 (1.3%) stddev-sans-first:1.54 07:50:50 INFO - PROCESS | 1656 | Values: 109.0 109.0 108.0 109.0 109.0 111.0 106.0 111.0 109.0 110.0 07:50:50 INFO - PROCESS | 1656 | 07:50:50 INFO - PROCESS | 1656 | [#6] imaging-darkroom Cycles:10 Average:93.50 Median:93.50 stddev:0.71 (0.8%) stddev-sans-first:0.73 07:50:50 INFO - PROCESS | 1656 | Values: 94.0 93.0 94.0 93.0 93.0 93.0 95.0 94.0 93.0 93.0 07:50:50 INFO - PROCESS | 1656 | 07:50:50 INFO - PROCESS | 1656 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:86.00 stddev:1.62 (1.9%) stddev-sans-first:1.51 07:50:50 INFO - PROCESS | 1656 | Values: 88.0 85.0 88.0 84.0 83.0 87.0 86.0 86.0 85.0 86.0 07:50:50 INFO - PROCESS | 1656 | 07:50:50 INFO - PROCESS | 1656 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:56.00 stddev:0.82 (1.5%) stddev-sans-first:0.83 07:50:50 INFO - PROCESS | 1656 | Values: 56.0 56.0 56.0 56.0 55.0 55.0 54.0 55.0 56.0 54.0 07:50:50 INFO - PROCESS | 1656 | 07:50:50 INFO - PROCESS | 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:70.50 stddev:4.20 (6.0%) stddev-sans-first:3.71 07:50:50 INFO - PROCESS | 1656 | Values: 64.0 66.0 77.0 77.0 73.0 70.0 69.0 70.0 69.0 71.0 07:50:50 INFO - PROCESS | 1656 | 07:50:50 INFO - PROCESS | 1656 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:87.50 stddev:1.49 (1.7%) stddev-sans-first:1.58 07:50:50 INFO - PROCESS | 1656 | Values: 87.0 88.0 86.0 86.0 85.0 86.0 86.0 88.0 90.0 88.0 07:50:50 INFO - PROCESS | 1656 | 07:50:50 INFO - PROCESS | 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:151.50 Median:146.00 stddev:20.80 (14.2%) stddev-sans-first:21.71 07:50:50 INFO - PROCESS | 1656 | Values: 141.0 141.0 138.0 144.0 146.0 151.0 144.0 146.0 209.0 155.0 07:50:50 INFO - PROCESS | 1656 | 07:50:50 INFO - PROCESS | 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.80 Median:171.00 stddev:16.31 (9.5%) stddev-sans-first:17.05 07:50:50 INFO - PROCESS | 1656 | Values: 169.0 171.0 171.0 170.0 171.0 170.0 172.0 170.0 182.0 222.0 07:50:50 INFO - PROCESS | 1656 | 07:50:50 INFO - PROCESS | 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 07:50:50 INFO - PROCESS | 1656 | Values: 67.0 68.0 67.0 68.0 67.0 68.0 66.0 66.0 66.0 66.0 07:50:50 INFO - PROCESS | 1656 | -------- Summary: end -------- 07:50:50 INFO - PROCESS | 1656 | 07:50:51 INFO - TEST-INFO | 1656: exit 0 07:50:51 INFO - TEST-OK | kraken | took 59464ms 07:50:51 INFO - SUITE-END | took 1178s 07:50:51 INFO - Completed test suite (00:19:38) 07:50:51 INFO - javascript benchmark 07:50:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3278.4918337657673, 3279.131030276976, 3284.7043766061056, 3298.455754800458, 3353.4299169141245, 5446.373667028293, 5535.363433205182, 5540.307461567304, 5571.58213134015, 5585.916211256829, 4424.225760491917, 5314.734263286829, 5520.199571062193, 5528.917066244009, 5607.0, 5144.151215049513, 5150.3047088642925, 5151.995360904634, 5162.535371816536, 5167.302414174094, 5060.392752869642, 5150.227465880129, 5186.948130518703, 5218.504242096995, 5219.269302297681, 4366.432363792703, 5160.638755287131, 5202.479752024805, 5208.895822083556, 5222.112240919053, 4903.019396120754, 5155.690658560461, 5159.097157997336, 5198.92201616976, 5231.372235331765, 4056.2090392373498, 5005.02402031604, 5058.7976480940715, 5099.46455622158, 5113.207452844815, 5535.6955367454775, 5554.91667624986, 5556.91664625031, 5575.0, 5644.238027866227, 5473.781048758085, 6095.573309868311, 6105.206323178003, 6115.4190351916495, 6127.632342059491, 6027.367126451703, 6034.456898879078, 6066.6663333516635, 6103.034636161418, 6199.690015499207, 5661.716914154317, 5663.32040155184, 5667.234923285304, 5701.800436984686, 5738.713064346766, 6270.905936410957, 6282.685865706696, 6283.717232724538, 6287.088372186007, 6290.528210384239, 5787.913181302284, 5826.126081087871, 5946.07835785454, 5994.490468310155, 6003.3996600339615, 6018.3680713524445, 6116.3883611638485, 6124.663143527148, 6131.8966377332845, 6180.3201647818705, 6073.558648111332, 6073.817785466443, 6079.513638908877, 6086.878262434727, 6115.235595550556, 6024.1265016573225, 6079.604825686316, 6094.8171554853425, 6099.603525770811, 6106.908396374058, 4734.0, 4771.832985845548, 4787.61699064074, 4787.80304923769, 4792.688475249168, 4313.568643135662, 4315.5900189481945, 4320.3519472078815, 4360.171567402183, 4360.978195109067, 5558.360788509373, 5565.610407271533, 5593.412691667398, 5620.241267428926, 5623.297087864017, 5969.522438204933, 5993.190919225849, 6022.608530445507, 6191.0, 6199.070139479114, 5585.497305242467, 5623.803166889139, 5624.521915637135, 5630.8029218977135, 5665.660060396307, 5199.6880187188135, 5212.921806172911, 5284.841454756363, 5292.603054770908, 5315.548178404879, 6163.568550201622, 6304.842378940563, 6311.116443697978, 6314.684265786784, 6328.0, 6053.939460605337, 6084.452399283909, 6137.7851775187655, 6139.508839292756, 6142.262928448615, 6224.719887604978, 6227.159333489921, 6275.748970041147, 6287.528435367274, 6324.620522768649, 6056.242969628796, 6087.086936959491, 6087.640516563359, 6087.695615219132, 6137.508999279958, 6115.00784866965, 6141.754329826936, 6154.415330543591, 6170.722317495633, 6172.074188871705, 4136.048708797054, 5722.599418040697, 5728.083506638918, 5775.422457754191, 5875.706214689334, 5846.327672317738, 5874.03078492044, 5875.706214689163, 5884.588078834612, 5935.169076329231, 5754.05058165398, 5818.185454036354, 5845.298564172326, 5848.824535263949, 5887.764489420375, 6005.669688167018, 6016.969915150396, 6024.8795024100145, 6026.969865150646, 6028.306744724237, 5652.802151924663, 5871.295444546682, 5881.353051164283, 5883.29400471929, 5915.37888521699], "value": 5559.652959967145, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.98851034468964, 481.04752589872055, 493.56073094945526, 493.5903200343713, 493.7481884239037, 30744.0, 37870.24259514811, 39310.80344598277, 39493.605063949355, 41541.0, 40855.59144408555, 41200.79399602998, 41239.0, 41326.58673413265, 41386.0, 9297.488638124918, 9522.80954380912, 9523.95238023809, 9524.476153811538, 9534.80930381392, 8538.786530336729, 8758.0, 11127.0, 11373.260738052042, 11397.0, 11377.431128443544, 11459.59891403801, 11476.311421314747, 11485.712857178554, 11560.537578496893, 8479.660813567512, 11271.0, 11327.0, 11329.71675708114, 11351.772964540745, 8474.788130296793, 8627.309815214769, 8637.870431943526, 8638.870416943751, 9242.353035287533, 37411.81294093539, 38968.0, 39004.21991560153, 39019.60980390188, 39022.80488597539, 2984.5373967035143, 3217.517372394136, 3320.1367644412626, 3356.597208334991, 3416.538767266412, 27317.863410683018, 27563.72436275652, 27564.724352756417, 27841.86079069612, 28206.153815385573, 3075.0, 3179.6979286967703, 3193.5209718542174, 3204.7115759581516, 3246.2858171202533, 396022.01988990157, 480176.0, 482709.0, 483175.9999999965, 483737.0, 53020.14429494949, 53378.73310633422, 53386.0, 53438.0, 53517.0, 48325.0, 55112.62218444491, 55204.723976379864, 55298.0, 55299.723501382236, 14507.492237771627, 15006.02460840042, 15016.849831501546, 15034.323455444532, 15040.247987600576, 10520.263581549218, 10784.0, 11706.239094459002, 11794.705132371588, 11809.11431642613, 13967.37146828395, 14096.85903140976, 14097.647558810906, 14111.71776564463, 15894.92052539753, 7229.277072292729, 7567.918822323795, 7570.129435115033, 7583.165851756303, 7594.126675432396, 858.3690987124459, 860.8249739106075, 934.2806039349663, 973.4889183178888, 983.6901376066517, 28586.85706571454, 29290.7070929288, 29529.409411812074, 29739.006219805957, 30276.0, 1052.310736467615, 1067.2049323254225, 1071.164491696478, 1082.577794660083, 1121.5233525751523, 12449.875501245053, 14692.118472891661, 15077.773833392508, 15208.543743687485, 15213.239338033054, 177588.0, 178213.0, 179026.10486947742, 651565.0, 831012.0, 47540.76229618899, 48074.759626201645, 48789.26816097761, 56500.0, 57749.0, 1356.5184359552218, 1379.3723855645658, 1403.1300593632013, 1403.5438482493025, 1403.6561042544847, 24380.26859194227, 28702.282442939093, 29344.85327573434, 29780.55329170021, 30753.231169220948, 48453.75773121112, 49277.01445970989, 49332.50667493279, 49370.75314623404, 49429.76425589245, 596717.0164149151, 602996.0, 603540.0, 603545.0, 605993.0, 36473.45289820708, 36615.0, 37101.814490927376, 37151.81424092862, 37365.4395184067, 40665.39001914914, 40773.79613102034, 41808.1638367237, 42020.73937781872, 42103.0, 33913.98258052262, 34794.478082828275, 35000.12499687528, 35801.64198357983, 36109.0, 34149.0, 34243.65756342404, 34343.96968090961, 35176.296474069866, 35327.82336088406, 33780.891998686464, 34156.658433415345, 34728.30543389067, 34869.0, 34883.9534813956, 28756.42487150287, 29556.852215738785, 31004.379912402077, 31019.224519387197, 31205.219869503446, 23332.0, 23658.053677853382, 23697.881510592335, 23782.405439864142, 23792.286231413087], "value": 18960.073520224712, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.53895698629464, 350.85439542589825, 371.7230663155949, 378.56465065175047, 381.43928425214943, 14699.26503674816, 14925.029873058258, 16419.83580164198, 20602.38192854213, 20774.714781374038, 19358.22567097318, 19975.700364494543, 20453.38639840807, 20751.377458676227, 20827.583448331025, 5732.656040637565, 5812.258227552822, 5983.461488466037, 6014.8195554133445, 6019.5485338599565, 4595.379623750801, 5884.08796636522, 5951.464368206861, 5953.345132035494, 5978.611390259619, 5603.187537807015, 5899.469047785698, 5903.4686878180955, 5906.763729450817, 5908.084246941731, 5758.971205143968, 5779.797707080253, 5824.53403727705, 5837.766489340422, 5847.9415205848245, 5118.872028199287, 5129.410117836459, 5131.281620573122, 6806.897896531556, 7094.11323584552, 27223.591646125325, 27706.56694928822, 27833.0, 27874.16377508678, 28114.437711245864, 2304.2626359564947, 2486.117682213206, 2490.003998400636, 3019.290466740314, 3313.9834300828343, 15033.849661503355, 16297.51107466766, 16602.75095873563, 16851.241694123793, 16904.915475422666, 1874.831265186126, 1971.3297478857114, 1973.6052789442026, 2018.5155562665002, 2130.38218916514, 112713.43643281813, 115874.0, 116564.0, 117091.0, 118268.40865795701, 16174.530187924689, 18299.34659474369, 19100.426987190407, 20330.186792528133, 20754.688679669816, 34119.31761364759, 34124.658753412645, 34139.51349243636, 34223.82888085594, 34234.31531369359, 8202.425830191949, 10403.895961040444, 10580.25938184335, 10723.410212438392, 10769.78460430787, 8654.394192406471, 8678.739637810875, 8684.392092553588, 8810.691625793066, 8861.202491775772, 7915.683372665144, 7948.244916732901, 9244.214241789388, 9663.226941844636, 9664.855027174597, 3160.9812628939308, 3168.429682657144, 3414.9413681758733, 3444.51776751255, 3717.70258379329, 899.9325050621229, 930.8091841172679, 949.2880339745191, 971.3734641156556, 1036.2538971940191, 19934.50163745918, 20873.895630522053, 21157.499050247046, 21286.574268514854, 21396.893015535134, 909.9863502047475, 946.4084946908182, 966.8453047512364, 968.2931460034074, 1020.550957578663, 9049.77375565616, 10684.51919663617, 10738.624148154777, 11111.833322500008, 11199.104071674246, 511809.0, 521753.8246175428, 531911.0, 534607.0, 534793.0, 110927.0, 111339.44330278297, 111431.47795386337, 115481.42259288649, 121027.0, 969.3311614985637, 977.2914636888199, 994.0308199505424, 1000.0399616368222, 1000.9549570269355, 14186.361613727613, 18633.347832825784, 18759.249630014645, 18859.528511787314, 19204.807951920302, 39948.60051399449, 48483.51516484931, 52705.472945270056, 53571.19643205433, 53635.46364536461, 67507.32492675011, 70875.0, 72036.9194462094, 72589.6370518144, 73617.0, 7747.573883436465, 7765.7670269892, 8044.436889417684, 8090.433669643304, 8237.135100814568, 11362.261453005529, 12222.0, 12590.307533085768, 12644.178128421623, 12655.177413468095, 8948.702438146562, 10317.535710892878, 10726.372038850532, 11015.28400653987, 11028.22802403856, 5215.009148261818, 7806.92193078062, 10522.526846241379, 10634.042936135476, 10958.068564172134, 10760.677179684622, 10879.292845964987, 11163.553457861595, 11245.0, 11261.831072533754, 7869.8819517708425, 8034.959825200836, 8074.111847696631, 8077.596120193849, 8085.312748416451, 8886.644534218818, 10551.788964220827, 10975.945120274348, 11007.119430445386, 11008.559657613927], "value": 10288.639429514607, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1342.0471465259666, 1350.2438634364753, 1494.0214159725376, 1640.3930545698092, 1833.569111258854, 7503.69985200592, 7874.92125078749, 8154.918450815498, 8425.620847061882, 8444.986601607816, 8284.544350060743, 8369.748907532768, 8372.874406883902, 8377.16228377162, 8388.454750441217, 2024.959500809983, 2114.6827975803676, 2219.289827255279, 2261.6607508873717, 2267.716535433071, 1888.6411581799482, 2115.016517319446, 2127.617028934799, 2131.2007997001124, 2332.102140675835, 2293.9770602294016, 2304.83866129371, 2306.642470417088, 2310.0182422470466, 2313.248194336839, 2215.1360969222014, 2219.8668079915255, 2231.8326125540566, 2246.84272100953, 2253.43664083979, 1999.2203040814095, 2273.693051438051, 2273.954520909589, 2301.505176387068, 2306.8039216666602, 8258.25675689191, 8288.627011784483, 8349.624266907944, 8385.832283354359, 8395.99248090227, 5032.169692000815, 5169.896602067975, 5179.818706345298, 5189.896202075937, 5190.0, 3438.933930481534, 3439.9828000860084, 3440.4839274108836, 3493.9650603494147, 3517.0, 847.7117779954783, 1031.793641271741, 1041.5989843910074, 1044.926855120142, 1069.8609180806523, 10618.097461715763, 10756.946215268874, 10769.407682577455, 10769.784604307948, 10786.46067696612, 4401.40581021558, 4508.481524624644, 4609.262517997105, 4616.0998605272325, 4666.183417901853, 9335.206507446943, 9357.0, 9358.766030849283, 9359.29805264608, 9364.62541498346, 5190.039842629126, 5219.765110570033, 5239.476052394806, 5245.816396426107, 5252.816151434681, 4592.104539614743, 4696.225122854691, 4734.171519983989, 4804.567588917014, 4805.903881922342, 3541.5218945442552, 3651.3975194092677, 3730.515033045687, 3776.735628506033, 3794.3739283017994, 1245.514249442718, 1250.9687257818628, 1254.3226657604791, 1264.8861602455822, 1275.0755702116078, 826.8506775581945, 845.564534264854, 894.5124906925741, 895.5477483870603, 930.4742820306641, 5402.677857713813, 5434.510894019557, 5637.9718101409235, 5703.914441283384, 5839.883202336015, 900.1898291537537, 900.7479603351347, 916.7478943290648, 934.8457504511815, 946.0208684012015, 2910.519764238877, 3242.5460435539044, 3335.4996750487135, 3356.14418323326, 3572.464130380412, 9718.416894986323, 9994.300398972147, 10067.748306292402, 10074.042965918226, 10101.14140298083, 10034.397936123856, 10045.246606504541, 10047.196224302184, 10070.093691567794, 10079.445630490394, 7400.0, 7612.467127301035, 7717.880907268414, 7780.727674531364, 7868.527888326718, 5440.6735595864375, 5556.861078472909, 5559.777608895761, 5573.916391254215, 5737.627054241461, 9168.174864262248, 9225.49259790718, 9347.813043739223, 9434.0, 9439.433633981984, 8990.145936136056, 9374.203192728695, 9447.52762361893, 9559.0, 9580.95209523948, 6881.621510816954, 7176.677049532888, 7184.784456466315, 7186.856262874609, 7195.71217151329, 7462.179160292472, 7644.273793989562, 7730.7680769577, 7762.379009679099, 7848.450608457353, 7015.894761578683, 7045.084139062094, 7070.292970702889, 7074.71701131949, 7111.075560177143, 6927.653617319214, 6966.233714291525, 6986.441084713312, 7043.401310888426, 7081.0, 5579.944200558105, 6489.0, 6550.377714117151, 6614.900776488453, 6623.801285961429, 4731.905361892674, 4754.31062495943, 4819.349387832598, 4827.686200396963, 4870.09903167915, 4693.296005599051, 4810.5670489656095, 4850.1269771441475, 4904.215325547895, 4965.453800081916], "value": 4351.149257786598, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.79839205320513, 351.3201954218587, 363.46933477123406, 369.9926001479969, 371.9683826874717, 4371.153385021181, 4669.743164125972, 4947.406311242651, 5197.636165468419, 5307.25698402223, 4350.630196433307, 4569.4745104313015, 4657.556157591141, 4977.850664480072, 5176.275321454999, 3925.8429662813523, 4044.413560033793, 4112.712110152291, 4131.0584025508115, 4133.875983720493, 3402.0, 3426.8800591979284, 3658.6890114340313, 4095.7542547447247, 4171.833126674929, 3280.9179770505807, 3941.783201923893, 4134.400511925769, 4135.379693046037, 4178.603032711888, 3488.8081155536433, 3943.9211215775813, 3949.7630142191274, 3958.247932892741, 3989.4866234272367, 2879.3809330993936, 3280.0979730574045, 3396.1679388549965, 3413.3887576004377, 3422.8801991930163, 4053.9594604053877, 4231.61915427613, 4610.608098311647, 4642.0, 5122.206058061007, 3995.36074228125, 4248.957510424918, 4417.0564951421275, 4510.007798284372, 4513.345564893105, 4534.7052441591195, 4798.880027999293, 5152.381714194284, 5437.945620543823, 5443.945560544384, 3682.6317368263226, 3756.849726010956, 3770.6606405423645, 3779.811009449544, 3781.7920014399197, 5442.863928401782, 5480.944645757841, 5815.255423372972, 5822.563307751935, 5826.563007774434, 3366.8316584170693, 3797.715171362159, 3798.5631652360335, 3818.1218319786603, 3855.6722678572073, 3227.596550431196, 3838.84834549634, 3882.8058597070035, 3884.864029758945, 3900.2004589059175, 4159.604837540429, 4338.522762496123, 4433.977830110894, 4502.144592527475, 4552.20188025728, 4204.4352944704315, 4546.61353784932, 4666.346711460398, 5552.305961754781, 5600.831975040755, 1115.760111576015, 1116.7492408502528, 1127.461015713545, 1211.660734994203, 1254.494606472237, 734.7942576078707, 756.0360540311037, 798.9320907722793, 812.1918690902589, 822.457178262344, 4628.490866004737, 4821.783019764119, 4839.9188349010265, 5077.644564880497, 5294.788208471695, 5738.254026976467, 5738.393249890038, 5747.626404283708, 5760.695721711265, 5783.2288362101435, 4229.619334259932, 4458.286674132123, 5000.399952005782, 5033.723145226974, 5311.787528498817, 2463.721058021323, 2623.462190251032, 2812.9578056329174, 2842.5025620516326, 2880.495913215179, 4877.951280449719, 4997.0, 5056.140456122468, 5303.6928935913, 5333.1600597793695, 4698.483166851644, 5376.4085950545405, 5391.272178255964, 5632.690202038927, 5646.334331372255, 5126.69239845603, 5643.322801263875, 5671.347795003545, 5676.716164191774, 5741.942580574141, 4447.911041779082, 4465.933011004772, 4806.197675871548, 4963.486136728333, 5122.564582010571, 4790.4251489821445, 5332.373626044094, 5352.384475785178, 5384.946150538444, 5397.514223719884, 5592.888142237051, 5593.664380137205, 5624.943750562442, 5652.802151924828, 5691.3170419549915, 3872.825722842535, 3874.4188371744463, 3929.6835560086547, 3937.853869640995, 3963.286608410514, 5599.692016939108, 5623.522000629992, 5629.352624448241, 5658.575606829422, 5698.800541981177, 4770.165221086366, 4812.157872372391, 5339.065663508948, 5468.183885298995, 5542.812882592606, 4738.620910327235, 5061.215511595708, 5175.715335656575, 5239.554637855825, 5377.784888604412, 4535.387722657399, 4601.838935637371, 5411.918821217763, 5454.154606036071, 5456.781728730806, 5410.889752996256, 5441.673499590037, 5462.3445186577865, 5608.38307786135, 5644.322681278109, 4694.178518759135, 4858.757062146808, 5305.1776974569, 5434.510894019557, 5453.045716999589], "value": 3929.3206148589084, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.266082587, 747.7868807389895, 779.8557266905623, 822.1408627983757, 833.5332213960181, 12729.236245825234, 14451.855481445182, 15353.84646153538, 15416.383344666214, 15436.91941564091, 13986.860131398684, 14167.362468688909, 14178.716425671506, 14188.929055354734, 14224.502142425017, 685.25649670108, 706.3431009161478, 837.969297763751, 862.0474375814713, 867.5185272173941, 875.5928493250638, 877.8814859993915, 878.8637761147032, 886.6896586194813, 888.5424006636588, 929.3262384771054, 929.4934260827865, 931.8276118918022, 932.4638332958542, 935.0509233128346, 721.942244620429, 888.2272422992038, 888.4358432395476, 889.0531583863198, 902.5757893789909, 556.7633755653872, 667.6461475418037, 688.4595592459895, 697.4106879686657, 700.1528150937372, 14503.41986320546, 14538.781918271234, 14548.709025819424, 14559.636009099751, 14573.344199511048, 12351.0, 13015.088943773939, 13177.670558236025, 13247.602571922858, 13520.391582378816, 10823.404712740796, 11081.667549973434, 11509.730053514064, 12334.691632709164, 12453.875461245361, 4361.847335343279, 4410.16206920684, 4419.226635338803, 4572.285392977634, 4590.150822097889, 101462.99999999926, 102915.48542257315, 103825.0, 104186.0, 104910.0, 10663.680089597325, 10689.893101069045, 10831.67504974852, 10842.295250808673, 11003.284786488852, 20647.967601619857, 21005.36983890486, 21087.68368474474, 21149.57700846005, 21615.56768864614, 7220.4584656151, 7464.850702986018, 7553.884912224586, 7728.613569321511, 7753.418493613001, 4308.719933204332, 4324.372965919924, 4325.0, 4327.891802704958, 4351.325544540601, 3328.134684981922, 3395.8981230562626, 3401.523786669868, 3412.7781694190294, 3418.6410426905313, 626.5269721360344, 633.3571425003626, 636.9713362898681, 639.6769631336145, 644.3588629313863, 506.8428787076018, 578.9768409263667, 616.0778371480918, 642.6626021338834, 656.0159760359461, 7630.7710768677025, 8829.0, 8835.779105522413, 9951.480443039245, 9955.153811925922, 480.16930709872116, 518.6239976017357, 583.2854752927715, 589.4930359890491, 630.706721374563, 4230.259704551691, 4392.231359512072, 4500.122476117126, 4547.7498737569085, 4588.403507543998, 78693.60653196697, 92605.53697231605, 95605.52197238969, 96563.0, 100252.0, 71010.64494677493, 73649.26350736425, 79915.0, 83784.16215837763, 85552.57223713842, 73633.63183184157, 73702.63148684437, 75266.24733752702, 76692.84960725594, 76995.61502192453, 8318.45930014547, 8791.208791208823, 8813.0, 8906.910930890608, 8926.608987551681, 47391.763041184575, 48297.82341355131, 48331.51668483411, 48497.5150248493, 49436.86544258346, 63512.09463716096, 67228.32771672221, 67613.0, 68649.3135068663, 70771.64614176896, 11591.0, 11697.23967942115, 11763.353015584225, 11807.409629518661, 11905.940470297593, 12798.744025119631, 12871.356432178167, 13066.346682665639, 13103.396565944442, 13457.461701531829, 11061.834072488758, 11644.184907056424, 11813.586524471602, 11861.169718119649, 12261.14172007951, 11782.705432364259, 12214.38928053576, 12371.13402061847, 12405.069619778373, 12485.93757031209, 11655.41722913834, 12003.939980300043, 12246.571370002008, 12325.198862073936, 12393.814092788796, 9968.850467243143, 10044.0, 10105.848412273968, 10290.073893349634, 10412.114970227616, 7538.811529711801, 7919.08930473003, 8235.34117270605, 9824.65613703517, 10376.584936602452], "value": 7126.909740170515, "unit": "score"}], "name": "dromaeo_css", "value": 7137.064540075051, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 114.0, 113.0, 112.0, 115.0, 114.0, 113.0, 114.0, 112.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 115.0, 135.0, 171.0, 116.0, 109.0, 108.0, 109.0, 129.0, 107.0], "value": 123.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 182.0, 183.0, 185.0, 179.0, 183.0, 181.0, 186.0, 182.0], "value": 183.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 60.0, 86.0, 62.0, 59.0, 59.0, 58.0, 75.0, 58.0], "value": 65.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 87.0, 81.0, 99.0, 98.0, 99.0, 69.0, 68.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 109.0, 108.0, 109.0, 109.0, 111.0, 106.0, 111.0, 109.0, 110.0], "value": 109.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 93.0, 93.0, 93.0, 95.0, 94.0, 93.0, 93.0], "value": 93.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 84.0, 83.0, 87.0, 86.0, 86.0, 85.0, 86.0], "value": 85.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 56.0, 55.0, 55.0, 54.0, 55.0, 56.0, 54.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 77.0, 77.0, 73.0, 70.0, 69.0, 70.0, 69.0, 71.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 86.0, 86.0, 85.0, 86.0, 86.0, 88.0, 90.0, 88.0], "value": 87.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 141.0, 138.0, 144.0, 146.0, 151.0, 144.0, 146.0, 209.0, 155.0], "value": 151.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 171.0, 171.0, 170.0, 171.0, 170.0, 172.0, 170.0, 182.0, 222.0], "value": 176.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 68.0, 67.0, 68.0, 66.0, 66.0, 66.0, 66.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1465.8, "alertThreshold": 2.0}]} 07:50:51 INFO - Return code: 0 07:50:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:50:51 INFO - # TBPL SUCCESS # 07:50:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:50:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:50:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:50:51 INFO - 2016-12-17 07:50:51.710 screenresolution[1660:9752] starting screenresolution argv=screenresolution get 07:50:51 INFO - 2016-12-17 07:50:51.713 screenresolution[1660:9752] Display 0: 1600x1200x32@60 07:50:51 INFO - 2016-12-17 07:50:51.719 screenresolution[1661:9755] starting screenresolution argv=screenresolution list 07:50:51 INFO - Available Modes on Display 0 07:50:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:50:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:50:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:50:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:50:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:50:51 INFO - Intel Iris: 07:50:51 INFO - Chipset Model: Intel Iris 07:50:51 INFO - Type: GPU 07:50:51 INFO - Bus: Built-In 07:50:51 INFO - VRAM (Dynamic, Max): 1536 MB 07:50:51 INFO - Vendor: Intel (0x8086) 07:50:51 INFO - Device ID: 0x0a2e 07:50:51 INFO - Revision ID: 0x0009 07:50:51 INFO - Displays: 07:50:51 INFO - Display: 07:50:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:50:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:50:51 INFO - Display Serial Number: 1600x1200 60 07:50:51 INFO - Main Display: Yes 07:50:51 INFO - Mirror: Off 07:50:51 INFO - Online: Yes 07:50:51 INFO - Rotation: Supported 07:50:51 INFO - Return code: 0 07:50:51 INFO - Running post-action listener: _resource_record_post_action 07:50:51 INFO - [mozharness: 2016-12-17 15:50:51.954162Z] Finished run-tests step (success) 07:50:51 INFO - Running post-run listener: _resource_record_post_run 07:50:52 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 37540864; Write bytes: 549835264; Read time: 247; Write time: 1658 07:50:52 INFO - TinderboxPrint: CPU usage
53.7% 07:50:52 INFO - TinderboxPrint: I/O read bytes / time
37,540,864 / 247 07:50:52 INFO - TinderboxPrint: I/O write bytes / time
549,835,264 / 1,658 07:50:52 INFO - TinderboxPrint: CPU idle
2,226.7 (46.3%) 07:50:52 INFO - TinderboxPrint: CPU system
960.4 (20.0%) 07:50:52 INFO - TinderboxPrint: CPU user
1,618.6 (33.7%) 07:50:52 INFO - TinderboxPrint: Swap in / out
286,793,728 / 0 07:50:52 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 250477056; Write bytes: 250269696; Read time: 18198; Write time: 543 07:50:52 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 34268160; Write bytes: 298226176; Read time: 220; Write time: 1109 07:50:52 INFO - Running post-run listener: _upload_blobber_files 07:50:52 INFO - Blob upload gear active. 07:50:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:50:52 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 07:50:52 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:50:52 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:50:52 INFO - (blobuploader) - INFO - Open directory for files ... 07:50:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:50:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:50:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:50:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:50:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:50:54 INFO - (blobuploader) - INFO - Done attempting. 07:50:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:50:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:50:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:50:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:50:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:50:55 INFO - (blobuploader) - INFO - Done attempting. 07:50:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:50:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:50:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:50:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:50:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:50:57 INFO - (blobuploader) - INFO - Done attempting. 07:50:57 INFO - (blobuploader) - INFO - Iteration through files over. 07:50:57 INFO - Return code: 0 07:50:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:50:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:50:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b52f8c3e03084e1dac6137fb46722f5bb7b8c0f6457f0e2b010a25fee6db9c48cd10907ec558c0993d0831fd6f4832ced8bf5e14574cca3970b5b7d45949f361", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e61fd886c0e8af4ae795f285528f3c92727bf6b50c963cc2aa0386f69371289b39a704b93f09dce4579f352800c0b96a37a6a52481902a161110559ec1535d3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da15d1837a60bb2af6e29e705214d68911479acd4aaefc300ce307de5203d698e3126bfaf2c69172ec5af8813ab3d13960b677082cdfa02ee7980f8901226750"} 07:50:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:50:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:50:57 INFO - Contents: 07:50:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b52f8c3e03084e1dac6137fb46722f5bb7b8c0f6457f0e2b010a25fee6db9c48cd10907ec558c0993d0831fd6f4832ced8bf5e14574cca3970b5b7d45949f361", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e61fd886c0e8af4ae795f285528f3c92727bf6b50c963cc2aa0386f69371289b39a704b93f09dce4579f352800c0b96a37a6a52481902a161110559ec1535d3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da15d1837a60bb2af6e29e705214d68911479acd4aaefc300ce307de5203d698e3126bfaf2c69172ec5af8813ab3d13960b677082cdfa02ee7980f8901226750"} 07:50:57 INFO - Running post-run listener: copy_logs_to_upload_dir 07:50:57 INFO - Copying logs to upload dir... 07:50:57 INFO - mkdir: /builds/slave/test/build/upload/logs 07:50:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.690119 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-12-17 07:50:57.406077) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-17 07:50:57.411997) ========= 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.J44IH4ziXi/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.RxH2Y9fCpg/Listeners TMPDIR=/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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/Firefox/sha512/b52f8c3e03084e1dac6137fb46722f5bb7b8c0f6457f0e2b010a25fee6db9c48cd10907ec558c0993d0831fd6f4832ced8bf5e14574cca3970b5b7d45949f361", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e61fd886c0e8af4ae795f285528f3c92727bf6b50c963cc2aa0386f69371289b39a704b93f09dce4579f352800c0b96a37a6a52481902a161110559ec1535d3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da15d1837a60bb2af6e29e705214d68911479acd4aaefc300ce307de5203d698e3126bfaf2c69172ec5af8813ab3d13960b677082cdfa02ee7980f8901226750"} build_url:https://queue.taskcluster.net/v1/task/K_tOI8VjQ8qRENhmOc-Vug/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010821 build_url: 'https://queue.taskcluster.net/v1/task/K_tOI8VjQ8qRENhmOc-Vug/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b52f8c3e03084e1dac6137fb46722f5bb7b8c0f6457f0e2b010a25fee6db9c48cd10907ec558c0993d0831fd6f4832ced8bf5e14574cca3970b5b7d45949f361", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e61fd886c0e8af4ae795f285528f3c92727bf6b50c963cc2aa0386f69371289b39a704b93f09dce4579f352800c0b96a37a6a52481902a161110559ec1535d3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da15d1837a60bb2af6e29e705214d68911479acd4aaefc300ce307de5203d698e3126bfaf2c69172ec5af8813ab3d13960b677082cdfa02ee7980f8901226750"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-17 07:50:57.446070) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 07:50:57.446402) ========= 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.J44IH4ziXi/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.RxH2Y9fCpg/Listeners TMPDIR=/var/folders/f5/y9v1vjgn6s1cnhhybj4hv4_r00000w/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.004954 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 07:50:57.496013) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-17 07:50:57.496353) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-17 07:50:57.496822) ========= ========= Total master_lag: 0.19 =========