lluv-websocket - Case 6.4.3 : Fail - 2000 ms @ 2016-03-22T16:32:43.827Z
Case Description
Same as Case 6.4.1, but we send message not in 3 frames, but in 3 chops of the same message frame.
MESSAGE PARTS:
PART1 = cebae1bdb9cf83cebcceb5
PART2 = f4908080
PART3 = 656469746564
Case Expectation
The first chop is accepted, we expect to timeout on the first wait. The 2nd chop should be rejected immediately (fail fast on UTF-8). If we timeout, we expect the connection is failed at least then, since the complete message payload is not valid UTF-8.
Case Outcome
Actual events differ from any expected.
Expected:
{'NON-STRICT': [('timeout', 'A'), ('timeout', 'B')], 'OK': [('timeout', 'A')]}
Observed:
[('timeout', 'A'), ('timeout', 'B')]
Case Closing Behavior
Connection was properly closed (OK)
GET /runCase?case=76&agent=lluv-websocket HTTP/1.1 Host: 127.0.0.1:9001 Upgrade: websocket Connection: Upgrade Sec-WebSocket-Key: DuKdxQpMFJgLJLZJCJkxMg== Sec-WebSocket-Version: 13 Sec-WebSocket-Protocol: echo Sec-WebSocket-Extensions: permessage-deflate; client_max_window_bits
HTTP/1.1 101 Switching Protocols Server: AutobahnTestSuite/0.7.1-0.10.0 Upgrade: WebSocket Connection: Upgrade Sec-WebSocket-Accept: AuTXvesjZ7Er5N6PTMad92qb3gw=
Key | Value | Description |
isServer | True | True, iff I (the fuzzer) am a server, and the peer is a client. |
closedByMe | False | 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 WebSockets 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 | 1000 | The close code I sent in close frame (if any). |
localCloseReason | None | The close reason I sent in close frame (if any). |
remoteCloseCode | 1007 | The close code the peer sent me in close frame (if any). |
remoteCloseReason | Invalid UTF8 character | The close reason the peer sent me in close frame (if any). |
Chop Size | Count | Octets |
30 | 1 | 30 |
289 | 1 | 289 |
Total | 2 | 319 |
Chop Size | Count | Octets |
2 | 2 | 4 |
4 | 2 | 8 |
6 | 1 | 6 |
11 | 1 | 11 |
169 | 1 | 169 |
Total | 7 | 198 |
Opcode | Count |
8 | 1 |
Total | 1 |
Opcode | Count |
0 | 1 |
8 | 1 |
Total | 2 |
000 RX OCTETS: 474554202f72756e436173653f636173653d3736266167656e743d6c6c75762d776562736f636b657420485454502f312e31
0d0a486f73743a203132372e302e ...
001 TX OCTETS: 485454502f312e312031303120537769746368696e672050726f746f636f6c730d0a5365727665723a204175746f6261686e
5465737453756974652f302e372e ...
002 TX OCTETS: 0115
003 TX OCTETS: cebae1bdb9cf83cebcceb5
004 DELAY 1.000000 sec for TAG A
005 DELAY TIMEOUT on TAG A
006 TX OCTETS: f4908080
007 DELAY 1.000000 sec for TAG B
008 DELAY TIMEOUT on TAG B
009 TX OCTETS: 656469746564
010 TX FRAME : OPCODE=0, FIN=True, RSV=0, PAYLOAD-LEN=0, MASK=None, PAYLOAD-REPEAT-LEN=None, CHOPSIZE=None, SYNC=False
011 TX OCTETS: 8000
012 FAIL CONNECTION AFTER 1.000000 sec
013 RX OCTETS: 8898c8f0b08fcb1ff9e1be91dce6acd0e5db8ec890eca091c2eeab84d5fd
014 RX FRAME : OPCODE=8, FIN=True, RSV=0, PAYLOAD-LEN=24, MASKED=True, MASK=6338663062303866
0x03ef496e76616c6964205554463820636861726163746572
015 TX FRAME : OPCODE=8, FIN=True, RSV=0, PAYLOAD-LEN=2, MASK=None, PAYLOAD-REPEAT-LEN=None, CHOPSIZE=None, SYNC=False
0x03e8
016 TX OCTETS: 880203e8
017 TCP DROPPED BY ME