Hornbeam - Case 2.11 : Fail - 3004 ms @ 2023-08-10T21:34:57.118Z

Case Description
Send 10 Pings with payload. Send out octets in octet-wise chops.

Case Expectation
Pongs for our Pings with all the payloads. Note: This is not required by the Spec .. but we check for this behaviour anyway. Clean close with normal code.

Case Outcome
Actual events differ from any expected.
Expected:
{'OK': [('pong', u'payload-0'), ('pong', u'payload-1'), ('pong', u'payload-2'), ('pong', u'payload-3'), ('pong', u'payload-4'), ('pong', u'payload-5'), ('pong', u'payload-6'), ('pong', u'payload-7'), ('pong', u'payload-8'), ('pong', u'payload-9')]}
Observed:
[]

Case Closing Behavior
Connection was properly closed (OK)

## Opening Handshake

    GET /runCase?case=27&agent=Hornbeam HTTP/1.1
    Host: localhost:9001
    Upgrade: websocket
    Connection: upgrade
    Sec-WebSocket-Key: CqDP2JS6VLKQiqPDk1rmtg==
    Sec-WebSocket-Version: 13

    HTTP/1.1 101 Switching Protocols
    Server: AutobahnTestSuite/0.8.2-0.10.9
    X-Powered-By: AutobahnPython/0.10.9
    Upgrade: WebSocket
    Connection: Upgrade
    Sec-WebSocket-Accept: 1s+Zltac/uOyGZTv+nnKnxCHRvI=

## Closing Behavior

Key | Value | Description
isServer | True | True, iff I (the fuzzer) am a server, and the peer is a client.
closedByMe | True | True, iff I have initiated closing handshake (that is, did send close first).
failedByMe | False | True, iff I have failed the WS connection (i.e. due to protocol error). Failing can be either by initiating closing handshake or brutal drop TCP.
droppedByMe | True | True, iff I dropped the TCP connection.
wasClean | True | True, iff full WebSocket closing handshake was performed (close frame sent and received) _and_ the server dropped the TCP (which is its responsibility).
wasNotCleanReason | None | When wasClean == False, the reason what happened.
wasServerConnectionDropTimeout | False | When we are a client, and we expected the server to drop the TCP, but that didn't happen in time, this gets True.
wasOpenHandshakeTimeout | False | When performing the opening handshake, but the peer did not finish in time, this gets True.
wasCloseHandshakeTimeout | False | When we initiated a closing handshake, but the peer did not respond in time, this gets True.
localCloseCode | None | The close code I sent in close frame (if any).
localCloseReason | None | The close reason I sent in close frame (if any).
remoteCloseCode | None | The close code the peer sent me in close frame (if any).
remoteCloseReason | None | The close reason the peer sent me in close frame (if any).

## Wire Statistics

### Octets Received by Chop Size

Chop Size | Count | Octets
6 | 1 | 6
183 | 1 | 183
Total | 2 | 189

### Octets Transmitted by Chop Size

Chop Size | Count | Octets
1 | 110 | 110
2 | 1 | 2
206 | 1 | 206
Total | 112 | 318

### Frames Received by Opcode

Opcode | Count
8 | 1
Total | 1

### Frames Transmitted by Opcode

Opcode | Count
8 | 1
9 | 10
Total | 11

## Wire Log

    000 RX OCTETS: 474554202f72756e436173653f636173653d3237266167656e743d486f726e6265616d20485454502f312e310d0a486f7374

                   3a206c6f63616c686f73743a3930 ...

    001 TX OCTETS: 485454502f312e312031303120537769746368696e672050726f746f636f6c730d0a5365727665723a204175746f6261686e

                   5465737453756974652f302e382e ...

    002 TX FRAME : OPCODE=9, FIN=True, RSV=0, PAYLOAD-LEN=9, MASK=None, PAYLOAD-REPEAT-LEN=None, CHOPSIZE=1, SYNC=False

                   payload-0

    003 TX OCTETS: 89

    004 TX FRAME : OPCODE=9, FIN=True, RSV=0, PAYLOAD-LEN=9, MASK=None, PAYLOAD-REPEAT-LEN=None, CHOPSIZE=1, SYNC=False

                   payload-1

    005 TX FRAME : OPCODE=9, FIN=True, RSV=0, PAYLOAD-LEN=9, MASK=None, PAYLOAD-REPEAT-LEN=None, CHOPSIZE=1, SYNC=False

                   payload-2

    006 TX FRAME : OPCODE=9, FIN=True, RSV=0, PAYLOAD-LEN=9, MASK=None, PAYLOAD-REPEAT-LEN=None, CHOPSIZE=1, SYNC=False

                   payload-3

    007 TX FRAME : OPCODE=9, FIN=True, RSV=0, PAYLOAD-LEN=9, MASK=None, PAYLOAD-REPEAT-LEN=None, CHOPSIZE=1, SYNC=False

                   payload-4

    008 TX FRAME : OPCODE=9, FIN=True, RSV=0, PAYLOAD-LEN=9, MASK=None, PAYLOAD-REPEAT-LEN=None, CHOPSIZE=1, SYNC=False

                   payload-5

    009 TX FRAME : OPCODE=9, FIN=True, RSV=0, PAYLOAD-LEN=9, MASK=None, PAYLOAD-REPEAT-LEN=None, CHOPSIZE=1, SYNC=False

                   payload-6

    010 TX FRAME : OPCODE=9, FIN=True, RSV=0, PAYLOAD-LEN=9, MASK=None, PAYLOAD-REPEAT-LEN=None, CHOPSIZE=1, SYNC=False

                   payload-7

    011 TX FRAME : OPCODE=9, FIN=True, RSV=0, PAYLOAD-LEN=9, MASK=None, PAYLOAD-REPEAT-LEN=None, CHOPSIZE=1, SYNC=False

                   payload-8

    012 TX FRAME : OPCODE=9, FIN=True, RSV=0, PAYLOAD-LEN=9, MASK=None, PAYLOAD-REPEAT-LEN=None, CHOPSIZE=1, SYNC=False

                   payload-9

    013 CLOSE CONNECTION AFTER 3.000000 sec

    014 TX OCTETS: 09

    015 TX OCTETS: 70

    016 TX OCTETS: 61

    017 TX OCTETS: 79

    018 TX OCTETS: 6c

    019 TX OCTETS: 6f

    020 TX OCTETS: 61

    021 TX OCTETS: 64

    022 TX OCTETS: 2d

    023 TX OCTETS: 30

    024 TX OCTETS: 89

    025 TX OCTETS: 09

    026 TX OCTETS: 70

    027 TX OCTETS: 61

    028 TX OCTETS: 79

    029 TX OCTETS: 6c

    030 TX OCTETS: 6f

    031 TX OCTETS: 61

    032 TX OCTETS: 64

    033 TX OCTETS: 2d

    034 TX OCTETS: 31

    035 TX OCTETS: 89

    036 TX OCTETS: 09

    037 TX OCTETS: 70

    038 TX OCTETS: 61

    039 TX OCTETS: 79

    040 TX OCTETS: 6c

    041 TX OCTETS: 6f

    042 TX OCTETS: 61

    043 TX OCTETS: 64

    044 TX OCTETS: 2d

    045 TX OCTETS: 32

    046 TX OCTETS: 89

    047 TX OCTETS: 09

    048 TX OCTETS: 70

    049 TX OCTETS: 61

    050 TX OCTETS: 79

    051 TX OCTETS: 6c

    052 TX OCTETS: 6f

    053 TX OCTETS: 61

    054 TX OCTETS: 64

    055 TX OCTETS: 2d

    056 TX OCTETS: 33

    057 TX OCTETS: 89

    058 TX OCTETS: 09

    059 TX OCTETS: 70

    060 TX OCTETS: 61

    061 TX OCTETS: 79

    062 TX OCTETS: 6c

    063 TX OCTETS: 6f

    064 TX OCTETS: 61

    065 TX OCTETS: 64

    066 TX OCTETS: 2d

    067 TX OCTETS: 34

    068 TX OCTETS: 89

    069 TX OCTETS: 09

    070 TX OCTETS: 70

    071 TX OCTETS: 61

    072 TX OCTETS: 79

    073 TX OCTETS: 6c

    074 TX OCTETS: 6f

    075 TX OCTETS: 61

    076 TX OCTETS: 64

    077 TX OCTETS: 2d

    078 TX OCTETS: 35

    079 TX OCTETS: 89

    080 TX OCTETS: 09

    081 TX OCTETS: 70

    082 TX OCTETS: 61

    083 TX OCTETS: 79

    084 TX OCTETS: 6c

    085 TX OCTETS: 6f

    086 TX OCTETS: 61

    087 TX OCTETS: 64

    088 TX OCTETS: 2d

    089 TX OCTETS: 36

    090 TX OCTETS: 89

    091 TX OCTETS: 09

    092 TX OCTETS: 70

    093 TX OCTETS: 61

    094 TX OCTETS: 79

    095 TX OCTETS: 6c

    096 TX OCTETS: 6f

    097 TX OCTETS: 61

    098 TX OCTETS: 64

    099 TX OCTETS: 2d

    100 TX OCTETS: 37

    101 TX OCTETS: 89

    102 TX OCTETS: 09

    103 TX OCTETS: 70

    104 TX OCTETS: 61

    105 TX OCTETS: 79

    106 TX OCTETS: 6c

    107 TX OCTETS: 6f

    108 TX OCTETS: 61

    109 TX OCTETS: 64

    110 TX OCTETS: 2d

    111 TX OCTETS: 38

    112 TX OCTETS: 89

    113 TX OCTETS: 09

    114 TX OCTETS: 70

    115 TX OCTETS: 61

    116 TX OCTETS: 79

    117 TX OCTETS: 6c

    118 TX OCTETS: 6f

    119 TX OCTETS: 61

    120 TX OCTETS: 64

    121 TX OCTETS: 2d

    122 TX OCTETS: 39

    123 CLOSING CONNECTION

    124 TX FRAME : OPCODE=8, FIN=True, RSV=0, PAYLOAD-LEN=0, MASK=None, PAYLOAD-REPEAT-LEN=None, CHOPSIZE=None, SYNC=False

    125 TX OCTETS: 8800

    126 RX OCTETS: 8880ac1cf067

    127 RX FRAME : OPCODE=8, FIN=True, RSV=0, PAYLOAD-LEN=0, MASKED=True, MASK=6163316366303637

    128 TCP DROPPED BY ME