builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0268 starttime: 1493034698.03 results: success (0) buildid: 20170424032920 builduid: 8090bfd39fe44179be8e4fb93bb38648 revision: e17cbb839dd225a2da7e5d5bec43cf94e11749d8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-24 04:51:38.034417) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-24 04:51:38.034902) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-24 04:51:38.035199) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-24 04:51:38.066288) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 04:51:38.066676) ========= 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.O9gJGn6wFE/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.ov5B4tD4Yy/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-24 04:51:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 22.7M=0.001s 2017-04-24 04:51:38 (22.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134605 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 04:51:38.226473) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 04:51:38.226805) ========= 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.O9gJGn6wFE/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.ov5B4tD4Yy/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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.027311 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 04:51:38.279798) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-24 04:51:38.283219) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e17cbb839dd225a2da7e5d5bec43cf94e11749d8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev e17cbb839dd225a2da7e5d5bec43cf94e11749d8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.O9gJGn6wFE/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.ov5B4tD4Yy/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-24 04:51:38,389 truncating revision to first 12 chars 2017-04-24 04:51:38,389 Setting DEBUG logging. 2017-04-24 04:51:38,390 attempt 1/10 2017-04-24 04:51:38,390 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e17cbb839dd2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-24 04:51:40,181 unpacking tar archive at: mozilla-central-e17cbb839dd2/testing/mozharness/ program finished with exit code 0 elapsedTime=2.073092 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-24 04:51:40.380757) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-24 04:51:40.384139) ========= script_repo_revision: e17cbb839dd225a2da7e5d5bec43cf94e11749d8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-24 04:51:40.384561) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-24 04:51:40.384834) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-24 04:51:40.405543) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2017-04-24 04:51:40.405956) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.O9gJGn6wFE/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.ov5B4tD4Yy/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:51:40 INFO - MultiFileLogger online at 20170424 04:51:40 in /builds/slave/test 04:51:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:51:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:51:40 INFO - {'append_to_log': False, 04:51:40 INFO - 'base_work_dir': '/builds/slave/test', 04:51:40 INFO - 'blob_upload_branch': 'Firefox', 04:51:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:51:40 INFO - 'branch': 'Firefox', 04:51:40 INFO - 'buildbot_json_path': 'buildprops.json', 04:51:40 INFO - 'config_files': ('talos/mac_config.py',), 04:51:40 INFO - 'default_actions': ('clobber', 04:51:40 INFO - 'read-buildbot-config', 04:51:40 INFO - 'download-and-extract', 04:51:40 INFO - 'populate-webroot', 04:51:40 INFO - 'create-virtualenv', 04:51:40 INFO - 'install', 04:51:40 INFO - 'run-tests'), 04:51:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:51:40 INFO - 'download_minidump_stackwalk': True, 04:51:40 INFO - 'download_symbols': 'ondemand', 04:51:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:51:40 INFO - 'tooltool.py': '/tools/tooltool.py', 04:51:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:51:40 INFO - '/tools/misc-python/virtualenv.py')}, 04:51:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:51:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:51:40 INFO - 'gecko_profile': False, 04:51:40 INFO - 'gecko_profile_interval': 0, 04:51:40 INFO - 'installer_path': 'installer.exe', 04:51:40 INFO - 'log_level': 'info', 04:51:40 INFO - 'log_name': 'talos', 04:51:40 INFO - 'log_to_console': True, 04:51:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:51:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:51:40 INFO - 'opt_config_files': (), 04:51:40 INFO - 'pip_index': False, 04:51:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:51:40 INFO - 'cmd': ('bash', 04:51:40 INFO - '-c', 04:51:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:51:40 INFO - 'enabled': True, 04:51:40 INFO - 'halt_on_failure': False, 04:51:40 INFO - 'name': 'check_screen_resolution'},), 04:51:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:51:40 INFO - 'cmd': ('bash', 04:51:40 INFO - '-c', 04:51:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:51:40 INFO - 'enabled': True, 04:51:40 INFO - 'halt_on_failure': False, 04:51:40 INFO - 'name': 'check_screen_resolution'},), 04:51:40 INFO - 'run_cmd_checks_enabled': True, 04:51:40 INFO - 'suite': 'dromaeojs-e10s', 04:51:40 INFO - 'system_bits': '32', 04:51:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:51:40 INFO - 'title': 't-yosemite-r7-0268', 04:51:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:51:40 INFO - 'use_talos_json': True, 04:51:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:51:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:51:40 INFO - 'work_dir': 'build'} 04:51:40 INFO - [mozharness: 2017-04-24 11:51:40.616756Z] Running clobber step. 04:51:40 INFO - Running pre-action listener: _resource_record_pre_action 04:51:40 INFO - Running main action method: clobber 04:51:40 INFO - rmtree: /builds/slave/test/build 04:51:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:51:43 INFO - Running post-action listener: _resource_record_post_action 04:51:43 INFO - [mozharness: 2017-04-24 11:51:43.258427Z] Finished clobber step (success) 04:51:43 INFO - [mozharness: 2017-04-24 11:51:43.258686Z] Running read-buildbot-config step. 04:51:43 INFO - Running pre-action listener: _resource_record_pre_action 04:51:43 INFO - Running main action method: read_buildbot_config 04:51:43 INFO - Using buildbot properties: 04:51:43 INFO - { 04:51:43 INFO - "project": "", 04:51:43 INFO - "product": "firefox", 04:51:43 INFO - "script_repo_revision": "production", 04:51:43 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:51:43 INFO - "repository": "", 04:51:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:51:43 INFO - "buildid": "20170424032920", 04:51:43 INFO - "pgo_build": "False", 04:51:43 INFO - "basedir": "/builds/slave/test", 04:51:43 INFO - "buildnumber": 203, 04:51:43 INFO - "slavename": "t-yosemite-r7-0268", 04:51:43 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 04:51:43 INFO - "platform": "yosemite_r7", 04:51:43 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:51:43 INFO - "branch": "mozilla-central", 04:51:43 INFO - "repo_path": "mozilla-central", 04:51:43 INFO - "revision": "e17cbb839dd225a2da7e5d5bec43cf94e11749d8", 04:51:43 INFO - "stage_platform": "macosx64", 04:51:43 INFO - "builduid": "8090bfd39fe44179be8e4fb93bb38648", 04:51:43 INFO - "slavebuilddir": "test" 04:51:43 INFO - } 04:51:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:51:43 INFO - Running post-action listener: _resource_record_post_action 04:51:43 INFO - [mozharness: 2017-04-24 11:51:43.264369Z] Finished read-buildbot-config step (success) 04:51:43 INFO - [mozharness: 2017-04-24 11:51:43.264600Z] Running download-and-extract step. 04:51:43 INFO - Running pre-action listener: _resource_record_pre_action 04:51:43 INFO - Running main action method: download_and_extract 04:51:43 INFO - mkdir: /builds/slave/test/build/tests 04:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:51:43 INFO - trying https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:51:43 INFO - Downloading https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:51:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:51:43 INFO - Downloaded 1325 bytes. 04:51:43 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:51:43 INFO - Using the following test package requirements: 04:51:43 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:51:43 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:51:43 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:51:43 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:51:43 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:51:43 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:51:43 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:51:43 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:51:43 INFO - u'jsshell-mac.zip'], 04:51:43 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:51:43 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:51:43 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:51:43 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:51:43 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:51:43 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:51:43 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:51:43 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:51:43 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:51:43 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:51:43 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:51:43 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:51:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:51:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:51:43 INFO - Fetch https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:51:45 INFO - Content-Length response header: 52523633 04:51:45 INFO - Bytes received: 52523633 04:52:01 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:52:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:52:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:52:01 INFO - Fetch https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:52:03 INFO - Content-Length response header: 52523633 04:52:03 INFO - Bytes received: 52523633 04:52:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:52:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:52:19 INFO - Fetch https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:52:20 INFO - Content-Length response header: 14408822 04:52:20 INFO - Bytes received: 14408822 04:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:20 INFO - trying https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:52:20 INFO - Downloading https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:52:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:52:22 INFO - Downloaded 71039720 bytes. 04:52:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:52:22 INFO - mkdir: /builds/slave/test/properties 04:52:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:52:22 INFO - Writing to file /builds/slave/test/properties/build_url 04:52:22 INFO - Contents: 04:52:22 INFO - build_url:https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:52:23 INFO - Running post-action listener: _resource_record_post_action 04:52:23 INFO - Running post-action listener: set_extra_try_arguments 04:52:23 INFO - [mozharness: 2017-04-24 11:52:23.134350Z] Finished download-and-extract step (success) 04:52:23 INFO - [mozharness: 2017-04-24 11:52:23.134470Z] Running populate-webroot step. 04:52:23 INFO - Running pre-action listener: _resource_record_pre_action 04:52:23 INFO - Running main action method: populate_webroot 04:52:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:52:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:52:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:52:23 INFO - '--tppagecycles', 04:52:23 INFO - '7'], 04:52:23 INFO - 'tests': ['tsvgm']}}, 04:52:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:52:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:52:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:52:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:52:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:52:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:52:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:52:23 INFO - 'talos_options': ['--disable-e10s'], 04:52:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:52:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:52:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:52:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:52:23 INFO - 'talos_options': ['--disable-e10s'], 04:52:23 INFO - 'tests': ['damp', 'tps']}, 04:52:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:52:23 INFO - 'tests': ['damp', 'tps']}, 04:52:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:52:23 INFO - 'tests': ['dromaeo_dom']}, 04:52:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:52:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:52:23 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:52:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:52:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:52:23 INFO - 'tests': ['a11yr', 04:52:23 INFO - 'ts_paint', 04:52:23 INFO - 'tpaint', 04:52:23 INFO - 'sessionrestore', 04:52:23 INFO - 'sessionrestore_no_auto_restore', 04:52:23 INFO - 'tabpaint']}, 04:52:23 INFO - 'other-e10s': {'tests': ['a11yr', 04:52:23 INFO - 'ts_paint', 04:52:23 INFO - 'tpaint', 04:52:23 INFO - 'sessionrestore', 04:52:23 INFO - 'sessionrestore_no_auto_restore', 04:52:23 INFO - 'tabpaint']}, 04:52:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:52:23 INFO - 'ts_paint', 04:52:23 INFO - 'tpaint', 04:52:23 INFO - 'sessionrestore', 04:52:23 INFO - 'sessionrestore_no_auto_restore', 04:52:23 INFO - 'tabpaint']}, 04:52:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:52:23 INFO - 'ts_paint', 04:52:23 INFO - 'tpaint', 04:52:23 INFO - 'sessionrestore', 04:52:23 INFO - 'sessionrestore_no_auto_restore', 04:52:23 INFO - 'tabpaint']}, 04:52:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:52:23 INFO - 'tests': ['a11yr', 04:52:23 INFO - 'ts_paint', 04:52:23 INFO - 'tpaint', 04:52:23 INFO - 'sessionrestore', 04:52:23 INFO - 'sessionrestore_no_auto_restore', 04:52:23 INFO - 'tabpaint']}, 04:52:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:52:23 INFO - 'tests': ['a11yr', 04:52:23 INFO - 'ts_paint', 04:52:23 INFO - 'tpaint', 04:52:23 INFO - 'sessionrestore', 04:52:23 INFO - 'sessionrestore_no_auto_restore', 04:52:23 INFO - 'tabpaint']}, 04:52:23 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:52:23 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:52:23 INFO - 'bloom_basic_ref']}, 04:52:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:52:23 INFO - 'tests': ['tsvgx', 04:52:23 INFO - 'tsvgr_opacity', 04:52:23 INFO - 'tart', 04:52:23 INFO - 'tscrollx', 04:52:23 INFO - 'cart', 04:52:23 INFO - 'tsvg_static']}, 04:52:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:52:23 INFO - 'tsvgr_opacity', 04:52:23 INFO - 'tart', 04:52:23 INFO - 'tscrollx', 04:52:23 INFO - 'cart', 04:52:23 INFO - 'tsvg_static']}, 04:52:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:52:23 INFO - 'talos_options': ['--disable-e10s'], 04:52:23 INFO - 'tests': ['tp5o']}, 04:52:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:52:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:52:23 INFO - 'talos_options': ['--disable-e10s', 04:52:23 INFO - '--xperf_path', 04:52:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:52:23 INFO - 'tests': ['tp5n']}, 04:52:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:52:23 INFO - 'talos_options': ['--xperf_path', 04:52:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:52:23 INFO - 'tests': ['tp5n']}}, 04:52:23 INFO - 'talos.zip': {'path': '', 04:52:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:52:23 INFO - Running post-action listener: _resource_record_post_action 04:52:23 INFO - [mozharness: 2017-04-24 11:52:23.153459Z] Finished populate-webroot step (success) 04:52:23 INFO - [mozharness: 2017-04-24 11:52:23.153592Z] Running create-virtualenv step. 04:52:23 INFO - Running pre-action listener: _resource_record_pre_action 04:52:23 INFO - Running main action method: create_virtualenv 04:52:23 INFO - Creating virtualenv /builds/slave/test/build/venv 04:52:23 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:52:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:52:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:52:23 INFO - Using real prefix '/tools/python27' 04:52:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:52:23 INFO - Installing distribute.............................................................................................................................................................................................done. 04:52:26 INFO - Installing pip.................done. 04:52:26 INFO - Return code: 0 04:52:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:52:27 INFO - Reading from file tmpfile_stdout 04:52:27 INFO - Output received: 04:52:27 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:52:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:27 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 0x102f46b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f49768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc12b5c4800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d24d30>, '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 0x102c4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d19be8>, '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.O9gJGn6wFE/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.ov5B4tD4Yy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:52:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:52:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:52:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O9gJGn6wFE/Render', 04:52:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:27 INFO - 'HOME': '/Users/cltbld', 04:52:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:27 INFO - 'LOGNAME': 'cltbld', 04:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:27 INFO - 'MOZ_NO_REMOTE': '1', 04:52:27 INFO - 'NO_EM_RESTART': '1', 04:52:27 INFO - 'PAGER': '/bin/cat', 04:52:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:27 INFO - 'PWD': '/builds/slave/test', 04:52:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:27 INFO - 'SHELL': '/bin/bash', 04:52:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ov5B4tD4Yy/Listeners', 04:52:27 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 04:52:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:27 INFO - 'USER': 'cltbld', 04:52:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:27 INFO - 'XPC_FLAGS': '0x0', 04:52:27 INFO - 'XPC_SERVICE_NAME': '0', 04:52:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:27 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:52:27 INFO - Cleaning up... 04:52:27 INFO - Return code: 0 04:52:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:27 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 0x102f46b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f49768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc12b5c4800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d24d30>, '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 0x102c4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d19be8>, '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.O9gJGn6wFE/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.ov5B4tD4Yy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:52:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:52:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:52:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O9gJGn6wFE/Render', 04:52:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:27 INFO - 'HOME': '/Users/cltbld', 04:52:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:27 INFO - 'LOGNAME': 'cltbld', 04:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:27 INFO - 'MOZ_NO_REMOTE': '1', 04:52:27 INFO - 'NO_EM_RESTART': '1', 04:52:27 INFO - 'PAGER': '/bin/cat', 04:52:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:27 INFO - 'PWD': '/builds/slave/test', 04:52:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:27 INFO - 'SHELL': '/bin/bash', 04:52:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ov5B4tD4Yy/Listeners', 04:52:27 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 04:52:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:27 INFO - 'USER': 'cltbld', 04:52:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:27 INFO - 'XPC_FLAGS': '0x0', 04:52:27 INFO - 'XPC_SERVICE_NAME': '0', 04:52:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:27 INFO - Downloading/unpacking psutil>=3.1.1 04:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:52:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:52:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:52:31 INFO - Installing collected packages: psutil 04:52:31 INFO - Running setup.py install for psutil 04:52:31 INFO - building 'psutil._psutil_osx' extension 04:52:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:52:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:52:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:52:31 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:52:32 INFO - building 'psutil._psutil_posix' extension 04:52:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:52:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:52:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:52:32 INFO - ^ 04:52:32 INFO - 1 warning generated. 04:52:32 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:52:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:52:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:52:32 INFO - Successfully installed psutil 04:52:32 INFO - Cleaning up... 04:52:32 INFO - Return code: 0 04:52:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:52: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')]} 04:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52: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')]} 04:52:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:32 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 0x102f46b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f49768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc12b5c4800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d24d30>, '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 0x102c4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d19be8>, '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.O9gJGn6wFE/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.ov5B4tD4Yy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:52:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:52:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:52:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O9gJGn6wFE/Render', 04:52:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:32 INFO - 'HOME': '/Users/cltbld', 04:52:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:32 INFO - 'LOGNAME': 'cltbld', 04:52:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:32 INFO - 'MOZ_NO_REMOTE': '1', 04:52:32 INFO - 'NO_EM_RESTART': '1', 04:52:32 INFO - 'PAGER': '/bin/cat', 04:52:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:32 INFO - 'PWD': '/builds/slave/test', 04:52:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:32 INFO - 'SHELL': '/bin/bash', 04:52:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ov5B4tD4Yy/Listeners', 04:52:32 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 04:52:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:32 INFO - 'USER': 'cltbld', 04:52:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:32 INFO - 'XPC_FLAGS': '0x0', 04:52:32 INFO - 'XPC_SERVICE_NAME': '0', 04:52:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:52:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:52:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:52:35 INFO - Installing collected packages: mozsystemmonitor 04:52:35 INFO - Running setup.py install for mozsystemmonitor 04:52:35 INFO - Successfully installed mozsystemmonitor 04:52:35 INFO - Cleaning up... 04:52:35 INFO - Return code: 0 04:52:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:36 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 0x102f46b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f49768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc12b5c4800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d24d30>, '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 0x102c4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d19be8>, '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.O9gJGn6wFE/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.ov5B4tD4Yy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:52:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:52:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:52:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O9gJGn6wFE/Render', 04:52:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:36 INFO - 'HOME': '/Users/cltbld', 04:52:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:36 INFO - 'LOGNAME': 'cltbld', 04:52:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:36 INFO - 'MOZ_NO_REMOTE': '1', 04:52:36 INFO - 'NO_EM_RESTART': '1', 04:52:36 INFO - 'PAGER': '/bin/cat', 04:52:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:36 INFO - 'PWD': '/builds/slave/test', 04:52:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:36 INFO - 'SHELL': '/bin/bash', 04:52:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ov5B4tD4Yy/Listeners', 04:52:36 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 04:52:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:36 INFO - 'USER': 'cltbld', 04:52:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:36 INFO - 'XPC_FLAGS': '0x0', 04:52:36 INFO - 'XPC_SERVICE_NAME': '0', 04:52:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:36 INFO - Downloading/unpacking jsonschema==2.5.1 04:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:52:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:39 INFO - Downloading functools32-3.2.3-2.tar.gz 04:52:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:52:39 INFO - warning: no files found matching '*.txt' 04:52:39 INFO - no previously-included directories found matching 'build' 04:52:39 INFO - no previously-included directories found matching 'dist' 04:52:39 INFO - no previously-included directories found matching '.git*' 04:52:39 INFO - Installing collected packages: jsonschema, functools32 04:52:39 INFO - Running setup.py install for functools32 04:52:39 INFO - warning: no files found matching '*.txt' 04:52:39 INFO - no previously-included directories found matching 'build' 04:52:39 INFO - no previously-included directories found matching 'dist' 04:52:39 INFO - no previously-included directories found matching '.git*' 04:52:39 INFO - Successfully installed jsonschema functools32 04:52:39 INFO - Cleaning up... 04:52:39 INFO - Return code: 0 04:52:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:52: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')]} 04:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52: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')]} 04:52:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52: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', '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 0x102f46b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f49768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc12b5c4800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d24d30>, '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 0x102c4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d19be8>, '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.O9gJGn6wFE/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.ov5B4tD4Yy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:52: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:52: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 functools32==3.2.3-2 04:52:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O9gJGn6wFE/Render', 04:52:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:39 INFO - 'HOME': '/Users/cltbld', 04:52:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:39 INFO - 'LOGNAME': 'cltbld', 04:52:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:39 INFO - 'MOZ_NO_REMOTE': '1', 04:52:39 INFO - 'NO_EM_RESTART': '1', 04:52:39 INFO - 'PAGER': '/bin/cat', 04:52:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:39 INFO - 'PWD': '/builds/slave/test', 04:52:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:39 INFO - 'SHELL': '/bin/bash', 04:52:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ov5B4tD4Yy/Listeners', 04:52:39 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 04:52:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:39 INFO - 'USER': 'cltbld', 04:52:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:39 INFO - 'XPC_FLAGS': '0x0', 04:52:39 INFO - 'XPC_SERVICE_NAME': '0', 04:52:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:52:40 INFO - Cleaning up... 04:52:40 INFO - Return code: 0 04:52:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:52: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')]} 04:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52: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')]} 04:52:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52: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', '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 0x102f46b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f49768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc12b5c4800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d24d30>, '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 0x102c4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d19be8>, '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.O9gJGn6wFE/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.ov5B4tD4Yy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:52: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:52: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 blobuploader==1.2.4 04:52:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O9gJGn6wFE/Render', 04:52:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:40 INFO - 'HOME': '/Users/cltbld', 04:52:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:40 INFO - 'LOGNAME': 'cltbld', 04:52:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:40 INFO - 'MOZ_NO_REMOTE': '1', 04:52:40 INFO - 'NO_EM_RESTART': '1', 04:52:40 INFO - 'PAGER': '/bin/cat', 04:52:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:40 INFO - 'PWD': '/builds/slave/test', 04:52:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:40 INFO - 'SHELL': '/bin/bash', 04:52:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ov5B4tD4Yy/Listeners', 04:52:40 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 04:52:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:40 INFO - 'USER': 'cltbld', 04:52:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:40 INFO - 'XPC_FLAGS': '0x0', 04:52:40 INFO - 'XPC_SERVICE_NAME': '0', 04:52:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:40 INFO - Downloading/unpacking blobuploader==1.2.4 04:52: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 04:52: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 04:52: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 04:52: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 04:52: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 04:52: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 04:52:43 INFO - Downloading blobuploader-1.2.4.tar.gz 04:52:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:52:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:52:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:44 INFO - Downloading docopt-0.6.1.tar.gz 04:52:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:52:44 INFO - Installing collected packages: blobuploader, requests, docopt 04:52:44 INFO - Running setup.py install for blobuploader 04:52:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:52:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:52:44 INFO - Running setup.py install for requests 04:52:45 INFO - Running setup.py install for docopt 04:52:45 INFO - Successfully installed blobuploader requests docopt 04:52:45 INFO - Cleaning up... 04:52:45 INFO - Return code: 0 04:52:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:45 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 0x102f46b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f49768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc12b5c4800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d24d30>, '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 0x102c4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d19be8>, '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.O9gJGn6wFE/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.ov5B4tD4Yy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:52:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:52:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:52:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O9gJGn6wFE/Render', 04:52:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:45 INFO - 'HOME': '/Users/cltbld', 04:52:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:45 INFO - 'LOGNAME': 'cltbld', 04:52:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:45 INFO - 'MOZ_NO_REMOTE': '1', 04:52:45 INFO - 'NO_EM_RESTART': '1', 04:52:45 INFO - 'PAGER': '/bin/cat', 04:52:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:45 INFO - 'PWD': '/builds/slave/test', 04:52:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:45 INFO - 'SHELL': '/bin/bash', 04:52:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ov5B4tD4Yy/Listeners', 04:52:45 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 04:52:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:45 INFO - 'USER': 'cltbld', 04:52:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:45 INFO - 'XPC_FLAGS': '0x0', 04:52:45 INFO - 'XPC_SERVICE_NAME': '0', 04:52:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:52:45 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-RGDD9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:52:45 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-y8XFRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:52:45 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-UJ6yue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:52:45 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-CWx41a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:52:46 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-2jrvNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:52:46 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-_M9fBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:52:46 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-ibWFFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:52:46 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-UCJYuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:52:46 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-klFK4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:52:46 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-K9fWZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:52:46 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-rSQ2Gy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:52:46 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-VT8EDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:52:46 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-5mfnAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:52:47 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-uqnBui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:47 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-rGVu6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:52:47 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-waqKsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:52:47 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-MhJeSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:52:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:52:47 INFO - Running setup.py install for manifestparser 04:52:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:52:47 INFO - Running setup.py install for mozcrash 04:52:47 INFO - Running setup.py install for mozdebug 04:52:47 INFO - Running setup.py install for mozdevice 04:52:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:52:48 INFO - Running setup.py install for mozfile 04:52:48 INFO - Running setup.py install for mozhttpd 04:52:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:52:48 INFO - Running setup.py install for mozinfo 04:52:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:52:48 INFO - Running setup.py install for mozInstall 04:52:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:52:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:52:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:52:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:52:48 INFO - Running setup.py install for mozleak 04:52:48 INFO - Running setup.py install for mozlog 04:52:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:52:48 INFO - Running setup.py install for moznetwork 04:52:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:52:49 INFO - Running setup.py install for mozprocess 04:52:49 INFO - Running setup.py install for mozprofile 04:52:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:52:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:52:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:52:49 INFO - Running setup.py install for mozrunner 04:52:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:52:49 INFO - Running setup.py install for mozscreenshot 04:52:49 INFO - Running setup.py install for moztest 04:52:49 INFO - Running setup.py install for mozversion 04:52:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:52:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:52:49 INFO - Cleaning up... 04:52:49 INFO - Return code: 0 04:52:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:49 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 0x102f46b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f49768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc12b5c4800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d24d30>, '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 0x102c4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d19be8>, '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.O9gJGn6wFE/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.ov5B4tD4Yy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:52:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:52:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:52:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O9gJGn6wFE/Render', 04:52:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:49 INFO - 'HOME': '/Users/cltbld', 04:52:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:49 INFO - 'LOGNAME': 'cltbld', 04:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:49 INFO - 'MOZ_NO_REMOTE': '1', 04:52:49 INFO - 'NO_EM_RESTART': '1', 04:52:49 INFO - 'PAGER': '/bin/cat', 04:52:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:49 INFO - 'PWD': '/builds/slave/test', 04:52:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:49 INFO - 'SHELL': '/bin/bash', 04:52:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ov5B4tD4Yy/Listeners', 04:52:49 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 04:52:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:49 INFO - 'USER': 'cltbld', 04:52:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:49 INFO - 'XPC_FLAGS': '0x0', 04:52:49 INFO - 'XPC_SERVICE_NAME': '0', 04:52:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:52:50 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-012HpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:52:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:52:50 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-XJ7JqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:52:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:52:50 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-gh40Fj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:52:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:52:50 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-hebA58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:52:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:52:50 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-_jcYyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:52:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:52:50 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-ZnQsxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:52:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:52:50 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-CNskYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:52:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:52:50 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-avHHzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:52:51 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-e5hmLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:52:51 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-Lio6Sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:52:51 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-J78TsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:52:51 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-nryf9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:52:51 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-Bq5Nk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:52:51 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-KPMfAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:51 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-cC8gyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:52:51 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-eDRmC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:52:51 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-1NGped-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:52:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:52:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:52:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:52:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:52:52 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:52:52 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:52:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:52: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 04:52: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 04:52: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 04:52: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 04:52: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 04:52: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 04:52:54 INFO - Downloading blessings-1.6.tar.gz 04:52:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:52:54 INFO - Installing collected packages: blessings 04:52:54 INFO - Running setup.py install for blessings 04:52:54 INFO - Successfully installed blessings 04:52:54 INFO - Cleaning up... 04:52:55 INFO - Return code: 0 04:52:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:52:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:52:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:52:55 INFO - Reading from file tmpfile_stdout 04:52:55 INFO - Current package versions: 04:52:55 INFO - blessings == 1.6 04:52:55 INFO - blobuploader == 1.2.4 04:52:55 INFO - docopt == 0.6.1 04:52:55 INFO - functools32 == 3.2.3-2 04:52:55 INFO - jsonschema == 2.5.1 04:52:55 INFO - manifestparser == 1.1 04:52:55 INFO - mozInstall == 1.12 04:52:55 INFO - mozcrash == 1.0 04:52:55 INFO - mozdebug == 0.1 04:52:55 INFO - mozdevice == 0.50 04:52:55 INFO - mozfile == 1.2 04:52:55 INFO - mozhttpd == 0.7 04:52:55 INFO - mozinfo == 0.9 04:52:55 INFO - mozleak == 0.1 04:52:55 INFO - mozlog == 3.4 04:52:55 INFO - moznetwork == 0.27 04:52:55 INFO - mozprocess == 0.25 04:52:55 INFO - mozprofile == 0.28 04:52:55 INFO - mozrunner == 6.13 04:52:55 INFO - mozscreenshot == 0.1 04:52:55 INFO - mozsystemmonitor == 0.3 04:52:55 INFO - moztest == 0.8 04:52:55 INFO - mozversion == 1.4 04:52:55 INFO - psutil == 3.1.1 04:52:55 INFO - requests == 1.2.3 04:52:55 INFO - wsgiref == 0.1.2 04:52:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:55 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 0x102f46b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f49768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc12b5c4800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d24d30>, '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 0x102c4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d19be8>, '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.O9gJGn6wFE/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.ov5B4tD4Yy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:52:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:52:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:52:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O9gJGn6wFE/Render', 04:52:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:55 INFO - 'HOME': '/Users/cltbld', 04:52:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:55 INFO - 'LOGNAME': 'cltbld', 04:52:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:55 INFO - 'MOZ_NO_REMOTE': '1', 04:52:55 INFO - 'NO_EM_RESTART': '1', 04:52:55 INFO - 'PAGER': '/bin/cat', 04:52:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:55 INFO - 'PWD': '/builds/slave/test', 04:52:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:55 INFO - 'SHELL': '/bin/bash', 04:52:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ov5B4tD4Yy/Listeners', 04:52:55 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 04:52:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:55 INFO - 'USER': 'cltbld', 04:52:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:55 INFO - 'XPC_FLAGS': '0x0', 04:52:55 INFO - 'XPC_SERVICE_NAME': '0', 04:52:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:52:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:52:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:52:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:52:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:52:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:52:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:52:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:52:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:52:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:52:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:52:55 INFO - Cleaning up... 04:52:55 INFO - Return code: 0 04:52:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:55 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 0x102f46b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f49768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc12b5c4800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d24d30>, '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 0x102c4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d19be8>, '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.O9gJGn6wFE/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.ov5B4tD4Yy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:52:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:52:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:52:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O9gJGn6wFE/Render', 04:52:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:55 INFO - 'HOME': '/Users/cltbld', 04:52:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:55 INFO - 'LOGNAME': 'cltbld', 04:52:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:55 INFO - 'MOZ_NO_REMOTE': '1', 04:52:55 INFO - 'NO_EM_RESTART': '1', 04:52:55 INFO - 'PAGER': '/bin/cat', 04:52:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:55 INFO - 'PWD': '/builds/slave/test', 04:52:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:55 INFO - 'SHELL': '/bin/bash', 04:52:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ov5B4tD4Yy/Listeners', 04:52:55 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 04:52:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:55 INFO - 'USER': 'cltbld', 04:52:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:55 INFO - 'XPC_FLAGS': '0x0', 04:52:55 INFO - 'XPC_SERVICE_NAME': '0', 04:52:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:52:55 INFO - Cleaning up... 04:52:55 INFO - Return code: 0 04:52:55 INFO - Running post-action listener: _resource_record_post_action 04:52:55 INFO - Running post-action listener: _start_resource_monitoring 04:52:55 INFO - Starting resource monitoring. 04:52:55 INFO - [mozharness: 2017-04-24 11:52:55.859139Z] Finished create-virtualenv step (success) 04:52:55 INFO - [mozharness: 2017-04-24 11:52:55.860104Z] Running install step. 04:52:55 INFO - Running pre-action listener: _resource_record_pre_action 04:52:55 INFO - Running main action method: install 04:52:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:52:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:52:56 INFO - Reading from file tmpfile_stdout 04:52:56 INFO - Detecting whether we're running mozinstall >=1.0... 04:52:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:52:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:52:56 INFO - Reading from file tmpfile_stdout 04:52:56 INFO - Output received: 04:52:56 INFO - Usage: mozinstall [options] installer 04:52:56 INFO - Options: 04:52:56 INFO - -h, --help show this help message and exit 04:52:56 INFO - -d DEST, --destination=DEST 04:52:56 INFO - Directory to install application into. [default: 04:52:56 INFO - "/builds/slave/test"] 04:52:56 INFO - --app=APP Application being installed. [default: firefox] 04:52:56 INFO - mkdir: /builds/slave/test/build/application 04:52:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:52:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:53:15 INFO - Reading from file tmpfile_stdout 04:53:15 INFO - Output received: 04:53:15 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:53:15 INFO - Running post-action listener: _resource_record_post_action 04:53:15 INFO - [mozharness: 2017-04-24 11:53:15.857915Z] Finished install step (success) 04:53:15 INFO - [mozharness: 2017-04-24 11:53:15.858066Z] Running run-tests step. 04:53:15 INFO - Running pre-action listener: _resource_record_pre_action 04:53:15 INFO - Running main action method: run_tests 04:53:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:53:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:53:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:53:15 INFO - 2017-04-24 04:53:15.872 screenresolution[1626:7608] starting screenresolution argv=screenresolution get 04:53:15 INFO - 2017-04-24 04:53:15.875 screenresolution[1626:7608] Display 0: 1600x1200x32@60 04:53:15 INFO - 2017-04-24 04:53:15.881 screenresolution[1627:7611] starting screenresolution argv=screenresolution list 04:53:15 INFO - Available Modes on Display 0 04:53:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:53:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:53:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:53:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:53:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:53:16 INFO - Intel Iris: 04:53:16 INFO - Chipset Model: Intel Iris 04:53:16 INFO - Type: GPU 04:53:16 INFO - Bus: Built-In 04:53:16 INFO - VRAM (Dynamic, Max): 1536 MB 04:53:16 INFO - Vendor: Intel (0x8086) 04:53:16 INFO - Device ID: 0x0a2e 04:53:16 INFO - Revision ID: 0x0009 04:53:16 INFO - Displays: 04:53:16 INFO - Display: 04:53:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:53:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:53:16 INFO - Display Serial Number: 1600x1200 60 04:53:16 INFO - Main Display: Yes 04:53:16 INFO - Mirror: Off 04:53:16 INFO - Online: Yes 04:53:16 INFO - Rotation: Supported 04:53:16 INFO - Return code: 0 04:53:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:53:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:53:16 INFO - Python 2.7.3 04:53:16 INFO - Return code: 0 04:53:16 INFO - grabbing minidump binary from tooltool 04:53:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:16 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 0x102d24d30>, '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 0x102c4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d19be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:53:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:53:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:53:16 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:53:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:53:16 INFO - Return code: 0 04:53:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:53:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:53:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:53:16 INFO - ENV: RUST_BACKTRACE is now 1 04:53:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:53:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:53:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0268', '--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 04:53:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0268 --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 04:53:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O9gJGn6wFE/Render', 04:53:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:16 INFO - 'HOME': '/Users/cltbld', 04:53:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:16 INFO - 'LOGNAME': 'cltbld', 04:53:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:53:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:16 INFO - 'MOZ_NO_REMOTE': '1', 04:53:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:53:16 INFO - 'NO_EM_RESTART': '1', 04:53:16 INFO - 'PAGER': '/bin/cat', 04:53:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:16 INFO - 'PWD': '/builds/slave/test', 04:53:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:53:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:16 INFO - 'RUST_BACKTRACE': '1', 04:53:16 INFO - 'SHELL': '/bin/bash', 04:53:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ov5B4tD4Yy/Listeners', 04:53:16 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 04:53:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:16 INFO - 'USER': 'cltbld', 04:53:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:16 INFO - 'XPC_FLAGS': '0x0', 04:53:16 INFO - 'XPC_SERVICE_NAME': '0', 04:53:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0268', '--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 04:53:16 INFO - mozversion application_buildid: 20170424032920 04:53:16 INFO - mozversion application_changeset: e17cbb839dd225a2da7e5d5bec43cf94e11749d8 04:53:16 INFO - mozversion application_display_name: Nightly 04:53:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:53:16 INFO - mozversion application_name: Firefox 04:53:16 INFO - mozversion application_remotingname: firefox 04:53:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:53:16 INFO - mozversion application_vendor: Mozilla 04:53:16 INFO - mozversion application_version: 55.0a1 04:53:16 INFO - mozversion platform_buildid: 20170424032920 04:53:16 INFO - mozversion platform_changeset: e17cbb839dd225a2da7e5d5bec43cf94e11749d8 04:53:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:53:16 INFO - mozversion platform_version: 55.0a1 04:53:16 INFO - using testdate: 1493034796 04:53:16 INFO - actual date: 1493034796 04:53:16 INFO - starting webserver on 'localhost:49244' 04:53:16 INFO - SUITE-START | Running 2 tests 04:53:16 INFO - TEST-START | dromaeo_css 04:53:16 INFO - operating with platform_type : mac_ 04:53:16 INFO - Initialising browser for dromaeo_css test... 04:53:16 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/tmp0FqiqX/profile http://localhost:49244/getInfo.html) 04:53:19 INFO - PID 1637 | 2017-04-24 04:53:19.344 plugin-container[1639:7796] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9837, name = 'com.apple.tsm.portname' 04:53:19 INFO - PID 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:53:19 INFO - PID 1637 | 2017-04-24 04:53:19.348 plugin-container[1639:7796] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c07, name = 'com.apple.CFPasteboardClient' 04:53:19 INFO - PID 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:53:19 INFO - PID 1637 | 2017-04-24 04:53:19.348 plugin-container[1639:7796] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:53:19 INFO - PID 1637 | __metrics Screen width/height:1600/1200 04:53:19 INFO - PID 1637 | colorDepth:24 04:53:19 INFO - PID 1637 | Browser inner width/height: 1024/689 04:53:19 INFO - PID 1637 | __metrics 04:53:19 ERROR - PID 1637 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 04:53:20 INFO - TEST-INFO | 1637: exit 0 04:53:20 INFO - Browser initialized. 04:53:20 INFO - Running cycle 1/1 for dromaeo_css test... 04:53:20 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/tmp0FqiqX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:53:23 INFO - PID 1640 | 2017-04-24 04:53:23.059 plugin-container[1641:7923] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x974b, name = 'com.apple.tsm.portname' 04:53:23 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:53:23 INFO - PID 1640 | 2017-04-24 04:53:23.060 plugin-container[1641:7923] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4413, name = 'com.apple.CFPasteboardClient' 04:53:23 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:53:23 INFO - PID 1640 | 2017-04-24 04:53:23.060 plugin-container[1641:7923] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:53:32 INFO - PID 1640 | RSS: Main: 236552192 04:53:32 INFO - PID 1640 | 04:56:36 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 04:56:38 INFO - PID 1640 | RSS: Main: 252280832 04:56:38 INFO - PID 1640 | 04:58:20 INFO - PID 1640 | ************************* 04:58:20 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 04:58:20 INFO - PID 1640 | 04:58:20 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:58:20 INFO - PID 1640 | Full stack: 04:58:20 INFO - PID 1640 | ************************* 04:58:20 INFO - PID 1640 | ************************* 04:58:20 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 04:58:20 INFO - PID 1640 | 04:58:20 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:58:20 INFO - PID 1640 | Full stack: 04:58:20 INFO - PID 1640 | ************************* 04:58:20 INFO - PID 1640 | ************************* 04:58:20 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 04:58:20 INFO - PID 1640 | 04:58:20 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:58:20 INFO - PID 1640 | Full stack: 04:58:20 INFO - PID 1640 | ************************* 04:58:20 INFO - PID 1640 | ************************* 04:58:20 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 04:58:20 INFO - PID 1640 | 04:58:20 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:58:20 INFO - PID 1640 | Full stack: 04:58:20 INFO - PID 1640 | ************************* 04:59:40 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 04:59:40 INFO - PID 1640 | RSS: Main: 257449984 04:59:40 INFO - PID 1640 | 05:02:42 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 05:02:43 INFO - PID 1640 | RSS: Main: 266043392 05:02:43 INFO - PID 1640 | 05:05:44 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 05:05:45 INFO - PID 1640 | RSS: Main: 260161536 05:05:45 INFO - PID 1640 | 05:08:48 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 05:08:49 INFO - PID 1640 | RSS: Main: 268861440 05:08:49 INFO - PID 1640 | 05:11:50 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 05:11:50 INFO - PID 1640 | RSS: Main: 263704576 05:11:50 INFO - PID 1640 | 05:11:50 INFO - PID 1640 | __start_tp_report 05:11:50 INFO - PID 1640 | _x_x_mozilla_page_load 05:11:50 INFO - PID 1640 | _x_x_mozilla_page_load_details 05:11:50 INFO - PID 1640 | |i|pagename|runs| 05:11:50 INFO - PID 1640 | |0;dojo.html;3619.2942376236642;3627.8004709740985;3633.927321453571;3664.0656632558703;3670.8164591770405;6112.47308512808;6258.561900666955;6284.905726414102;6300.2439707235135;6320.399562041599;4991.700497970115;6245.250569931614;6279.717412716427;6281.6545090020145;6358.332375100617;5470.972645136769;5524.171374293858;5573.331200255975;5582.771790206149;5626.549876009909;5464.0711079116645;5464.371597266306;5532;5602.1596760485845;5622.859428514299;4125.938110928339;5354.384245811703;5419.268398766156;5559.722013899329;5596;5444.265024221759;5456.072467680504;5456.345238571357;5477.75350109242;5542.501174894279;5398.460153984609;5442.102053161224;5453.945460545423;5491.2312276281355;5510.531604813596;5314.441983591706;6086.391360863922;6299.748010079591;6304.495640348761;6316.589421687621;5490.972545137249;6556.377144171296;6667.7666281680395;6679.833004174934;6746.696398662072;5743.942560574383;6874.690638921261;6907.723691052352;6918.927566227243;7016.087908571904;6259.561830671901;6380;6410.326915673833;6414.1340918976275;6424.775132870327;5282.260483532232;6805.829854253683;7050.788476345718;7054.611996340251;7070.540414873017;6379.872402551923;6607.80176594703;6666.500012499082;6681.064650948871;6754.358335958076;6855.6572171391235;6866.210385805696;6872.209695884937;6872.450203983769;6881.277465866112;6616.470682345401;6736.831579210559;6764.323567643295;6792.21889482706;6806.217285012188;5194.714290713971;5729.825385795902;6441.806745797634;6487.059376390397;6589.967050164719;4333.721552142063;5362.3565172178805;5365.356157261153;5368.516833485005;5374.838754837361;4801.927971080437;4802.135615589227;4835.685680430761;4836.782344794493;4837.927431088537;6106.6336019838955;6296.370362963667;6300.243970723543;6354.745810167541;6384.265809431882;6807.047013418125;6845.863082738318;6893.379595836399;6899.310068993161;6905.447564194953;6404.327545607737;6408.903866442007;6413.422791948747;6417.326180750954;6434.646094464756;5684.118961560965;5816.331121921034;5978.342382337939;5990.31111422192;6037.094435834572;5962.22491076166;6990.09128813251;6997.860042799217;7019.087518622547;7036.718531258693;6555.704993275219;6822.11312529368;6859.794206173623;6899.482538809509;6906.689198985957;6276.403741644536;6861.176658800976;7014.438844892498;7035.085438892911;7046;6390.584612000391;6453.9354606453335;6790.66046697673;6808.7276508939085;6820.3861652451515;6757.662116894037;6791.762288319885;6823.249442561413;6832.726690932506;6898.586084834926;6640.50196235294;6644.269130395749;6652.268250492345;6653.135092437952;6665.266820649822;6361.936380636134;6520.7391704333195;6674.499412543982;6678.899816502659;6690.899636505554;6315.052742088724;6339.936600633934;6433.195850518685;6447.9032814508755;6466.482681385572;6454.451371633464;6591.670416479061;6600.966995164993;6601.768938087336;6623.834404139935;6407.839804004937;6411.839704007437;6417.550771446141;6419.871602568016;6432.035194720829 05:11:50 INFO - PID 1640 | |1;ext.html;740.2264633458036;795.8686816675249;814.4176913506841;1184.431472893012;1205.7166565857017;30424.93512727055;34920.476192857124;36977;37355.81322093386;37482.43776343357;34688.95933122004;37101;37493.437598436045;37569.81215093927;37610.8119459403;7884.093329267122;8057.838843223132;8437.662493500253;8677.739667809945;8694.434861733998;8535.274501667365;8677.219050285474;8686.610142377222;8698.521581313025;8699.652013919436;8651.826963460728;8693.69572064978;8702.434341767797;8710.303175745958;8741.606627701736;8639.697610583631;8690.304775617935;8700.564971751388;8711.390202685814;8712.085231050743;8440.62017209227;8451.1548845115;8477.533735644538;8481.151884811532;8499.895013648247;36733;36889.26221475582;36979;37005.25989480195;37105.81447092747;3527.5414196154593;3551.1477245460906;3561.6972557332656;3561.82190890457;3566.696830769362;27174.320641984108;30040.648170832366;30338;30348.8482557588;30415.543766843515;3150.4329220740256;3181.284211052518;3192;3194.6965038321323;3204.3270913108277;296895;296932;297874;303624;305475;46961.29558056632;47017.29474057892;47028.29457558139;47120;47228.7638561805;49198;49364.50635493671;53556.66108347323;54386.45613543893;54398.72800636051;13179.934100329629;13987.860121398859;14099.224542650252;14104.08323458972;14106.365213565414;10310.948445257725;11308.09535237179;11359.261647992855;11374.260673056226;11530.01994830432;13677.384517696728;13751.724965500634;13780.724385512234;13799.03406761517;13817.378217980215;5139.922901156486;6150.600210986271;6162.26052873658;6166.136740856284;6197.845053873689;857.6612238166015;883.7172104926361;988.2143695761887;1020.3265844542566;1028.1825948371063;19077;20603.4849128773;24475.26574202741;24509.264722058368;25146.622800658006;900.7928176519438;1104.7403860092872;1120.3725913488472;1134.432783608196;1175.6590588729343;10603.734906627396;12704.555340563036;12735.490580376867;12778.936105319413;12793.552225672056;340844;342482.2875885605;343131;343364;345180;48330.5166948326;48598.75700621474;48693;48747;48838;1495.5289083938524;1496.2144873941268;1527.5417374787742;1553.7980062591791;1581.533447632951;17266.482005539852;19769.604607908048;23314.950827213157;24212.515749684557;24356.391090222885;31694.683053169174;36998;37064.814675927526;37099;37210.44184337183;292797.072029277;292806;292852;293695;294526;34882;35269.64730352664;35296;35331.82334088313;35344;43524.476643317335;44457.33198014162;44498.88752781206;44553.55446445494;44631.884202895184;29427.559869519704;29867.954621588142;30321.24196895095;30665.693343066283;31030.603622836574;30104.698953011066;30335.69664303417;30515.694843051286;30570.388592227588;30984.22539436532;35960.46059309165;36006.8199659;36735.63264367322;37079.8146009279;37162.62837371592;30006.099817005525;30186.094417167522;30781.538276925417;30874.91937782167;31145.532817008218;22675.546489070457;24081.036758529463;24319.756802432457;24509.754902450746;24520 05:11:50 INFO - PID 1640 | |2;jquery.html;441.08695001347223;446.2703479810511;446.5891379930463;463.38601353206997;465.0907475884646;15154.31805568748;19025.619487610275;21217.257395991124;21298.740251949595;21568.291261089584;21493.892530537363;22149.137056345007;22425.327240182778;22536.873156342157;23298.767012329914;6043.909341359883;6172;6196.039613859836;6256.593321434115;6257.780977665782;4929.556339929406;5734.168545560891;5994.790182343619;6055.666938318391;6155.19982402287;5930.466258036776;6059.333473317932;6121.296050954153;6142.3550527194675;6163.229596300463;6040.728167232463;6168.537359697995;6179.87640247197;6186.010238361863;6187.845303867394;5385.703786291752;5456.863578410532;5474.671519708831;5488.313960754906;5514.531264842493;27304;27665.723342766716;27782.583261251097;28140;28404;2210.8673479591275;2268.138107519132;2283.360659015478;2285.2915596165244;2287.97712022881;17698.823011769848;17722.468325950114;17788.37740679083;18187.909060454745;18246.726299105525;2171.7828217178158;2189.8029177373955;2224.065892325227;2224.154821167962;2228.1198926424136;132554;163307;164531;165393;167613.323866761;10888.891111088946;12165.391730413445;12703.30131842739;12843.550475733304;12874.034447416481;13471.797923031163;16764.664706705797;16842.494725158263;16843.831561684226;16851.74722379165;7203;8660.48441522731;8968.461892286483;9028.774280643036;9081.364304498753;8214.383921205934;8324.542150181798;8496.192861678132;8520.57397130141;8531.786705332417;7739.419543534257;7984.281414672707;8017.599120043975;8033.156518565466;8037.995250593675;2196.7473740520045;2206.316042026977;2206.9779302207094;2208.3485371815354;2396.808255339569;806.5926707013039;897.7441429192648;970.2432102959702;976.1946394224793;977.398899676708;21262.78737212608;21299.68050479244;21397.144114235256;21425.892870535547;21914.342569722932;968.8740463739668;1005.8440941654055;1033.2199189611945;1035.254616675992;1039.9636012739518;10807.567697292177;11190.496427660775;11228.887711122947;11279.210455268216;11294.265872718248;549524;554024;557423;565711;567301;126674;127463;130615.38769224752;131187;134178.6582134166;1086.7337502311984;1225.9141860069888;1264.0456455376132;1265.3862876504888;1266.468083404972;20152;20672;21534.246301379375;21914.67127993113;22486;56504.434955649915;57033.837938542165;57083.14375284291;57531.42468575261;57686.711566441896;68666;75709;76018.23981760333;76204;76458;9050.094990500897;9061.003289638003;9074.500902450429;9144.497052662167;9168.908310916806;13860.584182474542;13866.861331386557;14279.214643194724;14327.856721432652;14435.917306202287;11367.317960922372;11585.768284634429;12024.398780061138;12033;12051;8851.46891186531;9484.34024045803;10906.90930906903;11237.60668376603;11281.21031527785;11998.280103193836;12188.695282618006;12230.327331996825;12256.693582660504;12269.815952760895;9060.773480663036;9067;9070;9130.771730706785;9144.3598948073;11038.282511636718;11820.23168494045;11984.46069926838;12034.518619255481;12177.878221217674 05:11:51 INFO - PID 1640 | |3;mootools.html;1230.3725100198897;1332.8800407963288;1387.2578170678685;1440.6254373862791;1451.4266864588487;9819.852702209455;9822.705318840428;11568.421578921052;11963;12011.099167562435;11953.880461195386;12027.398630068483;12083.033357331415;12108.576199833007;12115.212511186766;2557.207265747615;2588.4823035392997;2602.921912342633;2605.114261151208;2612.5428050091255;2536.7336429674897;2575.240304110292;2580.845149291039;2584.5993870950033;2586.922392328233;2535.2014115553543;2549.592065269557;2594.520013797444;2594.7275536068723;2597.4545345477472;2515.5975043992967;2527.7093134289607;2554.1315952576215;2562.0776520452714;2564.9615255771178;2009.6583580791155;2464.7042354917344;2528.8356256843244;2529.6332031855277;2578.793696504275;11974.042076633848;12057.758844823054;12075.396230188544;12081.57714479989;12089.818652720216;6527.640979746112;6689.096971908779;6698.727241824038;6745.29174436682;6754;4007.7194596378267;4371.540988196257;4410.933835992462;4447;4493.370928070073;1277.4123903004536;1279.3986826191674;1293.4696774322576;1312.2257867857913;1317.426919290112;16452.588685282844;16910.492685219462;17016.574585635335;17028.914855425643;17121.400750973655;5705.885882282331;5789.102689083199;5817.941820581825;5917.911231331534;5964.433378829091;12382.62852114438;12389;12404.62786116418;12426.875731242753;12435.626931192079;5476.561875049986;6643.10318107059;6726.899096513556;6743.831404214934;6767.830804229934;6113.23584551931;6194.101855231056;6204.37956204385;6319.494440444753;6335.809925702236;4266.786660666954;4423.071155057474;4436.423264975532;4442.5557444255965;4457.442819647544;1203.4704729918808;1235.6037677424454;1296.4554886947506;1330.5476138113088;1336.3652265173964;593.896068188074;770.6878714120791;782.2646712090617;810.1452967119627;810.6352141536332;6443.4523065539015;6574.506911981621;6992.475564332695;7118.430525557943;7128.679209435588;744.4863044499278;902.251131560803;927.9814403711888;967.3663750243602;980.4411485453365;3911.647951684305;3918.549366822795;3993.3211354069877;4212.978935105305;4403.867883963486;12497.87502124967;14874;15008.24958752058;15216.163111029;15272.083674979536;10892.836607450894;12336.013118950463;15048.247587620794;15147;15149.621259468602;7038.542494737826;7925.405594580429;8526.616302266413;8774.649014039367;8777.956110219407;5842.678652674143;6208.596441231305;6560.901586476111;6988.720451181895;7121.118990150277;9505.809883802147;12943.288119153536;12997.220166790023;13056.477740890257;13807.930960345135;13260.469581217028;13949.790753138508;13959.604039595959;13978.510752123628;14135.717285654435;9434.245260379015;9492.905070949202;9623.5669394876;9667.70996870095;9707.805843883225;10734.14126869833;10957.397343146204;10992.340459572451;11018.944905275423;11047.226694131656;9118.22495087925;9206.631734730803;9255.76860578491;9347.953260233928;9423.811523769624;8951.507667078373;8994.640214391351;9026.729198124067;9105.362624616213;9223.031581683827;6969.7909062728195;8208.425410221465;8248.257656810916;8445.028821685584;8514.659413623385;5083.669561478492;5749.223854779551;5850.356460789225;6139.2325959255095;6228.34602366745;6140.355262697352;6246.250449946036;6266.342034086538;6280.434760871543;6372.713227904663 05:11:51 INFO - PID 1640 | |4;prototype.html;350.53203972696446;414.8859063757468;417.22604568525384;424.2384919070267;427.510500476954;5290.8889133282055;6242.500599952004;6264;6380.744770209192;6425.582337148082;5614.550835933126;5961.493273071783;6185.59793613416;6277.654728989904;6315.190025176837;3780.81095945203;4426.734395936238;4588.724676519403;4608.124456353299;4611.2621980483045;3807.562130355003;4571.702839315434;4612.930806037912;4616.53834616539;4625.259958406656;4580.885477863063;4593.955689718076;4597.793099310522;4599.586037256646;4609.654275929302;4474.328850672393;4528.298113792367;4549.567791059844;4588.862334129982;4604.217283061887;3583.372909740785;3908.6286802753693;3946.9013274668364;3955.129871428281;3966.5240171179353;4967.577755890754;6050.2134722486235;6089.0819391891855;6185.855616710923;6190.41191086846;3989.7432308822627;4761.428628564559;4831.130396528659;5185.55922746567;5428.2671839301975;6197.411245931629;6678.295290407393;6698.39714425704;6703.698333575001;6725.8654826903185;3549.473726297691;4496.8875778105485;4498.6626003049905;4498.730076195438;4503.48209955856;5918.704064796786;6074.726637301332;6498.642574658392;6792.6943287551685;6991;3999.900002499961;4465.196264672325;4534.433195850519;4543.61379282758;4561.156186105581;4619.722816631013;4623;4623.352730617717;4633.72197668141;4676.415448068991;5225.581953443715;5320.838786377208;5408.486193811582;5445.428230035868;5495.340559132929;5043.773030213576;5933.436323549256;6384.553081284358;6573.276939536647;6749.831254218586;1378.7518246715488;1406.9648258793407;1505.6449195723935;1555.844415558435;1586.5240427871593;971.7376308396694;980.8132160086376;993.3046867192994;1019.5717798524637;1054.4991129213563;5299.947000529945;5970.373110823388;6286.4342209201395;6288.465480434214;6309.274433440213;6952.5480843745;6956.756513522002;6996.860062798715;7011.964940175267;7014;6002;6240.906386404207;6263.874722505524;6352.522516218678;6357.205349331333;3609.2601016791496;3659.798711070917;3660.139867131222;3671.908202294964;3779.903827889936;5518.944810551923;6099.2680878294;6341.651209183447;7170.175429825533;7182.281771822776;5958.957182493046;6135.447809697149;6984.2317345092;7259.805685498364;7275.745348912868;6246.843828904223;6686.598804071771;6818.28408017161;7057;7112.679929403189;6148.815535533762;6376.362363763772;6385.425311721968;6958.095447591781;6966.756163534252;5352.705601191972;6434.8391290218115;6718.93281067183;6886.001529778255;6927.861442771217;5681.801136960186;6361.968190159019;6543.1821022372205;7003.669302832445;7269.600171990592;4125.525564560114;4523.778579783374;4525.253333199985;4568.0536054245495;4575.313702944585;5564.944350556604;6276.560640755103;6992.475564332593;7040.225575186623;7074.398676112588;6717.193936727624;6737.562058466184;6749;6750.72997080131;6754.8649027020165;5320.627556071193;6707.216505150308;6734.629595372302;6750.729970801113;6812.795616131524;5253.605979551472;5534.335879694462;5746.080627099644;6670.966000269966;6731.697073631601;6219.875602488016;6808.523403361717;6822.215445223665;6833.897491537531;6857.828554286183;6209.844753881189;6475.352464753487;6541.397357647407;6569.540132190701;6576.408123268738 05:11:51 INFO - PID 1640 | |5;yui.html;828.2131974624109;833.433265379542;853.7652145659943;854.918782715642;882.1178821178821;13761.931190344047;15495.992760470575;16803.24385402657;18457.446276611725;19127.330543430984;17614.20736066877;17682.82317176828;17738.29046838128;17827.821721782777;18434.907825460854;960.0543464687278;970.8932017478072;975.7072878136566;979.5347210075229;980.2648013989508;965.6330594374128;971.5482300730159;981.9656312029081;983.9754006149832;990.866233058535;1028.9742756431074;1030.3663247103052;1032.2052019944676;1032.6179313653959;1039.552992213348;1009.6264382178567;1010.8231059564547;1012.0739523336139;1013.9340942838692;1018.9847152292684;737.5316673912051;746.6528064450057;758.1281526244808;765.9463837531375;772.5480593852603;16460;16587.668246635;16637;16638.50084497467;16725.916370418192;16355.918220408941;16511.587210319718;16894.07082610456;17085.402010929556;17101.059441730824;11494.94252528732;13983.440662373492;13991.16053036821;14132.576022719335;14142.151470911778;3473.70473509752;3473.826308684581;3536.0275924120815;3537.4693795930557;3540.309639620275;117451;124369.29414940957;137864;141163;143294;13093.869061309266;13111;13244.20534767917;13252.27112508802;13278.402471888596;24937.62593561098;25113.62329565058;25363.74636253651;25591.23226303214;25612.231633051037;6687.896497077928;7596.620168991528;7627.8855817162785;7705.460617756816;7745.651445684957;3340.1315657928626;3827.5024246847734;3926.705497087673;3959.1685745993664;3992.8802135935966;3610.6389361064207;4297.119090586422;4349.630281426051;4369.2790689536505;4380.824767009284;779.9003405198756;841.3605659698551;878.3763527895265;886.1315910407836;886.4592598514901;658.7793089315037;671.1979184874028;672.331030624522;682.7644462660375;692.7402224165937;10967.232293739362;11668;11874.525018999317;11985.28088314704;12152.149349545447;572.8825590753886;649.376598465469;663.4957432351351;668.4785867023729;686.2588404523103;5435.565154787608;5540.944590554042;5593.608447408724;5608.1587761835235;5645.5201307888465;96237.51881240548;97533;106493;108050;109993.45003274933;95630;98028.05915822537;98719.50640246752;99720;100717.49641251893;82873.58563207266;84081.57959210165;84134.57932710297;84645.73031404534;84759.15240847513;10700.68278833564;10958.945205273923;11228.157888158585;11265;11416.94291528537;41442.58557414508;41864.790676046425;42200.78899605482;42222.57777422309;42312;78153;79026.81459777993;79514.60242698749;81968.59015704883;83598;16935.32258709687;17140.228689708743;17144.571385714957;17277;17772.46682599524;18581.814181858008;18593.814061859208;18673.253069877053;18891.716624250374;19005.954672492593;17191.7421238679;17349.73975390345;17395.91302043482;17514;17585.384511542034;17429;17628.471145865133;17637.647247055243;17780.288788448317;17835.46493605194;16464.917675411547;16588.336466541205;17075.743863841803;17107.48677539676;17273.91363043177;11768.293902365886;11830.881691182978;12287.955523780578;12335.239002699827;12376.009919206623;11596.768064638829;12000.75998480043;13241.404136813673;13393;14246.21645809449 05:11:51 INFO - PID 1640 | __end_tp_report 05:11:51 INFO - PID 1640 | __start_cc_report 05:11:51 INFO - PID 1640 | _x_x_mozilla_cycle_collect,426 05:11:51 INFO - PID 1640 | __end_cc_report 05:11:51 INFO - PID 1640 | __startTimestamp1493035910990__endTimestamp 05:11:51 INFO - PID 1640 | 05:11:51 INFO - PID 1640 | ------- Summary: start ------- 05:11:51 INFO - PID 1640 | Number of tests: 6 05:11:51 INFO - PID 1640 | 05:11:51 INFO - PID 1640 | [#0] dojo.html Cycles:165 Average:6173.40 Median:6410.33 stddev:768.01 (12.0%) stddev-sans-first:743.77 05:11:51 INFO - PID 1640 | Values: 3619.3 3627.8 3633.9 3664.1 3670.8 6112.5 6258.6 6284.9 6300.2 6320.4 4991.7 6245.3 6279.7 6281.7 6358.3 5471.0 5524.2 5573.3 5582.8 5626.5 5464.1 5464.4 5532.0 5602.2 5622.9 4125.9 5354.4 5419.3 5559.7 5596.0 5444.3 5456.1 5456.3 5477.8 5542.5 5398.5 5442.1 5453.9 5491.2 5510.5 5314.4 6086.4 6299.7 6304.5 6316.6 5491.0 6556.4 6667.8 6679.8 6746.7 5743.9 6874.7 6907.7 6918.9 7016.1 6259.6 6380.0 6410.3 6414.1 6424.8 5282.3 6805.8 7050.8 7054.6 7070.5 6379.9 6607.8 6666.5 6681.1 6754.4 6855.7 6866.2 6872.2 6872.5 6881.3 6616.5 6736.8 6764.3 6792.2 6806.2 5194.7 5729.8 6441.8 6487.1 6590.0 4333.7 5362.4 5365.4 5368.5 5374.8 4801.9 4802.1 4835.7 4836.8 4837.9 6106.6 6296.4 6300.2 6354.7 6384.3 6807.0 6845.9 6893.4 6899.3 6905.4 6404.3 6408.9 6413.4 6417.3 6434.6 5684.1 5816.3 5978.3 5990.3 6037.1 5962.2 6990.1 6997.9 7019.1 7036.7 6555.7 6822.1 6859.8 6899.5 6906.7 6276.4 6861.2 7014.4 7035.1 7046.0 6390.6 6453.9 6790.7 6808.7 6820.4 6757.7 6791.8 6823.2 6832.7 6898.6 6640.5 6644.3 6652.3 6653.1 6665.3 6361.9 6520.7 6674.5 6678.9 6690.9 6315.1 6339.9 6433.2 6447.9 6466.5 6454.5 6591.7 6601.0 6601.8 6623.8 6407.8 6411.8 6417.6 6419.9 6432.0 05:11:51 INFO - PID 1640 | 05:11:51 INFO - PID 1640 | [#1] ext.html Cycles:180 Average:45740.72 Median:34785.48 stddev:82213.52 (236.3%) stddev-sans-first:82374.72 05:11:51 INFO - PID 1640 | Values: 740.2 795.9 814.4 1184.4 1205.7 30424.9 34920.5 36977.0 37355.8 37482.4 34689.0 37101.0 37493.4 37569.8 37610.8 7884.1 8057.8 8437.7 8677.7 8694.4 8535.3 8677.2 8686.6 8698.5 8699.7 8651.8 8693.7 8702.4 8710.3 8741.6 8639.7 8690.3 8700.6 8711.4 8712.1 8440.6 8451.2 8477.5 8481.2 8499.9 36733.0 36889.3 36979.0 37005.3 37105.8 3527.5 3551.1 3561.7 3561.8 3566.7 27174.3 30040.6 30338.0 30348.8 30415.5 3150.4 3181.3 3192.0 3194.7 3204.3 296895.0 296932.0 297874.0 303624.0 305475.0 46961.3 47017.3 47028.3 47120.0 47228.8 49198.0 49364.5 53556.7 54386.5 54398.7 13179.9 13987.9 14099.2 14104.1 14106.4 10310.9 11308.1 11359.3 11374.3 11530.0 13677.4 13751.7 13780.7 13799.0 13817.4 5139.9 6150.6 6162.3 6166.1 6197.8 857.7 883.7 988.2 1020.3 1028.2 19077.0 20603.5 24475.3 24509.3 25146.6 900.8 1104.7 1120.4 1134.4 1175.7 10603.7 12704.6 12735.5 12778.9 12793.6 340844.0 342482.3 343131.0 343364.0 345180.0 48330.5 48598.8 48693.0 48747.0 48838.0 1495.5 1496.2 1527.5 1553.8 1581.5 17266.5 19769.6 23315.0 24212.5 24356.4 31694.7 36998.0 37064.8 37099.0 37210.4 292797.1 292806.0 292852.0 293695.0 294526.0 34882.0 35269.6 35296.0 35331.8 35344.0 43524.5 44457.3 44498.9 44553.6 44631.9 29427.6 29868.0 30321.2 30665.7 31030.6 30104.7 30335.7 30515.7 30570.4 30984.2 35960.5 36006.8 36735.6 37079.8 37162.6 30006.1 30186.1 30781.5 30874.9 31145.5 22675.5 24081.0 24319.8 24509.8 24520.0 05:11:51 INFO - PID 1640 | 05:11:51 INFO - PID 1640 | [#2] jquery.html Cycles:180 Average:35916.58 Median:12402.51 stddev:94797.97 (764.3%) stddev-sans-first:95026.48 05:11:51 INFO - PID 1640 | Values: 441.1 446.3 446.6 463.4 465.1 15154.3 19025.6 21217.3 21298.7 21568.3 21493.9 22149.1 22425.3 22536.9 23298.8 6043.9 6172.0 6196.0 6256.6 6257.8 4929.6 5734.2 5994.8 6055.7 6155.2 5930.5 6059.3 6121.3 6142.4 6163.2 6040.7 6168.5 6179.9 6186.0 6187.8 5385.7 5456.9 5474.7 5488.3 5514.5 27304.0 27665.7 27782.6 28140.0 28404.0 2210.9 2268.1 2283.4 2285.3 2288.0 17698.8 17722.5 17788.4 18187.9 18246.7 2171.8 2189.8 2224.1 2224.2 2228.1 132554.0 163307.0 164531.0 165393.0 167613.3 10888.9 12165.4 12703.3 12843.6 12874.0 13471.8 16764.7 16842.5 16843.8 16851.7 7203.0 8660.5 8968.5 9028.8 9081.4 8214.4 8324.5 8496.2 8520.6 8531.8 7739.4 7984.3 8017.6 8033.2 8038.0 2196.7 2206.3 2207.0 2208.3 2396.8 806.6 897.7 970.2 976.2 977.4 21262.8 21299.7 21397.1 21425.9 21914.3 968.9 1005.8 1033.2 1035.3 1040.0 10807.6 11190.5 11228.9 11279.2 11294.3 549524.0 554024.0 557423.0 565711.0 567301.0 126674.0 127463.0 130615.4 131187.0 134178.7 1086.7 1225.9 1264.0 1265.4 1266.5 20152.0 20672.0 21534.2 21914.7 22486.0 56504.4 57033.8 57083.1 57531.4 57686.7 68666.0 75709.0 76018.2 76204.0 76458.0 9050.1 9061.0 9074.5 9144.5 9168.9 13860.6 13866.9 14279.2 14327.9 14435.9 11367.3 11585.8 12024.4 12033.0 12051.0 8851.5 9484.3 10906.9 11237.6 11281.2 11998.3 12188.7 12230.3 12256.7 12269.8 9060.8 9067.0 9070.0 9130.8 9144.4 11038.3 11820.2 11984.5 12034.5 12177.9 05:11:51 INFO - PID 1640 | 05:11:51 INFO - PID 1640 | [#3] mootools.html Cycles:180 Average:7112.99 Median:4110.35 stddev:4474.17 (108.9%) stddev-sans-first:4464.88 05:11:51 INFO - PID 1640 | Values: 1230.4 1332.9 1387.3 1440.6 1451.4 9819.9 9822.7 11568.4 11963.0 12011.1 11953.9 12027.4 12083.0 12108.6 12115.2 2557.2 2588.5 2602.9 2605.1 2612.5 2536.7 2575.2 2580.8 2584.6 2586.9 2535.2 2549.6 2594.5 2594.7 2597.5 2515.6 2527.7 2554.1 2562.1 2565.0 2009.7 2464.7 2528.8 2529.6 2578.8 11974.0 12057.8 12075.4 12081.6 12089.8 6527.6 6689.1 6698.7 6745.3 6754.0 4007.7 4371.5 4410.9 4447.0 4493.4 1277.4 1279.4 1293.5 1312.2 1317.4 16452.6 16910.5 17016.6 17028.9 17121.4 5705.9 5789.1 5817.9 5917.9 5964.4 12382.6 12389.0 12404.6 12426.9 12435.6 5476.6 6643.1 6726.9 6743.8 6767.8 6113.2 6194.1 6204.4 6319.5 6335.8 4266.8 4423.1 4436.4 4442.6 4457.4 1203.5 1235.6 1296.5 1330.5 1336.4 593.9 770.7 782.3 810.1 810.6 6443.5 6574.5 6992.5 7118.4 7128.7 744.5 902.3 928.0 967.4 980.4 3911.6 3918.5 3993.3 4213.0 4403.9 12497.9 14874.0 15008.2 15216.2 15272.1 10892.8 12336.0 15048.2 15147.0 15149.6 7038.5 7925.4 8526.6 8774.6 8778.0 5842.7 6208.6 6560.9 6988.7 7121.1 9505.8 12943.3 12997.2 13056.5 13807.9 13260.5 13949.8 13959.6 13978.5 14135.7 9434.2 9492.9 9623.6 9667.7 9707.8 10734.1 10957.4 10992.3 11018.9 11047.2 9118.2 9206.6 9255.8 9348.0 9423.8 8951.5 8994.6 9026.7 9105.4 9223.0 6969.8 8208.4 8248.3 8445.0 8514.7 5083.7 5749.2 5850.4 6139.2 6228.3 6140.4 6246.3 6266.3 6280.4 6372.7 05:11:51 INFO - PID 1640 | 05:11:51 INFO - PID 1640 | [#4] prototype.html Cycles:180 Average:5321.40 Median:6026.11 stddev:1676.59 (27.8%) stddev-sans-first:1639.26 05:11:51 INFO - PID 1640 | Values: 350.5 414.9 417.2 424.2 427.5 5290.9 6242.5 6264.0 6380.7 6425.6 5614.6 5961.5 6185.6 6277.7 6315.2 3780.8 4426.7 4588.7 4608.1 4611.3 3807.6 4571.7 4612.9 4616.5 4625.3 4580.9 4594.0 4597.8 4599.6 4609.7 4474.3 4528.3 4549.6 4588.9 4604.2 3583.4 3908.6 3946.9 3955.1 3966.5 4967.6 6050.2 6089.1 6185.9 6190.4 3989.7 4761.4 4831.1 5185.6 5428.3 6197.4 6678.3 6698.4 6703.7 6725.9 3549.5 4496.9 4498.7 4498.7 4503.5 5918.7 6074.7 6498.6 6792.7 6991.0 3999.9 4465.2 4534.4 4543.6 4561.2 4619.7 4623.0 4623.4 4633.7 4676.4 5225.6 5320.8 5408.5 5445.4 5495.3 5043.8 5933.4 6384.6 6573.3 6749.8 1378.8 1407.0 1505.6 1555.8 1586.5 971.7 980.8 993.3 1019.6 1054.5 5299.9 5970.4 6286.4 6288.5 6309.3 6952.5 6956.8 6996.9 7012.0 7014.0 6002.0 6240.9 6263.9 6352.5 6357.2 3609.3 3659.8 3660.1 3671.9 3779.9 5518.9 6099.3 6341.7 7170.2 7182.3 5959.0 6135.4 6984.2 7259.8 7275.7 6246.8 6686.6 6818.3 7057.0 7112.7 6148.8 6376.4 6385.4 6958.1 6966.8 5352.7 6434.8 6718.9 6886.0 6927.9 5681.8 6362.0 6543.2 7003.7 7269.6 4125.5 4523.8 4525.3 4568.1 4575.3 5564.9 6276.6 6992.5 7040.2 7074.4 6717.2 6737.6 6749.0 6750.7 6754.9 5320.6 6707.2 6734.6 6750.7 6812.8 5253.6 5534.3 5746.1 6671.0 6731.7 6219.9 6808.5 6822.2 6833.9 6857.8 6209.8 6475.4 6541.4 6569.5 6576.4 05:11:51 INFO - PID 1640 | 05:11:51 INFO - PID 1640 | [#5] yui.html Cycles:180 Average:23051.27 Median:18782.48 stddev:32942.99 (175.4%) stddev-sans-first:32993.14 05:11:51 INFO - PID 1640 | Values: 828.2 833.4 853.8 854.9 882.1 13761.9 15496.0 16803.2 18457.4 19127.3 17614.2 17682.8 17738.3 17827.8 18434.9 960.1 970.9 975.7 979.5 980.3 965.6 971.5 982.0 984.0 990.9 1029.0 1030.4 1032.2 1032.6 1039.6 1009.6 1010.8 1012.1 1013.9 1019.0 737.5 746.7 758.1 765.9 772.5 16460.0 16587.7 16637.0 16638.5 16725.9 16355.9 16511.6 16894.1 17085.4 17101.1 11494.9 13983.4 13991.2 14132.6 14142.2 3473.7 3473.8 3536.0 3537.5 3540.3 117451.0 124369.3 137864.0 141163.0 143294.0 13093.9 13111.0 13244.2 13252.3 13278.4 24937.6 25113.6 25363.7 25591.2 25612.2 6687.9 7596.6 7627.9 7705.5 7745.7 3340.1 3827.5 3926.7 3959.2 3992.9 3610.6 4297.1 4349.6 4369.3 4380.8 779.9 841.4 878.4 886.1 886.5 658.8 671.2 672.3 682.8 692.7 10967.2 11668.0 11874.5 11985.3 12152.1 572.9 649.4 663.5 668.5 686.3 5435.6 5540.9 5593.6 5608.2 5645.5 96237.5 97533.0 106493.0 108050.0 109993.5 95630.0 98028.1 98719.5 99720.0 100717.5 82873.6 84081.6 84134.6 84645.7 84759.2 10700.7 10958.9 11228.2 11265.0 11416.9 41442.6 41864.8 42200.8 42222.6 42312.0 78153.0 79026.8 79514.6 81968.6 83598.0 16935.3 17140.2 17144.6 17277.0 17772.5 18581.8 18593.8 18673.3 18891.7 19006.0 17191.7 17349.7 17395.9 17514.0 17585.4 17429.0 17628.5 17637.6 17780.3 17835.5 16464.9 16588.3 17075.7 17107.5 17273.9 11768.3 11830.9 12288.0 12335.2 12376.0 11596.8 12000.8 13241.4 13393.0 14246.2 05:11:51 INFO - PID 1640 | -------- Summary: end -------- 05:11:51 INFO - PID 1640 | 05:11:51 INFO - TEST-INFO | 1640: exit 0 05:11:51 INFO - TEST-OK | dromaeo_css | took 1115124ms 05:11:51 INFO - TEST-START | kraken 05:11:51 INFO - operating with platform_type : mac_ 05:11:51 INFO - Initialising browser for kraken test... 05:11:51 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/tmpZzHRIk/profile http://localhost:49244/getInfo.html) 05:11:54 INFO - PID 1653 | 2017-04-24 05:11:54.302 plugin-container[1654:10548] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4547, name = 'com.apple.tsm.portname' 05:11:54 INFO - PID 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:11:54 INFO - PID 1653 | 2017-04-24 05:11:54.305 plugin-container[1654:10548] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4613, name = 'com.apple.CFPasteboardClient' 05:11:54 INFO - PID 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:11:54 INFO - PID 1653 | 2017-04-24 05:11:54.305 plugin-container[1654:10548] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:11:54 INFO - PID 1653 | __metrics Screen width/height:1600/1200 05:11:54 INFO - PID 1653 | colorDepth:24 05:11:54 INFO - PID 1653 | Browser inner width/height: 1024/689 05:11:54 INFO - PID 1653 | __metrics 05:11:54 ERROR - PID 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 05:11:55 INFO - TEST-INFO | 1653: exit 0 05:11:55 INFO - Browser initialized. 05:11:55 INFO - Running cycle 1/1 for kraken test... 05:11:55 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/tmpZzHRIk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:11:57 INFO - PID 1655 | 2017-04-24 05:11:57.972 plugin-container[1656:10674] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4543, name = 'com.apple.tsm.portname' 05:11:57 INFO - PID 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:11:57 INFO - PID 1655 | 2017-04-24 05:11:57.972 plugin-container[1656:10674] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x990b, name = 'com.apple.CFPasteboardClient' 05:11:57 INFO - PID 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:11:57 INFO - PID 1655 | 2017-04-24 05:11:57.972 plugin-container[1656:10674] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:12:07 INFO - PID 1655 | RSS: Main: 236404736 05:12:07 INFO - PID 1655 | 05:12:10 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 05:12:11 INFO - PID 1655 | RSS: Main: 249716736 05:12:11 INFO - PID 1655 | 05:12:14 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 05:12:14 INFO - PID 1655 | RSS: Main: 257753088 05:12:14 INFO - PID 1655 | 05:12:18 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 05:12:19 INFO - PID 1655 | RSS: Main: 260435968 05:12:19 INFO - PID 1655 | 05:12:21 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 05:12:21 INFO - PID 1655 | RSS: Main: 261312512 05:12:21 INFO - PID 1655 | 05:12:23 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:12:24 INFO - PID 1655 | RSS: Main: 261738496 05:12:24 INFO - PID 1655 | 05:12:27 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 05:12:27 INFO - PID 1655 | RSS: Main: 268783616 05:12:27 INFO - PID 1655 | 05:12:30 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 05:12:31 INFO - PID 1655 | RSS: Main: 269803520 05:12:31 INFO - PID 1655 | 05:12:34 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 05:12:35 INFO - PID 1655 | RSS: Main: 269914112 05:12:35 INFO - PID 1655 | 05:12:36 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:12:37 INFO - PID 1655 | RSS: Main: 269570048 05:12:37 INFO - PID 1655 | 05:12:39 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:12:40 INFO - PID 1655 | RSS: Main: 269651968 05:12:40 INFO - PID 1655 | 05:12:42 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:12:42 INFO - PID 1655 | RSS: Main: 269254656 05:12:42 INFO - PID 1655 | 05:12:45 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:12:46 INFO - PID 1655 | RSS: Main: 269832192 05:12:46 INFO - PID 1655 | 05:12:49 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:12:50 INFO - PID 1655 | RSS: Main: 269443072 05:12:50 INFO - PID 1655 | 05:12:52 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 05:12:52 INFO - PID 1655 | RSS: Main: 271224832 05:12:52 INFO - PID 1655 | 05:12:52 INFO - PID 1655 | __start_tp_report 05:12:52 INFO - PID 1655 | _x_x_mozilla_page_load 05:12:52 INFO - PID 1655 | _x_x_mozilla_page_load_details 05:12:52 INFO - PID 1655 | |i|pagename|runs| 05:12:52 INFO - PID 1655 | |0;ai-astar;105;116;113;121;120;96;167;168;145;115 05:12:52 INFO - PID 1655 | |1;audio-beat-detection;183;150;116;152;118;114;131;146;146;136 05:12:52 INFO - PID 1655 | |2;audio-dft;204;210;217;266;178;216;282;202;281;225 05:12:52 INFO - PID 1655 | |3;audio-fft;82;56;67;76;49;71;84;83;91;84 05:12:52 INFO - PID 1655 | |4;audio-oscillator;88;71;82;72;71;68;86;67;70;90 05:12:52 INFO - PID 1655 | |5;imaging-gaussian-blur;89;91;89;89;102;89;90;107;90;87 05:12:52 INFO - PID 1655 | |6;imaging-darkroom;96;97;95;96;95;122;135;155;94;96 05:12:52 INFO - PID 1655 | |7;imaging-desaturate;114;145;89;114;90;129;79;146;146;91 05:12:52 INFO - PID 1655 | |8;json-parse-financial;50;50;53;51;49;54;51;53;52;51 05:12:52 INFO - PID 1655 | |9;json-stringify-tinderbox;62;57;64;61;62;57;57;74;84;88 05:12:52 INFO - PID 1655 | |10;stanford-crypto-aes;82;85;96;110;106;79;83;83;81;87 05:12:52 INFO - PID 1655 | |11;stanford-crypto-ccm;135;148;138;127;124;169;164;157;196;138 05:12:52 INFO - PID 1655 | |12;stanford-crypto-pbkdf2;186;187;184;185;187;186;186;188;187;190 05:12:52 INFO - PID 1655 | |13;stanford-crypto-sha256-iterative;81;103;100;100;69;69;66;68;71;65 05:12:52 INFO - PID 1655 | __end_tp_report 05:12:52 INFO - PID 1655 | __start_cc_report 05:12:52 INFO - PID 1655 | _x_x_mozilla_cycle_collect,992 05:12:52 INFO - PID 1655 | __end_cc_report 05:12:52 INFO - PID 1655 | __startTimestamp1493035972387__endTimestamp 05:12:52 INFO - PID 1655 | 05:12:52 INFO - PID 1655 | ------- Summary: start ------- 05:12:52 INFO - PID 1655 | Number of tests: 14 05:12:52 INFO - PID 1655 | 05:12:52 INFO - PID 1655 | [#0] ai-astar Cycles:10 Average:126.60 Median:133.00 stddev:24.93 (18.7%) stddev-sans-first:25.19 05:12:52 INFO - PID 1655 | Values: 105.0 116.0 113.0 121.0 120.0 96.0 167.0 168.0 145.0 115.0 05:12:52 INFO - PID 1655 | 05:12:52 INFO - PID 1655 | [#1] audio-beat-detection Cycles:10 Average:139.20 Median:146.00 stddev:21.06 (14.4%) stddev-sans-first:15.25 05:12:52 INFO - PID 1655 | Values: 183.0 150.0 116.0 152.0 118.0 114.0 131.0 146.0 146.0 136.0 05:12:52 INFO - PID 1655 | 05:12:52 INFO - PID 1655 | [#2] audio-dft Cycles:10 Average:228.10 Median:221.00 stddev:35.78 (16.2%) stddev-sans-first:36.87 05:12:52 INFO - PID 1655 | Values: 204.0 210.0 217.0 266.0 178.0 216.0 282.0 202.0 281.0 225.0 05:12:52 INFO - PID 1655 | 05:12:52 INFO - PID 1655 | [#3] audio-fft Cycles:10 Average:74.30 Median:82.50 stddev:13.52 (16.4%) stddev-sans-first:14.05 05:12:52 INFO - PID 1655 | Values: 82.0 56.0 67.0 76.0 49.0 71.0 84.0 83.0 91.0 84.0 05:12:52 INFO - PID 1655 | 05:12:52 INFO - PID 1655 | [#4] audio-oscillator Cycles:10 Average:76.50 Median:77.00 stddev:8.95 (11.6%) stddev-sans-first:8.47 05:12:52 INFO - PID 1655 | Values: 88.0 71.0 82.0 72.0 71.0 68.0 86.0 67.0 70.0 90.0 05:12:52 INFO - PID 1655 | 05:12:52 INFO - PID 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:92.30 Median:89.00 stddev:6.62 (7.4%) stddev-sans-first:6.91 05:12:52 INFO - PID 1655 | Values: 89.0 91.0 89.0 89.0 102.0 89.0 90.0 107.0 90.0 87.0 05:12:52 INFO - PID 1655 | 05:12:52 INFO - PID 1655 | [#6] imaging-darkroom Cycles:10 Average:108.10 Median:95.50 stddev:21.66 (22.7%) stddev-sans-first:22.52 05:12:52 INFO - PID 1655 | Values: 96.0 97.0 95.0 96.0 95.0 122.0 135.0 155.0 94.0 96.0 05:12:52 INFO - PID 1655 | 05:12:52 INFO - PID 1655 | [#7] imaging-desaturate Cycles:10 Average:114.30 Median:112.50 stddev:26.22 (23.3%) stddev-sans-first:27.81 05:12:52 INFO - PID 1655 | Values: 114.0 145.0 89.0 114.0 90.0 129.0 79.0 146.0 146.0 91.0 05:12:52 INFO - PID 1655 | 05:12:52 INFO - PID 1655 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:51.50 stddev:1.58 (3.1%) stddev-sans-first:1.59 05:12:52 INFO - PID 1655 | Values: 50.0 50.0 53.0 51.0 49.0 54.0 51.0 53.0 52.0 51.0 05:12:52 INFO - PID 1655 | 05:12:52 INFO - PID 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:63.00 stddev:11.41 (18.1%) stddev-sans-first:11.98 05:12:52 INFO - PID 1655 | Values: 62.0 57.0 64.0 61.0 62.0 57.0 57.0 74.0 84.0 88.0 05:12:52 INFO - PID 1655 | 05:12:52 INFO - PID 1655 | [#10] stanford-crypto-aes Cycles:10 Average:89.20 Median:83.00 stddev:10.97 (13.2%) stddev-sans-first:11.32 05:12:52 INFO - PID 1655 | Values: 82.0 85.0 96.0 110.0 106.0 79.0 83.0 83.0 81.0 87.0 05:12:52 INFO - PID 1655 | 05:12:52 INFO - PID 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:149.60 Median:152.50 stddev:22.22 (14.6%) stddev-sans-first:22.93 05:12:52 INFO - PID 1655 | Values: 135.0 148.0 138.0 127.0 124.0 169.0 164.0 157.0 196.0 138.0 05:12:52 INFO - PID 1655 | 05:12:52 INFO - PID 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.60 Median:187.00 stddev:1.65 (0.9%) stddev-sans-first:1.73 05:12:52 INFO - PID 1655 | Values: 186.0 187.0 184.0 185.0 187.0 186.0 186.0 188.0 187.0 190.0 05:12:52 INFO - PID 1655 | 05:12:52 INFO - PID 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.20 Median:68.50 stddev:15.68 (22.9%) stddev-sans-first:16.61 05:12:52 INFO - PID 1655 | Values: 81.0 103.0 100.0 100.0 69.0 69.0 66.0 68.0 71.0 65.0 05:12:52 INFO - PID 1655 | -------- Summary: end -------- 05:12:52 INFO - PID 1655 | 05:12:53 INFO - TEST-INFO | 1655: exit 0 05:12:53 INFO - TEST-OK | kraken | took 61902ms 05:12:53 INFO - SUITE-END | took 1177s 05:12:53 INFO - Completed test suite (00:19:37) 05:12:53 INFO - javascript benchmark 05:12:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7914.7072102587435, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3619.2942376236642, 3627.8004709740985, 3633.927321453571, 3664.0656632558703, 3670.8164591770405, 6112.47308512808, 6258.561900666955, 6284.905726414102, 6300.2439707235135, 6320.399562041599, 4991.700497970115, 6245.250569931614, 6279.717412716427, 6281.6545090020145, 6358.332375100617, 5470.972645136769, 5524.171374293858, 5573.331200255975, 5582.771790206149, 5626.549876009909, 5464.0711079116645, 5464.371597266306, 5532.0, 5602.1596760485845, 5622.859428514299, 4125.938110928339, 5354.384245811703, 5419.268398766156, 5559.722013899329, 5596.0, 5444.265024221759, 5456.072467680504, 5456.345238571357, 5477.75350109242, 5542.501174894279, 5398.460153984609, 5442.102053161224, 5453.945460545423, 5491.2312276281355, 5510.531604813596, 5314.441983591706, 6086.391360863922, 6299.748010079591, 6304.495640348761, 6316.589421687621, 5490.972545137249, 6556.377144171296, 6667.7666281680395, 6679.833004174934, 6746.696398662072, 5743.942560574383, 6874.690638921261, 6907.723691052352, 6918.927566227243, 7016.087908571904, 6259.561830671901, 6380.0, 6410.326915673833, 6414.1340918976275, 6424.775132870327, 5282.260483532232, 6805.829854253683, 7050.788476345718, 7054.611996340251, 7070.540414873017, 6379.872402551923, 6607.80176594703, 6666.500012499082, 6681.064650948871, 6754.358335958076, 6855.6572171391235, 6866.210385805696, 6872.209695884937, 6872.450203983769, 6881.277465866112, 6616.470682345401, 6736.831579210559, 6764.323567643295, 6792.21889482706, 6806.217285012188, 5194.714290713971, 5729.825385795902, 6441.806745797634, 6487.059376390397, 6589.967050164719, 4333.721552142063, 5362.3565172178805, 5365.356157261153, 5368.516833485005, 5374.838754837361, 4801.927971080437, 4802.135615589227, 4835.685680430761, 4836.782344794493, 4837.927431088537, 6106.6336019838955, 6296.370362963667, 6300.243970723543, 6354.745810167541, 6384.265809431882, 6807.047013418125, 6845.863082738318, 6893.379595836399, 6899.310068993161, 6905.447564194953, 6404.327545607737, 6408.903866442007, 6413.422791948747, 6417.326180750954, 6434.646094464756, 5684.118961560965, 5816.331121921034, 5978.342382337939, 5990.31111422192, 6037.094435834572, 5962.22491076166, 6990.09128813251, 6997.860042799217, 7019.087518622547, 7036.718531258693, 6555.704993275219, 6822.11312529368, 6859.794206173623, 6899.482538809509, 6906.689198985957, 6276.403741644536, 6861.176658800976, 7014.438844892498, 7035.085438892911, 7046.0, 6390.584612000391, 6453.9354606453335, 6790.66046697673, 6808.7276508939085, 6820.3861652451515, 6757.662116894037, 6791.762288319885, 6823.249442561413, 6832.726690932506, 6898.586084834926, 6640.50196235294, 6644.269130395749, 6652.268250492345, 6653.135092437952, 6665.266820649822, 6361.936380636134, 6520.7391704333195, 6674.499412543982, 6678.899816502659, 6690.899636505554, 6315.052742088724, 6339.936600633934, 6433.195850518685, 6447.9032814508755, 6466.482681385572, 6454.451371633464, 6591.670416479061, 6600.966995164993, 6601.768938087336, 6623.834404139935, 6407.839804004937, 6411.839704007437, 6417.550771446141, 6419.871602568016, 6432.035194720829], "value": 6124.9882510969865, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.2264633458036, 795.8686816675249, 814.4176913506841, 1184.431472893012, 1205.7166565857017, 30424.93512727055, 34920.476192857124, 36977.0, 37355.81322093386, 37482.43776343357, 34688.95933122004, 37101.0, 37493.437598436045, 37569.81215093927, 37610.8119459403, 7884.093329267122, 8057.838843223132, 8437.662493500253, 8677.739667809945, 8694.434861733998, 8535.274501667365, 8677.219050285474, 8686.610142377222, 8698.521581313025, 8699.652013919436, 8651.826963460728, 8693.69572064978, 8702.434341767797, 8710.303175745958, 8741.606627701736, 8639.697610583631, 8690.304775617935, 8700.564971751388, 8711.390202685814, 8712.085231050743, 8440.62017209227, 8451.1548845115, 8477.533735644538, 8481.151884811532, 8499.895013648247, 36733.0, 36889.26221475582, 36979.0, 37005.25989480195, 37105.81447092747, 3527.5414196154593, 3551.1477245460906, 3561.6972557332656, 3561.82190890457, 3566.696830769362, 27174.320641984108, 30040.648170832366, 30338.0, 30348.8482557588, 30415.543766843515, 3150.4329220740256, 3181.284211052518, 3192.0, 3194.6965038321323, 3204.3270913108277, 296895.0, 296932.0, 297874.0, 303624.0, 305475.0, 46961.29558056632, 47017.29474057892, 47028.29457558139, 47120.0, 47228.7638561805, 49198.0, 49364.50635493671, 53556.66108347323, 54386.45613543893, 54398.72800636051, 13179.934100329629, 13987.860121398859, 14099.224542650252, 14104.08323458972, 14106.365213565414, 10310.948445257725, 11308.09535237179, 11359.261647992855, 11374.260673056226, 11530.01994830432, 13677.384517696728, 13751.724965500634, 13780.724385512234, 13799.03406761517, 13817.378217980215, 5139.922901156486, 6150.600210986271, 6162.26052873658, 6166.136740856284, 6197.845053873689, 857.6612238166015, 883.7172104926361, 988.2143695761887, 1020.3265844542566, 1028.1825948371063, 19077.0, 20603.4849128773, 24475.26574202741, 24509.264722058368, 25146.622800658006, 900.7928176519438, 1104.7403860092872, 1120.3725913488472, 1134.432783608196, 1175.6590588729343, 10603.734906627396, 12704.555340563036, 12735.490580376867, 12778.936105319413, 12793.552225672056, 340844.0, 342482.2875885605, 343131.0, 343364.0, 345180.0, 48330.5166948326, 48598.75700621474, 48693.0, 48747.0, 48838.0, 1495.5289083938524, 1496.2144873941268, 1527.5417374787742, 1553.7980062591791, 1581.533447632951, 17266.482005539852, 19769.604607908048, 23314.950827213157, 24212.515749684557, 24356.391090222885, 31694.683053169174, 36998.0, 37064.814675927526, 37099.0, 37210.44184337183, 292797.072029277, 292806.0, 292852.0, 293695.0, 294526.0, 34882.0, 35269.64730352664, 35296.0, 35331.82334088313, 35344.0, 43524.476643317335, 44457.33198014162, 44498.88752781206, 44553.55446445494, 44631.884202895184, 29427.559869519704, 29867.954621588142, 30321.24196895095, 30665.693343066283, 31030.603622836574, 30104.698953011066, 30335.69664303417, 30515.694843051286, 30570.388592227588, 30984.22539436532, 35960.46059309165, 36006.8199659, 36735.63264367322, 37079.8146009279, 37162.62837371592, 30006.099817005525, 30186.094417167522, 30781.538276925417, 30874.91937782167, 31145.532817008218, 22675.546489070457, 24081.036758529463, 24319.756802432457, 24509.754902450746, 24520.0], "value": 17388.342225672273, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [441.08695001347223, 446.2703479810511, 446.5891379930463, 463.38601353206997, 465.0907475884646, 15154.31805568748, 19025.619487610275, 21217.257395991124, 21298.740251949595, 21568.291261089584, 21493.892530537363, 22149.137056345007, 22425.327240182778, 22536.873156342157, 23298.767012329914, 6043.909341359883, 6172.0, 6196.039613859836, 6256.593321434115, 6257.780977665782, 4929.556339929406, 5734.168545560891, 5994.790182343619, 6055.666938318391, 6155.19982402287, 5930.466258036776, 6059.333473317932, 6121.296050954153, 6142.3550527194675, 6163.229596300463, 6040.728167232463, 6168.537359697995, 6179.87640247197, 6186.010238361863, 6187.845303867394, 5385.703786291752, 5456.863578410532, 5474.671519708831, 5488.313960754906, 5514.531264842493, 27304.0, 27665.723342766716, 27782.583261251097, 28140.0, 28404.0, 2210.8673479591275, 2268.138107519132, 2283.360659015478, 2285.2915596165244, 2287.97712022881, 17698.823011769848, 17722.468325950114, 17788.37740679083, 18187.909060454745, 18246.726299105525, 2171.7828217178158, 2189.8029177373955, 2224.065892325227, 2224.154821167962, 2228.1198926424136, 132554.0, 163307.0, 164531.0, 165393.0, 167613.323866761, 10888.891111088946, 12165.391730413445, 12703.30131842739, 12843.550475733304, 12874.034447416481, 13471.797923031163, 16764.664706705797, 16842.494725158263, 16843.831561684226, 16851.74722379165, 7203.0, 8660.48441522731, 8968.461892286483, 9028.774280643036, 9081.364304498753, 8214.383921205934, 8324.542150181798, 8496.192861678132, 8520.57397130141, 8531.786705332417, 7739.419543534257, 7984.281414672707, 8017.599120043975, 8033.156518565466, 8037.995250593675, 2196.7473740520045, 2206.316042026977, 2206.9779302207094, 2208.3485371815354, 2396.808255339569, 806.5926707013039, 897.7441429192648, 970.2432102959702, 976.1946394224793, 977.398899676708, 21262.78737212608, 21299.68050479244, 21397.144114235256, 21425.892870535547, 21914.342569722932, 968.8740463739668, 1005.8440941654055, 1033.2199189611945, 1035.254616675992, 1039.9636012739518, 10807.567697292177, 11190.496427660775, 11228.887711122947, 11279.210455268216, 11294.265872718248, 549524.0, 554024.0, 557423.0, 565711.0, 567301.0, 126674.0, 127463.0, 130615.38769224752, 131187.0, 134178.6582134166, 1086.7337502311984, 1225.9141860069888, 1264.0456455376132, 1265.3862876504888, 1266.468083404972, 20152.0, 20672.0, 21534.246301379375, 21914.67127993113, 22486.0, 56504.434955649915, 57033.837938542165, 57083.14375284291, 57531.42468575261, 57686.711566441896, 68666.0, 75709.0, 76018.23981760333, 76204.0, 76458.0, 9050.094990500897, 9061.003289638003, 9074.500902450429, 9144.497052662167, 9168.908310916806, 13860.584182474542, 13866.861331386557, 14279.214643194724, 14327.856721432652, 14435.917306202287, 11367.317960922372, 11585.768284634429, 12024.398780061138, 12033.0, 12051.0, 8851.46891186531, 9484.34024045803, 10906.90930906903, 11237.60668376603, 11281.21031527785, 11998.280103193836, 12188.695282618006, 12230.327331996825, 12256.693582660504, 12269.815952760895, 9060.773480663036, 9067.0, 9070.0, 9130.771730706785, 9144.3598948073, 11038.282511636718, 11820.23168494045, 11984.46069926838, 12034.518619255481, 12177.878221217674], "value": 10489.445963909848, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1230.3725100198897, 1332.8800407963288, 1387.2578170678685, 1440.6254373862791, 1451.4266864588487, 9819.852702209455, 9822.705318840428, 11568.421578921052, 11963.0, 12011.099167562435, 11953.880461195386, 12027.398630068483, 12083.033357331415, 12108.576199833007, 12115.212511186766, 2557.207265747615, 2588.4823035392997, 2602.921912342633, 2605.114261151208, 2612.5428050091255, 2536.7336429674897, 2575.240304110292, 2580.845149291039, 2584.5993870950033, 2586.922392328233, 2535.2014115553543, 2549.592065269557, 2594.520013797444, 2594.7275536068723, 2597.4545345477472, 2515.5975043992967, 2527.7093134289607, 2554.1315952576215, 2562.0776520452714, 2564.9615255771178, 2009.6583580791155, 2464.7042354917344, 2528.8356256843244, 2529.6332031855277, 2578.793696504275, 11974.042076633848, 12057.758844823054, 12075.396230188544, 12081.57714479989, 12089.818652720216, 6527.640979746112, 6689.096971908779, 6698.727241824038, 6745.29174436682, 6754.0, 4007.7194596378267, 4371.540988196257, 4410.933835992462, 4447.0, 4493.370928070073, 1277.4123903004536, 1279.3986826191674, 1293.4696774322576, 1312.2257867857913, 1317.426919290112, 16452.588685282844, 16910.492685219462, 17016.574585635335, 17028.914855425643, 17121.400750973655, 5705.885882282331, 5789.102689083199, 5817.941820581825, 5917.911231331534, 5964.433378829091, 12382.62852114438, 12389.0, 12404.62786116418, 12426.875731242753, 12435.626931192079, 5476.561875049986, 6643.10318107059, 6726.899096513556, 6743.831404214934, 6767.830804229934, 6113.23584551931, 6194.101855231056, 6204.37956204385, 6319.494440444753, 6335.809925702236, 4266.786660666954, 4423.071155057474, 4436.423264975532, 4442.5557444255965, 4457.442819647544, 1203.4704729918808, 1235.6037677424454, 1296.4554886947506, 1330.5476138113088, 1336.3652265173964, 593.896068188074, 770.6878714120791, 782.2646712090617, 810.1452967119627, 810.6352141536332, 6443.4523065539015, 6574.506911981621, 6992.475564332695, 7118.430525557943, 7128.679209435588, 744.4863044499278, 902.251131560803, 927.9814403711888, 967.3663750243602, 980.4411485453365, 3911.647951684305, 3918.549366822795, 3993.3211354069877, 4212.978935105305, 4403.867883963486, 12497.87502124967, 14874.0, 15008.24958752058, 15216.163111029, 15272.083674979536, 10892.836607450894, 12336.013118950463, 15048.247587620794, 15147.0, 15149.621259468602, 7038.542494737826, 7925.405594580429, 8526.616302266413, 8774.649014039367, 8777.956110219407, 5842.678652674143, 6208.596441231305, 6560.901586476111, 6988.720451181895, 7121.118990150277, 9505.809883802147, 12943.288119153536, 12997.220166790023, 13056.477740890257, 13807.930960345135, 13260.469581217028, 13949.790753138508, 13959.604039595959, 13978.510752123628, 14135.717285654435, 9434.245260379015, 9492.905070949202, 9623.5669394876, 9667.70996870095, 9707.805843883225, 10734.14126869833, 10957.397343146204, 10992.340459572451, 11018.944905275423, 11047.226694131656, 9118.22495087925, 9206.631734730803, 9255.76860578491, 9347.953260233928, 9423.811523769624, 8951.507667078373, 8994.640214391351, 9026.729198124067, 9105.362624616213, 9223.031581683827, 6969.7909062728195, 8208.425410221465, 8248.257656810916, 8445.028821685584, 8514.659413623385, 5083.669561478492, 5749.223854779551, 5850.356460789225, 6139.2325959255095, 6228.34602366745, 6140.355262697352, 6246.250449946036, 6266.342034086538, 6280.434760871543, 6372.713227904663], "value": 5394.759580750501, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.53203972696446, 414.8859063757468, 417.22604568525384, 424.2384919070267, 427.510500476954, 5290.8889133282055, 6242.500599952004, 6264.0, 6380.744770209192, 6425.582337148082, 5614.550835933126, 5961.493273071783, 6185.59793613416, 6277.654728989904, 6315.190025176837, 3780.81095945203, 4426.734395936238, 4588.724676519403, 4608.124456353299, 4611.2621980483045, 3807.562130355003, 4571.702839315434, 4612.930806037912, 4616.53834616539, 4625.259958406656, 4580.885477863063, 4593.955689718076, 4597.793099310522, 4599.586037256646, 4609.654275929302, 4474.328850672393, 4528.298113792367, 4549.567791059844, 4588.862334129982, 4604.217283061887, 3583.372909740785, 3908.6286802753693, 3946.9013274668364, 3955.129871428281, 3966.5240171179353, 4967.577755890754, 6050.2134722486235, 6089.0819391891855, 6185.855616710923, 6190.41191086846, 3989.7432308822627, 4761.428628564559, 4831.130396528659, 5185.55922746567, 5428.2671839301975, 6197.411245931629, 6678.295290407393, 6698.39714425704, 6703.698333575001, 6725.8654826903185, 3549.473726297691, 4496.8875778105485, 4498.6626003049905, 4498.730076195438, 4503.48209955856, 5918.704064796786, 6074.726637301332, 6498.642574658392, 6792.6943287551685, 6991.0, 3999.900002499961, 4465.196264672325, 4534.433195850519, 4543.61379282758, 4561.156186105581, 4619.722816631013, 4623.0, 4623.352730617717, 4633.72197668141, 4676.415448068991, 5225.581953443715, 5320.838786377208, 5408.486193811582, 5445.428230035868, 5495.340559132929, 5043.773030213576, 5933.436323549256, 6384.553081284358, 6573.276939536647, 6749.831254218586, 1378.7518246715488, 1406.9648258793407, 1505.6449195723935, 1555.844415558435, 1586.5240427871593, 971.7376308396694, 980.8132160086376, 993.3046867192994, 1019.5717798524637, 1054.4991129213563, 5299.947000529945, 5970.373110823388, 6286.4342209201395, 6288.465480434214, 6309.274433440213, 6952.5480843745, 6956.756513522002, 6996.860062798715, 7011.964940175267, 7014.0, 6002.0, 6240.906386404207, 6263.874722505524, 6352.522516218678, 6357.205349331333, 3609.2601016791496, 3659.798711070917, 3660.139867131222, 3671.908202294964, 3779.903827889936, 5518.944810551923, 6099.2680878294, 6341.651209183447, 7170.175429825533, 7182.281771822776, 5958.957182493046, 6135.447809697149, 6984.2317345092, 7259.805685498364, 7275.745348912868, 6246.843828904223, 6686.598804071771, 6818.28408017161, 7057.0, 7112.679929403189, 6148.815535533762, 6376.362363763772, 6385.425311721968, 6958.095447591781, 6966.756163534252, 5352.705601191972, 6434.8391290218115, 6718.93281067183, 6886.001529778255, 6927.861442771217, 5681.801136960186, 6361.968190159019, 6543.1821022372205, 7003.669302832445, 7269.600171990592, 4125.525564560114, 4523.778579783374, 4525.253333199985, 4568.0536054245495, 4575.313702944585, 5564.944350556604, 6276.560640755103, 6992.475564332593, 7040.225575186623, 7074.398676112588, 6717.193936727624, 6737.562058466184, 6749.0, 6750.72997080131, 6754.8649027020165, 5320.627556071193, 6707.216505150308, 6734.629595372302, 6750.729970801113, 6812.795616131524, 5253.605979551472, 5534.335879694462, 5746.080627099644, 6670.966000269966, 6731.697073631601, 6219.875602488016, 6808.523403361717, 6822.215445223665, 6833.897491537531, 6857.828554286183, 6209.844753881189, 6475.352464753487, 6541.397357647407, 6569.540132190701, 6576.408123268738], "value": 4800.931774704972, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [828.2131974624109, 833.433265379542, 853.7652145659943, 854.918782715642, 882.1178821178821, 13761.931190344047, 15495.992760470575, 16803.24385402657, 18457.446276611725, 19127.330543430984, 17614.20736066877, 17682.82317176828, 17738.29046838128, 17827.821721782777, 18434.907825460854, 960.0543464687278, 970.8932017478072, 975.7072878136566, 979.5347210075229, 980.2648013989508, 965.6330594374128, 971.5482300730159, 981.9656312029081, 983.9754006149832, 990.866233058535, 1028.9742756431074, 1030.3663247103052, 1032.2052019944676, 1032.6179313653959, 1039.552992213348, 1009.6264382178567, 1010.8231059564547, 1012.0739523336139, 1013.9340942838692, 1018.9847152292684, 737.5316673912051, 746.6528064450057, 758.1281526244808, 765.9463837531375, 772.5480593852603, 16460.0, 16587.668246635, 16637.0, 16638.50084497467, 16725.916370418192, 16355.918220408941, 16511.587210319718, 16894.07082610456, 17085.402010929556, 17101.059441730824, 11494.94252528732, 13983.440662373492, 13991.16053036821, 14132.576022719335, 14142.151470911778, 3473.70473509752, 3473.826308684581, 3536.0275924120815, 3537.4693795930557, 3540.309639620275, 117451.0, 124369.29414940957, 137864.0, 141163.0, 143294.0, 13093.869061309266, 13111.0, 13244.20534767917, 13252.27112508802, 13278.402471888596, 24937.62593561098, 25113.62329565058, 25363.74636253651, 25591.23226303214, 25612.231633051037, 6687.896497077928, 7596.620168991528, 7627.8855817162785, 7705.460617756816, 7745.651445684957, 3340.1315657928626, 3827.5024246847734, 3926.705497087673, 3959.1685745993664, 3992.8802135935966, 3610.6389361064207, 4297.119090586422, 4349.630281426051, 4369.2790689536505, 4380.824767009284, 779.9003405198756, 841.3605659698551, 878.3763527895265, 886.1315910407836, 886.4592598514901, 658.7793089315037, 671.1979184874028, 672.331030624522, 682.7644462660375, 692.7402224165937, 10967.232293739362, 11668.0, 11874.525018999317, 11985.28088314704, 12152.149349545447, 572.8825590753886, 649.376598465469, 663.4957432351351, 668.4785867023729, 686.2588404523103, 5435.565154787608, 5540.944590554042, 5593.608447408724, 5608.1587761835235, 5645.5201307888465, 96237.51881240548, 97533.0, 106493.0, 108050.0, 109993.45003274933, 95630.0, 98028.05915822537, 98719.50640246752, 99720.0, 100717.49641251893, 82873.58563207266, 84081.57959210165, 84134.57932710297, 84645.73031404534, 84759.15240847513, 10700.68278833564, 10958.945205273923, 11228.157888158585, 11265.0, 11416.94291528537, 41442.58557414508, 41864.790676046425, 42200.78899605482, 42222.57777422309, 42312.0, 78153.0, 79026.81459777993, 79514.60242698749, 81968.59015704883, 83598.0, 16935.32258709687, 17140.228689708743, 17144.571385714957, 17277.0, 17772.46682599524, 18581.814181858008, 18593.814061859208, 18673.253069877053, 18891.716624250374, 19005.954672492593, 17191.7421238679, 17349.73975390345, 17395.91302043482, 17514.0, 17585.384511542034, 17429.0, 17628.471145865133, 17637.647247055243, 17780.288788448317, 17835.46493605194, 16464.917675411547, 16588.336466541205, 17075.743863841803, 17107.48677539676, 17273.91363043177, 11768.293902365886, 11830.881691182978, 12287.955523780578, 12335.239002699827, 12376.009919206623, 11596.768064638829, 12000.75998480043, 13241.404136813673, 13393.0, 14246.21645809449], "value": 8495.038869245105, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1581.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 113.0, 121.0, 120.0, 96.0, 167.0, 168.0, 145.0, 115.0], "value": 126.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 150.0, 116.0, 152.0, 118.0, 114.0, 131.0, 146.0, 146.0, 136.0], "value": 139.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 210.0, 217.0, 266.0, 178.0, 216.0, 282.0, 202.0, 281.0, 225.0], "value": 228.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 56.0, 67.0, 76.0, 49.0, 71.0, 84.0, 83.0, 91.0, 84.0], "value": 74.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 82.0, 72.0, 71.0, 68.0, 86.0, 67.0, 70.0, 90.0], "value": 76.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 91.0, 89.0, 89.0, 102.0, 89.0, 90.0, 107.0, 90.0, 87.0], "value": 92.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 96.0, 95.0, 122.0, 135.0, 155.0, 94.0, 96.0], "value": 108.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 145.0, 89.0, 114.0, 90.0, 129.0, 79.0, 146.0, 146.0, 91.0], "value": 114.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 53.0, 51.0, 49.0, 54.0, 51.0, 53.0, 52.0, 51.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 57.0, 64.0, 61.0, 62.0, 57.0, 57.0, 74.0, 84.0, 88.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 96.0, 110.0, 106.0, 79.0, 83.0, 83.0, 81.0, 87.0], "value": 89.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 148.0, 138.0, 127.0, 124.0, 169.0, 164.0, 157.0, 196.0, 138.0], "value": 149.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 187.0, 184.0, 185.0, 187.0, 186.0, 186.0, 188.0, 187.0, 190.0], "value": 186.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 103.0, 100.0, 100.0, 69.0, 69.0, 66.0, 68.0, 71.0, 65.0], "value": 79.2, "unit": "score"}]}]} 05:12:53 INFO - Return code: 0 05:12:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:12:53 ERROR - # TBPL SUCCESS # 05:12:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:12:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:12:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:12:53 INFO - 2017-04-24 05:12:53.727 screenresolution[1660:11073] starting screenresolution argv=screenresolution get 05:12:53 INFO - 2017-04-24 05:12:53.730 screenresolution[1660:11073] Display 0: 1600x1200x32@60 05:12:53 INFO - 2017-04-24 05:12:53.736 screenresolution[1661:11076] starting screenresolution argv=screenresolution list 05:12:53 INFO - Available Modes on Display 0 05:12:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:12:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:12:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:12:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:12:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:12:53 INFO - Intel Iris: 05:12:53 INFO - Chipset Model: Intel Iris 05:12:53 INFO - Type: GPU 05:12:53 INFO - Bus: Built-In 05:12:53 INFO - VRAM (Dynamic, Max): 1536 MB 05:12:53 INFO - Vendor: Intel (0x8086) 05:12:53 INFO - Device ID: 0x0a2e 05:12:53 INFO - Revision ID: 0x0009 05:12:53 INFO - Displays: 05:12:53 INFO - Display: 05:12:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:12:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:12:53 INFO - Display Serial Number: 1600x1200 60 05:12:53 INFO - Main Display: Yes 05:12:53 INFO - Mirror: Off 05:12:53 INFO - Online: Yes 05:12:53 INFO - Rotation: Supported 05:12:53 INFO - Return code: 0 05:12:53 INFO - Running post-action listener: _resource_record_post_action 05:12:53 INFO - [mozharness: 2017-04-24 12:12:53.985391Z] Finished run-tests step (success) 05:12:53 INFO - Running post-run listener: _resource_record_post_run 05:12:54 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 39418368; Write bytes: 509743616; Read time: 253; Write time: 1646 05:12:54 INFO - TinderboxPrint: CPU usage
54.2% 05:12:54 INFO - TinderboxPrint: I/O read bytes / time
39,418,368 / 253 05:12:54 INFO - TinderboxPrint: I/O write bytes / time
509,743,616 / 1,646 05:12:54 INFO - TinderboxPrint: CPU idle
2,194.3 (45.8%) 05:12:54 INFO - TinderboxPrint: CPU system
969.2 (20.2%) 05:12:54 INFO - TinderboxPrint: CPU user
1,626.2 (34.0%) 05:12:54 INFO - TinderboxPrint: Swap in / out
247,140,352 / 0 05:12:54 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 194677248; Write bytes: 195048960; Read time: 14896; Write time: 432 05:12:54 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 38406656; Write bytes: 297847808; Read time: 237; Write time: 1161 05:12:54 INFO - Running post-run listener: _upload_blobber_files 05:12:54 INFO - Blob upload gear active. 05:12:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:12:54 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 05:12:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:12:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:12:54 INFO - (blobuploader) - INFO - Open directory for files ... 05:12:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:12:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:12:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:12:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:12:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:12:56 INFO - (blobuploader) - INFO - Done attempting. 05:12:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:12:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:12:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:12:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:12:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:12:57 INFO - (blobuploader) - INFO - Done attempting. 05:12:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:12:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:12:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:12:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:12:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:12:58 INFO - (blobuploader) - INFO - Done attempting. 05:12:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:12:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:12:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:13:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:00 INFO - (blobuploader) - INFO - Done attempting. 05:13:00 INFO - (blobuploader) - INFO - Iteration through files over. 05:13:00 INFO - Return code: 0 05:13:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:13:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:13:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d47b8a02a59e0121316d760b791789f06440e734c53d0c23ee879d46260ea6c3d29c63158cc735844f45160e15fa3098b9b220043be691630343c12dddb23d23", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a286f36c52948a4898682cb7547e93f90fe15ab1a11d7236143149ec4bd13ae435e63945137ea6dc8a0815bafa22a4f7770b789f3b6ffedf346445de62f2dc76", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de8926f12226eafd6a388e3dcbb9c30773a2123e907255a3f91a69d6c02df17d1f371fe1ae05ada1fb38bb821d348efbe83ccda7c5c6cf0ef7cbf22650ab5fcf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1702807064afb2c76d10d12bc08b5e1558b654ba699df807a36b9247613e5dbad9b5d5b6c5ea689a44abebd0af23fec2ac4d37de7798c40dd185dcd03c5d7812"} 05:13:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:13:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:13:00 INFO - Contents: 05:13:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d47b8a02a59e0121316d760b791789f06440e734c53d0c23ee879d46260ea6c3d29c63158cc735844f45160e15fa3098b9b220043be691630343c12dddb23d23", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a286f36c52948a4898682cb7547e93f90fe15ab1a11d7236143149ec4bd13ae435e63945137ea6dc8a0815bafa22a4f7770b789f3b6ffedf346445de62f2dc76", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de8926f12226eafd6a388e3dcbb9c30773a2123e907255a3f91a69d6c02df17d1f371fe1ae05ada1fb38bb821d348efbe83ccda7c5c6cf0ef7cbf22650ab5fcf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1702807064afb2c76d10d12bc08b5e1558b654ba699df807a36b9247613e5dbad9b5d5b6c5ea689a44abebd0af23fec2ac4d37de7798c40dd185dcd03c5d7812"} 05:13:00 INFO - Running post-run listener: copy_logs_to_upload_dir 05:13:00 INFO - Copying logs to upload dir... 05:13:00 INFO - mkdir: /builds/slave/test/build/upload/logs 05:13:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.928936 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2017-04-24 05:13:00.376875) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-24 05:13:00.380437) ========= 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.O9gJGn6wFE/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.ov5B4tD4Yy/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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/Firefox/sha512/d47b8a02a59e0121316d760b791789f06440e734c53d0c23ee879d46260ea6c3d29c63158cc735844f45160e15fa3098b9b220043be691630343c12dddb23d23", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a286f36c52948a4898682cb7547e93f90fe15ab1a11d7236143149ec4bd13ae435e63945137ea6dc8a0815bafa22a4f7770b789f3b6ffedf346445de62f2dc76", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de8926f12226eafd6a388e3dcbb9c30773a2123e907255a3f91a69d6c02df17d1f371fe1ae05ada1fb38bb821d348efbe83ccda7c5c6cf0ef7cbf22650ab5fcf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1702807064afb2c76d10d12bc08b5e1558b654ba699df807a36b9247613e5dbad9b5d5b6c5ea689a44abebd0af23fec2ac4d37de7798c40dd185dcd03c5d7812"} build_url:https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011005 build_url: 'https://queue.taskcluster.net/v1/task/K1ohL1jtTU2A4lKBS15kRQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d47b8a02a59e0121316d760b791789f06440e734c53d0c23ee879d46260ea6c3d29c63158cc735844f45160e15fa3098b9b220043be691630343c12dddb23d23", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a286f36c52948a4898682cb7547e93f90fe15ab1a11d7236143149ec4bd13ae435e63945137ea6dc8a0815bafa22a4f7770b789f3b6ffedf346445de62f2dc76", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de8926f12226eafd6a388e3dcbb9c30773a2123e907255a3f91a69d6c02df17d1f371fe1ae05ada1fb38bb821d348efbe83ccda7c5c6cf0ef7cbf22650ab5fcf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1702807064afb2c76d10d12bc08b5e1558b654ba699df807a36b9247613e5dbad9b5d5b6c5ea689a44abebd0af23fec2ac4d37de7798c40dd185dcd03c5d7812"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-24 05:13:00.415908) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 05:13:00.416345) ========= 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.O9gJGn6wFE/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.ov5B4tD4Yy/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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.005016 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 05:13:00.465330) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-24 05:13:00.465644) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-24 05:13:00.465974) ========= ========= Total master_lag: 0.19 =========