builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0133 starttime: 1487881030.0 results: success (0) buildid: 20170223103422 builduid: e72edaab5e914261aba9f214665ab98c revision: 02a085cba71fb767d17d3e3e33f252da066f5d41 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-23 12:17:09.996941) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-23 12:17:09.997401) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-23 12:17:09.997694) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-23 12:17:10.022819) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 12:17:10.023424) ========= 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.Yaj1RhGEW9/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.PYi81FDaQq/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-23 12:17:10-- 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% 153M=0s 2017-02-23 12:17:10 (153 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136917 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 12:17:10.184034) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 12:17:10.184350) ========= 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.Yaj1RhGEW9/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.PYi81FDaQq/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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.019459 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 12:17:10.233656) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-23 12:17:10.234184) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 02a085cba71fb767d17d3e3e33f252da066f5d41 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 02a085cba71fb767d17d3e3e33f252da066f5d41 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Yaj1RhGEW9/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.PYi81FDaQq/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-23 12:17:10,321 truncating revision to first 12 chars 2017-02-23 12:17:10,321 Setting DEBUG logging. 2017-02-23 12:17:10,321 attempt 1/10 2017-02-23 12:17:10,321 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/02a085cba71f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-23 12:17:11,414 unpacking tar archive at: mozilla-beta-02a085cba71f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.339647 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-23 12:17:11.598977) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-23 12:17:11.599576) ========= script_repo_revision: 02a085cba71fb767d17d3e3e33f252da066f5d41 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-23 12:17:11.600254) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-23 12:17:11.600745) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-23 12:17:11.621251) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-23 12:17:11.621677) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Yaj1RhGEW9/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.PYi81FDaQq/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 12:17:11 INFO - MultiFileLogger online at 20170223 12:17:11 in /builds/slave/test 12:17:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 12:17:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:17:11 INFO - {'append_to_log': False, 12:17:11 INFO - 'base_work_dir': '/builds/slave/test', 12:17:11 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:17:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:17:11 INFO - 'branch': 'Mozilla-Beta', 12:17:11 INFO - 'buildbot_json_path': 'buildprops.json', 12:17:11 INFO - 'config_files': ('talos/mac_config.py',), 12:17:11 INFO - 'default_actions': ('clobber', 12:17:11 INFO - 'read-buildbot-config', 12:17:11 INFO - 'download-and-extract', 12:17:11 INFO - 'populate-webroot', 12:17:11 INFO - 'create-virtualenv', 12:17:11 INFO - 'install', 12:17:11 INFO - 'run-tests'), 12:17:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:17:11 INFO - 'download_minidump_stackwalk': True, 12:17:11 INFO - 'download_symbols': 'ondemand', 12:17:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:17:11 INFO - 'tooltool.py': '/tools/tooltool.py', 12:17:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:17:11 INFO - '/tools/misc-python/virtualenv.py')}, 12:17:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:17:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:17:11 INFO - 'installer_path': 'installer.exe', 12:17:11 INFO - 'log_level': 'info', 12:17:11 INFO - 'log_name': 'talos', 12:17:11 INFO - 'log_to_console': True, 12:17:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:17:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:17:11 INFO - 'opt_config_files': (), 12:17:11 INFO - 'pip_index': False, 12:17:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:17:11 INFO - 'cmd': ('bash', 12:17:11 INFO - '-c', 12:17:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:17:11 INFO - 'enabled': True, 12:17:11 INFO - 'halt_on_failure': False, 12:17:11 INFO - 'name': 'check_screen_resolution'},), 12:17:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:17:11 INFO - 'cmd': ('bash', 12:17:11 INFO - '-c', 12:17:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:17:11 INFO - 'enabled': True, 12:17:11 INFO - 'halt_on_failure': False, 12:17:11 INFO - 'name': 'check_screen_resolution'},), 12:17:11 INFO - 'run_cmd_checks_enabled': True, 12:17:11 INFO - 'sps_profile': False, 12:17:11 INFO - 'sps_profile_interval': 0, 12:17:11 INFO - 'suite': 'dromaeojs-e10s', 12:17:11 INFO - 'system_bits': '32', 12:17:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:17:11 INFO - 'title': 't-yosemite-r7-0133', 12:17:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:17:11 INFO - 'use_talos_json': True, 12:17:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:17:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:17:11 INFO - 'work_dir': 'build'} 12:17:11 INFO - [mozharness: 2017-02-23 20:17:11.833609Z] Running clobber step. 12:17:11 INFO - Running pre-action listener: _resource_record_pre_action 12:17:11 INFO - Running main action method: clobber 12:17:11 INFO - rmtree: /builds/slave/test/build 12:17:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:17:13 INFO - Running post-action listener: _resource_record_post_action 12:17:13 INFO - [mozharness: 2017-02-23 20:17:13.478017Z] Finished clobber step (success) 12:17:13 INFO - [mozharness: 2017-02-23 20:17:13.478143Z] Running read-buildbot-config step. 12:17:13 INFO - Running pre-action listener: _resource_record_pre_action 12:17:13 INFO - Running main action method: read_buildbot_config 12:17:13 INFO - Using buildbot properties: 12:17:13 INFO - { 12:17:13 INFO - "project": "", 12:17:13 INFO - "product": "firefox", 12:17:13 INFO - "script_repo_revision": "production", 12:17:13 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 12:17:13 INFO - "repository": "", 12:17:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 12:17:13 INFO - "buildid": "20170223103422", 12:17:13 INFO - "pgo_build": "False", 12:17:13 INFO - "basedir": "/builds/slave/test", 12:17:13 INFO - "buildnumber": 19, 12:17:13 INFO - "slavename": "t-yosemite-r7-0133", 12:17:13 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 12:17:13 INFO - "platform": "yosemite_r7", 12:17:13 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 12:17:13 INFO - "branch": "mozilla-beta", 12:17:13 INFO - "repo_path": "releases/mozilla-beta", 12:17:13 INFO - "revision": "02a085cba71fb767d17d3e3e33f252da066f5d41", 12:17:13 INFO - "stage_platform": "macosx64", 12:17:13 INFO - "builduid": "e72edaab5e914261aba9f214665ab98c", 12:17:13 INFO - "slavebuilddir": "test" 12:17:13 INFO - } 12:17:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/Tg5fLDZLQAG8b-yuy5Qaiw/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 12:17:13 INFO - Running post-action listener: _resource_record_post_action 12:17:13 INFO - [mozharness: 2017-02-23 20:17:13.481375Z] Finished read-buildbot-config step (success) 12:17:13 INFO - [mozharness: 2017-02-23 20:17:13.481499Z] Running download-and-extract step. 12:17:13 INFO - Running pre-action listener: _resource_record_pre_action 12:17:13 INFO - Running main action method: download_and_extract 12:17:13 INFO - mkdir: /builds/slave/test/build/tests 12:17: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')]} 12:17:13 INFO - trying https://queue.taskcluster.net/v1/task/Tg5fLDZLQAG8b-yuy5Qaiw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 12:17:13 INFO - Downloading https://queue.taskcluster.net/v1/task/Tg5fLDZLQAG8b-yuy5Qaiw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 12:17:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tg5fLDZLQAG8b-yuy5Qaiw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 12:17:14 INFO - Downloaded 1165 bytes. 12:17:14 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 12:17:14 INFO - Using the following test package requirements: 12:17:14 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 12:17:14 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 12:17:14 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 12:17:14 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 12:17:14 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 12:17:14 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 12:17:14 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 12:17:14 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 12:17:14 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 12:17:14 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 12:17:14 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 12:17:14 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 12:17:14 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 12:17:14 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 12:17:14 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 12:17:14 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 12:17:14 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 12:17:14 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 12:17:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tg5fLDZLQAG8b-yuy5Qaiw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 12:17:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tg5fLDZLQAG8b-yuy5Qaiw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 12:17:14 INFO - Fetch https://queue.taskcluster.net/v1/task/Tg5fLDZLQAG8b-yuy5Qaiw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 12:17:15 INFO - Http code: 200 12:17:15 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 12:17:15 INFO - x-amz-cf-id: T6-5jtcbBaLqqiS7naRk-ImZ-c93H-jfCU4uo-fP7l7NVtcevL3OSQ== 12:17:15 INFO - x-amz-version-id: .dNfIcIF_7lGc93_2MJ9.hJm55yRtW3p 12:17:15 INFO - Expected file size: 16093388 12:17:15 INFO - Obtained file size: 16093388 12:17:22 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 12:17:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tg5fLDZLQAG8b-yuy5Qaiw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 12:17:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tg5fLDZLQAG8b-yuy5Qaiw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 12:17:22 INFO - Fetch https://queue.taskcluster.net/v1/task/Tg5fLDZLQAG8b-yuy5Qaiw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 12:17:23 INFO - Http code: 200 12:17:23 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 12:17:23 INFO - x-amz-cf-id: pNzb10iY14KVWPF12QM7AZIAuxQwDaYltL5x-qEKTAyEWsce4WhtcQ== 12:17:23 INFO - x-amz-version-id: .dNfIcIF_7lGc93_2MJ9.hJm55yRtW3p 12:17:23 INFO - Expected file size: 16093388 12:17:23 INFO - Obtained file size: 16093388 12:17:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tg5fLDZLQAG8b-yuy5Qaiw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 12:17:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tg5fLDZLQAG8b-yuy5Qaiw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 12:17:30 INFO - Fetch https://queue.taskcluster.net/v1/task/Tg5fLDZLQAG8b-yuy5Qaiw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 12:17:31 INFO - Http code: 200 12:17:31 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 12:17:31 INFO - x-amz-cf-id: WRrKxlScTjH7KdOCvchvIs4m4ekyAF8PmzSfZ-NsMF2K-LVEfAFFrA== 12:17:31 INFO - x-amz-version-id: L3szh.rX_aCWtkAYM5glaXvN3PHo084. 12:17:31 INFO - Expected file size: 14403005 12:17:31 INFO - Obtained file size: 14403005 12:17:32 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')]} 12:17:32 INFO - trying https://queue.taskcluster.net/v1/task/Tg5fLDZLQAG8b-yuy5Qaiw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 12:17:32 INFO - Downloading https://queue.taskcluster.net/v1/task/Tg5fLDZLQAG8b-yuy5Qaiw/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 12:17:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tg5fLDZLQAG8b-yuy5Qaiw/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 12:17:34 INFO - Downloaded 82109783 bytes. 12:17:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Tg5fLDZLQAG8b-yuy5Qaiw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 12:17:34 INFO - mkdir: /builds/slave/test/properties 12:17:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:17:34 INFO - Writing to file /builds/slave/test/properties/build_url 12:17:34 INFO - Contents: 12:17:34 INFO - build_url:https://queue.taskcluster.net/v1/task/Tg5fLDZLQAG8b-yuy5Qaiw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 12:17:35 INFO - Running post-action listener: _resource_record_post_action 12:17:35 INFO - Running post-action listener: set_extra_try_arguments 12:17:35 INFO - [mozharness: 2017-02-23 20:17:35.813067Z] Finished download-and-extract step (success) 12:17:35 INFO - [mozharness: 2017-02-23 20:17:35.813246Z] Running populate-webroot step. 12:17:35 INFO - Running pre-action listener: _resource_record_pre_action 12:17:35 INFO - Running main action method: populate_webroot 12:17:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:17:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:17:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:17:35 INFO - '--tppagecycles', 12:17:35 INFO - '7'], 12:17:35 INFO - 'tests': ['tsvgm']}}, 12:17:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:17:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:17:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:17:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:17:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:17:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:17:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:35 INFO - 'talos_options': ['--disable-e10s'], 12:17:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:17:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:17:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:35 INFO - 'talos_options': ['--disable-e10s'], 12:17:35 INFO - 'tests': ['damp', 'tps']}, 12:17:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:35 INFO - 'tests': ['damp', 'tps']}, 12:17:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:17:35 INFO - 'tests': ['dromaeo_dom']}, 12:17:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:17:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:17:35 INFO - 'tests': ['basic_compositor_video']}, 12:17:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:17:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:17:35 INFO - 'tests': ['a11yr', 12:17:35 INFO - 'ts_paint', 12:17:35 INFO - 'tpaint', 12:17:35 INFO - 'sessionrestore', 12:17:35 INFO - 'sessionrestore_no_auto_restore', 12:17:35 INFO - 'tabpaint']}, 12:17:35 INFO - 'other-e10s': {'tests': ['a11yr', 12:17:35 INFO - 'ts_paint', 12:17:35 INFO - 'tpaint', 12:17:35 INFO - 'sessionrestore', 12:17:35 INFO - 'sessionrestore_no_auto_restore', 12:17:35 INFO - 'tabpaint']}, 12:17:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:17:35 INFO - 'ts_paint', 12:17:35 INFO - 'tpaint', 12:17:35 INFO - 'sessionrestore', 12:17:35 INFO - 'sessionrestore_no_auto_restore', 12:17:35 INFO - 'tabpaint']}, 12:17:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:17:35 INFO - 'ts_paint', 12:17:35 INFO - 'tpaint', 12:17:35 INFO - 'sessionrestore', 12:17:35 INFO - 'sessionrestore_no_auto_restore', 12:17:35 INFO - 'tabpaint']}, 12:17:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:17:35 INFO - 'tests': ['a11yr', 12:17:35 INFO - 'ts_paint', 12:17:35 INFO - 'tpaint', 12:17:35 INFO - 'sessionrestore', 12:17:35 INFO - 'sessionrestore_no_auto_restore', 12:17:35 INFO - 'tabpaint']}, 12:17:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:17:35 INFO - 'tests': ['a11yr', 12:17:35 INFO - 'ts_paint', 12:17:35 INFO - 'tpaint', 12:17:35 INFO - 'sessionrestore', 12:17:35 INFO - 'sessionrestore_no_auto_restore', 12:17:35 INFO - 'tabpaint']}, 12:17:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:17:35 INFO - 'tests': ['tsvgx', 12:17:35 INFO - 'tsvgr_opacity', 12:17:35 INFO - 'tart', 12:17:35 INFO - 'tscrollx', 12:17:35 INFO - 'cart']}, 12:17:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:17:35 INFO - 'tsvgr_opacity', 12:17:35 INFO - 'tart', 12:17:35 INFO - 'tscrollx', 12:17:35 INFO - 'cart']}, 12:17:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:35 INFO - 'talos_options': ['--disable-e10s'], 12:17:35 INFO - 'tests': ['tp5o']}, 12:17:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:35 INFO - 'tests': ['tp5o']}, 12:17:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:35 INFO - 'talos_options': ['--disable-e10s', 12:17:35 INFO - '--xperf_path', 12:17:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:17:35 INFO - 'tests': ['tp5n']}, 12:17:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:35 INFO - 'talos_options': ['--xperf_path', 12:17:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:17:35 INFO - 'tests': ['tp5n']}}, 12:17:35 INFO - 'talos.zip': {'path': '', 12:17:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:17:35 INFO - Running post-action listener: _resource_record_post_action 12:17:35 INFO - [mozharness: 2017-02-23 20:17:35.831677Z] Finished populate-webroot step (success) 12:17:35 INFO - [mozharness: 2017-02-23 20:17:35.831805Z] Running create-virtualenv step. 12:17:35 INFO - Running pre-action listener: _resource_record_pre_action 12:17:35 INFO - Running main action method: create_virtualenv 12:17:35 INFO - Creating virtualenv /builds/slave/test/build/venv 12:17:35 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 12:17:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:17:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:17:35 INFO - Using real prefix '/tools/python27' 12:17:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:17:36 INFO - Installing distribute.............................................................................................................................................................................................done. 12:17:39 INFO - Installing pip.................done. 12:17:39 INFO - Return code: 0 12:17:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:17:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:17:39 INFO - Reading from file tmpfile_stdout 12:17:39 INFO - Output received: 12:17:39 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) 12:17:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cf4e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cec4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb971461330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd62d30>, '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 0x10cbc8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd5ab20>, '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.Yaj1RhGEW9/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.PYi81FDaQq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 12:17:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:17:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:17:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Yaj1RhGEW9/Render', 12:17:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:17:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:17:39 INFO - 'HOME': '/Users/cltbld', 12:17:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:17:39 INFO - 'LOGNAME': 'cltbld', 12:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:39 INFO - 'MOZ_NO_REMOTE': '1', 12:17:39 INFO - 'NO_EM_RESTART': '1', 12:17:39 INFO - 'PAGER': '/bin/cat', 12:17:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:39 INFO - 'PWD': '/builds/slave/test', 12:17:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:17:39 INFO - 'SHELL': '/bin/bash', 12:17:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PYi81FDaQq/Listeners', 12:17:39 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 12:17:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:17:39 INFO - 'USER': 'cltbld', 12:17:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:17:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:39 INFO - 'XPC_FLAGS': '0x0', 12:17:39 INFO - 'XPC_SERVICE_NAME': '0', 12:17:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:17:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:17:40 INFO - Cleaning up... 12:17:40 INFO - Return code: 0 12:17:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:17:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cf4e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cec4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb971461330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd62d30>, '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 0x10cbc8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd5ab20>, '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.Yaj1RhGEW9/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.PYi81FDaQq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 12:17:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:17:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Yaj1RhGEW9/Render', 12:17:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:17:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:17:40 INFO - 'HOME': '/Users/cltbld', 12:17:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:17:40 INFO - 'LOGNAME': 'cltbld', 12:17:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:40 INFO - 'MOZ_NO_REMOTE': '1', 12:17:40 INFO - 'NO_EM_RESTART': '1', 12:17:40 INFO - 'PAGER': '/bin/cat', 12:17:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:17:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:40 INFO - 'PWD': '/builds/slave/test', 12:17:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:17:40 INFO - 'SHELL': '/bin/bash', 12:17:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PYi81FDaQq/Listeners', 12:17:40 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 12:17:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:17:40 INFO - 'USER': 'cltbld', 12:17:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:17:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:17:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:40 INFO - 'XPC_FLAGS': '0x0', 12:17:40 INFO - 'XPC_SERVICE_NAME': '0', 12:17:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:17:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:40 INFO - Downloading/unpacking psutil>=3.1.1 12:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:17:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:17:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:17:43 INFO - Installing collected packages: psutil 12:17:43 INFO - Running setup.py install for psutil 12:17:44 INFO - building 'psutil._psutil_osx' extension 12:17:44 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 12:17:44 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 12:17:44 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 12:17:44 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 12:17:44 INFO - building 'psutil._psutil_posix' extension 12:17:44 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 12:17:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:17:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:17:44 INFO - ^ 12:17:44 INFO - 1 warning generated. 12:17:44 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 12:17:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:17:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:17:44 INFO - Successfully installed psutil 12:17:44 INFO - Cleaning up... 12:17:44 INFO - Return code: 0 12:17:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cf4e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cec4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb971461330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd62d30>, '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 0x10cbc8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd5ab20>, '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.Yaj1RhGEW9/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.PYi81FDaQq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 12:17:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:17:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:17:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Yaj1RhGEW9/Render', 12:17:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:17:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:17:44 INFO - 'HOME': '/Users/cltbld', 12:17:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:17:44 INFO - 'LOGNAME': 'cltbld', 12:17:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:44 INFO - 'MOZ_NO_REMOTE': '1', 12:17:44 INFO - 'NO_EM_RESTART': '1', 12:17:44 INFO - 'PAGER': '/bin/cat', 12:17:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:17:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:44 INFO - 'PWD': '/builds/slave/test', 12:17:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:17:44 INFO - 'SHELL': '/bin/bash', 12:17:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PYi81FDaQq/Listeners', 12:17:44 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 12:17:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:17:44 INFO - 'USER': 'cltbld', 12:17:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:17:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:17:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:44 INFO - 'XPC_FLAGS': '0x0', 12:17:44 INFO - 'XPC_SERVICE_NAME': '0', 12:17:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17: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 12:17:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:17:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:17:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:17:47 INFO - Installing collected packages: mozsystemmonitor 12:17:47 INFO - Running setup.py install for mozsystemmonitor 12:17:47 INFO - Successfully installed mozsystemmonitor 12:17:47 INFO - Cleaning up... 12:17:47 INFO - Return code: 0 12:17:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:17: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')]} 12:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17: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')]} 12:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:48 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 0x10cf4e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cec4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb971461330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd62d30>, '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 0x10cbc8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd5ab20>, '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.Yaj1RhGEW9/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.PYi81FDaQq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 12:17:48 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 12:17:48 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 12:17:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Yaj1RhGEW9/Render', 12:17:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:17:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:17:48 INFO - 'HOME': '/Users/cltbld', 12:17:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:17:48 INFO - 'LOGNAME': 'cltbld', 12:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:48 INFO - 'MOZ_NO_REMOTE': '1', 12:17:48 INFO - 'NO_EM_RESTART': '1', 12:17:48 INFO - 'PAGER': '/bin/cat', 12:17:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:48 INFO - 'PWD': '/builds/slave/test', 12:17:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:17:48 INFO - 'SHELL': '/bin/bash', 12:17:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PYi81FDaQq/Listeners', 12:17:48 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 12:17:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:17:48 INFO - 'USER': 'cltbld', 12:17:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:17:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:48 INFO - 'XPC_FLAGS': '0x0', 12:17:48 INFO - 'XPC_SERVICE_NAME': '0', 12:17:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:48 INFO - Downloading/unpacking jsonschema==2.5.1 12:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:17:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:51 INFO - Downloading functools32-3.2.3-2.tar.gz 12:17:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:17:51 INFO - warning: no files found matching '*.txt' 12:17:51 INFO - no previously-included directories found matching 'build' 12:17:51 INFO - no previously-included directories found matching 'dist' 12:17:51 INFO - no previously-included directories found matching '.git*' 12:17:51 INFO - Installing collected packages: jsonschema, functools32 12:17:51 INFO - Running setup.py install for functools32 12:17:51 INFO - warning: no files found matching '*.txt' 12:17:51 INFO - no previously-included directories found matching 'build' 12:17:51 INFO - no previously-included directories found matching 'dist' 12:17:51 INFO - no previously-included directories found matching '.git*' 12:17:51 INFO - Successfully installed jsonschema functools32 12:17:51 INFO - Cleaning up... 12:17:51 INFO - Return code: 0 12:17:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:17:51 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')]} 12:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:51 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')]} 12:17:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:51 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 0x10cf4e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cec4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb971461330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd62d30>, '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 0x10cbc8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd5ab20>, '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.Yaj1RhGEW9/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.PYi81FDaQq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 12:17:51 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 12:17:51 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 12:17:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Yaj1RhGEW9/Render', 12:17:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:17:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:17:51 INFO - 'HOME': '/Users/cltbld', 12:17:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:17:51 INFO - 'LOGNAME': 'cltbld', 12:17:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:51 INFO - 'MOZ_NO_REMOTE': '1', 12:17:51 INFO - 'NO_EM_RESTART': '1', 12:17:51 INFO - 'PAGER': '/bin/cat', 12:17:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:17:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:51 INFO - 'PWD': '/builds/slave/test', 12:17:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:17:51 INFO - 'SHELL': '/bin/bash', 12:17:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PYi81FDaQq/Listeners', 12:17:51 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 12:17:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:17:51 INFO - 'USER': 'cltbld', 12:17:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:17:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:17:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:51 INFO - 'XPC_FLAGS': '0x0', 12:17:51 INFO - 'XPC_SERVICE_NAME': '0', 12:17:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:17:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:17:51 INFO - Cleaning up... 12:17:51 INFO - Return code: 0 12:17:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:17:51 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')]} 12:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:51 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')]} 12:17:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:51 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 0x10cf4e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cec4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb971461330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd62d30>, '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 0x10cbc8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd5ab20>, '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.Yaj1RhGEW9/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.PYi81FDaQq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 12:17:51 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 12:17:51 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 12:17:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Yaj1RhGEW9/Render', 12:17:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:17:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:17:51 INFO - 'HOME': '/Users/cltbld', 12:17:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:17:51 INFO - 'LOGNAME': 'cltbld', 12:17:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:51 INFO - 'MOZ_NO_REMOTE': '1', 12:17:51 INFO - 'NO_EM_RESTART': '1', 12:17:51 INFO - 'PAGER': '/bin/cat', 12:17:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:17:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:51 INFO - 'PWD': '/builds/slave/test', 12:17:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:17:51 INFO - 'SHELL': '/bin/bash', 12:17:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PYi81FDaQq/Listeners', 12:17:51 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 12:17:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:17:51 INFO - 'USER': 'cltbld', 12:17:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:17:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:17:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:51 INFO - 'XPC_FLAGS': '0x0', 12:17:51 INFO - 'XPC_SERVICE_NAME': '0', 12:17:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:17:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:52 INFO - Downloading/unpacking blobuploader==1.2.4 12:17:52 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 12:17:52 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 12:17:52 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 12:17:52 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 12:17:52 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 12:17:52 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 12:17:54 INFO - Downloading blobuploader-1.2.4.tar.gz 12:17:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:17:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:17:54 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 12:17:54 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 12:17:54 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 12:17:54 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 12:17:54 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 12:17:54 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 12:17:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:17:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:17:55 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 12:17:55 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 12:17:55 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 12:17:55 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 12:17:55 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 12:17:55 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 12:17:56 INFO - Downloading docopt-0.6.1.tar.gz 12:17:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:17:56 INFO - Installing collected packages: blobuploader, requests, docopt 12:17:56 INFO - Running setup.py install for blobuploader 12:17:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:17:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:17:56 INFO - Running setup.py install for requests 12:17:56 INFO - Running setup.py install for docopt 12:17:57 INFO - Successfully installed blobuploader requests docopt 12:17:57 INFO - Cleaning up... 12:17:57 INFO - Return code: 0 12:17:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:57 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 0x10cf4e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cec4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb971461330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd62d30>, '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 0x10cbc8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd5ab20>, '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.Yaj1RhGEW9/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.PYi81FDaQq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 12:17:57 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 12:17:57 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 12:17:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Yaj1RhGEW9/Render', 12:17:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:17:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:17:57 INFO - 'HOME': '/Users/cltbld', 12:17:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:17:57 INFO - 'LOGNAME': 'cltbld', 12:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:57 INFO - 'MOZ_NO_REMOTE': '1', 12:17:57 INFO - 'NO_EM_RESTART': '1', 12:17:57 INFO - 'PAGER': '/bin/cat', 12:17:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:57 INFO - 'PWD': '/builds/slave/test', 12:17:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:17:57 INFO - 'SHELL': '/bin/bash', 12:17:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PYi81FDaQq/Listeners', 12:17:57 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 12:17:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:17:57 INFO - 'USER': 'cltbld', 12:17:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:17:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:57 INFO - 'XPC_FLAGS': '0x0', 12:17:57 INFO - 'XPC_SERVICE_NAME': '0', 12:17:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:17:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:17:57 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-SkufzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:17:57 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-6rjtQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:17:57 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-EFfrgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:17:57 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-RRR1Uc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:17:57 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-h0M0Dl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:17:57 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-2s61WE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:17:58 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-ncLsHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:17:58 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-XikBoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:17:58 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-v0pGkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:17:58 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-0sSpQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:17:58 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-6OaeyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:17:58 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-UNe6mr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:17:58 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-j3eIVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:17:58 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-phzr7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:58 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-LwU_Mt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:17:58 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-SlvXA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:17:59 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-QlCS_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:17:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:17:59 INFO - Running setup.py install for manifestparser 12:17:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:17:59 INFO - Running setup.py install for mozcrash 12:17:59 INFO - Running setup.py install for mozdebug 12:17:59 INFO - Running setup.py install for mozdevice 12:17:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:17:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:17:59 INFO - Running setup.py install for mozfile 12:17:59 INFO - Running setup.py install for mozhttpd 12:18:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:18:00 INFO - Running setup.py install for mozinfo 12:18:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:18:00 INFO - Running setup.py install for mozInstall 12:18:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:18:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:18:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:18:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:18:00 INFO - Running setup.py install for mozleak 12:18:00 INFO - Running setup.py install for mozlog 12:18:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:18:00 INFO - Running setup.py install for moznetwork 12:18:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:18:00 INFO - Running setup.py install for mozprocess 12:18:00 INFO - Running setup.py install for mozprofile 12:18:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:18:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:18:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:18:01 INFO - Running setup.py install for mozrunner 12:18:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:18:01 INFO - Running setup.py install for mozscreenshot 12:18:01 INFO - Running setup.py install for moztest 12:18:01 INFO - Running setup.py install for mozversion 12:18:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:18:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:18:01 INFO - Cleaning up... 12:18:01 INFO - Return code: 0 12:18:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:01 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 0x10cf4e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cec4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb971461330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd62d30>, '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 0x10cbc8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd5ab20>, '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.Yaj1RhGEW9/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.PYi81FDaQq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 12:18:01 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 12:18:01 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 12:18:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Yaj1RhGEW9/Render', 12:18:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:18:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:18:01 INFO - 'HOME': '/Users/cltbld', 12:18:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:18:01 INFO - 'LOGNAME': 'cltbld', 12:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:01 INFO - 'MOZ_NO_REMOTE': '1', 12:18:01 INFO - 'NO_EM_RESTART': '1', 12:18:01 INFO - 'PAGER': '/bin/cat', 12:18:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:01 INFO - 'PWD': '/builds/slave/test', 12:18:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:18:01 INFO - 'SHELL': '/bin/bash', 12:18:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PYi81FDaQq/Listeners', 12:18:01 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 12:18:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:18:01 INFO - 'USER': 'cltbld', 12:18:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:18:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:01 INFO - 'XPC_FLAGS': '0x0', 12:18:01 INFO - 'XPC_SERVICE_NAME': '0', 12:18:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:18:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:18:02 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-8BlUFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:18:02 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)) 12:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:18:02 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-2XTU3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:18:02 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)) 12:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:18:02 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-M6qHPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:18:02 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)) 12:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:18:02 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-QoUJ0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 12:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:18:02 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-lSgSTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:18:02 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)) 12:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:18:02 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-ljslNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:18:02 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)) 12:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:18:02 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-1FUmUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:18:02 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)) 12:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:18:02 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-u4o6OF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:18:02 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)) 12:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:18:02 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-8XPHQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:18:02 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)) 12:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:18:03 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-qCUkCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:18:03 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)) 12:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:18:03 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-zpVQMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:18:03 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)) 12:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:18:03 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-8LmWts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:18:03 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)) 12:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:18:03 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-IagCn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:18:03 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)) 12:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:18:03 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-_8gctE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:18:03 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)) 12:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:18:03 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-vV0SNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:18:03 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)) 12:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:18:03 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-2DfWBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:18:03 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-JblIuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:18:03 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)) 12:18:03 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)) 12:18:03 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)) 12:18:03 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)) 12:18:03 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:18:03 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:18:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:18:03 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 12:18:03 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 12:18:03 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 12:18:03 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 12:18:03 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 12:18:03 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 12:18:06 INFO - Downloading blessings-1.6.tar.gz 12:18:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:18:06 INFO - Installing collected packages: blessings 12:18:06 INFO - Running setup.py install for blessings 12:18:06 INFO - Successfully installed blessings 12:18:06 INFO - Cleaning up... 12:18:06 INFO - Return code: 0 12:18:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:18:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:18:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:18:07 INFO - Reading from file tmpfile_stdout 12:18:07 INFO - Current package versions: 12:18:07 INFO - blessings == 1.6 12:18:07 INFO - blobuploader == 1.2.4 12:18:07 INFO - docopt == 0.6.1 12:18:07 INFO - functools32 == 3.2.3-2 12:18:07 INFO - jsonschema == 2.5.1 12:18:07 INFO - manifestparser == 1.1 12:18:07 INFO - mozInstall == 1.12 12:18:07 INFO - mozcrash == 1.0 12:18:07 INFO - mozdebug == 0.1 12:18:07 INFO - mozdevice == 0.48 12:18:07 INFO - mozfile == 1.2 12:18:07 INFO - mozhttpd == 0.7 12:18:07 INFO - mozinfo == 0.9 12:18:07 INFO - mozleak == 0.1 12:18:07 INFO - mozlog == 3.4 12:18:07 INFO - moznetwork == 0.27 12:18:07 INFO - mozprocess == 0.23 12:18:07 INFO - mozprofile == 0.28 12:18:07 INFO - mozrunner == 6.13 12:18:07 INFO - mozscreenshot == 0.1 12:18:07 INFO - mozsystemmonitor == 0.3 12:18:07 INFO - moztest == 0.8 12:18:07 INFO - mozversion == 1.4 12:18:07 INFO - psutil == 3.1.1 12:18:07 INFO - requests == 1.2.3 12:18:07 INFO - wsgiref == 0.1.2 12:18:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:18:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:18:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:18:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:07 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 0x10cf4e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cec4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb971461330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd62d30>, '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 0x10cbc8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd5ab20>, '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.Yaj1RhGEW9/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.PYi81FDaQq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 12:18:07 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 12:18:07 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 12:18:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Yaj1RhGEW9/Render', 12:18:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:18:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:18:07 INFO - 'HOME': '/Users/cltbld', 12:18:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:18:07 INFO - 'LOGNAME': 'cltbld', 12:18:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:07 INFO - 'MOZ_NO_REMOTE': '1', 12:18:07 INFO - 'NO_EM_RESTART': '1', 12:18:07 INFO - 'PAGER': '/bin/cat', 12:18:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:18:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:07 INFO - 'PWD': '/builds/slave/test', 12:18:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:18:07 INFO - 'SHELL': '/bin/bash', 12:18:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PYi81FDaQq/Listeners', 12:18:07 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 12:18:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:18:07 INFO - 'USER': 'cltbld', 12:18:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:18:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:18:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:07 INFO - 'XPC_FLAGS': '0x0', 12:18:07 INFO - 'XPC_SERVICE_NAME': '0', 12:18:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:18:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:08 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)) 12:18:08 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)) 12:18:08 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)) 12:18:08 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)) 12:18:08 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)) 12:18:08 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)) 12:18:08 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)) 12:18:08 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)) 12:18:08 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)) 12:18:08 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)) 12:18:08 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)) 12:18:08 INFO - Cleaning up... 12:18:08 INFO - Return code: 0 12:18:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:18:08 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')]} 12:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:08 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')]} 12:18:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:08 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 0x10cf4e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cec4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb971461330>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd62d30>, '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 0x10cbc8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd5ab20>, '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.Yaj1RhGEW9/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.PYi81FDaQq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 12:18:08 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 12:18:08 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 12:18:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Yaj1RhGEW9/Render', 12:18:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:18:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:18:08 INFO - 'HOME': '/Users/cltbld', 12:18:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:18:08 INFO - 'LOGNAME': 'cltbld', 12:18:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:08 INFO - 'MOZ_NO_REMOTE': '1', 12:18:08 INFO - 'NO_EM_RESTART': '1', 12:18:08 INFO - 'PAGER': '/bin/cat', 12:18:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:18:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:08 INFO - 'PWD': '/builds/slave/test', 12:18:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:18:08 INFO - 'SHELL': '/bin/bash', 12:18:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PYi81FDaQq/Listeners', 12:18:08 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 12:18:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:18:08 INFO - 'USER': 'cltbld', 12:18:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:18:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:18:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:08 INFO - 'XPC_FLAGS': '0x0', 12:18:08 INFO - 'XPC_SERVICE_NAME': '0', 12:18:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:18:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:18:08 INFO - Cleaning up... 12:18:08 INFO - Return code: 0 12:18:08 INFO - Running post-action listener: _resource_record_post_action 12:18:08 INFO - Running post-action listener: _start_resource_monitoring 12:18:08 INFO - Starting resource monitoring. 12:18:08 INFO - [mozharness: 2017-02-23 20:18:08.873994Z] Finished create-virtualenv step (success) 12:18:08 INFO - [mozharness: 2017-02-23 20:18:08.875082Z] Running install step. 12:18:08 INFO - Running pre-action listener: _resource_record_pre_action 12:18:08 INFO - Running main action method: install 12:18:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:18:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:18:09 INFO - Reading from file tmpfile_stdout 12:18:09 INFO - Detecting whether we're running mozinstall >=1.0... 12:18:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:18:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:18:09 INFO - Reading from file tmpfile_stdout 12:18:09 INFO - Output received: 12:18:09 INFO - Usage: mozinstall [options] installer 12:18:09 INFO - Options: 12:18:09 INFO - -h, --help show this help message and exit 12:18:09 INFO - -d DEST, --destination=DEST 12:18:09 INFO - Directory to install application into. [default: 12:18:09 INFO - "/builds/slave/test"] 12:18:09 INFO - --app=APP Application being installed. [default: firefox] 12:18:09 INFO - mkdir: /builds/slave/test/build/application 12:18:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:18:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 12:18:30 INFO - Reading from file tmpfile_stdout 12:18:30 INFO - Output received: 12:18:30 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 12:18:30 INFO - Running post-action listener: _resource_record_post_action 12:18:30 INFO - [mozharness: 2017-02-23 20:18:30.314707Z] Finished install step (success) 12:18:30 INFO - [mozharness: 2017-02-23 20:18:30.314843Z] Running run-tests step. 12:18:30 INFO - Running pre-action listener: _resource_record_pre_action 12:18:30 INFO - Running main action method: run_tests 12:18:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:18:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:18:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:18:30 INFO - 2017-02-23 12:18:30.329 screenresolution[1902:15118] starting screenresolution argv=screenresolution get 12:18:30 INFO - 2017-02-23 12:18:30.331 screenresolution[1902:15118] Display 0: 1600x1200x32@60 12:18:30 INFO - 2017-02-23 12:18:30.337 screenresolution[1903:15120] starting screenresolution argv=screenresolution list 12:18:30 INFO - Available Modes on Display 0 12:18:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:18:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:18:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:18:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:18:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:18:30 INFO - Intel Iris: 12:18:30 INFO - Chipset Model: Intel Iris 12:18:30 INFO - Type: GPU 12:18:30 INFO - Bus: Built-In 12:18:30 INFO - VRAM (Dynamic, Max): 1536 MB 12:18:30 INFO - Vendor: Intel (0x8086) 12:18:30 INFO - Device ID: 0x0a2e 12:18:30 INFO - Revision ID: 0x0009 12:18:30 INFO - Displays: 12:18:30 INFO - Display: 12:18:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:18:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:18:30 INFO - Display Serial Number: 1600x1200 60 12:18:30 INFO - Main Display: Yes 12:18:30 INFO - Mirror: Off 12:18:30 INFO - Online: Yes 12:18:30 INFO - Rotation: Supported 12:18:30 INFO - Return code: 0 12:18:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:18:30 INFO - Python 2.7.3 12:18:30 INFO - Return code: 0 12:18:30 INFO - grabbing minidump binary from tooltool 12:18:30 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')]} 12:18:30 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 0x10cd62d30>, '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 0x10cbc8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd5ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:18:30 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 12:18:30 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 12:18:30 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 12:18:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:18:30 INFO - Return code: 0 12:18:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:18:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:18:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:18:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:18:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:18:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Tg5fLDZLQAG8b-yuy5Qaiw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0133', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Tg5fLDZLQAG8b-yuy5Qaiw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0133 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:18:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Yaj1RhGEW9/Render', 12:18:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:18:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:18:30 INFO - 'HOME': '/Users/cltbld', 12:18:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:18:30 INFO - 'LOGNAME': 'cltbld', 12:18:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:18:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:30 INFO - 'MOZ_NO_REMOTE': '1', 12:18:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:18:30 INFO - 'NO_EM_RESTART': '1', 12:18:30 INFO - 'PAGER': '/bin/cat', 12:18:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:30 INFO - 'PWD': '/builds/slave/test', 12:18:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:18:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:18:30 INFO - 'SHELL': '/bin/bash', 12:18:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PYi81FDaQq/Listeners', 12:18:30 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 12:18:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:18:30 INFO - 'USER': 'cltbld', 12:18:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:18:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:30 INFO - 'XPC_FLAGS': '0x0', 12:18:30 INFO - 'XPC_SERVICE_NAME': '0', 12:18:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:18:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Tg5fLDZLQAG8b-yuy5Qaiw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0133', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:18:30 INFO - mozversion application_buildid: 20170223103422 12:18:30 INFO - mozversion application_changeset: 02a085cba71fb767d17d3e3e33f252da066f5d41 12:18:30 INFO - mozversion application_display_name: Firefox 12:18:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:18:30 INFO - mozversion application_name: Firefox 12:18:30 INFO - mozversion application_remotingname: firefox 12:18:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:18:30 INFO - mozversion application_vendor: Mozilla 12:18:30 INFO - mozversion application_version: 52.0 12:18:30 INFO - mozversion platform_buildid: 20170223103422 12:18:30 INFO - mozversion platform_changeset: 02a085cba71fb767d17d3e3e33f252da066f5d41 12:18:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:18:30 INFO - mozversion platform_version: 52.0 12:18:30 INFO - using testdate: 1487881110 12:18:30 INFO - actual date: 1487881110 12:18:30 INFO - starting webserver on 'localhost:52335' 12:18:30 INFO - SUITE-START | Running 2 tests 12:18:30 INFO - TEST-START | dromaeo_css 12:18:30 INFO - operating with platform_type : mac_ 12:18:30 INFO - Initialising browser for dromaeo_css test... 12:18:30 INFO - TEST-INFO | started process 1913 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/tmplplXGi/profile http://localhost:52335/getInfo.html) 12:18:33 INFO - PROCESS | 1913 | 2017-02-23 12:18:33.734 plugin-container[1916:15259] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c43, name = 'com.apple.tsm.portname' 12:18:33 INFO - PROCESS | 1913 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:18:33 INFO - PROCESS | 1913 | 2017-02-23 12:18:33.736 plugin-container[1916:15259] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 12:18:33 INFO - PROCESS | 1913 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:18:33 INFO - PROCESS | 1913 | 2017-02-23 12:18:33.736 plugin-container[1916:15259] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:18:33 INFO - PROCESS | 1913 | __metrics Screen width/height:1600/1200 12:18:33 INFO - PROCESS | 1913 | colorDepth:24 12:18:33 INFO - PROCESS | 1913 | Browser inner width/height: 1024/689 12:18:33 INFO - PROCESS | 1913 | __metrics 12:18:33 ERROR - PROCESS | 1913 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 12:18:34 INFO - TEST-INFO | 1913: exit 0 12:18:34 INFO - Browser initialized. 12:18:34 INFO - Running cycle 1/1 for dromaeo_css test... 12:18:34 INFO - TEST-INFO | started process 1917 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/tmplplXGi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:18:37 INFO - PROCESS | 1917 | 2017-02-23 12:18:37.165 plugin-container[1918:15390] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4643, name = 'com.apple.tsm.portname' 12:18:37 INFO - PROCESS | 1917 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:18:37 INFO - PROCESS | 1917 | 2017-02-23 12:18:37.166 plugin-container[1918:15390] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x891b, name = 'com.apple.CFPasteboardClient' 12:18:37 INFO - PROCESS | 1917 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:18:37 INFO - PROCESS | 1917 | 2017-02-23 12:18:37.166 plugin-container[1918:15390] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:18:46 INFO - PROCESS | 1917 | RSS: Main: 177393664 12:18:46 INFO - PROCESS | 1917 | 12:21:49 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:52335/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52335/tests/dromaeo/cssquery-ext.html) 12:21:50 INFO - PROCESS | 1917 | RSS: Main: 181874688 12:21:50 INFO - PROCESS | 1917 | 12:24:53 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:52335/tests/dromaeo/cssquery-ext.html (next: http://localhost:52335/tests/dromaeo/cssquery-jquery.html) 12:24:54 INFO - PROCESS | 1917 | RSS: Main: 193810432 12:24:54 INFO - PROCESS | 1917 | 12:27:56 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:52335/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52335/tests/dromaeo/cssquery-mootools.html) 12:27:56 INFO - PROCESS | 1917 | RSS: Main: 195633152 12:27:56 INFO - PROCESS | 1917 | 12:30:58 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:52335/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52335/tests/dromaeo/cssquery-prototype.html) 12:30:59 INFO - PROCESS | 1917 | RSS: Main: 199659520 12:30:59 INFO - PROCESS | 1917 | 12:34:02 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:52335/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52335/tests/dromaeo/cssquery-yui.html) 12:34:02 INFO - PROCESS | 1917 | RSS: Main: 201031680 12:34:02 INFO - PROCESS | 1917 | 12:37:05 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:52335/tests/dromaeo/cssquery-yui.html (next: http://localhost:52335/tests/dromaeo/cssquery-dojo.html) 12:37:06 INFO - PROCESS | 1917 | RSS: Main: 201437184 12:37:06 INFO - PROCESS | 1917 | 12:37:06 INFO - PROCESS | 1917 | __start_tp_report 12:37:06 INFO - PROCESS | 1917 | _x_x_mozilla_page_load 12:37:06 INFO - PROCESS | 1917 | _x_x_mozilla_page_load_details 12:37:06 INFO - PROCESS | 1917 | |i|pagename|runs| 12:37:06 INFO - PROCESS | 1917 | |0;dojo.html;3601.333753255646;3613.710903127749;3619.927601447971;3620.3845346291127;3620.9637903620974;5999.7900073497385;6022.819315420539;6022.909656355158;6034.668093254869;6039.969800150999;5988.40115988401;6049.637021778685;6057.575969682124;6064.181335519704;6070.57505974582;5407.702576358309;5460.863478413032;5466.426025267349;5475.09660905952;5588.273524441817;5565.970295495326;5573.8606534836545;5574.136008918624;5583.637063590853;5634.267545219116;5394.649347792381;5404.702741349224;5497.670139791605;5552;5556.86107847303;5469.863253418656;5501.944980550204;5515.283013208297;5525.889482210374;5536.529395001389;5350.5452036576935;5461.481159289861;5465.754041068161;5490.203920431555;5521.861953451155;5115.8209462669;5830.7084645767545;6085.9391406085815;6113.810786210561;6118.010103775202;6190.84522886927;6228.37716228378;6325.367463253684;6334.271558770754;6343.46080583151;5121.84634460963;5839.737211825478;5893.174955506232;6432.678366081677;6472.967635161841;5433.157860531624;6007.909881351783;6064.636121832704;6174.351693072253;6184.041473571604;6521.413072823374;6524.412802847766;6534.7386104556235;6541.6075035498025;6557.442617377481;6260.968695156495;6294.118823364733;6353.14232578596;6356.872862542723;6393.7762178324465;6218.31598524162;6502.447291980235;6514.315996820265;6532;6536.640484773383;6163.19878415812;6196.256449226032;6211.9750241210595;6271.843203919939;6369.936300637027;6365.981442969102;6380.0748891410485;6402.9359706403275;6406.167198264196;6416.615003099736;5051.116054690415;5155.948440515622;5179.507946745053;5184.248283998799;5208.114620514521;4523.864284071417;4534.546545345505;4578.153041687298;4584.724916504953;4657.278121891112;5998.580099393088;6181.8454538636;6194.473469755031;6197.659128747962;6204.751809927642;6473.805785826433;6486.189226346707;6530.118434011348;6537.280899101095;6541.345865413516;6088.878222435526;6102.084687296941;6117.309816958539;6154.19995400604;6154.969225153935;5717.22817419643;5721.742521586539;5725.484706376446;5737.311522617312;5742.08126699726;6488.967555162194;6584.209894812461;6716.496262780311;6736.831579210559;6756.0879281297375;6344.587601805868;6372.55392122547;6380.680965951777;6468.514861385321;6513.088167656627;6604;6698;6700.329967003261;6728.394444500019;6799.558028728117;6144.279601711528;6320.5891617044745;6381.553291269753;6413.615183089029;6419.486441084796;6247.219097612799;6285.214348206474;6320.494360451061;6360.363963603602;6365.3316401779;5293.338332708411;6147.72335244924;6233.127362169209;6241.3134555197985;6242.500599952084;6180.6291622502795;6184.66378606569;6209.410106039919;6234.3453937337745;6240.843978900564;5936.13925980739;6059.545534084873;6086.939130608637;6118.071005858243;6190.907136393048;6251.968740156452;6256.655883926428;6264.749410023548;6271.278802937721;6282.434580887742;6179.81460556184;6199.56603037783;6203.844903877439;6208;6213.37866213375 12:37:06 INFO - PROCESS | 1917 | |1;ext.html;477.8685861388118;508.67699011127934;513.1251216675569;532.1512188060043;538.5664540045262;38123;41374.58625413749;41506.58493415065;43709.68870933877;43897;43315.566844331544;43652.56347436525;43663;43677.12645747091;43799;9516.143547080761;9673.322867399285;9683.98318176592;9698.175655069292;9705.611775529005;9633.133018028377;9711.368761030546;9745.951270243639;9760.170385517204;9763.463009534473;9749.025097490265;9795.363301385423;9813.950930245339;9814.705558833246;9823.263255255884;9753.927068022513;9756.268279879003;9763.804723905554;9782.9510852446;9805.823301203829;9574.856377154349;9657.227421806308;9680.56437460316;9687.757806054835;9719.319647624669;41005;41190.79404602958;41294.38058429096;41508.96227594304;41541;3344.381289461433;3405.6594340565994;3452.4130897747445;3809.276237514863;4040;30484.69515304863;30618.846905765327;30746.077617671504;31317.530237046463;31905.840470797728;3196.3447493263825;3336.4494858348344;3446.8965931022108;3447.6897079262985;3450.0684815100035;419679.90160049003;466015;467525;469763;471553.64223179006;57871;58084.70957645269;58275.834483310944;58514.70742646259;58559.414405856245;65168.67415662986;65348;65441;65595.34404655892;65890;16746.6650666986;17033.31866725317;17051.40320088816;17062.402815901383;17099.572510687085;13032.892204162752;13095.214287142611;13113.016523760756;13116.60650180477;13201.811836934721;15584.230352962846;18793.624127517374;18814.435566933014;18831.71752423715;19082.759620624893;3289.62169350523;6870.656467176621;7386.9288953101495;7590.658420371096;7897.60511974399;898.4070513461085;1034.4569101221919;1066.2855886556026;1071.2608300272786;1105.4693747001484;26500.734992650214;30116.849415752782;30367.93712220106;30622.38755224883;30667.11845488435;1016.1870503597092;1075.4837677914488;1094.4691824465128;1109.5839060352369;1158.6639874436319;15340.693186136215;15598.298076586581;15790;15974.201289935456;16013.039217646978;666889;673963;677405;679403;679793.202067973;59397.40602594005;59604.70197648984;59751.80496390048;59785;59982;1391.2626308056747;1409.689868228988;1415.504573399302;1422.381264150098;1424.2024466298906;28850.855745721135;29400.411991759618;30183.09450716482;30309.39381212319;30838.537421939138;51009;51040.48959510357;51164.48835511597;51223.48776512187;51281;473501;505491;506323;507377;509522;26808.59787103234;27063.458730825667;27075.72924270811;27249.72750272472;27980.58029129524;46002.849928752046;46358.53641463542;47742;48419.27371089366;48627.27059094187;38346;38938.22123557569;39090.41364379593;40344.798276008434;41061;38844.41733373945;39110.804445977585;39492;39766.40350394689;39896.40155397613;38377.4243386355;38746.22507549889;38845.47504412204;39187.62843300585;39277.607223928535;28981.13056608305;31579.526307104952;34201.637259577255;34600.653993459746;34619.82690086534;22006.88996555071;24736.134235301677;25553.744462555136;25578.744212557634;25840.741592583832 12:37:06 INFO - PROCESS | 1917 | |2;jquery.html;383.6642937429749;387.6220684832287;391.75711059143333;393.24889461129237;418.45600719065226;16247.756283655755;19539.023048847554;20153.899230503863;20994.26520071798;21031;18922.62154756904;20268.59462810743;20620.587588248265;20746.44401669877;20936.68594971073;5801.129830525423;6022.698865056752;6091.543134264948;6092.786752463665;6093.299270583873;4782.426108866924;5197.7920883164625;5961;6043.063325184604;6045.818625441222;5944.7324870380935;5951.6726580038085;5954.047352423613;5960.88078238435;5984.970075149618;5682.801101961453;5965.61223520472;5967;5977.46202841742;6017.037274036134;5751.971240143773;5912.793052243151;5922.141289512996;5940.108983652443;5950.702464876782;19428.90285548563;23696.64455033176;24401.511969760682;24631.261062167985;24664.630030549557;1898.2312163573774;2316.3630001749484;2327.394877331889;2611.490759301937;2903.2016195546184;9061.7281481555;9307.696922430865;10369.96300369957;12573.308468034254;14492.927535362256;1550.8836837237252;1844.4050723627963;1923.000039979203;2018.3339497965635;2033.1968872295508;120053;126488;128200;128847;134423;11271.605493807678;11321.490532926038;11758.176927615155;11799.823002654966;11913.10651701126;11728.648140555797;12458.563950261878;14886.627834304229;14902.627434314229;14916;8082.676692932335;8241.381896357798;8241.846141540189;8360.205780450848;8369.539675317916;8566.82866342682;8572.357073219533;8574.442661227125;8704.6518139275;8733.563321833883;3358.8488518016748;3917.5103112110987;3961.7821019844187;3965.088029753173;4013.6588389986596;1948.4057362504573;1968.2323893681476;2005.1678553400175;2009.768876579183;2020.1010550304973;861.6467248428114;885.8439736144264;886.7029545102334;924.8196601662746;927.3137877970388;19902.303419380252;20436.28473003438;20484.487887802625;21199.046042928105;21210.469738256666;955.3933252384786;957.1481381570408;964.3876138651866;970.6219761584147;983.2281658897731;10764.3541387517;11146.665600032013;11165.888341116648;11182.32906025641;11191.328520288645;503231;505767;510245;549968;560278;120106;121966;122086.77913220754;122274;126820;966.2028826218398;975.658519518163;998.6604554451376;1000.494750151169;1002.0630710285906;13590.796138058135;17908.55228619295;18151.27394904189;18329.81670183281;19245.230190792772;51905.96188076142;52126;53801.73099134479;54218.728906355216;54499.72750136224;70988;74126;74326.25673743193;74897;75781.24218757963;6048.911195984765;7641.044869391326;7798.961005194938;8006.599670016592;8268.669253229804;9279.443233406017;10466.110380617733;11338.546458141913;11714.824277635671;13065.346732663518;8921.553922303989;10880.67357979262;10911.290766100177;11037;11287.7742445149;8394;8965.417247878868;10964.506597202986;11114.555417783198;11231.66305010851;8870.51212183336;10766.246362754531;11048.06091482233;11286.49210785533;11431.085513159094;8266.751997440086;8372.33021358302;8407.747767566983;8485.91514084876;8505.829883402173;8968.641254350014;9997.100260976547;10909.781804364027;10984.06635435997;11287.153463490107 12:37:06 INFO - PROCESS | 1917 | |3;mootools.html;1502.0837289253557;1505.7139143562722;1733.4106403822698;1861.4694811978588;1910.5701217226126;8110.95944520278;8279.54462504562;8609.096044915272;8613.870791938118;8640.049594544604;8426.15738426157;8581.227689507943;8585.399022068443;8597.269232115277;8608.48349099053;2397.2568503763846;2409.771071748181;2411.493586346869;2412.541617092747;2419.8064154867657;2407.9157229496973;2433.1727212747664;2433.2821817563863;2441.963370549443;2446.889889954947;2374.4301367671806;2394.425337918896;2407.337982054931;2410.337157281744;2413.2880800163994;2369.206315884181;2372.8457650252676;2388.6894703688495;2397.484540823714;2400.84394514356;2153.536989547239;2388.4148383646116;2392.9162479313313;2409.325388891113;2425.0905910283645;8020.959895200545;8109.4323397362205;8507.659693612248;8510.829783404359;8550.957245213796;5207.843764687065;5335.706536140511;5346.625736198468;5352;5355.973220133913;3071.1707838883376;3505.737069719781;3544.2025544252597;3627.1838836261895;3628.4375921732176;1061.946902654864;1070.4273213830563;1094.698957786607;1099.4997276239371;1115.553778488611;10911.727206819814;10988.395638239894;10988.835167472495;11011.00900918913;11011.889881101166;4245.681573881971;4439.622632076245;4484.663650226246;4541.886452838639;4549.181147393435;8655.52394618302;8658.264047556027;8695.869561956575;8698.782530436789;8699.304055675531;5124.1032819257225;5144.125498665236;5169.948300517022;5172.586193104543;5173.301604283449;4344.9348259776125;4499.370088187657;4701.717896926195;4796.8081276749235;4829.73436460991;3706.5737440194184;3746.981265093657;3798.6771124454176;3846.1346197105986;3860.9034774130873;1173.2901594535354;1196.3719047499958;1196.6529706385224;1198.3648666206925;1209.2683926224508;926.2034650200821;928.4800511713462;934.313279739391;939.4316438554577;953.9570719317647;4990.6506544541535;5784.566157538202;5862.091375836752;6015.2781666200335;6240.157578726814;897.7710683775596;939.1735272959888;961.5480724059821;962.3430962343068;962.6101428921298;3629.455581662719;3867.497225360685;3913.412988051815;3991.780452075164;3998.380251061032;8485.32117430604;10190.184785217165;10271.94864025675;10360.740981475523;10390.168786497063;9613.90386096144;10079.395236285847;10134.645287414905;10181.33821301613;10261.435621040915;7768.339691126317;7984.720534781371;7990.880136797953;8024.879626805603;8031.638576264082;5688;5746.396628353963;5784.739686714192;5837.328707198726;6122.693865306628;9158.084191580789;9421.152096311365;9579.760505987406;9582.520873956413;9611.519424028631;9669;9692.5638346276;9747.317687761788;9757.170640495353;9761.902380976384;6717.731290748511;6891.827704307232;7066.964665176847;7249.927500724925;7383.446241531799;7811.336036436966;8119;8131.552764597767;8147.226013528705;8161.469504482189;7007.40437062835;7054.224035356209;7250.492465527574;7304.890426643711;7332.670029848777;7013.473989450914;7098.219195888345;7134.32223938725;7221.855562888818;7243.203247642649;5985.132155837467;6660.533762636569;6770.2891196425635;6798.252192258748;6892.758753443605;4906.748779061317;4909.68087074339;4910.558049775537;4937.987712518853;4990.850274491771;4882.145624515767;4895.167821470287;4903.681260718042;4906.656534042726;5138.229265610188 12:37:06 INFO - PROCESS | 1917 | |4;prototype.html;301.29797571658025;314.83785850287103;319.21632392476465;324.3334946684565;325.68408643615686;5322.92015619766;5380.569554435646;5510.713054082556;5595.4684304991015;5607.915881261779;4798.808047678098;5442.863928401792;5520.227168196456;5527.640703354289;5607.635503692257;4233.523388817545;4234.513031001444;4234.724742891717;4238.689913996864;4246.2993606055115;3646.3618866698353;4170.749755014694;4192.155451601301;4262.232798096342;4265.445492086024;3523.559555055618;4111.856085037024;4145.917081658365;4166.854160104397;4211.073563815971;4176.916461670765;4180.414741936132;4195.433616461769;4203.936940945889;4223.746575205482;3218.2758879252215;3229.7900636458553;3656.872009479682;3684.6868016218655;3701.68535674468;4034.031832360242;4472.875384192483;5158.478248916541;5351.678899266057;5352.545033672142;3885.348726791131;4009.578994205625;4040.7777572233517;4851.369321988154;4863.440704319013;5558.360788509332;5813.563982701315;5816.004757549823;5843.737031833578;5879.265616643101;3517.542719446481;3547.2018795771005;3661.652143046433;3799.620037996206;3899.7660140391667;5734.942650573483;6105.572609917308;6124.601900876429;6138.263408391022;6184.413040436581;4006.9198616027516;4012.3179059559943;4027.4764280643913;4031;4036;3374.4600863861665;3779.7165212609166;4050.918981620351;4052.2170245092066;4053.8851815750313;4105.794710264535;4594.701344412602;4607.055553611502;4740.620750339965;4782.32618583493;4672.378906347608;5172.560332371715;5819.88360232793;5906.527477801766;5955.225820643289;1093.5297821936485;1252.768237875996;1288.9742205155844;1298.668839445954;1343.6909510812568;863.2662237098416;888.5157589113949;891.4250308550949;896.059137905197;896.2471523919809;4268.466441694788;4563.06457176278;5057.949420505822;5098.694078355311;5234.450382709837;4487.573680500347;4740.217864052462;5038.798448062036;5553.555715542828;5671.51792097668;4446.799894004777;5202;5263.552598029134;5267.473252674702;5343.465653434703;2566.6406703061584;2567.4223299757405;2940.9264768380963;2949.4248621519027;2991.865366058533;5497.780088796403;5701.116326969326;5733.939221244;5756.597038207369;5818.301803783488;4767.638814635674;5006.824761133343;5317.548008419328;5415.566754659618;5804.709764511757;5200.583953283653;5433.402325744165;5801.7389217485315;5818.8254352369495;5845.622027734495;4722.740249286185;4966;5384.407715151408;5612.550995920398;5615.809834164761;4822.373091498223;5116.769745361542;5847.619904706181;5919.579300967823;5964.7912323068485;6309.463695585927;6316.210473690789;6343.55595108338;6357.777477788255;6373.681315934277;3846.306434975835;4052.244473757873;4055.939160912648;4083.632473077437;4104.856330028435;4752.431697539872;5434.347878254634;5995.505617977528;6058.576569372286;6066.362082237682;4479.619232365155;5176.4047134580005;5270.868228294324;5844.707764611838;5884.440978107073;5689.7439615218245;5866;5875.093063112982;5875.853103672443;5927.911081333869;5498.780048798163;5643.795372447389;5706.885862282814;5757.560609847538;5778.27771528559;4926.802927882844;5009.273655320031;5578.2748242728185;5837.416258374129;5900.468957793819;4972.5276098770555;5705.771769129188;5730.06937819355;5799.404369291066;5819.883602328015 12:37:06 INFO - PROCESS | 1917 | |5;yui.html;708.5075872268775;728.5665029307563;756.6821934787389;804.9656191793547;822.8562298405216;14914.477993270239;15436.845631543682;15468.303926323315;15507.689846203084;15623.218839058045;13818.101823381474;13998.720025599481;14012;14038.227897465635;14048.43806247749;858.6908712863365;877.4603618774439;877.6664867350398;879.9208071273584;882.7660669922476;851.7402192331336;857.1771099744221;864.7276108025983;865.3250464637592;867.5488745852153;887.5118684723409;904.2178515584038;908.1735620585268;920.5029284186564;922.5295099499236;855.7561095087871;884.6682494064726;893.0533634347612;901.6844104563415;903.412781691899;663.9900401493982;680.7515256931234;684.1858188755365;688.7486067585345;694.6735034533812;12615.747685046339;12624.495020199181;12631.621051368382;12638.810417843739;12797.168184068007;10402.739931501697;11292.108492024687;11495.42522873853;12024.939875300568;12109.636710898687;10325.225608079425;10390.960903909549;10476.68569942903;10575.78848423035;10611.098056665192;3549.1304630365726;3617.981910090433;3786.053486628343;3878.8836334909715;3882.514685664292;95200;95866;96450.0354996448;98113.5282970756;98857.5057124717;8180.754577362689;8880.51157186348;9261.907380926239;10107.191424686007;10564;17996.740228183902;18532.073396330128;19563.80436195648;19967;19993.600127997648;6323.810285691437;7328.59692716895;7599.126100498403;7692.923070769332;7865.685372585147;4325.783710814447;4406.216089756968;4421.955780442155;4425.9159643775;4558.49856515783;3267.967320326814;3370.8146051966887;3372.2412457196933;3372.274960883422;3379.881704140343;614.3549273263056;625.3964923848417;640.2285246278224;642.2678146912524;653.8234676637281;561.6658088437455;566.963147395418;567.2597260574906;642.7557528139278;649.5128653509868;8554.401191916506;8669.56652167389;8849.469031858109;8875.378723489423;9050.728478145535;587.1984740828823;611.8286879673699;648.2156590525517;653.6633633678659;659.8911179655303;4199.769012704331;4294.892627684333;4319.136172765459;4373.431453910971;4395.428594282723;105300.36749081181;112845.19285154305;116495.41752291184;117748;118035.40982295033;64200;67627;84393.57803211067;88254;103854.48072759739;77671.50478228381;79328.603356984;85194.5740271307;89334;95958.56062158933;9217.585208665492;9410.52947352616;9826.263030272616;9849.753756156153;9873.062059104373;57079.14381284201;59074.40925590689;59701;60473.69763151156;60876.69561652163;77600.2239977593;80722.5963870177;83090;84234.57882710548;85957;13061;13150.342482876009;13456.663583410493;13682.247476388895;14030.368633411317;14162.929185354007;14295.714085718435;14317.64205894861;14549.490767823076;15275.854310926947;11794.46924888365;13133.277669728257;13523;13969.301534923416;14149.504767333094;13137.146085504412;13328.933355333162;13462;13734;14064.945129115153;10701.678949631523;13179.67050823737;13216.405261763435;13282.335883205995;13856.722865542833;10584.682459526226;10832.5125369357;11195.496202670736;11221.887781122085;11619.01238394746;8968.775780605538;9349.39228950116;11357.886421135683;11572.479238434458;11583.942080289544 12:37:06 INFO - PROCESS | 1917 | __end_tp_report 12:37:06 INFO - PROCESS | 1917 | __start_cc_report 12:37:06 INFO - PROCESS | 1917 | _x_x_mozilla_cycle_collect,372 12:37:06 INFO - PROCESS | 1917 | __end_cc_report 12:37:06 INFO - PROCESS | 1917 | __startTimestamp1487882226226__endTimestamp 12:37:06 INFO - PROCESS | 1917 | 12:37:06 INFO - PROCESS | 1917 | ------- Summary: start ------- 12:37:06 INFO - PROCESS | 1917 | Number of tests: 6 12:37:06 INFO - PROCESS | 1917 | 12:37:06 INFO - PROCESS | 1917 | [#0] dojo.html Cycles:165 Average:5960.53 Median:6180.63 stddev:632.08 (10.2%) stddev-sans-first:606.32 12:37:06 INFO - PROCESS | 1917 | Values: 3601.3 3613.7 3619.9 3620.4 3621.0 5999.8 6022.8 6022.9 6034.7 6040.0 5988.4 6049.6 6057.6 6064.2 6070.6 5407.7 5460.9 5466.4 5475.1 5588.3 5566.0 5573.9 5574.1 5583.6 5634.3 5394.6 5404.7 5497.7 5552.0 5556.9 5469.9 5501.9 5515.3 5525.9 5536.5 5350.5 5461.5 5465.8 5490.2 5521.9 5115.8 5830.7 6085.9 6113.8 6118.0 6190.8 6228.4 6325.4 6334.3 6343.5 5121.8 5839.7 5893.2 6432.7 6473.0 5433.2 6007.9 6064.6 6174.4 6184.0 6521.4 6524.4 6534.7 6541.6 6557.4 6261.0 6294.1 6353.1 6356.9 6393.8 6218.3 6502.4 6514.3 6532.0 6536.6 6163.2 6196.3 6212.0 6271.8 6369.9 6366.0 6380.1 6402.9 6406.2 6416.6 5051.1 5155.9 5179.5 5184.2 5208.1 4523.9 4534.5 4578.2 4584.7 4657.3 5998.6 6181.8 6194.5 6197.7 6204.8 6473.8 6486.2 6530.1 6537.3 6541.3 6088.9 6102.1 6117.3 6154.2 6155.0 5717.2 5721.7 5725.5 5737.3 5742.1 6489.0 6584.2 6716.5 6736.8 6756.1 6344.6 6372.6 6380.7 6468.5 6513.1 6604.0 6698.0 6700.3 6728.4 6799.6 6144.3 6320.6 6381.6 6413.6 6419.5 6247.2 6285.2 6320.5 6360.4 6365.3 5293.3 6147.7 6233.1 6241.3 6242.5 6180.6 6184.7 6209.4 6234.3 6240.8 5936.1 6059.5 6086.9 6118.1 6190.9 6252.0 6256.7 6264.7 6271.3 6282.4 6179.8 6199.6 6203.8 6208.0 6213.4 12:37:06 INFO - PROCESS | 1917 | 12:37:06 INFO - PROCESS | 1917 | [#1] ext.html Cycles:180 Average:68530.04 Median:41033.00 stddev:147769.23 (360.1%) stddev-sans-first:148095.43 12:37:06 INFO - PROCESS | 1917 | Values: 477.9 508.7 513.1 532.2 538.6 38123.0 41374.6 41506.6 43709.7 43897.0 43315.6 43652.6 43663.0 43677.1 43799.0 9516.1 9673.3 9684.0 9698.2 9705.6 9633.1 9711.4 9746.0 9760.2 9763.5 9749.0 9795.4 9814.0 9814.7 9823.3 9753.9 9756.3 9763.8 9783.0 9805.8 9574.9 9657.2 9680.6 9687.8 9719.3 41005.0 41190.8 41294.4 41509.0 41541.0 3344.4 3405.7 3452.4 3809.3 4040.0 30484.7 30618.8 30746.1 31317.5 31905.8 3196.3 3336.4 3446.9 3447.7 3450.1 419679.9 466015.0 467525.0 469763.0 471553.6 57871.0 58084.7 58275.8 58514.7 58559.4 65168.7 65348.0 65441.0 65595.3 65890.0 16746.7 17033.3 17051.4 17062.4 17099.6 13032.9 13095.2 13113.0 13116.6 13201.8 15584.2 18793.6 18814.4 18831.7 19082.8 3289.6 6870.7 7386.9 7590.7 7897.6 898.4 1034.5 1066.3 1071.3 1105.5 26500.7 30116.8 30367.9 30622.4 30667.1 1016.2 1075.5 1094.5 1109.6 1158.7 15340.7 15598.3 15790.0 15974.2 16013.0 666889.0 673963.0 677405.0 679403.0 679793.2 59397.4 59604.7 59751.8 59785.0 59982.0 1391.3 1409.7 1415.5 1422.4 1424.2 28850.9 29400.4 30183.1 30309.4 30838.5 51009.0 51040.5 51164.5 51223.5 51281.0 473501.0 505491.0 506323.0 507377.0 509522.0 26808.6 27063.5 27075.7 27249.7 27980.6 46002.8 46358.5 47742.0 48419.3 48627.3 38346.0 38938.2 39090.4 40344.8 41061.0 38844.4 39110.8 39492.0 39766.4 39896.4 38377.4 38746.2 38845.5 39187.6 39277.6 28981.1 31579.5 34201.6 34600.7 34619.8 22006.9 24736.1 25553.7 25578.7 25840.7 12:37:06 INFO - PROCESS | 1917 | 12:37:06 INFO - PROCESS | 1917 | [#2] jquery.html Cycles:180 Average:32808.87 Median:389.69 stddev:88719.34 (22766.7%) stddev-sans-first:88934.81 12:37:06 INFO - PROCESS | 1917 | Values: 383.7 387.6 391.8 393.2 418.5 16247.8 19539.0 20153.9 20994.3 21031.0 18922.6 20268.6 20620.6 20746.4 20936.7 5801.1 6022.7 6091.5 6092.8 6093.3 4782.4 5197.8 5961.0 6043.1 6045.8 5944.7 5951.7 5954.0 5960.9 5985.0 5682.8 5965.6 5967.0 5977.5 6017.0 5752.0 5912.8 5922.1 5940.1 5950.7 19428.9 23696.6 24401.5 24631.3 24664.6 1898.2 2316.4 2327.4 2611.5 2903.2 9061.7 9307.7 10370.0 12573.3 14492.9 1550.9 1844.4 1923.0 2018.3 2033.2 120053.0 126488.0 128200.0 128847.0 134423.0 11271.6 11321.5 11758.2 11799.8 11913.1 11728.6 12458.6 14886.6 14902.6 14916.0 8082.7 8241.4 8241.8 8360.2 8369.5 8566.8 8572.4 8574.4 8704.7 8733.6 3358.8 3917.5 3961.8 3965.1 4013.7 1948.4 1968.2 2005.2 2009.8 2020.1 861.6 885.8 886.7 924.8 927.3 19902.3 20436.3 20484.5 21199.0 21210.5 955.4 957.1 964.4 970.6 983.2 10764.4 11146.7 11165.9 11182.3 11191.3 503231.0 505767.0 510245.0 549968.0 560278.0 120106.0 121966.0 122086.8 122274.0 126820.0 966.2 975.7 998.7 1000.5 1002.1 13590.8 17908.6 18151.3 18329.8 19245.2 51906.0 52126.0 53801.7 54218.7 54499.7 70988.0 74126.0 74326.3 74897.0 75781.2 6048.9 7641.0 7799.0 8006.6 8268.7 9279.4 10466.1 11338.5 11714.8 13065.3 8921.6 10880.7 10911.3 11037.0 11287.8 8394.0 8965.4 10964.5 11114.6 11231.7 8870.5 10766.2 11048.1 11286.5 11431.1 8266.8 8372.3 8407.7 8485.9 8505.8 8968.6 9997.1 10909.8 10984.1 11287.2 12:37:06 INFO - PROCESS | 1917 | 12:37:06 INFO - PROCESS | 1917 | [#3] mootools.html Cycles:180 Average:5508.46 Median:5157.04 stddev:2981.47 (57.8%) stddev-sans-first:2974.63 12:37:06 INFO - PROCESS | 1917 | Values: 1502.1 1505.7 1733.4 1861.5 1910.6 8111.0 8279.5 8609.1 8613.9 8640.0 8426.2 8581.2 8585.4 8597.3 8608.5 2397.3 2409.8 2411.5 2412.5 2419.8 2407.9 2433.2 2433.3 2442.0 2446.9 2374.4 2394.4 2407.3 2410.3 2413.3 2369.2 2372.8 2388.7 2397.5 2400.8 2153.5 2388.4 2392.9 2409.3 2425.1 8021.0 8109.4 8507.7 8510.8 8551.0 5207.8 5335.7 5346.6 5352.0 5356.0 3071.2 3505.7 3544.2 3627.2 3628.4 1061.9 1070.4 1094.7 1099.5 1115.6 10911.7 10988.4 10988.8 11011.0 11011.9 4245.7 4439.6 4484.7 4541.9 4549.2 8655.5 8658.3 8695.9 8698.8 8699.3 5124.1 5144.1 5169.9 5172.6 5173.3 4344.9 4499.4 4701.7 4796.8 4829.7 3706.6 3747.0 3798.7 3846.1 3860.9 1173.3 1196.4 1196.7 1198.4 1209.3 926.2 928.5 934.3 939.4 954.0 4990.7 5784.6 5862.1 6015.3 6240.2 897.8 939.2 961.5 962.3 962.6 3629.5 3867.5 3913.4 3991.8 3998.4 8485.3 10190.2 10271.9 10360.7 10390.2 9613.9 10079.4 10134.6 10181.3 10261.4 7768.3 7984.7 7990.9 8024.9 8031.6 5688.0 5746.4 5784.7 5837.3 6122.7 9158.1 9421.2 9579.8 9582.5 9611.5 9669.0 9692.6 9747.3 9757.2 9761.9 6717.7 6891.8 7067.0 7249.9 7383.4 7811.3 8119.0 8131.6 8147.2 8161.5 7007.4 7054.2 7250.5 7304.9 7332.7 7013.5 7098.2 7134.3 7221.9 7243.2 5985.1 6660.5 6770.3 6798.3 6892.8 4906.7 4909.7 4910.6 4938.0 4990.9 4882.1 4895.2 4903.7 4906.7 5138.2 12:37:06 INFO - PROCESS | 1917 | 12:37:06 INFO - PROCESS | 1917 | [#4] prototype.html Cycles:180 Average:4590.27 Median:5078.32 stddev:1430.86 (28.2%) stddev-sans-first:1398.19 12:37:06 INFO - PROCESS | 1917 | Values: 301.3 314.8 319.2 324.3 325.7 5322.9 5380.6 5510.7 5595.5 5607.9 4798.8 5442.9 5520.2 5527.6 5607.6 4233.5 4234.5 4234.7 4238.7 4246.3 3646.4 4170.7 4192.2 4262.2 4265.4 3523.6 4111.9 4145.9 4166.9 4211.1 4176.9 4180.4 4195.4 4203.9 4223.7 3218.3 3229.8 3656.9 3684.7 3701.7 4034.0 4472.9 5158.5 5351.7 5352.5 3885.3 4009.6 4040.8 4851.4 4863.4 5558.4 5813.6 5816.0 5843.7 5879.3 3517.5 3547.2 3661.7 3799.6 3899.8 5734.9 6105.6 6124.6 6138.3 6184.4 4006.9 4012.3 4027.5 4031.0 4036.0 3374.5 3779.7 4050.9 4052.2 4053.9 4105.8 4594.7 4607.1 4740.6 4782.3 4672.4 5172.6 5819.9 5906.5 5955.2 1093.5 1252.8 1289.0 1298.7 1343.7 863.3 888.5 891.4 896.1 896.2 4268.5 4563.1 5057.9 5098.7 5234.5 4487.6 4740.2 5038.8 5553.6 5671.5 4446.8 5202.0 5263.6 5267.5 5343.5 2566.6 2567.4 2940.9 2949.4 2991.9 5497.8 5701.1 5733.9 5756.6 5818.3 4767.6 5006.8 5317.5 5415.6 5804.7 5200.6 5433.4 5801.7 5818.8 5845.6 4722.7 4966.0 5384.4 5612.6 5615.8 4822.4 5116.8 5847.6 5919.6 5964.8 6309.5 6316.2 6343.6 6357.8 6373.7 3846.3 4052.2 4055.9 4083.6 4104.9 4752.4 5434.3 5995.5 6058.6 6066.4 4479.6 5176.4 5270.9 5844.7 5884.4 5689.7 5866.0 5875.1 5875.9 5927.9 5498.8 5643.8 5706.9 5757.6 5778.3 4926.8 5009.3 5578.3 5837.4 5900.5 4972.5 5705.8 5730.1 5799.4 5819.9 12:37:06 INFO - PROCESS | 1917 | 12:37:06 INFO - PROCESS | 1917 | [#5] yui.html Cycles:180 Average:20842.63 Median:2560.08 stddev:30856.82 (1205.3%) stddev-sans-first:30906.34 12:37:06 INFO - PROCESS | 1917 | Values: 708.5 728.6 756.7 805.0 822.9 14914.5 15436.8 15468.3 15507.7 15623.2 13818.1 13998.7 14012.0 14038.2 14048.4 858.7 877.5 877.7 879.9 882.8 851.7 857.2 864.7 865.3 867.5 887.5 904.2 908.2 920.5 922.5 855.8 884.7 893.1 901.7 903.4 664.0 680.8 684.2 688.7 694.7 12615.7 12624.5 12631.6 12638.8 12797.2 10402.7 11292.1 11495.4 12024.9 12109.6 10325.2 10391.0 10476.7 10575.8 10611.1 3549.1 3618.0 3786.1 3878.9 3882.5 95200.0 95866.0 96450.0 98113.5 98857.5 8180.8 8880.5 9261.9 10107.2 10564.0 17996.7 18532.1 19563.8 19967.0 19993.6 6323.8 7328.6 7599.1 7692.9 7865.7 4325.8 4406.2 4422.0 4425.9 4558.5 3268.0 3370.8 3372.2 3372.3 3379.9 614.4 625.4 640.2 642.3 653.8 561.7 567.0 567.3 642.8 649.5 8554.4 8669.6 8849.5 8875.4 9050.7 587.2 611.8 648.2 653.7 659.9 4199.8 4294.9 4319.1 4373.4 4395.4 105300.4 112845.2 116495.4 117748.0 118035.4 64200.0 67627.0 84393.6 88254.0 103854.5 77671.5 79328.6 85194.6 89334.0 95958.6 9217.6 9410.5 9826.3 9849.8 9873.1 57079.1 59074.4 59701.0 60473.7 60876.7 77600.2 80722.6 83090.0 84234.6 85957.0 13061.0 13150.3 13456.7 13682.2 14030.4 14162.9 14295.7 14317.6 14549.5 15275.9 11794.5 13133.3 13523.0 13969.3 14149.5 13137.1 13328.9 13462.0 13734.0 14064.9 10701.7 13179.7 13216.4 13282.3 13856.7 10584.7 10832.5 11195.5 11221.9 11619.0 8968.8 9349.4 11357.9 11572.5 11583.9 12:37:06 INFO - PROCESS | 1917 | -------- Summary: end -------- 12:37:06 INFO - PROCESS | 1917 | 12:37:06 INFO - TEST-INFO | 1917: exit 0 12:37:06 INFO - TEST-OK | dromaeo_css | took 1115953ms 12:37:06 INFO - TEST-START | kraken 12:37:06 INFO - operating with platform_type : mac_ 12:37:06 INFO - Initialising browser for kraken test... 12:37:06 INFO - TEST-INFO | started process 1925 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/tmp5Bknde/profile http://localhost:52335/getInfo.html) 12:37:09 INFO - PROCESS | 1925 | 2017-02-23 12:37:09.677 plugin-container[1927:17568] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8843, name = 'com.apple.tsm.portname' 12:37:09 INFO - PROCESS | 1925 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:37:09 INFO - PROCESS | 1925 | 2017-02-23 12:37:09.678 plugin-container[1927:17568] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 12:37:09 INFO - PROCESS | 1925 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:37:09 INFO - PROCESS | 1925 | 2017-02-23 12:37:09.678 plugin-container[1927:17568] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:37:09 INFO - PROCESS | 1925 | __metrics Screen width/height:1600/1200 12:37:09 INFO - PROCESS | 1925 | colorDepth:24 12:37:09 INFO - PROCESS | 1925 | Browser inner width/height: 1024/689 12:37:09 INFO - PROCESS | 1925 | __metrics 12:37:09 ERROR - PROCESS | 1925 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 12:37:10 INFO - TEST-INFO | 1925: exit 0 12:37:10 INFO - Browser initialized. 12:37:10 INFO - Running cycle 1/1 for kraken test... 12:37:10 INFO - TEST-INFO | started process 1928 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/tmp5Bknde/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:37:13 INFO - PROCESS | 1928 | 2017-02-23 12:37:13.058 plugin-container[1929:17694] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x834b, name = 'com.apple.tsm.portname' 12:37:13 INFO - PROCESS | 1928 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:37:13 INFO - PROCESS | 1928 | 2017-02-23 12:37:13.059 plugin-container[1929:17694] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8517, name = 'com.apple.CFPasteboardClient' 12:37:13 INFO - PROCESS | 1928 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:37:13 INFO - PROCESS | 1928 | 2017-02-23 12:37:13.059 plugin-container[1929:17694] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:37:22 INFO - PROCESS | 1928 | RSS: Main: 177709056 12:37:22 INFO - PROCESS | 1928 | 12:37:25 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:52335/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52335/tests/kraken/driver.html?testName=audio-beat-detection) 12:37:27 INFO - PROCESS | 1928 | RSS: Main: 190595072 12:37:27 INFO - PROCESS | 1928 | 12:37:29 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:52335/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52335/tests/kraken/driver.html?testName=audio-dft) 12:37:30 INFO - PROCESS | 1928 | RSS: Main: 198475776 12:37:30 INFO - PROCESS | 1928 | 12:37:33 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:52335/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52335/tests/kraken/driver.html?testName=audio-fft) 12:37:34 INFO - PROCESS | 1928 | RSS: Main: 202235904 12:37:34 INFO - PROCESS | 1928 | 12:37:36 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:52335/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52335/tests/kraken/driver.html?testName=audio-oscillator) 12:37:36 INFO - PROCESS | 1928 | RSS: Main: 202412032 12:37:36 INFO - PROCESS | 1928 | 12:37:38 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:52335/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52335/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:37:39 INFO - PROCESS | 1928 | RSS: Main: 203747328 12:37:39 INFO - PROCESS | 1928 | 12:37:42 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:52335/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52335/tests/kraken/driver.html?testName=imaging-darkroom) 12:37:43 INFO - PROCESS | 1928 | RSS: Main: 207544320 12:37:43 INFO - PROCESS | 1928 | 12:37:45 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:52335/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52335/tests/kraken/driver.html?testName=imaging-desaturate) 12:37:46 INFO - PROCESS | 1928 | RSS: Main: 207183872 12:37:46 INFO - PROCESS | 1928 | 12:37:49 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:52335/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52335/tests/kraken/driver.html?testName=json-parse-financial) 12:37:50 INFO - PROCESS | 1928 | RSS: Main: 207110144 12:37:50 INFO - PROCESS | 1928 | 12:37:51 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:52335/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52335/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:37:52 INFO - PROCESS | 1928 | RSS: Main: 206626816 12:37:52 INFO - PROCESS | 1928 | 12:37:54 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:52335/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52335/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:37:54 INFO - PROCESS | 1928 | RSS: Main: 206680064 12:37:54 INFO - PROCESS | 1928 | 12:37:56 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:52335/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52335/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:37:57 INFO - PROCESS | 1928 | RSS: Main: 206639104 12:37:57 INFO - PROCESS | 1928 | 12:38:00 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:52335/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52335/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:38:01 INFO - PROCESS | 1928 | RSS: Main: 206884864 12:38:01 INFO - PROCESS | 1928 | 12:38:04 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:52335/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52335/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:38:04 INFO - PROCESS | 1928 | RSS: Main: 206934016 12:38:04 INFO - PROCESS | 1928 | 12:38:06 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:52335/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52335/tests/kraken/driver.html?testName=ai-astar) 12:38:06 INFO - PROCESS | 1928 | RSS: Main: 208785408 12:38:06 INFO - PROCESS | 1928 | 12:38:06 INFO - PROCESS | 1928 | __start_tp_report 12:38:06 INFO - PROCESS | 1928 | _x_x_mozilla_page_load 12:38:06 INFO - PROCESS | 1928 | _x_x_mozilla_page_load_details 12:38:06 INFO - PROCESS | 1928 | |i|pagename|runs| 12:38:06 INFO - PROCESS | 1928 | |0;ai-astar;127;173;162;117;119;134;174;118;117;118 12:38:06 INFO - PROCESS | 1928 | |1;audio-beat-detection;185;113;113;143;108;134;112;99;167;147 12:38:06 INFO - PROCESS | 1928 | |2;audio-dft;200;197;193;271;273;203;195;200;197;197 12:38:06 INFO - PROCESS | 1928 | |3;audio-fft;81;59;58;87;59;61;58;59;78;60 12:38:06 INFO - PROCESS | 1928 | |4;audio-oscillator;93;70;89;72;72;71;108;100;103;121 12:38:06 INFO - PROCESS | 1928 | |5;imaging-gaussian-blur;77;132;136;89;104;85;89;86;94;85 12:38:06 INFO - PROCESS | 1928 | |6;imaging-darkroom;96;96;96;95;95;95;95;96;96;142 12:38:06 INFO - PROCESS | 1928 | |7;imaging-desaturate;92;100;74;132;135;90;108;123;89;90 12:38:06 INFO - PROCESS | 1928 | |8;json-parse-financial;56;55;55;59;60;62;61;60;63;60 12:38:06 INFO - PROCESS | 1928 | |9;json-stringify-tinderbox;66;73;68;74;71;67;67;70;69;70 12:38:06 INFO - PROCESS | 1928 | |10;stanford-crypto-aes;77;84;82;84;83;83;84;93;103;86 12:38:06 INFO - PROCESS | 1928 | |11;stanford-crypto-ccm;138;137;138;138;157;148;158;160;208;165 12:38:06 INFO - PROCESS | 1928 | |12;stanford-crypto-pbkdf2;145;200;226;151;223;222;163;160;162;164 12:38:06 INFO - PROCESS | 1928 | |13;stanford-crypto-sha256-iterative;66;66;66;66;67;65;65;66;67;68 12:38:06 INFO - PROCESS | 1928 | __end_tp_report 12:38:06 INFO - PROCESS | 1928 | __start_cc_report 12:38:06 INFO - PROCESS | 1928 | _x_x_mozilla_cycle_collect,947 12:38:06 INFO - PROCESS | 1928 | __end_cc_report 12:38:06 INFO - PROCESS | 1928 | __startTimestamp1487882286713__endTimestamp 12:38:06 INFO - PROCESS | 1928 | 12:38:06 INFO - PROCESS | 1928 | ------- Summary: start ------- 12:38:06 INFO - PROCESS | 1928 | Number of tests: 14 12:38:06 INFO - PROCESS | 1928 | 12:38:06 INFO - PROCESS | 1928 | [#0] ai-astar Cycles:10 Average:135.90 Median:130.50 stddev:24.11 (18.5%) stddev-sans-first:25.36 12:38:06 INFO - PROCESS | 1928 | Values: 127.0 173.0 162.0 117.0 119.0 134.0 174.0 118.0 117.0 118.0 12:38:06 INFO - PROCESS | 1928 | 12:38:06 INFO - PROCESS | 1928 | [#1] audio-beat-detection Cycles:10 Average:132.10 Median:145.00 stddev:28.23 (19.5%) stddev-sans-first:22.53 12:38:06 INFO - PROCESS | 1928 | Values: 185.0 113.0 113.0 143.0 108.0 134.0 112.0 99.0 167.0 147.0 12:38:06 INFO - PROCESS | 1928 | 12:38:06 INFO - PROCESS | 1928 | [#2] audio-dft Cycles:10 Average:212.60 Median:200.00 stddev:31.43 (15.7%) stddev-sans-first:33.01 12:38:06 INFO - PROCESS | 1928 | Values: 200.0 197.0 193.0 271.0 273.0 203.0 195.0 200.0 197.0 197.0 12:38:06 INFO - PROCESS | 1928 | 12:38:06 INFO - PROCESS | 1928 | [#3] audio-fft Cycles:10 Average:66.00 Median:60.50 stddev:11.28 (18.7%) stddev-sans-first:10.58 12:38:06 INFO - PROCESS | 1928 | Values: 81.0 59.0 58.0 87.0 59.0 61.0 58.0 59.0 78.0 60.0 12:38:06 INFO - PROCESS | 1928 | 12:38:06 INFO - PROCESS | 1928 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:71.50 stddev:18.17 (25.4%) stddev-sans-first:19.24 12:38:06 INFO - PROCESS | 1928 | Values: 93.0 70.0 89.0 72.0 72.0 71.0 108.0 100.0 103.0 121.0 12:38:06 INFO - PROCESS | 1928 | 12:38:06 INFO - PROCESS | 1928 | [#5] imaging-gaussian-blur Cycles:10 Average:97.70 Median:85.50 stddev:20.37 (23.8%) stddev-sans-first:20.19 12:38:06 INFO - PROCESS | 1928 | Values: 77.0 132.0 136.0 89.0 104.0 85.0 89.0 86.0 94.0 85.0 12:38:06 INFO - PROCESS | 1928 | 12:38:06 INFO - PROCESS | 1928 | [#6] imaging-darkroom Cycles:10 Average:100.20 Median:96.00 stddev:14.70 (15.3%) stddev-sans-first:15.51 12:38:06 INFO - PROCESS | 1928 | Values: 96.0 96.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 142.0 12:38:06 INFO - PROCESS | 1928 | 12:38:06 INFO - PROCESS | 1928 | [#7] imaging-desaturate Cycles:10 Average:103.30 Median:81.50 stddev:20.53 (25.2%) stddev-sans-first:21.37 12:38:06 INFO - PROCESS | 1928 | Values: 92.0 100.0 74.0 132.0 135.0 90.0 108.0 123.0 89.0 90.0 12:38:06 INFO - PROCESS | 1928 | 12:38:06 INFO - PROCESS | 1928 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:60.00 stddev:2.85 (4.7%) stddev-sans-first:2.79 12:38:06 INFO - PROCESS | 1928 | Values: 56.0 55.0 55.0 59.0 60.0 62.0 61.0 60.0 63.0 60.0 12:38:06 INFO - PROCESS | 1928 | 12:38:06 INFO - PROCESS | 1928 | [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:70.00 stddev:2.64 (3.8%) stddev-sans-first:2.47 12:38:06 INFO - PROCESS | 1928 | Values: 66.0 73.0 68.0 74.0 71.0 67.0 67.0 70.0 69.0 70.0 12:38:06 INFO - PROCESS | 1928 | 12:38:06 INFO - PROCESS | 1928 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:84.00 stddev:7.19 (8.6%) stddev-sans-first:6.86 12:38:06 INFO - PROCESS | 1928 | Values: 77.0 84.0 82.0 84.0 83.0 83.0 84.0 93.0 103.0 86.0 12:38:06 INFO - PROCESS | 1928 | 12:38:06 INFO - PROCESS | 1928 | [#11] stanford-crypto-ccm Cycles:10 Average:154.70 Median:157.50 stddev:21.57 (13.7%) stddev-sans-first:22.01 12:38:06 INFO - PROCESS | 1928 | Values: 138.0 137.0 138.0 138.0 157.0 148.0 158.0 160.0 208.0 165.0 12:38:06 INFO - PROCESS | 1928 | 12:38:06 INFO - PROCESS | 1928 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.60 Median:182.00 stddev:32.38 (17.8%) stddev-sans-first:31.52 12:38:06 INFO - PROCESS | 1928 | Values: 145.0 200.0 226.0 151.0 223.0 222.0 163.0 160.0 162.0 164.0 12:38:06 INFO - PROCESS | 1928 | 12:38:06 INFO - PROCESS | 1928 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 12:38:06 INFO - PROCESS | 1928 | Values: 66.0 66.0 66.0 66.0 67.0 65.0 65.0 66.0 67.0 68.0 12:38:06 INFO - PROCESS | 1928 | -------- Summary: end -------- 12:38:06 INFO - PROCESS | 1928 | 12:38:07 INFO - TEST-INFO | 1928: exit 0 12:38:07 INFO - TEST-OK | kraken | took 60943ms 12:38:07 INFO - SUITE-END | took 1176s 12:38:07 INFO - Completed test suite (00:19:36) 12:38:07 INFO - javascript benchmark 12:38:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7309.079405704969, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3601.333753255646, 3613.710903127749, 3619.927601447971, 3620.3845346291127, 3620.9637903620974, 5999.7900073497385, 6022.819315420539, 6022.909656355158, 6034.668093254869, 6039.969800150999, 5988.40115988401, 6049.637021778685, 6057.575969682124, 6064.181335519704, 6070.57505974582, 5407.702576358309, 5460.863478413032, 5466.426025267349, 5475.09660905952, 5588.273524441817, 5565.970295495326, 5573.8606534836545, 5574.136008918624, 5583.637063590853, 5634.267545219116, 5394.649347792381, 5404.702741349224, 5497.670139791605, 5552.0, 5556.86107847303, 5469.863253418656, 5501.944980550204, 5515.283013208297, 5525.889482210374, 5536.529395001389, 5350.5452036576935, 5461.481159289861, 5465.754041068161, 5490.203920431555, 5521.861953451155, 5115.8209462669, 5830.7084645767545, 6085.9391406085815, 6113.810786210561, 6118.010103775202, 6190.84522886927, 6228.37716228378, 6325.367463253684, 6334.271558770754, 6343.46080583151, 5121.84634460963, 5839.737211825478, 5893.174955506232, 6432.678366081677, 6472.967635161841, 5433.157860531624, 6007.909881351783, 6064.636121832704, 6174.351693072253, 6184.041473571604, 6521.413072823374, 6524.412802847766, 6534.7386104556235, 6541.6075035498025, 6557.442617377481, 6260.968695156495, 6294.118823364733, 6353.14232578596, 6356.872862542723, 6393.7762178324465, 6218.31598524162, 6502.447291980235, 6514.315996820265, 6532.0, 6536.640484773383, 6163.19878415812, 6196.256449226032, 6211.9750241210595, 6271.843203919939, 6369.936300637027, 6365.981442969102, 6380.0748891410485, 6402.9359706403275, 6406.167198264196, 6416.615003099736, 5051.116054690415, 5155.948440515622, 5179.507946745053, 5184.248283998799, 5208.114620514521, 4523.864284071417, 4534.546545345505, 4578.153041687298, 4584.724916504953, 4657.278121891112, 5998.580099393088, 6181.8454538636, 6194.473469755031, 6197.659128747962, 6204.751809927642, 6473.805785826433, 6486.189226346707, 6530.118434011348, 6537.280899101095, 6541.345865413516, 6088.878222435526, 6102.084687296941, 6117.309816958539, 6154.19995400604, 6154.969225153935, 5717.22817419643, 5721.742521586539, 5725.484706376446, 5737.311522617312, 5742.08126699726, 6488.967555162194, 6584.209894812461, 6716.496262780311, 6736.831579210559, 6756.0879281297375, 6344.587601805868, 6372.55392122547, 6380.680965951777, 6468.514861385321, 6513.088167656627, 6604.0, 6698.0, 6700.329967003261, 6728.394444500019, 6799.558028728117, 6144.279601711528, 6320.5891617044745, 6381.553291269753, 6413.615183089029, 6419.486441084796, 6247.219097612799, 6285.214348206474, 6320.494360451061, 6360.363963603602, 6365.3316401779, 5293.338332708411, 6147.72335244924, 6233.127362169209, 6241.3134555197985, 6242.500599952084, 6180.6291622502795, 6184.66378606569, 6209.410106039919, 6234.3453937337745, 6240.843978900564, 5936.13925980739, 6059.545534084873, 6086.939130608637, 6118.071005858243, 6190.907136393048, 6251.968740156452, 6256.655883926428, 6264.749410023548, 6271.278802937721, 6282.434580887742, 6179.81460556184, 6199.56603037783, 6203.844903877439, 6208.0, 6213.37866213375], "value": 5923.066551171303, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [477.8685861388118, 508.67699011127934, 513.1251216675569, 532.1512188060043, 538.5664540045262, 38123.0, 41374.58625413749, 41506.58493415065, 43709.68870933877, 43897.0, 43315.566844331544, 43652.56347436525, 43663.0, 43677.12645747091, 43799.0, 9516.143547080761, 9673.322867399285, 9683.98318176592, 9698.175655069292, 9705.611775529005, 9633.133018028377, 9711.368761030546, 9745.951270243639, 9760.170385517204, 9763.463009534473, 9749.025097490265, 9795.363301385423, 9813.950930245339, 9814.705558833246, 9823.263255255884, 9753.927068022513, 9756.268279879003, 9763.804723905554, 9782.9510852446, 9805.823301203829, 9574.856377154349, 9657.227421806308, 9680.56437460316, 9687.757806054835, 9719.319647624669, 41005.0, 41190.79404602958, 41294.38058429096, 41508.96227594304, 41541.0, 3344.381289461433, 3405.6594340565994, 3452.4130897747445, 3809.276237514863, 4040.0, 30484.69515304863, 30618.846905765327, 30746.077617671504, 31317.530237046463, 31905.840470797728, 3196.3447493263825, 3336.4494858348344, 3446.8965931022108, 3447.6897079262985, 3450.0684815100035, 419679.90160049003, 466015.0, 467525.0, 469763.0, 471553.64223179006, 57871.0, 58084.70957645269, 58275.834483310944, 58514.70742646259, 58559.414405856245, 65168.67415662986, 65348.0, 65441.0, 65595.34404655892, 65890.0, 16746.6650666986, 17033.31866725317, 17051.40320088816, 17062.402815901383, 17099.572510687085, 13032.892204162752, 13095.214287142611, 13113.016523760756, 13116.60650180477, 13201.811836934721, 15584.230352962846, 18793.624127517374, 18814.435566933014, 18831.71752423715, 19082.759620624893, 3289.62169350523, 6870.656467176621, 7386.9288953101495, 7590.658420371096, 7897.60511974399, 898.4070513461085, 1034.4569101221919, 1066.2855886556026, 1071.2608300272786, 1105.4693747001484, 26500.734992650214, 30116.849415752782, 30367.93712220106, 30622.38755224883, 30667.11845488435, 1016.1870503597092, 1075.4837677914488, 1094.4691824465128, 1109.5839060352369, 1158.6639874436319, 15340.693186136215, 15598.298076586581, 15790.0, 15974.201289935456, 16013.039217646978, 666889.0, 673963.0, 677405.0, 679403.0, 679793.202067973, 59397.40602594005, 59604.70197648984, 59751.80496390048, 59785.0, 59982.0, 1391.2626308056747, 1409.689868228988, 1415.504573399302, 1422.381264150098, 1424.2024466298906, 28850.855745721135, 29400.411991759618, 30183.09450716482, 30309.39381212319, 30838.537421939138, 51009.0, 51040.48959510357, 51164.48835511597, 51223.48776512187, 51281.0, 473501.0, 505491.0, 506323.0, 507377.0, 509522.0, 26808.59787103234, 27063.458730825667, 27075.72924270811, 27249.72750272472, 27980.58029129524, 46002.849928752046, 46358.53641463542, 47742.0, 48419.27371089366, 48627.27059094187, 38346.0, 38938.22123557569, 39090.41364379593, 40344.798276008434, 41061.0, 38844.41733373945, 39110.804445977585, 39492.0, 39766.40350394689, 39896.40155397613, 38377.4243386355, 38746.22507549889, 38845.47504412204, 39187.62843300585, 39277.607223928535, 28981.13056608305, 31579.526307104952, 34201.637259577255, 34600.653993459746, 34619.82690086534, 22006.88996555071, 24736.134235301677, 25553.744462555136, 25578.744212557634, 25840.741592583832], "value": 20135.175374409304, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.6642937429749, 387.6220684832287, 391.75711059143333, 393.24889461129237, 418.45600719065226, 16247.756283655755, 19539.023048847554, 20153.899230503863, 20994.26520071798, 21031.0, 18922.62154756904, 20268.59462810743, 20620.587588248265, 20746.44401669877, 20936.68594971073, 5801.129830525423, 6022.698865056752, 6091.543134264948, 6092.786752463665, 6093.299270583873, 4782.426108866924, 5197.7920883164625, 5961.0, 6043.063325184604, 6045.818625441222, 5944.7324870380935, 5951.6726580038085, 5954.047352423613, 5960.88078238435, 5984.970075149618, 5682.801101961453, 5965.61223520472, 5967.0, 5977.46202841742, 6017.037274036134, 5751.971240143773, 5912.793052243151, 5922.141289512996, 5940.108983652443, 5950.702464876782, 19428.90285548563, 23696.64455033176, 24401.511969760682, 24631.261062167985, 24664.630030549557, 1898.2312163573774, 2316.3630001749484, 2327.394877331889, 2611.490759301937, 2903.2016195546184, 9061.7281481555, 9307.696922430865, 10369.96300369957, 12573.308468034254, 14492.927535362256, 1550.8836837237252, 1844.4050723627963, 1923.000039979203, 2018.3339497965635, 2033.1968872295508, 120053.0, 126488.0, 128200.0, 128847.0, 134423.0, 11271.605493807678, 11321.490532926038, 11758.176927615155, 11799.823002654966, 11913.10651701126, 11728.648140555797, 12458.563950261878, 14886.627834304229, 14902.627434314229, 14916.0, 8082.676692932335, 8241.381896357798, 8241.846141540189, 8360.205780450848, 8369.539675317916, 8566.82866342682, 8572.357073219533, 8574.442661227125, 8704.6518139275, 8733.563321833883, 3358.8488518016748, 3917.5103112110987, 3961.7821019844187, 3965.088029753173, 4013.6588389986596, 1948.4057362504573, 1968.2323893681476, 2005.1678553400175, 2009.768876579183, 2020.1010550304973, 861.6467248428114, 885.8439736144264, 886.7029545102334, 924.8196601662746, 927.3137877970388, 19902.303419380252, 20436.28473003438, 20484.487887802625, 21199.046042928105, 21210.469738256666, 955.3933252384786, 957.1481381570408, 964.3876138651866, 970.6219761584147, 983.2281658897731, 10764.3541387517, 11146.665600032013, 11165.888341116648, 11182.32906025641, 11191.328520288645, 503231.0, 505767.0, 510245.0, 549968.0, 560278.0, 120106.0, 121966.0, 122086.77913220754, 122274.0, 126820.0, 966.2028826218398, 975.658519518163, 998.6604554451376, 1000.494750151169, 1002.0630710285906, 13590.796138058135, 17908.55228619295, 18151.27394904189, 18329.81670183281, 19245.230190792772, 51905.96188076142, 52126.0, 53801.73099134479, 54218.728906355216, 54499.72750136224, 70988.0, 74126.0, 74326.25673743193, 74897.0, 75781.24218757963, 6048.911195984765, 7641.044869391326, 7798.961005194938, 8006.599670016592, 8268.669253229804, 9279.443233406017, 10466.110380617733, 11338.546458141913, 11714.824277635671, 13065.346732663518, 8921.553922303989, 10880.67357979262, 10911.290766100177, 11037.0, 11287.7742445149, 8394.0, 8965.417247878868, 10964.506597202986, 11114.555417783198, 11231.66305010851, 8870.51212183336, 10766.246362754531, 11048.06091482233, 11286.49210785533, 11431.085513159094, 8266.751997440086, 8372.33021358302, 8407.747767566983, 8485.91514084876, 8505.829883402173, 8968.641254350014, 9997.100260976547, 10909.781804364027, 10984.06635435997, 11287.153463490107], "value": 9399.929235842397, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1502.0837289253557, 1505.7139143562722, 1733.4106403822698, 1861.4694811978588, 1910.5701217226126, 8110.95944520278, 8279.54462504562, 8609.096044915272, 8613.870791938118, 8640.049594544604, 8426.15738426157, 8581.227689507943, 8585.399022068443, 8597.269232115277, 8608.48349099053, 2397.2568503763846, 2409.771071748181, 2411.493586346869, 2412.541617092747, 2419.8064154867657, 2407.9157229496973, 2433.1727212747664, 2433.2821817563863, 2441.963370549443, 2446.889889954947, 2374.4301367671806, 2394.425337918896, 2407.337982054931, 2410.337157281744, 2413.2880800163994, 2369.206315884181, 2372.8457650252676, 2388.6894703688495, 2397.484540823714, 2400.84394514356, 2153.536989547239, 2388.4148383646116, 2392.9162479313313, 2409.325388891113, 2425.0905910283645, 8020.959895200545, 8109.4323397362205, 8507.659693612248, 8510.829783404359, 8550.957245213796, 5207.843764687065, 5335.706536140511, 5346.625736198468, 5352.0, 5355.973220133913, 3071.1707838883376, 3505.737069719781, 3544.2025544252597, 3627.1838836261895, 3628.4375921732176, 1061.946902654864, 1070.4273213830563, 1094.698957786607, 1099.4997276239371, 1115.553778488611, 10911.727206819814, 10988.395638239894, 10988.835167472495, 11011.00900918913, 11011.889881101166, 4245.681573881971, 4439.622632076245, 4484.663650226246, 4541.886452838639, 4549.181147393435, 8655.52394618302, 8658.264047556027, 8695.869561956575, 8698.782530436789, 8699.304055675531, 5124.1032819257225, 5144.125498665236, 5169.948300517022, 5172.586193104543, 5173.301604283449, 4344.9348259776125, 4499.370088187657, 4701.717896926195, 4796.8081276749235, 4829.73436460991, 3706.5737440194184, 3746.981265093657, 3798.6771124454176, 3846.1346197105986, 3860.9034774130873, 1173.2901594535354, 1196.3719047499958, 1196.6529706385224, 1198.3648666206925, 1209.2683926224508, 926.2034650200821, 928.4800511713462, 934.313279739391, 939.4316438554577, 953.9570719317647, 4990.6506544541535, 5784.566157538202, 5862.091375836752, 6015.2781666200335, 6240.157578726814, 897.7710683775596, 939.1735272959888, 961.5480724059821, 962.3430962343068, 962.6101428921298, 3629.455581662719, 3867.497225360685, 3913.412988051815, 3991.780452075164, 3998.380251061032, 8485.32117430604, 10190.184785217165, 10271.94864025675, 10360.740981475523, 10390.168786497063, 9613.90386096144, 10079.395236285847, 10134.645287414905, 10181.33821301613, 10261.435621040915, 7768.339691126317, 7984.720534781371, 7990.880136797953, 8024.879626805603, 8031.638576264082, 5688.0, 5746.396628353963, 5784.739686714192, 5837.328707198726, 6122.693865306628, 9158.084191580789, 9421.152096311365, 9579.760505987406, 9582.520873956413, 9611.519424028631, 9669.0, 9692.5638346276, 9747.317687761788, 9757.170640495353, 9761.902380976384, 6717.731290748511, 6891.827704307232, 7066.964665176847, 7249.927500724925, 7383.446241531799, 7811.336036436966, 8119.0, 8131.552764597767, 8147.226013528705, 8161.469504482189, 7007.40437062835, 7054.224035356209, 7250.492465527574, 7304.890426643711, 7332.670029848777, 7013.473989450914, 7098.219195888345, 7134.32223938725, 7221.855562888818, 7243.203247642649, 5985.132155837467, 6660.533762636569, 6770.2891196425635, 6798.252192258748, 6892.758753443605, 4906.748779061317, 4909.68087074339, 4910.558049775537, 4937.987712518853, 4990.850274491771, 4882.145624515767, 4895.167821470287, 4903.681260718042, 4906.656534042726, 5138.229265610188], "value": 4489.687906814405, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.29797571658025, 314.83785850287103, 319.21632392476465, 324.3334946684565, 325.68408643615686, 5322.92015619766, 5380.569554435646, 5510.713054082556, 5595.4684304991015, 5607.915881261779, 4798.808047678098, 5442.863928401792, 5520.227168196456, 5527.640703354289, 5607.635503692257, 4233.523388817545, 4234.513031001444, 4234.724742891717, 4238.689913996864, 4246.2993606055115, 3646.3618866698353, 4170.749755014694, 4192.155451601301, 4262.232798096342, 4265.445492086024, 3523.559555055618, 4111.856085037024, 4145.917081658365, 4166.854160104397, 4211.073563815971, 4176.916461670765, 4180.414741936132, 4195.433616461769, 4203.936940945889, 4223.746575205482, 3218.2758879252215, 3229.7900636458553, 3656.872009479682, 3684.6868016218655, 3701.68535674468, 4034.031832360242, 4472.875384192483, 5158.478248916541, 5351.678899266057, 5352.545033672142, 3885.348726791131, 4009.578994205625, 4040.7777572233517, 4851.369321988154, 4863.440704319013, 5558.360788509332, 5813.563982701315, 5816.004757549823, 5843.737031833578, 5879.265616643101, 3517.542719446481, 3547.2018795771005, 3661.652143046433, 3799.620037996206, 3899.7660140391667, 5734.942650573483, 6105.572609917308, 6124.601900876429, 6138.263408391022, 6184.413040436581, 4006.9198616027516, 4012.3179059559943, 4027.4764280643913, 4031.0, 4036.0, 3374.4600863861665, 3779.7165212609166, 4050.918981620351, 4052.2170245092066, 4053.8851815750313, 4105.794710264535, 4594.701344412602, 4607.055553611502, 4740.620750339965, 4782.32618583493, 4672.378906347608, 5172.560332371715, 5819.88360232793, 5906.527477801766, 5955.225820643289, 1093.5297821936485, 1252.768237875996, 1288.9742205155844, 1298.668839445954, 1343.6909510812568, 863.2662237098416, 888.5157589113949, 891.4250308550949, 896.059137905197, 896.2471523919809, 4268.466441694788, 4563.06457176278, 5057.949420505822, 5098.694078355311, 5234.450382709837, 4487.573680500347, 4740.217864052462, 5038.798448062036, 5553.555715542828, 5671.51792097668, 4446.799894004777, 5202.0, 5263.552598029134, 5267.473252674702, 5343.465653434703, 2566.6406703061584, 2567.4223299757405, 2940.9264768380963, 2949.4248621519027, 2991.865366058533, 5497.780088796403, 5701.116326969326, 5733.939221244, 5756.597038207369, 5818.301803783488, 4767.638814635674, 5006.824761133343, 5317.548008419328, 5415.566754659618, 5804.709764511757, 5200.583953283653, 5433.402325744165, 5801.7389217485315, 5818.8254352369495, 5845.622027734495, 4722.740249286185, 4966.0, 5384.407715151408, 5612.550995920398, 5615.809834164761, 4822.373091498223, 5116.769745361542, 5847.619904706181, 5919.579300967823, 5964.7912323068485, 6309.463695585927, 6316.210473690789, 6343.55595108338, 6357.777477788255, 6373.681315934277, 3846.306434975835, 4052.244473757873, 4055.939160912648, 4083.632473077437, 4104.856330028435, 4752.431697539872, 5434.347878254634, 5995.505617977528, 6058.576569372286, 6066.362082237682, 4479.619232365155, 5176.4047134580005, 5270.868228294324, 5844.707764611838, 5884.440978107073, 5689.7439615218245, 5866.0, 5875.093063112982, 5875.853103672443, 5927.911081333869, 5498.780048798163, 5643.795372447389, 5706.885862282814, 5757.560609847538, 5778.27771528559, 4926.802927882844, 5009.273655320031, 5578.2748242728185, 5837.416258374129, 5900.468957793819, 4972.5276098770555, 5705.771769129188, 5730.06937819355, 5799.404369291066, 5819.883602328015], "value": 4134.5400120588965, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.5075872268775, 728.5665029307563, 756.6821934787389, 804.9656191793547, 822.8562298405216, 14914.477993270239, 15436.845631543682, 15468.303926323315, 15507.689846203084, 15623.218839058045, 13818.101823381474, 13998.720025599481, 14012.0, 14038.227897465635, 14048.43806247749, 858.6908712863365, 877.4603618774439, 877.6664867350398, 879.9208071273584, 882.7660669922476, 851.7402192331336, 857.1771099744221, 864.7276108025983, 865.3250464637592, 867.5488745852153, 887.5118684723409, 904.2178515584038, 908.1735620585268, 920.5029284186564, 922.5295099499236, 855.7561095087871, 884.6682494064726, 893.0533634347612, 901.6844104563415, 903.412781691899, 663.9900401493982, 680.7515256931234, 684.1858188755365, 688.7486067585345, 694.6735034533812, 12615.747685046339, 12624.495020199181, 12631.621051368382, 12638.810417843739, 12797.168184068007, 10402.739931501697, 11292.108492024687, 11495.42522873853, 12024.939875300568, 12109.636710898687, 10325.225608079425, 10390.960903909549, 10476.68569942903, 10575.78848423035, 10611.098056665192, 3549.1304630365726, 3617.981910090433, 3786.053486628343, 3878.8836334909715, 3882.514685664292, 95200.0, 95866.0, 96450.0354996448, 98113.5282970756, 98857.5057124717, 8180.754577362689, 8880.51157186348, 9261.907380926239, 10107.191424686007, 10564.0, 17996.740228183902, 18532.073396330128, 19563.80436195648, 19967.0, 19993.600127997648, 6323.810285691437, 7328.59692716895, 7599.126100498403, 7692.923070769332, 7865.685372585147, 4325.783710814447, 4406.216089756968, 4421.955780442155, 4425.9159643775, 4558.49856515783, 3267.967320326814, 3370.8146051966887, 3372.2412457196933, 3372.274960883422, 3379.881704140343, 614.3549273263056, 625.3964923848417, 640.2285246278224, 642.2678146912524, 653.8234676637281, 561.6658088437455, 566.963147395418, 567.2597260574906, 642.7557528139278, 649.5128653509868, 8554.401191916506, 8669.56652167389, 8849.469031858109, 8875.378723489423, 9050.728478145535, 587.1984740828823, 611.8286879673699, 648.2156590525517, 653.6633633678659, 659.8911179655303, 4199.769012704331, 4294.892627684333, 4319.136172765459, 4373.431453910971, 4395.428594282723, 105300.36749081181, 112845.19285154305, 116495.41752291184, 117748.0, 118035.40982295033, 64200.0, 67627.0, 84393.57803211067, 88254.0, 103854.48072759739, 77671.50478228381, 79328.603356984, 85194.5740271307, 89334.0, 95958.56062158933, 9217.585208665492, 9410.52947352616, 9826.263030272616, 9849.753756156153, 9873.062059104373, 57079.14381284201, 59074.40925590689, 59701.0, 60473.69763151156, 60876.69561652163, 77600.2239977593, 80722.5963870177, 83090.0, 84234.57882710548, 85957.0, 13061.0, 13150.342482876009, 13456.663583410493, 13682.247476388895, 14030.368633411317, 14162.929185354007, 14295.714085718435, 14317.64205894861, 14549.490767823076, 15275.854310926947, 11794.46924888365, 13133.277669728257, 13523.0, 13969.301534923416, 14149.504767333094, 13137.146085504412, 13328.933355333162, 13462.0, 13734.0, 14064.945129115153, 10701.678949631523, 13179.67050823737, 13216.405261763435, 13282.335883205995, 13856.722865542833, 10584.682459526226, 10832.5125369357, 11195.496202670736, 11221.887781122085, 11619.01238394746, 8968.775780605538, 9349.39228950116, 11357.886421135683, 11572.479238434458, 11583.942080289544], "value": 7325.891646386144, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1554.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 173.0, 162.0, 117.0, 119.0, 134.0, 174.0, 118.0, 117.0, 118.0], "value": 135.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 113.0, 113.0, 143.0, 108.0, 134.0, 112.0, 99.0, 167.0, 147.0], "value": 132.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 197.0, 193.0, 271.0, 273.0, 203.0, 195.0, 200.0, 197.0, 197.0], "value": 212.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 58.0, 87.0, 59.0, 61.0, 58.0, 59.0, 78.0, 60.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 70.0, 89.0, 72.0, 72.0, 71.0, 108.0, 100.0, 103.0, 121.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 132.0, 136.0, 89.0, 104.0, 85.0, 89.0, 86.0, 94.0, 85.0], "value": 97.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 142.0], "value": 100.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 100.0, 74.0, 132.0, 135.0, 90.0, 108.0, 123.0, 89.0, 90.0], "value": 103.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 59.0, 60.0, 62.0, 61.0, 60.0, 63.0, 60.0], "value": 59.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 73.0, 68.0, 74.0, 71.0, 67.0, 67.0, 70.0, 69.0, 70.0], "value": 69.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 84.0, 82.0, 84.0, 83.0, 83.0, 84.0, 93.0, 103.0, 86.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 137.0, 138.0, 138.0, 157.0, 148.0, 158.0, 160.0, 208.0, 165.0], "value": 154.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 200.0, 226.0, 151.0, 223.0, 222.0, 163.0, 160.0, 162.0, 164.0], "value": 181.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 67.0, 65.0, 65.0, 66.0, 67.0, 68.0], "value": 66.2, "unit": "score"}]}]} 12:38:07 INFO - Return code: 0 12:38:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:38:08 ERROR - # TBPL SUCCESS # 12:38:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:38:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:38:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:38:08 INFO - 2017-02-23 12:38:08.032 screenresolution[1933:18070] starting screenresolution argv=screenresolution get 12:38:08 INFO - 2017-02-23 12:38:08.035 screenresolution[1933:18070] Display 0: 1600x1200x32@60 12:38:08 INFO - 2017-02-23 12:38:08.041 screenresolution[1934:18073] starting screenresolution argv=screenresolution list 12:38:08 INFO - Available Modes on Display 0 12:38:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:38:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:38:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:38:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:38:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:38:08 INFO - Intel Iris: 12:38:08 INFO - Chipset Model: Intel Iris 12:38:08 INFO - Type: GPU 12:38:08 INFO - Bus: Built-In 12:38:08 INFO - VRAM (Dynamic, Max): 1536 MB 12:38:08 INFO - Vendor: Intel (0x8086) 12:38:08 INFO - Device ID: 0x0a2e 12:38:08 INFO - Revision ID: 0x0009 12:38:08 INFO - Displays: 12:38:08 INFO - Display: 12:38:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:38:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:38:08 INFO - Display Serial Number: 1600x1200 60 12:38:08 INFO - Main Display: Yes 12:38:08 INFO - Mirror: Off 12:38:08 INFO - Online: Yes 12:38:08 INFO - Rotation: Supported 12:38:08 INFO - Return code: 0 12:38:08 INFO - Running post-action listener: _resource_record_post_action 12:38:08 INFO - [mozharness: 2017-02-23 20:38:08.284727Z] Finished run-tests step (success) 12:38:08 INFO - Running post-run listener: _resource_record_post_run 12:38:08 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 1695744; Write bytes: 500872192; Read time: 21; Write time: 1731 12:38:08 INFO - TinderboxPrint: CPU usage
54.5% 12:38:08 INFO - TinderboxPrint: I/O read bytes / time
1,695,744 / 21 12:38:08 INFO - TinderboxPrint: I/O write bytes / time
500,872,192 / 1,731 12:38:08 INFO - TinderboxPrint: CPU idle
2,182.8 (45.5%) 12:38:08 INFO - TinderboxPrint: CPU system
971.1 (20.3%) 12:38:08 INFO - TinderboxPrint: CPU user
1,639.8 (34.2%) 12:38:08 INFO - TinderboxPrint: Swap in / out
193,728,512 / 0 12:38:08 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 188705280; Write bytes: 189408768; Read time: 17096; Write time: 433 12:38:08 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 1695744; Write bytes: 304483840; Read time: 21; Write time: 1268 12:38:08 INFO - Running post-run listener: _upload_blobber_files 12:38:08 INFO - Blob upload gear active. 12:38:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:38:08 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 12:38:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:38:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:38:09 INFO - (blobuploader) - INFO - Open directory for files ... 12:38:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:38:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:38:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:38:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:38:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:38:09 INFO - (blobuploader) - INFO - Done attempting. 12:38:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:38:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:38:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:38:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:38:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:38:10 INFO - (blobuploader) - INFO - Done attempting. 12:38:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:38:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:38:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:38:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:38:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:38:13 INFO - (blobuploader) - INFO - Done attempting. 12:38:13 INFO - (blobuploader) - INFO - Iteration through files over. 12:38:13 INFO - Return code: 0 12:38:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:38:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:38:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0fb00e2aef27182949f21c966d6f5112397018dc8ca9dcbdf3e876e94794219cca39228b86bc180f1de3cd891df93d9e30b19e1d1c45f3e48818e7ceda2108b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d7c38033a9b3f6744e91c8b3a479206cbd61b8b6d2255788f9e3fceee27b606982c591b4841c0f30562bfb581e24f38cfd4bb2cc57cdb08e33c723fe517df3d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/09065f5d4f7f12abbfc9e1b255962d04d32703df1816a9a0f6867a667024ab4135825e07944b41af2dd80b7317641e9c221fdeb085f42231d277a771adbdf3b4"} 12:38:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:38:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:38:13 INFO - Contents: 12:38:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0fb00e2aef27182949f21c966d6f5112397018dc8ca9dcbdf3e876e94794219cca39228b86bc180f1de3cd891df93d9e30b19e1d1c45f3e48818e7ceda2108b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d7c38033a9b3f6744e91c8b3a479206cbd61b8b6d2255788f9e3fceee27b606982c591b4841c0f30562bfb581e24f38cfd4bb2cc57cdb08e33c723fe517df3d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/09065f5d4f7f12abbfc9e1b255962d04d32703df1816a9a0f6867a667024ab4135825e07944b41af2dd80b7317641e9c221fdeb085f42231d277a771adbdf3b4"} 12:38:13 INFO - Running post-run listener: copy_logs_to_upload_dir 12:38:13 INFO - Copying logs to upload dir... 12:38:13 INFO - mkdir: /builds/slave/test/build/upload/logs 12:38:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.713011 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-23 12:38:13.373305) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-23 12:38:13.376949) ========= 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.Yaj1RhGEW9/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.PYi81FDaQq/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0fb00e2aef27182949f21c966d6f5112397018dc8ca9dcbdf3e876e94794219cca39228b86bc180f1de3cd891df93d9e30b19e1d1c45f3e48818e7ceda2108b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d7c38033a9b3f6744e91c8b3a479206cbd61b8b6d2255788f9e3fceee27b606982c591b4841c0f30562bfb581e24f38cfd4bb2cc57cdb08e33c723fe517df3d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/09065f5d4f7f12abbfc9e1b255962d04d32703df1816a9a0f6867a667024ab4135825e07944b41af2dd80b7317641e9c221fdeb085f42231d277a771adbdf3b4"} build_url:https://queue.taskcluster.net/v1/task/Tg5fLDZLQAG8b-yuy5Qaiw/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010928 build_url: 'https://queue.taskcluster.net/v1/task/Tg5fLDZLQAG8b-yuy5Qaiw/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0fb00e2aef27182949f21c966d6f5112397018dc8ca9dcbdf3e876e94794219cca39228b86bc180f1de3cd891df93d9e30b19e1d1c45f3e48818e7ceda2108b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d7c38033a9b3f6744e91c8b3a479206cbd61b8b6d2255788f9e3fceee27b606982c591b4841c0f30562bfb581e24f38cfd4bb2cc57cdb08e33c723fe517df3d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/09065f5d4f7f12abbfc9e1b255962d04d32703df1816a9a0f6867a667024ab4135825e07944b41af2dd80b7317641e9c221fdeb085f42231d277a771adbdf3b4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-23 12:38:13.409619) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 12:38:13.409950) ========= 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.Yaj1RhGEW9/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.PYi81FDaQq/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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.005251 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 12:38:13.458392) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-23 12:38:13.458716) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-23 12:38:13.459020) ========= ========= Total master_lag: 0.18 =========