Hornbeam - Case 7.1.6 : Informational - 723 ms @ 2023-08-10T21:35:51.478Z

Case Description
Send 256K message followed by close then a ping

Case Expectation
Case outcome depends on implementation defined close behavior. Message and close frame are sent back to back. If the close frame is processed before the text message write is complete (as can happen in asynchronous processing models) the close frame is processed first and the text message may not be received or may only be partially recieved.

Case Outcome
Close was processed before text message could be returned.
Expected:
{'OK': [('message', u'Hello World!', False)], 'NON-STRICT': []}
Observed:
[]

Case Closing Behavior
The spec requires the connection to be failed cleanly here (INFORMATIONAL)

## Opening Handshake

    GET /runCase?case=215&agent=Hornbeam HTTP/1.1
    Host: localhost:9001
    Upgrade: websocket
    Connection: upgrade
    Sec-WebSocket-Key: gtuj/GR6WG//yd/VdXUKvg==
    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: 16RmqdfxLEPZBd+4NucYuSPaxhU=

## 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 | False | True, iff I dropped the TCP connection.
wasClean | False | True, iff full WebSocket closing handshake was performed (close frame sent and received) _and_ the server dropped the TCP (which is its responsibility).
wasNotCleanReason | peer dropped the TCP connection without previous WebSocket closing handshake | 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 | 1000 | 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
184 | 1 | 184
7241 | 1 | 7241
23168 | 1 | 23168
46336 | 1 | 46336
56152 | 1 | 56152
63712 | 1 | 63712
65536 | 1 | 65536
Total | 7 | 262329

### Octets Transmitted by Chop Size

Chop Size | Count | Octets
2 | 1 | 2
4 | 1 | 4
14 | 1 | 14
206 | 1 | 206
262154 | 1 | 262154
Total | 5 | 262380

### Frames Received by Opcode

Opcode | Count
Total | 0

### Frames Transmitted by Opcode

Opcode | Count
1 | 2
8 | 1
9 | 1
Total | 4

## Wire Log

    000 RX OCTETS: 474554202f72756e436173653f636173653d323135266167656e743d486f726e6265616d20485454502f312e310d0a486f73

                   743a206c6f63616c686f73743a39 ...

    001 TX OCTETS: 485454502f312e312031303120537769746368696e672050726f746f636f6c730d0a5365727665723a204175746f6261686e

                   5465737453756974652f302e382e ...

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

                   BAsd7&jh23

    003 TX OCTETS: 817f00000000000400004241736437266a6832334241736437266a6832334241736437266a6832334241736437266a683233

                   4241736437266a68323342417364 ...

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

                   Hello World!

    005 TX OCTETS: 810c48656c6c6f20576f726c6421

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

                   0x03e8

    007 TX OCTETS: 880203e8

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

    009 TX OCTETS: 8900

    010 FAIL CONNECTION AFTER 1.000000 sec

    011 RX OCTETS: 81ff0000000000040000e73b58dea57a2bbad01d32b6d5081a9f945f6ff88d536aeda57a2bbad01d32b6d5081a9f945f6ff8

                   8d536aeda57a2bbad01d32b6d508 ...

    012 RX OCTETS: b6d5081a9f945f6ff88d536aeda57a2bbad01d32b6d5081a9f945f6ff88d536aeda57a2bbad01d32b6d5081a9f945f6ff88d

                   536aeda57a2bbad01d32b6d5081a ...

    013 RX OCTETS: f88d536aeda57a2bbad01d32b6d5081a9f945f6ff88d536aeda57a2bbad01d32b6d5081a9f945f6ff88d536aeda57a2bbad0

                   1d32b6d5081a9f945f6ff88d536a ...

    014 RX OCTETS: 9f945f6ff88d536aeda57a2bbad01d32b6d5081a9f945f6ff88d536aeda57a2bbad01d32b6d5081a9f945f6ff88d536aeda5

                   7a2bbad01d32b6d5081a9f945f6f ...

    015 RX OCTETS: bad01d32b6d5081a9f945f6ff88d536aeda57a2bbad01d32b6d5081a9f945f6ff88d536aeda57a2bbad01d32b6d5081a9f94

                   5f6ff88d536aeda57a2bbad01d32 ...

    016 RX OCTETS: eda57a2bbad01d32b6d5081a9f945f6ff88d536aeda57a2bbad01d32b6d5081a9f945f6ff88d536aeda57a2bbad01d32b6d5

                   081a9f945f6ff88d536aeda57a2b ...

    017 TCP DROPPED BY PEER