builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0100 starttime: 1486049396.72 results: success (0) buildid: 20170202061208 builduid: 82cf8ed124404346821a7e1666eb2c4a revision: d1569ed822af8f33141533522e7ea3b3ab6f2eea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-02 07:29:56.718966) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-02 07:29:56.719438) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-02 07:29:56.719749) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-02 07:29:56.746765) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 07:29:56.747148) ========= 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.JIJHtG1KDp/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.p0egPIR2Iw/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-02 07:29:56-- 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% 45.4M=0s 2017-02-02 07:29:56 (45.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.146793 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 07:29:56.917856) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 07:29:56.918161) ========= 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.JIJHtG1KDp/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.p0egPIR2Iw/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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.027021 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 07:29:56.968399) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-02 07:29:56.968743) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d1569ed822af8f33141533522e7ea3b3ab6f2eea --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d1569ed822af8f33141533522e7ea3b3ab6f2eea --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JIJHtG1KDp/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.p0egPIR2Iw/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-02 07:29:57,072 truncating revision to first 12 chars 2017-02-02 07:29:57,072 Setting DEBUG logging. 2017-02-02 07:29:57,073 attempt 1/10 2017-02-02 07:29:57,073 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d1569ed822af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-02 07:29:58,775 unpacking tar archive at: mozilla-aurora-d1569ed822af/testing/mozharness/ program finished with exit code 0 elapsedTime=1.971807 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-02 07:29:58.964238) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-02 07:29:58.964598) ========= script_repo_revision: d1569ed822af8f33141533522e7ea3b3ab6f2eea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-02 07:29:58.964997) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-02 07:29:58.965280) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-02 07:29:58.984874) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-02-02 07:29:58.985274) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JIJHtG1KDp/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.p0egPIR2Iw/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 07:29:59 INFO - MultiFileLogger online at 20170202 07:29:59 in /builds/slave/test 07:29:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:29:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:29:59 INFO - {'append_to_log': False, 07:29:59 INFO - 'base_work_dir': '/builds/slave/test', 07:29:59 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:29:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:29:59 INFO - 'branch': 'Mozilla-Aurora', 07:29:59 INFO - 'buildbot_json_path': 'buildprops.json', 07:29:59 INFO - 'config_files': ('talos/mac_config.py',), 07:29:59 INFO - 'default_actions': ('clobber', 07:29:59 INFO - 'read-buildbot-config', 07:29:59 INFO - 'download-and-extract', 07:29:59 INFO - 'populate-webroot', 07:29:59 INFO - 'create-virtualenv', 07:29:59 INFO - 'install', 07:29:59 INFO - 'run-tests'), 07:29:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:29:59 INFO - 'download_minidump_stackwalk': True, 07:29:59 INFO - 'download_symbols': 'ondemand', 07:29:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:29:59 INFO - 'tooltool.py': '/tools/tooltool.py', 07:29:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:29:59 INFO - '/tools/misc-python/virtualenv.py')}, 07:29:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:29:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:29:59 INFO - 'installer_path': 'installer.exe', 07:29:59 INFO - 'log_level': 'info', 07:29:59 INFO - 'log_name': 'talos', 07:29:59 INFO - 'log_to_console': True, 07:29:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:29:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:29:59 INFO - 'opt_config_files': (), 07:29:59 INFO - 'pip_index': False, 07:29:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:29:59 INFO - 'cmd': ('bash', 07:29:59 INFO - '-c', 07:29:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:29:59 INFO - 'enabled': True, 07:29:59 INFO - 'halt_on_failure': False, 07:29:59 INFO - 'name': 'check_screen_resolution'},), 07:29:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:29:59 INFO - 'cmd': ('bash', 07:29:59 INFO - '-c', 07:29:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:29:59 INFO - 'enabled': True, 07:29:59 INFO - 'halt_on_failure': False, 07:29:59 INFO - 'name': 'check_screen_resolution'},), 07:29:59 INFO - 'run_cmd_checks_enabled': True, 07:29:59 INFO - 'sps_profile': False, 07:29:59 INFO - 'sps_profile_interval': 0, 07:29:59 INFO - 'suite': 'dromaeojs-e10s', 07:29:59 INFO - 'system_bits': '32', 07:29:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:29:59 INFO - 'title': 't-yosemite-r7-0100', 07:29:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:29:59 INFO - 'use_talos_json': True, 07:29:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:29:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:29:59 INFO - 'work_dir': 'build'} 07:29:59 INFO - [mozharness: 2017-02-02 15:29:59.203886Z] Running clobber step. 07:29:59 INFO - Running pre-action listener: _resource_record_pre_action 07:29:59 INFO - Running main action method: clobber 07:29:59 INFO - rmtree: /builds/slave/test/build 07:29:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:30:01 INFO - Running post-action listener: _resource_record_post_action 07:30:01 INFO - [mozharness: 2017-02-02 15:30:01.753706Z] Finished clobber step (success) 07:30:01 INFO - [mozharness: 2017-02-02 15:30:01.753833Z] Running read-buildbot-config step. 07:30:01 INFO - Running pre-action listener: _resource_record_pre_action 07:30:01 INFO - Running main action method: read_buildbot_config 07:30:01 INFO - Using buildbot properties: 07:30:01 INFO - { 07:30:01 INFO - "project": "", 07:30:01 INFO - "product": "firefox", 07:30:01 INFO - "script_repo_revision": "production", 07:30:01 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 07:30:01 INFO - "repository": "", 07:30:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 07:30:01 INFO - "buildid": "20170202061208", 07:30:01 INFO - "pgo_build": "False", 07:30:01 INFO - "basedir": "/builds/slave/test", 07:30:01 INFO - "buildnumber": 33, 07:30:01 INFO - "slavename": "t-yosemite-r7-0100", 07:30:01 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 07:30:01 INFO - "platform": "yosemite_r7", 07:30:01 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:30:01 INFO - "branch": "mozilla-aurora", 07:30:01 INFO - "repo_path": "releases/mozilla-aurora", 07:30:01 INFO - "revision": "d1569ed822af8f33141533522e7ea3b3ab6f2eea", 07:30:01 INFO - "stage_platform": "macosx64", 07:30:01 INFO - "builduid": "82cf8ed124404346821a7e1666eb2c4a", 07:30:01 INFO - "slavebuilddir": "test" 07:30:01 INFO - } 07:30:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 07:30:01 INFO - Running post-action listener: _resource_record_post_action 07:30:01 INFO - [mozharness: 2017-02-02 15:30:01.757198Z] Finished read-buildbot-config step (success) 07:30:01 INFO - [mozharness: 2017-02-02 15:30:01.757362Z] Running download-and-extract step. 07:30:01 INFO - Running pre-action listener: _resource_record_pre_action 07:30:01 INFO - Running main action method: download_and_extract 07:30:01 INFO - mkdir: /builds/slave/test/build/tests 07:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:01 INFO - trying https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 07:30:01 INFO - Downloading https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 07:30:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 07:30:02 INFO - Downloaded 1199 bytes. 07:30:02 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 07:30:02 INFO - Using the following test package requirements: 07:30:02 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 07:30:02 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:30:02 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 07:30:02 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:30:02 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 07:30:02 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:30:02 INFO - u'jsshell-mac.zip'], 07:30:02 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:30:02 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 07:30:02 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 07:30:02 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:30:02 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 07:30:02 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:30:02 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 07:30:02 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:30:02 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 07:30:02 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:30:02 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 07:30:02 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:30:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 07:30:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:30:02 INFO - Fetch https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 07:30:03 INFO - Expected file size: 16356058 07:30:03 INFO - Obtained file size: 16356058 07:30:10 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 07:30:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 07:30:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:30:10 INFO - Fetch https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 07:30:11 INFO - Expected file size: 16356058 07:30:11 INFO - Obtained file size: 16356058 07:30:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 07:30:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:30:17 INFO - Fetch https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 07:30:18 INFO - Expected file size: 14403485 07:30:18 INFO - Obtained file size: 14403485 07:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:18 INFO - trying https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 07:30:18 INFO - Downloading https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 07:30:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 07:30:20 INFO - Downloaded 73824774 bytes. 07:30:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 07:30:20 INFO - mkdir: /builds/slave/test/properties 07:30:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:30:20 INFO - Writing to file /builds/slave/test/properties/build_url 07:30:20 INFO - Contents: 07:30:20 INFO - build_url:https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 07:30:21 INFO - Running post-action listener: _resource_record_post_action 07:30:21 INFO - Running post-action listener: set_extra_try_arguments 07:30:21 INFO - [mozharness: 2017-02-02 15:30:21.463951Z] Finished download-and-extract step (success) 07:30:21 INFO - [mozharness: 2017-02-02 15:30:21.464096Z] Running populate-webroot step. 07:30:21 INFO - Running pre-action listener: _resource_record_pre_action 07:30:21 INFO - Running main action method: populate_webroot 07:30:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:30:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:30:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:30:21 INFO - '--tppagecycles', 07:30:21 INFO - '7'], 07:30:21 INFO - 'tests': ['tsvgm']}}, 07:30:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:30:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:30:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:30:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:30:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:30:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:30:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:30:21 INFO - 'talos_options': ['--disable-e10s'], 07:30:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:30:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:30:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:30:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:30:21 INFO - 'talos_options': ['--disable-e10s'], 07:30:21 INFO - 'tests': ['damp', 'tps']}, 07:30:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:30:21 INFO - 'tests': ['damp', 'tps']}, 07:30:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:30:21 INFO - 'tests': ['dromaeo_dom']}, 07:30:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:30:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:30:21 INFO - 'tests': ['basic_compositor_video']}, 07:30:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:30:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:30:21 INFO - 'tests': ['a11yr', 07:30:21 INFO - 'ts_paint', 07:30:21 INFO - 'tpaint', 07:30:21 INFO - 'sessionrestore', 07:30:21 INFO - 'sessionrestore_no_auto_restore', 07:30:21 INFO - 'tabpaint']}, 07:30:21 INFO - 'other-e10s': {'tests': ['a11yr', 07:30:21 INFO - 'ts_paint', 07:30:21 INFO - 'tpaint', 07:30:21 INFO - 'sessionrestore', 07:30:21 INFO - 'sessionrestore_no_auto_restore', 07:30:21 INFO - 'tabpaint']}, 07:30:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:30:21 INFO - 'ts_paint', 07:30:21 INFO - 'tpaint', 07:30:21 INFO - 'sessionrestore', 07:30:21 INFO - 'sessionrestore_no_auto_restore', 07:30:21 INFO - 'tabpaint']}, 07:30:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:30:21 INFO - 'ts_paint', 07:30:21 INFO - 'tpaint', 07:30:21 INFO - 'sessionrestore', 07:30:21 INFO - 'sessionrestore_no_auto_restore', 07:30:21 INFO - 'tabpaint']}, 07:30:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:30:21 INFO - 'tests': ['a11yr', 07:30:21 INFO - 'ts_paint', 07:30:21 INFO - 'tpaint', 07:30:21 INFO - 'sessionrestore', 07:30:21 INFO - 'sessionrestore_no_auto_restore', 07:30:21 INFO - 'tabpaint']}, 07:30:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:30:21 INFO - 'tests': ['a11yr', 07:30:21 INFO - 'ts_paint', 07:30:21 INFO - 'tpaint', 07:30:21 INFO - 'sessionrestore', 07:30:21 INFO - 'sessionrestore_no_auto_restore', 07:30:21 INFO - 'tabpaint']}, 07:30:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:30:21 INFO - 'tests': ['tsvgx', 07:30:21 INFO - 'tsvgr_opacity', 07:30:21 INFO - 'tart', 07:30:21 INFO - 'tscrollx', 07:30:21 INFO - 'cart', 07:30:21 INFO - 'tsvg_static']}, 07:30:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:30:21 INFO - 'tsvgr_opacity', 07:30:21 INFO - 'tart', 07:30:21 INFO - 'tscrollx', 07:30:21 INFO - 'cart', 07:30:21 INFO - 'tsvg_static']}, 07:30:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:30:21 INFO - 'talos_options': ['--disable-e10s'], 07:30:21 INFO - 'tests': ['tp5o']}, 07:30:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:30:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:30:21 INFO - 'talos_options': ['--disable-e10s', 07:30:21 INFO - '--xperf_path', 07:30:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:30:21 INFO - 'tests': ['tp5n']}, 07:30:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:30:21 INFO - 'talos_options': ['--xperf_path', 07:30:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:30:21 INFO - 'tests': ['tp5n']}}, 07:30:21 INFO - 'talos.zip': {'path': '', 07:30:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:30:21 INFO - Running post-action listener: _resource_record_post_action 07:30:21 INFO - [mozharness: 2017-02-02 15:30:21.482892Z] Finished populate-webroot step (success) 07:30:21 INFO - [mozharness: 2017-02-02 15:30:21.483005Z] Running create-virtualenv step. 07:30:21 INFO - Running pre-action listener: _resource_record_pre_action 07:30:21 INFO - Running main action method: create_virtualenv 07:30:21 INFO - Creating virtualenv /builds/slave/test/build/venv 07:30:21 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:30:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:30:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:30:21 INFO - Using real prefix '/tools/python27' 07:30:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:30:22 INFO - Installing distribute.............................................................................................................................................................................................done. 07:30:25 INFO - Installing pip.................done. 07:30:25 INFO - Return code: 0 07:30:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:30:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:30:25 INFO - Reading from file tmpfile_stdout 07:30:25 INFO - Output received: 07:30:25 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:30:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:30:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:25 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 0x10f1beb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1c1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc20b4e13a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef9cd30>, '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 0x10eec3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef91be8>, '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.JIJHtG1KDp/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.p0egPIR2Iw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:30:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:30:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:30:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JIJHtG1KDp/Render', 07:30:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:30:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:30:25 INFO - 'HOME': '/Users/cltbld', 07:30:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:30:25 INFO - 'LOGNAME': 'cltbld', 07:30:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:25 INFO - 'MOZ_NO_REMOTE': '1', 07:30:25 INFO - 'NO_EM_RESTART': '1', 07:30:25 INFO - 'PAGER': '/bin/cat', 07:30:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:30:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:25 INFO - 'PWD': '/builds/slave/test', 07:30:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:30:25 INFO - 'SHELL': '/bin/bash', 07:30:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p0egPIR2Iw/Listeners', 07:30:25 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 07:30:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:30:25 INFO - 'USER': 'cltbld', 07:30:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:30:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:30:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:25 INFO - 'XPC_FLAGS': '0x0', 07:30:25 INFO - 'XPC_SERVICE_NAME': '0', 07:30:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:30:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:25 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:30:25 INFO - Cleaning up... 07:30:25 INFO - Return code: 0 07:30:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:30:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:25 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 0x10f1beb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1c1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc20b4e13a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef9cd30>, '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 0x10eec3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef91be8>, '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.JIJHtG1KDp/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.p0egPIR2Iw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:30:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:30:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:30:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JIJHtG1KDp/Render', 07:30:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:30:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:30:25 INFO - 'HOME': '/Users/cltbld', 07:30:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:30:25 INFO - 'LOGNAME': 'cltbld', 07:30:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:25 INFO - 'MOZ_NO_REMOTE': '1', 07:30:25 INFO - 'NO_EM_RESTART': '1', 07:30:25 INFO - 'PAGER': '/bin/cat', 07:30:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:30:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:25 INFO - 'PWD': '/builds/slave/test', 07:30:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:30:25 INFO - 'SHELL': '/bin/bash', 07:30:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p0egPIR2Iw/Listeners', 07:30:25 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 07:30:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:30:25 INFO - 'USER': 'cltbld', 07:30:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:30:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:30:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:25 INFO - 'XPC_FLAGS': '0x0', 07:30:25 INFO - 'XPC_SERVICE_NAME': '0', 07:30:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:30:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:26 INFO - Downloading/unpacking psutil>=3.1.1 07:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:30:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:30:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:30:29 INFO - Installing collected packages: psutil 07:30:29 INFO - Running setup.py install for psutil 07:30:29 INFO - building 'psutil._psutil_osx' extension 07:30:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:30:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:30:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:30:30 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:30:30 INFO - building 'psutil._psutil_posix' extension 07:30:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:30:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:30:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:30:30 INFO - ^ 07:30:30 INFO - 1 warning generated. 07:30:30 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:30:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:30:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:30:30 INFO - Successfully installed psutil 07:30:30 INFO - Cleaning up... 07:30:30 INFO - Return code: 0 07:30:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:30: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')]} 07:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30: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')]} 07:30:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f1beb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1c1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc20b4e13a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef9cd30>, '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 0x10eec3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef91be8>, '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.JIJHtG1KDp/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.p0egPIR2Iw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:30: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:30: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 mozsystemmonitor==0.3 07:30:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JIJHtG1KDp/Render', 07:30:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:30:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:30:30 INFO - 'HOME': '/Users/cltbld', 07:30:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:30:30 INFO - 'LOGNAME': 'cltbld', 07:30:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:30 INFO - 'MOZ_NO_REMOTE': '1', 07:30:30 INFO - 'NO_EM_RESTART': '1', 07:30:30 INFO - 'PAGER': '/bin/cat', 07:30:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:30:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:30 INFO - 'PWD': '/builds/slave/test', 07:30:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:30:30 INFO - 'SHELL': '/bin/bash', 07:30:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p0egPIR2Iw/Listeners', 07:30:30 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 07:30:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:30:30 INFO - 'USER': 'cltbld', 07:30:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:30:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:30:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:30 INFO - 'XPC_FLAGS': '0x0', 07:30:30 INFO - 'XPC_SERVICE_NAME': '0', 07:30:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:30:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:30: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 07:30: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 07:30: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 07:30: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 07:30: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 07:30: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 07:30:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:30:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:30:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:30:33 INFO - Installing collected packages: mozsystemmonitor 07:30:33 INFO - Running setup.py install for mozsystemmonitor 07:30:33 INFO - Successfully installed mozsystemmonitor 07:30:33 INFO - Cleaning up... 07:30:33 INFO - Return code: 0 07:30:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f1beb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1c1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc20b4e13a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef9cd30>, '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 0x10eec3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef91be8>, '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.JIJHtG1KDp/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.p0egPIR2Iw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:30:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:30:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:30:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JIJHtG1KDp/Render', 07:30:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:30:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:30:33 INFO - 'HOME': '/Users/cltbld', 07:30:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:30:33 INFO - 'LOGNAME': 'cltbld', 07:30:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:33 INFO - 'MOZ_NO_REMOTE': '1', 07:30:33 INFO - 'NO_EM_RESTART': '1', 07:30:33 INFO - 'PAGER': '/bin/cat', 07:30:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:30:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:33 INFO - 'PWD': '/builds/slave/test', 07:30:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:30:33 INFO - 'SHELL': '/bin/bash', 07:30:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p0egPIR2Iw/Listeners', 07:30:33 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 07:30:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:30:33 INFO - 'USER': 'cltbld', 07:30:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:30:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:30:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:33 INFO - 'XPC_FLAGS': '0x0', 07:30:33 INFO - 'XPC_SERVICE_NAME': '0', 07:30:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:30:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:34 INFO - Downloading/unpacking jsonschema==2.5.1 07:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:30:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:37 INFO - Downloading functools32-3.2.3-2.tar.gz 07:30:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:30:37 INFO - warning: no files found matching '*.txt' 07:30:37 INFO - no previously-included directories found matching 'build' 07:30:37 INFO - no previously-included directories found matching 'dist' 07:30:37 INFO - no previously-included directories found matching '.git*' 07:30:37 INFO - Installing collected packages: jsonschema, functools32 07:30:37 INFO - Running setup.py install for functools32 07:30:37 INFO - warning: no files found matching '*.txt' 07:30:37 INFO - no previously-included directories found matching 'build' 07:30:37 INFO - no previously-included directories found matching 'dist' 07:30:37 INFO - no previously-included directories found matching '.git*' 07:30:37 INFO - Successfully installed jsonschema functools32 07:30:37 INFO - Cleaning up... 07:30:37 INFO - Return code: 0 07:30:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:37 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 0x10f1beb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1c1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc20b4e13a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef9cd30>, '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 0x10eec3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef91be8>, '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.JIJHtG1KDp/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.p0egPIR2Iw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:30:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:30:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JIJHtG1KDp/Render', 07:30:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:30:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:30:37 INFO - 'HOME': '/Users/cltbld', 07:30:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:30:37 INFO - 'LOGNAME': 'cltbld', 07:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:37 INFO - 'MOZ_NO_REMOTE': '1', 07:30:37 INFO - 'NO_EM_RESTART': '1', 07:30:37 INFO - 'PAGER': '/bin/cat', 07:30:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:37 INFO - 'PWD': '/builds/slave/test', 07:30:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:30:37 INFO - 'SHELL': '/bin/bash', 07:30:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p0egPIR2Iw/Listeners', 07:30:37 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 07:30:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:30:37 INFO - 'USER': 'cltbld', 07:30:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:30:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:37 INFO - 'XPC_FLAGS': '0x0', 07:30:37 INFO - 'XPC_SERVICE_NAME': '0', 07:30:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:30:37 INFO - Cleaning up... 07:30:37 INFO - Return code: 0 07:30:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:37 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 0x10f1beb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1c1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc20b4e13a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef9cd30>, '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 0x10eec3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef91be8>, '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.JIJHtG1KDp/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.p0egPIR2Iw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:30:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:30:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JIJHtG1KDp/Render', 07:30:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:30:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:30:37 INFO - 'HOME': '/Users/cltbld', 07:30:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:30:37 INFO - 'LOGNAME': 'cltbld', 07:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:37 INFO - 'MOZ_NO_REMOTE': '1', 07:30:37 INFO - 'NO_EM_RESTART': '1', 07:30:37 INFO - 'PAGER': '/bin/cat', 07:30:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:37 INFO - 'PWD': '/builds/slave/test', 07:30:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:30:37 INFO - 'SHELL': '/bin/bash', 07:30:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p0egPIR2Iw/Listeners', 07:30:37 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 07:30:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:30:37 INFO - 'USER': 'cltbld', 07:30:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:30:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:37 INFO - 'XPC_FLAGS': '0x0', 07:30:37 INFO - 'XPC_SERVICE_NAME': '0', 07:30:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:38 INFO - Downloading/unpacking blobuploader==1.2.4 07:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:40 INFO - Downloading blobuploader-1.2.4.tar.gz 07:30:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:30:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:30: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 07:30: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 07:30: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 07:30: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 07:30: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 07:30: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 07:30:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:30:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:41 INFO - Downloading docopt-0.6.1.tar.gz 07:30:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:30:41 INFO - Installing collected packages: blobuploader, requests, docopt 07:30:41 INFO - Running setup.py install for blobuploader 07:30:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:30:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:30:42 INFO - Running setup.py install for requests 07:30:42 INFO - Running setup.py install for docopt 07:30:42 INFO - Successfully installed blobuploader requests docopt 07:30:42 INFO - Cleaning up... 07:30:42 INFO - Return code: 0 07:30:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:30:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:42 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 0x10f1beb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1c1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc20b4e13a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef9cd30>, '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 0x10eec3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef91be8>, '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.JIJHtG1KDp/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.p0egPIR2Iw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:30:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:30:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:30:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JIJHtG1KDp/Render', 07:30:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:30:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:30:42 INFO - 'HOME': '/Users/cltbld', 07:30:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:30:42 INFO - 'LOGNAME': 'cltbld', 07:30:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:42 INFO - 'MOZ_NO_REMOTE': '1', 07:30:42 INFO - 'NO_EM_RESTART': '1', 07:30:42 INFO - 'PAGER': '/bin/cat', 07:30:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:30:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:42 INFO - 'PWD': '/builds/slave/test', 07:30:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:30:42 INFO - 'SHELL': '/bin/bash', 07:30:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p0egPIR2Iw/Listeners', 07:30:42 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 07:30:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:30:42 INFO - 'USER': 'cltbld', 07:30:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:30:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:30:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:42 INFO - 'XPC_FLAGS': '0x0', 07:30:42 INFO - 'XPC_SERVICE_NAME': '0', 07:30:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:30:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:30:43 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-ooE5z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:30:43 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-lwP3SX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:30:43 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-wEtwQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:30:43 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-s7nyrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:30:43 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-ZtRf6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:30:43 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-8sUGAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:30:43 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-wFWj3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:30:43 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-cus11M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:30:43 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-joHYK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:30:44 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-yS2MZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:30:44 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-eCcAaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:30:44 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-r0VK0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:30:44 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-SqJy7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:30:44 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-VW0Y75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:30:44 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-vTTu03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:30:44 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-UGtFLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:30:44 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-D4DP74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:30:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:30:44 INFO - Running setup.py install for manifestparser 07:30:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:30:45 INFO - Running setup.py install for mozcrash 07:30:45 INFO - Running setup.py install for mozdebug 07:30:45 INFO - Running setup.py install for mozdevice 07:30:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:30:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:30:45 INFO - Running setup.py install for mozfile 07:30:45 INFO - Running setup.py install for mozhttpd 07:30:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:30:45 INFO - Running setup.py install for mozinfo 07:30:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:30:45 INFO - Running setup.py install for mozInstall 07:30:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:30:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:30:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:30:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:30:46 INFO - Running setup.py install for mozleak 07:30:46 INFO - Running setup.py install for mozlog 07:30:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:30:46 INFO - Running setup.py install for moznetwork 07:30:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:30:46 INFO - Running setup.py install for mozprocess 07:30:46 INFO - Running setup.py install for mozprofile 07:30:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:30:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:30:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:30:46 INFO - Running setup.py install for mozrunner 07:30:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:30:47 INFO - Running setup.py install for mozscreenshot 07:30:47 INFO - Running setup.py install for moztest 07:30:47 INFO - Running setup.py install for mozversion 07:30:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:30:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:30:47 INFO - Cleaning up... 07:30:47 INFO - Return code: 0 07:30:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:30:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:47 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 0x10f1beb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1c1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc20b4e13a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef9cd30>, '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 0x10eec3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef91be8>, '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.JIJHtG1KDp/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.p0egPIR2Iw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:30:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:30:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:30:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JIJHtG1KDp/Render', 07:30:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:30:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:30:47 INFO - 'HOME': '/Users/cltbld', 07:30:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:30:47 INFO - 'LOGNAME': 'cltbld', 07:30:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:47 INFO - 'MOZ_NO_REMOTE': '1', 07:30:47 INFO - 'NO_EM_RESTART': '1', 07:30:47 INFO - 'PAGER': '/bin/cat', 07:30:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:30:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:47 INFO - 'PWD': '/builds/slave/test', 07:30:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:30:47 INFO - 'SHELL': '/bin/bash', 07:30:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p0egPIR2Iw/Listeners', 07:30:47 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 07:30:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:30:47 INFO - 'USER': 'cltbld', 07:30:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:30:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:30:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:47 INFO - 'XPC_FLAGS': '0x0', 07:30:47 INFO - 'XPC_SERVICE_NAME': '0', 07:30:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:30:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:30:47 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-0M9tl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:30:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:30:47 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-aYnlfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:30:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:30:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:30:47 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-gmMAc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:30:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:30:48 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-guteRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:30:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:30:48 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-3HhSQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:30:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:30:48 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-KZ7T9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:30:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:30:48 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-y6n5Ur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:30:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:30:48 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-9hJPPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:30:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:30:48 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-1KZ8yH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:30:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:30:48 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-aV1LoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:30:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:30:48 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-SiESBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:30:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:30:48 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-M0JDPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:30:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:30:49 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-Lxv7Yz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:30:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:30:49 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-UmHIXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:30:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:30:49 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-10TLu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:30:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:30:49 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-HofmSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:30:49 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)) 07:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:30:49 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-8RqlCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:30:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:30:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:30:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:30:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:30:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:30:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:30:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:52 INFO - Downloading blessings-1.6.tar.gz 07:30:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:30:52 INFO - Installing collected packages: blessings 07:30:52 INFO - Running setup.py install for blessings 07:30:52 INFO - Successfully installed blessings 07:30:52 INFO - Cleaning up... 07:30:52 INFO - Return code: 0 07:30:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:30:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:30:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:30:52 INFO - Reading from file tmpfile_stdout 07:30:52 INFO - Current package versions: 07:30:52 INFO - blessings == 1.6 07:30:52 INFO - blobuploader == 1.2.4 07:30:52 INFO - docopt == 0.6.1 07:30:52 INFO - functools32 == 3.2.3-2 07:30:52 INFO - jsonschema == 2.5.1 07:30:52 INFO - manifestparser == 1.1 07:30:52 INFO - mozInstall == 1.12 07:30:52 INFO - mozcrash == 1.0 07:30:52 INFO - mozdebug == 0.1 07:30:52 INFO - mozdevice == 0.49 07:30:52 INFO - mozfile == 1.2 07:30:52 INFO - mozhttpd == 0.7 07:30:52 INFO - mozinfo == 0.9 07:30:52 INFO - mozleak == 0.1 07:30:52 INFO - mozlog == 3.4 07:30:52 INFO - moznetwork == 0.27 07:30:52 INFO - mozprocess == 0.24 07:30:52 INFO - mozprofile == 0.28 07:30:52 INFO - mozrunner == 6.13 07:30:52 INFO - mozscreenshot == 0.1 07:30:52 INFO - mozsystemmonitor == 0.3 07:30:52 INFO - moztest == 0.8 07:30:52 INFO - mozversion == 1.4 07:30:52 INFO - psutil == 3.1.1 07:30:52 INFO - requests == 1.2.3 07:30:52 INFO - wsgiref == 0.1.2 07:30:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30: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')]} 07:30:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:53 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 0x10f1beb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1c1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc20b4e13a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef9cd30>, '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 0x10eec3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef91be8>, '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.JIJHtG1KDp/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.p0egPIR2Iw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:30:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:30:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:30:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JIJHtG1KDp/Render', 07:30:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:30:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:30:53 INFO - 'HOME': '/Users/cltbld', 07:30:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:30:53 INFO - 'LOGNAME': 'cltbld', 07:30:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:53 INFO - 'MOZ_NO_REMOTE': '1', 07:30:53 INFO - 'NO_EM_RESTART': '1', 07:30:53 INFO - 'PAGER': '/bin/cat', 07:30:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:30:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:53 INFO - 'PWD': '/builds/slave/test', 07:30:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:30:53 INFO - 'SHELL': '/bin/bash', 07:30:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p0egPIR2Iw/Listeners', 07:30:53 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 07:30:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:30:53 INFO - 'USER': 'cltbld', 07:30:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:30:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:30:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:53 INFO - 'XPC_FLAGS': '0x0', 07:30:53 INFO - 'XPC_SERVICE_NAME': '0', 07:30:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:30:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:30:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:30:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:30:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:30:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:30:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:30:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:30:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:30:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:30:53 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:30:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:30:53 INFO - Cleaning up... 07:30:53 INFO - Return code: 0 07:30:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:30: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')]} 07:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30: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')]} 07:30:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:54 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 0x10f1beb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1c1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc20b4e13a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef9cd30>, '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 0x10eec3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef91be8>, '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.JIJHtG1KDp/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.p0egPIR2Iw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:30:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:30:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:30:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JIJHtG1KDp/Render', 07:30:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:30:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:30:54 INFO - 'HOME': '/Users/cltbld', 07:30:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:30:54 INFO - 'LOGNAME': 'cltbld', 07:30:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:54 INFO - 'MOZ_NO_REMOTE': '1', 07:30:54 INFO - 'NO_EM_RESTART': '1', 07:30:54 INFO - 'PAGER': '/bin/cat', 07:30:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:30:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:54 INFO - 'PWD': '/builds/slave/test', 07:30:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:30:54 INFO - 'SHELL': '/bin/bash', 07:30:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p0egPIR2Iw/Listeners', 07:30:54 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 07:30:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:30:54 INFO - 'USER': 'cltbld', 07:30:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:30:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:30:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:54 INFO - 'XPC_FLAGS': '0x0', 07:30:54 INFO - 'XPC_SERVICE_NAME': '0', 07:30:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:30:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:30:54 INFO - Cleaning up... 07:30:54 INFO - Return code: 0 07:30:54 INFO - Running post-action listener: _resource_record_post_action 07:30:54 INFO - Running post-action listener: _start_resource_monitoring 07:30:54 INFO - Starting resource monitoring. 07:30:54 INFO - [mozharness: 2017-02-02 15:30:54.552901Z] Finished create-virtualenv step (success) 07:30:54 INFO - [mozharness: 2017-02-02 15:30:54.553877Z] Running install step. 07:30:54 INFO - Running pre-action listener: _resource_record_pre_action 07:30:54 INFO - Running main action method: install 07:30:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:30:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:30:54 INFO - Reading from file tmpfile_stdout 07:30:54 INFO - Detecting whether we're running mozinstall >=1.0... 07:30:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:30:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:30:54 INFO - Reading from file tmpfile_stdout 07:30:54 INFO - Output received: 07:30:54 INFO - Usage: mozinstall [options] installer 07:30:54 INFO - Options: 07:30:54 INFO - -h, --help show this help message and exit 07:30:54 INFO - -d DEST, --destination=DEST 07:30:54 INFO - Directory to install application into. [default: 07:30:54 INFO - "/builds/slave/test"] 07:30:54 INFO - --app=APP Application being installed. [default: firefox] 07:30:54 INFO - mkdir: /builds/slave/test/build/application 07:30:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:30:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 07:31:14 INFO - Reading from file tmpfile_stdout 07:31:14 INFO - Output received: 07:31:14 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:31:14 INFO - Running post-action listener: _resource_record_post_action 07:31:14 INFO - [mozharness: 2017-02-02 15:31:14.877047Z] Finished install step (success) 07:31:14 INFO - [mozharness: 2017-02-02 15:31:14.877208Z] Running run-tests step. 07:31:14 INFO - Running pre-action listener: _resource_record_pre_action 07:31:14 INFO - Running main action method: run_tests 07:31:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:31:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:31:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:31:14 INFO - 2017-02-02 07:31:14.891 screenresolution[1623:7415] starting screenresolution argv=screenresolution get 07:31:14 INFO - 2017-02-02 07:31:14.894 screenresolution[1623:7415] Display 0: 1600x1200x32@60 07:31:14 INFO - 2017-02-02 07:31:14.899 screenresolution[1624:7418] starting screenresolution argv=screenresolution list 07:31:14 INFO - Available Modes on Display 0 07:31:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:31:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:31:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:31:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:31:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:31:15 INFO - Intel Iris: 07:31:15 INFO - Chipset Model: Intel Iris 07:31:15 INFO - Type: GPU 07:31:15 INFO - Bus: Built-In 07:31:15 INFO - VRAM (Dynamic, Max): 1536 MB 07:31:15 INFO - Vendor: Intel (0x8086) 07:31:15 INFO - Device ID: 0x0a2e 07:31:15 INFO - Revision ID: 0x0009 07:31:15 INFO - Displays: 07:31:15 INFO - Display: 07:31:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:31:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:31:15 INFO - Display Serial Number: 1600x1200 60 07:31:15 INFO - Main Display: Yes 07:31:15 INFO - Mirror: Off 07:31:15 INFO - Online: Yes 07:31:15 INFO - Rotation: Supported 07:31:15 INFO - Return code: 0 07:31:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:31:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:31:15 INFO - Python 2.7.3 07:31:15 INFO - Return code: 0 07:31:15 INFO - grabbing minidump binary from tooltool 07:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:15 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 0x10ef9cd30>, '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 0x10eec3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef91be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:31:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:31:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:31:15 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:31:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:31:15 INFO - Return code: 0 07:31:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:31:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:31:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:31:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:31:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:31:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0100', '--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 07:31:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0100 --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 07:31:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JIJHtG1KDp/Render', 07:31:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:15 INFO - 'HOME': '/Users/cltbld', 07:31:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:15 INFO - 'LOGNAME': 'cltbld', 07:31:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:31:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:31:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:15 INFO - 'MOZ_NO_REMOTE': '1', 07:31:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:31:15 INFO - 'NO_EM_RESTART': '1', 07:31:15 INFO - 'PAGER': '/bin/cat', 07:31:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:15 INFO - 'PWD': '/builds/slave/test', 07:31:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:31:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:15 INFO - 'SHELL': '/bin/bash', 07:31:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p0egPIR2Iw/Listeners', 07:31:15 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 07:31:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:15 INFO - 'USER': 'cltbld', 07:31:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:15 INFO - 'XPC_FLAGS': '0x0', 07:31:15 INFO - 'XPC_SERVICE_NAME': '0', 07:31:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0100', '--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 07:31:15 INFO - mozversion application_buildid: 20170202061208 07:31:15 INFO - mozversion application_changeset: d1569ed822af8f33141533522e7ea3b3ab6f2eea 07:31:15 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:31:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:31:15 INFO - mozversion application_name: Firefox 07:31:15 INFO - mozversion application_remotingname: firefox-dev 07:31:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:31:15 INFO - mozversion application_vendor: Mozilla 07:31:15 INFO - mozversion application_version: 53.0a2 07:31:15 INFO - mozversion platform_buildid: 20170202061208 07:31:15 INFO - mozversion platform_changeset: d1569ed822af8f33141533522e7ea3b3ab6f2eea 07:31:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:31:15 INFO - mozversion platform_version: 53.0a2 07:31:15 INFO - using testdate: 1486049475 07:31:15 INFO - actual date: 1486049475 07:31:15 INFO - starting webserver on 'localhost:49244' 07:31:15 INFO - SUITE-START | Running 2 tests 07:31:15 INFO - TEST-START | dromaeo_css 07:31:15 INFO - operating with platform_type : mac_ 07:31:15 INFO - Initialising browser for dromaeo_css test... 07:31:15 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpRRS_Tm/profile http://localhost:49244/getInfo.html) 07:31:18 INFO - PROCESS | 1634 | 2017-02-02 07:31:18.243 plugin-container[1636:7566] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x903f, name = 'com.apple.tsm.portname' 07:31:18 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:31:18 INFO - PROCESS | 1634 | 2017-02-02 07:31:18.246 plugin-container[1636:7566] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950f, name = 'com.apple.CFPasteboardClient' 07:31:18 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:31:18 INFO - PROCESS | 1634 | 2017-02-02 07:31:18.246 plugin-container[1636:7566] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:31:18 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 07:31:18 INFO - PROCESS | 1634 | colorDepth:24 07:31:18 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 07:31:18 INFO - PROCESS | 1634 | __metrics 07:31:18 ERROR - PROCESS | 1634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 07:31:19 INFO - TEST-INFO | 1634: exit 0 07:31:19 INFO - Browser initialized. 07:31:19 INFO - Running cycle 1/1 for dromaeo_css test... 07:31:19 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpRRS_Tm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:31:21 INFO - PROCESS | 1637 | 2017-02-02 07:31:21.799 plugin-container[1638:7692] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 07:31:21 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:31:21 INFO - PROCESS | 1637 | 2017-02-02 07:31:21.800 plugin-container[1638:7692] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d13, name = 'com.apple.CFPasteboardClient' 07:31:21 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:31:21 INFO - PROCESS | 1637 | 2017-02-02 07:31:21.800 plugin-container[1638:7692] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:31:31 INFO - PROCESS | 1637 | RSS: Main: 218460160 07:31:31 INFO - PROCESS | 1637 | 07:34:33 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 07:34:35 INFO - PROCESS | 1637 | RSS: Main: 238968832 07:34:35 INFO - PROCESS | 1637 | 07:36:19 INFO - PROCESS | 1637 | ************************* 07:36:19 INFO - PROCESS | 1637 | A coding exception was thrown and uncaught in a Task. 07:36:19 INFO - PROCESS | 1637 | 07:36:19 ERROR - PROCESS | 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:36:19 INFO - PROCESS | 1637 | Full stack: 07:36:19 INFO - PROCESS | 1637 | ************************* 07:37:37 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 07:37:38 INFO - PROCESS | 1637 | RSS: Main: 248930304 07:37:38 INFO - PROCESS | 1637 | 07:40:39 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 07:40:40 INFO - PROCESS | 1637 | RSS: Main: 256339968 07:40:40 INFO - PROCESS | 1637 | 07:43:42 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 07:43:43 INFO - PROCESS | 1637 | RSS: Main: 253480960 07:43:43 INFO - PROCESS | 1637 | 07:46:45 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 07:46:46 INFO - PROCESS | 1637 | RSS: Main: 257032192 07:46:46 INFO - PROCESS | 1637 | 07:49:49 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 07:49:49 INFO - PROCESS | 1637 | RSS: Main: 258682880 07:49:49 INFO - PROCESS | 1637 | 07:49:49 INFO - PROCESS | 1637 | __start_tp_report 07:49:49 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 07:49:49 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 07:49:49 INFO - PROCESS | 1637 | |i|pagename|runs| 07:49:49 INFO - PROCESS | 1637 | |0;dojo.html;2944.396398738258;3389.9830500847474;3411.2495251044775;3425.7430692698053;3440.1399650087487;5808.738606762695;5890.882182356356;5917.585768996172;5926.140709597106;5926.703664816758;5755.712214389285;5812.709364531777;5827.970860145693;5846.356900740915;5854.76580936762;4509.887252818673;5233.86915327117;5276.604254680895;5308.522232999029;5358.59810514211;4419.491758447772;5340.679559226459;5343.946560534403;5356.491133342346;5359.008583412062;4334.393184954109;5202.089634313998;5203.635745497817;5336.092864213093;5367.221752845854;5240.082985477527;5288.947110528903;5308.5487733542695;5348.277982472356;5396.082665946759;5192.402873669538;5276.894462110737;5286.233496143038;5292.814751483679;5306.310179676656;5579.497845193911;5762.423757624246;5792.855178620568;5896.651690094579;5949.524038076944;5802.18769372284;6108.372425856745;6187.3503282155625;6214.192155019864;6258.655773932432;6249.093881387219;6261.248650161964;6264.7807326743805;6277.246730392337;6279.434850863398;5923.970380148072;5943.900378430004;5960.672163031031;5964.075568286879;6009.06859436788;5534.363548191929;5938.317093534212;6142.314611233313;6267.310595834455;6322.241331040213;5064.366954130734;6181.567290289727;6194.938050619527;6234.625922444668;6237.5321850860455;6252.874942501125;6260.718267677966;6261.96869015652;6269.5611307208055;6275.6862156892885;6109.435031337442;6113.476306051851;6116.42707509198;6237.688115594202;6273.059041143865;6126.517673797367;6171.444569988723;6187.907181392283;6192.566520343533;6209.751609935552;5077.644564880497;5078.873028174326;5080.949190508121;5086.898262034739;5093;4411.4926783420315;4426;4453.799579018952;4476.6194873436125;4477.485089214717;5831.591788574759;5842.649441033552;5907.734151963172;5966.343702192756;6022.156898034279;6217.482437404474;6219.222597175353;6268.905966410416;6275.090111933744;6275.748970041239;5333.6533125347505;5719.2279042328755;5822.767089316465;5856;5879.65318726497;4593.954060459419;4627.236505976476;5556.638818476867;5580.330360356702;5626.071698169756;5477.972610137003;5572.804951826748;6422.807315780534;6430.871382572416;6437.645929473831;5172.637915345889;6178.66017369049;6224.128621993015;6293.276273228637;6331.430171284606;6355;6390.137331460193;6412.454941329853;6431.807045788634;6433.742650293936;5069.493050694901;6192.504599632109;6242.157308763259;6259.061140828912;6269.341719119427;5280.471952804689;5745.534888603379;6195.907061394173;6225.688715564113;6288.339724329063;6160.014397696347;6163.229596300463;6196.349383314687;6264.874702506016;6285.465735412541;6223.906641400473;6276.843078923063;6286.18279623646;6295.401936815995;6295.653739044396;4849.80600775965;5384.838454846361;6178.258608966953;6182.659953702409;6189.381061893775;5066.392032956069;6145.187169785014;6157.0456579230295;6182.041783523561;6271.153394291712;6095.47954366257;6102.542309326907;6118.785842495491;6128.693565321805;6130.9179418630665 07:49:49 INFO - PROCESS | 1637 | |1;ext.html;459.51980180711166;474.15126922808156;496.01293426082105;516.4912561127292;529.1031701266353;32468;40118.19763604726;40125.19749605006;41737;41743.58256417435;40573.59426405735;41123.76628701136;41208.58791412085;41224.79387603058;41266.58733412665;9176.954115229415;9264.907350926505;9383.108604682544;9421.199198068172;10875.83686244707;10950.123990080814;11147.996680298771;11156.386398748065;11168.385738784364;11180.217384783027;11155.944220278887;11193.27243729159;11194.160437967144;11198.104151667847;11223.046041086518;11054.723631909226;11091.279066860629;11129.666110016753;11137.888621113767;11157.609483668033;10911;10968.670939871816;10982.231243812936;10989.890101098967;11006.889931100666;35447.93656190293;35754.821225893706;35805.64194358049;35820;35875.64124358749;3875.476810630585;3900.863469778544;3965.286248475273;3967.02807812085;3991;26619.46761064768;26791.330216744736;27320.180394588195;28031.719682803116;28440.28899277514;3174.777765556412;3206.679332066798;3228.725558327545;3300.2079500919845;3377.746668999835;474822;474943;476573;478558.6072069652;480723;46809.29786053212;52840.73579632077;53100;53122.203166952524;53202.7339863306;56060.87878242412;56252;56307.43692563104;56497.71751141218;56521.43478565244;15242;15563.533094007198;15589.610259743597;15631;15657.843421565867;11794.823077653842;12070.698232544257;12119.21225120382;12120.69698257533;12278.508859645513;12987.740245195044;15089.943703940618;17412.738808917875;17416.825831741775;17499.825001750076;6751.7171737369745;7277.52696074764;7432.554046757212;8132.186781321939;8146.796330091676;856.2935578148052;862.6198083067168;866.4151697604092;876.0188588780607;894.9149830766066;21702.565948681255;23187.956541955653;29586.852065739535;29631.40737185244;29813.701862981525;896.4128495835238;1019.3883669798062;1050.4852622215212;1074.5862842805577;1195.9581414650445;14103.71792564143;16748.413805516993;17095.48713538596;17158.48524544266;17358.826411735972;613996;617982;623074;623702;624131;60582;60762.39237607656;61407.078893815735;61478.69260653668;61623.6918815412;1390.7705228637365;1406.9507567235303;1424.988258336572;1427.9214643194723;1434.9713005739827;26258.73741262563;29496.262593435335;30259.63831627538;30681.53977690292;31134.844325778227;48722.025559487905;49213.76965575889;49341;49409.258861116396;49457.76355590995;605651;606091;608841;609002;610010.9499452474;37654;38462.42306365351;38571.421428679154;39894.40158397568;41330.38004429996;40184.79445616636;40229.79885100556;40731.38902916399;41193.38209926913;41447.792761036;29394.412111757218;34477.65522344845;34720;34734.65265347314;34849.47725784065;33201.833990830855;33272.33455330831;33592.66407335895;33720.1569960753;33819.66180338264;33804.83097584594;33813.3237335247;33865.49201761926;33881;34093.65906341004;23710.525789484458;27441.31396715098;27720.44559108766;30833.845830770704;31086.22284442907;22474.550508989403;23065.76934230636;23460.76539234654;23992.520149597258;24176.337798462395 07:49:49 INFO - PROCESS | 1637 | |2;jquery.html;374.57859907603944;389.7427697719506;390.75577763897564;399.3012228599951;422.9048464095579;14817.333220005099;19256.22975080997;20172.293969711063;20430.387088387353;20489.87305698188;20754.377368678925;20820.271290504836;20950.58098838026;21026;21078.15687372507;5484.177373393993;5835.5915085944;5889.087191485327;5897.852553686171;5905.704714764244;5709.257796486451;5766.884662306751;5856.092305692603;5876.70616469177;5887.676177810219;5141.511556402136;5822.563307751935;5870.853228669274;5882.176495290662;5889.1755154278435;5864.706764661772;5873.060310350324;5902.793402230923;7383.778486645409;7746.535207887545;7391.260873912565;7607.467477276593;7720.613969301568;7733.7679869604;7739.032620922385;27078;27562.310942226406;27772.58341124885;27815.443691126064;28029.719702802915;2824.7316504932;2972.286651203717;2976.7469765069995;3000.939981200364;3001.9849900750355;14606.780898286534;14761.89285803569;16327.918360408241;16531.090790006543;17518.649627007515;1742.912854357277;2034.4812072921459;2040.8877511736848;2053.761996447707;2064.607724532334;146076;149396;153382;155173.22413387973;157114;18600.720989185174;20297.79702202959;21450.712957222306;24377.878110609687;24469.75530244675;12142.575009874612;12719.300438475788;41661.375079373836;41710.374344384254;41755.7912210437;8114.391420643476;8129.959350203211;8246.216609422096;8306.875396869053;8361.581920903931;8506.638937769927;8549.487030778173;8575.142485751376;8694.434861733967;8716.912830871737;3957.7229593928723;4009.939850902239;4035.152617950205;4053.2298863215897;4102.056526998807;1987.6819708846515;2030.8883011434218;2041.8774873507637;2046.785087565814;2061.9793802062086;823.3865770001387;840.8696652018824;886.2201262888617;893.3300024981264;893.3657103456488;20190.495237618885;20601.690974635392;20703.689444658343;20877.89561052185;21006.78993210079;881.1364862434722;893.5130353957109;895.2345744388584;908.1281969309405;912.5300470257822;8154.959225203836;10180;10942.835857462145;10999.395033273087;11066.723331916766;751953;773123;773296;791035;792213;135662;141759.2912035433;144409.55590444172;144777.27611361875;154256;978.3738407419257;985.2955137077024;996.4519514267124;999.8450240212778;1012.8048902295362;17416.216270267614;17958;18214.180361883482;18309.3591724289;18352.449426517225;55120.173197401265;55331.72334138303;56835.579110520914;57212.85574288574;57358.426415736976;73158.26841731727;81919;81997;82863;84005;10595.258331916692;11398.031167350868;12048.156629035884;12140.386947387247;12442;10578.523966421684;12907.161034532724;12922.483100675867;12986.805197921849;13212.207267563977;10834.566617335218;10904.672859814218;11164.665060048212;11323.207375483636;11348.092152627934;10945.45272736376;11265.211435199784;11281.887181128084;11379.260348077349;11577.363245021605;11418.600348987746;11431.714207144887;11616;11619.244749091282;11863.406829658656;12203.694907627025;12245.326507042199;12437.689057773629;12486.313252771184;12616.621501354974;9321.44071355721;10428.85282618896;10855.78288434211;11397.544098235978;11487.827682584935 07:49:49 INFO - PROCESS | 1637 | |3;mootools.html;1253.7492501499698;1316.6774140335617;1415.5541004583563;1428.6785473268521;1437.3029080895765;7452.96273518633;7691.692332306701;8002.999999999993;8446.957765211173;8450.197231263028;7912.327452166573;8122.228388303101;8225.136360682132;8267.049289331728;8304.169583041692;2274.6246869266593;2312.629979203328;2313.3175713164655;2320.454693147109;2320.7563205863394;2063.5357044664906;2294.6902168207243;2323.0475505042937;2327.534493101378;2332.626779715246;2096.6540520814046;2243.383069655841;2311.2719493359623;2322.2336628912503;2326.8830961138665;2120.8303335733103;2129.8296136309136;2135.4554588579967;2142.871427714342;2143.8070573648447;2297.9425514362106;2300.826578445005;2326.0579465316405;2331.137479132715;2333.183385814968;7201.747938822116;8024.959875200587;8180.977377827771;8264.669413223464;8269.751907442786;4979.850604481871;5025.497450254982;5132.5893928486;5153.304303918998;5205.479452054802;3329.1344250495044;3460.463628137643;3474.9826250868837;3535.9646403535894;3568.072301201706;1161.848959635242;1235.0983781839218;1249.5501619417003;1257.8427696537933;1261.7981123020272;10402.635907743193;10655.573777048909;10734;10814.945925270402;10818.29681070728;4168.749875007448;4383.802728877208;4696.436427628706;4747.8575642730775;4752.073345697625;9377.859332110023;9479.715608531755;9509.191718703849;9512.09635084666;9513.143817056498;5232.005918875401;5233.319668443154;5238.816641417532;5244.056069907377;5251.975864706422;4715.81136754526;4719.2921061841;4773.880652983634;4779.737114458669;4788.329633851264;3840.5967373425387;3910.921781564353;3915.314819906505;3943.72393932422;4011.13760541485;1173.0556901694217;1243.6269119264184;1278.086168389606;1284.8329717136712;1289.619562229126;794.8608993426127;812.9349652027823;884.7566919097171;906.6554709210458;947.0907928388687;5447.373552041487;5516.9448305517235;5578.581606379537;5630.85922851932;5665.235193248941;959.5777857742571;977.726236653738;992.8758905136858;998.3660375661507;1042.6455005298235;3645.9453108203397;3694.6674799268194;3703.370427027358;3787.4129509926006;3796.088938654703;8372.874406883902;9725.465099419458;10042.497875106215;10051.798964020678;10063.04401081896;8443;9991.800163996679;9995.150412214898;10021.549030293654;10027.699169024942;6897.448204143657;7677.692892284358;7759.262870027338;7791.844163116706;7891.171427000198;4830.888895553972;5347.572194224531;5429.429909859566;5466.781328746805;5566.471185237396;8508.404411691123;9306.860397094184;9318.254539636677;9319.86020209684;9327.720168394959;8333.916660833314;8550;8691.870056892563;9400.435973841319;9440.669576564787;5820.214271073351;6300.338464461165;6462.644554549545;6478.773242936474;6481.902771458526;7873.488223265469;7898.881516777138;7981.521108733495;7995.080565735015;7995.400344974034;6993.930060699327;7131.572105673677;7136.643167841483;7160.248173941869;7212.531185472927;5607.41122182165;6953.26990665993;6999.615021173884;7038;7050.330218629222;6187.907181392373;6269.059641053696;6332.651704156316;6332.841678958063;6344.048392741126;4869.756512174448;4873.4882837301575;4931.605471562339;4962.057209130254;4967.180415231446;4895.853124406273;4897.730624815669;4911.778969946289;5043.167877300351;5065.8733531662 07:49:49 INFO - PROCESS | 1637 | |4;prototype.html;353.5739433982052;358.7847291625025;364.1624264192357;364.2805459218043;365.70012589676475;5143.682324900437;5331.57347412207;5336.4129945705945;5599.720013999299;5667.348254950677;4319.697621166511;4683;5057.595392368611;5182.714950677711;5295.781970146869;3845.730798844082;4124.83500659974;4343.739375637456;4363.80362883671;4400.207962566737;3802.448644946481;4259.78701064947;4378.008006357116;4380.364847097169;4502.527234640364;3780.8298626561873;4269.850555230568;4276.722013069156;4291.420658211148;4292.570742925698;4086.1010577672864;4280.957190428103;4298.237722533746;4321;4340.8697739067875;3022.9697703022907;3818.1409182933894;3844.7693138411787;3849.30712471755;3854.69162467002;5165.25933656578;5257.396494069308;5291.920621190685;5303.6552624079695;5391.379991301012;4198.118395136994;4526.936170000047;4694.976525117387;5004.374453193351;5076.842342004633;4779.976100119512;5949.167116603679;5955.40445955401;5986.8503287417725;6000.249968753906;3234.854431550586;3382.391169589473;3925.7840818754958;3934.7639141651307;3953.5453422856453;6106;6122.703986005248;6160.353162917919;6165.229346331708;6208.379162083756;3365.730741540671;3861.972464456183;3971.781552014609;4006.579309172553;4007.458993035961;3444.2778610694654;3863.497745293094;3863.5318578939823;3867.961320386816;4049.8785036448953;3826.9284600311958;3987.7407968481957;4625.259958406638;4750.976245118822;4781.402324709411;4801.759912004386;5221.373435187802;5255.950179430025;5870.002099643071;5934.851628709231;1213.3993673131856;1241.3234787040903;1281.2632736176736;1313.39583791457;1322.821419108408;867.2714919467677;882.7042940614838;883.5361435246547;888.8622263549161;889.835380454618;4395.912081758347;4657.417822772153;5099.464556221544;5112.667676601083;5116.667416617908;5070.923936140961;5355.437679043722;5757.337906140848;5788.594798364074;5875.941240587539;4575.656825738083;4605.677602567788;4944.887400334967;5000;5281.419043905167;2681.2303879439864;2919.8394088325344;2942.822311489525;3092.768042396829;3112.937741245162;4860.586850117779;5298.523132918056;5503.780288531254;5935.495482883917;5989.717352093274;5032.823851165192;5736;5824.621719402821;6063.090536419572;6107.358727333566;5711.1724248241;5744;5999.730012149376;6346.365363463525;6418.679066046772;5347.117725575236;5735.36910939788;6186.154368990315;6199.318075011835;6230.7819226326865;5164.8192313268855;5573.634459557435;5998.710277290404;6046.183765191643;6071.939280607137;5288.629795914249;5747.7296467895785;6322.715477803602;6379.77670781539;6410.551261411843;3401.370746411823;3765.962340376671;3933.3509970855634;3958.8812335629977;4016.979915100406;4799.5680388763785;5377.8117765878005;5429.837104886859;6130.448259656652;6140.17107690456;5786.103154011135;5852.970735146297;5927.465488901081;5968.940310597012;5982.910256346071;5866.3015013092745;5915.08316210988;5924;5952.5833191676165;5969.611975221596;5687.402822703557;5759.683217423082;5782.45066718661;5791.797287094932;5945.762169513171;4940.505949405031;5649.350324712711;5893.139993304392;5931.64410135376;5970.820425701939;5358.7320633967365;5775.797847075332;5795.450001999276;5795.913061304;5859.414058594107 07:49:49 INFO - PROCESS | 1637 | |5;yui.html;698.8148140742701;709.2659097833744;744.2148533297373;822.9382796290279;845.1506236232588;14660.78008829867;15381.69236615267;15474.690506189898;15489.84510154898;15688.921555392222;14132.22272774997;14254.572362829105;14264.358103885324;14273.50042748504;15749.921250393732;862.0474375814729;877.9297656187522;885.6059053721096;889.9466032038066;891.7369376034053;792.2592376128309;883.1565854608865;891.3715830339595;895.8477058900003;899.703097977669;910.4082346474778;933.286036182321;934.8597710343469;936.4989730494187;938.5964035464748;825.5707032343208;930.4277869110516;931.8043210925714;934.0379409208526;934.9579268932914;678.5487650712271;693.2409012131708;695.2491309385852;697.285282585349;699.1470406104544;13135;15438.5368438947;15668.686626267525;15675.137867417288;15677.372905083783;13679.590708240166;13706.109102908278;14032.43870245189;14095.22476263805;14128.152310861278;11626.244294120856;11836.11229157808;11894.52421903123;12367.814482782765;12602.306873121976;3760.304343696425;3791.274969888694;3807.562130355017;3824.694024478035;3826.942595861064;90824.09175908222;105969;112428;112820;113655;8962.551872406353;11128.554857805759;11157.832632510519;11567.248128871597;11853.9331460169;23899.52200955971;23998.52002959931;24052.639210411857;24147;24157.51684966291;7823.335016523659;7883.5664038478435;7892.644830982619;7955.4828936118965;8116.797080073045;4279.636230920407;4315.438992930899;4395.922998865299;4430.556944305544;4456.665750068758;3626.637336266352;3705.09225239818;3707.332680117605;3711.03513086594;3838.40504721763;728.7522242437597;736.322583223425;740.9147947985942;754.7132089805948;766.3677466090497;679.9252082270946;683.0812557110678;702.880510313248;720.2761224968873;729.2962291388835;9551;9712.3201375903;10166.678331816964;10401.27191096631;10562.471876406149;701.2671758012889;705.693023534764;728.7595093619199;729.901463302458;730.987626769814;4776.59398951093;5123.410807757081;5124;5127.9230811537855;5177.197534382177;62609.68695156495;79639.60180199062;91277.54361228152;106474.46762766292;108662.91337086528;46535;60954;63741;76715.61642191753;89021;58797;62183;72256.277437226;74912.25087749053;76268;10355.964403559583;10804.405757683402;10954.342739435659;11068.335899846035;11076.224664273423;46499.535004650876;47363;47398.052038959715;50709;51885.44343669696;65238;65310;67412.32587674257;67558;69517;11385.203035787416;12814.871851281741;12999;13295.20228786276;13402.362910131505;14387.64030899194;14598.416063357772;14627.853721462649;14640;14732.631684207981;13020.804687929878;13167.275799830719;13177;13321.800172997606;13730.970177236548;13470.93264533671;13570.457181712622;14172.858271417153;14304.57086287413;14577.635559110682;12754.68113297175;13062.281574513492;13198.934005329911;13681.726365472834;13733.381997809922;10922.836157457803;11297.774044519228;11530.1928864982;11638.243514171552;11725.443763332856;9506.382085164441;9714.70940966282;11419.543218271509;11482.598109066143;11773.88226117728 07:49:49 INFO - PROCESS | 1637 | __end_tp_report 07:49:49 INFO - PROCESS | 1637 | __start_cc_report 07:49:49 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,388 07:49:49 INFO - PROCESS | 1637 | __end_cc_report 07:49:49 INFO - PROCESS | 1637 | __startTimestamp1486050589435__endTimestamp 07:49:49 INFO - PROCESS | 1637 | 07:49:49 INFO - PROCESS | 1637 | ------- Summary: start ------- 07:49:49 INFO - PROCESS | 1637 | Number of tests: 6 07:49:49 INFO - PROCESS | 1637 | 07:49:49 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5733.20 Median:5949.52 stddev:678.91 (11.4%) stddev-sans-first:644.78 07:49:49 INFO - PROCESS | 1637 | Values: 2944.4 3390.0 3411.2 3425.7 3440.1 5808.7 5890.9 5917.6 5926.1 5926.7 5755.7 5812.7 5828.0 5846.4 5854.8 4509.9 5233.9 5276.6 5308.5 5358.6 4419.5 5340.7 5343.9 5356.5 5359.0 4334.4 5202.1 5203.6 5336.1 5367.2 5240.1 5288.9 5308.5 5348.3 5396.1 5192.4 5276.9 5286.2 5292.8 5306.3 5579.5 5762.4 5792.9 5896.7 5949.5 5802.2 6108.4 6187.4 6214.2 6258.7 6249.1 6261.2 6264.8 6277.2 6279.4 5924.0 5943.9 5960.7 5964.1 6009.1 5534.4 5938.3 6142.3 6267.3 6322.2 5064.4 6181.6 6194.9 6234.6 6237.5 6252.9 6260.7 6262.0 6269.6 6275.7 6109.4 6113.5 6116.4 6237.7 6273.1 6126.5 6171.4 6187.9 6192.6 6209.8 5077.6 5078.9 5080.9 5086.9 5093.0 4411.5 4426.0 4453.8 4476.6 4477.5 5831.6 5842.6 5907.7 5966.3 6022.2 6217.5 6219.2 6268.9 6275.1 6275.7 5333.7 5719.2 5822.8 5856.0 5879.7 4594.0 4627.2 5556.6 5580.3 5626.1 5478.0 5572.8 6422.8 6430.9 6437.6 5172.6 6178.7 6224.1 6293.3 6331.4 6355.0 6390.1 6412.5 6431.8 6433.7 5069.5 6192.5 6242.2 6259.1 6269.3 5280.5 5745.5 6195.9 6225.7 6288.3 6160.0 6163.2 6196.3 6264.9 6285.5 6223.9 6276.8 6286.2 6295.4 6295.7 4849.8 5384.8 6178.3 6182.7 6189.4 5066.4 6145.2 6157.0 6182.0 6271.2 6095.5 6102.5 6118.8 6128.7 6130.9 07:49:49 INFO - PROCESS | 1637 | 07:49:49 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:69149.49 Median:33987.33 stddev:153057.52 (450.3%) stddev-sans-first:153400.00 07:49:49 INFO - PROCESS | 1637 | Values: 459.5 474.2 496.0 516.5 529.1 32468.0 40118.2 40125.2 41737.0 41743.6 40573.6 41123.8 41208.6 41224.8 41266.6 9177.0 9264.9 9383.1 9421.2 10875.8 10950.1 11148.0 11156.4 11168.4 11180.2 11155.9 11193.3 11194.2 11198.1 11223.0 11054.7 11091.3 11129.7 11137.9 11157.6 10911.0 10968.7 10982.2 10989.9 11006.9 35447.9 35754.8 35805.6 35820.0 35875.6 3875.5 3900.9 3965.3 3967.0 3991.0 26619.5 26791.3 27320.2 28031.7 28440.3 3174.8 3206.7 3228.7 3300.2 3377.7 474822.0 474943.0 476573.0 478558.6 480723.0 46809.3 52840.7 53100.0 53122.2 53202.7 56060.9 56252.0 56307.4 56497.7 56521.4 15242.0 15563.5 15589.6 15631.0 15657.8 11794.8 12070.7 12119.2 12120.7 12278.5 12987.7 15089.9 17412.7 17416.8 17499.8 6751.7 7277.5 7432.6 8132.2 8146.8 856.3 862.6 866.4 876.0 894.9 21702.6 23188.0 29586.9 29631.4 29813.7 896.4 1019.4 1050.5 1074.6 1196.0 14103.7 16748.4 17095.5 17158.5 17358.8 613996.0 617982.0 623074.0 623702.0 624131.0 60582.0 60762.4 61407.1 61478.7 61623.7 1390.8 1407.0 1425.0 1427.9 1435.0 26258.7 29496.3 30259.6 30681.5 31134.8 48722.0 49213.8 49341.0 49409.3 49457.8 605651.0 606091.0 608841.0 609002.0 610010.9 37654.0 38462.4 38571.4 39894.4 41330.4 40184.8 40229.8 40731.4 41193.4 41447.8 29394.4 34477.7 34720.0 34734.7 34849.5 33201.8 33272.3 33592.7 33720.2 33819.7 33804.8 33813.3 33865.5 33881.0 34093.7 23710.5 27441.3 27720.4 30833.8 31086.2 22474.6 23065.8 23460.8 23992.5 24176.3 07:49:49 INFO - PROCESS | 1637 | 07:49:49 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:42726.51 Median:25773.88 stddev:129082.54 (500.8%) stddev-sans-first:129405.48 07:49:49 INFO - PROCESS | 1637 | Values: 374.6 389.7 390.8 399.3 422.9 14817.3 19256.2 20172.3 20430.4 20489.9 20754.4 20820.3 20950.6 21026.0 21078.2 5484.2 5835.6 5889.1 5897.9 5905.7 5709.3 5766.9 5856.1 5876.7 5887.7 5141.5 5822.6 5870.9 5882.2 5889.2 5864.7 5873.1 5902.8 7383.8 7746.5 7391.3 7607.5 7720.6 7733.8 7739.0 27078.0 27562.3 27772.6 27815.4 28029.7 2824.7 2972.3 2976.7 3000.9 3002.0 14606.8 14761.9 16327.9 16531.1 17518.6 1742.9 2034.5 2040.9 2053.8 2064.6 146076.0 149396.0 153382.0 155173.2 157114.0 18600.7 20297.8 21450.7 24377.9 24469.8 12142.6 12719.3 41661.4 41710.4 41755.8 8114.4 8130.0 8246.2 8306.9 8361.6 8506.6 8549.5 8575.1 8694.4 8716.9 3957.7 4009.9 4035.2 4053.2 4102.1 1987.7 2030.9 2041.9 2046.8 2062.0 823.4 840.9 886.2 893.3 893.4 20190.5 20601.7 20703.7 20877.9 21006.8 881.1 893.5 895.2 908.1 912.5 8155.0 10180.0 10942.8 10999.4 11066.7 751953.0 773123.0 773296.0 791035.0 792213.0 135662.0 141759.3 144409.6 144777.3 154256.0 978.4 985.3 996.5 999.8 1012.8 17416.2 17958.0 18214.2 18309.4 18352.4 55120.2 55331.7 56835.6 57212.9 57358.4 73158.3 81919.0 81997.0 82863.0 84005.0 10595.3 11398.0 12048.2 12140.4 12442.0 10578.5 12907.2 12922.5 12986.8 13212.2 10834.6 10904.7 11164.7 11323.2 11348.1 10945.5 11265.2 11281.9 11379.3 11577.4 11418.6 11431.7 11616.0 11619.2 11863.4 12203.7 12245.3 12437.7 12486.3 12616.6 9321.4 10428.9 10855.8 11397.5 11487.8 07:49:49 INFO - PROCESS | 1637 | 07:49:49 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5341.19 Median:5179.39 stddev:2889.09 (55.8%) stddev-sans-first:2880.86 07:49:49 INFO - PROCESS | 1637 | Values: 1253.7 1316.7 1415.6 1428.7 1437.3 7453.0 7691.7 8003.0 8447.0 8450.2 7912.3 8122.2 8225.1 8267.0 8304.2 2274.6 2312.6 2313.3 2320.5 2320.8 2063.5 2294.7 2323.0 2327.5 2332.6 2096.7 2243.4 2311.3 2322.2 2326.9 2120.8 2129.8 2135.5 2142.9 2143.8 2297.9 2300.8 2326.1 2331.1 2333.2 7201.7 8025.0 8181.0 8264.7 8269.8 4979.9 5025.5 5132.6 5153.3 5205.5 3329.1 3460.5 3475.0 3536.0 3568.1 1161.8 1235.1 1249.6 1257.8 1261.8 10402.6 10655.6 10734.0 10814.9 10818.3 4168.7 4383.8 4696.4 4747.9 4752.1 9377.9 9479.7 9509.2 9512.1 9513.1 5232.0 5233.3 5238.8 5244.1 5252.0 4715.8 4719.3 4773.9 4779.7 4788.3 3840.6 3910.9 3915.3 3943.7 4011.1 1173.1 1243.6 1278.1 1284.8 1289.6 794.9 812.9 884.8 906.7 947.1 5447.4 5516.9 5578.6 5630.9 5665.2 959.6 977.7 992.9 998.4 1042.6 3645.9 3694.7 3703.4 3787.4 3796.1 8372.9 9725.5 10042.5 10051.8 10063.0 8443.0 9991.8 9995.2 10021.5 10027.7 6897.4 7677.7 7759.3 7791.8 7891.2 4830.9 5347.6 5429.4 5466.8 5566.5 8508.4 9306.9 9318.3 9319.9 9327.7 8333.9 8550.0 8691.9 9400.4 9440.7 5820.2 6300.3 6462.6 6478.8 6481.9 7873.5 7898.9 7981.5 7995.1 7995.4 6993.9 7131.6 7136.6 7160.2 7212.5 5607.4 6953.3 6999.6 7038.0 7050.3 6187.9 6269.1 6332.7 6332.8 6344.0 4869.8 4873.5 4931.6 4962.1 4967.2 4895.9 4897.7 4911.8 5043.2 5065.9 07:49:49 INFO - PROCESS | 1637 | 07:49:49 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4672.64 Median:5165.04 stddev:1464.65 (28.4%) stddev-sans-first:1432.43 07:49:49 INFO - PROCESS | 1637 | Values: 353.6 358.8 364.2 364.3 365.7 5143.7 5331.6 5336.4 5599.7 5667.3 4319.7 4683.0 5057.6 5182.7 5295.8 3845.7 4124.8 4343.7 4363.8 4400.2 3802.4 4259.8 4378.0 4380.4 4502.5 3780.8 4269.9 4276.7 4291.4 4292.6 4086.1 4281.0 4298.2 4321.0 4340.9 3023.0 3818.1 3844.8 3849.3 3854.7 5165.3 5257.4 5291.9 5303.7 5391.4 4198.1 4526.9 4695.0 5004.4 5076.8 4780.0 5949.2 5955.4 5986.9 6000.2 3234.9 3382.4 3925.8 3934.8 3953.5 6106.0 6122.7 6160.4 6165.2 6208.4 3365.7 3862.0 3971.8 4006.6 4007.5 3444.3 3863.5 3863.5 3868.0 4049.9 3826.9 3987.7 4625.3 4751.0 4781.4 4801.8 5221.4 5256.0 5870.0 5934.9 1213.4 1241.3 1281.3 1313.4 1322.8 867.3 882.7 883.5 888.9 889.8 4395.9 4657.4 5099.5 5112.7 5116.7 5070.9 5355.4 5757.3 5788.6 5875.9 4575.7 4605.7 4944.9 5000.0 5281.4 2681.2 2919.8 2942.8 3092.8 3112.9 4860.6 5298.5 5503.8 5935.5 5989.7 5032.8 5736.0 5824.6 6063.1 6107.4 5711.2 5744.0 5999.7 6346.4 6418.7 5347.1 5735.4 6186.2 6199.3 6230.8 5164.8 5573.6 5998.7 6046.2 6071.9 5288.6 5747.7 6322.7 6379.8 6410.6 3401.4 3766.0 3933.4 3958.9 4017.0 4799.6 5377.8 5429.8 6130.4 6140.2 5786.1 5853.0 5927.5 5968.9 5982.9 5866.3 5915.1 5924.0 5952.6 5969.6 5687.4 5759.7 5782.5 5791.8 5945.8 4940.5 5649.4 5893.1 5931.6 5970.8 5358.7 5775.8 5795.5 5795.9 5859.4 07:49:49 INFO - PROCESS | 1637 | 07:49:49 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:19392.04 Median:4059.02 stddev:26967.42 (664.4%) stddev-sans-first:27006.54 07:49:49 INFO - PROCESS | 1637 | Values: 698.8 709.3 744.2 822.9 845.2 14660.8 15381.7 15474.7 15489.8 15688.9 14132.2 14254.6 14264.4 14273.5 15749.9 862.0 877.9 885.6 889.9 891.7 792.3 883.2 891.4 895.8 899.7 910.4 933.3 934.9 936.5 938.6 825.6 930.4 931.8 934.0 935.0 678.5 693.2 695.2 697.3 699.1 13135.0 15438.5 15668.7 15675.1 15677.4 13679.6 13706.1 14032.4 14095.2 14128.2 11626.2 11836.1 11894.5 12367.8 12602.3 3760.3 3791.3 3807.6 3824.7 3826.9 90824.1 105969.0 112428.0 112820.0 113655.0 8962.6 11128.6 11157.8 11567.2 11853.9 23899.5 23998.5 24052.6 24147.0 24157.5 7823.3 7883.6 7892.6 7955.5 8116.8 4279.6 4315.4 4395.9 4430.6 4456.7 3626.6 3705.1 3707.3 3711.0 3838.4 728.8 736.3 740.9 754.7 766.4 679.9 683.1 702.9 720.3 729.3 9551.0 9712.3 10166.7 10401.3 10562.5 701.3 705.7 728.8 729.9 731.0 4776.6 5123.4 5124.0 5127.9 5177.2 62609.7 79639.6 91277.5 106474.5 108662.9 46535.0 60954.0 63741.0 76715.6 89021.0 58797.0 62183.0 72256.3 74912.3 76268.0 10356.0 10804.4 10954.3 11068.3 11076.2 46499.5 47363.0 47398.1 50709.0 51885.4 65238.0 65310.0 67412.3 67558.0 69517.0 11385.2 12814.9 12999.0 13295.2 13402.4 14387.6 14598.4 14627.9 14640.0 14732.6 13020.8 13167.3 13177.0 13321.8 13731.0 13470.9 13570.5 14172.9 14304.6 14577.6 12754.7 13062.3 13198.9 13681.7 13733.4 10922.8 11297.8 11530.2 11638.2 11725.4 9506.4 9714.7 11419.5 11482.6 11773.9 07:49:49 INFO - PROCESS | 1637 | -------- Summary: end -------- 07:49:49 INFO - PROCESS | 1637 | 07:49:50 INFO - TEST-INFO | 1637: exit 0 07:49:50 INFO - TEST-OK | dromaeo_css | took 1114655ms 07:49:50 INFO - TEST-START | kraken 07:49:50 INFO - operating with platform_type : mac_ 07:49:50 INFO - Initialising browser for kraken test... 07:49:50 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmp2PN5bi/profile http://localhost:49244/getInfo.html) 07:49:53 INFO - PROCESS | 1648 | 2017-02-02 07:49:53.093 plugin-container[1649:10047] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x914b, name = 'com.apple.tsm.portname' 07:49:53 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:49:53 INFO - PROCESS | 1648 | 2017-02-02 07:49:53.095 plugin-container[1649:10047] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0f, name = 'com.apple.CFPasteboardClient' 07:49:53 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:49:53 INFO - PROCESS | 1648 | 2017-02-02 07:49:53.095 plugin-container[1649:10047] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:49:53 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 07:49:53 INFO - PROCESS | 1648 | colorDepth:24 07:49:53 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 07:49:53 INFO - PROCESS | 1648 | __metrics 07:49:53 ERROR - PROCESS | 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 07:49:53 INFO - TEST-INFO | 1648: exit 0 07:49:53 INFO - Browser initialized. 07:49:53 INFO - Running cycle 1/1 for kraken test... 07:49:53 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmp2PN5bi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:49:56 INFO - PROCESS | 1650 | 2017-02-02 07:49:56.548 plugin-container[1651:10174] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4743, name = 'com.apple.tsm.portname' 07:49:56 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:49:56 INFO - PROCESS | 1650 | 2017-02-02 07:49:56.550 plugin-container[1651:10174] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f13, name = 'com.apple.CFPasteboardClient' 07:49:56 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:49:56 INFO - PROCESS | 1650 | 2017-02-02 07:49:56.550 plugin-container[1651:10174] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:50:06 INFO - PROCESS | 1650 | RSS: Main: 218796032 07:50:06 INFO - PROCESS | 1650 | 07:50:09 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 07:50:10 INFO - PROCESS | 1650 | RSS: Main: 233095168 07:50:10 INFO - PROCESS | 1650 | 07:50:13 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 07:50:13 INFO - PROCESS | 1650 | RSS: Main: 241659904 07:50:13 INFO - PROCESS | 1650 | 07:50:17 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 07:50:17 INFO - PROCESS | 1650 | RSS: Main: 244604928 07:50:17 INFO - PROCESS | 1650 | 07:50:19 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 07:50:20 INFO - PROCESS | 1650 | RSS: Main: 246091776 07:50:20 INFO - PROCESS | 1650 | 07:50:22 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:50:23 INFO - PROCESS | 1650 | RSS: Main: 246108160 07:50:23 INFO - PROCESS | 1650 | 07:50:25 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 07:50:26 INFO - PROCESS | 1650 | RSS: Main: 250609664 07:50:26 INFO - PROCESS | 1650 | 07:50:29 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 07:50:30 INFO - PROCESS | 1650 | RSS: Main: 249356288 07:50:30 INFO - PROCESS | 1650 | 07:50:33 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 07:50:33 INFO - PROCESS | 1650 | RSS: Main: 249495552 07:50:33 INFO - PROCESS | 1650 | 07:50:35 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:50:36 INFO - PROCESS | 1650 | RSS: Main: 248729600 07:50:36 INFO - PROCESS | 1650 | 07:50:38 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:50:38 INFO - PROCESS | 1650 | RSS: Main: 248537088 07:50:38 INFO - PROCESS | 1650 | 07:50:40 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:50:41 INFO - PROCESS | 1650 | RSS: Main: 248553472 07:50:41 INFO - PROCESS | 1650 | 07:50:44 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:50:45 INFO - PROCESS | 1650 | RSS: Main: 249167872 07:50:45 INFO - PROCESS | 1650 | 07:50:48 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:50:48 INFO - PROCESS | 1650 | RSS: Main: 248692736 07:50:48 INFO - PROCESS | 1650 | 07:50:50 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 07:50:50 INFO - PROCESS | 1650 | RSS: Main: 250658816 07:50:50 INFO - PROCESS | 1650 | 07:50:50 INFO - PROCESS | 1650 | __start_tp_report 07:50:50 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 07:50:50 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 07:50:50 INFO - PROCESS | 1650 | |i|pagename|runs| 07:50:50 INFO - PROCESS | 1650 | |0;ai-astar;152;161;123;106;159;134;157;175;160;160 07:50:50 INFO - PROCESS | 1650 | |1;audio-beat-detection;180;101;145;163;142;100;148;147;168;119 07:50:50 INFO - PROCESS | 1650 | |2;audio-dft;199;197;201;204;197;196;214;194;196;196 07:50:50 INFO - PROCESS | 1650 | |3;audio-fft;73;85;86;102;60;62;50;74;95;87 07:50:50 INFO - PROCESS | 1650 | |4;audio-oscillator;85;70;83;72;70;71;81;70;73;83 07:50:50 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;91;110;90;88;90;86;93;89;93;87 07:50:50 INFO - PROCESS | 1650 | |6;imaging-darkroom;131;152;93;103;156;152;96;104;98;96 07:50:50 INFO - PROCESS | 1650 | |7;imaging-desaturate;92;96;93;100;123;94;91;92;92;91 07:50:50 INFO - PROCESS | 1650 | |8;json-parse-financial;61;59;59;60;64;64;63;63;64;63 07:50:50 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;68;77;69;74;85;77;70;73;72;72 07:50:50 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;83;88;85;90;88;96;103;119;85;89 07:50:50 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;163;159;156;131;149;157;155;158;211;152 07:50:50 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;169;172;172;171;172;168;167;222;198;222 07:50:50 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;69;65;69;71;88;91;88;68;67;66 07:50:50 INFO - PROCESS | 1650 | __end_tp_report 07:50:50 INFO - PROCESS | 1650 | __start_cc_report 07:50:50 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,945 07:50:50 INFO - PROCESS | 1650 | __end_cc_report 07:50:50 INFO - PROCESS | 1650 | __startTimestamp1486050650937__endTimestamp 07:50:50 INFO - PROCESS | 1650 | 07:50:50 INFO - PROCESS | 1650 | ------- Summary: start ------- 07:50:50 INFO - PROCESS | 1650 | Number of tests: 14 07:50:50 INFO - PROCESS | 1650 | 07:50:50 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:148.70 Median:159.50 stddev:21.04 (13.2%) stddev-sans-first:22.28 07:50:50 INFO - PROCESS | 1650 | Values: 152.0 161.0 123.0 106.0 159.0 134.0 157.0 175.0 160.0 160.0 07:50:50 INFO - PROCESS | 1650 | 07:50:50 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:147.50 stddev:27.08 (18.4%) stddev-sans-first:24.84 07:50:50 INFO - PROCESS | 1650 | Values: 180.0 101.0 145.0 163.0 142.0 100.0 148.0 147.0 168.0 119.0 07:50:50 INFO - PROCESS | 1650 | 07:50:50 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:199.40 Median:198.00 stddev:5.89 (3.0%) stddev-sans-first:6.25 07:50:50 INFO - PROCESS | 1650 | Values: 199.0 197.0 201.0 204.0 197.0 196.0 214.0 194.0 196.0 196.0 07:50:50 INFO - PROCESS | 1650 | 07:50:50 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:77.40 Median:79.50 stddev:16.53 (20.8%) stddev-sans-first:17.46 07:50:50 INFO - PROCESS | 1650 | Values: 73.0 85.0 86.0 102.0 60.0 62.0 50.0 74.0 95.0 87.0 07:50:50 INFO - PROCESS | 1650 | 07:50:50 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:75.80 Median:77.00 stddev:6.34 (8.2%) stddev-sans-first:5.78 07:50:50 INFO - PROCESS | 1650 | Values: 85.0 70.0 83.0 72.0 70.0 71.0 81.0 70.0 73.0 83.0 07:50:50 INFO - PROCESS | 1650 | 07:50:50 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:91.70 Median:90.00 stddev:6.83 (7.6%) stddev-sans-first:7.24 07:50:50 INFO - PROCESS | 1650 | Values: 91.0 110.0 90.0 88.0 90.0 86.0 93.0 89.0 93.0 87.0 07:50:50 INFO - PROCESS | 1650 | 07:50:50 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:118.10 Median:124.50 stddev:26.54 (21.3%) stddev-sans-first:27.74 07:50:50 INFO - PROCESS | 1650 | Values: 131.0 152.0 93.0 103.0 156.0 152.0 96.0 104.0 98.0 96.0 07:50:50 INFO - PROCESS | 1650 | 07:50:50 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:92.00 stddev:9.74 (10.6%) stddev-sans-first:10.20 07:50:50 INFO - PROCESS | 1650 | Values: 92.0 96.0 93.0 100.0 123.0 94.0 91.0 92.0 92.0 91.0 07:50:50 INFO - PROCESS | 1650 | 07:50:50 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:62.00 Median:63.00 stddev:2.05 (3.3%) stddev-sans-first:2.15 07:50:50 INFO - PROCESS | 1650 | Values: 61.0 59.0 59.0 60.0 64.0 64.0 63.0 63.0 64.0 63.0 07:50:50 INFO - PROCESS | 1650 | 07:50:50 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:73.70 Median:73.50 stddev:4.99 (6.8%) stddev-sans-first:4.85 07:50:50 INFO - PROCESS | 1650 | Values: 68.0 77.0 69.0 74.0 85.0 77.0 70.0 73.0 72.0 72.0 07:50:50 INFO - PROCESS | 1650 | 07:50:50 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:92.60 Median:88.00 stddev:10.99 (12.5%) stddev-sans-first:11.09 07:50:50 INFO - PROCESS | 1650 | Values: 83.0 88.0 85.0 90.0 88.0 96.0 103.0 119.0 85.0 89.0 07:50:50 INFO - PROCESS | 1650 | 07:50:50 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:159.10 Median:157.50 stddev:20.23 (12.8%) stddev-sans-first:21.41 07:50:50 INFO - PROCESS | 1650 | Values: 163.0 159.0 156.0 131.0 149.0 157.0 155.0 158.0 211.0 152.0 07:50:50 INFO - PROCESS | 1650 | 07:50:50 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.30 Median:172.00 stddev:22.24 (12.9%) stddev-sans-first:22.98 07:50:50 INFO - PROCESS | 1650 | Values: 169.0 172.0 172.0 171.0 172.0 168.0 167.0 222.0 198.0 222.0 07:50:50 INFO - PROCESS | 1650 | 07:50:50 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.20 Median:70.00 stddev:10.38 (14.8%) stddev-sans-first:10.84 07:50:50 INFO - PROCESS | 1650 | Values: 69.0 65.0 69.0 71.0 88.0 91.0 88.0 68.0 67.0 66.0 07:50:50 INFO - PROCESS | 1650 | -------- Summary: end -------- 07:50:50 INFO - PROCESS | 1650 | 07:50:51 INFO - TEST-INFO | 1650: exit 0 07:50:51 INFO - TEST-OK | kraken | took 61747ms 07:50:51 INFO - SUITE-END | took 1176s 07:50:52 INFO - Completed test suite (00:19:36) 07:50:52 INFO - javascript benchmark 07:50:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7412.229943021109, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2944.396398738258, 3389.9830500847474, 3411.2495251044775, 3425.7430692698053, 3440.1399650087487, 5808.738606762695, 5890.882182356356, 5917.585768996172, 5926.140709597106, 5926.703664816758, 5755.712214389285, 5812.709364531777, 5827.970860145693, 5846.356900740915, 5854.76580936762, 4509.887252818673, 5233.86915327117, 5276.604254680895, 5308.522232999029, 5358.59810514211, 4419.491758447772, 5340.679559226459, 5343.946560534403, 5356.491133342346, 5359.008583412062, 4334.393184954109, 5202.089634313998, 5203.635745497817, 5336.092864213093, 5367.221752845854, 5240.082985477527, 5288.947110528903, 5308.5487733542695, 5348.277982472356, 5396.082665946759, 5192.402873669538, 5276.894462110737, 5286.233496143038, 5292.814751483679, 5306.310179676656, 5579.497845193911, 5762.423757624246, 5792.855178620568, 5896.651690094579, 5949.524038076944, 5802.18769372284, 6108.372425856745, 6187.3503282155625, 6214.192155019864, 6258.655773932432, 6249.093881387219, 6261.248650161964, 6264.7807326743805, 6277.246730392337, 6279.434850863398, 5923.970380148072, 5943.900378430004, 5960.672163031031, 5964.075568286879, 6009.06859436788, 5534.363548191929, 5938.317093534212, 6142.314611233313, 6267.310595834455, 6322.241331040213, 5064.366954130734, 6181.567290289727, 6194.938050619527, 6234.625922444668, 6237.5321850860455, 6252.874942501125, 6260.718267677966, 6261.96869015652, 6269.5611307208055, 6275.6862156892885, 6109.435031337442, 6113.476306051851, 6116.42707509198, 6237.688115594202, 6273.059041143865, 6126.517673797367, 6171.444569988723, 6187.907181392283, 6192.566520343533, 6209.751609935552, 5077.644564880497, 5078.873028174326, 5080.949190508121, 5086.898262034739, 5093.0, 4411.4926783420315, 4426.0, 4453.799579018952, 4476.6194873436125, 4477.485089214717, 5831.591788574759, 5842.649441033552, 5907.734151963172, 5966.343702192756, 6022.156898034279, 6217.482437404474, 6219.222597175353, 6268.905966410416, 6275.090111933744, 6275.748970041239, 5333.6533125347505, 5719.2279042328755, 5822.767089316465, 5856.0, 5879.65318726497, 4593.954060459419, 4627.236505976476, 5556.638818476867, 5580.330360356702, 5626.071698169756, 5477.972610137003, 5572.804951826748, 6422.807315780534, 6430.871382572416, 6437.645929473831, 5172.637915345889, 6178.66017369049, 6224.128621993015, 6293.276273228637, 6331.430171284606, 6355.0, 6390.137331460193, 6412.454941329853, 6431.807045788634, 6433.742650293936, 5069.493050694901, 6192.504599632109, 6242.157308763259, 6259.061140828912, 6269.341719119427, 5280.471952804689, 5745.534888603379, 6195.907061394173, 6225.688715564113, 6288.339724329063, 6160.014397696347, 6163.229596300463, 6196.349383314687, 6264.874702506016, 6285.465735412541, 6223.906641400473, 6276.843078923063, 6286.18279623646, 6295.401936815995, 6295.653739044396, 4849.80600775965, 5384.838454846361, 6178.258608966953, 6182.659953702409, 6189.381061893775, 5066.392032956069, 6145.187169785014, 6157.0456579230295, 6182.041783523561, 6271.153394291712, 6095.47954366257, 6102.542309326907, 6118.785842495491, 6128.693565321805, 6130.9179418630665], "value": 5692.368461753474, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [459.51980180711166, 474.15126922808156, 496.01293426082105, 516.4912561127292, 529.1031701266353, 32468.0, 40118.19763604726, 40125.19749605006, 41737.0, 41743.58256417435, 40573.59426405735, 41123.76628701136, 41208.58791412085, 41224.79387603058, 41266.58733412665, 9176.954115229415, 9264.907350926505, 9383.108604682544, 9421.199198068172, 10875.83686244707, 10950.123990080814, 11147.996680298771, 11156.386398748065, 11168.385738784364, 11180.217384783027, 11155.944220278887, 11193.27243729159, 11194.160437967144, 11198.104151667847, 11223.046041086518, 11054.723631909226, 11091.279066860629, 11129.666110016753, 11137.888621113767, 11157.609483668033, 10911.0, 10968.670939871816, 10982.231243812936, 10989.890101098967, 11006.889931100666, 35447.93656190293, 35754.821225893706, 35805.64194358049, 35820.0, 35875.64124358749, 3875.476810630585, 3900.863469778544, 3965.286248475273, 3967.02807812085, 3991.0, 26619.46761064768, 26791.330216744736, 27320.180394588195, 28031.719682803116, 28440.28899277514, 3174.777765556412, 3206.679332066798, 3228.725558327545, 3300.2079500919845, 3377.746668999835, 474822.0, 474943.0, 476573.0, 478558.6072069652, 480723.0, 46809.29786053212, 52840.73579632077, 53100.0, 53122.203166952524, 53202.7339863306, 56060.87878242412, 56252.0, 56307.43692563104, 56497.71751141218, 56521.43478565244, 15242.0, 15563.533094007198, 15589.610259743597, 15631.0, 15657.843421565867, 11794.823077653842, 12070.698232544257, 12119.21225120382, 12120.69698257533, 12278.508859645513, 12987.740245195044, 15089.943703940618, 17412.738808917875, 17416.825831741775, 17499.825001750076, 6751.7171737369745, 7277.52696074764, 7432.554046757212, 8132.186781321939, 8146.796330091676, 856.2935578148052, 862.6198083067168, 866.4151697604092, 876.0188588780607, 894.9149830766066, 21702.565948681255, 23187.956541955653, 29586.852065739535, 29631.40737185244, 29813.701862981525, 896.4128495835238, 1019.3883669798062, 1050.4852622215212, 1074.5862842805577, 1195.9581414650445, 14103.71792564143, 16748.413805516993, 17095.48713538596, 17158.48524544266, 17358.826411735972, 613996.0, 617982.0, 623074.0, 623702.0, 624131.0, 60582.0, 60762.39237607656, 61407.078893815735, 61478.69260653668, 61623.6918815412, 1390.7705228637365, 1406.9507567235303, 1424.988258336572, 1427.9214643194723, 1434.9713005739827, 26258.73741262563, 29496.262593435335, 30259.63831627538, 30681.53977690292, 31134.844325778227, 48722.025559487905, 49213.76965575889, 49341.0, 49409.258861116396, 49457.76355590995, 605651.0, 606091.0, 608841.0, 609002.0, 610010.9499452474, 37654.0, 38462.42306365351, 38571.421428679154, 39894.40158397568, 41330.38004429996, 40184.79445616636, 40229.79885100556, 40731.38902916399, 41193.38209926913, 41447.792761036, 29394.412111757218, 34477.65522344845, 34720.0, 34734.65265347314, 34849.47725784065, 33201.833990830855, 33272.33455330831, 33592.66407335895, 33720.1569960753, 33819.66180338264, 33804.83097584594, 33813.3237335247, 33865.49201761926, 33881.0, 34093.65906341004, 23710.525789484458, 27441.31396715098, 27720.44559108766, 30833.845830770704, 31086.22284442907, 22474.550508989403, 23065.76934230636, 23460.76539234654, 23992.520149597258, 24176.337798462395], "value": 19646.10270454508, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.57859907603944, 389.7427697719506, 390.75577763897564, 399.3012228599951, 422.9048464095579, 14817.333220005099, 19256.22975080997, 20172.293969711063, 20430.387088387353, 20489.87305698188, 20754.377368678925, 20820.271290504836, 20950.58098838026, 21026.0, 21078.15687372507, 5484.177373393993, 5835.5915085944, 5889.087191485327, 5897.852553686171, 5905.704714764244, 5709.257796486451, 5766.884662306751, 5856.092305692603, 5876.70616469177, 5887.676177810219, 5141.511556402136, 5822.563307751935, 5870.853228669274, 5882.176495290662, 5889.1755154278435, 5864.706764661772, 5873.060310350324, 5902.793402230923, 7383.778486645409, 7746.535207887545, 7391.260873912565, 7607.467477276593, 7720.613969301568, 7733.7679869604, 7739.032620922385, 27078.0, 27562.310942226406, 27772.58341124885, 27815.443691126064, 28029.719702802915, 2824.7316504932, 2972.286651203717, 2976.7469765069995, 3000.939981200364, 3001.9849900750355, 14606.780898286534, 14761.89285803569, 16327.918360408241, 16531.090790006543, 17518.649627007515, 1742.912854357277, 2034.4812072921459, 2040.8877511736848, 2053.761996447707, 2064.607724532334, 146076.0, 149396.0, 153382.0, 155173.22413387973, 157114.0, 18600.720989185174, 20297.79702202959, 21450.712957222306, 24377.878110609687, 24469.75530244675, 12142.575009874612, 12719.300438475788, 41661.375079373836, 41710.374344384254, 41755.7912210437, 8114.391420643476, 8129.959350203211, 8246.216609422096, 8306.875396869053, 8361.581920903931, 8506.638937769927, 8549.487030778173, 8575.142485751376, 8694.434861733967, 8716.912830871737, 3957.7229593928723, 4009.939850902239, 4035.152617950205, 4053.2298863215897, 4102.056526998807, 1987.6819708846515, 2030.8883011434218, 2041.8774873507637, 2046.785087565814, 2061.9793802062086, 823.3865770001387, 840.8696652018824, 886.2201262888617, 893.3300024981264, 893.3657103456488, 20190.495237618885, 20601.690974635392, 20703.689444658343, 20877.89561052185, 21006.78993210079, 881.1364862434722, 893.5130353957109, 895.2345744388584, 908.1281969309405, 912.5300470257822, 8154.959225203836, 10180.0, 10942.835857462145, 10999.395033273087, 11066.723331916766, 751953.0, 773123.0, 773296.0, 791035.0, 792213.0, 135662.0, 141759.2912035433, 144409.55590444172, 144777.27611361875, 154256.0, 978.3738407419257, 985.2955137077024, 996.4519514267124, 999.8450240212778, 1012.8048902295362, 17416.216270267614, 17958.0, 18214.180361883482, 18309.3591724289, 18352.449426517225, 55120.173197401265, 55331.72334138303, 56835.579110520914, 57212.85574288574, 57358.426415736976, 73158.26841731727, 81919.0, 81997.0, 82863.0, 84005.0, 10595.258331916692, 11398.031167350868, 12048.156629035884, 12140.386947387247, 12442.0, 10578.523966421684, 12907.161034532724, 12922.483100675867, 12986.805197921849, 13212.207267563977, 10834.566617335218, 10904.672859814218, 11164.665060048212, 11323.207375483636, 11348.092152627934, 10945.45272736376, 11265.211435199784, 11281.887181128084, 11379.260348077349, 11577.363245021605, 11418.600348987746, 11431.714207144887, 11616.0, 11619.244749091282, 11863.406829658656, 12203.694907627025, 12245.326507042199, 12437.689057773629, 12486.313252771184, 12616.621501354974, 9321.44071355721, 10428.85282618896, 10855.78288434211, 11397.544098235978, 11487.827682584935], "value": 10656.381480943905, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1253.7492501499698, 1316.6774140335617, 1415.5541004583563, 1428.6785473268521, 1437.3029080895765, 7452.96273518633, 7691.692332306701, 8002.999999999993, 8446.957765211173, 8450.197231263028, 7912.327452166573, 8122.228388303101, 8225.136360682132, 8267.049289331728, 8304.169583041692, 2274.6246869266593, 2312.629979203328, 2313.3175713164655, 2320.454693147109, 2320.7563205863394, 2063.5357044664906, 2294.6902168207243, 2323.0475505042937, 2327.534493101378, 2332.626779715246, 2096.6540520814046, 2243.383069655841, 2311.2719493359623, 2322.2336628912503, 2326.8830961138665, 2120.8303335733103, 2129.8296136309136, 2135.4554588579967, 2142.871427714342, 2143.8070573648447, 2297.9425514362106, 2300.826578445005, 2326.0579465316405, 2331.137479132715, 2333.183385814968, 7201.747938822116, 8024.959875200587, 8180.977377827771, 8264.669413223464, 8269.751907442786, 4979.850604481871, 5025.497450254982, 5132.5893928486, 5153.304303918998, 5205.479452054802, 3329.1344250495044, 3460.463628137643, 3474.9826250868837, 3535.9646403535894, 3568.072301201706, 1161.848959635242, 1235.0983781839218, 1249.5501619417003, 1257.8427696537933, 1261.7981123020272, 10402.635907743193, 10655.573777048909, 10734.0, 10814.945925270402, 10818.29681070728, 4168.749875007448, 4383.802728877208, 4696.436427628706, 4747.8575642730775, 4752.073345697625, 9377.859332110023, 9479.715608531755, 9509.191718703849, 9512.09635084666, 9513.143817056498, 5232.005918875401, 5233.319668443154, 5238.816641417532, 5244.056069907377, 5251.975864706422, 4715.81136754526, 4719.2921061841, 4773.880652983634, 4779.737114458669, 4788.329633851264, 3840.5967373425387, 3910.921781564353, 3915.314819906505, 3943.72393932422, 4011.13760541485, 1173.0556901694217, 1243.6269119264184, 1278.086168389606, 1284.8329717136712, 1289.619562229126, 794.8608993426127, 812.9349652027823, 884.7566919097171, 906.6554709210458, 947.0907928388687, 5447.373552041487, 5516.9448305517235, 5578.581606379537, 5630.85922851932, 5665.235193248941, 959.5777857742571, 977.726236653738, 992.8758905136858, 998.3660375661507, 1042.6455005298235, 3645.9453108203397, 3694.6674799268194, 3703.370427027358, 3787.4129509926006, 3796.088938654703, 8372.874406883902, 9725.465099419458, 10042.497875106215, 10051.798964020678, 10063.04401081896, 8443.0, 9991.800163996679, 9995.150412214898, 10021.549030293654, 10027.699169024942, 6897.448204143657, 7677.692892284358, 7759.262870027338, 7791.844163116706, 7891.171427000198, 4830.888895553972, 5347.572194224531, 5429.429909859566, 5466.781328746805, 5566.471185237396, 8508.404411691123, 9306.860397094184, 9318.254539636677, 9319.86020209684, 9327.720168394959, 8333.916660833314, 8550.0, 8691.870056892563, 9400.435973841319, 9440.669576564787, 5820.214271073351, 6300.338464461165, 6462.644554549545, 6478.773242936474, 6481.902771458526, 7873.488223265469, 7898.881516777138, 7981.521108733495, 7995.080565735015, 7995.400344974034, 6993.930060699327, 7131.572105673677, 7136.643167841483, 7160.248173941869, 7212.531185472927, 5607.41122182165, 6953.26990665993, 6999.615021173884, 7038.0, 7050.330218629222, 6187.907181392373, 6269.059641053696, 6332.651704156316, 6332.841678958063, 6344.048392741126, 4869.756512174448, 4873.4882837301575, 4931.605471562339, 4962.057209130254, 4967.180415231446, 4895.853124406273, 4897.730624815669, 4911.778969946289, 5043.167877300351, 5065.8733531662], "value": 4361.070290653662, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.5739433982052, 358.7847291625025, 364.1624264192357, 364.2805459218043, 365.70012589676475, 5143.682324900437, 5331.57347412207, 5336.4129945705945, 5599.720013999299, 5667.348254950677, 4319.697621166511, 4683.0, 5057.595392368611, 5182.714950677711, 5295.781970146869, 3845.730798844082, 4124.83500659974, 4343.739375637456, 4363.80362883671, 4400.207962566737, 3802.448644946481, 4259.78701064947, 4378.008006357116, 4380.364847097169, 4502.527234640364, 3780.8298626561873, 4269.850555230568, 4276.722013069156, 4291.420658211148, 4292.570742925698, 4086.1010577672864, 4280.957190428103, 4298.237722533746, 4321.0, 4340.8697739067875, 3022.9697703022907, 3818.1409182933894, 3844.7693138411787, 3849.30712471755, 3854.69162467002, 5165.25933656578, 5257.396494069308, 5291.920621190685, 5303.6552624079695, 5391.379991301012, 4198.118395136994, 4526.936170000047, 4694.976525117387, 5004.374453193351, 5076.842342004633, 4779.976100119512, 5949.167116603679, 5955.40445955401, 5986.8503287417725, 6000.249968753906, 3234.854431550586, 3382.391169589473, 3925.7840818754958, 3934.7639141651307, 3953.5453422856453, 6106.0, 6122.703986005248, 6160.353162917919, 6165.229346331708, 6208.379162083756, 3365.730741540671, 3861.972464456183, 3971.781552014609, 4006.579309172553, 4007.458993035961, 3444.2778610694654, 3863.497745293094, 3863.5318578939823, 3867.961320386816, 4049.8785036448953, 3826.9284600311958, 3987.7407968481957, 4625.259958406638, 4750.976245118822, 4781.402324709411, 4801.759912004386, 5221.373435187802, 5255.950179430025, 5870.002099643071, 5934.851628709231, 1213.3993673131856, 1241.3234787040903, 1281.2632736176736, 1313.39583791457, 1322.821419108408, 867.2714919467677, 882.7042940614838, 883.5361435246547, 888.8622263549161, 889.835380454618, 4395.912081758347, 4657.417822772153, 5099.464556221544, 5112.667676601083, 5116.667416617908, 5070.923936140961, 5355.437679043722, 5757.337906140848, 5788.594798364074, 5875.941240587539, 4575.656825738083, 4605.677602567788, 4944.887400334967, 5000.0, 5281.419043905167, 2681.2303879439864, 2919.8394088325344, 2942.822311489525, 3092.768042396829, 3112.937741245162, 4860.586850117779, 5298.523132918056, 5503.780288531254, 5935.495482883917, 5989.717352093274, 5032.823851165192, 5736.0, 5824.621719402821, 6063.090536419572, 6107.358727333566, 5711.1724248241, 5744.0, 5999.730012149376, 6346.365363463525, 6418.679066046772, 5347.117725575236, 5735.36910939788, 6186.154368990315, 6199.318075011835, 6230.7819226326865, 5164.8192313268855, 5573.634459557435, 5998.710277290404, 6046.183765191643, 6071.939280607137, 5288.629795914249, 5747.7296467895785, 6322.715477803602, 6379.77670781539, 6410.551261411843, 3401.370746411823, 3765.962340376671, 3933.3509970855634, 3958.8812335629977, 4016.979915100406, 4799.5680388763785, 5377.8117765878005, 5429.837104886859, 6130.448259656652, 6140.17107690456, 5786.103154011135, 5852.970735146297, 5927.465488901081, 5968.940310597012, 5982.910256346071, 5866.3015013092745, 5915.08316210988, 5924.0, 5952.5833191676165, 5969.611975221596, 5687.402822703557, 5759.683217423082, 5782.45066718661, 5791.797287094932, 5945.762169513171, 4940.505949405031, 5649.350324712711, 5893.139993304392, 5931.64410135376, 5970.820425701939, 5358.7320633967365, 5775.797847075332, 5795.450001999276, 5795.913061304, 5859.414058594107], "value": 4215.6298225450355, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.8148140742701, 709.2659097833744, 744.2148533297373, 822.9382796290279, 845.1506236232588, 14660.78008829867, 15381.69236615267, 15474.690506189898, 15489.84510154898, 15688.921555392222, 14132.22272774997, 14254.572362829105, 14264.358103885324, 14273.50042748504, 15749.921250393732, 862.0474375814729, 877.9297656187522, 885.6059053721096, 889.9466032038066, 891.7369376034053, 792.2592376128309, 883.1565854608865, 891.3715830339595, 895.8477058900003, 899.703097977669, 910.4082346474778, 933.286036182321, 934.8597710343469, 936.4989730494187, 938.5964035464748, 825.5707032343208, 930.4277869110516, 931.8043210925714, 934.0379409208526, 934.9579268932914, 678.5487650712271, 693.2409012131708, 695.2491309385852, 697.285282585349, 699.1470406104544, 13135.0, 15438.5368438947, 15668.686626267525, 15675.137867417288, 15677.372905083783, 13679.590708240166, 13706.109102908278, 14032.43870245189, 14095.22476263805, 14128.152310861278, 11626.244294120856, 11836.11229157808, 11894.52421903123, 12367.814482782765, 12602.306873121976, 3760.304343696425, 3791.274969888694, 3807.562130355017, 3824.694024478035, 3826.942595861064, 90824.09175908222, 105969.0, 112428.0, 112820.0, 113655.0, 8962.551872406353, 11128.554857805759, 11157.832632510519, 11567.248128871597, 11853.9331460169, 23899.52200955971, 23998.52002959931, 24052.639210411857, 24147.0, 24157.51684966291, 7823.335016523659, 7883.5664038478435, 7892.644830982619, 7955.4828936118965, 8116.797080073045, 4279.636230920407, 4315.438992930899, 4395.922998865299, 4430.556944305544, 4456.665750068758, 3626.637336266352, 3705.09225239818, 3707.332680117605, 3711.03513086594, 3838.40504721763, 728.7522242437597, 736.322583223425, 740.9147947985942, 754.7132089805948, 766.3677466090497, 679.9252082270946, 683.0812557110678, 702.880510313248, 720.2761224968873, 729.2962291388835, 9551.0, 9712.3201375903, 10166.678331816964, 10401.27191096631, 10562.471876406149, 701.2671758012889, 705.693023534764, 728.7595093619199, 729.901463302458, 730.987626769814, 4776.59398951093, 5123.410807757081, 5124.0, 5127.9230811537855, 5177.197534382177, 62609.68695156495, 79639.60180199062, 91277.54361228152, 106474.46762766292, 108662.91337086528, 46535.0, 60954.0, 63741.0, 76715.61642191753, 89021.0, 58797.0, 62183.0, 72256.277437226, 74912.25087749053, 76268.0, 10355.964403559583, 10804.405757683402, 10954.342739435659, 11068.335899846035, 11076.224664273423, 46499.535004650876, 47363.0, 47398.052038959715, 50709.0, 51885.44343669696, 65238.0, 65310.0, 67412.32587674257, 67558.0, 69517.0, 11385.203035787416, 12814.871851281741, 12999.0, 13295.20228786276, 13402.362910131505, 14387.64030899194, 14598.416063357772, 14627.853721462649, 14640.0, 14732.631684207981, 13020.804687929878, 13167.275799830719, 13177.0, 13321.800172997606, 13730.970177236548, 13470.93264533671, 13570.457181712622, 14172.858271417153, 14304.57086287413, 14577.635559110682, 12754.68113297175, 13062.281574513492, 13198.934005329911, 13681.726365472834, 13733.381997809922, 10922.836157457803, 11297.774044519228, 11530.1928864982, 11638.243514171552, 11725.443763332856, 9506.382085164441, 9714.70940966282, 11419.543218271509, 11482.598109066143, 11773.88226117728], "value": 7568.520571614568, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1593.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 161.0, 123.0, 106.0, 159.0, 134.0, 157.0, 175.0, 160.0, 160.0], "value": 148.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 101.0, 145.0, 163.0, 142.0, 100.0, 148.0, 147.0, 168.0, 119.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 197.0, 201.0, 204.0, 197.0, 196.0, 214.0, 194.0, 196.0, 196.0], "value": 199.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 85.0, 86.0, 102.0, 60.0, 62.0, 50.0, 74.0, 95.0, 87.0], "value": 77.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 83.0, 72.0, 70.0, 71.0, 81.0, 70.0, 73.0, 83.0], "value": 75.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 110.0, 90.0, 88.0, 90.0, 86.0, 93.0, 89.0, 93.0, 87.0], "value": 91.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 152.0, 93.0, 103.0, 156.0, 152.0, 96.0, 104.0, 98.0, 96.0], "value": 118.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 96.0, 93.0, 100.0, 123.0, 94.0, 91.0, 92.0, 92.0, 91.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 59.0, 60.0, 64.0, 64.0, 63.0, 63.0, 64.0, 63.0], "value": 62.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 77.0, 69.0, 74.0, 85.0, 77.0, 70.0, 73.0, 72.0, 72.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 88.0, 85.0, 90.0, 88.0, 96.0, 103.0, 119.0, 85.0, 89.0], "value": 92.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 159.0, 156.0, 131.0, 149.0, 157.0, 155.0, 158.0, 211.0, 152.0], "value": 159.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 172.0, 172.0, 171.0, 172.0, 168.0, 167.0, 222.0, 198.0, 222.0], "value": 183.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 69.0, 71.0, 88.0, 91.0, 88.0, 68.0, 67.0, 66.0], "value": 74.2, "unit": "score"}]}]} 07:50:52 INFO - Return code: 0 07:50:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:50:52 ERROR - # TBPL SUCCESS # 07:50:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:50:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:50:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:50:52 INFO - 2017-02-02 07:50:52.234 screenresolution[1655:10558] starting screenresolution argv=screenresolution get 07:50:52 INFO - 2017-02-02 07:50:52.237 screenresolution[1655:10558] Display 0: 1600x1200x32@60 07:50:52 INFO - 2017-02-02 07:50:52.243 screenresolution[1656:10561] starting screenresolution argv=screenresolution list 07:50:52 INFO - Available Modes on Display 0 07:50:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:50:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:50:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:50:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:50:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:50:52 INFO - Intel Iris: 07:50:52 INFO - Chipset Model: Intel Iris 07:50:52 INFO - Type: GPU 07:50:52 INFO - Bus: Built-In 07:50:52 INFO - VRAM (Dynamic, Max): 1536 MB 07:50:52 INFO - Vendor: Intel (0x8086) 07:50:52 INFO - Device ID: 0x0a2e 07:50:52 INFO - Revision ID: 0x0009 07:50:52 INFO - Displays: 07:50:52 INFO - Display: 07:50:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:50:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:50:52 INFO - Display Serial Number: 1600x1200 60 07:50:52 INFO - Main Display: Yes 07:50:52 INFO - Mirror: Off 07:50:52 INFO - Online: Yes 07:50:52 INFO - Rotation: Supported 07:50:52 INFO - Return code: 0 07:50:52 INFO - Running post-action listener: _resource_record_post_action 07:50:52 INFO - [mozharness: 2017-02-02 15:50:52.480323Z] Finished run-tests step (success) 07:50:52 INFO - Running post-run listener: _resource_record_post_run 07:50:52 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 39877120; Write bytes: 511070720; Read time: 384; Write time: 1602 07:50:52 INFO - TinderboxPrint: CPU usage
54.2% 07:50:52 INFO - TinderboxPrint: I/O read bytes / time
39,877,120 / 384 07:50:52 INFO - TinderboxPrint: I/O write bytes / time
511,070,720 / 1,602 07:50:52 INFO - TinderboxPrint: CPU idle
2,192.3 (45.8%) 07:50:52 INFO - TinderboxPrint: CPU system
963.9 (20.1%) 07:50:52 INFO - TinderboxPrint: CPU user
1,633.4 (34.1%) 07:50:52 INFO - TinderboxPrint: Swap in / out
247,635,968 / 0 07:50:52 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205316608; Write bytes: 198795264; Read time: 15714; Write time: 352 07:50:52 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 37788160; Write bytes: 299686912; Read time: 361; Write time: 1176 07:50:52 INFO - Running post-run listener: _upload_blobber_files 07:50:52 INFO - Blob upload gear active. 07:50:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:50:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:50:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:50:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:50:53 INFO - (blobuploader) - INFO - Open directory for files ... 07:50:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:50:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:50:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:50:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:50:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:50:54 INFO - (blobuploader) - INFO - Done attempting. 07:50:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:50:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:50:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:50:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:50:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:50:55 INFO - (blobuploader) - INFO - Done attempting. 07:50:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:50:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:50:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:50:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:50:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:50:56 INFO - (blobuploader) - INFO - Done attempting. 07:50:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:50:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:50:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:50:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:50:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:50:58 INFO - (blobuploader) - INFO - Done attempting. 07:50:58 INFO - (blobuploader) - INFO - Iteration through files over. 07:50:58 INFO - Return code: 0 07:50:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:50:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:50:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8d324a54c9b7fa08c8cc9833b448b6223880d10ecaa112291d2efc1348190cdd1b83c076cc786b99384d24f89f63a0e261bacbcb31a1a2e145705b87876aec46", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/96984c2702028af36eeee29f512db534a460f5c22e8df733b9b91606fb798d83c49ac26391948c85bfe9625fd08f5930f47f1c35f1840710fdb101589198b2f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f8527ac00b455bd7e928acb5b817a76218acc6d4115fd99f40b05b89d610ade018b774cd4814096d1b1cdb53edf2b1d2feb6b6786c07480f15bf841f3b3dee2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/da533e1346eccd3428ad94ecd348b9c5b38ec8cef9cf084f312f61187f0366d8cb49cc16370725fd782b5fb06b314cf5c0780be0c4bb80a61f769ed0dfa16555"} 07:50:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:50:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:50:58 INFO - Contents: 07:50:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8d324a54c9b7fa08c8cc9833b448b6223880d10ecaa112291d2efc1348190cdd1b83c076cc786b99384d24f89f63a0e261bacbcb31a1a2e145705b87876aec46", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/96984c2702028af36eeee29f512db534a460f5c22e8df733b9b91606fb798d83c49ac26391948c85bfe9625fd08f5930f47f1c35f1840710fdb101589198b2f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f8527ac00b455bd7e928acb5b817a76218acc6d4115fd99f40b05b89d610ade018b774cd4814096d1b1cdb53edf2b1d2feb6b6786c07480f15bf841f3b3dee2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/da533e1346eccd3428ad94ecd348b9c5b38ec8cef9cf084f312f61187f0366d8cb49cc16370725fd782b5fb06b314cf5c0780be0c4bb80a61f769ed0dfa16555"} 07:50:58 INFO - Running post-run listener: copy_logs_to_upload_dir 07:50:58 INFO - Copying logs to upload dir... 07:50:58 INFO - mkdir: /builds/slave/test/build/upload/logs 07:50:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.883078 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-02-02 07:50:58.906989) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-02 07:50:58.910643) ========= 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.JIJHtG1KDp/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.p0egPIR2Iw/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8d324a54c9b7fa08c8cc9833b448b6223880d10ecaa112291d2efc1348190cdd1b83c076cc786b99384d24f89f63a0e261bacbcb31a1a2e145705b87876aec46", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/96984c2702028af36eeee29f512db534a460f5c22e8df733b9b91606fb798d83c49ac26391948c85bfe9625fd08f5930f47f1c35f1840710fdb101589198b2f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f8527ac00b455bd7e928acb5b817a76218acc6d4115fd99f40b05b89d610ade018b774cd4814096d1b1cdb53edf2b1d2feb6b6786c07480f15bf841f3b3dee2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/da533e1346eccd3428ad94ecd348b9c5b38ec8cef9cf084f312f61187f0366d8cb49cc16370725fd782b5fb06b314cf5c0780be0c4bb80a61f769ed0dfa16555"} build_url:https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011103 build_url: 'https://queue.taskcluster.net/v1/task/AUGO9vSHSMWlZYgw2ZUqhw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8d324a54c9b7fa08c8cc9833b448b6223880d10ecaa112291d2efc1348190cdd1b83c076cc786b99384d24f89f63a0e261bacbcb31a1a2e145705b87876aec46", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/96984c2702028af36eeee29f512db534a460f5c22e8df733b9b91606fb798d83c49ac26391948c85bfe9625fd08f5930f47f1c35f1840710fdb101589198b2f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f8527ac00b455bd7e928acb5b817a76218acc6d4115fd99f40b05b89d610ade018b774cd4814096d1b1cdb53edf2b1d2feb6b6786c07480f15bf841f3b3dee2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/da533e1346eccd3428ad94ecd348b9c5b38ec8cef9cf084f312f61187f0366d8cb49cc16370725fd782b5fb06b314cf5c0780be0c4bb80a61f769ed0dfa16555"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-02 07:50:58.944130) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 07:50:58.944463) ========= 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.JIJHtG1KDp/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.p0egPIR2Iw/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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.005171 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 07:50:58.992178) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-02 07:50:58.992523) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-02 07:50:58.992843) ========= ========= Total master_lag: 0.17 =========