builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0002 starttime: 1492768820.07 results: success (0) buildid: 20170421014628 builduid: 3654f57986464cbfb0090181e00c5d82 revision: 7b43acb948540e6687bab6d508dcf6add5823e03 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-21 03:00:20.067429) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-21 03:00:20.067864) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-21 03:00:20.068136) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-21 03:00:20.093049) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 03:00:20.093359) ========= 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.bfjn8WvdTC/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.ZcJHhkVhrp/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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-21 03:00:20-- 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% 6.53M=0.002s 2017-04-21 03:00:20 (6.53 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131012 ========= master_lag: 0.27 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 03:00:20.495492) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 03:00:20.495803) ========= 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.bfjn8WvdTC/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.ZcJHhkVhrp/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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.021835 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 03:00:20.543805) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-21 03:00:20.544833) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7b43acb948540e6687bab6d508dcf6add5823e03 --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 7b43acb948540e6687bab6d508dcf6add5823e03 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bfjn8WvdTC/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.ZcJHhkVhrp/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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-21 03:00:20,632 truncating revision to first 12 chars 2017-04-21 03:00:20,632 Setting DEBUG logging. 2017-04-21 03:00:20,632 attempt 1/10 2017-04-21 03:00:20,633 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7b43acb94854?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-21 03:00:22,332 unpacking tar archive at: mozilla-central-7b43acb94854/testing/mozharness/ program finished with exit code 0 elapsedTime=1.964699 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-21 03:00:22.534724) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-21 03:00:22.535091) ========= script_repo_revision: 7b43acb948540e6687bab6d508dcf6add5823e03 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-21 03:00:22.535538) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-21 03:00:22.535841) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-21 03:00:22.559977) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2017-04-21 03:00:22.560429) ========= /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.bfjn8WvdTC/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.ZcJHhkVhrp/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 03:00:22 INFO - MultiFileLogger online at 20170421 03:00:22 in /builds/slave/test 03:00:22 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 03:00:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:00:22 INFO - {'append_to_log': False, 03:00:22 INFO - 'base_work_dir': '/builds/slave/test', 03:00:22 INFO - 'blob_upload_branch': 'Firefox', 03:00:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:00:22 INFO - 'branch': 'Firefox', 03:00:22 INFO - 'buildbot_json_path': 'buildprops.json', 03:00:22 INFO - 'config_files': ('talos/mac_config.py',), 03:00:22 INFO - 'default_actions': ('clobber', 03:00:22 INFO - 'read-buildbot-config', 03:00:22 INFO - 'download-and-extract', 03:00:22 INFO - 'populate-webroot', 03:00:22 INFO - 'create-virtualenv', 03:00:22 INFO - 'install', 03:00:22 INFO - 'run-tests'), 03:00:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:00:22 INFO - 'download_minidump_stackwalk': True, 03:00:22 INFO - 'download_symbols': 'ondemand', 03:00:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:00:22 INFO - 'tooltool.py': '/tools/tooltool.py', 03:00:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:00:22 INFO - '/tools/misc-python/virtualenv.py')}, 03:00:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:00:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:00:22 INFO - 'gecko_profile': False, 03:00:22 INFO - 'gecko_profile_interval': 0, 03:00:22 INFO - 'installer_path': 'installer.exe', 03:00:22 INFO - 'log_level': 'info', 03:00:22 INFO - 'log_name': 'talos', 03:00:22 INFO - 'log_to_console': True, 03:00:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:00:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:00:22 INFO - 'opt_config_files': (), 03:00:22 INFO - 'pip_index': False, 03:00:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:00:22 INFO - 'cmd': ('bash', 03:00:22 INFO - '-c', 03:00:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:00:22 INFO - 'enabled': True, 03:00:22 INFO - 'halt_on_failure': False, 03:00:22 INFO - 'name': 'check_screen_resolution'},), 03:00:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:00:22 INFO - 'cmd': ('bash', 03:00:22 INFO - '-c', 03:00:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:00:22 INFO - 'enabled': True, 03:00:22 INFO - 'halt_on_failure': False, 03:00:22 INFO - 'name': 'check_screen_resolution'},), 03:00:22 INFO - 'run_cmd_checks_enabled': True, 03:00:22 INFO - 'suite': 'dromaeojs-e10s', 03:00:22 INFO - 'system_bits': '32', 03:00:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:00:22 INFO - 'title': 't-yosemite-r7-0002', 03:00:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:00:22 INFO - 'use_talos_json': True, 03:00:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:00:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:00:22 INFO - 'work_dir': 'build'} 03:00:22 INFO - [mozharness: 2017-04-21 10:00:22.773312Z] Running clobber step. 03:00:22 INFO - Running pre-action listener: _resource_record_pre_action 03:00:22 INFO - Running main action method: clobber 03:00:22 INFO - rmtree: /builds/slave/test/build 03:00:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:00:23 INFO - Running post-action listener: _resource_record_post_action 03:00:23 INFO - [mozharness: 2017-04-21 10:00:23.217302Z] Finished clobber step (success) 03:00:23 INFO - [mozharness: 2017-04-21 10:00:23.217525Z] Running read-buildbot-config step. 03:00:23 INFO - Running pre-action listener: _resource_record_pre_action 03:00:23 INFO - Running main action method: read_buildbot_config 03:00:23 INFO - Using buildbot properties: 03:00:23 INFO - { 03:00:23 INFO - "project": "", 03:00:23 INFO - "product": "firefox", 03:00:23 INFO - "script_repo_revision": "production", 03:00:23 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 03:00:23 INFO - "repository": "", 03:00:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 03:00:23 INFO - "buildid": "20170421014628", 03:00:23 INFO - "pgo_build": "False", 03:00:23 INFO - "basedir": "/builds/slave/test", 03:00:23 INFO - "buildnumber": 33, 03:00:23 INFO - "slavename": "t-yosemite-r7-0002", 03:00:23 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 03:00:23 INFO - "platform": "yosemite_r7", 03:00:23 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:00:23 INFO - "branch": "mozilla-central", 03:00:23 INFO - "repo_path": "mozilla-central", 03:00:23 INFO - "revision": "7b43acb948540e6687bab6d508dcf6add5823e03", 03:00:23 INFO - "stage_platform": "macosx64", 03:00:23 INFO - "builduid": "3654f57986464cbfb0090181e00c5d82", 03:00:23 INFO - "slavebuilddir": "test" 03:00:23 INFO - } 03:00:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 03:00:23 INFO - Running post-action listener: _resource_record_post_action 03:00:23 INFO - [mozharness: 2017-04-21 10:00:23.223404Z] Finished read-buildbot-config step (success) 03:00:23 INFO - [mozharness: 2017-04-21 10:00:23.223584Z] Running download-and-extract step. 03:00:23 INFO - Running pre-action listener: _resource_record_pre_action 03:00:23 INFO - Running main action method: download_and_extract 03:00:23 INFO - mkdir: /builds/slave/test/build/tests 03:00:23 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')]} 03:00:23 INFO - trying https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 03:00:23 INFO - Downloading https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/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 03:00:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/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 03:00:24 INFO - Downloaded 1325 bytes. 03:00:24 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 03:00:24 INFO - Using the following test package requirements: 03:00:24 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:00:24 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 03:00:24 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:00:24 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:00:24 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 03:00:24 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:00:24 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 03:00:24 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:00:24 INFO - u'jsshell-mac.zip'], 03:00:24 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:00:24 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 03:00:24 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:00:24 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:00:24 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 03:00:24 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:00:24 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 03:00:24 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:00:24 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 03:00:24 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:00:24 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 03:00:24 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:00:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:00:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:00:24 INFO - Fetch https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:00:26 INFO - Content-Length response header: 52523527 03:00:26 INFO - Bytes received: 52523527 03:00:42 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 03:00:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:00:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:00:42 INFO - Fetch https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:00:44 INFO - Content-Length response header: 52523527 03:00:44 INFO - Bytes received: 52523527 03:00:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 03:00:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:00:59 INFO - Fetch https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 03:01:00 INFO - Content-Length response header: 14408811 03:01:00 INFO - Bytes received: 14408811 03:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:01 INFO - trying https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:01:01 INFO - Downloading https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 03:01:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/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 03:01:03 INFO - Downloaded 71026675 bytes. 03:01:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:01:03 INFO - mkdir: /builds/slave/test/properties 03:01:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:01:03 INFO - Writing to file /builds/slave/test/properties/build_url 03:01:03 INFO - Contents: 03:01:03 INFO - build_url:https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:01:03 INFO - Running post-action listener: _resource_record_post_action 03:01:03 INFO - Running post-action listener: set_extra_try_arguments 03:01:03 INFO - [mozharness: 2017-04-21 10:01:03.987168Z] Finished download-and-extract step (success) 03:01:03 INFO - [mozharness: 2017-04-21 10:01:03.987320Z] Running populate-webroot step. 03:01:03 INFO - Running pre-action listener: _resource_record_pre_action 03:01:03 INFO - Running main action method: populate_webroot 03:01:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:01:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:01:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:01:03 INFO - '--tppagecycles', 03:01:03 INFO - '7'], 03:01:03 INFO - 'tests': ['tsvgm']}}, 03:01:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:01:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:01:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:01:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:01:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:01:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:01:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:01:03 INFO - 'talos_options': ['--disable-e10s'], 03:01:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:01:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:01:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:01:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:01:03 INFO - 'talos_options': ['--disable-e10s'], 03:01:03 INFO - 'tests': ['damp', 'tps']}, 03:01:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:01:03 INFO - 'tests': ['damp', 'tps']}, 03:01:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:01:03 INFO - 'tests': ['dromaeo_dom']}, 03:01:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:01:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:01:03 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:01:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:01:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:01:03 INFO - 'tests': ['a11yr', 03:01:03 INFO - 'ts_paint', 03:01:03 INFO - 'tpaint', 03:01:03 INFO - 'sessionrestore', 03:01:03 INFO - 'sessionrestore_no_auto_restore', 03:01:03 INFO - 'tabpaint']}, 03:01:04 INFO - 'other-e10s': {'tests': ['a11yr', 03:01:04 INFO - 'ts_paint', 03:01:04 INFO - 'tpaint', 03:01:04 INFO - 'sessionrestore', 03:01:04 INFO - 'sessionrestore_no_auto_restore', 03:01:04 INFO - 'tabpaint']}, 03:01:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:01:04 INFO - 'ts_paint', 03:01:04 INFO - 'tpaint', 03:01:04 INFO - 'sessionrestore', 03:01:04 INFO - 'sessionrestore_no_auto_restore', 03:01:04 INFO - 'tabpaint']}, 03:01:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:01:04 INFO - 'ts_paint', 03:01:04 INFO - 'tpaint', 03:01:04 INFO - 'sessionrestore', 03:01:04 INFO - 'sessionrestore_no_auto_restore', 03:01:04 INFO - 'tabpaint']}, 03:01:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:01:04 INFO - 'tests': ['a11yr', 03:01:04 INFO - 'ts_paint', 03:01:04 INFO - 'tpaint', 03:01:04 INFO - 'sessionrestore', 03:01:04 INFO - 'sessionrestore_no_auto_restore', 03:01:04 INFO - 'tabpaint']}, 03:01:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:01:04 INFO - 'tests': ['a11yr', 03:01:04 INFO - 'ts_paint', 03:01:04 INFO - 'tpaint', 03:01:04 INFO - 'sessionrestore', 03:01:04 INFO - 'sessionrestore_no_auto_restore', 03:01:04 INFO - 'tabpaint']}, 03:01:04 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:01:04 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:01:04 INFO - 'bloom_basic_ref']}, 03:01:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:01:04 INFO - 'tests': ['tsvgx', 03:01:04 INFO - 'tsvgr_opacity', 03:01:04 INFO - 'tart', 03:01:04 INFO - 'tscrollx', 03:01:04 INFO - 'cart', 03:01:04 INFO - 'tsvg_static']}, 03:01:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:01:04 INFO - 'tsvgr_opacity', 03:01:04 INFO - 'tart', 03:01:04 INFO - 'tscrollx', 03:01:04 INFO - 'cart', 03:01:04 INFO - 'tsvg_static']}, 03:01:04 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:01:04 INFO - 'talos_options': ['--disable-e10s'], 03:01:04 INFO - 'tests': ['tp5o']}, 03:01:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:01:04 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:01:04 INFO - 'talos_options': ['--disable-e10s', 03:01:04 INFO - '--xperf_path', 03:01:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:01:04 INFO - 'tests': ['tp5n']}, 03:01:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:01:04 INFO - 'talos_options': ['--xperf_path', 03:01:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:01:04 INFO - 'tests': ['tp5n']}}, 03:01:04 INFO - 'talos.zip': {'path': '', 03:01:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:01:04 INFO - Running post-action listener: _resource_record_post_action 03:01:04 INFO - [mozharness: 2017-04-21 10:01:04.006400Z] Finished populate-webroot step (success) 03:01:04 INFO - [mozharness: 2017-04-21 10:01:04.006514Z] Running create-virtualenv step. 03:01:04 INFO - Running pre-action listener: _resource_record_pre_action 03:01:04 INFO - Running main action method: create_virtualenv 03:01:04 INFO - Creating virtualenv /builds/slave/test/build/venv 03:01:04 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 03:01:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:01:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:01:04 INFO - Using real prefix '/tools/python27' 03:01:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:01:04 INFO - Installing distribute.............................................................................................................................................................................................done. 03:01:07 INFO - Installing pip.................done. 03:01:07 INFO - Return code: 0 03:01:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:01:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:01:07 INFO - Reading from file tmpfile_stdout 03:01:07 INFO - Output received: 03:01:07 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) 03:01:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:01:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105622b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105625768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca3049f0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105400d30>, '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 0x105326db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053f5be8>, '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.bfjn8WvdTC/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.ZcJHhkVhrp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 03:01:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:01:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:01:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bfjn8WvdTC/Render', 03:01:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:07 INFO - 'HOME': '/Users/cltbld', 03:01:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:07 INFO - 'LOGNAME': 'cltbld', 03:01:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:07 INFO - 'MOZ_NO_REMOTE': '1', 03:01:07 INFO - 'NO_EM_RESTART': '1', 03:01:07 INFO - 'PAGER': '/bin/cat', 03:01:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:07 INFO - 'PWD': '/builds/slave/test', 03:01:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:07 INFO - 'SHELL': '/bin/bash', 03:01:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZcJHhkVhrp/Listeners', 03:01:07 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 03:01:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:07 INFO - 'USER': 'cltbld', 03:01:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:07 INFO - 'XPC_FLAGS': '0x0', 03:01:07 INFO - 'XPC_SERVICE_NAME': '0', 03:01:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:08 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 03:01:08 INFO - Cleaning up... 03:01:08 INFO - Return code: 0 03:01:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:01:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105622b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105625768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca3049f0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105400d30>, '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 0x105326db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053f5be8>, '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.bfjn8WvdTC/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.ZcJHhkVhrp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 03:01:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:01:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:01:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bfjn8WvdTC/Render', 03:01:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:08 INFO - 'HOME': '/Users/cltbld', 03:01:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:08 INFO - 'LOGNAME': 'cltbld', 03:01:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:08 INFO - 'MOZ_NO_REMOTE': '1', 03:01:08 INFO - 'NO_EM_RESTART': '1', 03:01:08 INFO - 'PAGER': '/bin/cat', 03:01:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:08 INFO - 'PWD': '/builds/slave/test', 03:01:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:08 INFO - 'SHELL': '/bin/bash', 03:01:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZcJHhkVhrp/Listeners', 03:01:08 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 03:01:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:08 INFO - 'USER': 'cltbld', 03:01:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:08 INFO - 'XPC_FLAGS': '0x0', 03:01:08 INFO - 'XPC_SERVICE_NAME': '0', 03:01:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:08 INFO - Downloading/unpacking psutil>=3.1.1 03:01:08 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 03:01:08 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 03:01:08 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 03:01:08 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 03:01:08 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 03:01:08 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 03:01:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:01:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:01:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:01:12 INFO - Installing collected packages: psutil 03:01:12 INFO - Running setup.py install for psutil 03:01:12 INFO - building 'psutil._psutil_osx' extension 03:01:12 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 03:01:12 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 03:01:12 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 03:01:12 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 03:01:12 INFO - building 'psutil._psutil_posix' extension 03:01:12 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 03:01:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:01:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:01:12 INFO - ^ 03:01:12 INFO - 1 warning generated. 03:01:12 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 03:01:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:01:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:01:12 INFO - Successfully installed psutil 03:01:12 INFO - Cleaning up... 03:01:13 INFO - Return code: 0 03:01:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:01:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:13 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 0x105622b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105625768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca3049f0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105400d30>, '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 0x105326db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053f5be8>, '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.bfjn8WvdTC/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.ZcJHhkVhrp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 03:01:13 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 03:01:13 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 03:01:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bfjn8WvdTC/Render', 03:01:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:13 INFO - 'HOME': '/Users/cltbld', 03:01:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:13 INFO - 'LOGNAME': 'cltbld', 03:01:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:13 INFO - 'MOZ_NO_REMOTE': '1', 03:01:13 INFO - 'NO_EM_RESTART': '1', 03:01:13 INFO - 'PAGER': '/bin/cat', 03:01:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:13 INFO - 'PWD': '/builds/slave/test', 03:01:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:13 INFO - 'SHELL': '/bin/bash', 03:01:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZcJHhkVhrp/Listeners', 03:01:13 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 03:01:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:13 INFO - 'USER': 'cltbld', 03:01:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:13 INFO - 'XPC_FLAGS': '0x0', 03:01:13 INFO - 'XPC_SERVICE_NAME': '0', 03:01:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:01:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:01:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:01:17 INFO - Installing collected packages: mozsystemmonitor 03:01:17 INFO - Running setup.py install for mozsystemmonitor 03:01:17 INFO - Successfully installed mozsystemmonitor 03:01:17 INFO - Cleaning up... 03:01:17 INFO - Return code: 0 03:01:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:01:17 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')]} 03:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:17 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')]} 03:01:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:17 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 0x105622b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105625768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca3049f0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105400d30>, '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 0x105326db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053f5be8>, '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.bfjn8WvdTC/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.ZcJHhkVhrp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 03:01:17 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 03:01:17 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 03:01:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bfjn8WvdTC/Render', 03:01:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:17 INFO - 'HOME': '/Users/cltbld', 03:01:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:17 INFO - 'LOGNAME': 'cltbld', 03:01:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:17 INFO - 'MOZ_NO_REMOTE': '1', 03:01:17 INFO - 'NO_EM_RESTART': '1', 03:01:17 INFO - 'PAGER': '/bin/cat', 03:01:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:17 INFO - 'PWD': '/builds/slave/test', 03:01:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:17 INFO - 'SHELL': '/bin/bash', 03:01:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZcJHhkVhrp/Listeners', 03:01:17 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 03:01:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:17 INFO - 'USER': 'cltbld', 03:01:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:17 INFO - 'XPC_FLAGS': '0x0', 03:01:17 INFO - 'XPC_SERVICE_NAME': '0', 03:01:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:17 INFO - Downloading/unpacking jsonschema==2.5.1 03:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:01:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:01:20 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 03:01:20 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 03:01:20 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 03:01:20 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 03:01:20 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 03:01:20 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 03:01:20 INFO - Downloading functools32-3.2.3-2.tar.gz 03:01:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:01:20 INFO - warning: no files found matching '*.txt' 03:01:20 INFO - no previously-included directories found matching 'build' 03:01:20 INFO - no previously-included directories found matching 'dist' 03:01:20 INFO - no previously-included directories found matching '.git*' 03:01:20 INFO - Installing collected packages: jsonschema, functools32 03:01:20 INFO - Running setup.py install for functools32 03:01:20 INFO - warning: no files found matching '*.txt' 03:01:20 INFO - no previously-included directories found matching 'build' 03:01:20 INFO - no previously-included directories found matching 'dist' 03:01:20 INFO - no previously-included directories found matching '.git*' 03:01:21 INFO - Successfully installed jsonschema functools32 03:01:21 INFO - Cleaning up... 03:01:21 INFO - Return code: 0 03:01:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:01:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105622b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105625768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca3049f0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105400d30>, '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 0x105326db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053f5be8>, '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.bfjn8WvdTC/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.ZcJHhkVhrp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 03:01:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:01:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:01:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bfjn8WvdTC/Render', 03:01:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:21 INFO - 'HOME': '/Users/cltbld', 03:01:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:21 INFO - 'LOGNAME': 'cltbld', 03:01:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:21 INFO - 'MOZ_NO_REMOTE': '1', 03:01:21 INFO - 'NO_EM_RESTART': '1', 03:01:21 INFO - 'PAGER': '/bin/cat', 03:01:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:21 INFO - 'PWD': '/builds/slave/test', 03:01:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:21 INFO - 'SHELL': '/bin/bash', 03:01:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZcJHhkVhrp/Listeners', 03:01:21 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 03:01:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:21 INFO - 'USER': 'cltbld', 03:01:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:21 INFO - 'XPC_FLAGS': '0x0', 03:01:21 INFO - 'XPC_SERVICE_NAME': '0', 03:01:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:01:21 INFO - Cleaning up... 03:01:21 INFO - Return code: 0 03:01:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:01:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105622b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105625768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca3049f0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105400d30>, '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 0x105326db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053f5be8>, '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.bfjn8WvdTC/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.ZcJHhkVhrp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 03:01:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:01:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:01:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bfjn8WvdTC/Render', 03:01:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:21 INFO - 'HOME': '/Users/cltbld', 03:01:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:21 INFO - 'LOGNAME': 'cltbld', 03:01:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:21 INFO - 'MOZ_NO_REMOTE': '1', 03:01:21 INFO - 'NO_EM_RESTART': '1', 03:01:21 INFO - 'PAGER': '/bin/cat', 03:01:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:21 INFO - 'PWD': '/builds/slave/test', 03:01:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:21 INFO - 'SHELL': '/bin/bash', 03:01:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZcJHhkVhrp/Listeners', 03:01:21 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 03:01:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:21 INFO - 'USER': 'cltbld', 03:01:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:21 INFO - 'XPC_FLAGS': '0x0', 03:01:21 INFO - 'XPC_SERVICE_NAME': '0', 03:01:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:21 INFO - Downloading/unpacking blobuploader==1.2.4 03:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:24 INFO - Downloading blobuploader-1.2.4.tar.gz 03:01:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:01:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:01:24 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 03:01:24 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 03:01:24 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 03:01:24 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 03:01:24 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 03:01:24 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 03:01:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:01:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:01:25 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 03:01:25 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 03:01:25 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 03:01:25 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 03:01:25 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 03:01:25 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 03:01:25 INFO - Downloading docopt-0.6.1.tar.gz 03:01:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:01:25 INFO - Installing collected packages: blobuploader, requests, docopt 03:01:25 INFO - Running setup.py install for blobuploader 03:01:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:01:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:01:25 INFO - Running setup.py install for requests 03:01:26 INFO - Running setup.py install for docopt 03:01:26 INFO - Successfully installed blobuploader requests docopt 03:01:26 INFO - Cleaning up... 03:01:26 INFO - Return code: 0 03:01:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:01:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:26 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 0x105622b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105625768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca3049f0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105400d30>, '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 0x105326db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053f5be8>, '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.bfjn8WvdTC/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.ZcJHhkVhrp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 03:01:26 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 03:01:26 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 03:01:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bfjn8WvdTC/Render', 03:01:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:26 INFO - 'HOME': '/Users/cltbld', 03:01:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:26 INFO - 'LOGNAME': 'cltbld', 03:01:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:26 INFO - 'MOZ_NO_REMOTE': '1', 03:01:26 INFO - 'NO_EM_RESTART': '1', 03:01:26 INFO - 'PAGER': '/bin/cat', 03:01:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:26 INFO - 'PWD': '/builds/slave/test', 03:01:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:26 INFO - 'SHELL': '/bin/bash', 03:01:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZcJHhkVhrp/Listeners', 03:01:26 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 03:01:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:26 INFO - 'USER': 'cltbld', 03:01:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:26 INFO - 'XPC_FLAGS': '0x0', 03:01:26 INFO - 'XPC_SERVICE_NAME': '0', 03:01:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:01:26 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-Ljmd19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:01:26 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-t97oko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:01:26 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-VgrHDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:01:27 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-K6FIV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:01:27 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-ucgI9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:01:27 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-oII8Qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:01:27 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-7zh5hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:01:27 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-PRQVY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:01:27 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-pBj7uQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:01:27 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-zSwSiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:01:27 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-bQjPeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:01:27 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-eKrIMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:01:27 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-QZsc51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:01:28 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-rtzfIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:01:28 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-Ix846y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:01:28 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-En9p0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:01:28 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-m9ZYpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:01:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:01:28 INFO - Running setup.py install for manifestparser 03:01:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:01:28 INFO - Running setup.py install for mozcrash 03:01:28 INFO - Running setup.py install for mozdebug 03:01:28 INFO - Running setup.py install for mozdevice 03:01:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:01:29 INFO - Running setup.py install for mozfile 03:01:29 INFO - Running setup.py install for mozhttpd 03:01:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:01:29 INFO - Running setup.py install for mozinfo 03:01:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:01:29 INFO - Running setup.py install for mozInstall 03:01:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:01:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:01:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:01:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:01:29 INFO - Running setup.py install for mozleak 03:01:29 INFO - Running setup.py install for mozlog 03:01:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:01:29 INFO - Running setup.py install for moznetwork 03:01:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:01:30 INFO - Running setup.py install for mozprocess 03:01:30 INFO - Running setup.py install for mozprofile 03:01:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:01:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:01:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:01:30 INFO - Running setup.py install for mozrunner 03:01:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:01:30 INFO - Running setup.py install for mozscreenshot 03:01:30 INFO - Running setup.py install for moztest 03:01:30 INFO - Running setup.py install for mozversion 03:01:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:01:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:01:31 INFO - Cleaning up... 03:01:31 INFO - Return code: 0 03:01:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:01:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:31 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 0x105622b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105625768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca3049f0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105400d30>, '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 0x105326db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053f5be8>, '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.bfjn8WvdTC/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.ZcJHhkVhrp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 03:01:31 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 03:01:31 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 03:01:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bfjn8WvdTC/Render', 03:01:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:31 INFO - 'HOME': '/Users/cltbld', 03:01:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:31 INFO - 'LOGNAME': 'cltbld', 03:01:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:31 INFO - 'MOZ_NO_REMOTE': '1', 03:01:31 INFO - 'NO_EM_RESTART': '1', 03:01:31 INFO - 'PAGER': '/bin/cat', 03:01:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:31 INFO - 'PWD': '/builds/slave/test', 03:01:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:31 INFO - 'SHELL': '/bin/bash', 03:01:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZcJHhkVhrp/Listeners', 03:01:31 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 03:01:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:31 INFO - 'USER': 'cltbld', 03:01:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:31 INFO - 'XPC_FLAGS': '0x0', 03:01:31 INFO - 'XPC_SERVICE_NAME': '0', 03:01:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:01:31 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-8i_28f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:01:31 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)) 03:01:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:01:31 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-ZTjNmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:01:31 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)) 03:01:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:01:31 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-33Q2PT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:01:31 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)) 03:01:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:01:31 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-mqVDaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:01:31 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)) 03:01:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:01:31 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-DrGmTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:01:31 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)) 03:01:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:01:31 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-MiXVtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:01:31 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)) 03:01:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:01:31 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-mlU0ex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:01:32 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)) 03:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:01:32 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-nztHrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:01:32 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)) 03:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:01:32 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-iL1vFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:01:32 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)) 03:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:01:32 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-GACnVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:01:32 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)) 03:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:01:32 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-MRSCZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:01:32 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)) 03:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:01:32 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-BIuvhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:01:32 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)) 03:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:01:32 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-M_7Hn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:01:32 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)) 03:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:01:32 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-vNLbF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:01:32 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)) 03:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:01:32 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-J5mJq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:01:32 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)) 03:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:01:32 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-vmG6tL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:01:33 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)) 03:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:01:33 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-eNra5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:01:33 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)) 03:01:33 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)) 03:01:33 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)) 03:01:33 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)) 03:01:33 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)) 03:01:33 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)) 03:01:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:35 INFO - Downloading blessings-1.6.tar.gz 03:01:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:01:35 INFO - Installing collected packages: blessings 03:01:35 INFO - Running setup.py install for blessings 03:01:36 INFO - Successfully installed blessings 03:01:36 INFO - Cleaning up... 03:01:36 INFO - Return code: 0 03:01:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:01:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:01:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:01:36 INFO - Reading from file tmpfile_stdout 03:01:36 INFO - Current package versions: 03:01:36 INFO - blessings == 1.6 03:01:36 INFO - blobuploader == 1.2.4 03:01:36 INFO - docopt == 0.6.1 03:01:36 INFO - functools32 == 3.2.3-2 03:01:36 INFO - jsonschema == 2.5.1 03:01:36 INFO - manifestparser == 1.1 03:01:36 INFO - mozInstall == 1.12 03:01:36 INFO - mozcrash == 1.0 03:01:36 INFO - mozdebug == 0.1 03:01:36 INFO - mozdevice == 0.50 03:01:36 INFO - mozfile == 1.2 03:01:36 INFO - mozhttpd == 0.7 03:01:36 INFO - mozinfo == 0.9 03:01:36 INFO - mozleak == 0.1 03:01:36 INFO - mozlog == 3.4 03:01:36 INFO - moznetwork == 0.27 03:01:36 INFO - mozprocess == 0.25 03:01:36 INFO - mozprofile == 0.28 03:01:36 INFO - mozrunner == 6.13 03:01:36 INFO - mozscreenshot == 0.1 03:01:36 INFO - mozsystemmonitor == 0.3 03:01:36 INFO - moztest == 0.8 03:01:36 INFO - mozversion == 1.4 03:01:36 INFO - psutil == 3.1.1 03:01:36 INFO - requests == 1.2.3 03:01:36 INFO - wsgiref == 0.1.2 03:01:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:01: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')]} 03:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01: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')]} 03:01:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:36 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 0x105622b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105625768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca3049f0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105400d30>, '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 0x105326db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053f5be8>, '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.bfjn8WvdTC/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.ZcJHhkVhrp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 03:01:36 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 03:01:36 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 03:01:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bfjn8WvdTC/Render', 03:01:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:36 INFO - 'HOME': '/Users/cltbld', 03:01:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:36 INFO - 'LOGNAME': 'cltbld', 03:01:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:36 INFO - 'MOZ_NO_REMOTE': '1', 03:01:36 INFO - 'NO_EM_RESTART': '1', 03:01:36 INFO - 'PAGER': '/bin/cat', 03:01:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:36 INFO - 'PWD': '/builds/slave/test', 03:01:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:36 INFO - 'SHELL': '/bin/bash', 03:01:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZcJHhkVhrp/Listeners', 03:01:36 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 03:01:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:36 INFO - 'USER': 'cltbld', 03:01:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:36 INFO - 'XPC_FLAGS': '0x0', 03:01:36 INFO - 'XPC_SERVICE_NAME': '0', 03:01:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:36 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)) 03:01:36 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)) 03:01:36 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)) 03:01:36 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)) 03:01:36 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)) 03:01:36 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)) 03:01:36 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)) 03:01:36 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)) 03:01:36 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)) 03:01:36 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)) 03:01:36 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)) 03:01:36 INFO - Cleaning up... 03:01:36 INFO - Return code: 0 03:01:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:01: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')]} 03:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01: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')]} 03:01:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105622b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105625768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca3049f0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105400d30>, '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 0x105326db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053f5be8>, '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.bfjn8WvdTC/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.ZcJHhkVhrp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 03:01: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'] in /builds/slave/test/build 03:01: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 03:01:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bfjn8WvdTC/Render', 03:01:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:36 INFO - 'HOME': '/Users/cltbld', 03:01:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:36 INFO - 'LOGNAME': 'cltbld', 03:01:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:36 INFO - 'MOZ_NO_REMOTE': '1', 03:01:36 INFO - 'NO_EM_RESTART': '1', 03:01:36 INFO - 'PAGER': '/bin/cat', 03:01:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:36 INFO - 'PWD': '/builds/slave/test', 03:01:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:36 INFO - 'SHELL': '/bin/bash', 03:01:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZcJHhkVhrp/Listeners', 03:01:36 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 03:01:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:36 INFO - 'USER': 'cltbld', 03:01:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:36 INFO - 'XPC_FLAGS': '0x0', 03:01:36 INFO - 'XPC_SERVICE_NAME': '0', 03:01:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:01:36 INFO - Cleaning up... 03:01:36 INFO - Return code: 0 03:01:36 INFO - Running post-action listener: _resource_record_post_action 03:01:36 INFO - Running post-action listener: _start_resource_monitoring 03:01:36 INFO - Starting resource monitoring. 03:01:36 INFO - [mozharness: 2017-04-21 10:01:36.977294Z] Finished create-virtualenv step (success) 03:01:36 INFO - [mozharness: 2017-04-21 10:01:36.978326Z] Running install step. 03:01:36 INFO - Running pre-action listener: _resource_record_pre_action 03:01:36 INFO - Running main action method: install 03:01:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:01:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:01:37 INFO - Reading from file tmpfile_stdout 03:01:37 INFO - Detecting whether we're running mozinstall >=1.0... 03:01:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:01:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:01:37 INFO - Reading from file tmpfile_stdout 03:01:37 INFO - Output received: 03:01:37 INFO - Usage: mozinstall [options] installer 03:01:37 INFO - Options: 03:01:37 INFO - -h, --help show this help message and exit 03:01:37 INFO - -d DEST, --destination=DEST 03:01:37 INFO - Directory to install application into. [default: 03:01:37 INFO - "/builds/slave/test"] 03:01:37 INFO - --app=APP Application being installed. [default: firefox] 03:01:37 INFO - mkdir: /builds/slave/test/build/application 03:01:37 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'] 03:01:37 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 03:01:57 INFO - Reading from file tmpfile_stdout 03:01:57 INFO - Output received: 03:01:57 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:01:57 INFO - Running post-action listener: _resource_record_post_action 03:01:57 INFO - [mozharness: 2017-04-21 10:01:57.347842Z] Finished install step (success) 03:01:57 INFO - [mozharness: 2017-04-21 10:01:57.347938Z] Running run-tests step. 03:01:57 INFO - Running pre-action listener: _resource_record_pre_action 03:01:57 INFO - Running main action method: run_tests 03:01:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:01:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:01:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:01:57 INFO - 2017-04-21 03:01:57.360 screenresolution[84825:720190] starting screenresolution argv=screenresolution get 03:01:57 INFO - 2017-04-21 03:01:57.363 screenresolution[84825:720190] Display 0: 1600x1200x32@60 03:01:57 INFO - 2017-04-21 03:01:57.368 screenresolution[84826:720193] starting screenresolution argv=screenresolution list 03:01:57 INFO - Available Modes on Display 0 03:01:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:01:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:01:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:01:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:01:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:01:57 INFO - Intel Iris: 03:01:57 INFO - Chipset Model: Intel Iris 03:01:57 INFO - Type: GPU 03:01:57 INFO - Bus: Built-In 03:01:57 INFO - VRAM (Dynamic, Max): 1536 MB 03:01:57 INFO - Vendor: Intel (0x8086) 03:01:57 INFO - Device ID: 0x0a2e 03:01:57 INFO - Revision ID: 0x0009 03:01:57 INFO - Displays: 03:01:57 INFO - Display: 03:01:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:01:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:01:57 INFO - Display Serial Number: 1600x1200 60 03:01:57 INFO - Main Display: Yes 03:01:57 INFO - Mirror: Off 03:01:57 INFO - Online: Yes 03:01:57 INFO - Rotation: Supported 03:01:57 INFO - Return code: 0 03:01:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:01:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:01:57 INFO - Python 2.7.3 03:01:57 INFO - Return code: 0 03:01:57 INFO - grabbing minidump binary from tooltool 03:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:57 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 0x105400d30>, '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 0x105326db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053f5be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:01:57 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 03:01:57 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 03:01:57 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 03:01:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:01:57 INFO - Return code: 0 03:01:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:01:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:01:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:01:57 INFO - ENV: RUST_BACKTRACE is now 1 03:01:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:01:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:01:57 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/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0002', '--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 03:01:57 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/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0002 --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 03:01:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bfjn8WvdTC/Render', 03:01:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:57 INFO - 'HOME': '/Users/cltbld', 03:01:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:57 INFO - 'LOGNAME': 'cltbld', 03:01:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:01:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:57 INFO - 'MOZ_NO_REMOTE': '1', 03:01:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:01:57 INFO - 'NO_EM_RESTART': '1', 03:01:57 INFO - 'PAGER': '/bin/cat', 03:01:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:57 INFO - 'PWD': '/builds/slave/test', 03:01:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:01:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:57 INFO - 'RUST_BACKTRACE': '1', 03:01:57 INFO - 'SHELL': '/bin/bash', 03:01:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZcJHhkVhrp/Listeners', 03:01:57 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 03:01:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:57 INFO - 'USER': 'cltbld', 03:01:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:57 INFO - 'XPC_FLAGS': '0x0', 03:01:57 INFO - 'XPC_SERVICE_NAME': '0', 03:01:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:57 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/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0002', '--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 03:01:57 INFO - mozversion application_buildid: 20170421014628 03:01:57 INFO - mozversion application_changeset: 7b43acb948540e6687bab6d508dcf6add5823e03 03:01:57 INFO - mozversion application_display_name: Nightly 03:01:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:01:57 INFO - mozversion application_name: Firefox 03:01:57 INFO - mozversion application_remotingname: firefox 03:01:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:01:57 INFO - mozversion application_vendor: Mozilla 03:01:57 INFO - mozversion application_version: 55.0a1 03:01:57 INFO - mozversion platform_buildid: 20170421014628 03:01:57 INFO - mozversion platform_changeset: 7b43acb948540e6687bab6d508dcf6add5823e03 03:01:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:01:57 INFO - mozversion platform_version: 55.0a1 03:01:57 INFO - using testdate: 1492768917 03:01:57 INFO - actual date: 1492768917 03:01:57 INFO - starting webserver on 'localhost:53210' 03:01:57 INFO - SUITE-START | Running 2 tests 03:01:57 INFO - TEST-START | dromaeo_css 03:01:57 INFO - operating with platform_type : mac_ 03:01:57 INFO - Initialising browser for dromaeo_css test... 03:01:57 INFO - TEST-INFO | started process 84836 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpdaU7ho/profile http://localhost:53210/getInfo.html) 03:02:01 INFO - PID 84836 | 2017-04-21 03:02:01.216 plugin-container[84839:720375] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3f, name = 'com.apple.tsm.portname' 03:02:01 INFO - PID 84836 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:02:01 INFO - PID 84836 | 2017-04-21 03:02:01.220 plugin-container[84839:720375] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930f, name = 'com.apple.CFPasteboardClient' 03:02:01 INFO - PID 84836 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:02:01 INFO - PID 84836 | 2017-04-21 03:02:01.220 plugin-container[84839:720375] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:02:01 INFO - PID 84836 | __metrics Screen width/height:1600/1200 03:02:01 INFO - PID 84836 | colorDepth:24 03:02:01 INFO - PID 84836 | Browser inner width/height: 1024/689 03:02:01 INFO - PID 84836 | __metrics 03:02:01 ERROR - PID 84836 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 03:02:02 INFO - TEST-INFO | 84836: exit 0 03:02:02 INFO - Browser initialized. 03:02:02 INFO - Running cycle 1/1 for dromaeo_css test... 03:02:02 INFO - TEST-INFO | started process 84840 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpdaU7ho/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:02:04 INFO - PID 84840 | 2017-04-21 03:02:04.817 plugin-container[84841:720511] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4443, name = 'com.apple.tsm.portname' 03:02:04 INFO - PID 84840 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:02:04 INFO - PID 84840 | 2017-04-21 03:02:04.817 plugin-container[84841:720511] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 03:02:04 INFO - PID 84840 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:02:04 INFO - PID 84840 | 2017-04-21 03:02:04.817 plugin-container[84841:720511] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:02:14 INFO - PID 84840 | RSS: Main: 236576768 03:02:14 INFO - PID 84840 | 03:05:18 INFO - PID 84840 | Cycle 1(1): loaded http://localhost:53210/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53210/tests/dromaeo/cssquery-ext.html) 03:05:19 INFO - PID 84840 | RSS: Main: 251883520 03:05:19 INFO - PID 84840 | 03:07:02 INFO - PID 84840 | ************************* 03:07:02 INFO - PID 84840 | A coding exception was thrown and uncaught in a Task. 03:07:02 INFO - PID 84840 | 03:07:02 ERROR - PID 84840 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:07:02 INFO - PID 84840 | Full stack: 03:07:02 INFO - PID 84840 | ************************* 03:07:02 INFO - PID 84840 | ************************* 03:07:02 INFO - PID 84840 | A coding exception was thrown and uncaught in a Task. 03:07:02 INFO - PID 84840 | 03:07:02 ERROR - PID 84840 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:07:02 INFO - PID 84840 | Full stack: 03:07:02 INFO - PID 84840 | ************************* 03:07:02 INFO - PID 84840 | ************************* 03:07:02 INFO - PID 84840 | A coding exception was thrown and uncaught in a Task. 03:07:02 INFO - PID 84840 | 03:07:02 ERROR - PID 84840 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:07:02 INFO - PID 84840 | Full stack: 03:07:02 INFO - PID 84840 | ************************* 03:07:02 INFO - PID 84840 | ************************* 03:07:02 INFO - PID 84840 | A coding exception was thrown and uncaught in a Task. 03:07:02 INFO - PID 84840 | 03:07:02 ERROR - PID 84840 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:07:02 INFO - PID 84840 | Full stack: 03:07:02 INFO - PID 84840 | ************************* 03:08:21 INFO - PID 84840 | Cycle 1(1): loaded http://localhost:53210/tests/dromaeo/cssquery-ext.html (next: http://localhost:53210/tests/dromaeo/cssquery-jquery.html) 03:08:22 INFO - PID 84840 | RSS: Main: 256081920 03:08:22 INFO - PID 84840 | 03:11:24 INFO - PID 84840 | Cycle 1(1): loaded http://localhost:53210/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53210/tests/dromaeo/cssquery-mootools.html) 03:11:24 INFO - PID 84840 | RSS: Main: 267030528 03:11:24 INFO - PID 84840 | 03:14:26 INFO - PID 84840 | Cycle 1(1): loaded http://localhost:53210/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53210/tests/dromaeo/cssquery-prototype.html) 03:14:27 INFO - PID 84840 | RSS: Main: 260329472 03:14:27 INFO - PID 84840 | 03:17:30 INFO - PID 84840 | Cycle 1(1): loaded http://localhost:53210/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53210/tests/dromaeo/cssquery-yui.html) 03:17:30 INFO - PID 84840 | RSS: Main: 269656064 03:17:30 INFO - PID 84840 | 03:20:32 INFO - PID 84840 | Cycle 1(1): loaded http://localhost:53210/tests/dromaeo/cssquery-yui.html (next: http://localhost:53210/tests/dromaeo/cssquery-dojo.html) 03:20:32 INFO - PID 84840 | RSS: Main: 264294400 03:20:32 INFO - PID 84840 | 03:20:32 INFO - PID 84840 | __start_tp_report 03:20:32 INFO - PID 84840 | _x_x_mozilla_page_load 03:20:32 INFO - PID 84840 | _x_x_mozilla_page_load_details 03:20:32 INFO - PID 84840 | |i|pagename|runs| 03:20:32 INFO - PID 84840 | |0;dojo.html;3532.275883443894;3540.9822950885227;3563.3229686359605;3581.391163502205;3592.4431713084464;5610.4670056344585;6100.938990610087;6121.908171377428;6156.1073644321605;6170.938290617092;6003.819885403434;6104.610739188311;6106.21798979648;6138.143176733777;6182.103594978726;5339.279197308372;5393.919091213635;5414.512693857552;5465.125579907216;5502.669839809604;5336.279602253704;5387.649802762828;5437.564994800427;5451.155070964007;5475.67145971241;5386.757595908193;5441.673499590037;5445.646033007842;5458.699771512565;5493.148561972901;5245.31810864589;5325.4940780625775;5337.066013447631;5337.412884582693;5343;5336.43967383423;5353.009693206769;5390.460953904618;5400.83797486076;5430.728463576806;4793.5925446337105;5733.140028995643;6054.51563874889;6130.8773824523705;6155.630662160284;5372.194170874361;6225.19072520574;6352.682365881734;6530.249021362509;6639.136912201431;5565.5825813063775;6588.209414870246;6679.899801502981;6687.498437617198;6693.564918280296;6216.222972128484;6270.65511396873;6271.717772700239;6281.748730050838;6286.591371560834;6510.9023364649565;6813.182418109858;6822.215445223764;6931.549449285781;6936.2023367312395;5489.2589500417735;6296.65368404733;6331.683415829282;6407.711652975628;6443.581167224115;5872.265966754156;6122.020476723792;6488.805335839932;6704.061431399608;6723.294054124247;6413.807585772434;6562.737490500326;6568.376004279586;6589.242237142694;6610.900836487456;6569.835754106186;6582.3746744059235;6595.373439523238;6617.669116544153;6619.933800662028;5145.897082058338;5196.974015129976;5221.13851214553;5252.501012403815;5308.177232528964;4670.486246512881;4684.531546845288;4687.67186296956;4721;4775.42694876617;5311;6171.783987560414;6242.812715618448;6264.718087686065;6264.718087686065;6421.133147025185;6503.9349606504275;6629.569078009914;6633.86732265352;6681.098051763047;6214.130021796862;6239.157713708682;6283.8114856554375;6290.811275661737;6299.622022678654;5845.357010728816;5859.501942334864;5868.413158684183;5878.2358293421585;5897.997340452133;6587.703553340016;6696.464282857262;6873.759418420332;6880.243173251039;6883.242843287235;6662.866742665023;6677.265500795006;6682.431993280626;6731.124953755981;6769;5114.948850511596;6836.555623884432;6869.587824730333;6936.4797640176175;6939.063226464363;6306.432421082125;6558.409743123142;6609.339066093352;6633.900491492535;6654.600723956578;6496.382843629847;6577.934220657924;6624.403803657694;6647.069410282661;6713.194416669836;5286.788528458818;5295.629305948547;6335.936640633719;6521;6535.771248006297;6218.53360997936;6256.530760192913;6329.240491141092;6449.709763060768;6516.609003459807;6186.783462578788;6210.968945155245;6306.306306306211;6364.268109167319;6368.681565921593;6537.248216455168;6541.149650545399;6550.050242714684;6551.934480655323;6560.081588577507;5410.296661433988;6164.4760195382105;6224.813255602339;6375.171227740364;6391.58454700443 03:20:32 INFO - PID 84840 | |1;ext.html;672.4452326830364;788.400815380311;810.5298926622557;1028.7171027967313;1082.6048492300313;35791.64208357919;37188.07029824256;37225.06937326565;37258.999999999935;37371;39545.60454395455;40084.398734019014;40118;40178.59821401785;40207;8435.70475033374;8582.356323275764;8668;8706.259967902735;8743.475391476532;8710.738677839676;8739.126087391242;8838.29293656509;8850.5574721264;8856.468611883307;8767.95616021919;8771.605277762515;8834.38159328844;8855.335849811258;8856.380053396233;8781.912180878173;8813;8824.602892869772;8842.911570884306;8865.645374185026;8458.36562257833;8524.445911015764;8530.402871798977;8542.18849209324;8560.828783424358;38633.61366386328;38698.41952370717;38879.611203887885;38895.22209555793;38939.026524336834;3626.8911932642063;3665.065408320888;3674.1182116292166;3675.4303083022173;3683.852645894161;31326;31805.52291715626;31831;31850.044498665076;31896;3119.23578723212;3212.903612891617;3216.34065016671;3219.935601287961;3237.3039796443877;220059;222875;267829.9999999981;310937;311609;48988;49292.75353623209;49339.25991110136;49379;49390.25914611212;51684.741576291875;52055.69860753436;52122;52156.47843521592;52218;14209.85790142106;14245.715085698228;14355.928220358832;14378.28108594587;14389.42442302317;11640.592579259684;11712.004479619327;11729.941350293364;11734.354610496333;11754.29474231549;11513.942430287794;13276;13743;13833.239171845444;13966.650833729238;5163.863949931009;5210.879660872931;5613.943860561424;5903.468687818117;5925.792597259161;909.7862002429424;943.2218419803689;1026.6355443817338;1043.89561043895;1069.0752499088387;20047.699284510745;22125.672459652473;22216.111355545596;24297.271081867573;24444.38889027753;1018.7554986803113;1062.102523367753;1076.4187338837096;1123.7246874515633;1158.976820463603;12638.368081595883;12745.872541274468;12798.680032999064;12812.42344094518;13057.21656700601;332279;333918;335156;335865.32067339506;336247;56003.719981400645;56200;56382.7180864093;56428.435715643136;56556;1504.2253239581623;1525.6948610277989;1564.8043994500688;1569.395782623698;1574.3781206423398;20150.496237594176;23909.52180956406;24366.878165609058;24515.322701594905;24531.38671533226;38407;40186.39720404255;40298.9925251871;40328;40384.59615403926;263641;277039;279200;280553;282273;27260.454790904467;35095.12262193466;35222.82388588143;35887.64112358843;35967.92096237117;46020.769896150305;46815.531844681114;46832;47004;47123.52876471191;30236;31277.68722312839;31335.21661958469;31747.20631984219;31819.522707158947;28008;30778.846105770222;31454.37091258208;31555.94886332381;31792;28826.711732882402;33522.66477335196;36209.09477262984;38440.80779596084;38614.80692596519;25911.611325829752;28530;29683.703162968093;30368.240793980327;30827.0751877444;24795;24820.751792481846;24834.25497235086;24867.875660622303;25029.624555631315 03:20:32 INFO - PID 84840 | |2;jquery.html;350.852641890406;425.38768733513774;430.8233624214073;445.63235330852046;450.78587670856325;16739.493445589895;20647.587048259025;21514.569708605817;21906;22075.889620551916;22143;22239.666405003896;22558.661620075673;22932.656010159862;23008.194713185043;6060.939390606092;6218.844528886769;6266.185395898527;6282.623042617434;6288.496920246393;5923.822285331447;6085.878282434349;6124.265088189423;6164;6167.599106058092;6096.512279017668;6115.908261376061;6121.479674227696;6126.724297406605;6151.815445536618;5836.649801011931;6057.848553786169;6087;6087.726052327655;6103.633781973073;5219.608529360313;5393.083175860113;5409.594280428944;5439.374471935738;5452.754626041798;25882.87058564714;26180.476390472275;26402.339941501617;26427.867860660575;26761.73238267612;2249.640057590778;2291.2438895164555;2326.3137374474572;2327.918522851692;2337.6026075567192;17752.55618609545;17937.461876143607;18259.72610410845;18320.541986450313;18379;2125.798049185325;2220.9777902221094;2222.699935508702;2223.855449395784;2227.4208705736464;158416;160035.1998240013;161050;161843;162038.18980905137;10500.842487362695;13045.608631741063;13174.934125329311;13189.670258243621;13217.669558261121;16679.416220432468;16849.073300968565;16921.915390423215;16922.830771692126;16942.322307107825;8715.084916083846;9031.909680903238;9059.773505662411;9173.312001599774;9183.90816091844;8537.103604121601;8541.44480608771;8549.871751923725;8700.434471759316;8740.781480462912;8062.234087761653;8157.347412207009;8192;8248.628811703487;8249.29880960125;1883.2372888979985;2180.4112889519743;2186.5080356919884;2198.6372248579123;2389.9761002389755;927.6753136402206;934.5654270764128;948.8624149498285;964.7732782796037;988.9258305626963;20071.59856802885;20745.688814667792;20759.896200518902;20793.376198714064;20796.48008799792;785.5443842571295;878.1438097854668;907.9409838360485;907.9921287371013;1010.8231059564547;7842.647080881374;10244.505111292781;10686.679399618024;10718.464076796128;10875.238733288594;557764;565710;571054;571441.1427942917;572372;127870;133829.33085334706;135922;142334;142463.6166840806;1182.526989204308;1192.9105317101253;1235.3699613197155;1245.1221888568537;1245.4457766294092;21806.01872915691;21970.89014554981;22092.784896830184;22213.77786222117;22217.66673499931;58912.11631825612;59471.40528594659;60161.39838601733;60210.698946504985;61385;75381.86927196206;80950;82103;82165.58917205376;82221.58889205515;8722;8825.823483530165;8928.73213803561;9322.906770932475;9384.202342800938;11890.940545297219;14545.054571452822;14700.191489467754;15006.174660393783;15037.323320450387;11921.940390297994;12083.818742719042;12308.815367769312;12332.136750427742;12380.328655631374;11323.32060076398;11449;11575.016123629586;11765.411729413667;11802.409879506162;12383.75232495363;12435.875641243472;12582.559610413591;12745.74508509806;12867;8713;9104.180623743894;9150.771230719285;9162.816743665222;9217.170454659114;9652.420854748456;11145.2198346115;11696.941515292368;12182.710668119735;12339.69150771238 03:20:32 INFO - PID 84840 | |3;mootools.html;1409.6334952912243;1433.9354729037186;1454.7454195515782;1475.9852401475982;1482.5922871210423;10385.688429347123;10673.519691613887;10798.784024319519;11428.257163284381;11945.820812687816;11175.273607215526;11418.7145321367;11529.250598711078;11605.593804216855;11630.709232269197;2491.202815099169;2535.378832186108;2557.1177943609423;2558.2581051495044;2561.1804222648666;2459.557279689655;2490.2902672738273;2525.6969163700383;2548.197317844882;2555.821092523515;2282.0415425521237;2366.9053237870467;2444.9511009779794;2511.309389917769;2573.1508602161334;2437.402836305108;2485.8135639826996;2496.3010357100043;2498.6127150291554;2513.1329691256487;2408.1932552594903;2494.4886298308984;2495.026939493599;2504.348869293997;2525.6464095026713;11388;11459.598914037968;11738.178327516991;11841.40792960357;11934.045276377869;6508.837279068014;6800.727970881158;6817.727290908358;6843.3840954314355;6859.039734437133;4140.523839758436;4308.569143085666;4404.229259879508;4436.44544431946;4469.9776501117285;1076.682378698286;1265.2218885385514;1284.094713227182;1306.6406738147086;1307.8495972963135;15989.920050399789;16340.918295408566;16486.6702665946;16657.83342166587;16705.49883503509;5368.248445217672;5672.858178545569;5856.238688970407;5939.426052096198;5967.940320596738;12026.75946481083;12050.819237711441;12242.693932651755;12259.632211033684;12334.691632709255;6651.966740166365;6656;6663.800085997428;6715.227748808852;6727.327267273331;5974.61165024272;6151.907721384183;6221.782237621752;6277.560570760094;6279.995200767855;4391.8462853799965;4516.16450956574;4525.343825145335;4547.272436410225;4586.2661974083985;1310.6199202231246;1326.403118596616;1328.6479083043002;1337.779266421049;1341.5438750824767;672.6905623413187;716.5808002318598;730.5032577847115;783.9960800196077;801.7554645833077;5170.741462926839;5210.6613070150315;6284.402981716729;6443.420092191725;6542.443892269211;578.5169383564687;587.952963762898;596.9136172166702;600.6156060121526;603.3815339277276;4565.223911934912;4571.817127314936;4614.74618895964;4739.95260047402;4794.352762377104;12293.815592766116;14482;15029.624259393602;15147.924260378628;15197.848021519865;14388;14634.195119268543;14997.550073497812;15061.472848450252;15135.318910649048;6967.721291148398;7445.069366329209;8262.42163048593;8392.16078392156;8438.873416898752;5641.746121424628;5874.500667443315;6782.423494003065;6846.7945961621235;7112.964435177998;12240.877591223974;12279.570215042431;12637.87362126367;12749.617511474671;12794.552190673281;12892.162009469355;12926.741465170457;13028.869711303145;13064.54274100402;13356.265405402795;9427.622895084394;9573.569189386355;9617.807643846943;9803.264755143535;9879.604815807288;9835.704928852147;9966.604675345312;10493.108085812792;10735.89264107349;10783.838242426527;9181.77045573866;9242.72271831846;9244.168024877794;9274.165325120772;9400.200982916254;8868.911310887066;8979.326550508607;8992.685256016008;9012.504312262889;9081.59132839037;8127.3091787198755;8215.09633940278;8259.587020648823;8323.625436855476;8351.373646976379;6066.757329706938;6068.241469816273;6171.59884607499;6239.06414037898;6249.843753906007;5229.947700522946;6117.96941015292;6149.2313460817395;6293.874122517615;6322.7670604231735 03:20:32 INFO - PID 84840 | |4;prototype.html;368.90224090615993;399.71420434389404;401.46639835827153;408.6832704653891;415.0992346607862;4934.25986102084;5529.355341513128;5664.801731939383;5835.183074369592;5841;4273.444452221207;5509.641873278234;5571.690652696623;5667.829965101054;5706.9727449059155;4378.8686339409705;4397.604215620586;4399.206503870049;4414.3378493225955;4423.810213944086;4118.485189351331;4160.895977600554;4429.889252768674;4443.333499974998;4454.643628509712;3645.6172101929183;3737.177820879402;4062.6140516651017;4275.294576394891;4422.049259409227;3479.565054368204;3552.378333791576;4253.936190957138;4279.529251782302;4312.310030395138;3062.0660698486954;3730.3658378075793;3750.6811920986747;3753.60587138352;3755.7183211259266;5389.892202155974;5669.206311116447;5673.23411339468;5677.517411020068;5719.456651618089;4390.429244198266;4665;5123.718195499246;5135.611940447672;5136.229565565158;6242.282137554194;6248.968755156195;6258.4680302174365;6272.623642581414;6273.780417685405;3624.894407205801;3980.7213495055357;4246.278132717445;4255.085156691295;4265.573442655709;6195.81412557624;6224.968875155595;6465.579737317106;6507.837304067389;6693.966530167318;3438.570178727659;3559.893203203856;4000.8199631016673;4089.938650920179;4295.398644189816;3871.4192871069563;4143.212789570032;4390.143921935192;4390.780460976938;4409.867703968886;4845.224764037737;5056.924146137811;5111.386633603991;5142.434332223453;5143.794248230029;5368.651037682616;6032.00471922128;6284.146176877832;6291.307956124822;6294.464970477561;1310.8230388897568;1483.725510780509;1485.2944851195812;1488.3823213366547;1491.6792889528804;901.4951627088851;929.025820132219;974.6734843827255;993.9503024848873;1011.5245834457793;5968.7015649217365;5969.671668058299;5972.641641501524;6006.12911127884;6020.668863212478;5699.487046165782;6036.969815150984;6185.567010309325;6529.836754081091;6549.967250163814;4638.0491999140095;4982.4768399317545;5707.828765137053;5955.553333500005;5968.1942937703725;2953.7784666150123;3321.4519604265024;3371.4268574342423;3371.6291207967106;3387.644297348743;5544.3346798384455;6014.248218972629;6365.713542890581;6660.70026848793;6722.924332106937;5551.500364967173;5753.568482363839;5770.855728606734;6072.908906366408;6606.372394622599;5979.850503737354;6668.799936001928;6671.099401580725;6688;6710;4997.700137991732;5530.05988981866;5620.718964051863;6159.583295841891;6405.3594640535575;5734.827955161351;6396.872062558629;6479.611223326616;6495.610263384212;6541.672916354259;6081.5742897996715;6377.7767778127545;6697.732090716317;6773.491988101011;6792.72829086831;4133.648639865525;4365.5197928227235;4580.770961451847;4778.1638213311835;4783.6412269079265;4942.555170034714;5313.628046036741;5436.972815135899;6313.10606817962;6547.410733033859;5134.460881607378;5540.445955404427;6085.421884920926;6251.71867265965;6289.591176573508;5440.700761458158;6302.779402720883;6314.147590075281;6317.273513545817;6330.683465826598;4799.272261985752;6157.630542167484;6174.25908890936;6175.505959523138;6207.534434917489;5553.8611534710335;5783.392743762012;6037.698115094316;6240.4071613196675;6322.905156422749;5616.354119276336;5690.804930964378;6001.399860013964;6055.000924847351;6128.325884152829 03:20:32 INFO - PID 84840 | |5;yui.html;822.7161629237911;839.7228914458226;840.2605706977861;847.4406891451639;862.3058437957442;15998.920005399972;16240.269187886544;16630.75053874193;18190.45428637143;18791.966441845692;17477.475675729747;17764.64470710585;18024.54938626535;18072.367467138654;18306.908465457687;946.5740416812428;962.451402700461;967.6032826541119;969.0600117885675;972.610955617755;970.1268858027796;993.46849435552;993.538004827755;996.566493575297;1000.1348833259251;1036.9585216591327;1047.9633212837552;1055.9472026398687;1058.5712786321515;1059.7668512927144;1025.2413214221422;1050;1052.079430498314;1053.525913338993;1054.9924821795166;742.22066829829;746.6490749347798;761.3984951888002;764.1403421151205;768.0514564512822;16428.096454694987;16661.416850410176;16780;16841.747373789403;16853.157342132967;16437.83562164387;16438;16751.246193921303;16891.662166756596;16896.493105206864;13470.865291347158;13575.864241357558;13649.658758531017;13755.243461609607;13828.93085534576;3474.9652503474895;3533.6643018913164;3537.6108628050893;3539.3098345822573;3541.451075083366;93557.5322123385;115851;118291.81708182894;128855;130859.34570327183;12198.207116537396;13218.669533261746;13416.530421435398;13534.45862165522;13555.728885422433;20340.79659203389;23299.417514561934;24306.392340191283;25167.867445964974;25214.36964075876;7725.304722574995;7735.9613201933635;7761.922380776233;8018.799530011796;8031.156728543536;3859.729818912649;3977.443157957888;3992.540857801332;4031.5162180538523;4031.6169963853386;4314.482262128502;4350.564943505624;4389.780510974439;4412.227860124465;4442.4669039715445;809.8501777171242;939.5255396024963;964.4599024546277;966.0918736387773;972.8005758819424;616.2252712188867;637.9362063793584;648.8053583924803;649.2047242128355;672.4620303756975;10966.945165274123;11595.130365222474;11910.166288359906;11969.700757481132;12566.246025238515;560.7504660426152;602.7106988645475;641.153677146172;650.1742786660914;654.9770758023446;5366.597505187126;5484.588655850827;5488.670679759227;5515.227868098469;5618.185363122325;99142.08579142028;104687.4765626167;104942.95057049484;106060.46969765256;106192.46903765431;92053;93124;93735;95349;95910;73770;81825;82103.17896820956;82230;82294.11970581001;11065.723356916142;11247.381394023407;11358.60244891425;11413.486393112164;11529.250598711056;40029.39955900606;40065;40409.1918161641;40586;40847.591524084375;51368;51440.971180576926;51973.7401312991;52146;52300.16949406905;13887.30563471802;13933.303334833015;14290.785638215642;14456.494022709154;14497.492587759378;15480.5355839325;15566.533004009898;15707.978981366176;15737.291821867815;15879.967802092828;14232.288385580887;14531.346089426213;14611.634709132357;14640.926795365955;14704.55886323412;14280.07179533327;14606.561803145923;16548.255328510488;16987.490375288762;17435.912820435817;16533.421330253383;16627.83372166311;16794.748078779074;16877.32490700358;16926.830731692524;11546.364949927498;11632.243904146204;12022.819657704966;12046.149472014302;12150.149489535648;11883.881161188277;12829.550965716155;13187.944964403017;13247.403866825824;13329.133606315558 03:20:32 INFO - PID 84840 | __end_tp_report 03:20:32 INFO - PID 84840 | __start_cc_report 03:20:32 INFO - PID 84840 | _x_x_mozilla_cycle_collect,429 03:20:32 INFO - PID 84840 | __end_cc_report 03:20:32 INFO - PID 84840 | __startTimestamp1492770032805__endTimestamp 03:20:32 INFO - PID 84840 | 03:20:32 INFO - PID 84840 | ------- Summary: start ------- 03:20:32 INFO - PID 84840 | Number of tests: 6 03:20:32 INFO - PID 84840 | 03:20:32 INFO - PID 84840 | [#0] dojo.html Cycles:165 Average:6033.36 Median:6264.72 stddev:721.26 (11.5%) stddev-sans-first:696.27 03:20:32 INFO - PID 84840 | Values: 3532.3 3541.0 3563.3 3581.4 3592.4 5610.5 6100.9 6121.9 6156.1 6170.9 6003.8 6104.6 6106.2 6138.1 6182.1 5339.3 5393.9 5414.5 5465.1 5502.7 5336.3 5387.6 5437.6 5451.2 5475.7 5386.8 5441.7 5445.6 5458.7 5493.1 5245.3 5325.5 5337.1 5337.4 5343.0 5336.4 5353.0 5390.5 5400.8 5430.7 4793.6 5733.1 6054.5 6130.9 6155.6 5372.2 6225.2 6352.7 6530.2 6639.1 5565.6 6588.2 6679.9 6687.5 6693.6 6216.2 6270.7 6271.7 6281.7 6286.6 6510.9 6813.2 6822.2 6931.5 6936.2 5489.3 6296.7 6331.7 6407.7 6443.6 5872.3 6122.0 6488.8 6704.1 6723.3 6413.8 6562.7 6568.4 6589.2 6610.9 6569.8 6582.4 6595.4 6617.7 6619.9 5145.9 5197.0 5221.1 5252.5 5308.2 4670.5 4684.5 4687.7 4721.0 4775.4 5311.0 6171.8 6242.8 6264.7 6264.7 6421.1 6503.9 6629.6 6633.9 6681.1 6214.1 6239.2 6283.8 6290.8 6299.6 5845.4 5859.5 5868.4 5878.2 5898.0 6587.7 6696.5 6873.8 6880.2 6883.2 6662.9 6677.3 6682.4 6731.1 6769.0 5114.9 6836.6 6869.6 6936.5 6939.1 6306.4 6558.4 6609.3 6633.9 6654.6 6496.4 6577.9 6624.4 6647.1 6713.2 5286.8 5295.6 6335.9 6521.0 6535.8 6218.5 6256.5 6329.2 6449.7 6516.6 6186.8 6211.0 6306.3 6364.3 6368.7 6537.2 6541.1 6550.1 6551.9 6560.1 5410.3 6164.5 6224.8 6375.2 6391.6 03:20:32 INFO - PID 84840 | 03:20:32 INFO - PID 84840 | [#1] ext.html Cycles:180 Average:44818.49 Median:184693.99 stddev:77407.92 (41.9%) stddev-sans-first:77554.11 03:20:32 INFO - PID 84840 | Values: 672.4 788.4 810.5 1028.7 1082.6 35791.6 37188.1 37225.1 37259.0 37371.0 39545.6 40084.4 40118.0 40178.6 40207.0 8435.7 8582.4 8668.0 8706.3 8743.5 8710.7 8739.1 8838.3 8850.6 8856.5 8768.0 8771.6 8834.4 8855.3 8856.4 8781.9 8813.0 8824.6 8842.9 8865.6 8458.4 8524.4 8530.4 8542.2 8560.8 38633.6 38698.4 38879.6 38895.2 38939.0 3626.9 3665.1 3674.1 3675.4 3683.9 31326.0 31805.5 31831.0 31850.0 31896.0 3119.2 3212.9 3216.3 3219.9 3237.3 220059.0 222875.0 267830.0 310937.0 311609.0 48988.0 49292.8 49339.3 49379.0 49390.3 51684.7 52055.7 52122.0 52156.5 52218.0 14209.9 14245.7 14355.9 14378.3 14389.4 11640.6 11712.0 11729.9 11734.4 11754.3 11513.9 13276.0 13743.0 13833.2 13966.7 5163.9 5210.9 5613.9 5903.5 5925.8 909.8 943.2 1026.6 1043.9 1069.1 20047.7 22125.7 22216.1 24297.3 24444.4 1018.8 1062.1 1076.4 1123.7 1159.0 12638.4 12745.9 12798.7 12812.4 13057.2 332279.0 333918.0 335156.0 335865.3 336247.0 56003.7 56200.0 56382.7 56428.4 56556.0 1504.2 1525.7 1564.8 1569.4 1574.4 20150.5 23909.5 24366.9 24515.3 24531.4 38407.0 40186.4 40299.0 40328.0 40384.6 263641.0 277039.0 279200.0 280553.0 282273.0 27260.5 35095.1 35222.8 35887.6 35967.9 46020.8 46815.5 46832.0 47004.0 47123.5 30236.0 31277.7 31335.2 31747.2 31819.5 28008.0 30778.8 31454.4 31555.9 31792.0 28826.7 33522.7 36209.1 38440.8 38614.8 25911.6 28530.0 29683.7 30368.2 30827.1 24795.0 24820.8 24834.3 24867.9 25029.6 03:20:32 INFO - PID 84840 | 03:20:32 INFO - PID 84840 | [#2] jquery.html Cycles:180 Average:36702.33 Median:2327.12 stddev:96465.74 (4145.3%) stddev-sans-first:96697.74 03:20:32 INFO - PID 84840 | Values: 350.9 425.4 430.8 445.6 450.8 16739.5 20647.6 21514.6 21906.0 22075.9 22143.0 22239.7 22558.7 22932.7 23008.2 6060.9 6218.8 6266.2 6282.6 6288.5 5923.8 6085.9 6124.3 6164.0 6167.6 6096.5 6115.9 6121.5 6126.7 6151.8 5836.6 6057.8 6087.0 6087.7 6103.6 5219.6 5393.1 5409.6 5439.4 5452.8 25882.9 26180.5 26402.3 26427.9 26761.7 2249.6 2291.2 2326.3 2327.9 2337.6 17752.6 17937.5 18259.7 18320.5 18379.0 2125.8 2221.0 2222.7 2223.9 2227.4 158416.0 160035.2 161050.0 161843.0 162038.2 10500.8 13045.6 13174.9 13189.7 13217.7 16679.4 16849.1 16921.9 16922.8 16942.3 8715.1 9031.9 9059.8 9173.3 9183.9 8537.1 8541.4 8549.9 8700.4 8740.8 8062.2 8157.3 8192.0 8248.6 8249.3 1883.2 2180.4 2186.5 2198.6 2390.0 927.7 934.6 948.9 964.8 988.9 20071.6 20745.7 20759.9 20793.4 20796.5 785.5 878.1 907.9 908.0 1010.8 7842.6 10244.5 10686.7 10718.5 10875.2 557764.0 565710.0 571054.0 571441.1 572372.0 127870.0 133829.3 135922.0 142334.0 142463.6 1182.5 1192.9 1235.4 1245.1 1245.4 21806.0 21970.9 22092.8 22213.8 22217.7 58912.1 59471.4 60161.4 60210.7 61385.0 75381.9 80950.0 82103.0 82165.6 82221.6 8722.0 8825.8 8928.7 9322.9 9384.2 11890.9 14545.1 14700.2 15006.2 15037.3 11921.9 12083.8 12308.8 12332.1 12380.3 11323.3 11449.0 11575.0 11765.4 11802.4 12383.8 12435.9 12582.6 12745.7 12867.0 8713.0 9104.2 9150.8 9162.8 9217.2 9652.4 11145.2 11696.9 12182.7 12339.7 03:20:32 INFO - PID 84840 | 03:20:32 INFO - PID 84840 | [#3] mootools.html Cycles:180 Average:7039.37 Median:4398.04 stddev:4400.90 (100.1%) stddev-sans-first:4392.91 03:20:32 INFO - PID 84840 | Values: 1409.6 1433.9 1454.7 1476.0 1482.6 10385.7 10673.5 10798.8 11428.3 11945.8 11175.3 11418.7 11529.3 11605.6 11630.7 2491.2 2535.4 2557.1 2558.3 2561.2 2459.6 2490.3 2525.7 2548.2 2555.8 2282.0 2366.9 2445.0 2511.3 2573.2 2437.4 2485.8 2496.3 2498.6 2513.1 2408.2 2494.5 2495.0 2504.3 2525.6 11388.0 11459.6 11738.2 11841.4 11934.0 6508.8 6800.7 6817.7 6843.4 6859.0 4140.5 4308.6 4404.2 4436.4 4470.0 1076.7 1265.2 1284.1 1306.6 1307.8 15989.9 16340.9 16486.7 16657.8 16705.5 5368.2 5672.9 5856.2 5939.4 5967.9 12026.8 12050.8 12242.7 12259.6 12334.7 6652.0 6656.0 6663.8 6715.2 6727.3 5974.6 6151.9 6221.8 6277.6 6280.0 4391.8 4516.2 4525.3 4547.3 4586.3 1310.6 1326.4 1328.6 1337.8 1341.5 672.7 716.6 730.5 784.0 801.8 5170.7 5210.7 6284.4 6443.4 6542.4 578.5 588.0 596.9 600.6 603.4 4565.2 4571.8 4614.7 4740.0 4794.4 12293.8 14482.0 15029.6 15147.9 15197.8 14388.0 14634.2 14997.6 15061.5 15135.3 6967.7 7445.1 8262.4 8392.2 8438.9 5641.7 5874.5 6782.4 6846.8 7113.0 12240.9 12279.6 12637.9 12749.6 12794.6 12892.2 12926.7 13028.9 13064.5 13356.3 9427.6 9573.6 9617.8 9803.3 9879.6 9835.7 9966.6 10493.1 10735.9 10783.8 9181.8 9242.7 9244.2 9274.2 9400.2 8868.9 8979.3 8992.7 9012.5 9081.6 8127.3 8215.1 8259.6 8323.6 8351.4 6066.8 6068.2 6171.6 6239.1 6249.8 5229.9 6118.0 6149.2 6293.9 6322.8 03:20:32 INFO - PID 84840 | 03:20:32 INFO - PID 84840 | [#4] prototype.html Cycles:180 Average:4968.89 Median:5562.78 stddev:1560.78 (28.1%) stddev-sans-first:1526.49 03:20:32 INFO - PID 84840 | Values: 368.9 399.7 401.5 408.7 415.1 4934.3 5529.4 5664.8 5835.2 5841.0 4273.4 5509.6 5571.7 5667.8 5707.0 4378.9 4397.6 4399.2 4414.3 4423.8 4118.5 4160.9 4429.9 4443.3 4454.6 3645.6 3737.2 4062.6 4275.3 4422.0 3479.6 3552.4 4253.9 4279.5 4312.3 3062.1 3730.4 3750.7 3753.6 3755.7 5389.9 5669.2 5673.2 5677.5 5719.5 4390.4 4665.0 5123.7 5135.6 5136.2 6242.3 6249.0 6258.5 6272.6 6273.8 3624.9 3980.7 4246.3 4255.1 4265.6 6195.8 6225.0 6465.6 6507.8 6694.0 3438.6 3559.9 4000.8 4089.9 4295.4 3871.4 4143.2 4390.1 4390.8 4409.9 4845.2 5056.9 5111.4 5142.4 5143.8 5368.7 6032.0 6284.1 6291.3 6294.5 1310.8 1483.7 1485.3 1488.4 1491.7 901.5 929.0 974.7 994.0 1011.5 5968.7 5969.7 5972.6 6006.1 6020.7 5699.5 6037.0 6185.6 6529.8 6550.0 4638.0 4982.5 5707.8 5955.6 5968.2 2953.8 3321.5 3371.4 3371.6 3387.6 5544.3 6014.2 6365.7 6660.7 6722.9 5551.5 5753.6 5770.9 6072.9 6606.4 5979.9 6668.8 6671.1 6688.0 6710.0 4997.7 5530.1 5620.7 6159.6 6405.4 5734.8 6396.9 6479.6 6495.6 6541.7 6081.6 6377.8 6697.7 6773.5 6792.7 4133.6 4365.5 4580.8 4778.2 4783.6 4942.6 5313.6 5437.0 6313.1 6547.4 5134.5 5540.4 6085.4 6251.7 6289.6 5440.7 6302.8 6314.1 6317.3 6330.7 4799.3 6157.6 6174.3 6175.5 6207.5 5553.9 5783.4 6037.7 6240.4 6322.9 5616.4 5690.8 6001.4 6055.0 6128.3 03:20:32 INFO - PID 84840 | 03:20:32 INFO - PID 84840 | [#5] yui.html Cycles:180 Average:21265.06 Median:18131.41 stddev:30004.40 (165.5%) stddev-sans-first:30049.31 03:20:32 INFO - PID 84840 | Values: 822.7 839.7 840.3 847.4 862.3 15998.9 16240.3 16630.8 18190.5 18792.0 17477.5 17764.6 18024.5 18072.4 18306.9 946.6 962.5 967.6 969.1 972.6 970.1 993.5 993.5 996.6 1000.1 1037.0 1048.0 1055.9 1058.6 1059.8 1025.2 1050.0 1052.1 1053.5 1055.0 742.2 746.6 761.4 764.1 768.1 16428.1 16661.4 16780.0 16841.7 16853.2 16437.8 16438.0 16751.2 16891.7 16896.5 13470.9 13575.9 13649.7 13755.2 13828.9 3475.0 3533.7 3537.6 3539.3 3541.5 93557.5 115851.0 118291.8 128855.0 130859.3 12198.2 13218.7 13416.5 13534.5 13555.7 20340.8 23299.4 24306.4 25167.9 25214.4 7725.3 7736.0 7761.9 8018.8 8031.2 3859.7 3977.4 3992.5 4031.5 4031.6 4314.5 4350.6 4389.8 4412.2 4442.5 809.9 939.5 964.5 966.1 972.8 616.2 637.9 648.8 649.2 672.5 10966.9 11595.1 11910.2 11969.7 12566.2 560.8 602.7 641.2 650.2 655.0 5366.6 5484.6 5488.7 5515.2 5618.2 99142.1 104687.5 104943.0 106060.5 106192.5 92053.0 93124.0 93735.0 95349.0 95910.0 73770.0 81825.0 82103.2 82230.0 82294.1 11065.7 11247.4 11358.6 11413.5 11529.3 40029.4 40065.0 40409.2 40586.0 40847.6 51368.0 51441.0 51973.7 52146.0 52300.2 13887.3 13933.3 14290.8 14456.5 14497.5 15480.5 15566.5 15708.0 15737.3 15880.0 14232.3 14531.3 14611.6 14640.9 14704.6 14280.1 14606.6 16548.3 16987.5 17435.9 16533.4 16627.8 16794.7 16877.3 16926.8 11546.4 11632.2 12022.8 12046.1 12150.1 11883.9 12829.6 13187.9 13247.4 13329.1 03:20:32 INFO - PID 84840 | -------- Summary: end -------- 03:20:32 INFO - PID 84840 | 03:20:33 INFO - TEST-INFO | 84840: exit 0 03:20:33 INFO - TEST-OK | dromaeo_css | took 1115562ms 03:20:33 INFO - TEST-START | kraken 03:20:33 INFO - operating with platform_type : mac_ 03:20:33 INFO - Initialising browser for kraken test... 03:20:33 INFO - TEST-INFO | started process 84848 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmp_kFMUQ/profile http://localhost:53210/getInfo.html) 03:20:36 INFO - PID 84848 | 2017-04-21 03:20:36.512 plugin-container[84849:722719] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883b, name = 'com.apple.tsm.portname' 03:20:36 INFO - PID 84848 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:20:36 INFO - PID 84848 | 2017-04-21 03:20:36.516 plugin-container[84849:722719] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0f, name = 'com.apple.CFPasteboardClient' 03:20:36 INFO - PID 84848 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:20:36 INFO - PID 84848 | 2017-04-21 03:20:36.516 plugin-container[84849:722719] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:20:36 INFO - PID 84848 | __metrics Screen width/height:1600/1200 03:20:36 INFO - PID 84848 | colorDepth:24 03:20:36 INFO - PID 84848 | Browser inner width/height: 1024/689 03:20:36 INFO - PID 84848 | __metrics 03:20:36 ERROR - PID 84848 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 03:20:37 INFO - TEST-INFO | 84848: exit 0 03:20:37 INFO - Browser initialized. 03:20:37 INFO - Running cycle 1/1 for kraken test... 03:20:37 INFO - TEST-INFO | started process 84850 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmp_kFMUQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:20:40 INFO - PID 84850 | 2017-04-21 03:20:40.322 plugin-container[84851:722856] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4653, name = 'com.apple.tsm.portname' 03:20:40 INFO - PID 84850 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:20:40 INFO - PID 84850 | 2017-04-21 03:20:40.322 plugin-container[84851:722856] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 03:20:40 INFO - PID 84850 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:20:40 INFO - PID 84850 | 2017-04-21 03:20:40.322 plugin-container[84851:722856] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:20:50 INFO - PID 84850 | RSS: Main: 237756416 03:20:50 INFO - PID 84850 | 03:20:52 INFO - PID 84850 | Cycle 1(1): loaded http://localhost:53210/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53210/tests/kraken/driver.html?testName=audio-beat-detection) 03:20:53 INFO - PID 84850 | RSS: Main: 249778176 03:20:53 INFO - PID 84850 | 03:20:56 INFO - PID 84850 | Cycle 1(1): loaded http://localhost:53210/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53210/tests/kraken/driver.html?testName=audio-dft) 03:20:57 INFO - PID 84850 | RSS: Main: 258056192 03:20:57 INFO - PID 84850 | 03:21:00 INFO - PID 84850 | Cycle 1(1): loaded http://localhost:53210/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53210/tests/kraken/driver.html?testName=audio-fft) 03:21:01 INFO - PID 84850 | RSS: Main: 260759552 03:21:01 INFO - PID 84850 | 03:21:03 INFO - PID 84850 | Cycle 1(1): loaded http://localhost:53210/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53210/tests/kraken/driver.html?testName=audio-oscillator) 03:21:03 INFO - PID 84850 | RSS: Main: 263176192 03:21:03 INFO - PID 84850 | 03:21:05 INFO - PID 84850 | Cycle 1(1): loaded http://localhost:53210/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53210/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:21:06 INFO - PID 84850 | RSS: Main: 263118848 03:21:06 INFO - PID 84850 | 03:21:09 INFO - PID 84850 | Cycle 1(1): loaded http://localhost:53210/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53210/tests/kraken/driver.html?testName=imaging-darkroom) 03:21:10 INFO - PID 84850 | RSS: Main: 269033472 03:21:10 INFO - PID 84850 | 03:21:13 INFO - PID 84850 | Cycle 1(1): loaded http://localhost:53210/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53210/tests/kraken/driver.html?testName=imaging-desaturate) 03:21:14 INFO - PID 84850 | RSS: Main: 269516800 03:21:14 INFO - PID 84850 | 03:21:17 INFO - PID 84850 | Cycle 1(1): loaded http://localhost:53210/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53210/tests/kraken/driver.html?testName=json-parse-financial) 03:21:18 INFO - PID 84850 | RSS: Main: 269312000 03:21:18 INFO - PID 84850 | 03:21:19 INFO - PID 84850 | Cycle 1(1): loaded http://localhost:53210/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53210/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:21:20 INFO - PID 84850 | RSS: Main: 269144064 03:21:20 INFO - PID 84850 | 03:21:21 INFO - PID 84850 | Cycle 1(1): loaded http://localhost:53210/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53210/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:21:22 INFO - PID 84850 | RSS: Main: 269160448 03:21:22 INFO - PID 84850 | 03:21:24 INFO - PID 84850 | Cycle 1(1): loaded http://localhost:53210/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53210/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:21:25 INFO - PID 84850 | RSS: Main: 268812288 03:21:25 INFO - PID 84850 | 03:21:28 INFO - PID 84850 | Cycle 1(1): loaded http://localhost:53210/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53210/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:21:29 INFO - PID 84850 | RSS: Main: 269148160 03:21:29 INFO - PID 84850 | 03:21:32 INFO - PID 84850 | Cycle 1(1): loaded http://localhost:53210/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53210/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:21:32 INFO - PID 84850 | RSS: Main: 266280960 03:21:32 INFO - PID 84850 | 03:21:34 INFO - PID 84850 | Cycle 1(1): loaded http://localhost:53210/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53210/tests/kraken/driver.html?testName=ai-astar) 03:21:35 INFO - PID 84850 | RSS: Main: 268210176 03:21:35 INFO - PID 84850 | 03:21:35 INFO - PID 84850 | __start_tp_report 03:21:35 INFO - PID 84850 | _x_x_mozilla_page_load 03:21:35 INFO - PID 84850 | _x_x_mozilla_page_load_details 03:21:35 INFO - PID 84850 | |i|pagename|runs| 03:21:35 INFO - PID 84850 | |0;ai-astar;125;168;153;115;114;114;116;114;114;114 03:21:35 INFO - PID 84850 | |1;audio-beat-detection;150;110;112;152;110;115;112;113;144;116 03:21:35 INFO - PID 84850 | |2;audio-dft;201;208;205;220;229;269;271;205;200;203 03:21:35 INFO - PID 84850 | |3;audio-fft;86;61;83;79;81;89;50;83;96;84 03:21:35 INFO - PID 84850 | |4;audio-oscillator;87;70;84;71;73;70;91;88;104;116 03:21:35 INFO - PID 84850 | |5;imaging-gaussian-blur;135;90;136;86;135;89;134;136;91;121 03:21:35 INFO - PID 84850 | |6;imaging-darkroom;97;98;128;109;150;151;97;98;104;98 03:21:35 INFO - PID 84850 | |7;imaging-desaturate;142;101;100;123;90;92;91;91;91;92 03:21:35 INFO - PID 84850 | |8;json-parse-financial;50;49;51;52;52;53;51;51;52;50 03:21:35 INFO - PID 84850 | |9;json-stringify-tinderbox;59;64;61;68;67;65;59;61;58;63 03:21:35 INFO - PID 84850 | |10;stanford-crypto-aes;85;82;82;85;83;83;83;86;86;105 03:21:35 INFO - PID 84850 | |11;stanford-crypto-ccm;139;158;154;137;140;134;141;143;197;138 03:21:35 INFO - PID 84850 | |12;stanford-crypto-pbkdf2;234;199;184;188;219;239;223;187;182;208 03:21:35 INFO - PID 84850 | |13;stanford-crypto-sha256-iterative;69;71;102;99;97;72;69;68;70;70 03:21:35 INFO - PID 84850 | __end_tp_report 03:21:35 INFO - PID 84850 | __start_cc_report 03:21:35 INFO - PID 84850 | _x_x_mozilla_cycle_collect,1024 03:21:35 INFO - PID 84850 | __end_cc_report 03:21:35 INFO - PID 84850 | __startTimestamp1492770095067__endTimestamp 03:21:35 INFO - PID 84850 | 03:21:35 INFO - PID 84850 | ------- Summary: start ------- 03:21:35 INFO - PID 84850 | Number of tests: 14 03:21:35 INFO - PID 84850 | 03:21:35 INFO - PID 84850 | [#0] ai-astar Cycles:10 Average:124.70 Median:115.50 stddev:19.49 (16.9%) stddev-sans-first:20.67 03:21:35 INFO - PID 84850 | Values: 125.0 168.0 153.0 115.0 114.0 114.0 116.0 114.0 114.0 114.0 03:21:35 INFO - PID 84850 | 03:21:35 INFO - PID 84850 | [#1] audio-beat-detection Cycles:10 Average:123.40 Median:115.50 stddev:17.65 (15.3%) stddev-sans-first:15.88 03:21:35 INFO - PID 84850 | Values: 150.0 110.0 112.0 152.0 110.0 115.0 112.0 113.0 144.0 116.0 03:21:35 INFO - PID 84850 | 03:21:35 INFO - PID 84850 | [#2] audio-dft Cycles:10 Average:221.10 Median:214.00 stddev:27.31 (12.8%) stddev-sans-first:27.99 03:21:35 INFO - PID 84850 | Values: 201.0 208.0 205.0 220.0 229.0 269.0 271.0 205.0 200.0 203.0 03:21:35 INFO - PID 84850 | 03:21:35 INFO - PID 84850 | [#3] audio-fft Cycles:10 Average:79.20 Median:83.50 stddev:13.60 (16.3%) stddev-sans-first:14.20 03:21:35 INFO - PID 84850 | Values: 86.0 61.0 83.0 79.0 81.0 89.0 50.0 83.0 96.0 84.0 03:21:35 INFO - PID 84850 | 03:21:35 INFO - PID 84850 | [#4] audio-oscillator Cycles:10 Average:85.40 Median:78.50 stddev:15.49 (19.7%) stddev-sans-first:16.42 03:21:35 INFO - PID 84850 | Values: 87.0 70.0 84.0 71.0 73.0 70.0 91.0 88.0 104.0 116.0 03:21:35 INFO - PID 84850 | 03:21:35 INFO - PID 84850 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:111.00 stddev:23.08 (20.8%) stddev-sans-first:23.36 03:21:35 INFO - PID 84850 | Values: 135.0 90.0 136.0 86.0 135.0 89.0 134.0 136.0 91.0 121.0 03:21:35 INFO - PID 84850 | 03:21:35 INFO - PID 84850 | [#6] imaging-darkroom Cycles:10 Average:113.00 Median:97.00 stddev:21.91 (22.6%) stddev-sans-first:22.47 03:21:35 INFO - PID 84850 | Values: 97.0 98.0 128.0 109.0 150.0 151.0 97.0 98.0 104.0 98.0 03:21:35 INFO - PID 84850 | 03:21:35 INFO - PID 84850 | [#7] imaging-desaturate Cycles:10 Average:101.30 Median:91.00 stddev:17.47 (19.2%) stddev-sans-first:10.65 03:21:35 INFO - PID 84850 | Values: 142.0 101.0 100.0 123.0 90.0 92.0 91.0 91.0 91.0 92.0 03:21:35 INFO - PID 84850 | 03:21:35 INFO - PID 84850 | [#8] json-parse-financial Cycles:10 Average:51.10 Median:51.50 stddev:1.20 (2.3%) stddev-sans-first:1.20 03:21:35 INFO - PID 84850 | Values: 50.0 49.0 51.0 52.0 52.0 53.0 51.0 51.0 52.0 50.0 03:21:35 INFO - PID 84850 | 03:21:35 INFO - PID 84850 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:63.50 stddev:3.47 (5.5%) stddev-sans-first:3.44 03:21:35 INFO - PID 84850 | Values: 59.0 64.0 61.0 68.0 67.0 65.0 59.0 61.0 58.0 63.0 03:21:35 INFO - PID 84850 | 03:21:35 INFO - PID 84850 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:84.00 stddev:6.85 (8.2%) stddev-sans-first:7.25 03:21:35 INFO - PID 84850 | Values: 85.0 82.0 82.0 85.0 83.0 83.0 83.0 86.0 86.0 105.0 03:21:35 INFO - PID 84850 | 03:21:35 INFO - PID 84850 | [#11] stanford-crypto-ccm Cycles:10 Average:148.10 Median:142.00 stddev:18.78 (13.2%) stddev-sans-first:19.62 03:21:35 INFO - PID 84850 | Values: 139.0 158.0 154.0 137.0 140.0 134.0 141.0 143.0 197.0 138.0 03:21:35 INFO - PID 84850 | 03:21:35 INFO - PID 84850 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:206.30 Median:213.50 stddev:21.42 (10.0%) stddev-sans-first:20.23 03:21:35 INFO - PID 84850 | Values: 234.0 199.0 184.0 188.0 219.0 239.0 223.0 187.0 182.0 208.0 03:21:35 INFO - PID 84850 | 03:21:35 INFO - PID 84850 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.70 Median:70.50 stddev:14.33 (20.3%) stddev-sans-first:14.76 03:21:35 INFO - PID 84850 | Values: 69.0 71.0 102.0 99.0 97.0 72.0 69.0 68.0 70.0 70.0 03:21:35 INFO - PID 84850 | -------- Summary: end -------- 03:21:35 INFO - PID 84850 | 03:21:36 INFO - TEST-INFO | 84850: exit 0 03:21:36 INFO - TEST-OK | kraken | took 62798ms 03:21:36 INFO - SUITE-END | took 1178s 03:21:36 INFO - Completed test suite (00:19:38) 03:21:36 INFO - javascript benchmark 03:21:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7760.174639224116, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3532.275883443894, 3540.9822950885227, 3563.3229686359605, 3581.391163502205, 3592.4431713084464, 5610.4670056344585, 6100.938990610087, 6121.908171377428, 6156.1073644321605, 6170.938290617092, 6003.819885403434, 6104.610739188311, 6106.21798979648, 6138.143176733777, 6182.103594978726, 5339.279197308372, 5393.919091213635, 5414.512693857552, 5465.125579907216, 5502.669839809604, 5336.279602253704, 5387.649802762828, 5437.564994800427, 5451.155070964007, 5475.67145971241, 5386.757595908193, 5441.673499590037, 5445.646033007842, 5458.699771512565, 5493.148561972901, 5245.31810864589, 5325.4940780625775, 5337.066013447631, 5337.412884582693, 5343.0, 5336.43967383423, 5353.009693206769, 5390.460953904618, 5400.83797486076, 5430.728463576806, 4793.5925446337105, 5733.140028995643, 6054.51563874889, 6130.8773824523705, 6155.630662160284, 5372.194170874361, 6225.19072520574, 6352.682365881734, 6530.249021362509, 6639.136912201431, 5565.5825813063775, 6588.209414870246, 6679.899801502981, 6687.498437617198, 6693.564918280296, 6216.222972128484, 6270.65511396873, 6271.717772700239, 6281.748730050838, 6286.591371560834, 6510.9023364649565, 6813.182418109858, 6822.215445223764, 6931.549449285781, 6936.2023367312395, 5489.2589500417735, 6296.65368404733, 6331.683415829282, 6407.711652975628, 6443.581167224115, 5872.265966754156, 6122.020476723792, 6488.805335839932, 6704.061431399608, 6723.294054124247, 6413.807585772434, 6562.737490500326, 6568.376004279586, 6589.242237142694, 6610.900836487456, 6569.835754106186, 6582.3746744059235, 6595.373439523238, 6617.669116544153, 6619.933800662028, 5145.897082058338, 5196.974015129976, 5221.13851214553, 5252.501012403815, 5308.177232528964, 4670.486246512881, 4684.531546845288, 4687.67186296956, 4721.0, 4775.42694876617, 5311.0, 6171.783987560414, 6242.812715618448, 6264.718087686065, 6264.718087686065, 6421.133147025185, 6503.9349606504275, 6629.569078009914, 6633.86732265352, 6681.098051763047, 6214.130021796862, 6239.157713708682, 6283.8114856554375, 6290.811275661737, 6299.622022678654, 5845.357010728816, 5859.501942334864, 5868.413158684183, 5878.2358293421585, 5897.997340452133, 6587.703553340016, 6696.464282857262, 6873.759418420332, 6880.243173251039, 6883.242843287235, 6662.866742665023, 6677.265500795006, 6682.431993280626, 6731.124953755981, 6769.0, 5114.948850511596, 6836.555623884432, 6869.587824730333, 6936.4797640176175, 6939.063226464363, 6306.432421082125, 6558.409743123142, 6609.339066093352, 6633.900491492535, 6654.600723956578, 6496.382843629847, 6577.934220657924, 6624.403803657694, 6647.069410282661, 6713.194416669836, 5286.788528458818, 5295.629305948547, 6335.936640633719, 6521.0, 6535.771248006297, 6218.53360997936, 6256.530760192913, 6329.240491141092, 6449.709763060768, 6516.609003459807, 6186.783462578788, 6210.968945155245, 6306.306306306211, 6364.268109167319, 6368.681565921593, 6537.248216455168, 6541.149650545399, 6550.050242714684, 6551.934480655323, 6560.081588577507, 5410.296661433988, 6164.4760195382105, 6224.813255602339, 6375.171227740364, 6391.58454700443], "value": 5989.3080094118395, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.4452326830364, 788.400815380311, 810.5298926622557, 1028.7171027967313, 1082.6048492300313, 35791.64208357919, 37188.07029824256, 37225.06937326565, 37258.999999999935, 37371.0, 39545.60454395455, 40084.398734019014, 40118.0, 40178.59821401785, 40207.0, 8435.70475033374, 8582.356323275764, 8668.0, 8706.259967902735, 8743.475391476532, 8710.738677839676, 8739.126087391242, 8838.29293656509, 8850.5574721264, 8856.468611883307, 8767.95616021919, 8771.605277762515, 8834.38159328844, 8855.335849811258, 8856.380053396233, 8781.912180878173, 8813.0, 8824.602892869772, 8842.911570884306, 8865.645374185026, 8458.36562257833, 8524.445911015764, 8530.402871798977, 8542.18849209324, 8560.828783424358, 38633.61366386328, 38698.41952370717, 38879.611203887885, 38895.22209555793, 38939.026524336834, 3626.8911932642063, 3665.065408320888, 3674.1182116292166, 3675.4303083022173, 3683.852645894161, 31326.0, 31805.52291715626, 31831.0, 31850.044498665076, 31896.0, 3119.23578723212, 3212.903612891617, 3216.34065016671, 3219.935601287961, 3237.3039796443877, 220059.0, 222875.0, 267829.9999999981, 310937.0, 311609.0, 48988.0, 49292.75353623209, 49339.25991110136, 49379.0, 49390.25914611212, 51684.741576291875, 52055.69860753436, 52122.0, 52156.47843521592, 52218.0, 14209.85790142106, 14245.715085698228, 14355.928220358832, 14378.28108594587, 14389.42442302317, 11640.592579259684, 11712.004479619327, 11729.941350293364, 11734.354610496333, 11754.29474231549, 11513.942430287794, 13276.0, 13743.0, 13833.239171845444, 13966.650833729238, 5163.863949931009, 5210.879660872931, 5613.943860561424, 5903.468687818117, 5925.792597259161, 909.7862002429424, 943.2218419803689, 1026.6355443817338, 1043.89561043895, 1069.0752499088387, 20047.699284510745, 22125.672459652473, 22216.111355545596, 24297.271081867573, 24444.38889027753, 1018.7554986803113, 1062.102523367753, 1076.4187338837096, 1123.7246874515633, 1158.976820463603, 12638.368081595883, 12745.872541274468, 12798.680032999064, 12812.42344094518, 13057.21656700601, 332279.0, 333918.0, 335156.0, 335865.32067339506, 336247.0, 56003.719981400645, 56200.0, 56382.7180864093, 56428.435715643136, 56556.0, 1504.2253239581623, 1525.6948610277989, 1564.8043994500688, 1569.395782623698, 1574.3781206423398, 20150.496237594176, 23909.52180956406, 24366.878165609058, 24515.322701594905, 24531.38671533226, 38407.0, 40186.39720404255, 40298.9925251871, 40328.0, 40384.59615403926, 263641.0, 277039.0, 279200.0, 280553.0, 282273.0, 27260.454790904467, 35095.12262193466, 35222.82388588143, 35887.64112358843, 35967.92096237117, 46020.769896150305, 46815.531844681114, 46832.0, 47004.0, 47123.52876471191, 30236.0, 31277.68722312839, 31335.21661958469, 31747.20631984219, 31819.522707158947, 28008.0, 30778.846105770222, 31454.37091258208, 31555.94886332381, 31792.0, 28826.711732882402, 33522.66477335196, 36209.09477262984, 38440.80779596084, 38614.80692596519, 25911.611325829752, 28530.0, 29683.703162968093, 30368.240793980327, 30827.0751877444, 24795.0, 24820.751792481846, 24834.25497235086, 24867.875660622303, 25029.624555631315], "value": 17633.786593085293, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.852641890406, 425.38768733513774, 430.8233624214073, 445.63235330852046, 450.78587670856325, 16739.493445589895, 20647.587048259025, 21514.569708605817, 21906.0, 22075.889620551916, 22143.0, 22239.666405003896, 22558.661620075673, 22932.656010159862, 23008.194713185043, 6060.939390606092, 6218.844528886769, 6266.185395898527, 6282.623042617434, 6288.496920246393, 5923.822285331447, 6085.878282434349, 6124.265088189423, 6164.0, 6167.599106058092, 6096.512279017668, 6115.908261376061, 6121.479674227696, 6126.724297406605, 6151.815445536618, 5836.649801011931, 6057.848553786169, 6087.0, 6087.726052327655, 6103.633781973073, 5219.608529360313, 5393.083175860113, 5409.594280428944, 5439.374471935738, 5452.754626041798, 25882.87058564714, 26180.476390472275, 26402.339941501617, 26427.867860660575, 26761.73238267612, 2249.640057590778, 2291.2438895164555, 2326.3137374474572, 2327.918522851692, 2337.6026075567192, 17752.55618609545, 17937.461876143607, 18259.72610410845, 18320.541986450313, 18379.0, 2125.798049185325, 2220.9777902221094, 2222.699935508702, 2223.855449395784, 2227.4208705736464, 158416.0, 160035.1998240013, 161050.0, 161843.0, 162038.18980905137, 10500.842487362695, 13045.608631741063, 13174.934125329311, 13189.670258243621, 13217.669558261121, 16679.416220432468, 16849.073300968565, 16921.915390423215, 16922.830771692126, 16942.322307107825, 8715.084916083846, 9031.909680903238, 9059.773505662411, 9173.312001599774, 9183.90816091844, 8537.103604121601, 8541.44480608771, 8549.871751923725, 8700.434471759316, 8740.781480462912, 8062.234087761653, 8157.347412207009, 8192.0, 8248.628811703487, 8249.29880960125, 1883.2372888979985, 2180.4112889519743, 2186.5080356919884, 2198.6372248579123, 2389.9761002389755, 927.6753136402206, 934.5654270764128, 948.8624149498285, 964.7732782796037, 988.9258305626963, 20071.59856802885, 20745.688814667792, 20759.896200518902, 20793.376198714064, 20796.48008799792, 785.5443842571295, 878.1438097854668, 907.9409838360485, 907.9921287371013, 1010.8231059564547, 7842.647080881374, 10244.505111292781, 10686.679399618024, 10718.464076796128, 10875.238733288594, 557764.0, 565710.0, 571054.0, 571441.1427942917, 572372.0, 127870.0, 133829.33085334706, 135922.0, 142334.0, 142463.6166840806, 1182.526989204308, 1192.9105317101253, 1235.3699613197155, 1245.1221888568537, 1245.4457766294092, 21806.01872915691, 21970.89014554981, 22092.784896830184, 22213.77786222117, 22217.66673499931, 58912.11631825612, 59471.40528594659, 60161.39838601733, 60210.698946504985, 61385.0, 75381.86927196206, 80950.0, 82103.0, 82165.58917205376, 82221.58889205515, 8722.0, 8825.823483530165, 8928.73213803561, 9322.906770932475, 9384.202342800938, 11890.940545297219, 14545.054571452822, 14700.191489467754, 15006.174660393783, 15037.323320450387, 11921.940390297994, 12083.818742719042, 12308.815367769312, 12332.136750427742, 12380.328655631374, 11323.32060076398, 11449.0, 11575.016123629586, 11765.411729413667, 11802.409879506162, 12383.75232495363, 12435.875641243472, 12582.559610413591, 12745.74508509806, 12867.0, 8713.0, 9104.180623743894, 9150.771230719285, 9162.816743665222, 9217.170454659114, 9652.420854748456, 11145.2198346115, 11696.941515292368, 12182.710668119735, 12339.69150771238], "value": 10564.644641382334, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1409.6334952912243, 1433.9354729037186, 1454.7454195515782, 1475.9852401475982, 1482.5922871210423, 10385.688429347123, 10673.519691613887, 10798.784024319519, 11428.257163284381, 11945.820812687816, 11175.273607215526, 11418.7145321367, 11529.250598711078, 11605.593804216855, 11630.709232269197, 2491.202815099169, 2535.378832186108, 2557.1177943609423, 2558.2581051495044, 2561.1804222648666, 2459.557279689655, 2490.2902672738273, 2525.6969163700383, 2548.197317844882, 2555.821092523515, 2282.0415425521237, 2366.9053237870467, 2444.9511009779794, 2511.309389917769, 2573.1508602161334, 2437.402836305108, 2485.8135639826996, 2496.3010357100043, 2498.6127150291554, 2513.1329691256487, 2408.1932552594903, 2494.4886298308984, 2495.026939493599, 2504.348869293997, 2525.6464095026713, 11388.0, 11459.598914037968, 11738.178327516991, 11841.40792960357, 11934.045276377869, 6508.837279068014, 6800.727970881158, 6817.727290908358, 6843.3840954314355, 6859.039734437133, 4140.523839758436, 4308.569143085666, 4404.229259879508, 4436.44544431946, 4469.9776501117285, 1076.682378698286, 1265.2218885385514, 1284.094713227182, 1306.6406738147086, 1307.8495972963135, 15989.920050399789, 16340.918295408566, 16486.6702665946, 16657.83342166587, 16705.49883503509, 5368.248445217672, 5672.858178545569, 5856.238688970407, 5939.426052096198, 5967.940320596738, 12026.75946481083, 12050.819237711441, 12242.693932651755, 12259.632211033684, 12334.691632709255, 6651.966740166365, 6656.0, 6663.800085997428, 6715.227748808852, 6727.327267273331, 5974.61165024272, 6151.907721384183, 6221.782237621752, 6277.560570760094, 6279.995200767855, 4391.8462853799965, 4516.16450956574, 4525.343825145335, 4547.272436410225, 4586.2661974083985, 1310.6199202231246, 1326.403118596616, 1328.6479083043002, 1337.779266421049, 1341.5438750824767, 672.6905623413187, 716.5808002318598, 730.5032577847115, 783.9960800196077, 801.7554645833077, 5170.741462926839, 5210.6613070150315, 6284.402981716729, 6443.420092191725, 6542.443892269211, 578.5169383564687, 587.952963762898, 596.9136172166702, 600.6156060121526, 603.3815339277276, 4565.223911934912, 4571.817127314936, 4614.74618895964, 4739.95260047402, 4794.352762377104, 12293.815592766116, 14482.0, 15029.624259393602, 15147.924260378628, 15197.848021519865, 14388.0, 14634.195119268543, 14997.550073497812, 15061.472848450252, 15135.318910649048, 6967.721291148398, 7445.069366329209, 8262.42163048593, 8392.16078392156, 8438.873416898752, 5641.746121424628, 5874.500667443315, 6782.423494003065, 6846.7945961621235, 7112.964435177998, 12240.877591223974, 12279.570215042431, 12637.87362126367, 12749.617511474671, 12794.552190673281, 12892.162009469355, 12926.741465170457, 13028.869711303145, 13064.54274100402, 13356.265405402795, 9427.622895084394, 9573.569189386355, 9617.807643846943, 9803.264755143535, 9879.604815807288, 9835.704928852147, 9966.604675345312, 10493.108085812792, 10735.89264107349, 10783.838242426527, 9181.77045573866, 9242.72271831846, 9244.168024877794, 9274.165325120772, 9400.200982916254, 8868.911310887066, 8979.326550508607, 8992.685256016008, 9012.504312262889, 9081.59132839037, 8127.3091787198755, 8215.09633940278, 8259.587020648823, 8323.625436855476, 8351.373646976379, 6066.757329706938, 6068.241469816273, 6171.59884607499, 6239.06414037898, 6249.843753906007, 5229.947700522946, 6117.96941015292, 6149.2313460817395, 6293.874122517615, 6322.7670604231735], "value": 5302.703819411747, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.90224090615993, 399.71420434389404, 401.46639835827153, 408.6832704653891, 415.0992346607862, 4934.25986102084, 5529.355341513128, 5664.801731939383, 5835.183074369592, 5841.0, 4273.444452221207, 5509.641873278234, 5571.690652696623, 5667.829965101054, 5706.9727449059155, 4378.8686339409705, 4397.604215620586, 4399.206503870049, 4414.3378493225955, 4423.810213944086, 4118.485189351331, 4160.895977600554, 4429.889252768674, 4443.333499974998, 4454.643628509712, 3645.6172101929183, 3737.177820879402, 4062.6140516651017, 4275.294576394891, 4422.049259409227, 3479.565054368204, 3552.378333791576, 4253.936190957138, 4279.529251782302, 4312.310030395138, 3062.0660698486954, 3730.3658378075793, 3750.6811920986747, 3753.60587138352, 3755.7183211259266, 5389.892202155974, 5669.206311116447, 5673.23411339468, 5677.517411020068, 5719.456651618089, 4390.429244198266, 4665.0, 5123.718195499246, 5135.611940447672, 5136.229565565158, 6242.282137554194, 6248.968755156195, 6258.4680302174365, 6272.623642581414, 6273.780417685405, 3624.894407205801, 3980.7213495055357, 4246.278132717445, 4255.085156691295, 4265.573442655709, 6195.81412557624, 6224.968875155595, 6465.579737317106, 6507.837304067389, 6693.966530167318, 3438.570178727659, 3559.893203203856, 4000.8199631016673, 4089.938650920179, 4295.398644189816, 3871.4192871069563, 4143.212789570032, 4390.143921935192, 4390.780460976938, 4409.867703968886, 4845.224764037737, 5056.924146137811, 5111.386633603991, 5142.434332223453, 5143.794248230029, 5368.651037682616, 6032.00471922128, 6284.146176877832, 6291.307956124822, 6294.464970477561, 1310.8230388897568, 1483.725510780509, 1485.2944851195812, 1488.3823213366547, 1491.6792889528804, 901.4951627088851, 929.025820132219, 974.6734843827255, 993.9503024848873, 1011.5245834457793, 5968.7015649217365, 5969.671668058299, 5972.641641501524, 6006.12911127884, 6020.668863212478, 5699.487046165782, 6036.969815150984, 6185.567010309325, 6529.836754081091, 6549.967250163814, 4638.0491999140095, 4982.4768399317545, 5707.828765137053, 5955.553333500005, 5968.1942937703725, 2953.7784666150123, 3321.4519604265024, 3371.4268574342423, 3371.6291207967106, 3387.644297348743, 5544.3346798384455, 6014.248218972629, 6365.713542890581, 6660.70026848793, 6722.924332106937, 5551.500364967173, 5753.568482363839, 5770.855728606734, 6072.908906366408, 6606.372394622599, 5979.850503737354, 6668.799936001928, 6671.099401580725, 6688.0, 6710.0, 4997.700137991732, 5530.05988981866, 5620.718964051863, 6159.583295841891, 6405.3594640535575, 5734.827955161351, 6396.872062558629, 6479.611223326616, 6495.610263384212, 6541.672916354259, 6081.5742897996715, 6377.7767778127545, 6697.732090716317, 6773.491988101011, 6792.72829086831, 4133.648639865525, 4365.5197928227235, 4580.770961451847, 4778.1638213311835, 4783.6412269079265, 4942.555170034714, 5313.628046036741, 5436.972815135899, 6313.10606817962, 6547.410733033859, 5134.460881607378, 5540.445955404427, 6085.421884920926, 6251.71867265965, 6289.591176573508, 5440.700761458158, 6302.779402720883, 6314.147590075281, 6317.273513545817, 6330.683465826598, 4799.272261985752, 6157.630542167484, 6174.25908890936, 6175.505959523138, 6207.534434917489, 5553.8611534710335, 5783.392743762012, 6037.698115094316, 6240.4071613196675, 6322.905156422749, 5616.354119276336, 5690.804930964378, 6001.399860013964, 6055.000924847351, 6128.325884152829], "value": 4492.855307440985, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [822.7161629237911, 839.7228914458226, 840.2605706977861, 847.4406891451639, 862.3058437957442, 15998.920005399972, 16240.269187886544, 16630.75053874193, 18190.45428637143, 18791.966441845692, 17477.475675729747, 17764.64470710585, 18024.54938626535, 18072.367467138654, 18306.908465457687, 946.5740416812428, 962.451402700461, 967.6032826541119, 969.0600117885675, 972.610955617755, 970.1268858027796, 993.46849435552, 993.538004827755, 996.566493575297, 1000.1348833259251, 1036.9585216591327, 1047.9633212837552, 1055.9472026398687, 1058.5712786321515, 1059.7668512927144, 1025.2413214221422, 1050.0, 1052.079430498314, 1053.525913338993, 1054.9924821795166, 742.22066829829, 746.6490749347798, 761.3984951888002, 764.1403421151205, 768.0514564512822, 16428.096454694987, 16661.416850410176, 16780.0, 16841.747373789403, 16853.157342132967, 16437.83562164387, 16438.0, 16751.246193921303, 16891.662166756596, 16896.493105206864, 13470.865291347158, 13575.864241357558, 13649.658758531017, 13755.243461609607, 13828.93085534576, 3474.9652503474895, 3533.6643018913164, 3537.6108628050893, 3539.3098345822573, 3541.451075083366, 93557.5322123385, 115851.0, 118291.81708182894, 128855.0, 130859.34570327183, 12198.207116537396, 13218.669533261746, 13416.530421435398, 13534.45862165522, 13555.728885422433, 20340.79659203389, 23299.417514561934, 24306.392340191283, 25167.867445964974, 25214.36964075876, 7725.304722574995, 7735.9613201933635, 7761.922380776233, 8018.799530011796, 8031.156728543536, 3859.729818912649, 3977.443157957888, 3992.540857801332, 4031.5162180538523, 4031.6169963853386, 4314.482262128502, 4350.564943505624, 4389.780510974439, 4412.227860124465, 4442.4669039715445, 809.8501777171242, 939.5255396024963, 964.4599024546277, 966.0918736387773, 972.8005758819424, 616.2252712188867, 637.9362063793584, 648.8053583924803, 649.2047242128355, 672.4620303756975, 10966.945165274123, 11595.130365222474, 11910.166288359906, 11969.700757481132, 12566.246025238515, 560.7504660426152, 602.7106988645475, 641.153677146172, 650.1742786660914, 654.9770758023446, 5366.597505187126, 5484.588655850827, 5488.670679759227, 5515.227868098469, 5618.185363122325, 99142.08579142028, 104687.4765626167, 104942.95057049484, 106060.46969765256, 106192.46903765431, 92053.0, 93124.0, 93735.0, 95349.0, 95910.0, 73770.0, 81825.0, 82103.17896820956, 82230.0, 82294.11970581001, 11065.723356916142, 11247.381394023407, 11358.60244891425, 11413.486393112164, 11529.250598711056, 40029.39955900606, 40065.0, 40409.1918161641, 40586.0, 40847.591524084375, 51368.0, 51440.971180576926, 51973.7401312991, 52146.0, 52300.16949406905, 13887.30563471802, 13933.303334833015, 14290.785638215642, 14456.494022709154, 14497.492587759378, 15480.5355839325, 15566.533004009898, 15707.978981366176, 15737.291821867815, 15879.967802092828, 14232.288385580887, 14531.346089426213, 14611.634709132357, 14640.926795365955, 14704.55886323412, 14280.07179533327, 14606.561803145923, 16548.255328510488, 16987.490375288762, 17435.912820435817, 16533.421330253383, 16627.83372166311, 16794.748078779074, 16877.32490700358, 16926.830731692524, 11546.364949927498, 11632.243904146204, 12022.819657704966, 12046.149472014302, 12150.149489535648, 11883.881161188277, 12829.550965716155, 13187.944964403017, 13247.403866825824, 13329.133606315558], "value": 8214.822073492785, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1596.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 168.0, 153.0, 115.0, 114.0, 114.0, 116.0, 114.0, 114.0, 114.0], "value": 124.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 110.0, 112.0, 152.0, 110.0, 115.0, 112.0, 113.0, 144.0, 116.0], "value": 123.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 208.0, 205.0, 220.0, 229.0, 269.0, 271.0, 205.0, 200.0, 203.0], "value": 221.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 61.0, 83.0, 79.0, 81.0, 89.0, 50.0, 83.0, 96.0, 84.0], "value": 79.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 84.0, 71.0, 73.0, 70.0, 91.0, 88.0, 104.0, 116.0], "value": 85.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 90.0, 136.0, 86.0, 135.0, 89.0, 134.0, 136.0, 91.0, 121.0], "value": 115.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 128.0, 109.0, 150.0, 151.0, 97.0, 98.0, 104.0, 98.0], "value": 113.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 101.0, 100.0, 123.0, 90.0, 92.0, 91.0, 91.0, 91.0, 92.0], "value": 101.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 51.0, 52.0, 52.0, 53.0, 51.0, 51.0, 52.0, 50.0], "value": 51.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 64.0, 61.0, 68.0, 67.0, 65.0, 59.0, 61.0, 58.0, 63.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 82.0, 85.0, 83.0, 83.0, 83.0, 86.0, 86.0, 105.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 158.0, 154.0, 137.0, 140.0, 134.0, 141.0, 143.0, 197.0, 138.0], "value": 148.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [234.0, 199.0, 184.0, 188.0, 219.0, 239.0, 223.0, 187.0, 182.0, 208.0], "value": 206.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 102.0, 99.0, 97.0, 72.0, 69.0, 68.0, 70.0, 70.0], "value": 78.7, "unit": "score"}]}]} 03:21:36 INFO - Return code: 0 03:21:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:21:36 ERROR - # TBPL SUCCESS # 03:21:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:21:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:21:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:21:36 INFO - 2017-04-21 03:21:36.909 screenresolution[84855:723248] starting screenresolution argv=screenresolution get 03:21:36 INFO - 2017-04-21 03:21:36.912 screenresolution[84855:723248] Display 0: 1600x1200x32@60 03:21:36 INFO - 2017-04-21 03:21:36.918 screenresolution[84856:723251] starting screenresolution argv=screenresolution list 03:21:36 INFO - Available Modes on Display 0 03:21:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:21:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:21:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:21:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:21:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:21:37 INFO - Intel Iris: 03:21:37 INFO - Chipset Model: Intel Iris 03:21:37 INFO - Type: GPU 03:21:37 INFO - Bus: Built-In 03:21:37 INFO - VRAM (Dynamic, Max): 1536 MB 03:21:37 INFO - Vendor: Intel (0x8086) 03:21:37 INFO - Device ID: 0x0a2e 03:21:37 INFO - Revision ID: 0x0009 03:21:37 INFO - Displays: 03:21:37 INFO - Display: 03:21:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:21:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:21:37 INFO - Display Serial Number: 1600x1200 60 03:21:37 INFO - Main Display: Yes 03:21:37 INFO - Mirror: Off 03:21:37 INFO - Online: Yes 03:21:37 INFO - Rotation: Supported 03:21:37 INFO - Return code: 0 03:21:37 INFO - Running post-action listener: _resource_record_post_action 03:21:37 INFO - [mozharness: 2017-04-21 10:21:37.154615Z] Finished run-tests step (success) 03:21:37 INFO - Running post-run listener: _resource_record_post_run 03:21:37 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 709120; Write bytes: 519268352; Read time: 14; Write time: 1591 03:21:37 INFO - TinderboxPrint: CPU usage
54.0% 03:21:37 INFO - TinderboxPrint: I/O read bytes / time
709,120 / 14 03:21:37 INFO - TinderboxPrint: I/O write bytes / time
519,268,352 / 1,591 03:21:37 INFO - TinderboxPrint: CPU idle
2,206.1 (46.0%) 03:21:37 INFO - TinderboxPrint: CPU system
971.3 (20.2%) 03:21:37 INFO - TinderboxPrint: CPU user
1,620.3 (33.8%) 03:21:37 INFO - TinderboxPrint: Swap in / out
207,908,864 / 0 03:21:37 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205230592; Write bytes: 204247040; Read time: 15778; Write time: 379 03:21:37 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 671744; Write bytes: 307968000; Read time: 7; Write time: 1182 03:21:37 INFO - Running post-run listener: _upload_blobber_files 03:21:37 INFO - Blob upload gear active. 03:21:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:21:37 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 03:21:37 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'] 03:21:37 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 03:21:38 INFO - (blobuploader) - INFO - Open directory for files ... 03:21:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:21:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:21:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:39 INFO - (blobuploader) - INFO - Done attempting. 03:21:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:21:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:21:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:40 INFO - (blobuploader) - INFO - Done attempting. 03:21:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:21:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:41 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:21:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:41 INFO - (blobuploader) - INFO - Done attempting. 03:21:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:21:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:21:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:43 INFO - (blobuploader) - INFO - Done attempting. 03:21:43 INFO - (blobuploader) - INFO - Iteration through files over. 03:21:43 INFO - Return code: 0 03:21:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:21:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:21:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7facdf050371a75b960d8d6071dd917edda56e8b03d013e04bcb6c3d813f362706068c6bbdac91cd6c4bafec96c6e47228e9c1b4fe637c2e59e494ab5fa135e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1396a8e8a43f6525e84b10f3d3a572a91c1de5d02cf3c1f2d6b97aca646dbff7d27bd589769dcdaaacff573734a5b3a8dd2ebf60d7459654d0176a8e696b3fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1d4f446315609505c986f30beddd29c6d89de6a8a19ae1211f7bb7882ea7162c0772a308ac813ed20f0cb40be177ad0283046c5026687f5a7d912bc05ab9402", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86de26fdd1f3f196279737a338c1b169bd28c819c85b9a49e311f0b39847453e3617d20f1225ffdb51290fc0a157799b637dd68f40d8e77f4eaf451ce7e87d52"} 03:21:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:21:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:21:43 INFO - Contents: 03:21:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7facdf050371a75b960d8d6071dd917edda56e8b03d013e04bcb6c3d813f362706068c6bbdac91cd6c4bafec96c6e47228e9c1b4fe637c2e59e494ab5fa135e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1396a8e8a43f6525e84b10f3d3a572a91c1de5d02cf3c1f2d6b97aca646dbff7d27bd589769dcdaaacff573734a5b3a8dd2ebf60d7459654d0176a8e696b3fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1d4f446315609505c986f30beddd29c6d89de6a8a19ae1211f7bb7882ea7162c0772a308ac813ed20f0cb40be177ad0283046c5026687f5a7d912bc05ab9402", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86de26fdd1f3f196279737a338c1b169bd28c819c85b9a49e311f0b39847453e3617d20f1225ffdb51290fc0a157799b637dd68f40d8e77f4eaf451ce7e87d52"} 03:21:43 INFO - Running post-run listener: copy_logs_to_upload_dir 03:21:43 INFO - Copying logs to upload dir... 03:21:43 INFO - mkdir: /builds/slave/test/build/upload/logs 03:21:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.463866 ========= master_lag: 0.15 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2017-04-21 03:21:43.175206) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-21 03:21:43.178722) ========= 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.bfjn8WvdTC/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.ZcJHhkVhrp/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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/f7facdf050371a75b960d8d6071dd917edda56e8b03d013e04bcb6c3d813f362706068c6bbdac91cd6c4bafec96c6e47228e9c1b4fe637c2e59e494ab5fa135e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1396a8e8a43f6525e84b10f3d3a572a91c1de5d02cf3c1f2d6b97aca646dbff7d27bd589769dcdaaacff573734a5b3a8dd2ebf60d7459654d0176a8e696b3fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1d4f446315609505c986f30beddd29c6d89de6a8a19ae1211f7bb7882ea7162c0772a308ac813ed20f0cb40be177ad0283046c5026687f5a7d912bc05ab9402", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86de26fdd1f3f196279737a338c1b169bd28c819c85b9a49e311f0b39847453e3617d20f1225ffdb51290fc0a157799b637dd68f40d8e77f4eaf451ce7e87d52"} build_url:https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011534 build_url: 'https://queue.taskcluster.net/v1/task/QOj__KhgRxGJ2OQRp8IbhA/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/f7facdf050371a75b960d8d6071dd917edda56e8b03d013e04bcb6c3d813f362706068c6bbdac91cd6c4bafec96c6e47228e9c1b4fe637c2e59e494ab5fa135e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1396a8e8a43f6525e84b10f3d3a572a91c1de5d02cf3c1f2d6b97aca646dbff7d27bd589769dcdaaacff573734a5b3a8dd2ebf60d7459654d0176a8e696b3fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1d4f446315609505c986f30beddd29c6d89de6a8a19ae1211f7bb7882ea7162c0772a308ac813ed20f0cb40be177ad0283046c5026687f5a7d912bc05ab9402", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86de26fdd1f3f196279737a338c1b169bd28c819c85b9a49e311f0b39847453e3617d20f1225ffdb51290fc0a157799b637dd68f40d8e77f4eaf451ce7e87d52"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-21 03:21:43.218337) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 03:21:43.219032) ========= 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.bfjn8WvdTC/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.ZcJHhkVhrp/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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.005367 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 03:21:43.271908) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-21 03:21:43.272664) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-21 03:21:43.273297) ========= ========= Total master_lag: 0.55 =========