builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0176 starttime: 1491048160.2 results: success (0) buildid: 20170401040823 builduid: 76e86c87d9064fa9976f81d6328c6b37 revision: 0d6ffde320ec3a3b44dc4c27f7c11cc9a9bf341c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-01 05:02:40.200013) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-01 05:02:40.200549) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-01 05:02:40.200889) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-01 05:02:40.231949) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 05:02:40.232298) ========= 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.qFB1ukSECy/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.ABHfBWrt8X/Listeners TMPDIR=/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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-01 05:02:40-- 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% 14.9M=0.001s 2017-04-01 05:02:40 (14.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.555691 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 05:02:40.812338) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 05:02:40.812686) ========= 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.qFB1ukSECy/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.ABHfBWrt8X/Listeners TMPDIR=/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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.029538 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 05:02:40.864549) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 05:02:40.864953) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0d6ffde320ec3a3b44dc4c27f7c11cc9a9bf341c --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 0d6ffde320ec3a3b44dc4c27f7c11cc9a9bf341c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qFB1ukSECy/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.ABHfBWrt8X/Listeners TMPDIR=/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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-01 05:02:40,968 truncating revision to first 12 chars 2017-04-01 05:02:40,968 Setting DEBUG logging. 2017-04-01 05:02:40,968 attempt 1/10 2017-04-01 05:02:40,968 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0d6ffde320ec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-01 05:02:41,283 unpacking tar archive at: mozilla-central-0d6ffde320ec/testing/mozharness/ program finished with exit code 0 elapsedTime=0.581055 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 05:02:41.469997) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-01 05:02:41.470370) ========= script_repo_revision: 0d6ffde320ec3a3b44dc4c27f7c11cc9a9bf341c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-01 05:02:41.470840) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-01 05:02:41.471151) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-01 05:02:41.491298) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-04-01 05:02:41.491654) ========= /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.qFB1ukSECy/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.ABHfBWrt8X/Listeners TMPDIR=/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 05:02:41 INFO - MultiFileLogger online at 20170401 05:02:41 in /builds/slave/test 05:02:41 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 05:02:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:02:41 INFO - {'append_to_log': False, 05:02:41 INFO - 'base_work_dir': '/builds/slave/test', 05:02:41 INFO - 'blob_upload_branch': 'Firefox', 05:02:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:02:41 INFO - 'branch': 'Firefox', 05:02:41 INFO - 'buildbot_json_path': 'buildprops.json', 05:02:41 INFO - 'config_files': ('talos/mac_config.py',), 05:02:41 INFO - 'default_actions': ('clobber', 05:02:41 INFO - 'read-buildbot-config', 05:02:41 INFO - 'download-and-extract', 05:02:41 INFO - 'populate-webroot', 05:02:41 INFO - 'create-virtualenv', 05:02:41 INFO - 'install', 05:02:41 INFO - 'run-tests'), 05:02:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:02:41 INFO - 'download_minidump_stackwalk': True, 05:02:41 INFO - 'download_symbols': 'ondemand', 05:02:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:02:41 INFO - 'tooltool.py': '/tools/tooltool.py', 05:02:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:02:41 INFO - '/tools/misc-python/virtualenv.py')}, 05:02:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:02:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:02:41 INFO - 'gecko_profile': False, 05:02:41 INFO - 'gecko_profile_interval': 0, 05:02:41 INFO - 'installer_path': 'installer.exe', 05:02:41 INFO - 'log_level': 'info', 05:02:41 INFO - 'log_name': 'talos', 05:02:41 INFO - 'log_to_console': True, 05:02:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:02:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:02:41 INFO - 'opt_config_files': (), 05:02:41 INFO - 'pip_index': False, 05:02:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:02:41 INFO - 'cmd': ('bash', 05:02:41 INFO - '-c', 05:02:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:02:41 INFO - 'enabled': True, 05:02:41 INFO - 'halt_on_failure': False, 05:02:41 INFO - 'name': 'check_screen_resolution'},), 05:02:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:02:41 INFO - 'cmd': ('bash', 05:02:41 INFO - '-c', 05:02:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:02:41 INFO - 'enabled': True, 05:02:41 INFO - 'halt_on_failure': False, 05:02:41 INFO - 'name': 'check_screen_resolution'},), 05:02:41 INFO - 'run_cmd_checks_enabled': True, 05:02:41 INFO - 'suite': 'dromaeojs-e10s', 05:02:41 INFO - 'system_bits': '32', 05:02:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:02:41 INFO - 'title': 't-yosemite-r7-0176', 05:02:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:02:41 INFO - 'use_talos_json': True, 05:02:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:02:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:02:41 INFO - 'work_dir': 'build'} 05:02:41 INFO - [mozharness: 2017-04-01 12:02:41.709953Z] Running clobber step. 05:02:41 INFO - Running pre-action listener: _resource_record_pre_action 05:02:41 INFO - Running main action method: clobber 05:02:41 INFO - rmtree: /builds/slave/test/build 05:02:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:02:44 INFO - Running post-action listener: _resource_record_post_action 05:02:44 INFO - [mozharness: 2017-04-01 12:02:44.257791Z] Finished clobber step (success) 05:02:44 INFO - [mozharness: 2017-04-01 12:02:44.258002Z] Running read-buildbot-config step. 05:02:44 INFO - Running pre-action listener: _resource_record_pre_action 05:02:44 INFO - Running main action method: read_buildbot_config 05:02:44 INFO - Using buildbot properties: 05:02:44 INFO - { 05:02:44 INFO - "project": "", 05:02:44 INFO - "product": "firefox", 05:02:44 INFO - "script_repo_revision": "production", 05:02:44 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:02:44 INFO - "repository": "", 05:02:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:02:44 INFO - "buildid": "20170401040823", 05:02:44 INFO - "stage_platform": "macosx64", 05:02:44 INFO - "basedir": "/builds/slave/test", 05:02:44 INFO - "nightly_build": "True", 05:02:44 INFO - "buildnumber": 16, 05:02:44 INFO - "slavename": "t-yosemite-r7-0176", 05:02:44 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 05:02:44 INFO - "platform": "yosemite_r7", 05:02:44 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:02:44 INFO - "branch": "mozilla-central", 05:02:44 INFO - "repo_path": "mozilla-central", 05:02:44 INFO - "revision": "0d6ffde320ec3a3b44dc4c27f7c11cc9a9bf341c", 05:02:44 INFO - "pgo_build": "False", 05:02:44 INFO - "builduid": "76e86c87d9064fa9976f81d6328c6b37", 05:02:44 INFO - "slavebuilddir": "test" 05:02:44 INFO - } 05:02:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 05:02:44 INFO - Running post-action listener: _resource_record_post_action 05:02:44 INFO - [mozharness: 2017-04-01 12:02:44.264118Z] Finished read-buildbot-config step (success) 05:02:44 INFO - [mozharness: 2017-04-01 12:02:44.264283Z] Running download-and-extract step. 05:02:44 INFO - Running pre-action listener: _resource_record_pre_action 05:02:44 INFO - Running main action method: download_and_extract 05:02:44 INFO - mkdir: /builds/slave/test/build/tests 05:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:44 INFO - trying https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 05:02:44 INFO - Downloading https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/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 05:02:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/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 05:02:45 INFO - Downloaded 1325 bytes. 05:02:45 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 05:02:45 INFO - Using the following test package requirements: 05:02:45 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:02:45 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 05:02:45 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 05:02:45 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:02:45 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 05:02:45 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:02:45 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 05:02:45 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:02:45 INFO - u'jsshell-mac.zip'], 05:02:45 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:02:45 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 05:02:45 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 05:02:45 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:02:45 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 05:02:45 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:02:45 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 05:02:45 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:02:45 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 05:02:45 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:02:45 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 05:02:45 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:02:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 05:02:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:02:45 INFO - Fetch https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 05:02:47 INFO - Expected file size: 52515537 05:02:47 INFO - Obtained file size: 52515537 05:03:04 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 05:03:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 05:03:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:03:04 INFO - Fetch https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 05:03:06 INFO - Expected file size: 52515537 05:03:06 INFO - Obtained file size: 52515537 05:03:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 05:03:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:03:21 INFO - Fetch https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 05:03:23 INFO - Expected file size: 14404152 05:03:23 INFO - Obtained file size: 14404152 05:03: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')]} 05:03:23 INFO - trying https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:03:23 INFO - Downloading https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 05:03:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/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 05:03:26 INFO - Downloaded 75579452 bytes. 05:03:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:03:26 INFO - mkdir: /builds/slave/test/properties 05:03:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:03:26 INFO - Writing to file /builds/slave/test/properties/build_url 05:03:26 INFO - Contents: 05:03:26 INFO - build_url:https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:03:26 INFO - Running post-action listener: _resource_record_post_action 05:03:26 INFO - Running post-action listener: set_extra_try_arguments 05:03:26 INFO - [mozharness: 2017-04-01 12:03:26.873288Z] Finished download-and-extract step (success) 05:03:26 INFO - [mozharness: 2017-04-01 12:03:26.873421Z] Running populate-webroot step. 05:03:26 INFO - Running pre-action listener: _resource_record_pre_action 05:03:26 INFO - Running main action method: populate_webroot 05:03:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:03:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:03:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:03:26 INFO - '--tppagecycles', 05:03:26 INFO - '7'], 05:03:26 INFO - 'tests': ['tsvgm']}}, 05:03:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:03:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:03:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:03:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:03:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:03:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:03:26 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:03:26 INFO - 'talos_options': ['--disable-e10s'], 05:03:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:03:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:03:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:03:26 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:03:26 INFO - 'talos_options': ['--disable-e10s'], 05:03:26 INFO - 'tests': ['damp', 'tps']}, 05:03:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:03:26 INFO - 'tests': ['damp', 'tps']}, 05:03:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:03:26 INFO - 'tests': ['dromaeo_dom']}, 05:03:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:03:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:03:26 INFO - 'tests': ['basic_compositor_video']}, 05:03:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:03:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:03:26 INFO - 'tests': ['a11yr', 05:03:26 INFO - 'ts_paint', 05:03:26 INFO - 'tpaint', 05:03:26 INFO - 'sessionrestore', 05:03:26 INFO - 'sessionrestore_no_auto_restore', 05:03:26 INFO - 'tabpaint']}, 05:03:26 INFO - 'other-e10s': {'tests': ['a11yr', 05:03:26 INFO - 'ts_paint', 05:03:26 INFO - 'tpaint', 05:03:26 INFO - 'sessionrestore', 05:03:26 INFO - 'sessionrestore_no_auto_restore', 05:03:26 INFO - 'tabpaint']}, 05:03:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:03:26 INFO - 'ts_paint', 05:03:26 INFO - 'tpaint', 05:03:26 INFO - 'sessionrestore', 05:03:26 INFO - 'sessionrestore_no_auto_restore', 05:03:26 INFO - 'tabpaint']}, 05:03:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:03:26 INFO - 'ts_paint', 05:03:26 INFO - 'tpaint', 05:03:26 INFO - 'sessionrestore', 05:03:26 INFO - 'sessionrestore_no_auto_restore', 05:03:26 INFO - 'tabpaint']}, 05:03:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:03:26 INFO - 'tests': ['a11yr', 05:03:26 INFO - 'ts_paint', 05:03:26 INFO - 'tpaint', 05:03:26 INFO - 'sessionrestore', 05:03:26 INFO - 'sessionrestore_no_auto_restore', 05:03:26 INFO - 'tabpaint']}, 05:03:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:03:26 INFO - 'tests': ['a11yr', 05:03:26 INFO - 'ts_paint', 05:03:26 INFO - 'tpaint', 05:03:26 INFO - 'sessionrestore', 05:03:26 INFO - 'sessionrestore_no_auto_restore', 05:03:26 INFO - 'tabpaint']}, 05:03:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:03:26 INFO - 'tests': ['tsvgx', 05:03:26 INFO - 'tsvgr_opacity', 05:03:26 INFO - 'tart', 05:03:26 INFO - 'tscrollx', 05:03:26 INFO - 'cart', 05:03:26 INFO - 'tsvg_static']}, 05:03:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:03:26 INFO - 'tsvgr_opacity', 05:03:26 INFO - 'tart', 05:03:26 INFO - 'tscrollx', 05:03:26 INFO - 'cart', 05:03:26 INFO - 'tsvg_static']}, 05:03:26 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:03:26 INFO - 'talos_options': ['--disable-e10s'], 05:03:26 INFO - 'tests': ['tp5o']}, 05:03:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:03:26 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:03:26 INFO - 'talos_options': ['--disable-e10s', 05:03:26 INFO - '--xperf_path', 05:03:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:03:26 INFO - 'tests': ['tp5n']}, 05:03:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:03:26 INFO - 'talos_options': ['--xperf_path', 05:03:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:03:26 INFO - 'tests': ['tp5n']}}, 05:03:26 INFO - 'talos.zip': {'path': '', 05:03:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:03:26 INFO - Running post-action listener: _resource_record_post_action 05:03:26 INFO - [mozharness: 2017-04-01 12:03:26.892141Z] Finished populate-webroot step (success) 05:03:26 INFO - [mozharness: 2017-04-01 12:03:26.892252Z] Running create-virtualenv step. 05:03:26 INFO - Running pre-action listener: _resource_record_pre_action 05:03:26 INFO - Running main action method: create_virtualenv 05:03:26 INFO - Creating virtualenv /builds/slave/test/build/venv 05:03:26 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 05:03:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:03:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:03:27 INFO - Using real prefix '/tools/python27' 05:03:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:03:27 INFO - Installing distribute.............................................................................................................................................................................................done. 05:03:30 INFO - Installing pip.................done. 05:03:30 INFO - Return code: 0 05:03:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:03:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:03:30 INFO - Reading from file tmpfile_stdout 05:03:30 INFO - Output received: 05:03:30 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) 05:03:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:30 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 0x1073beb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7e254fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10719cd30>, '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 0x1070c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107191be8>, '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.qFB1ukSECy/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.ABHfBWrt8X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 05:03:30 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 05:03:30 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 05:03:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qFB1ukSECy/Render', 05:03:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:30 INFO - 'HOME': '/Users/cltbld', 05:03:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:30 INFO - 'LOGNAME': 'cltbld', 05:03:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:30 INFO - 'MOZ_NO_REMOTE': '1', 05:03:30 INFO - 'NO_EM_RESTART': '1', 05:03:30 INFO - 'PAGER': '/bin/cat', 05:03:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:30 INFO - 'PWD': '/builds/slave/test', 05:03:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:30 INFO - 'SHELL': '/bin/bash', 05:03:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ABHfBWrt8X/Listeners', 05:03:30 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 05:03:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:30 INFO - 'USER': 'cltbld', 05:03:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:30 INFO - 'XPC_FLAGS': '0x0', 05:03:30 INFO - 'XPC_SERVICE_NAME': '0', 05:03:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:31 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 05:03:31 INFO - Cleaning up... 05:03:31 INFO - Return code: 0 05:03:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:03: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')]} 05:03:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03: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')]} 05:03:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:31 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 0x1073beb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7e254fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10719cd30>, '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 0x1070c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107191be8>, '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.qFB1ukSECy/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.ABHfBWrt8X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 05:03:31 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 05:03:31 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 05:03:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qFB1ukSECy/Render', 05:03:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:31 INFO - 'HOME': '/Users/cltbld', 05:03:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:31 INFO - 'LOGNAME': 'cltbld', 05:03:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:31 INFO - 'MOZ_NO_REMOTE': '1', 05:03:31 INFO - 'NO_EM_RESTART': '1', 05:03:31 INFO - 'PAGER': '/bin/cat', 05:03:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:31 INFO - 'PWD': '/builds/slave/test', 05:03:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:31 INFO - 'SHELL': '/bin/bash', 05:03:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ABHfBWrt8X/Listeners', 05:03:31 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 05:03:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:31 INFO - 'USER': 'cltbld', 05:03:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:31 INFO - 'XPC_FLAGS': '0x0', 05:03:31 INFO - 'XPC_SERVICE_NAME': '0', 05:03:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:31 INFO - Downloading/unpacking psutil>=3.1.1 05:03:31 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 05:03:31 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 05:03:31 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 05:03:31 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 05:03:31 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 05:03:31 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 05:03:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:03:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:03:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:03:35 INFO - Installing collected packages: psutil 05:03:35 INFO - Running setup.py install for psutil 05:03:35 INFO - building 'psutil._psutil_osx' extension 05:03:35 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 05:03:35 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 05:03:36 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 05:03:36 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 05:03:36 INFO - building 'psutil._psutil_posix' extension 05:03:36 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 05:03:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:03:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:03:36 INFO - ^ 05:03:36 INFO - 1 warning generated. 05:03:36 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 05:03:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:03:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:03:36 INFO - Successfully installed psutil 05:03:36 INFO - Cleaning up... 05:03:36 INFO - Return code: 0 05:03:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:03: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')]} 05:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03: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')]} 05:03:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1073beb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7e254fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10719cd30>, '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 0x1070c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107191be8>, '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.qFB1ukSECy/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.ABHfBWrt8X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 05:03: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:03: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 mozsystemmonitor==0.3 05:03:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qFB1ukSECy/Render', 05:03:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:36 INFO - 'HOME': '/Users/cltbld', 05:03:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:36 INFO - 'LOGNAME': 'cltbld', 05:03:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:36 INFO - 'MOZ_NO_REMOTE': '1', 05:03:36 INFO - 'NO_EM_RESTART': '1', 05:03:36 INFO - 'PAGER': '/bin/cat', 05:03:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:36 INFO - 'PWD': '/builds/slave/test', 05:03:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:36 INFO - 'SHELL': '/bin/bash', 05:03:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ABHfBWrt8X/Listeners', 05:03:36 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 05:03:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:36 INFO - 'USER': 'cltbld', 05:03:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:36 INFO - 'XPC_FLAGS': '0x0', 05:03:36 INFO - 'XPC_SERVICE_NAME': '0', 05:03:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:03:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:03:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:03:39 INFO - Installing collected packages: mozsystemmonitor 05:03:39 INFO - Running setup.py install for mozsystemmonitor 05:03:39 INFO - Successfully installed mozsystemmonitor 05:03:39 INFO - Cleaning up... 05:03:39 INFO - Return code: 0 05:03:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1073beb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7e254fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10719cd30>, '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 0x1070c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107191be8>, '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.qFB1ukSECy/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.ABHfBWrt8X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 05:03:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:03:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:03:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qFB1ukSECy/Render', 05:03:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:39 INFO - 'HOME': '/Users/cltbld', 05:03:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:39 INFO - 'LOGNAME': 'cltbld', 05:03:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:39 INFO - 'MOZ_NO_REMOTE': '1', 05:03:39 INFO - 'NO_EM_RESTART': '1', 05:03:39 INFO - 'PAGER': '/bin/cat', 05:03:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:39 INFO - 'PWD': '/builds/slave/test', 05:03:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:39 INFO - 'SHELL': '/bin/bash', 05:03:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ABHfBWrt8X/Listeners', 05:03:39 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 05:03:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:39 INFO - 'USER': 'cltbld', 05:03:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:39 INFO - 'XPC_FLAGS': '0x0', 05:03:39 INFO - 'XPC_SERVICE_NAME': '0', 05:03:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:40 INFO - Downloading/unpacking jsonschema==2.5.1 05:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:03:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:03:42 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 05:03:42 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 05:03:42 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 05:03:42 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 05:03:42 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 05:03:42 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 05:03:42 INFO - Downloading functools32-3.2.3-2.tar.gz 05:03:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:03:43 INFO - warning: no files found matching '*.txt' 05:03:43 INFO - no previously-included directories found matching 'build' 05:03:43 INFO - no previously-included directories found matching 'dist' 05:03:43 INFO - no previously-included directories found matching '.git*' 05:03:43 INFO - Installing collected packages: jsonschema, functools32 05:03:43 INFO - Running setup.py install for functools32 05:03:43 INFO - warning: no files found matching '*.txt' 05:03:43 INFO - no previously-included directories found matching 'build' 05:03:43 INFO - no previously-included directories found matching 'dist' 05:03:43 INFO - no previously-included directories found matching '.git*' 05:03:43 INFO - Successfully installed jsonschema functools32 05:03:43 INFO - Cleaning up... 05:03:43 INFO - Return code: 0 05:03:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:43 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 0x1073beb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7e254fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10719cd30>, '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 0x1070c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107191be8>, '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.qFB1ukSECy/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.ABHfBWrt8X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 05:03:43 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 05:03:43 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 05:03:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qFB1ukSECy/Render', 05:03:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:43 INFO - 'HOME': '/Users/cltbld', 05:03:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:43 INFO - 'LOGNAME': 'cltbld', 05:03:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:43 INFO - 'MOZ_NO_REMOTE': '1', 05:03:43 INFO - 'NO_EM_RESTART': '1', 05:03:43 INFO - 'PAGER': '/bin/cat', 05:03:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:43 INFO - 'PWD': '/builds/slave/test', 05:03:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:43 INFO - 'SHELL': '/bin/bash', 05:03:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ABHfBWrt8X/Listeners', 05:03:43 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 05:03:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:43 INFO - 'USER': 'cltbld', 05:03:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:43 INFO - 'XPC_FLAGS': '0x0', 05:03:43 INFO - 'XPC_SERVICE_NAME': '0', 05:03:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:03:43 INFO - Cleaning up... 05:03:43 INFO - Return code: 0 05:03:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:43 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 0x1073beb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7e254fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10719cd30>, '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 0x1070c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107191be8>, '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.qFB1ukSECy/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.ABHfBWrt8X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 05:03:43 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 05:03:43 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 05:03:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qFB1ukSECy/Render', 05:03:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:43 INFO - 'HOME': '/Users/cltbld', 05:03:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:43 INFO - 'LOGNAME': 'cltbld', 05:03:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:43 INFO - 'MOZ_NO_REMOTE': '1', 05:03:43 INFO - 'NO_EM_RESTART': '1', 05:03:43 INFO - 'PAGER': '/bin/cat', 05:03:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:43 INFO - 'PWD': '/builds/slave/test', 05:03:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:43 INFO - 'SHELL': '/bin/bash', 05:03:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ABHfBWrt8X/Listeners', 05:03:43 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 05:03:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:43 INFO - 'USER': 'cltbld', 05:03:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:43 INFO - 'XPC_FLAGS': '0x0', 05:03:43 INFO - 'XPC_SERVICE_NAME': '0', 05:03:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:43 INFO - Downloading/unpacking blobuploader==1.2.4 05:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:46 INFO - Downloading blobuploader-1.2.4.tar.gz 05:03:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:03:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:03:46 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 05:03:46 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 05:03:46 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 05:03:46 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 05:03:46 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 05:03:46 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 05:03:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:03:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:03:47 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 05:03:47 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 05:03:47 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 05:03:47 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 05:03:47 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 05:03:47 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 05:03:47 INFO - Downloading docopt-0.6.1.tar.gz 05:03:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:03:47 INFO - Installing collected packages: blobuploader, requests, docopt 05:03:47 INFO - Running setup.py install for blobuploader 05:03:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:03:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:03:47 INFO - Running setup.py install for requests 05:03:48 INFO - Running setup.py install for docopt 05:03:48 INFO - Successfully installed blobuploader requests docopt 05:03:48 INFO - Cleaning up... 05:03:48 INFO - Return code: 0 05:03:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:03:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:03:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:48 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 0x1073beb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7e254fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10719cd30>, '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 0x1070c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107191be8>, '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.qFB1ukSECy/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.ABHfBWrt8X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 05:03:48 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 05:03:48 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 05:03:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qFB1ukSECy/Render', 05:03:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:48 INFO - 'HOME': '/Users/cltbld', 05:03:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:48 INFO - 'LOGNAME': 'cltbld', 05:03:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:48 INFO - 'MOZ_NO_REMOTE': '1', 05:03:48 INFO - 'NO_EM_RESTART': '1', 05:03:48 INFO - 'PAGER': '/bin/cat', 05:03:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:48 INFO - 'PWD': '/builds/slave/test', 05:03:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:48 INFO - 'SHELL': '/bin/bash', 05:03:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ABHfBWrt8X/Listeners', 05:03:48 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 05:03:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:48 INFO - 'USER': 'cltbld', 05:03:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:48 INFO - 'XPC_FLAGS': '0x0', 05:03:48 INFO - 'XPC_SERVICE_NAME': '0', 05:03:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:03:48 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-Q2n2or-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:03:49 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-WOmryr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:03:49 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-C32Gpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:03:49 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-rUHJC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:03:49 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-VT2b96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:03:49 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-wA3K6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:03:49 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-6zknHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:03:49 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-4R_Zs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:03:49 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-NfUsSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:03:49 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-VjNhbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:03:49 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-uqg31e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:03:50 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-nJyIMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:03:50 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-mgQe5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:03:50 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-t_0qOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:50 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-aai219-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:03:50 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-4rxgop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:03:50 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-obykmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:03:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:03:50 INFO - Running setup.py install for manifestparser 05:03:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:03:50 INFO - Running setup.py install for mozcrash 05:03:50 INFO - Running setup.py install for mozdebug 05:03:51 INFO - Running setup.py install for mozdevice 05:03:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:03:51 INFO - Running setup.py install for mozfile 05:03:51 INFO - Running setup.py install for mozhttpd 05:03:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:03:51 INFO - Running setup.py install for mozinfo 05:03:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:03:51 INFO - Running setup.py install for mozInstall 05:03:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:03:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:03:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:03:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:03:51 INFO - Running setup.py install for mozleak 05:03:51 INFO - Running setup.py install for mozlog 05:03:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:03:52 INFO - Running setup.py install for moznetwork 05:03:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:03:52 INFO - Running setup.py install for mozprocess 05:03:52 INFO - Running setup.py install for mozprofile 05:03:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:03:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:03:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:03:52 INFO - Running setup.py install for mozrunner 05:03:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:03:52 INFO - Running setup.py install for mozscreenshot 05:03:52 INFO - Running setup.py install for moztest 05:03:53 INFO - Running setup.py install for mozversion 05:03:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:03:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:03:53 INFO - Cleaning up... 05:03:53 INFO - Return code: 0 05:03:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:03:53 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')]} 05:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:53 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')]} 05:03:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:53 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 0x1073beb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7e254fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10719cd30>, '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 0x1070c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107191be8>, '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.qFB1ukSECy/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.ABHfBWrt8X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 05:03:53 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 05:03:53 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 05:03:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qFB1ukSECy/Render', 05:03:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:53 INFO - 'HOME': '/Users/cltbld', 05:03:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:53 INFO - 'LOGNAME': 'cltbld', 05:03:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:53 INFO - 'MOZ_NO_REMOTE': '1', 05:03:53 INFO - 'NO_EM_RESTART': '1', 05:03:53 INFO - 'PAGER': '/bin/cat', 05:03:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:53 INFO - 'PWD': '/builds/slave/test', 05:03:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:53 INFO - 'SHELL': '/bin/bash', 05:03:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ABHfBWrt8X/Listeners', 05:03:53 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 05:03:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:53 INFO - 'USER': 'cltbld', 05:03:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:53 INFO - 'XPC_FLAGS': '0x0', 05:03:53 INFO - 'XPC_SERVICE_NAME': '0', 05:03:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:03:53 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-woWLOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:03:53 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)) 05:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:03:53 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-1KTvjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:03:53 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)) 05:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:03:53 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-tDUfnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:03:53 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)) 05:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:03:53 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-wG50qq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:03:53 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-lwxRki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:03:54 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)) 05:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:03:54 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-CH9aAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:03:54 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)) 05:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:03:54 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-iEjdEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:03:54 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)) 05:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:03:54 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-y7i7s9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:03:54 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)) 05:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:03:54 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-92f7Cp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:03:54 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)) 05:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:03:54 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-QZfS_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:03:54 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)) 05:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:03:54 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-wQFHK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:03:54 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)) 05:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:03:54 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-5bX4Om-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:03:54 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)) 05:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:03:54 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-_Aq_hb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:03:54 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)) 05:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:03:54 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-Ow2sgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:03:55 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)) 05:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:55 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-9lVtao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:55 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)) 05:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:03:55 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-4XGBml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:03:55 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)) 05:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:03:55 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-M7fjmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:03:55 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)) 05:03:55 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)) 05:03:55 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)) 05:03:55 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)) 05:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:03:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:57 INFO - Downloading blessings-1.6.tar.gz 05:03:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:03:58 INFO - Installing collected packages: blessings 05:03:58 INFO - Running setup.py install for blessings 05:03:58 INFO - Successfully installed blessings 05:03:58 INFO - Cleaning up... 05:03:58 INFO - Return code: 0 05:03:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:03:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:03:58 INFO - Reading from file tmpfile_stdout 05:03:58 INFO - Current package versions: 05:03:58 INFO - blessings == 1.6 05:03:58 INFO - blobuploader == 1.2.4 05:03:58 INFO - docopt == 0.6.1 05:03:58 INFO - functools32 == 3.2.3-2 05:03:58 INFO - jsonschema == 2.5.1 05:03:58 INFO - manifestparser == 1.1 05:03:58 INFO - mozInstall == 1.12 05:03:58 INFO - mozcrash == 1.0 05:03:58 INFO - mozdebug == 0.1 05:03:58 INFO - mozdevice == 0.49 05:03:58 INFO - mozfile == 1.2 05:03:58 INFO - mozhttpd == 0.7 05:03:58 INFO - mozinfo == 0.9 05:03:58 INFO - mozleak == 0.1 05:03:58 INFO - mozlog == 3.4 05:03:58 INFO - moznetwork == 0.27 05:03:58 INFO - mozprocess == 0.25 05:03:58 INFO - mozprofile == 0.28 05:03:58 INFO - mozrunner == 6.13 05:03:58 INFO - mozscreenshot == 0.1 05:03:58 INFO - mozsystemmonitor == 0.3 05:03:58 INFO - moztest == 0.8 05:03:58 INFO - mozversion == 1.4 05:03:58 INFO - psutil == 3.1.1 05:03:58 INFO - requests == 1.2.3 05:03:58 INFO - wsgiref == 0.1.2 05:03:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:03:58 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')]} 05:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:58 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')]} 05:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:58 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 0x1073beb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7e254fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10719cd30>, '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 0x1070c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107191be8>, '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.qFB1ukSECy/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.ABHfBWrt8X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 05:03:58 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 05:03:58 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 05:03:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qFB1ukSECy/Render', 05:03:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:58 INFO - 'HOME': '/Users/cltbld', 05:03:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:58 INFO - 'LOGNAME': 'cltbld', 05:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:58 INFO - 'MOZ_NO_REMOTE': '1', 05:03:58 INFO - 'NO_EM_RESTART': '1', 05:03:58 INFO - 'PAGER': '/bin/cat', 05:03:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:58 INFO - 'PWD': '/builds/slave/test', 05:03:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:58 INFO - 'SHELL': '/bin/bash', 05:03:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ABHfBWrt8X/Listeners', 05:03:58 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 05:03:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:58 INFO - 'USER': 'cltbld', 05:03:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:58 INFO - 'XPC_FLAGS': '0x0', 05:03:58 INFO - 'XPC_SERVICE_NAME': '0', 05:03:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:58 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)) 05:03:58 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)) 05:03:58 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)) 05:03:58 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)) 05:03:58 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)) 05:03:58 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)) 05:03:58 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)) 05:03:58 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)) 05:03:58 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)) 05:03:58 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)) 05:03:58 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)) 05:03:58 INFO - Cleaning up... 05:03:58 INFO - Return code: 0 05:03:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:03:58 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')]} 05:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:58 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')]} 05:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:58 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 0x1073beb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7e254fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10719cd30>, '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 0x1070c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107191be8>, '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.qFB1ukSECy/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.ABHfBWrt8X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 05:03:58 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 05:03:58 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 05:03:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qFB1ukSECy/Render', 05:03:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:03:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:03:58 INFO - 'HOME': '/Users/cltbld', 05:03:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:03:58 INFO - 'LOGNAME': 'cltbld', 05:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:58 INFO - 'MOZ_NO_REMOTE': '1', 05:03:58 INFO - 'NO_EM_RESTART': '1', 05:03:58 INFO - 'PAGER': '/bin/cat', 05:03:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:58 INFO - 'PWD': '/builds/slave/test', 05:03:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:03:58 INFO - 'SHELL': '/bin/bash', 05:03:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ABHfBWrt8X/Listeners', 05:03:58 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 05:03:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:03:58 INFO - 'USER': 'cltbld', 05:03:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:03:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:58 INFO - 'XPC_FLAGS': '0x0', 05:03:58 INFO - 'XPC_SERVICE_NAME': '0', 05:03:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:03:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:03:59 INFO - Cleaning up... 05:03:59 INFO - Return code: 0 05:03:59 INFO - Running post-action listener: _resource_record_post_action 05:03:59 INFO - Running post-action listener: _start_resource_monitoring 05:03:59 INFO - Starting resource monitoring. 05:03:59 INFO - [mozharness: 2017-04-01 12:03:59.179452Z] Finished create-virtualenv step (success) 05:03:59 INFO - [mozharness: 2017-04-01 12:03:59.180403Z] Running install step. 05:03:59 INFO - Running pre-action listener: _resource_record_pre_action 05:03:59 INFO - Running main action method: install 05:03:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:03:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:03:59 INFO - Reading from file tmpfile_stdout 05:03:59 INFO - Detecting whether we're running mozinstall >=1.0... 05:03:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:03:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:03:59 INFO - Reading from file tmpfile_stdout 05:03:59 INFO - Output received: 05:03:59 INFO - Usage: mozinstall [options] installer 05:03:59 INFO - Options: 05:03:59 INFO - -h, --help show this help message and exit 05:03:59 INFO - -d DEST, --destination=DEST 05:03:59 INFO - Directory to install application into. [default: 05:03:59 INFO - "/builds/slave/test"] 05:03:59 INFO - --app=APP Application being installed. [default: firefox] 05:03:59 INFO - mkdir: /builds/slave/test/build/application 05:03:59 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'] 05:03:59 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 05:04:19 INFO - Reading from file tmpfile_stdout 05:04:19 INFO - Output received: 05:04:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:04:19 INFO - Running post-action listener: _resource_record_post_action 05:04:19 INFO - [mozharness: 2017-04-01 12:04:19.902960Z] Finished install step (success) 05:04:19 INFO - [mozharness: 2017-04-01 12:04:19.903125Z] Running run-tests step. 05:04:19 INFO - Running pre-action listener: _resource_record_pre_action 05:04:19 INFO - Running main action method: run_tests 05:04:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:04:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:04:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:04:19 INFO - 2017-04-01 05:04:19.917 screenresolution[1668:13525] starting screenresolution argv=screenresolution get 05:04:19 INFO - 2017-04-01 05:04:19.920 screenresolution[1668:13525] Display 0: 1600x1200x32@60 05:04:19 INFO - 2017-04-01 05:04:19.926 screenresolution[1669:13528] starting screenresolution argv=screenresolution list 05:04:19 INFO - Available Modes on Display 0 05:04:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:04:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:04:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:04:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:04:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:04:20 INFO - Intel Iris: 05:04:20 INFO - Chipset Model: Intel Iris 05:04:20 INFO - Type: GPU 05:04:20 INFO - Bus: Built-In 05:04:20 INFO - VRAM (Dynamic, Max): 1536 MB 05:04:20 INFO - Vendor: Intel (0x8086) 05:04:20 INFO - Device ID: 0x0a2e 05:04:20 INFO - Revision ID: 0x0009 05:04:20 INFO - Displays: 05:04:20 INFO - Display: 05:04:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:04:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:04:20 INFO - Display Serial Number: 1600x1200 60 05:04:20 INFO - Main Display: Yes 05:04:20 INFO - Mirror: Off 05:04:20 INFO - Online: Yes 05:04:20 INFO - Rotation: Supported 05:04:20 INFO - Return code: 0 05:04:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:04:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:04:20 INFO - Python 2.7.3 05:04:20 INFO - Return code: 0 05:04:20 INFO - grabbing minidump binary from tooltool 05:04:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:20 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 0x10719cd30>, '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 0x1070c3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107191be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:04:20 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 05:04:20 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 05:04:20 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 05:04:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:04:20 INFO - Return code: 0 05:04:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:04:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:04:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:04:20 INFO - ENV: RUST_BACKTRACE is now 1 05:04:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:04:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:04:20 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/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0176', '--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 05:04:20 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/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0176 --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 05:04:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qFB1ukSECy/Render', 05:04:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:04:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:04:20 INFO - 'HOME': '/Users/cltbld', 05:04:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:04:20 INFO - 'LOGNAME': 'cltbld', 05:04:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:04:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:04:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:20 INFO - 'MOZ_NO_REMOTE': '1', 05:04:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:04:20 INFO - 'NO_EM_RESTART': '1', 05:04:20 INFO - 'PAGER': '/bin/cat', 05:04:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:04:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:20 INFO - 'PWD': '/builds/slave/test', 05:04:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:04:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:04:20 INFO - 'RUST_BACKTRACE': '1', 05:04:20 INFO - 'SHELL': '/bin/bash', 05:04:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ABHfBWrt8X/Listeners', 05:04:20 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 05:04:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:04:20 INFO - 'USER': 'cltbld', 05:04:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:04:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:04:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:20 INFO - 'XPC_FLAGS': '0x0', 05:04:20 INFO - 'XPC_SERVICE_NAME': '0', 05:04:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:04:20 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/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0176', '--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 05:04:20 INFO - mozversion application_buildid: 20170401040823 05:04:20 INFO - mozversion application_changeset: 0d6ffde320ec3a3b44dc4c27f7c11cc9a9bf341c 05:04:20 INFO - mozversion application_display_name: Nightly 05:04:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:04:20 INFO - mozversion application_name: Firefox 05:04:20 INFO - mozversion application_remotingname: firefox 05:04:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:04:20 INFO - mozversion application_vendor: Mozilla 05:04:20 INFO - mozversion application_version: 55.0a1 05:04:20 INFO - mozversion platform_buildid: 20170401040823 05:04:20 INFO - mozversion platform_changeset: 0d6ffde320ec3a3b44dc4c27f7c11cc9a9bf341c 05:04:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:04:20 INFO - mozversion platform_version: 55.0a1 05:04:20 INFO - using testdate: 1491048260 05:04:20 INFO - actual date: 1491048260 05:04:20 INFO - starting webserver on 'localhost:49242' 05:04:20 INFO - SUITE-START | Running 2 tests 05:04:20 INFO - TEST-START | dromaeo_css 05:04:20 INFO - operating with platform_type : mac_ 05:04:20 INFO - Initialising browser for dromaeo_css test... 05:04:20 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/tmpqBVS6J/profile http://localhost:49242/getInfo.html) 05:04:23 INFO - PID 1679 | 2017-04-01 05:04:23.357 plugin-container[1681:13704] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3f, name = 'com.apple.tsm.portname' 05:04:23 INFO - PID 1679 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:04:23 INFO - PID 1679 | 2017-04-01 05:04:23.360 plugin-container[1681:13704] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9423, name = 'com.apple.CFPasteboardClient' 05:04:23 INFO - PID 1679 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:04:23 INFO - PID 1679 | 2017-04-01 05:04:23.360 plugin-container[1681:13704] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:04:23 INFO - PID 1679 | __metrics Screen width/height:1600/1200 05:04:23 INFO - PID 1679 | colorDepth:24 05:04:23 INFO - PID 1679 | Browser inner width/height: 1024/689 05:04:23 INFO - PID 1679 | __metrics 05:04:23 ERROR - PID 1679 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 05:04:24 INFO - TEST-INFO | 1679: exit 0 05:04:24 INFO - Browser initialized. 05:04:24 INFO - Running cycle 1/1 for dromaeo_css test... 05:04:24 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/tmpqBVS6J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:04:26 INFO - PID 1683 | 2017-04-01 05:04:26.661 plugin-container[1684:13838] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b43, name = 'com.apple.tsm.portname' 05:04:26 INFO - PID 1683 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:04:26 INFO - PID 1683 | 2017-04-01 05:04:26.661 plugin-container[1684:13838] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x451f, name = 'com.apple.CFPasteboardClient' 05:04:26 INFO - PID 1683 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:04:26 INFO - PID 1683 | 2017-04-01 05:04:26.661 plugin-container[1684:13838] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:04:36 INFO - PID 1683 | RSS: Main: 228626432 05:04:36 INFO - PID 1683 | 05:07:40 INFO - PID 1683 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 05:07:41 INFO - PID 1683 | RSS: Main: 251478016 05:07:41 INFO - PID 1683 | 05:09:24 INFO - PID 1683 | ************************* 05:09:24 INFO - PID 1683 | A coding exception was thrown and uncaught in a Task. 05:09:24 INFO - PID 1683 | 05:09:24 ERROR - PID 1683 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:09:24 INFO - PID 1683 | Full stack: 05:09:24 INFO - PID 1683 | ************************* 05:09:24 INFO - PID 1683 | ************************* 05:09:24 INFO - PID 1683 | A coding exception was thrown and uncaught in a Task. 05:09:24 INFO - PID 1683 | 05:09:24 ERROR - PID 1683 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:09:24 INFO - PID 1683 | Full stack: 05:09:24 INFO - PID 1683 | ************************* 05:09:24 INFO - PID 1683 | ************************* 05:09:24 INFO - PID 1683 | A coding exception was thrown and uncaught in a Task. 05:09:24 INFO - PID 1683 | 05:09:24 ERROR - PID 1683 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:09:24 INFO - PID 1683 | Full stack: 05:09:24 INFO - PID 1683 | ************************* 05:09:24 INFO - PID 1683 | ************************* 05:09:24 INFO - PID 1683 | A coding exception was thrown and uncaught in a Task. 05:09:24 INFO - PID 1683 | 05:09:24 ERROR - PID 1683 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:09:24 INFO - PID 1683 | Full stack: 05:09:24 INFO - PID 1683 | ************************* 05:10:44 INFO - PID 1683 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 05:10:44 INFO - PID 1683 | RSS: Main: 260456448 05:10:44 INFO - PID 1683 | 05:13:46 INFO - PID 1683 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 05:13:47 INFO - PID 1683 | RSS: Main: 275554304 05:13:47 INFO - PID 1683 | 05:16:49 INFO - PID 1683 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 05:16:49 INFO - PID 1683 | RSS: Main: 268894208 05:16:49 INFO - PID 1683 | 05:19:52 INFO - PID 1683 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 05:19:53 INFO - PID 1683 | RSS: Main: 279076864 05:19:53 INFO - PID 1683 | 05:22:56 INFO - PID 1683 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 05:22:56 INFO - PID 1683 | RSS: Main: 272830464 05:22:56 INFO - PID 1683 | 05:22:56 INFO - PID 1683 | __start_tp_report 05:22:56 INFO - PID 1683 | _x_x_mozilla_page_load 05:22:56 INFO - PID 1683 | _x_x_mozilla_page_load_details 05:22:56 INFO - PID 1683 | |i|pagename|runs| 05:22:56 INFO - PID 1683 | |0;dojo.html;2676.973230267698;3132.5457808617753;3180.252640629452;3454.9136271593206;3477.843497042633;6184.350643182469;6187.288461826885;6232.189815324007;6235.968820155893;6260.874782504358;4894.094592500381;6059.66671833049;6101.3382043442025;6117.7969560326965;6140.903050468112;5292.682439053649;5450.672959622435;5474.644148130379;5506.421825708303;5523.530499907512;5417.756200970946;5456.7544460499375;5547.057000309957;5549.1676248562635;5568.805091821787;5502.504774570268;5534.916976245359;5567.3040869891265;5606.719664016803;5629.324481062278;4508.661850361236;5364.624476286662;5454.699991500466;5513.145462453326;5523.4200408956885;5405.486478784548;5417.539509141728;5435;5438.700871452069;5448.591355648342;4710.646701497401;5152.407473140599;6140.201773769426;6212.254529456449;6248.468880145193;6360.809175724689;6440.581362211441;6552.049952756871;6631.966840165816;6671.699773510204;6772.932270677279;6785.91425371943;6793.898091528631;6803.2856550062525;6820.522563420563;6276.089966954766;6282.874342513124;6285.779997700059;6287.528435367366;6291.182146320949;6630.237522684856;6646.235682896432;6812;6850.8972365413565;6981.05755722981;6219;6496.382843629847;6572.375624315682;6580.276169621337;6586.769463068866;5682.664573825148;6508.121403610452;6511.674416279167;6616.305287944792;6668.397766880669;6634;6672.633005184664;6686.09737685416;6687.76592819249;6691.531592788556;5554.333479982347;6038.788642397495;6065.272167339947;6439.452646525097;6700.966495167493;5301.416844147141;5331.946680533222;5363.329583802025;5379.946200537945;5396.865078372994;4664.626829853603;4674.901398171427;4679.766011699469;4685.882852928636;4701.036287561042;6176.66028368435;6328.557001009885;6330.8100756977365;6345.841353966188;6372.012338087604;6534.869302613921;6662.6335551545135;6734.764283250062;6750.088738020402;6754.5609535380045;6243.594166379171;6299.496040316763;6349.46029587481;6352.936470635234;6362.204724409449;5955.464008239279;5969.791057312973;5976.163337132805;5978.910316345258;6008.489278411296;6584.407403333723;6720.126383570105;6855.794326170223;6919.8962015568795;6947.478939079489;6696.966515167393;6724.462043036643;6728.899066513908;6730.629815360202;6732.663366831737;6846.8862212994445;6898.1377327834025;6912.55068420551;6930.06444130036;6935.82660433473;5378.946210538001;6309.305976342691;6370.872582548416;6468.256150542559;6643.534952553275;6686.030525573668;6717.899231511434;6720.865582688417;6722.092517510074;6755.3582409671;6201.81394558164;6360.968195158995;6461.547691661539;6491.642959637265;6540.9861471471995;6276.560640755103;6295.779647712308;6337.6197428154455;6494.253160886558;6497.805065848032;6219.440250377488;6284.277308109443;6319.58922670025;6335.366463353628;6341.270753863365;6424.357564243725;6430.582012169194;6438.291787903233;6446.355364463516;6457.225132984072;4732.526747325378;5767.250257466502;6122.947104152957;6218.595791273553;6327.873442531216 05:22:56 INFO - PID 1683 | |1;ext.html;728.5774250934459;754.8452567223719;820.6758330459469;1157.3056166300225;1279.4626256972072;40113.3982990255;40756.18487630245;40818.97952551188;40865.387019194735;41001.79499102504;40084.59915400845;40436.98907527306;40466.59533404665;40531.79734101333;40589;8076.676932922676;8240.093589705128;8516.78708032298;8757.95621021894;8767.736967890973;8724.214820666139;8750.6937257196;8846.601902914352;8847.02682704902;8848;8768.386212965095;8837.204651581356;8841.690540831072;8851.114888511129;8863.645454181826;8812.471251724884;8828.161324674145;8830.558472076435;8844.55777211137;8874.29005679544;8635.870461943075;8672.783180420476;8691.956540217321;8697.913020869773;8703.52130632815;38935.41596876049;39060.21879562421;39074.82775516739;39146.412803807965;39339.80330098331;3066.4480393529157;3075.1082186165986;3086.5215891536845;3093.535969604555;3112.3464072544793;28231.717682823113;28349.716502834915;28496.430071398663;28529.429411411864;29292.70707292921;2797.37059161689;2800.6639203295736;2816.084772448962;2825.19481947646;2861.871215795294;231617;272557.2744272571;295982.5200873982;329350;329812;49927.25109123366;49979.75010124926;50008;50349.49650503448;50415.49584504181;50674;52348.738256308476;52385.7380713094;52612.47387526076;52682.20976685353;14389.568312950629;14495.782563261559;14520.056196347203;14521.128732276096;14543.127412355292;11735.119866010084;11754.941225293818;11864.584739534075;11874.406279685982;11885.22746021506;13958.511452099128;13993.440262389391;14022.929885350712;14057.78913316301;14139.64650883736;6063.878722425527;6066.363031881677;6073.1497590337385;6079.148919151322;6111.786087486917;952.6951375559754;955.302629080775;961.245422343457;971.2618410008304;1007.2093406675724;19414;24428.63357049646;24696;24740.505189896103;24887;1068.9946550267198;1073.4525392050111;1107.7507560798756;1108.3682301088463;1110.0841805510324;12072;12644.873551264369;12646.873531264753;12669;12687.365631718378;353689;424664;424728;425597;426355;43990;57158.142627860616;57224.71387643035;57292.42707572871;57420;1364.2632978191864;1454.4182327069045;1462.8610282023403;1525.2831169350388;1538.8691961183424;20714.378568642966;22621.43446413853;22852;24169.395765106012;24410.145644902343;33432.16419589432;40222.59777402306;40512.98717532085;40688.186236274516;41490.58509414867;420650;429054;429505;430717;430802;34250.48624270588;34323.828380857936;35074;35142.64857351496;35179.47230791489;43569.56430435655;43802.78098609487;44187.77906110449;45006;45278;30164.69835301619;30680.693193068677;30929.226769330948;31004.22489437782;31256.06231813049;29874.402511950073;30709;30893.53659695151;31028.53457198099;31145.37709245757;36363.636363636026;36675.633243667224;36714.8164259177;36879.44680829736;36934.261314773015;29865.5520167202;30635.927742528904;31426.21434464157;31592.368152636358;31681;20312.37500999946;23042.962212521612;23652.763472365743;24591.631125533488;25010.624840627042 05:22:56 INFO - PID 1683 | |2;jquery.html;414.45913083426115;420.28121333358973;428.59069588542945;443.8823711716396;444.9888752781182;20057.899710501446;21545.1381944722;22553.887230563865;22631.66052509214;22665.886670566644;21801.890990545064;22381.32856014318;23031.654525182137;23296;23337.183198588053;6032.366601506845;6059.54553408495;6262.5929314594405;6271.655058971754;6274.341194174614;5513.393526712059;6041.335453100178;6210.347913469089;6224.937750622481;6237.688115594225;5940.821775346725;6081.908771368433;6117.143599896018;6179.938200618004;6199.5350348723805;6078.422549857756;6129.601575897553;6164.722587483551;6171.907421388682;6175.382461753834;5256.947430525723;5428.701421421821;5445.482679145475;5489.478499542537;5500.339959204881;27060.78226479813;27122.45755084907;27188.45623087547;27384;27440.313992150357;2020.9393718188478;2022.8786272823677;2027.5539381336082;2042.1014753508557;2058.999999999985;15467.303971321318;16040.11779352135;16082.39039241544;16179.191040447931;16456.67086658272;1898.5728211152518;1898.6297671953976;1903.790583035865;1926.5280006398382;1940.6797878350055;134558.98161527584;140538;148384;154107;156992.2150389252;10008.749781255381;11476.622805263421;11705.531778728755;12491.93754031224;12567.622971310875;13117.016223783254;13692.383842727102;15590.376384944702;15717.607059823597;15749.763753543706;8678.826423471495;8876.934767827903;8902.287816974627;8945.23965462943;9027.277817774693;7065.328793764585;8527.648897827476;8535.487870727777;8773.780655483537;8811.986621538605;6580.177477815273;7237.457190710613;7423.740169094056;7463.701451941862;7537.2462753724185;1817.4275103342404;2009.1260301768484;2182.9890850545644;2183.617866873291;2231.821454283686;922.5663937949154;942.4157022645867;950.619752099152;994.3884511025811;1004.8040632076675;18181;19683.803161968197;19977.400677979684;20762.584748305253;21242.893785530974;858.5142629759457;966.9419834809934;975.1077763846001;1007.2445665750687;1015.939043657383;9876.40741555509;10271.7432064199;11496.54013839437;12474.563390281297;13573.52492662752;638244;683371;687815.2436951232;748766;751698;157387;160036;161494;164416;166267.16866415832;1052.8631277933819;1213.9089568282413;1237.6101528018646;1269.10528077705;1271.3007845685022;20009.699369540933;20628.96855157206;21525.46186345354;21661.241856534947;21792.564148717254;47989.76005119952;52002.95994080173;64102;64604.38489037812;65363.34636653573;79330;80429.59785201037;80628;80821;82927;8398.454100483448;8503.489790612583;8504.829903402022;8532.189442003;8698.521581312836;13551.79672304936;13629.86370136286;13776.24230667323;14030.579082627537;14055.367508462348;11297.096232301561;11513;11698.70753231176;11858.703532411759;11898.524059037542;10697.358158510515;10775.407352595683;11107.555697772323;11112.111031117329;11177.329360238411;11350.091992640733;11509.36698481558;11815.82276265874;12056.578019769266;12249.326287054297;6583.473322134314;8318.417710760188;8511.106333834858;8512;8912.33157513202;11542.480588373712;11593.130515211224;11741.765164696488;11885.524579017088;12000.57997970067 05:22:56 INFO - PID 1683 | |3;mootools.html;1219.6645922371347;1419.8225221847276;1426.351010290318;1430.7138572285533;1431.1341638308822;10263.076323130927;10510.947445262764;10684.51919663615;10714.142868570516;10714.357138571691;10526.263161578674;10648.094911932476;10657.680269591905;10668.78662426753;10687.78624427511;2411.481531470729;2449.963250551243;2450.9142180023705;2451.2156110044793;2452.104981681682;2338.029717667166;2404.038384646147;2409.734929157791;2415.1426243683504;2419.7822196002357;2332.895019724108;2399.568077746005;2402.6636270922086;2445.572024895645;2447.877606119696;2315.5947709151;2385.630227314769;2390.8206884483648;2392.2942731894045;2416.915407960722;1946.562023544691;2324.697789287382;2335.4511689752894;2359.893804778789;2414.5774489464447;8932.821343573092;10721.142308615292;10755.247132700713;10759.569617215302;10784.13726901846;6057.182280392179;6290.968545157245;6296.118543403927;6296.275928268262;6305;3967.147063381358;3975.5428125765616;4006.779627120507;4056.695747818896;4109.363048727452;1173.4836671864439;1191.2137988927266;1195.043964828134;1222.6759908624222;1233.5127624588238;13118.803217951738;13508.527201547997;14604.634884127876;14627.195504247262;14683.706325873423;5152;5303.734813259399;5316.680999139987;5379.677219366772;5383.192521121785;11131.387773672526;11166.720831979266;11206.49570769301;11213.271137376207;11232.66302010941;5169.7673604687125;5939.198208241918;6189.752409903644;6203.379662033851;6210.689465526705;5744.942550574524;5807;5836.328822185418;5851.005329094064;5857.794977175864;4058.6347228749555;4237.851675191415;4274.016976095515;4323.978380108079;4330.112326972963;1223.3760782001066;1249.1325468424582;1254.3477391756235;1259.3262604506729;1266.4490946438145;761.6153842309598;763.1262204775501;790.213737331359;790.7904405332591;799.5322736199389;4746.644001699887;5273.472652734773;5769.480746732815;5901.967155747727;6118.632882027093;587.1134586774002;592.3543337761774;597.9850503737441;885.623609965762;922.326701507903;4028.456158418576;4124.835006599762;4135.338345864648;4301.956980430155;4302.569743025735;13001.95984321252;13477;13503.257320847448;13515.797263041062;13568.728625427437;12979.675508112372;13153.21080735159;13277.468901244036;13278.668033299246;13380.799288010687;8515.872261916076;9941.950290248502;9970.052844979715;10066.345687530287;10140.138088262433;6202.41077097675;6273;6363.936360636334;6406.359364063556;6502.317256687979;9862.013798620368;12018.819717704417;12281;12298.877011229773;12330.136890417944;11476.540938362372;11879.049676025725;12182.634520964386;12484.750304994031;12501.687457813627;7852.6073696313815;8133.308668763221;8288.58557072156;8293;8334.20825021622;8313.251807337369;9823.410595364301;9863.901360986298;10007.299489035697;10055.145312648507;7060.505764596429;8452.873206902024;8495.575221238789;8497.673885184959;8618.698345557876;8272.296854767412;8318.958405208177;8364.079951205242;8391.244787969112;8592.398532102692;7696.384289256958;7832.608369581384;7836.490628109154;7845.450818442654;7848.803779905548;5805.593608447368;5842.269716285465;5962.55280853929;5989.431004054608;5992.280926288873;5804.419558044162;5932.2584676915385;5967.343592204941;6108.358622344767;6129.785457508966 05:22:56 INFO - PID 1683 | |4;prototype.html;328.7468649140162;358.36211543452663;391.99020024499384;399.72818483431263;403.55205721648963;5863.856547973136;6424.61452312861;6449.2905780364235;6457.806265812027;6500.804975850726;5391.870211266548;5520.171974203861;5716.685582292972;6305.337939516354;6315.431611154995;3495.207699645881;4138.793060346986;4755.334253204554;4769.284607308897;4832.275158726184;4790.592799612037;4802.59177969873;4802.927956080662;4842.612590992712;4852.199387101124;3776.9622303776887;3937;4606.848287928018;4734.171519983989;4808.879778005543;4723.834665786698;4737.7681802731195;4747.382840230783;4789.856304310876;4805.231163013918;4209.695389119526;4229.873103806891;4240.745555266663;4270.444842170529;4273.615374616268;5287.964133808473;5383.784648614051;5999.250093738283;6192.81421557354;6196.10156527301;5619.466150715675;5632;5670.994372982326;5678.290213723285;5680.233168522238;6769.763058292985;6782.559133656297;6809.761658341934;6837;6859.588424694484;3740.8503659853573;4205.149734116979;4410.955890441087;4431.379606855043;4446.55534446556;6535.934640653581;6897.724091036353;7038.577685338845;7095.787126386217;7208.855822883565;4383.978080109579;4481.011899409528;4527.139843429738;4529.32060190974;4529.84145554904;4160.938960565037;4558.635309175258;4616.561426664462;4636.9566847459055;4639.698419602715;5135.743212839343;5307.124324486494;5457.263269458573;5470.671759694431;5475.014497390428;6676.6661666917435;6749.865002700017;6751.729930802713;6772.5936443813525;6775.457963362919;1529.296523599157;1533.5322726568281;1533.562934563644;1536.3700882638288;1536.8934367255558;1009.5154325923597;1022.749426390539;1034.1416624201895;1035.3011717090933;1047.2302857399804;4825.962418080129;6153.7230824613;6311.936880631135;6334.524910631629;6359.872802543923;6698.933010669928;6824.488163387766;6847.520673552903;6945.617991010442;6963.1644202696;6322.9051564226575;6323.399277068671;6339.587926784744;6345.619262844152;6399.408609132601;3605.6214097519905;3626.3472574936236;3674.210044840372;3674.540682414698;3685.7972811495088;6423.683144955273;6592.274849766522;7217.711291548279;7313.597752123685;7376.852462950711;7223.205447400782;7252.984582158502;7270.781876543712;7301.853962920712;7324.230955749569;5900.350961394243;6851.588904665736;7135.928640713631;7207.495475316782;7302.780916572511;6415.679216039086;6930.757423490154;6952.687129079102;7048.224695283618;7048.400885924754;6007.459328660441;6332.556721029484;6436.685107169717;6867.148763406979;6914;6644.106429667521;6953.130858642669;7122.145342558926;7171.318724721144;7270.491065625567;4922;4950.6782059166035;4962.950370496394;4981.701097934136;4986.950130498793;6175.980963141032;6377.808665740035;6386.65880165152;6890.379865812101;6998.500749625187;5069.695818250917;6764.425023873026;6784.626845523544;6820.795376138723;6827.89758153638;5344.893102138013;6514.013225965937;6761.951897455902;6774.830629234309;6800.795976120724;6609.8017059486365;6619.940809470461;6627.37039981201;6635.568688035262;6679.76620818269;5369.4630536946;6425.421712045938;6751.156105486814;6784.864302714017;6803.9319606805275;5230.607704422107;5710.743016564347;6043.36544662804;6564.934350656624;6576.914809056452 05:22:56 INFO - PID 1683 | |5;yui.html;662.4600950225569;663.3234101216759;726.46604745512;729.7445893937121;766.1419210484255;13323.26722030288;13386.933065334684;15797.684046319067;16622.833771662295;16678;13863.445462181526;14074.64813379666;15193.468228612;15273.312700928456;15330.003549769257;867.0462491259595;934.5467448287609;953.7472569769017;1032.592126110186;1037.6886933919832;969.612155137947;1027.542743479152;1040.9895901041007;1045.6026709850246;1048.6172547020358;1082.1775450657517;1085.8751243606969;1093.0763504838399;1093.5899037860802;1096.0464395975512;1083.9620613278498;1083.975643017353;1084.0839490630483;1086.190787863047;1086.7989421956925;786.182370334851;802.8835818806241;805.8630032894422;806.1938061938062;811.6266517402003;16344.918275408547;16913.985160890385;17017.319307227695;17108.401205957733;17112.48662540126;12300.938495307555;13168;15053;15134.772978405334;15136.394544218218;11436.828447573293;11713.70715732105;11766.117541184445;12077.275363478131;12441.502339906392;2984.7164519370626;3044.710752478511;3046.2688954650944;3123.7848347375107;3171.001134642603;117936;120928;121310;123772.9999999991;124157.37921310426;11363.14776391774;11500.654980350602;11580.189386742848;11611.187216894905;11935.641930742091;25279.494410111696;25475.10837120692;25565;25630.359241019123;25718.228453146436;7577.469577129548;7596.24037596247;7605.733799316998;7684.231576842383;7761.223877612194;4012.398140278923;4116.444280022219;4125.938110928339;4151.3772934059525;4191.140816132685;4149.33610622299;4208.516020657602;4251.681123915657;4255.574442555781;4258.318669012943;854.3549620036832;857.4416518390369;862.7454900804278;864.5849992003873;865.057087774329;538.8087229033715;549.428594261971;552.2268823646926;567.9943200567941;591.9496842768327;10289.125424338865;10307.226957978182;10307.690769276935;10526.315789473812;10563.154947604173;557.345119484612;557.5511713071016;576.3659974028535;582.7173820696959;607.750822162911;4487.640988720895;4664.533546645376;4724.2205036169335;4742.881427964259;4828.61371090312;102238;103309;103332.45001324987;105813;106122.4081638776;68955.65522172357;79171.8124228137;85076.14923850683;85523;87603;62100.37899621036;74282.62858685672;78801.60599196967;79860.20139798644;80326.79509807358;10767.842266036914;10835.945820271163;11025.44872756375;11116;11134.27627204229;30024.167132699946;37233;37437;39445.21109577735;41002;52750;58596;71314.79083441154;74775.62612187122;75085.12287192864;13733.176009439465;13786.931065344608;14414.990950633355;14666.56000319992;14880;14661.926690366907;14794.63013424673;14919.701605967603;15032.473863414729;15042.097474151586;13657.179351350722;13759.380827862971;13870.583882483541;13988.509792452178;14071.718565628835;11685.546035332676;13808.516701915385;13863.168209907439;13890;14294.785578216542;13223.669408264486;13381.39783709716;13452.730945381234;13870.4451821926;14169.716605667623;9449.622015119317;9463.810723785624;9521.904780952102;9541.284403669892;9664;7927.038264178366;9387.624495020124;10347.63783267582;10356.326838755456;10386.11718003978 05:22:56 INFO - PID 1683 | __end_tp_report 05:22:56 INFO - PID 1683 | __start_cc_report 05:22:56 INFO - PID 1683 | _x_x_mozilla_cycle_collect,429 05:22:56 INFO - PID 1683 | __end_cc_report 05:22:56 INFO - PID 1683 | __startTimestamp1491049376337__endTimestamp 05:22:56 INFO - PID 1683 | 05:22:56 INFO - PID 1683 | ------- Summary: start ------- 05:22:56 INFO - PID 1683 | Number of tests: 6 05:22:56 INFO - PID 1683 | 05:22:56 INFO - PID 1683 | [#0] dojo.html Cycles:165 Average:6072.48 Median:6299.50 stddev:777.50 (12.3%) stddev-sans-first:732.83 05:22:56 INFO - PID 1683 | Values: 2677.0 3132.5 3180.3 3454.9 3477.8 6184.4 6187.3 6232.2 6236.0 6260.9 4894.1 6059.7 6101.3 6117.8 6140.9 5292.7 5450.7 5474.6 5506.4 5523.5 5417.8 5456.8 5547.1 5549.2 5568.8 5502.5 5534.9 5567.3 5606.7 5629.3 4508.7 5364.6 5454.7 5513.1 5523.4 5405.5 5417.5 5435.0 5438.7 5448.6 4710.6 5152.4 6140.2 6212.3 6248.5 6360.8 6440.6 6552.0 6632.0 6671.7 6772.9 6785.9 6793.9 6803.3 6820.5 6276.1 6282.9 6285.8 6287.5 6291.2 6630.2 6646.2 6812.0 6850.9 6981.1 6219.0 6496.4 6572.4 6580.3 6586.8 5682.7 6508.1 6511.7 6616.3 6668.4 6634.0 6672.6 6686.1 6687.8 6691.5 5554.3 6038.8 6065.3 6439.5 6701.0 5301.4 5331.9 5363.3 5379.9 5396.9 4664.6 4674.9 4679.8 4685.9 4701.0 6176.7 6328.6 6330.8 6345.8 6372.0 6534.9 6662.6 6734.8 6750.1 6754.6 6243.6 6299.5 6349.5 6352.9 6362.2 5955.5 5969.8 5976.2 5978.9 6008.5 6584.4 6720.1 6855.8 6919.9 6947.5 6697.0 6724.5 6728.9 6730.6 6732.7 6846.9 6898.1 6912.6 6930.1 6935.8 5378.9 6309.3 6370.9 6468.3 6643.5 6686.0 6717.9 6720.9 6722.1 6755.4 6201.8 6361.0 6461.5 6491.6 6541.0 6276.6 6295.8 6337.6 6494.3 6497.8 6219.4 6284.3 6319.6 6335.4 6341.3 6424.4 6430.6 6438.3 6446.4 6457.2 4732.5 5767.3 6122.9 6218.6 6327.9 05:22:56 INFO - PID 1683 | 05:22:56 INFO - PID 1683 | [#1] ext.html Cycles:180 Average:51870.93 Median:36519.63 stddev:101437.83 (277.8%) stddev-sans-first:101649.71 05:22:56 INFO - PID 1683 | Values: 728.6 754.8 820.7 1157.3 1279.5 40113.4 40756.2 40819.0 40865.4 41001.8 40084.6 40437.0 40466.6 40531.8 40589.0 8076.7 8240.1 8516.8 8758.0 8767.7 8724.2 8750.7 8846.6 8847.0 8848.0 8768.4 8837.2 8841.7 8851.1 8863.6 8812.5 8828.2 8830.6 8844.6 8874.3 8635.9 8672.8 8692.0 8697.9 8703.5 38935.4 39060.2 39074.8 39146.4 39339.8 3066.4 3075.1 3086.5 3093.5 3112.3 28231.7 28349.7 28496.4 28529.4 29292.7 2797.4 2800.7 2816.1 2825.2 2861.9 231617.0 272557.3 295982.5 329350.0 329812.0 49927.3 49979.8 50008.0 50349.5 50415.5 50674.0 52348.7 52385.7 52612.5 52682.2 14389.6 14495.8 14520.1 14521.1 14543.1 11735.1 11754.9 11864.6 11874.4 11885.2 13958.5 13993.4 14022.9 14057.8 14139.6 6063.9 6066.4 6073.1 6079.1 6111.8 952.7 955.3 961.2 971.3 1007.2 19414.0 24428.6 24696.0 24740.5 24887.0 1069.0 1073.5 1107.8 1108.4 1110.1 12072.0 12644.9 12646.9 12669.0 12687.4 353689.0 424664.0 424728.0 425597.0 426355.0 43990.0 57158.1 57224.7 57292.4 57420.0 1364.3 1454.4 1462.9 1525.3 1538.9 20714.4 22621.4 22852.0 24169.4 24410.1 33432.2 40222.6 40513.0 40688.2 41490.6 420650.0 429054.0 429505.0 430717.0 430802.0 34250.5 34323.8 35074.0 35142.6 35179.5 43569.6 43802.8 44187.8 45006.0 45278.0 30164.7 30680.7 30929.2 31004.2 31256.1 29874.4 30709.0 30893.5 31028.5 31145.4 36363.6 36675.6 36714.8 36879.4 36934.3 29865.6 30635.9 31426.2 31592.4 31681.0 20312.4 23043.0 23652.8 24591.6 25010.6 05:22:56 INFO - PID 1683 | 05:22:56 INFO - PID 1683 | [#2] jquery.html Cycles:180 Average:40503.05 Median:22467.61 stddev:117954.73 (525.0%) stddev-sans-first:118247.22 05:22:56 INFO - PID 1683 | Values: 414.5 420.3 428.6 443.9 445.0 20057.9 21545.1 22553.9 22631.7 22665.9 21801.9 22381.3 23031.7 23296.0 23337.2 6032.4 6059.5 6262.6 6271.7 6274.3 5513.4 6041.3 6210.3 6224.9 6237.7 5940.8 6081.9 6117.1 6179.9 6199.5 6078.4 6129.6 6164.7 6171.9 6175.4 5256.9 5428.7 5445.5 5489.5 5500.3 27060.8 27122.5 27188.5 27384.0 27440.3 2020.9 2022.9 2027.6 2042.1 2059.0 15467.3 16040.1 16082.4 16179.2 16456.7 1898.6 1898.6 1903.8 1926.5 1940.7 134559.0 140538.0 148384.0 154107.0 156992.2 10008.7 11476.6 11705.5 12491.9 12567.6 13117.0 13692.4 15590.4 15717.6 15749.8 8678.8 8876.9 8902.3 8945.2 9027.3 7065.3 8527.6 8535.5 8773.8 8812.0 6580.2 7237.5 7423.7 7463.7 7537.2 1817.4 2009.1 2183.0 2183.6 2231.8 922.6 942.4 950.6 994.4 1004.8 18181.0 19683.8 19977.4 20762.6 21242.9 858.5 966.9 975.1 1007.2 1015.9 9876.4 10271.7 11496.5 12474.6 13573.5 638244.0 683371.0 687815.2 748766.0 751698.0 157387.0 160036.0 161494.0 164416.0 166267.2 1052.9 1213.9 1237.6 1269.1 1271.3 20009.7 20629.0 21525.5 21661.2 21792.6 47989.8 52003.0 64102.0 64604.4 65363.3 79330.0 80429.6 80628.0 80821.0 82927.0 8398.5 8503.5 8504.8 8532.2 8698.5 13551.8 13629.9 13776.2 14030.6 14055.4 11297.1 11513.0 11698.7 11858.7 11898.5 10697.4 10775.4 11107.6 11112.1 11177.3 11350.1 11509.4 11815.8 12056.6 12249.3 6583.5 8318.4 8511.1 8512.0 8912.3 11542.5 11593.1 11741.8 11885.5 12000.6 05:22:56 INFO - PID 1683 | 05:22:56 INFO - PID 1683 | [#3] mootools.html Cycles:180 Average:6560.08 Median:4042.58 stddev:3985.92 (98.6%) stddev-sans-first:3976.90 05:22:56 INFO - PID 1683 | Values: 1219.7 1419.8 1426.4 1430.7 1431.1 10263.1 10510.9 10684.5 10714.1 10714.4 10526.3 10648.1 10657.7 10668.8 10687.8 2411.5 2450.0 2450.9 2451.2 2452.1 2338.0 2404.0 2409.7 2415.1 2419.8 2332.9 2399.6 2402.7 2445.6 2447.9 2315.6 2385.6 2390.8 2392.3 2416.9 1946.6 2324.7 2335.5 2359.9 2414.6 8932.8 10721.1 10755.2 10759.6 10784.1 6057.2 6291.0 6296.1 6296.3 6305.0 3967.1 3975.5 4006.8 4056.7 4109.4 1173.5 1191.2 1195.0 1222.7 1233.5 13118.8 13508.5 14604.6 14627.2 14683.7 5152.0 5303.7 5316.7 5379.7 5383.2 11131.4 11166.7 11206.5 11213.3 11232.7 5169.8 5939.2 6189.8 6203.4 6210.7 5744.9 5807.0 5836.3 5851.0 5857.8 4058.6 4237.9 4274.0 4324.0 4330.1 1223.4 1249.1 1254.3 1259.3 1266.4 761.6 763.1 790.2 790.8 799.5 4746.6 5273.5 5769.5 5902.0 6118.6 587.1 592.4 598.0 885.6 922.3 4028.5 4124.8 4135.3 4302.0 4302.6 13002.0 13477.0 13503.3 13515.8 13568.7 12979.7 13153.2 13277.5 13278.7 13380.8 8515.9 9942.0 9970.1 10066.3 10140.1 6202.4 6273.0 6363.9 6406.4 6502.3 9862.0 12018.8 12281.0 12298.9 12330.1 11476.5 11879.0 12182.6 12484.8 12501.7 7852.6 8133.3 8288.6 8293.0 8334.2 8313.3 9823.4 9863.9 10007.3 10055.1 7060.5 8452.9 8495.6 8497.7 8618.7 8272.3 8319.0 8364.1 8391.2 8592.4 7696.4 7832.6 7836.5 7845.5 7848.8 5805.6 5842.3 5962.6 5989.4 5992.3 5804.4 5932.3 5967.3 6108.4 6129.8 05:22:56 INFO - PID 1683 | 05:22:56 INFO - PID 1683 | [#4] prototype.html Cycles:180 Average:5451.52 Median:6098.54 stddev:1710.09 (28.0%) stddev-sans-first:1671.10 05:22:56 INFO - PID 1683 | Values: 328.7 358.4 392.0 399.7 403.6 5863.9 6424.6 6449.3 6457.8 6500.8 5391.9 5520.2 5716.7 6305.3 6315.4 3495.2 4138.8 4755.3 4769.3 4832.3 4790.6 4802.6 4802.9 4842.6 4852.2 3777.0 3937.0 4606.8 4734.2 4808.9 4723.8 4737.8 4747.4 4789.9 4805.2 4209.7 4229.9 4240.7 4270.4 4273.6 5288.0 5383.8 5999.3 6192.8 6196.1 5619.5 5632.0 5671.0 5678.3 5680.2 6769.8 6782.6 6809.8 6837.0 6859.6 3740.9 4205.1 4411.0 4431.4 4446.6 6535.9 6897.7 7038.6 7095.8 7208.9 4384.0 4481.0 4527.1 4529.3 4529.8 4160.9 4558.6 4616.6 4637.0 4639.7 5135.7 5307.1 5457.3 5470.7 5475.0 6676.7 6749.9 6751.7 6772.6 6775.5 1529.3 1533.5 1533.6 1536.4 1536.9 1009.5 1022.7 1034.1 1035.3 1047.2 4826.0 6153.7 6311.9 6334.5 6359.9 6698.9 6824.5 6847.5 6945.6 6963.2 6322.9 6323.4 6339.6 6345.6 6399.4 3605.6 3626.3 3674.2 3674.5 3685.8 6423.7 6592.3 7217.7 7313.6 7376.9 7223.2 7253.0 7270.8 7301.9 7324.2 5900.4 6851.6 7135.9 7207.5 7302.8 6415.7 6930.8 6952.7 7048.2 7048.4 6007.5 6332.6 6436.7 6867.1 6914.0 6644.1 6953.1 7122.1 7171.3 7270.5 4922.0 4950.7 4963.0 4981.7 4987.0 6176.0 6377.8 6386.7 6890.4 6998.5 5069.7 6764.4 6784.6 6820.8 6827.9 5344.9 6514.0 6762.0 6774.8 6800.8 6609.8 6619.9 6627.4 6635.6 6679.8 5369.5 6425.4 6751.2 6784.9 6803.9 5230.6 5710.7 6043.4 6564.9 6576.9 05:22:56 INFO - PID 1683 | 05:22:56 INFO - PID 1683 | [#5] yui.html Cycles:180 Average:20495.53 Median:16965.65 stddev:29967.24 (176.6%) stddev-sans-first:30014.30 05:22:56 INFO - PID 1683 | Values: 662.5 663.3 726.5 729.7 766.1 13323.3 13386.9 15797.7 16622.8 16678.0 13863.4 14074.6 15193.5 15273.3 15330.0 867.0 934.5 953.7 1032.6 1037.7 969.6 1027.5 1041.0 1045.6 1048.6 1082.2 1085.9 1093.1 1093.6 1096.0 1084.0 1084.0 1084.1 1086.2 1086.8 786.2 802.9 805.9 806.2 811.6 16344.9 16914.0 17017.3 17108.4 17112.5 12300.9 13168.0 15053.0 15134.8 15136.4 11436.8 11713.7 11766.1 12077.3 12441.5 2984.7 3044.7 3046.3 3123.8 3171.0 117936.0 120928.0 121310.0 123773.0 124157.4 11363.1 11500.7 11580.2 11611.2 11935.6 25279.5 25475.1 25565.0 25630.4 25718.2 7577.5 7596.2 7605.7 7684.2 7761.2 4012.4 4116.4 4125.9 4151.4 4191.1 4149.3 4208.5 4251.7 4255.6 4258.3 854.4 857.4 862.7 864.6 865.1 538.8 549.4 552.2 568.0 591.9 10289.1 10307.2 10307.7 10526.3 10563.2 557.3 557.6 576.4 582.7 607.8 4487.6 4664.5 4724.2 4742.9 4828.6 102238.0 103309.0 103332.5 105813.0 106122.4 68955.7 79171.8 85076.1 85523.0 87603.0 62100.4 74282.6 78801.6 79860.2 80326.8 10767.8 10835.9 11025.4 11116.0 11134.3 30024.2 37233.0 37437.0 39445.2 41002.0 52750.0 58596.0 71314.8 74775.6 75085.1 13733.2 13786.9 14415.0 14666.6 14880.0 14661.9 14794.6 14919.7 15032.5 15042.1 13657.2 13759.4 13870.6 13988.5 14071.7 11685.5 13808.5 13863.2 13890.0 14294.8 13223.7 13381.4 13452.7 13870.4 14169.7 9449.6 9463.8 9521.9 9541.3 9664.0 7927.0 9387.6 10347.6 10356.3 10386.1 05:22:56 INFO - PID 1683 | -------- Summary: end -------- 05:22:56 INFO - PID 1683 | 05:22:56 INFO - TEST-INFO | 1683: exit 0 05:22:56 INFO - TEST-OK | dromaeo_css | took 1116480ms 05:22:56 INFO - TEST-START | kraken 05:22:56 INFO - operating with platform_type : mac_ 05:22:56 INFO - Initialising browser for kraken test... 05:22:57 INFO - TEST-INFO | started process 1691 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/tmpOMudRm/profile http://localhost:49242/getInfo.html) 05:22:59 INFO - PID 1691 | 2017-04-01 05:22:59.917 plugin-container[1692:16185] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434f, name = 'com.apple.tsm.portname' 05:22:59 INFO - PID 1691 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:22:59 INFO - PID 1691 | 2017-04-01 05:22:59.920 plugin-container[1692:16185] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 05:22:59 INFO - PID 1691 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:22:59 INFO - PID 1691 | 2017-04-01 05:22:59.920 plugin-container[1692:16185] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:23:00 INFO - PID 1691 | __metrics Screen width/height:1600/1200 05:23:00 INFO - PID 1691 | colorDepth:24 05:23:00 INFO - PID 1691 | Browser inner width/height: 1024/689 05:23:00 INFO - PID 1691 | __metrics 05:23:00 ERROR - PID 1691 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 05:23:00 INFO - TEST-INFO | 1691: exit 0 05:23:00 INFO - Browser initialized. 05:23:00 INFO - Running cycle 1/1 for kraken test... 05:23:01 INFO - TEST-INFO | started process 1693 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/tmpOMudRm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:23:03 INFO - PID 1693 | 2017-04-01 05:23:03.425 plugin-container[1694:16310] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8843, name = 'com.apple.tsm.portname' 05:23:03 INFO - PID 1693 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:23:03 INFO - PID 1693 | 2017-04-01 05:23:03.426 plugin-container[1694:16310] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 05:23:03 INFO - PID 1693 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:23:03 INFO - PID 1693 | 2017-04-01 05:23:03.426 plugin-container[1694:16310] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:23:13 INFO - PID 1693 | RSS: Main: 228786176 05:23:13 INFO - PID 1693 | 05:23:16 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 05:23:17 INFO - PID 1693 | RSS: Main: 243707904 05:23:17 INFO - PID 1693 | 05:23:20 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 05:23:20 INFO - PID 1693 | RSS: Main: 252289024 05:23:20 INFO - PID 1693 | 05:23:24 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 05:23:25 INFO - PID 1693 | RSS: Main: 254787584 05:23:25 INFO - PID 1693 | 05:23:27 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 05:23:27 INFO - PID 1693 | RSS: Main: 256618496 05:23:27 INFO - PID 1693 | 05:23:30 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:23:30 INFO - PID 1693 | RSS: Main: 257236992 05:23:30 INFO - PID 1693 | 05:23:34 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 05:23:34 INFO - PID 1693 | RSS: Main: 262946816 05:23:34 INFO - PID 1693 | 05:23:37 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 05:23:38 INFO - PID 1693 | RSS: Main: 263454720 05:23:38 INFO - PID 1693 | 05:23:41 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 05:23:42 INFO - PID 1693 | RSS: Main: 263323648 05:23:42 INFO - PID 1693 | 05:23:44 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:23:44 INFO - PID 1693 | RSS: Main: 262594560 05:23:44 INFO - PID 1693 | 05:23:46 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:23:47 INFO - PID 1693 | RSS: Main: 262549504 05:23:47 INFO - PID 1693 | 05:23:49 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:23:50 INFO - PID 1693 | RSS: Main: 262901760 05:23:50 INFO - PID 1693 | 05:23:53 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:23:54 INFO - PID 1693 | RSS: Main: 263434240 05:23:54 INFO - PID 1693 | 05:23:57 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:23:58 INFO - PID 1693 | RSS: Main: 268611584 05:23:58 INFO - PID 1693 | 05:24:00 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 05:24:00 INFO - PID 1693 | RSS: Main: 271290368 05:24:00 INFO - PID 1693 | 05:24:00 INFO - PID 1693 | __start_tp_report 05:24:00 INFO - PID 1693 | _x_x_mozilla_page_load 05:24:00 INFO - PID 1693 | _x_x_mozilla_page_load_details 05:24:00 INFO - PID 1693 | |i|pagename|runs| 05:24:00 INFO - PID 1693 | |0;ai-astar;118;179;158;123;128;155;184;182;124;131 05:24:00 INFO - PID 1693 | |1;audio-beat-detection;161;117;118;159;127;118;118;133;177;163 05:24:00 INFO - PID 1693 | |2;audio-dft;201;228;264;299;223;201;211;278;276;272 05:24:00 INFO - PID 1693 | |3;audio-fft;81;70;75;107;90;87;60;60;76;61 05:24:00 INFO - PID 1693 | |4;audio-oscillator;91;75;101;108;113;102;87;73;71;70 05:24:00 INFO - PID 1693 | |5;imaging-gaussian-blur;141;103;141;92;95;93;94;85;100;140 05:24:00 INFO - PID 1693 | |6;imaging-darkroom;101;101;101;103;102;101;104;123;101;100 05:24:00 INFO - PID 1693 | |7;imaging-desaturate;103;141;109;119;106;164;142;110;163;106 05:24:00 INFO - PID 1693 | |8;json-parse-financial;51;51;51;52;51;51;51;51;53;51 05:24:00 INFO - PID 1693 | |9;json-stringify-tinderbox;57;60;69;102;99;85;65;62;59;61 05:24:00 INFO - PID 1693 | |10;stanford-crypto-aes;88;86;82;107;87;76;116;121;119;90 05:24:00 INFO - PID 1693 | |11;stanford-crypto-ccm;186;174;148;153;147;148;146;171;235;186 05:24:00 INFO - PID 1693 | |12;stanford-crypto-pbkdf2;187;253;187;251;258;231;197;198;196;189 05:24:00 INFO - PID 1693 | |13;stanford-crypto-sha256-iterative;72;71;69;72;85;105;98;104;96;75 05:24:00 INFO - PID 1693 | __end_tp_report 05:24:00 INFO - PID 1693 | __start_cc_report 05:24:00 INFO - PID 1693 | _x_x_mozilla_cycle_collect,1016 05:24:00 INFO - PID 1693 | __end_cc_report 05:24:00 INFO - PID 1693 | __startTimestamp1491049440500__endTimestamp 05:24:00 INFO - PID 1693 | 05:24:00 INFO - PID 1693 | ------- Summary: start ------- 05:24:00 INFO - PID 1693 | Number of tests: 14 05:24:00 INFO - PID 1693 | 05:24:00 INFO - PID 1693 | [#0] ai-astar Cycles:10 Average:148.20 Median:156.50 stddev:26.57 (17.0%) stddev-sans-first:25.83 05:24:00 INFO - PID 1693 | Values: 118.0 179.0 158.0 123.0 128.0 155.0 184.0 182.0 124.0 131.0 05:24:00 INFO - PID 1693 | 05:24:00 INFO - PID 1693 | [#1] audio-beat-detection Cycles:10 Average:139.10 Median:146.00 stddev:23.31 (16.0%) stddev-sans-first:23.34 05:24:00 INFO - PID 1693 | Values: 161.0 117.0 118.0 159.0 127.0 118.0 118.0 133.0 177.0 163.0 05:24:00 INFO - PID 1693 | 05:24:00 INFO - PID 1693 | [#2] audio-dft Cycles:10 Average:245.30 Median:268.00 stddev:36.30 (13.5%) stddev-sans-first:34.78 05:24:00 INFO - PID 1693 | Values: 201.0 228.0 264.0 299.0 223.0 201.0 211.0 278.0 276.0 272.0 05:24:00 INFO - PID 1693 | 05:24:00 INFO - PID 1693 | [#3] audio-fft Cycles:10 Average:76.70 Median:75.50 stddev:15.17 (20.1%) stddev-sans-first:16.01 05:24:00 INFO - PID 1693 | Values: 81.0 70.0 75.0 107.0 90.0 87.0 60.0 60.0 76.0 61.0 05:24:00 INFO - PID 1693 | 05:24:00 INFO - PID 1693 | [#4] audio-oscillator Cycles:10 Average:89.10 Median:72.00 stddev:16.31 (22.7%) stddev-sans-first:17.29 05:24:00 INFO - PID 1693 | Values: 91.0 75.0 101.0 108.0 113.0 102.0 87.0 73.0 71.0 70.0 05:24:00 INFO - PID 1693 | 05:24:00 INFO - PID 1693 | [#5] imaging-gaussian-blur Cycles:10 Average:108.40 Median:88.50 stddev:22.77 (25.7%) stddev-sans-first:20.87 05:24:00 INFO - PID 1693 | Values: 141.0 103.0 141.0 92.0 95.0 93.0 94.0 85.0 100.0 140.0 05:24:00 INFO - PID 1693 | 05:24:00 INFO - PID 1693 | [#6] imaging-darkroom Cycles:10 Average:103.70 Median:101.50 stddev:6.88 (6.8%) stddev-sans-first:7.23 05:24:00 INFO - PID 1693 | Values: 101.0 101.0 101.0 103.0 102.0 101.0 104.0 123.0 101.0 100.0 05:24:00 INFO - PID 1693 | 05:24:00 INFO - PID 1693 | [#7] imaging-desaturate Cycles:10 Average:126.30 Median:130.00 stddev:24.07 (18.5%) stddev-sans-first:24.01 05:24:00 INFO - PID 1693 | Values: 103.0 141.0 109.0 119.0 106.0 164.0 142.0 110.0 163.0 106.0 05:24:00 INFO - PID 1693 | 05:24:00 INFO - PID 1693 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:51.00 stddev:0.67 (1.3%) stddev-sans-first:0.71 05:24:00 INFO - PID 1693 | Values: 51.0 51.0 51.0 52.0 51.0 51.0 51.0 51.0 53.0 51.0 05:24:00 INFO - PID 1693 | 05:24:00 INFO - PID 1693 | [#9] json-stringify-tinderbox Cycles:10 Average:71.90 Median:63.50 stddev:17.05 (26.8%) stddev-sans-first:17.21 05:24:00 INFO - PID 1693 | Values: 57.0 60.0 69.0 102.0 99.0 85.0 65.0 62.0 59.0 61.0 05:24:00 INFO - PID 1693 | 05:24:00 INFO - PID 1693 | [#10] stanford-crypto-aes Cycles:10 Average:97.20 Median:84.00 stddev:16.79 (20.0%) stddev-sans-first:17.48 05:24:00 INFO - PID 1693 | Values: 88.0 86.0 82.0 107.0 87.0 76.0 116.0 121.0 119.0 90.0 05:24:00 INFO - PID 1693 | 05:24:00 INFO - PID 1693 | [#11] stanford-crypto-ccm Cycles:10 Average:169.40 Median:172.50 stddev:28.11 (16.3%) stddev-sans-first:29.17 05:24:00 INFO - PID 1693 | Values: 186.0 174.0 148.0 153.0 147.0 148.0 146.0 171.0 235.0 186.0 05:24:00 INFO - PID 1693 | 05:24:00 INFO - PID 1693 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:214.70 Median:214.50 stddev:29.93 (14.0%) stddev-sans-first:30.02 05:24:00 INFO - PID 1693 | Values: 187.0 253.0 187.0 251.0 258.0 231.0 197.0 198.0 196.0 189.0 05:24:00 INFO - PID 1693 | 05:24:00 INFO - PID 1693 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:84.70 Median:73.50 stddev:14.68 (20.0%) stddev-sans-first:14.84 05:24:00 INFO - PID 1693 | Values: 72.0 71.0 69.0 72.0 85.0 105.0 98.0 104.0 96.0 75.0 05:24:00 INFO - PID 1693 | -------- Summary: end -------- 05:24:00 INFO - PID 1693 | 05:24:01 INFO - TEST-INFO | 1693: exit 0 05:24:01 INFO - TEST-OK | kraken | took 64383ms 05:24:01 INFO - SUITE-END | took 1180s 05:24:01 INFO - Completed test suite (00:19:41) 05:24:01 INFO - javascript benchmark 05:24:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7723.038992612553, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2676.973230267698, 3132.5457808617753, 3180.252640629452, 3454.9136271593206, 3477.843497042633, 6184.350643182469, 6187.288461826885, 6232.189815324007, 6235.968820155893, 6260.874782504358, 4894.094592500381, 6059.66671833049, 6101.3382043442025, 6117.7969560326965, 6140.903050468112, 5292.682439053649, 5450.672959622435, 5474.644148130379, 5506.421825708303, 5523.530499907512, 5417.756200970946, 5456.7544460499375, 5547.057000309957, 5549.1676248562635, 5568.805091821787, 5502.504774570268, 5534.916976245359, 5567.3040869891265, 5606.719664016803, 5629.324481062278, 4508.661850361236, 5364.624476286662, 5454.699991500466, 5513.145462453326, 5523.4200408956885, 5405.486478784548, 5417.539509141728, 5435.0, 5438.700871452069, 5448.591355648342, 4710.646701497401, 5152.407473140599, 6140.201773769426, 6212.254529456449, 6248.468880145193, 6360.809175724689, 6440.581362211441, 6552.049952756871, 6631.966840165816, 6671.699773510204, 6772.932270677279, 6785.91425371943, 6793.898091528631, 6803.2856550062525, 6820.522563420563, 6276.089966954766, 6282.874342513124, 6285.779997700059, 6287.528435367366, 6291.182146320949, 6630.237522684856, 6646.235682896432, 6812.0, 6850.8972365413565, 6981.05755722981, 6219.0, 6496.382843629847, 6572.375624315682, 6580.276169621337, 6586.769463068866, 5682.664573825148, 6508.121403610452, 6511.674416279167, 6616.305287944792, 6668.397766880669, 6634.0, 6672.633005184664, 6686.09737685416, 6687.76592819249, 6691.531592788556, 5554.333479982347, 6038.788642397495, 6065.272167339947, 6439.452646525097, 6700.966495167493, 5301.416844147141, 5331.946680533222, 5363.329583802025, 5379.946200537945, 5396.865078372994, 4664.626829853603, 4674.901398171427, 4679.766011699469, 4685.882852928636, 4701.036287561042, 6176.66028368435, 6328.557001009885, 6330.8100756977365, 6345.841353966188, 6372.012338087604, 6534.869302613921, 6662.6335551545135, 6734.764283250062, 6750.088738020402, 6754.5609535380045, 6243.594166379171, 6299.496040316763, 6349.46029587481, 6352.936470635234, 6362.204724409449, 5955.464008239279, 5969.791057312973, 5976.163337132805, 5978.910316345258, 6008.489278411296, 6584.407403333723, 6720.126383570105, 6855.794326170223, 6919.8962015568795, 6947.478939079489, 6696.966515167393, 6724.462043036643, 6728.899066513908, 6730.629815360202, 6732.663366831737, 6846.8862212994445, 6898.1377327834025, 6912.55068420551, 6930.06444130036, 6935.82660433473, 5378.946210538001, 6309.305976342691, 6370.872582548416, 6468.256150542559, 6643.534952553275, 6686.030525573668, 6717.899231511434, 6720.865582688417, 6722.092517510074, 6755.3582409671, 6201.81394558164, 6360.968195158995, 6461.547691661539, 6491.642959637265, 6540.9861471471995, 6276.560640755103, 6295.779647712308, 6337.6197428154455, 6494.253160886558, 6497.805065848032, 6219.440250377488, 6284.277308109443, 6319.58922670025, 6335.366463353628, 6341.270753863365, 6424.357564243725, 6430.582012169194, 6438.291787903233, 6446.355364463516, 6457.225132984072, 4732.526747325378, 5767.250257466502, 6122.947104152957, 6218.595791273553, 6327.873442531216], "value": 6016.724160014866, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.5774250934459, 754.8452567223719, 820.6758330459469, 1157.3056166300225, 1279.4626256972072, 40113.3982990255, 40756.18487630245, 40818.97952551188, 40865.387019194735, 41001.79499102504, 40084.59915400845, 40436.98907527306, 40466.59533404665, 40531.79734101333, 40589.0, 8076.676932922676, 8240.093589705128, 8516.78708032298, 8757.95621021894, 8767.736967890973, 8724.214820666139, 8750.6937257196, 8846.601902914352, 8847.02682704902, 8848.0, 8768.386212965095, 8837.204651581356, 8841.690540831072, 8851.114888511129, 8863.645454181826, 8812.471251724884, 8828.161324674145, 8830.558472076435, 8844.55777211137, 8874.29005679544, 8635.870461943075, 8672.783180420476, 8691.956540217321, 8697.913020869773, 8703.52130632815, 38935.41596876049, 39060.21879562421, 39074.82775516739, 39146.412803807965, 39339.80330098331, 3066.4480393529157, 3075.1082186165986, 3086.5215891536845, 3093.535969604555, 3112.3464072544793, 28231.717682823113, 28349.716502834915, 28496.430071398663, 28529.429411411864, 29292.70707292921, 2797.37059161689, 2800.6639203295736, 2816.084772448962, 2825.19481947646, 2861.871215795294, 231617.0, 272557.2744272571, 295982.5200873982, 329350.0, 329812.0, 49927.25109123366, 49979.75010124926, 50008.0, 50349.49650503448, 50415.49584504181, 50674.0, 52348.738256308476, 52385.7380713094, 52612.47387526076, 52682.20976685353, 14389.568312950629, 14495.782563261559, 14520.056196347203, 14521.128732276096, 14543.127412355292, 11735.119866010084, 11754.941225293818, 11864.584739534075, 11874.406279685982, 11885.22746021506, 13958.511452099128, 13993.440262389391, 14022.929885350712, 14057.78913316301, 14139.64650883736, 6063.878722425527, 6066.363031881677, 6073.1497590337385, 6079.148919151322, 6111.786087486917, 952.6951375559754, 955.302629080775, 961.245422343457, 971.2618410008304, 1007.2093406675724, 19414.0, 24428.63357049646, 24696.0, 24740.505189896103, 24887.0, 1068.9946550267198, 1073.4525392050111, 1107.7507560798756, 1108.3682301088463, 1110.0841805510324, 12072.0, 12644.873551264369, 12646.873531264753, 12669.0, 12687.365631718378, 353689.0, 424664.0, 424728.0, 425597.0, 426355.0, 43990.0, 57158.142627860616, 57224.71387643035, 57292.42707572871, 57420.0, 1364.2632978191864, 1454.4182327069045, 1462.8610282023403, 1525.2831169350388, 1538.8691961183424, 20714.378568642966, 22621.43446413853, 22852.0, 24169.395765106012, 24410.145644902343, 33432.16419589432, 40222.59777402306, 40512.98717532085, 40688.186236274516, 41490.58509414867, 420650.0, 429054.0, 429505.0, 430717.0, 430802.0, 34250.48624270588, 34323.828380857936, 35074.0, 35142.64857351496, 35179.47230791489, 43569.56430435655, 43802.78098609487, 44187.77906110449, 45006.0, 45278.0, 30164.69835301619, 30680.693193068677, 30929.226769330948, 31004.22489437782, 31256.06231813049, 29874.402511950073, 30709.0, 30893.53659695151, 31028.53457198099, 31145.37709245757, 36363.636363636026, 36675.633243667224, 36714.8164259177, 36879.44680829736, 36934.261314773015, 29865.5520167202, 30635.927742528904, 31426.21434464157, 31592.368152636358, 31681.0, 20312.37500999946, 23042.962212521612, 23652.763472365743, 24591.631125533488, 25010.624840627042], "value": 17926.208402907137, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.45913083426115, 420.28121333358973, 428.59069588542945, 443.8823711716396, 444.9888752781182, 20057.899710501446, 21545.1381944722, 22553.887230563865, 22631.66052509214, 22665.886670566644, 21801.890990545064, 22381.32856014318, 23031.654525182137, 23296.0, 23337.183198588053, 6032.366601506845, 6059.54553408495, 6262.5929314594405, 6271.655058971754, 6274.341194174614, 5513.393526712059, 6041.335453100178, 6210.347913469089, 6224.937750622481, 6237.688115594225, 5940.821775346725, 6081.908771368433, 6117.143599896018, 6179.938200618004, 6199.5350348723805, 6078.422549857756, 6129.601575897553, 6164.722587483551, 6171.907421388682, 6175.382461753834, 5256.947430525723, 5428.701421421821, 5445.482679145475, 5489.478499542537, 5500.339959204881, 27060.78226479813, 27122.45755084907, 27188.45623087547, 27384.0, 27440.313992150357, 2020.9393718188478, 2022.8786272823677, 2027.5539381336082, 2042.1014753508557, 2058.999999999985, 15467.303971321318, 16040.11779352135, 16082.39039241544, 16179.191040447931, 16456.67086658272, 1898.5728211152518, 1898.6297671953976, 1903.790583035865, 1926.5280006398382, 1940.6797878350055, 134558.98161527584, 140538.0, 148384.0, 154107.0, 156992.2150389252, 10008.749781255381, 11476.622805263421, 11705.531778728755, 12491.93754031224, 12567.622971310875, 13117.016223783254, 13692.383842727102, 15590.376384944702, 15717.607059823597, 15749.763753543706, 8678.826423471495, 8876.934767827903, 8902.287816974627, 8945.23965462943, 9027.277817774693, 7065.328793764585, 8527.648897827476, 8535.487870727777, 8773.780655483537, 8811.986621538605, 6580.177477815273, 7237.457190710613, 7423.740169094056, 7463.701451941862, 7537.2462753724185, 1817.4275103342404, 2009.1260301768484, 2182.9890850545644, 2183.617866873291, 2231.821454283686, 922.5663937949154, 942.4157022645867, 950.619752099152, 994.3884511025811, 1004.8040632076675, 18181.0, 19683.803161968197, 19977.400677979684, 20762.584748305253, 21242.893785530974, 858.5142629759457, 966.9419834809934, 975.1077763846001, 1007.2445665750687, 1015.939043657383, 9876.40741555509, 10271.7432064199, 11496.54013839437, 12474.563390281297, 13573.52492662752, 638244.0, 683371.0, 687815.2436951232, 748766.0, 751698.0, 157387.0, 160036.0, 161494.0, 164416.0, 166267.16866415832, 1052.8631277933819, 1213.9089568282413, 1237.6101528018646, 1269.10528077705, 1271.3007845685022, 20009.699369540933, 20628.96855157206, 21525.46186345354, 21661.241856534947, 21792.564148717254, 47989.76005119952, 52002.95994080173, 64102.0, 64604.38489037812, 65363.34636653573, 79330.0, 80429.59785201037, 80628.0, 80821.0, 82927.0, 8398.454100483448, 8503.489790612583, 8504.829903402022, 8532.189442003, 8698.521581312836, 13551.79672304936, 13629.86370136286, 13776.24230667323, 14030.579082627537, 14055.367508462348, 11297.096232301561, 11513.0, 11698.70753231176, 11858.703532411759, 11898.524059037542, 10697.358158510515, 10775.407352595683, 11107.555697772323, 11112.111031117329, 11177.329360238411, 11350.091992640733, 11509.36698481558, 11815.82276265874, 12056.578019769266, 12249.326287054297, 6583.473322134314, 8318.417710760188, 8511.106333834858, 8512.0, 8912.33157513202, 11542.480588373712, 11593.130515211224, 11741.765164696488, 11885.524579017088, 12000.57997970067], "value": 10391.264231296724, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1219.6645922371347, 1419.8225221847276, 1426.351010290318, 1430.7138572285533, 1431.1341638308822, 10263.076323130927, 10510.947445262764, 10684.51919663615, 10714.142868570516, 10714.357138571691, 10526.263161578674, 10648.094911932476, 10657.680269591905, 10668.78662426753, 10687.78624427511, 2411.481531470729, 2449.963250551243, 2450.9142180023705, 2451.2156110044793, 2452.104981681682, 2338.029717667166, 2404.038384646147, 2409.734929157791, 2415.1426243683504, 2419.7822196002357, 2332.895019724108, 2399.568077746005, 2402.6636270922086, 2445.572024895645, 2447.877606119696, 2315.5947709151, 2385.630227314769, 2390.8206884483648, 2392.2942731894045, 2416.915407960722, 1946.562023544691, 2324.697789287382, 2335.4511689752894, 2359.893804778789, 2414.5774489464447, 8932.821343573092, 10721.142308615292, 10755.247132700713, 10759.569617215302, 10784.13726901846, 6057.182280392179, 6290.968545157245, 6296.118543403927, 6296.275928268262, 6305.0, 3967.147063381358, 3975.5428125765616, 4006.779627120507, 4056.695747818896, 4109.363048727452, 1173.4836671864439, 1191.2137988927266, 1195.043964828134, 1222.6759908624222, 1233.5127624588238, 13118.803217951738, 13508.527201547997, 14604.634884127876, 14627.195504247262, 14683.706325873423, 5152.0, 5303.734813259399, 5316.680999139987, 5379.677219366772, 5383.192521121785, 11131.387773672526, 11166.720831979266, 11206.49570769301, 11213.271137376207, 11232.66302010941, 5169.7673604687125, 5939.198208241918, 6189.752409903644, 6203.379662033851, 6210.689465526705, 5744.942550574524, 5807.0, 5836.328822185418, 5851.005329094064, 5857.794977175864, 4058.6347228749555, 4237.851675191415, 4274.016976095515, 4323.978380108079, 4330.112326972963, 1223.3760782001066, 1249.1325468424582, 1254.3477391756235, 1259.3262604506729, 1266.4490946438145, 761.6153842309598, 763.1262204775501, 790.213737331359, 790.7904405332591, 799.5322736199389, 4746.644001699887, 5273.472652734773, 5769.480746732815, 5901.967155747727, 6118.632882027093, 587.1134586774002, 592.3543337761774, 597.9850503737441, 885.623609965762, 922.326701507903, 4028.456158418576, 4124.835006599762, 4135.338345864648, 4301.956980430155, 4302.569743025735, 13001.95984321252, 13477.0, 13503.257320847448, 13515.797263041062, 13568.728625427437, 12979.675508112372, 13153.21080735159, 13277.468901244036, 13278.668033299246, 13380.799288010687, 8515.872261916076, 9941.950290248502, 9970.052844979715, 10066.345687530287, 10140.138088262433, 6202.41077097675, 6273.0, 6363.936360636334, 6406.359364063556, 6502.317256687979, 9862.013798620368, 12018.819717704417, 12281.0, 12298.877011229773, 12330.136890417944, 11476.540938362372, 11879.049676025725, 12182.634520964386, 12484.750304994031, 12501.687457813627, 7852.6073696313815, 8133.308668763221, 8288.58557072156, 8293.0, 8334.20825021622, 8313.251807337369, 9823.410595364301, 9863.901360986298, 10007.299489035697, 10055.145312648507, 7060.505764596429, 8452.873206902024, 8495.575221238789, 8497.673885184959, 8618.698345557876, 8272.296854767412, 8318.958405208177, 8364.079951205242, 8391.244787969112, 8592.398532102692, 7696.384289256958, 7832.608369581384, 7836.490628109154, 7845.450818442654, 7848.803779905548, 5805.593608447368, 5842.269716285465, 5962.55280853929, 5989.431004054608, 5992.280926288873, 5804.419558044162, 5932.2584676915385, 5967.343592204941, 6108.358622344767, 6129.785457508966], "value": 5026.402094417946, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.7468649140162, 358.36211543452663, 391.99020024499384, 399.72818483431263, 403.55205721648963, 5863.856547973136, 6424.61452312861, 6449.2905780364235, 6457.806265812027, 6500.804975850726, 5391.870211266548, 5520.171974203861, 5716.685582292972, 6305.337939516354, 6315.431611154995, 3495.207699645881, 4138.793060346986, 4755.334253204554, 4769.284607308897, 4832.275158726184, 4790.592799612037, 4802.59177969873, 4802.927956080662, 4842.612590992712, 4852.199387101124, 3776.9622303776887, 3937.0, 4606.848287928018, 4734.171519983989, 4808.879778005543, 4723.834665786698, 4737.7681802731195, 4747.382840230783, 4789.856304310876, 4805.231163013918, 4209.695389119526, 4229.873103806891, 4240.745555266663, 4270.444842170529, 4273.615374616268, 5287.964133808473, 5383.784648614051, 5999.250093738283, 6192.81421557354, 6196.10156527301, 5619.466150715675, 5632.0, 5670.994372982326, 5678.290213723285, 5680.233168522238, 6769.763058292985, 6782.559133656297, 6809.761658341934, 6837.0, 6859.588424694484, 3740.8503659853573, 4205.149734116979, 4410.955890441087, 4431.379606855043, 4446.55534446556, 6535.934640653581, 6897.724091036353, 7038.577685338845, 7095.787126386217, 7208.855822883565, 4383.978080109579, 4481.011899409528, 4527.139843429738, 4529.32060190974, 4529.84145554904, 4160.938960565037, 4558.635309175258, 4616.561426664462, 4636.9566847459055, 4639.698419602715, 5135.743212839343, 5307.124324486494, 5457.263269458573, 5470.671759694431, 5475.014497390428, 6676.6661666917435, 6749.865002700017, 6751.729930802713, 6772.5936443813525, 6775.457963362919, 1529.296523599157, 1533.5322726568281, 1533.562934563644, 1536.3700882638288, 1536.8934367255558, 1009.5154325923597, 1022.749426390539, 1034.1416624201895, 1035.3011717090933, 1047.2302857399804, 4825.962418080129, 6153.7230824613, 6311.936880631135, 6334.524910631629, 6359.872802543923, 6698.933010669928, 6824.488163387766, 6847.520673552903, 6945.617991010442, 6963.1644202696, 6322.9051564226575, 6323.399277068671, 6339.587926784744, 6345.619262844152, 6399.408609132601, 3605.6214097519905, 3626.3472574936236, 3674.210044840372, 3674.540682414698, 3685.7972811495088, 6423.683144955273, 6592.274849766522, 7217.711291548279, 7313.597752123685, 7376.852462950711, 7223.205447400782, 7252.984582158502, 7270.781876543712, 7301.853962920712, 7324.230955749569, 5900.350961394243, 6851.588904665736, 7135.928640713631, 7207.495475316782, 7302.780916572511, 6415.679216039086, 6930.757423490154, 6952.687129079102, 7048.224695283618, 7048.400885924754, 6007.459328660441, 6332.556721029484, 6436.685107169717, 6867.148763406979, 6914.0, 6644.106429667521, 6953.130858642669, 7122.145342558926, 7171.318724721144, 7270.491065625567, 4922.0, 4950.6782059166035, 4962.950370496394, 4981.701097934136, 4986.950130498793, 6175.980963141032, 6377.808665740035, 6386.65880165152, 6890.379865812101, 6998.500749625187, 5069.695818250917, 6764.425023873026, 6784.626845523544, 6820.795376138723, 6827.89758153638, 5344.893102138013, 6514.013225965937, 6761.951897455902, 6774.830629234309, 6800.795976120724, 6609.8017059486365, 6619.940809470461, 6627.37039981201, 6635.568688035262, 6679.76620818269, 5369.4630536946, 6425.421712045938, 6751.156105486814, 6784.864302714017, 6803.9319606805275, 5230.607704422107, 5710.743016564347, 6043.36544662804, 6564.934350656624, 6576.914809056452], "value": 4906.1110532594175, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.4600950225569, 663.3234101216759, 726.46604745512, 729.7445893937121, 766.1419210484255, 13323.26722030288, 13386.933065334684, 15797.684046319067, 16622.833771662295, 16678.0, 13863.445462181526, 14074.64813379666, 15193.468228612, 15273.312700928456, 15330.003549769257, 867.0462491259595, 934.5467448287609, 953.7472569769017, 1032.592126110186, 1037.6886933919832, 969.612155137947, 1027.542743479152, 1040.9895901041007, 1045.6026709850246, 1048.6172547020358, 1082.1775450657517, 1085.8751243606969, 1093.0763504838399, 1093.5899037860802, 1096.0464395975512, 1083.9620613278498, 1083.975643017353, 1084.0839490630483, 1086.190787863047, 1086.7989421956925, 786.182370334851, 802.8835818806241, 805.8630032894422, 806.1938061938062, 811.6266517402003, 16344.918275408547, 16913.985160890385, 17017.319307227695, 17108.401205957733, 17112.48662540126, 12300.938495307555, 13168.0, 15053.0, 15134.772978405334, 15136.394544218218, 11436.828447573293, 11713.70715732105, 11766.117541184445, 12077.275363478131, 12441.502339906392, 2984.7164519370626, 3044.710752478511, 3046.2688954650944, 3123.7848347375107, 3171.001134642603, 117936.0, 120928.0, 121310.0, 123772.9999999991, 124157.37921310426, 11363.14776391774, 11500.654980350602, 11580.189386742848, 11611.187216894905, 11935.641930742091, 25279.494410111696, 25475.10837120692, 25565.0, 25630.359241019123, 25718.228453146436, 7577.469577129548, 7596.24037596247, 7605.733799316998, 7684.231576842383, 7761.223877612194, 4012.398140278923, 4116.444280022219, 4125.938110928339, 4151.3772934059525, 4191.140816132685, 4149.33610622299, 4208.516020657602, 4251.681123915657, 4255.574442555781, 4258.318669012943, 854.3549620036832, 857.4416518390369, 862.7454900804278, 864.5849992003873, 865.057087774329, 538.8087229033715, 549.428594261971, 552.2268823646926, 567.9943200567941, 591.9496842768327, 10289.125424338865, 10307.226957978182, 10307.690769276935, 10526.315789473812, 10563.154947604173, 557.345119484612, 557.5511713071016, 576.3659974028535, 582.7173820696959, 607.750822162911, 4487.640988720895, 4664.533546645376, 4724.2205036169335, 4742.881427964259, 4828.61371090312, 102238.0, 103309.0, 103332.45001324987, 105813.0, 106122.4081638776, 68955.65522172357, 79171.8124228137, 85076.14923850683, 85523.0, 87603.0, 62100.37899621036, 74282.62858685672, 78801.60599196967, 79860.20139798644, 80326.79509807358, 10767.842266036914, 10835.945820271163, 11025.44872756375, 11116.0, 11134.27627204229, 30024.167132699946, 37233.0, 37437.0, 39445.21109577735, 41002.0, 52750.0, 58596.0, 71314.79083441154, 74775.62612187122, 75085.12287192864, 13733.176009439465, 13786.931065344608, 14414.990950633355, 14666.56000319992, 14880.0, 14661.926690366907, 14794.63013424673, 14919.701605967603, 15032.473863414729, 15042.097474151586, 13657.179351350722, 13759.380827862971, 13870.583882483541, 13988.509792452178, 14071.718565628835, 11685.546035332676, 13808.516701915385, 13863.168209907439, 13890.0, 14294.785578216542, 13223.669408264486, 13381.39783709716, 13452.730945381234, 13870.4451821926, 14169.716605667623, 9449.622015119317, 9463.810723785624, 9521.904780952102, 9541.284403669892, 9664.0, 7927.038264178366, 9387.624495020124, 10347.63783267582, 10356.326838755456, 10386.11718003978], "value": 7676.894007377125, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1726.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 179.0, 158.0, 123.0, 128.0, 155.0, 184.0, 182.0, 124.0, 131.0], "value": 148.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 117.0, 118.0, 159.0, 127.0, 118.0, 118.0, 133.0, 177.0, 163.0], "value": 139.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 228.0, 264.0, 299.0, 223.0, 201.0, 211.0, 278.0, 276.0, 272.0], "value": 245.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 70.0, 75.0, 107.0, 90.0, 87.0, 60.0, 60.0, 76.0, 61.0], "value": 76.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 75.0, 101.0, 108.0, 113.0, 102.0, 87.0, 73.0, 71.0, 70.0], "value": 89.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 103.0, 141.0, 92.0, 95.0, 93.0, 94.0, 85.0, 100.0, 140.0], "value": 108.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 101.0, 101.0, 103.0, 102.0, 101.0, 104.0, 123.0, 101.0, 100.0], "value": 103.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 141.0, 109.0, 119.0, 106.0, 164.0, 142.0, 110.0, 163.0, 106.0], "value": 126.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 51.0, 52.0, 51.0, 51.0, 51.0, 51.0, 53.0, 51.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 60.0, 69.0, 102.0, 99.0, 85.0, 65.0, 62.0, 59.0, 61.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 82.0, 107.0, 87.0, 76.0, 116.0, 121.0, 119.0, 90.0], "value": 97.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 174.0, 148.0, 153.0, 147.0, 148.0, 146.0, 171.0, 235.0, 186.0], "value": 169.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 253.0, 187.0, 251.0, 258.0, 231.0, 197.0, 198.0, 196.0, 189.0], "value": 214.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 69.0, 72.0, 85.0, 105.0, 98.0, 104.0, 96.0, 75.0], "value": 84.7, "unit": "score"}]}]} 05:24:01 INFO - Return code: 0 05:24:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:24:01 ERROR - # TBPL SUCCESS # 05:24:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:24:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:24:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:24:01 INFO - 2017-04-01 05:24:01.857 screenresolution[1698:16714] starting screenresolution argv=screenresolution get 05:24:01 INFO - 2017-04-01 05:24:01.859 screenresolution[1698:16714] Display 0: 1600x1200x32@60 05:24:01 INFO - 2017-04-01 05:24:01.865 screenresolution[1699:16718] starting screenresolution argv=screenresolution list 05:24:01 INFO - Available Modes on Display 0 05:24:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:24:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:24:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:24:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:24:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:24:02 INFO - Intel Iris: 05:24:02 INFO - Chipset Model: Intel Iris 05:24:02 INFO - Type: GPU 05:24:02 INFO - Bus: Built-In 05:24:02 INFO - VRAM (Dynamic, Max): 1536 MB 05:24:02 INFO - Vendor: Intel (0x8086) 05:24:02 INFO - Device ID: 0x0a2e 05:24:02 INFO - Revision ID: 0x0009 05:24:02 INFO - Displays: 05:24:02 INFO - Display: 05:24:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:24:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:24:02 INFO - Display Serial Number: 1600x1200 60 05:24:02 INFO - Main Display: Yes 05:24:02 INFO - Mirror: Off 05:24:02 INFO - Online: Yes 05:24:02 INFO - Rotation: Supported 05:24:02 INFO - Return code: 0 05:24:02 INFO - Running post-action listener: _resource_record_post_action 05:24:02 INFO - [mozharness: 2017-04-01 12:24:02.099981Z] Finished run-tests step (success) 05:24:02 INFO - Running post-run listener: _resource_record_post_run 05:24:02 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 34767360; Write bytes: 519574528; Read time: 374; Write time: 1735 05:24:02 INFO - TinderboxPrint: CPU usage
54.3% 05:24:02 INFO - TinderboxPrint: I/O read bytes / time
34,767,360 / 374 05:24:02 INFO - TinderboxPrint: I/O write bytes / time
519,574,528 / 1,735 05:24:02 INFO - TinderboxPrint: CPU idle
2,197.1 (45.7%) 05:24:02 INFO - TinderboxPrint: CPU system
970.9 (20.2%) 05:24:02 INFO - TinderboxPrint: CPU user
1,641.5 (34.1%) 05:24:02 INFO - TinderboxPrint: Swap in / out
242,356,224 / 0 05:24:02 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 204179968; Write bytes: 202760192; Read time: 15634; Write time: 408 05:24:02 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 33784320; Write bytes: 303832064; Read time: 359; Write time: 1199 05:24:02 INFO - Running post-run listener: _upload_blobber_files 05:24:02 INFO - Blob upload gear active. 05:24:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:24:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:24:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:24:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:24:02 INFO - (blobuploader) - INFO - Open directory for files ... 05:24:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:24:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:24:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:04 INFO - (blobuploader) - INFO - Done attempting. 05:24:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:24:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:24:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:05 INFO - (blobuploader) - INFO - Done attempting. 05:24:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:24:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:24:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:06 INFO - (blobuploader) - INFO - Done attempting. 05:24:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:24:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:24:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:09 INFO - (blobuploader) - INFO - Done attempting. 05:24:09 INFO - (blobuploader) - INFO - Iteration through files over. 05:24:09 INFO - Return code: 0 05:24:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:24:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:24:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d81ed36fd99fe31a8f4d202dc354ab93cd01d1023349f18521095fc7eda5bd17d523085dce33b3fee1cb1c8bf9c441a2e323562d466c80fa4221810f1d37685", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eea905b086b50216640bae30c43ddc2f4385e6f16a4d8e9f5dea5f7c714ccc85fd5dec7d8f717b1babc2abfc68faf55b5d2d458a2c726431f752d14d4ba0751d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a7e45ca833d3c8735d82e05db6193eb07149eca3a396b4333c9d5d03312eaed46903aed82dc1af6475e4ee29c269320c4cc6cebd6e0e4123cb3a49e702f238b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f954126e357c8b3971a06158c686efe24565f9c06b9d326bb17eb21bf8e2c4ab1dbbcf06352af491531c19e5e4eda7e8199563b7c81104ca17c630b137aa03a5"} 05:24:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:24:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:24:09 INFO - Contents: 05:24:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d81ed36fd99fe31a8f4d202dc354ab93cd01d1023349f18521095fc7eda5bd17d523085dce33b3fee1cb1c8bf9c441a2e323562d466c80fa4221810f1d37685", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eea905b086b50216640bae30c43ddc2f4385e6f16a4d8e9f5dea5f7c714ccc85fd5dec7d8f717b1babc2abfc68faf55b5d2d458a2c726431f752d14d4ba0751d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a7e45ca833d3c8735d82e05db6193eb07149eca3a396b4333c9d5d03312eaed46903aed82dc1af6475e4ee29c269320c4cc6cebd6e0e4123cb3a49e702f238b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f954126e357c8b3971a06158c686efe24565f9c06b9d326bb17eb21bf8e2c4ab1dbbcf06352af491531c19e5e4eda7e8199563b7c81104ca17c630b137aa03a5"} 05:24:09 INFO - Running post-run listener: copy_logs_to_upload_dir 05:24:09 INFO - Copying logs to upload dir... 05:24:09 INFO - mkdir: /builds/slave/test/build/upload/logs 05:24:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1287.560439 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-04-01 05:24:09.096670) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-01 05:24:09.100191) ========= 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.qFB1ukSECy/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.ABHfBWrt8X/Listeners TMPDIR=/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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/6d81ed36fd99fe31a8f4d202dc354ab93cd01d1023349f18521095fc7eda5bd17d523085dce33b3fee1cb1c8bf9c441a2e323562d466c80fa4221810f1d37685", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eea905b086b50216640bae30c43ddc2f4385e6f16a4d8e9f5dea5f7c714ccc85fd5dec7d8f717b1babc2abfc68faf55b5d2d458a2c726431f752d14d4ba0751d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a7e45ca833d3c8735d82e05db6193eb07149eca3a396b4333c9d5d03312eaed46903aed82dc1af6475e4ee29c269320c4cc6cebd6e0e4123cb3a49e702f238b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f954126e357c8b3971a06158c686efe24565f9c06b9d326bb17eb21bf8e2c4ab1dbbcf06352af491531c19e5e4eda7e8199563b7c81104ca17c630b137aa03a5"} build_url:https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011284 build_url: 'https://queue.taskcluster.net/v1/task/LeePutLIT0qiC4AclezLhQ/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/6d81ed36fd99fe31a8f4d202dc354ab93cd01d1023349f18521095fc7eda5bd17d523085dce33b3fee1cb1c8bf9c441a2e323562d466c80fa4221810f1d37685", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eea905b086b50216640bae30c43ddc2f4385e6f16a4d8e9f5dea5f7c714ccc85fd5dec7d8f717b1babc2abfc68faf55b5d2d458a2c726431f752d14d4ba0751d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a7e45ca833d3c8735d82e05db6193eb07149eca3a396b4333c9d5d03312eaed46903aed82dc1af6475e4ee29c269320c4cc6cebd6e0e4123cb3a49e702f238b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f954126e357c8b3971a06158c686efe24565f9c06b9d326bb17eb21bf8e2c4ab1dbbcf06352af491531c19e5e4eda7e8199563b7c81104ca17c630b137aa03a5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-01 05:24:09.135722) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 05:24:09.136093) ========= 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.qFB1ukSECy/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.ABHfBWrt8X/Listeners TMPDIR=/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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.005192 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 05:24:09.184837) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-01 05:24:09.185189) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-01 05:24:09.185563) ========= ========= Total master_lag: 0.18 =========