[0000.709|0000.000] Info: Minimum real time factor is set to 1.
[0000.709|0000.000] Info: Simulation will guarantee a maximum 1.00x speed for each time step.
[0001.977|0000.000] Info: Spawned RED_PLAYER_1 RoboCup_GankenKun on port 10001 at halfTimeStartingPose: translation (3.5 -3.1 0.439), rotation (0 0 1 1.571592653589793).
[0002.566|0000.000] Info: Spawned RED_PLAYER_2 RoboCup_GankenKun on port 10002 at halfTimeStartingPose: translation (3.5 3.1 0.439), rotation (0 0 1 4.711592653589793).
[0003.162|0000.000] Info: Spawned RED_PLAYER_3 RoboCup_GankenKun on port 10003 at halfTimeStartingPose: translation (2.5 -3.1 0.439), rotation (0 0 1 1.571592653589793).
[0016.610|0000.000] Info: Spawned BLUE_PLAYER_1 WolfgangRobocup on port 10021 at halfTimeStartingPose: translation (-3.6 -3.2 0.43), rotation (0 0 -1 -1.57).
[0029.643|0000.000] Info: Spawned BLUE_PLAYER_2 WolfgangRobocup on port 10022 at halfTimeStartingPose: translation (-1.6 3.2 0.43), rotation (0 0 1 -1.57).
[0042.697|0000.000] Info: Spawned BLUE_PLAYER_3 WolfgangRobocup on port 10023 at halfTimeStartingPose: translation (-1.6 -3.2 0.43), rotation (0 0 -1 -1.57).
[0042.955|0000.000] Info: Connected to GameControllerSimulator at localhost:8750.
[0042.955|0000.000] Info: Game type is KNOCKOUT.
[0042.955|0000.000] Info: Red team is "CIT Brains", playing on right side.
[0042.955|0000.000] Info: Blue team is "Bit-Bots", playing on left side.
[0042.955|0000.000] Info: Sending 1:SIDE_LEFT:7 to GameController.
[0042.955|0000.000] Info: Waiting for GameController to answer to 1:SIDE_LEFT:7.
[0043.155|0000.000] Info: Waiting for GameController to answer to 1:SIDE_LEFT:7.
[0043.356|0000.000] Info: Waiting for GameController to answer to 1:SIDE_LEFT:7.
[0043.557|0000.000] Info: New state received from GameController: STATE_INITIAL.
[0043.557|0000.000] Info: State has succesfully changed to INITIAL
[0043.557|0000.000] Info: New secondary state received from GameController: STATE_NORMAL, phase 0.
[0043.560|0000.000] Info: Regular start: Waiting 120 seconds (real-time) before going to READY
[0043.560|0000.000] Info: Kick-off is red.
[0043.561|0000.000] Info: Moved ball out of the field temporarily
[0043.561|0000.000] Info: Ball not in play, will be kicked by a player from the red team.
[0043.561|0000.000] Info: Sending 5:KICKOFF:4 to GameController.
[0043.561|0000.000] Info: Waiting for GameController to answer to 5:KICKOFF:4.
[0043.761|0000.000] Info: Waiting for GameController to answer to 5:KICKOFF:4.
[0065.894|0001.712] Info: STATUS: Avg speed factor: 0.085 (over last 20.10 seconds)
[0065.894|0001.712] Info: STATUS: state: STATE_INITIAL, remaining time: 15
[0085.956|0003.472] Info: STATUS: Avg speed factor: 0.088 (over last 20.06 seconds)
[0085.956|0003.472] Info: STATUS: state: STATE_INITIAL, remaining time: 15
[0106.076|0005.232] Info: STATUS: Avg speed factor: 0.087 (over last 20.12 seconds)
[0106.076|0005.232] Info: STATUS: state: STATE_INITIAL, remaining time: 15
[0126.100|0007.000] Info: STATUS: Avg speed factor: 0.088 (over last 20.02 seconds)
[0126.100|0007.000] Info: STATUS: state: STATE_INITIAL, remaining time: 15
[0146.112|0008.784] Info: STATUS: Avg speed factor: 0.089 (over last 20.01 seconds)
[0146.112|0008.784] Info: STATUS: state: STATE_INITIAL, remaining time: 15
[0163.577|0010.352] Info: Real-time to wait elasped, moving to READY
[0163.577|0010.352] Info: Sending 1303:STATE:READY to GameController.
[0163.577|0010.352] Info: Waiting for GameController to answer to 1303:STATE:READY.
[0163.777|0010.352] Info: Waiting for GameController to answer to 1303:STATE:READY.
[0163.977|0010.352] Info: Waiting for GameController to answer to 1303:STATE:READY.
[0164.289|0010.352] Info: New state received from GameController: STATE_READY.
[0164.290|0010.352] Info: State has succesfully changed to READY
[0166.133|0010.512] Info: STATUS: Avg speed factor: 0.086 (over last 20.02 seconds)
[0166.134|0010.512] Info: STATUS: state: STATE_READY, remaining time: 15
[0186.166|0012.328] Info: STATUS: Avg speed factor: 0.091 (over last 20.03 seconds)
[0186.166|0012.328] Info: STATUS: state: STATE_READY, remaining time: 15
[0206.219|0014.032] Info: STATUS: Avg speed factor: 0.085 (over last 20.05 seconds)
[0206.219|0014.032] Info: STATUS: state: STATE_READY, remaining time: 15
[0226.310|0015.784] Info: STATUS: Avg speed factor: 0.087 (over last 20.09 seconds)
[0226.310|0015.784] Info: STATUS: state: STATE_READY, remaining time: 15
[0246.362|0017.512] Info: STATUS: Avg speed factor: 0.086 (over last 20.05 seconds)
[0246.362|0017.512] Info: STATUS: state: STATE_READY, remaining time: 15
[0266.404|0019.264] Info: STATUS: Avg speed factor: 0.087 (over last 20.04 seconds)
[0266.404|0019.264] Info: STATUS: state: STATE_READY, remaining time: 15
[0286.504|0021.064] Info: STATUS: Avg speed factor: 0.090 (over last 20.10 seconds)
[0286.504|0021.064] Info: STATUS: state: STATE_READY, remaining time: 15
[0306.507|0022.952] Info: STATUS: Avg speed factor: 0.094 (over last 20.00 seconds)
[0306.507|0022.952] Info: STATUS: state: STATE_READY, remaining time: 15
[0326.557|0024.752] Info: STATUS: Avg speed factor: 0.090 (over last 20.05 seconds)
[0326.557|0024.752] Info: STATUS: state: STATE_READY, remaining time: 15
[0346.608|0026.520] Info: STATUS: Avg speed factor: 0.088 (over last 20.05 seconds)
[0346.608|0026.520] Info: STATUS: state: STATE_READY, remaining time: 15
[0366.634|0028.224] Info: STATUS: Avg speed factor: 0.085 (over last 20.03 seconds)
[0366.634|0028.224] Info: STATUS: state: STATE_READY, remaining time: 15
[0386.668|0029.968] Info: STATUS: Avg speed factor: 0.087 (over last 20.03 seconds)
[0386.668|0029.968] Info: STATUS: state: STATE_READY, remaining time: 15
[0406.726|0031.664] Info: STATUS: Avg speed factor: 0.085 (over last 20.06 seconds)
[0406.726|0031.664] Info: STATUS: state: STATE_READY, remaining time: 15
[0426.757|0033.264] Info: STATUS: Avg speed factor: 0.080 (over last 20.03 seconds)
[0426.757|0033.264] Info: STATUS: state: STATE_READY, remaining time: 15
[0437.072|0034.072] Info: Blue player 3 has fallen down.
[0445.164|0034.648] Info: Blue player 3 just recovered after 0.5 seconds.
[0446.770|0034.768] Info: STATUS: Avg speed factor: 0.075 (over last 20.01 seconds)
[0446.770|0034.768] Info: STATUS: state: STATE_READY, remaining time: 15
[0449.243|0034.976] Info: Blue player 3 has fallen down.
[0466.819|0035.872] Info: STATUS: Avg speed factor: 0.055 (over last 20.05 seconds)
[0466.819|0035.872] Info: STATUS: state: STATE_READY, remaining time: 15
[0484.893|0037.064] Info: Blue player 3 just recovered after 2.0 seconds.
[0486.819|0037.184] Info: STATUS: Avg speed factor: 0.066 (over last 20.00 seconds)
[0486.819|0037.184] Info: STATUS: state: STATE_READY, remaining time: 15
[0492.175|0037.664] Info: Blue player 3 has fallen down.
[0506.826|0038.832] Info: STATUS: Avg speed factor: 0.082 (over last 20.01 seconds)
[0506.826|0038.832] Info: STATUS: state: STATE_READY, remaining time: 15
[0514.200|0039.472] Info: Blue player 3 just recovered after 1.8 seconds.
[0526.882|0040.600] Info: STATUS: Avg speed factor: 0.088 (over last 20.06 seconds)
[0526.882|0040.600] Info: STATUS: state: STATE_READY, remaining time: 15
[0546.896|0042.376] Info: STATUS: Avg speed factor: 0.089 (over last 20.01 seconds)
[0546.896|0042.376] Info: STATUS: state: STATE_READY, remaining time: 15
[0566.902|0044.144] Info: STATUS: Avg speed factor: 0.088 (over last 20.01 seconds)
[0566.902|0044.144] Info: STATUS: state: STATE_READY, remaining time: 15
[0586.930|0045.912] Info: STATUS: Avg speed factor: 0.088 (over last 20.03 seconds)
[0586.930|0045.912] Info: STATUS: state: STATE_READY, remaining time: 15
[0606.990|0047.688] Info: STATUS: Avg speed factor: 0.089 (over last 20.06 seconds)
[0606.990|0047.688] Info: STATUS: state: STATE_READY, remaining time: 15
[0627.034|0049.496] Info: STATUS: Avg speed factor: 0.090 (over last 20.04 seconds)
[0627.034|0049.496] Info: STATUS: state: STATE_READY, remaining time: 15
[0647.086|0051.304] Info: STATUS: Avg speed factor: 0.090 (over last 20.05 seconds)
[0647.086|0051.304] Info: STATUS: state: STATE_READY, remaining time: 15
[0667.152|0053.104] Info: STATUS: Avg speed factor: 0.090 (over last 20.07 seconds)
[0667.152|0053.104] Info: STATUS: state: STATE_READY, remaining time: 15
[0687.180|0054.872] Info: STATUS: Avg speed factor: 0.088 (over last 20.03 seconds)
[0687.180|0054.872] Info: STATUS: state: STATE_READY, remaining time: 15
[0693.282|0055.408] Info: New state received from GameController: STATE_SET.
[0693.291|0055.408] Info: Waiting for classic play
[0693.291|0055.408] Info: Ball respawned at 0 0 0.07.
[0707.200|0056.680] Info: STATUS: Avg speed factor: 0.090 (over last 20.02 seconds)
[0707.200|0056.680] Info: STATUS: state: STATE_SET, remaining time: 15
[0727.222|0058.440] Info: STATUS: Avg speed factor: 0.088 (over last 20.02 seconds)
[0727.222|0058.440] Info: STATUS: state: STATE_SET, remaining time: 15
[0747.250|0060.216] Info: STATUS: Avg speed factor: 0.089 (over last 20.03 seconds)
[0747.250|0060.216] Info: STATUS: state: STATE_SET, remaining time: 15
[0749.427|0060.408] Info: Sending 7564:STATE:PLAY to GameController.
[0749.427|0060.408] Info: Waiting for GameController to answer to 7564:STATE:PLAY.
[0749.628|0060.408] Info: Waiting for GameController to answer to 7564:STATE:PLAY.
[0749.829|0060.408] Info: New state received from GameController: STATE_PLAYING.
[0749.829|0060.408] Info: State has succesfully changed to PLAYING
[0767.288|0061.952] Info: STATUS: Avg speed factor: 0.087 (over last 20.04 seconds)
[0767.288|0061.952] Info: STATUS: state: STATE_PLAYING, remaining time: 14
[0787.382|0063.816] Info: STATUS: Avg speed factor: 0.093 (over last 20.09 seconds)
[0787.382|0063.816] Info: STATUS: state: STATE_PLAYING, remaining time: 12
[0807.402|0065.576] Info: STATUS: Avg speed factor: 0.088 (over last 20.02 seconds)
[0807.402|0065.576] Info: STATUS: state: STATE_PLAYING, remaining time: 10
[0810.014|0065.808] Info: Red team (['2']) is holding the ball.
[0810.314|0065.832] Info: Ball kicked by red player 2.
[0810.366|0065.840] Info: Red team released the ball after 0.0 seconds.
[0810.483|0065.856] Info: [0, 0, 0.07] [-0.06637585463785722, 0.014831804697565445, 0.09459393272537141]
[0810.483|0065.856] Info: Ball in play, can be touched by any player (moved by 6.80 cm).
[0815.680|0066.336] Info: The ball has left the center circle after kick-off.
[0827.444|0067.416] Info: STATUS: Avg speed factor: 0.092 (over last 20.04 seconds)
[0827.444|0067.416] Info: STATUS: state: STATE_PLAYING, remaining time: 9
[0847.545|0069.192] Info: STATUS: Avg speed factor: 0.088 (over last 20.10 seconds)
[0847.545|0069.192] Info: STATUS: state: STATE_PLAYING, remaining time: 7
[0863.617|0070.664] Info: 70664: contact between red player 2 and blue player 2.
[0863.617|0070.664] Info: Check if red 2 is performing a foul on blue 2
[0863.617|0070.664] Info: red 2 : at [-0.77  0.16  0.32], dist to ball: 0.63
[0863.617|0070.664] Info: blue 2: at [-0.99 -0.02  0.39], dist to ball: 0.51
[0863.617|0070.664] Info: red 2 : velocity: [-0.26  0.03 -0.00], speed: 0.26
[0863.617|0070.664] Info: blue 2: velocity: [-0.00 -0.02  0.00], speed: 0.02
[0863.617|0070.664] Info: red 2 is close to the ball (0.63 < 2)
[0863.617|0070.664] Info: blue 2 is significantly closer to the ball than red 2: (0.12 < 0.1)
[0863.617|0070.664] Info: Red player 2 committed a forceful contact foul on blue player 2 (opponent moving towards the ball, charge from behind) outside penalty area.
[0863.617|0070.664] Info: Ball in play: 65856, foul far from ball: False
[0863.617|0070.664] Info: Interruption countdown set to 625
[0863.617|0070.664] Info: Ball not in play, will be kicked by a player from the blue team.
[0863.617|0070.664] Info: Direct free kick awarded to blue team.
[0863.617|0070.664] Info: Waiting for secondary state: DIRECT_FREEKICK:0
[0863.617|0070.664] Info: Sending 8849:DIRECT_FREEKICK:7 to GameController.
[0863.617|0070.664] Info: Waiting for GameController to answer to 8849:DIRECT_FREEKICK:7.
[0863.817|0070.664] Info: Waiting for GameController to answer to 8849:DIRECT_FREEKICK:7.
[0864.018|0070.664] Info: Waiting for GameController to answer to 8849:DIRECT_FREEKICK:7.
[0864.817|0070.664] Info: New secondary state received from GameController: STATE_DIRECT_FREEKICK, phase 0.
[0864.817|0070.664] Info: State has succesfully changed to STATE_DIRECT_FREEKICK:0
[0864.817|0070.664] Info: Awarding a direct free kick.
[0867.583|0070.880] Info: STATUS: Avg speed factor: 0.084 (over last 20.04 seconds)
[0867.583|0070.880] Info: STATUS: state: STATE_PLAYING, remaining time: 5
[0887.641|0072.168] Info: STATUS: Avg speed factor: 0.064 (over last 20.06 seconds)
[0887.641|0072.168] Info: STATUS: state: STATE_PLAYING, remaining time: 5
[0907.707|0073.344] Info: STATUS: Avg speed factor: 0.059 (over last 20.07 seconds)
[0907.707|0073.344] Info: STATUS: state: STATE_PLAYING, remaining time: 5
[0927.813|0074.520] Info: STATUS: Avg speed factor: 0.058 (over last 20.11 seconds)
[0927.813|0074.520] Info: STATUS: state: STATE_PLAYING, remaining time: 5
[0946.408|0075.656] Info: GI placing ball to [-0.7712305514654197, 0.1643966581233799, 0]
[0946.408|0075.656] Info: Reset of penalized robots
[0946.408|0075.656] Info: Penalizing fallen robots
[0946.408|0075.656] Info: Finding alternative locations
[0946.408|0075.656] Info: Testing alternative location: [-0.27123055  0.16439666  0.        ]
[0946.408|0075.656] Info: Set alternative location to: [-0.27123055  0.16439666  0.        ]
[0946.408|0075.656] Info: Ball respawned at -0.27123055146541974 0.1643966581233799 0.07.
[0946.408|0075.656] Info: Waiting for secondary state: DIRECT_FREEKICK:1
[0946.408|0075.656] Info: Sending 9477:DIRECT_FREEKICK:7:READY to GameController.
[0946.408|0075.656] Info: Waiting for GameController to answer to 9477:DIRECT_FREEKICK:7:READY.
[0946.609|0075.656] Info: Waiting for GameController to answer to 9477:DIRECT_FREEKICK:7:READY.
[0947.376|0075.656] Info: New secondary state received from GameController: STATE_DIRECT_FREEKICK, phase 1.
[0947.376|0075.656] Info: State has succesfully changed to STATE_DIRECT_FREEKICK:1
[0947.472|0075.664] Info: 75664: contact between red player 2 and blue player 2.
[0947.833|0075.688] Info: STATUS: Avg speed factor: 0.058 (over last 20.02 seconds)
[0947.833|0075.688] Info: STATUS: state: STATE_PLAYING, remaining time: 5
[0951.566|0075.912] Info: 75912: contact between red player 2 and blue player 2.
[0954.818|0076.112] Info: 76112: contact between red player 2 and blue player 2.
[0957.518|0076.352] Info: 76352: contact between red player 2 and blue player 2.
[0957.923|0076.376] Info: 76376: contact between red player 2 and blue player 2.
[0960.780|0076.576] Info: 76576: contact between red player 2 and blue player 2.
[0961.124|0076.600] Info: 76600: contact between red player 2 and blue player 2.
[0963.835|0076.784] Info: 76784: contact between red player 2 and blue player 2.
[0965.691|0076.912] Info: 76912: contact between red player 2 and blue player 2.
[0966.033|0076.936] Info: 76936: contact between red player 2 and blue player 2.
[0967.930|0077.064] Info: STATUS: Avg speed factor: 0.068 (over last 20.10 seconds)
[0967.930|0077.064] Info: STATUS: state: STATE_PLAYING, remaining time: 5
[0969.906|0077.232] Info: 77232: contact between red player 2 and blue player 2.
[0970.023|0077.240] Info: Check if blue 2 is performing a foul on red 2
[0970.023|0077.240] Info: blue 2: at [-0.99 -0.02  0.39], dist to ball: 0.74
[0970.023|0077.240] Info: red 2 : at [-0.74  0.15  0.32], dist to ball: 0.47
[0970.023|0077.240] Info: Pushing time: 1.008 > 1 over the last 2
[0970.023|0077.240] Info: Difference of distance: 0.27329211191638336 > 0.1
[0970.023|0077.240] Info: Blue player 2 committed a forceful contact foul on red player 2 (long_collision) outside penalty area.
[0970.023|0077.240] Info: Ball in play: None, foul far from ball: False
[0970.023|0077.240] Info: Sending 9678:PENALTY:7:2:PHYSICAL_CONTACT to GameController.
[0970.023|0077.240] Info: Waiting for GameController to answer to 9678:PENALTY:7:2:PHYSICAL_CONTACT.
[0970.224|0077.240] Info: Waiting for GameController to answer to 9678:PENALTY:7:2:PHYSICAL_CONTACT.
[0970.424|0077.240] Info: Waiting for GameController to answer to 9678:PENALTY:7:2:PHYSICAL_CONTACT.
[0970.624|0077.240] Info: Waiting for GameController to answer to 9678:PENALTY:7:2:PHYSICAL_CONTACT.
[0970.825|0077.240] Info: placing player blue 2 at [-3, -3.2, 0.43]
[0970.825|0077.240] Info: -> pos: [-3, -3.2, 0.43]
[0970.874|0077.240] Info: Blue player 2 reset to None: translation (-3 -3.2 0.43), rotation (0.0 0.0 1.0 1.571592653589793).
[0970.874|0077.240] Info: Disabling actuators of blue player 2.
[0970.874|0077.240] Info: PHYSICAL_CONTACT penalty for blue player 2: forceful contact foul.
[0971.385|0077.288] Info: Stabilizing blue player 2
[0987.945|0078.864] Info: STATUS: Avg speed factor: 0.090 (over last 20.01 seconds)
[0987.945|0078.864] Info: STATUS: state: STATE_PLAYING, remaining time: 5
[1007.959|0080.872] Info: STATUS: Avg speed factor: 0.100 (over last 20.01 seconds)
[1007.959|0080.872] Info: STATUS: state: STATE_PLAYING, remaining time: 5
[1027.975|0082.872] Info: STATUS: Avg speed factor: 0.100 (over last 20.02 seconds)
[1027.975|0082.872] Info: STATUS: state: STATE_PLAYING, remaining time: 5
[1048.032|0084.936] Info: STATUS: Avg speed factor: 0.103 (over last 20.06 seconds)
[1048.032|0084.936] Info: STATUS: state: STATE_PLAYING, remaining time: 5
[1068.074|0086.928] Info: STATUS: Avg speed factor: 0.099 (over last 20.04 seconds)
[1068.074|0086.928] Info: STATUS: state: STATE_PLAYING, remaining time: 5
[1088.095|0089.000] Info: STATUS: Avg speed factor: 0.103 (over last 20.02 seconds)
[1088.095|0089.000] Info: STATUS: state: STATE_PLAYING, remaining time: 5
[1105.593|0090.704] Info: Waiting for secondary state: DIRECT_FREEKICK:2
[1105.593|0090.704] Info: Sending 11366:DIRECT_FREEKICK:7:PREPARE to GameController.
[1105.593|0090.704] Info: Waiting for GameController to answer to 11366:DIRECT_FREEKICK:7:PREPARE.
[1105.793|0090.704] Info: Waiting for GameController to answer to 11366:DIRECT_FREEKICK:7:PREPARE.
[1105.994|0090.704] Info: Waiting for GameController to answer to 11366:DIRECT_FREEKICK:7:PREPARE.
[1106.194|0090.704] Info: Waiting for GameController to answer to 11366:DIRECT_FREEKICK:7:PREPARE.
[1106.997|0090.704] Info: New secondary state received from GameController: STATE_DIRECT_FREEKICK, phase 2.
[1106.998|0090.704] Info: State has succesfully changed to STATE_DIRECT_FREEKICK:2
[1106.998|0090.704] Info: Waiting for secondary state: NORMAL:0
[1106.998|0090.704] Info: Sending 11371:DIRECT_FREEKICK:7:EXECUTE to GameController.
[1106.998|0090.704] Info: Waiting for GameController to answer to 11371:DIRECT_FREEKICK:7:EXECUTE.
[1107.198|0090.704] Info: Waiting for GameController to answer to 11371:DIRECT_FREEKICK:7:EXECUTE.
[1108.002|0090.704] Info: New secondary state received from GameController: STATE_NORMAL, phase 0.
[1108.002|0090.704] Info: State has succesfully changed to STATE_NORMAL:0
[1108.005|0090.704] Info: Execute direct free kick.
[1108.007|0090.704] Info: Prepare for direct free kick.
[1108.128|0090.720] Info: STATUS: Avg speed factor: 0.086 (over last 20.03 seconds)
[1108.128|0090.720] Info: STATUS: state: STATE_PLAYING, remaining time: 5
[1128.137|0092.672] Info: STATUS: Avg speed factor: 0.098 (over last 20.01 seconds)
[1128.137|0092.672] Info: STATUS: state: STATE_PLAYING, remaining time: 3
[1148.222|0094.672] Info: STATUS: Avg speed factor: 0.100 (over last 20.08 seconds)
[1148.222|0094.672] Info: STATUS: state: STATE_PLAYING, remaining time: 1
[1156.644|0095.496] Info: Sending FINISH because seconds remaining = 0
[1156.644|0095.496] Info: Sending 11973:STATE:FINISH to GameController.
[1156.644|0095.496] Info: Waiting for GameController to answer to 11973:STATE:FINISH.
[1156.844|0095.496] Info: Waiting for GameController to answer to 11973:STATE:FINISH.
[1157.045|0095.496] Info: Waiting for GameController to answer to 11973:STATE:FINISH.
[1157.245|0095.496] Info: End of  first half.
[1157.278|0095.496] Info: Red player 1 reset to halfTimeStartingPose: translation (-3.5 -3.1 0.439), rotation (0 0 1 1.57).
[1157.278|0095.496] Info: Disabling actuators of red player 1.
[1157.307|0095.496] Info: Red player 2 reset to halfTimeStartingPose: translation (-3.5 3.1 0.439), rotation (0 0 1 -1.5700000000000003).
[1157.307|0095.496] Info: Disabling actuators of red player 2.
[1157.334|0095.496] Info: Red player 3 reset to halfTimeStartingPose: translation (-2.5 -3.1 0.439), rotation (0 0 1 1.57).
[1157.334|0095.496] Info: Disabling actuators of red player 3.
[1157.390|0095.496] Info: Blue player 1 reset to halfTimeStartingPose: translation (3.6 -3.2 0.43), rotation (0 0 -1 4.711592653589793).
[1157.391|0095.496] Info: Disabling actuators of blue player 1.
[1157.438|0095.496] Info: Blue player 2 reset to halfTimeStartingPose: translation (1.6 3.2 0.43), rotation (0 0 1 4.711592653589793).
[1157.438|0095.496] Info: Disabling actuators of blue player 2.
[1157.477|0095.496] Info: Blue player 3 reset to halfTimeStartingPose: translation (1.6 -3.2 0.43), rotation (0 0 -1 4.711592653589793).
[1157.477|0095.496] Info: Disabling actuators of blue player 3.
[1157.547|0095.504] Info: New state received from GameController: STATE_FINISHED.
[1157.603|0095.504] Info: Received state FINISHED: end of first half
[1157.626|0095.512] Info: New state received from GameController: STATE_INITIAL.
[1157.638|0095.512] Info: Beginning of second half.
[1157.638|0095.512] Info: Kick-off is blue.
[1157.638|0095.512] Info: Moved ball out of the field temporarily
[1157.638|0095.512] Info: Ball not in play, will be kicked by a player from the blue team.
[1157.638|0095.512] Info: Going to READY in 15 seconds (real-time)
[1157.972|0095.544] Info: Stabilizing red player 1
[1157.975|0095.544] Info: Stabilizing red player 2
[1157.977|0095.544] Info: Stabilizing red player 3
[1157.979|0095.544] Info: Stabilizing blue player 1
[1157.985|0095.544] Info: Stabilizing blue player 2
[1157.991|0095.544] Info: Stabilizing blue player 3
[1164.585|0096.560] Info: Enabling actuators of red player 1.
[1164.585|0096.560] Info: Enabling actuators of red player 2.
[1164.585|0096.560] Info: Enabling actuators of red player 3.
[1164.585|0096.560] Info: Enabling actuators of blue player 1.
[1164.585|0096.560] Info: Enabling actuators of blue player 2.
[1164.585|0096.560] Info: Enabling actuators of blue player 3.
[1168.224|0096.904] Info: STATUS: Avg speed factor: 0.112 (over last 20.00 seconds)
[1168.224|0096.904] Info: STATUS: state: STATE_INITIAL, remaining time: 15
[1172.765|0097.328] Info: Real-time to wait elasped, moving to READY
[1172.765|0097.328] Info: Sending 12206:STATE:READY to GameController.
[1172.765|0097.328] Info: Waiting for GameController to answer to 12206:STATE:READY.
[1172.966|0097.328] Info: Waiting for GameController to answer to 12206:STATE:READY.
[1173.166|0097.328] Info: Waiting for GameController to answer to 12206:STATE:READY.
[1173.367|0097.328] Info: New state received from GameController: STATE_READY.
[1173.367|0097.328] Info: State has succesfully changed to READY
[1177.611|0097.728] Info: Blue player 3 has fallen down.
[1180.000|0097.960] Info: Blue player 3 just recovered after 0.2 seconds.
[1180.156|0097.968] Info: Blue player 3 has fallen down.
[1180.328|0097.992] Info: Blue player 3 just recovered after 0.0 seconds.
[1180.485|0098.000] Info: Blue player 3 has fallen down.
[1185.402|0098.440] Info: Blue player 3 just recovered after 0.4 seconds.
[1188.273|0098.704] Info: STATUS: Avg speed factor: 0.090 (over last 20.05 seconds)
[1188.273|0098.704] Info: STATUS: state: STATE_READY, remaining time: 15
[1189.337|0098.800] Info: Blue player 3 has fallen down.
[1197.111|0099.536] Info: Blue player 3 just recovered after 0.7 seconds.
[1208.292|0100.632] Info: STATUS: Avg speed factor: 0.096 (over last 20.02 seconds)
[1208.292|0100.632] Info: STATUS: state: STATE_READY, remaining time: 15
[1228.327|0102.544] Info: STATUS: Avg speed factor: 0.095 (over last 20.03 seconds)
[1228.327|0102.544] Info: STATUS: state: STATE_READY, remaining time: 15
[1248.388|0104.512] Info: STATUS: Avg speed factor: 0.098 (over last 20.06 seconds)
[1248.388|0104.512] Info: STATUS: state: STATE_READY, remaining time: 15
[1268.451|0106.496] Info: STATUS: Avg speed factor: 0.099 (over last 20.06 seconds)
[1268.451|0106.496] Info: STATUS: state: STATE_READY, remaining time: 15
[1288.461|0108.488] Info: STATUS: Avg speed factor: 0.100 (over last 20.01 seconds)
[1288.461|0108.488] Info: STATUS: state: STATE_READY, remaining time: 15
[1308.473|0110.528] Info: STATUS: Avg speed factor: 0.102 (over last 20.01 seconds)
[1308.473|0110.528] Info: STATUS: state: STATE_READY, remaining time: 15
[1328.478|0112.512] Info: STATUS: Avg speed factor: 0.099 (over last 20.00 seconds)
[1328.478|0112.512] Info: STATUS: state: STATE_READY, remaining time: 15
[1348.485|0114.512] Info: STATUS: Avg speed factor: 0.100 (over last 20.01 seconds)
[1348.485|0114.512] Info: STATUS: state: STATE_READY, remaining time: 15
[1368.504|0116.416] Info: STATUS: Avg speed factor: 0.095 (over last 20.02 seconds)
[1368.504|0116.416] Info: STATUS: state: STATE_READY, remaining time: 15
[1388.579|0118.352] Info: STATUS: Avg speed factor: 0.096 (over last 20.07 seconds)
[1388.579|0118.352] Info: STATUS: state: STATE_READY, remaining time: 15
[1408.599|0120.272] Info: STATUS: Avg speed factor: 0.096 (over last 20.02 seconds)
[1408.599|0120.272] Info: STATUS: state: STATE_READY, remaining time: 15
[1428.663|0122.232] Info: STATUS: Avg speed factor: 0.098 (over last 20.06 seconds)
[1428.663|0122.232] Info: STATUS: state: STATE_READY, remaining time: 15
[1448.703|0124.208] Info: STATUS: Avg speed factor: 0.099 (over last 20.04 seconds)
[1448.703|0124.208] Info: STATUS: state: STATE_READY, remaining time: 15
[1468.735|0126.216] Info: STATUS: Avg speed factor: 0.100 (over last 20.03 seconds)
[1468.735|0126.216] Info: STATUS: state: STATE_READY, remaining time: 15
[1488.755|0128.200] Info: STATUS: Avg speed factor: 0.099 (over last 20.02 seconds)
[1488.755|0128.200] Info: STATUS: state: STATE_READY, remaining time: 15
[1508.827|0130.256] Info: STATUS: Avg speed factor: 0.102 (over last 20.07 seconds)
[1508.827|0130.256] Info: STATUS: state: STATE_READY, remaining time: 15
[1528.854|0132.256] Info: STATUS: Avg speed factor: 0.100 (over last 20.03 seconds)
[1528.854|0132.256] Info: STATUS: state: STATE_READY, remaining time: 15
[1548.883|0134.280] Info: STATUS: Avg speed factor: 0.101 (over last 20.03 seconds)
[1548.883|0134.280] Info: STATUS: state: STATE_READY, remaining time: 15
[1568.908|0136.296] Info: STATUS: Avg speed factor: 0.101 (over last 20.03 seconds)
[1568.908|0136.296] Info: STATUS: state: STATE_READY, remaining time: 15
[1588.964|0138.320] Info: STATUS: Avg speed factor: 0.101 (over last 20.06 seconds)
[1588.964|0138.320] Info: STATUS: state: STATE_READY, remaining time: 15
[1609.006|0140.360] Info: STATUS: Avg speed factor: 0.102 (over last 20.04 seconds)
[1609.006|0140.360] Info: STATUS: state: STATE_READY, remaining time: 15
[1628.943|0142.368] Info: New state received from GameController: STATE_SET.
[1628.955|0142.368] Info: Waiting for classic play
[1628.956|0142.368] Info: Ball respawned at 0 0 0.07.
[1629.007|0142.376] Info: Sending 17841:PENALTY:4:3:INCAPABLE to GameController.
[1629.007|0142.376] Info: Waiting for GameController to answer to 17841:PENALTY:4:3:INCAPABLE.
[1629.208|0142.376] Info: Waiting for GameController to answer to 17841:PENALTY:4:3:INCAPABLE.
[1629.408|0142.376] Info: placing player red 3 at [-3, 3.11, 0.439]
[1629.408|0142.376] Info: -> pos: [-3, 3.11, 0.439]
[1629.436|0142.376] Info: Red player 3 reset to None: translation (-3 3.11 0.439), rotation (0.0 0.0 1.0 4.711592653589793).
[1629.436|0142.376] Info: Disabling actuators of red player 3.
[1629.436|0142.376] Info: INCAPABLE penalty for red player 3: inside center circle during opponent's kick-off.
[1629.531|0142.384] Info: STATUS: Avg speed factor: 0.099 (over last 20.52 seconds)
[1629.531|0142.384] Info: STATUS: state: STATE_SET, remaining time: 15
[1629.934|0142.424] Info: Stabilizing red player 3
[1649.602|0144.472] Info: STATUS: Avg speed factor: 0.104 (over last 20.07 seconds)
[1649.602|0144.472] Info: STATUS: state: STATE_SET, remaining time: 15
[1669.677|0146.608] Info: STATUS: Avg speed factor: 0.106 (over last 20.08 seconds)
[1669.677|0146.608] Info: STATUS: state: STATE_SET, remaining time: 15
[1676.718|0147.368] Info: Sending 18468:STATE:PLAY to GameController.
[1676.718|0147.368] Info: Waiting for GameController to answer to 18468:STATE:PLAY.
[1676.918|0147.368] Info: Waiting for GameController to answer to 18468:STATE:PLAY.
[1677.119|0147.368] Info: Waiting for GameController to answer to 18468:STATE:PLAY.
[1677.319|0147.368] Info: Waiting for GameController to answer to 18468:STATE:PLAY.
[1677.520|0147.368] Info: New state received from GameController: STATE_PLAYING.
[1677.520|0147.368] Info: State has succesfully changed to PLAYING
[1677.943|0147.408] Info: Enabling actuators of red player 3.
[1689.733|0148.520] Info: STATUS: Avg speed factor: 0.095 (over last 20.06 seconds)
[1689.733|0148.520] Info: STATUS: state: STATE_PLAYING, remaining time: 14
[1709.795|0150.528] Info: STATUS: Avg speed factor: 0.100 (over last 20.06 seconds)
[1709.795|0150.528] Info: STATUS: state: STATE_PLAYING, remaining time: 12
[1729.851|0152.528] Info: STATUS: Avg speed factor: 0.100 (over last 20.06 seconds)
[1729.851|0152.528] Info: STATUS: state: STATE_PLAYING, remaining time: 10
[1731.455|0152.688] Info: Red player 2 entering circle during opponent's kick-off.
[1731.455|0152.688] Info: Sending 19138:PENALTY:4:2:INCAPABLE to GameController.
[1731.455|0152.688] Info: Waiting for GameController to answer to 19138:PENALTY:4:2:INCAPABLE.
[1731.656|0152.688] Info: Waiting for GameController to answer to 19138:PENALTY:4:2:INCAPABLE.
[1731.856|0152.688] Info: placing player red 2 at [-3, -3.11, 0.439]
[1731.856|0152.688] Info: -> pos: [-3, -3.11, 0.439]
[1731.885|0152.688] Info: Red player 2 reset to None: translation (-3 -3.11 0.439), rotation (0 0 1 1.57).
[1731.885|0152.688] Info: Disabling actuators of red player 2.
[1731.885|0152.688] Info: INCAPABLE penalty for red player 2: entered circle during oppenent's kick-off.
[1732.351|0152.736] Info: Stabilizing red player 2
[1749.891|0154.552] Info: STATUS: Avg speed factor: 0.101 (over last 20.04 seconds)
[1749.891|0154.552] Info: STATUS: state: STATE_PLAYING, remaining time: 8
[1769.895|0156.664] Info: STATUS: Avg speed factor: 0.106 (over last 20.00 seconds)
[1769.895|0156.664] Info: STATUS: state: STATE_PLAYING, remaining time: 6
[1776.506|0157.384] Info: Ball in play, can be touched by any player (10 seconds elapsed after kickoff).
[1789.920|0158.792] Info: STATUS: Avg speed factor: 0.106 (over last 20.03 seconds)
[1789.920|0158.792] Info: STATUS: state: STATE_PLAYING, remaining time: 4
[1809.949|0160.888] Info: STATUS: Avg speed factor: 0.105 (over last 20.03 seconds)
[1809.949|0160.888] Info: STATUS: state: STATE_PLAYING, remaining time: 2
[1819.410|0161.864] Info: Ball kicked by blue player 2.
[1824.584|0162.416] Info: Sending FINISH because seconds remaining = 0
[1824.584|0162.416] Info: Sending 20357:STATE:FINISH to GameController.
[1824.584|0162.416] Info: Waiting for GameController to answer to 20357:STATE:FINISH.
[1824.784|0162.416] Info: Waiting for GameController to answer to 20357:STATE:FINISH.
[1824.985|0162.416] Info: End of second half.
[1825.016|0162.416] Info: Red player 1 reset to halfTimeStartingPose: translation (3.5 -3.1 0.439), rotation (0 0 1 1.571592653589793).
[1825.016|0162.416] Info: Disabling actuators of red player 1.
[1825.044|0162.416] Info: Red player 2 reset to halfTimeStartingPose: translation (3.5 3.1 0.439), rotation (0 0 1 4.711592653589793).
[1825.044|0162.416] Info: Disabling actuators of red player 2.
[1825.071|0162.416] Info: Red player 3 reset to halfTimeStartingPose: translation (2.5 -3.1 0.439), rotation (0 0 1 1.571592653589793).
[1825.071|0162.416] Info: Disabling actuators of red player 3.
[1825.125|0162.416] Info: Blue player 1 reset to halfTimeStartingPose: translation (-3.6 -3.2 0.43), rotation (0 0 -1 -1.5700000000000003).
[1825.125|0162.416] Info: Disabling actuators of blue player 1.
[1825.172|0162.416] Info: Blue player 2 reset to halfTimeStartingPose: translation (-1.6 3.2 0.43), rotation (0 0 1 -1.5700000000000003).
[1825.172|0162.416] Info: Disabling actuators of blue player 2.
[1825.211|0162.416] Info: Blue player 3 reset to halfTimeStartingPose: translation (-1.6 -3.2 0.43), rotation (0 0 -1 -1.5700000000000003).
[1825.211|0162.416] Info: Disabling actuators of blue player 3.
[1825.291|0162.424] Info: New state received from GameController: STATE_FINISHED.
[1825.370|0162.424] Info: Beginning of the knockout first half.
[1825.370|0162.424] Info: Sending 20361:STATE:OVERTIME-FIRST-HALF to GameController.
[1825.370|0162.424] Info: Waiting for GameController to answer to 20361:STATE:OVERTIME-FIRST-HALF.
[1825.570|0162.424] Info: Waiting for GameController to answer to 20361:STATE:OVERTIME-FIRST-HALF.
[1825.771|0162.424] Info: Waiting for GameController to answer to 20361:STATE:OVERTIME-FIRST-HALF.
[1825.971|0162.424] Info: Going to READY in 15 seconds (real-time)
[1826.396|0162.464] Info: Stabilizing red player 1
[1826.400|0162.464] Info: Stabilizing red player 2
[1826.402|0162.464] Info: Stabilizing red player 3
[1826.405|0162.464] Info: Stabilizing blue player 1
[1826.410|0162.464] Info: Stabilizing blue player 2
[1826.416|0162.464] Info: Stabilizing blue player 3
[1826.650|0162.488] Info: New state received from GameController: STATE_INITIAL.
[1826.650|0162.488] Info: New secondary state received from GameController: STATE_OVERTIME, phase 0.
[1829.975|0162.784] Info: STATUS: Avg speed factor: 0.095 (over last 20.03 seconds)
[1829.975|0162.784] Info: STATUS: state: STATE_INITIAL, remaining time: 150
[1834.046|0163.472] Info: Enabling actuators of red player 1.
[1834.046|0163.472] Info: Enabling actuators of red player 2.
[1834.046|0163.472] Info: Enabling actuators of red player 3.
[1834.046|0163.472] Info: Enabling actuators of blue player 1.
[1834.046|0163.472] Info: Enabling actuators of blue player 2.
[1834.046|0163.472] Info: Enabling actuators of blue player 3.
[1841.016|0164.064] Info: Real-time to wait elasped, moving to READY
[1841.017|0164.064] Info: Sending 20570:STATE:READY to GameController.
[1841.017|0164.064] Info: Waiting for GameController to answer to 20570:STATE:READY.
[1841.217|0164.064] Info: Waiting for GameController to answer to 20570:STATE:READY.
[1841.561|0164.064] Info: New state received from GameController: STATE_READY.
[1841.561|0164.064] Info: State has succesfully changed to READY
[1846.360|0164.480] Info: Blue player 1 has fallen down.
[1848.509|0164.664] Info: Blue player 3 has fallen down.
[1848.696|0164.688] Info: Blue player 3 just recovered after 0.0 seconds.
[1849.766|0164.776] Info: Blue player 3 has fallen down.
[1850.061|0164.800] Info: STATUS: Avg speed factor: 0.100 (over last 20.09 seconds)
[1850.061|0164.800] Info: STATUS: state: STATE_READY, remaining time: 150
[1854.228|0165.152] Info: Blue player 1 just recovered after 0.6 seconds.
[1859.305|0165.600] Info: Blue player 1 has fallen down.
[1867.280|0166.272] Info: Blue player 3 just recovered after 1.4 seconds.
[1867.348|0166.280] Info: Blue player 1 just recovered after 0.6 seconds.
[1870.120|0166.536] Info: STATUS: Avg speed factor: 0.087 (over last 20.06 seconds)
[1870.120|0166.536] Info: STATUS: state: STATE_READY, remaining time: 150
[1890.236|0168.416] Info: STATUS: Avg speed factor: 0.093 (over last 20.12 seconds)
[1890.236|0168.416] Info: STATUS: state: STATE_READY, remaining time: 150
[1910.238|0170.224] Info: STATUS: Avg speed factor: 0.090 (over last 20.00 seconds)
[1910.238|0170.224] Info: STATUS: state: STATE_READY, remaining time: 150
[1930.260|0172.040] Info: STATUS: Avg speed factor: 0.091 (over last 20.02 seconds)
[1930.260|0172.040] Info: STATUS: state: STATE_READY, remaining time: 150
[1950.303|0173.880] Info: STATUS: Avg speed factor: 0.092 (over last 20.04 seconds)
[1950.303|0173.880] Info: STATUS: state: STATE_READY, remaining time: 150
[1970.308|0175.712] Info: STATUS: Avg speed factor: 0.092 (over last 20.00 seconds)
[1970.308|0175.712] Info: STATUS: state: STATE_READY, remaining time: 150
[1990.348|0177.528] Info: STATUS: Avg speed factor: 0.091 (over last 20.04 seconds)
[1990.348|0177.528] Info: STATUS: state: STATE_READY, remaining time: 150
[2010.368|0179.320] Info: STATUS: Avg speed factor: 0.090 (over last 20.02 seconds)
[2010.368|0179.320] Info: STATUS: state: STATE_READY, remaining time: 150
[2030.395|0181.088] Info: STATUS: Avg speed factor: 0.088 (over last 20.03 seconds)
[2030.395|0181.088] Info: STATUS: state: STATE_READY, remaining time: 150
[2050.413|0182.824] Info: STATUS: Avg speed factor: 0.087 (over last 20.02 seconds)
[2050.413|0182.824] Info: STATUS: state: STATE_READY, remaining time: 150
[2070.470|0184.576] Info: STATUS: Avg speed factor: 0.087 (over last 20.06 seconds)
[2070.470|0184.576] Info: STATUS: state: STATE_READY, remaining time: 150
[2090.508|0186.312] Info: STATUS: Avg speed factor: 0.087 (over last 20.04 seconds)
[2090.508|0186.312] Info: STATUS: state: STATE_READY, remaining time: 150
[2110.577|0188.056] Info: STATUS: Avg speed factor: 0.087 (over last 20.07 seconds)
[2110.577|0188.056] Info: STATUS: state: STATE_READY, remaining time: 150
[2130.590|0189.744] Info: STATUS: Avg speed factor: 0.084 (over last 20.01 seconds)
[2130.590|0189.744] Info: STATUS: state: STATE_READY, remaining time: 150
[2150.630|0191.432] Info: STATUS: Avg speed factor: 0.084 (over last 20.04 seconds)
[2150.630|0191.432] Info: STATUS: state: STATE_READY, remaining time: 150
[2170.688|0193.088] Info: STATUS: Avg speed factor: 0.083 (over last 20.06 seconds)
[2170.688|0193.088] Info: STATUS: state: STATE_READY, remaining time: 150
[2190.752|0194.776] Info: STATUS: Avg speed factor: 0.084 (over last 20.06 seconds)
[2190.752|0194.776] Info: STATUS: state: STATE_READY, remaining time: 150
[2210.807|0196.480] Info: STATUS: Avg speed factor: 0.085 (over last 20.06 seconds)
[2210.807|0196.480] Info: STATUS: state: STATE_READY, remaining time: 150
[2230.912|0198.176] Info: STATUS: Avg speed factor: 0.084 (over last 20.10 seconds)
[2230.912|0198.176] Info: STATUS: state: STATE_READY, remaining time: 150
[2251.034|0199.904] Info: STATUS: Avg speed factor: 0.086 (over last 20.12 seconds)
[2251.034|0199.904] Info: STATUS: state: STATE_READY, remaining time: 150
[2271.044|0201.608] Info: STATUS: Avg speed factor: 0.085 (over last 20.01 seconds)
[2271.044|0201.608] Info: STATUS: state: STATE_READY, remaining time: 150
[2291.097|0203.320] Info: STATUS: Avg speed factor: 0.085 (over last 20.05 seconds)
[2291.097|0203.320] Info: STATUS: state: STATE_READY, remaining time: 150
[2311.217|0205.024] Info: STATUS: Avg speed factor: 0.085 (over last 20.12 seconds)
[2311.217|0205.024] Info: STATUS: state: STATE_READY, remaining time: 150
[2331.252|0206.736] Info: STATUS: Avg speed factor: 0.085 (over last 20.04 seconds)
[2331.252|0206.736] Info: STATUS: state: STATE_READY, remaining time: 150
[2351.280|0208.440] Info: STATUS: Avg speed factor: 0.085 (over last 20.03 seconds)
[2351.280|0208.440] Info: STATUS: state: STATE_READY, remaining time: 150
[2358.982|0209.120] Info: New state received from GameController: STATE_SET.
[2358.990|0209.120] Info: Waiting for classic play
[2371.315|0210.152] Info: STATUS: Avg speed factor: 0.085 (over last 20.03 seconds)
[2371.315|0210.152] Info: STATUS: state: STATE_SET, remaining time: 150
[2391.339|0211.840] Info: STATUS: Avg speed factor: 0.084 (over last 20.02 seconds)
[2391.339|0211.840] Info: STATUS: state: STATE_SET, remaining time: 150
[2411.411|0213.536] Info: STATUS: Avg speed factor: 0.084 (over last 20.07 seconds)
[2411.411|0213.536] Info: STATUS: state: STATE_SET, remaining time: 150
[2418.322|0214.120] Info: Sending 26830:STATE:PLAY to GameController.
[2418.322|0214.120] Info: Waiting for GameController to answer to 26830:STATE:PLAY.
[2418.522|0214.120] Info: Waiting for GameController to answer to 26830:STATE:PLAY.
[2418.723|0214.120] Info: New state received from GameController: STATE_PLAYING.
[2418.723|0214.120] Info: State has succesfully changed to PLAYING
[2431.516|0215.200] Info: STATUS: Avg speed factor: 0.083 (over last 20.11 seconds)
[2431.516|0215.200] Info: STATUS: state: STATE_PLAYING, remaining time: 149
[2451.557|0216.912] Info: STATUS: Avg speed factor: 0.085 (over last 20.04 seconds)
[2451.557|0216.912] Info: STATUS: state: STATE_PLAYING, remaining time: 148
[2471.563|0218.568] Info: STATUS: Avg speed factor: 0.083 (over last 20.01 seconds)
[2471.563|0218.568] Info: STATUS: state: STATE_PLAYING, remaining time: 146
[2491.629|0220.264] Info: STATUS: Avg speed factor: 0.085 (over last 20.07 seconds)
[2491.629|0220.264] Info: STATUS: state: STATE_PLAYING, remaining time: 144
[2494.535|0220.504] Info: Ball touched by blue player 3.
[2511.676|0221.944] Info: STATUS: Avg speed factor: 0.084 (over last 20.05 seconds)
[2511.676|0221.944] Info: STATUS: state: STATE_PLAYING, remaining time: 143
[2531.685|0223.656] Info: STATUS: Avg speed factor: 0.086 (over last 20.01 seconds)
[2531.685|0223.656] Info: STATUS: state: STATE_PLAYING, remaining time: 141
[2551.759|0225.344] Info: STATUS: Avg speed factor: 0.084 (over last 20.07 seconds)
[2551.759|0225.344] Info: STATUS: state: STATE_PLAYING, remaining time: 139
[2571.811|0227.080] Info: STATUS: Avg speed factor: 0.087 (over last 20.05 seconds)
[2571.811|0227.080] Info: STATUS: state: STATE_PLAYING, remaining time: 138
[2591.918|0228.792] Info: STATUS: Avg speed factor: 0.085 (over last 20.11 seconds)
[2591.918|0228.792] Info: STATUS: state: STATE_PLAYING, remaining time: 136
[2611.943|0230.528] Info: STATUS: Avg speed factor: 0.087 (over last 20.02 seconds)
[2611.943|0230.528] Info: STATUS: state: STATE_PLAYING, remaining time: 134
[2631.995|0232.232] Info: STATUS: Avg speed factor: 0.085 (over last 20.05 seconds)
[2631.995|0232.232] Info: STATUS: state: STATE_PLAYING, remaining time: 132
[2641.734|0233.080] Info: Ball touched by red player 3.
[2647.795|0233.608] Info: Ball touched by blue player 2.
[2650.249|0233.816] Info: Ball touched by red player 3.
[2651.057|0233.888] Info: Ball touched by blue player 2.
[2652.054|0233.976] Info: STATUS: Avg speed factor: 0.087 (over last 20.06 seconds)
[2652.054|0233.976] Info: STATUS: state: STATE_PLAYING, remaining time: 131
[2654.147|0234.144] Info: Ball touched by red player 3.
[2656.131|0234.320] Info: Ball touched by blue player 2.
[2671.016|0235.552] Info: 235552: contact between red player 3 and blue player 2.
[2672.060|0235.616] Info: STATUS: Avg speed factor: 0.082 (over last 20.01 seconds)
[2672.060|0235.616] Info: STATUS: state: STATE_PLAYING, remaining time: 129
[2692.090|0237.280] Info: STATUS: Avg speed factor: 0.083 (over last 20.03 seconds)
[2692.090|0237.280] Info: STATUS: state: STATE_PLAYING, remaining time: 127
[2712.129|0238.968] Info: STATUS: Avg speed factor: 0.084 (over last 20.04 seconds)
[2712.129|0238.968] Info: STATUS: state: STATE_PLAYING, remaining time: 126
[2732.168|0240.664] Info: STATUS: Avg speed factor: 0.085 (over last 20.04 seconds)
[2732.168|0240.664] Info: STATUS: state: STATE_PLAYING, remaining time: 124
[2745.906|0241.800] Info: Ball touched again by blue player 2.
[2752.237|0242.304] Info: STATUS: Avg speed factor: 0.082 (over last 20.07 seconds)
[2752.237|0242.304] Info: STATUS: state: STATE_PLAYING, remaining time: 122
[2762.049|0243.112] Info: 243112: contact between red player 3 and blue player 2.
[2772.250|0243.984] Info: STATUS: Avg speed factor: 0.084 (over last 20.01 seconds)
[2772.250|0243.984] Info: STATUS: state: STATE_PLAYING, remaining time: 121
[2792.303|0245.688] Info: STATUS: Avg speed factor: 0.085 (over last 20.05 seconds)
[2792.303|0245.688] Info: STATUS: state: STATE_PLAYING, remaining time: 119
[2812.352|0247.400] Info: STATUS: Avg speed factor: 0.085 (over last 20.05 seconds)
[2812.352|0247.400] Info: STATUS: state: STATE_PLAYING, remaining time: 117
[2832.391|0249.136] Info: STATUS: Avg speed factor: 0.087 (over last 20.04 seconds)
[2832.391|0249.136] Info: STATUS: state: STATE_PLAYING, remaining time: 115
[2852.504|0250.880] Info: STATUS: Avg speed factor: 0.087 (over last 20.11 seconds)
[2852.504|0250.880] Info: STATUS: state: STATE_PLAYING, remaining time: 114
[2858.387|0251.424] Info: 251424: contact between red player 3 and blue player 2.
[2858.387|0251.424] Info: Check if blue 2 is performing a foul on red 3
[2858.387|0251.424] Info: blue 2: at [-0.27 -0.50  0.39], dist to ball: 0.45
[2858.387|0251.424] Info: red 3 : at [ 0.03 -0.42  0.32], dist to ball: 0.25
[2858.387|0251.424] Info: blue 2: velocity: [ 0.23 -0.05  0.00], speed: 0.23
[2858.387|0251.424] Info: red 3 : velocity: [ 0.12 -0.09 -0.00], speed: 0.15
[2858.387|0251.424] Info: blue 2 is close to the ball (0.45 < 2)
[2858.387|0251.424] Info: red 3 is significantly closer to the ball than blue 2: (0.20 < 0.1)
[2858.387|0251.424] Info: Blue player 2 committed a forceful contact foul on red player 3 (opponent moving towards the ball, charge from behind) outside penalty area.
[2858.387|0251.424] Info: Ball in play: 157384, foul far from ball: False
[2858.387|0251.424] Info: Interruption countdown set to 625
[2858.387|0251.424] Info: Ball not in play, will be kicked by a player from the red team.
[2858.387|0251.424] Info: Direct free kick awarded to red team.
[2858.387|0251.424] Info: Waiting for secondary state: DIRECT_FREEKICK:0
[2858.387|0251.424] Info: Sending 31496:DIRECT_FREEKICK:4 to GameController.
[2858.387|0251.424] Info: Waiting for GameController to answer to 31496:DIRECT_FREEKICK:4.
[2858.588|0251.424] Info: Waiting for GameController to answer to 31496:DIRECT_FREEKICK:4.
[2859.293|0251.424] Info: New secondary state received from GameController: STATE_DIRECT_FREEKICK, phase 0.
[2859.293|0251.424] Info: State has succesfully changed to STATE_DIRECT_FREEKICK:0
[2859.294|0251.424] Info: Awarding a direct free kick.
[2859.298|0251.424] Info: Sending FINISH because seconds remaining = -22
[2859.298|0251.424] Info: Sending 31499:STATE:FINISH to GameController.
[2859.298|0251.424] Info: Waiting for GameController to answer to 31499:STATE:FINISH.
[2859.498|0251.424] Info: Waiting for GameController to answer to 31499:STATE:FINISH.
[2859.699|0251.424] Error: Received illegal answer from GameController for message 31499:STATE:FINISH.
[2859.699|0251.424] Info: FINAL SCORE: 0-0
[2859.699|0251.424] Info: Closing 'controller' socket
[2859.699|0251.424] Info: Terminating 'game_controller' process
[2859.699|0251.424] Info: Stopping animation recording
[2860.196|0251.424] Info: Exiting webots properly