· 7 years ago · Dec 24, 2018, 01:38 PM
12018-12-24 08:11:54,711 [ MainThread][ dbWrapperBase][ INFO] Connecting pool to DB
22018-12-24 08:11:54,711 [webhook_asyncio_loop][selector_events][ DEBUG] Using selector: EpollSelector
32018-12-24 08:11:54,714 [ MainThread][ dbWrapperBase][ DEBUG] {DbWrapperBase::create_hash_database_if_not_exists} called
42018-12-24 08:11:54,714 [ MainThread][ dbWrapperBase][ DEBUG] Creating hash db in database
52018-12-24 08:11:54,714 [ MainThread][ dbWrapperBase][ DEBUG] Create table if not exists trshash ( hashid MEDIUMINT NOT NULL AUTO_INCREMENT, hash VARCHAR(255) NOT NULL, type VARCHAR(10) NOT NULL, id VARCHAR(255) NOT NULL, count INT(10) NOT NULL DEFAULT 1, modify DATETIME NOT NULL DEFAULT CURRENT_TIMESTAMP, PRIMARY KEY (hashid))
62018-12-24 08:11:54,715 [ MainThread][ dbWrapperBase][ DEBUG] {DbWrapperBase::check_and_create_spawn_tables} called
72018-12-24 08:11:54,719 [ MainThread][geofenceHelper][ INFO] Loading geofenced or excluded areas.
82018-12-24 08:11:54,719 [ MainThread][geofenceHelper][ DEBUG] Found geofence: Default.
92018-12-24 08:11:54,719 [ MainThread][geofenceHelper][ INFO] Loaded 1 geofenced and 0 excluded areas.
102018-12-24 08:11:54,719 [ MainThread][ s2Helper][ WARNING] Calculating corners of fences
112018-12-24 08:11:54,720 [ MainThread][ s2Helper][ WARNING] Calculating coverage of region
122018-12-24 08:11:54,765 [ MainThread][ s2Helper][ WARNING] Iterating cell_ids
132018-12-24 08:11:54,774 [ MainThread][ s2Helper][ DEBUG] Detecting 331 L17 Cells in Area
142018-12-24 08:11:54,775 [ MainThread][geofenceHelper][ INFO] Loading geofenced or excluded areas.
152018-12-24 08:11:54,775 [ MainThread][geofenceHelper][ DEBUG] Found geofence: Default.
162018-12-24 08:11:54,775 [ MainThread][geofenceHelper][ INFO] Loaded 1 geofenced and 0 excluded areas.
172018-12-24 08:11:54,775 [ MainThread][geofenceHelper][ INFO] Using matplotlib: True.
182018-12-24 08:11:54,775 [ MainThread][geofenceHelper][ INFO] Found 331 coordinates to geofence.
192018-12-24 08:11:54,785 [ MainThread][geofenceHelper][ INFO] Geofenced to 277 coordinates
202018-12-24 08:11:54,785 [ MainThread][ mappingParser][ DEBUG] <multiprocessing.pool.ApplyResult object at 0x7f068c232748>
212018-12-24 08:11:54,785 [ Thread-1][calculate_route][ INFO] Found existing Routefile
222018-12-24 08:11:54,821 [ MainThread][ start][ INFO] Starting scanner....
232018-12-24 08:11:54,821 [ MainThread][ start][ INFO] Starting Madmin on Port: 5001
242018-12-24 08:11:54,828 [ scanner][geofenceHelper][ INFO] Loading geofenced or excluded areas.
252018-12-24 08:11:54,828 [ scanner][geofenceHelper][ DEBUG] Found geofence: Default.
262018-12-24 08:11:54,829 [ scanner][geofenceHelper][ INFO] Loaded 1 geofenced and 0 excluded areas.
272018-12-24 08:11:54,829 [ scanner][ s2Helper][ WARNING] Calculating corners of fences
282018-12-24 08:11:54,830 [ scanner][ s2Helper][ WARNING] Calculating coverage of region
292018-12-24 08:11:54,880 [ scanner][ s2Helper][ WARNING] Iterating cell_ids
302018-12-24 08:11:54,889 [ scanner][ s2Helper][ DEBUG] Detecting 331 L17 Cells in Area
312018-12-24 08:11:54,889 [ scanner][geofenceHelper][ INFO] Loading geofenced or excluded areas.
322018-12-24 08:11:54,890 [ scanner][geofenceHelper][ DEBUG] Found geofence: Default.
332018-12-24 08:11:54,890 [ scanner][geofenceHelper][ INFO] Loaded 1 geofenced and 0 excluded areas.
342018-12-24 08:11:54,890 [ scanner][geofenceHelper][ INFO] Using matplotlib: True.
352018-12-24 08:11:54,892 [ scanner][geofenceHelper][ INFO] Found 331 coordinates to geofence.
362018-12-24 08:11:54,901 [ scanner][geofenceHelper][ INFO] Geofenced to 277 coordinates
372018-12-24 08:11:54,901 [ scanner][ mappingParser][ DEBUG] <multiprocessing.pool.ApplyResult object at 0x7f066c332668>
382018-12-24 08:11:54,902 [ Thread-8][calculate_route][ INFO] Found existing Routefile
392018-12-24 08:11:54,926 [ scanner][WebsocketServerBase][ INFO] Starting websocket server...
402018-12-24 08:11:54,927 [ scanner][selector_events][ DEBUG] Using selector: EpollSelector
412018-12-24 08:11:54,927 [ scanner][WebsocketServerBase][ INFO] Device mappings: {'071607f34fa91503': {'daytime_area': 'Default', 'nighttime_area': 'Default', 'settings': {'cool_down_sleep': False, 'restart_pogo': 0, 'walk_after_teleport_distance': '5.0'}}}
422018-12-24 08:11:54,928 [ scanner][WebsocketServerBase][ INFO] Allowed origins derived: ['071607f34fa91503']
432018-12-24 08:11:54,966 [ mitm_receiver][ _internal][ INFO] * Running on http://0.0.0.0:8000/ (Press CTRL+C to quit)
442018-12-24 08:11:54,968 [ madmin][ dbWrapperBase][ INFO] Connecting pool to DB
452018-12-24 08:11:54,978 [ madmin][ _internal][ INFO] * Running on http://0.0.0.0:5001/ (Press CTRL+C to quit)
462018-12-24 08:11:55,703 [ scanner][ protocol][ DEBUG] server - state = CONNECTING
472018-12-24 08:11:55,704 [ scanner][ protocol][ DEBUG] server - event = connection_made(<_SelectorSocketTransport fd=18 read=idle write=<idle, bufsize=0>>)
482018-12-24 08:11:55,707 [ scanner][ protocol][ DEBUG] server - state = OPEN
492018-12-24 08:11:55,708 [ scanner][WebsocketServerBase][ DEBUG] Waiting for connections
502018-12-24 08:11:55,708 [ scanner][WebsocketServerBase][ INFO] Client registering....
512018-12-24 08:11:55,710 [ 071607f34fa91503][ WorkerMITM][ INFO] MITM worker starting
522018-12-24 08:11:55,712 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Sending command: more topmost app
53
542018-12-24 08:11:55,712 [mitm_asyncio_071607f34fa91503][selector_events][ DEBUG] Using selector: EpollSelector
552018-12-24 08:11:55,712 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Sending:
562018-12-24 08:11:55,713 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] To be sent: 1;more topmost app
57
582018-12-24 08:11:55,713 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Timeout: 30
592018-12-24 08:11:55,730 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=1, data=b'1;more topmost app\r\n', rsv1=False, rsv2=False, rsv3=False)
602018-12-24 08:11:55,821 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=1, data=b'1;com.nianticlabs.pokemongo\r\n', rsv1=False, rsv2=False, rsv3=False)
612018-12-24 08:11:55,821 [ scanner][WebsocketServerBase][ DEBUG] Receiving message: 1;com.nianticlabs.pokemongo
62
632018-12-24 08:11:55,822 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received anser, popping response
642018-12-24 08:11:55,822 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received an answer
652018-12-24 08:11:55,822 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Answer: com.nianticlabs.pokemongo
66
672018-12-24 08:11:55,823 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received response: com.nianticlabs.pokemongo
68
692018-12-24 08:11:55,823 [ 071607f34fa91503][ WorkerMITM][ DEBUG] Worker: acquiring lock for restart check
702018-12-24 08:11:55,823 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Sending command: more topmost app
71
722018-12-24 08:11:55,823 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Sending:
732018-12-24 08:11:55,824 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] To be sent: 2;more topmost app
74
752018-12-24 08:11:55,824 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Timeout: 30
762018-12-24 08:11:55,833 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=1, data=b'2;more topmost app\r\n', rsv1=False, rsv2=False, rsv3=False)
772018-12-24 08:11:55,909 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=1, data=b'2;com.nianticlabs.pokemongo\r\n', rsv1=False, rsv2=False, rsv3=False)
782018-12-24 08:11:55,910 [ scanner][WebsocketServerBase][ DEBUG] Receiving message: 2;com.nianticlabs.pokemongo
79
802018-12-24 08:11:55,910 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received anser, popping response
812018-12-24 08:11:55,911 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received an answer
822018-12-24 08:11:55,911 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Answer: com.nianticlabs.pokemongo
83
842018-12-24 08:11:55,911 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received response: com.nianticlabs.pokemongo
85
862018-12-24 08:11:55,911 [ 071607f34fa91503][ WorkerMITM][ DEBUG] Worker: acquired lock
872018-12-24 08:11:55,912 [ 071607f34fa91503][ WorkerMITM][ DEBUG] Worker: lock released
882018-12-24 08:11:55,912 [ 071607f34fa91503][ RouteManager][ INFO] Round of route Default started at 2018-12-24 08:11:55.912323
892018-12-24 08:11:55,912 [ 071607f34fa91503][ RouteManager][ INFO] main: Moving on with gym at {'lat': 42.784961486346546, 'lng': -81.18314697749516}
902018-12-24 08:11:55,913 [ 071607f34fa91503][ WorkerMITM][ DEBUG] main: next stop: Location(lat=42.784961486346546, lng=-81.18314697749516)
912018-12-24 08:11:55,913 [ 071607f34fa91503][ WorkerMITM][ DEBUG] main: LastLat: 0.0, LastLng: 0.0, CurLat: 42.784961486346546, CurLng: -81.18314697749516
922018-12-24 08:11:55,913 [ 071607f34fa91503][ WorkerMITM][ INFO] main: Moving 9292259.950032946 meters to the next position
932018-12-24 08:11:55,914 [ 071607f34fa91503][ WorkerMITM][ DEBUG] Getting time
942018-12-24 08:11:55,914 [ 071607f34fa91503][ WorkerMITM][ INFO] main: Teleporting...
952018-12-24 08:11:55,914 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Sending command: geo fix 42.784961486346546 -81.18314697749516 0
96
972018-12-24 08:11:55,914 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Sending:
982018-12-24 08:11:55,915 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] To be sent: 3;geo fix 42.784961486346546 -81.18314697749516 0
99
1002018-12-24 08:11:55,915 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Timeout: 30
1012018-12-24 08:11:55,915 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=1, data=b'3;geo fix 42.784961486346546 -81.18314697749516 0\r\n', rsv1=False, rsv2=False, rsv3=False)
1022018-12-24 08:11:55,922 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=1, data=b'3;OK\r\n', rsv1=False, rsv2=False, rsv3=False)
1032018-12-24 08:11:55,923 [ scanner][WebsocketServerBase][ DEBUG] Receiving message: 3;OK
104
1052018-12-24 08:11:55,923 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received anser, popping response
1062018-12-24 08:11:55,924 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received an answer
1072018-12-24 08:11:55,924 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Answer: OK
108
1092018-12-24 08:11:55,924 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received response: OK
110
1112018-12-24 08:12:15,711 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\x9a\xe9\t\xea', rsv1=False, rsv2=False, rsv3=False)
1122018-12-24 08:12:15,885 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\x9a\xe9\t\xea', rsv1=False, rsv2=False, rsv3=False)
1132018-12-24 08:12:15,886 [ scanner][ protocol][ DEBUG] server - received solicited pong: 9ae909ea
1142018-12-24 08:12:35,887 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\x1bhH\r', rsv1=False, rsv2=False, rsv3=False)
1152018-12-24 08:12:35,891 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\x1bhH\r', rsv1=False, rsv2=False, rsv3=False)
1162018-12-24 08:12:35,892 [ scanner][ protocol][ DEBUG] server - received solicited pong: 1b68480d
1172018-12-24 08:12:55,755 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=9, data=b'', rsv1=False, rsv2=False, rsv3=False)
1182018-12-24 08:12:55,756 [ scanner][ protocol][ DEBUG] server - received ping, sending pong: [empty]
1192018-12-24 08:12:55,756 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=10, data=b'', rsv1=False, rsv2=False, rsv3=False)
1202018-12-24 08:12:55,893 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\xc5\xcb\xb3O', rsv1=False, rsv2=False, rsv3=False)
1212018-12-24 08:12:55,897 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\xc5\xcb\xb3O', rsv1=False, rsv2=False, rsv3=False)
1222018-12-24 08:12:55,898 [ scanner][ protocol][ DEBUG] server - received solicited pong: c5cbb34f
1232018-12-24 08:13:15,900 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'Y\xe0\xea\x91', rsv1=False, rsv2=False, rsv3=False)
1242018-12-24 08:13:16,616 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'Y\xe0\xea\x91', rsv1=False, rsv2=False, rsv3=False)
1252018-12-24 08:13:16,617 [ scanner][ protocol][ DEBUG] server - received solicited pong: 59e0ea91
1262018-12-24 08:13:36,618 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'S\x86\xa2\xb6', rsv1=False, rsv2=False, rsv3=False)
1272018-12-24 08:13:36,768 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'S\x86\xa2\xb6', rsv1=False, rsv2=False, rsv3=False)
1282018-12-24 08:13:36,768 [ scanner][ protocol][ DEBUG] server - received solicited pong: 5386a2b6
1292018-12-24 08:13:55,722 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=9, data=b'', rsv1=False, rsv2=False, rsv3=False)
1302018-12-24 08:13:55,723 [ scanner][ protocol][ DEBUG] server - received ping, sending pong: [empty]
1312018-12-24 08:13:55,723 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=10, data=b'', rsv1=False, rsv2=False, rsv3=False)
1322018-12-24 08:13:56,770 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b':>\xa8\x1f', rsv1=False, rsv2=False, rsv3=False)
1332018-12-24 08:13:56,842 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b':>\xa8\x1f', rsv1=False, rsv2=False, rsv3=False)
1342018-12-24 08:13:56,843 [ scanner][ protocol][ DEBUG] server - received solicited pong: 3a3ea81f
1352018-12-24 08:14:16,844 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'o\x9a\x01H', rsv1=False, rsv2=False, rsv3=False)
1362018-12-24 08:14:16,921 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'o\x9a\x01H', rsv1=False, rsv2=False, rsv3=False)
1372018-12-24 08:14:16,921 [ scanner][ protocol][ DEBUG] server - received solicited pong: 6f9a0148
1382018-12-24 08:14:21,773 [ Thread-20][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657261.7736301
1392018-12-24 08:14:21,774 [ Thread-20][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:14:21] "POST / HTTP/1.1" 200 -
1402018-12-24 08:14:21,791 [ Thread-21][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657261.791177
1412018-12-24 08:14:21,791 [ Thread-21][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:14:21] "POST / HTTP/1.1" 200 -
1422018-12-24 08:14:21,794 [ Thread-22][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657261.7949393
1432018-12-24 08:14:21,795 [ Thread-22][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:14:21] "POST / HTTP/1.1" 200 -
1442018-12-24 08:14:21,803 [ Thread-23][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657261.8038306
1452018-12-24 08:14:21,804 [ Thread-23][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:14:21] "POST / HTTP/1.1" 200 -
1462018-12-24 08:14:21,812 [ Thread-24][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545657261.8122633
1472018-12-24 08:14:21,813 [ Thread-24][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:14:21] "POST / HTTP/1.1" 200 -
1482018-12-24 08:14:21,946 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
1492018-12-24 08:14:21,946 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
1502018-12-24 08:14:21,947 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
1512018-12-24 08:14:21,949 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
1522018-12-24 08:14:21,951 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
1532018-12-24 08:14:21,951 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
1542018-12-24 08:14:21,951 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
1552018-12-24 08:14:21,952 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
1562018-12-24 08:14:21,953 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
1572018-12-24 08:14:22,789 [ Thread-26][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657262.7895837
1582018-12-24 08:14:22,790 [ Thread-26][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:14:22] "POST / HTTP/1.1" 200 -
1592018-12-24 08:14:22,792 [ Thread-25][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657262.7923806
1602018-12-24 08:14:22,793 [ Thread-25][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:14:22] "POST / HTTP/1.1" 200 -
1612018-12-24 08:14:22,796 [ Thread-28][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657262.7968748
1622018-12-24 08:14:22,798 [ Thread-28][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:14:22] "POST / HTTP/1.1" 200 -
1632018-12-24 08:14:22,798 [ Thread-27][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657262.7981596
1642018-12-24 08:14:22,799 [ Thread-27][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:14:22] "POST / HTTP/1.1" 200 -
1652018-12-24 08:14:22,803 [ Thread-29][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545657262.8031757
1662018-12-24 08:14:22,803 [ Thread-29][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:14:22] "POST / HTTP/1.1" 200 -
1672018-12-24 08:14:22,950 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
1682018-12-24 08:14:22,951 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
1692018-12-24 08:14:22,951 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
1702018-12-24 08:14:22,954 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
1712018-12-24 08:14:22,957 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
1722018-12-24 08:14:22,957 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
1732018-12-24 08:14:22,958 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
1742018-12-24 08:14:22,958 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
1752018-12-24 08:14:22,960 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
1762018-12-24 08:14:36,923 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'd\xcfU\xd5', rsv1=False, rsv2=False, rsv3=False)
1772018-12-24 08:14:37,184 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'd\xcfU\xd5', rsv1=False, rsv2=False, rsv3=False)
1782018-12-24 08:14:37,185 [ scanner][ protocol][ DEBUG] server - received solicited pong: 64cf55d5
1792018-12-24 08:14:52,796 [ Thread-30][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657292.7963939
1802018-12-24 08:14:52,797 [ Thread-30][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:14:52] "POST / HTTP/1.1" 200 -
1812018-12-24 08:14:52,806 [ Thread-31][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657292.8059726
1822018-12-24 08:14:52,806 [ Thread-31][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:14:52] "POST / HTTP/1.1" 200 -
1832018-12-24 08:14:52,814 [ Thread-32][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657292.8147182
1842018-12-24 08:14:52,815 [ Thread-32][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:14:52] "POST / HTTP/1.1" 200 -
1852018-12-24 08:14:52,827 [ Thread-33][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657292.8273046
1862018-12-24 08:14:52,827 [ Thread-33][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:14:52] "POST / HTTP/1.1" 200 -
1872018-12-24 08:14:52,911 [ Thread-34][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545657292.9112236
1882018-12-24 08:14:52,911 [ Thread-34][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:14:52] "POST / HTTP/1.1" 200 -
1892018-12-24 08:14:52,999 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
1902018-12-24 08:14:53,000 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
1912018-12-24 08:14:53,001 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
1922018-12-24 08:14:53,016 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
1932018-12-24 08:14:53,027 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
1942018-12-24 08:14:53,027 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
1952018-12-24 08:14:53,029 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
1962018-12-24 08:14:53,029 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
1972018-12-24 08:14:53,030 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
1982018-12-24 08:14:53,032 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
1992018-12-24 08:14:53,041 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
2002018-12-24 08:14:53,041 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
2012018-12-24 08:14:53,043 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #361 at 42.78478347201546, -81.18280250140161. Despawning at 2018-12-24 13:42:39 (non-init) (9358295669543)
2022018-12-24 08:14:53,043 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
2032018-12-24 08:14:53,044 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #48 at 42.785161915891486, -81.18280250140161. Despawning at 2018-12-24 13:19:53 (init) (9358295669573)
2042018-12-24 08:14:55,764 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=9, data=b'', rsv1=False, rsv2=False, rsv3=False)
2052018-12-24 08:14:55,764 [ scanner][ protocol][ DEBUG] server - received ping, sending pong: [empty]
2062018-12-24 08:14:55,765 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=10, data=b'', rsv1=False, rsv2=False, rsv3=False)
2072018-12-24 08:14:57,187 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'7&R\x1b', rsv1=False, rsv2=False, rsv3=False)
2082018-12-24 08:14:57,254 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'7&R\x1b', rsv1=False, rsv2=False, rsv3=False)
2092018-12-24 08:14:57,254 [ scanner][ protocol][ DEBUG] server - received solicited pong: 3726521b
2102018-12-24 08:15:17,256 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\xdc\xd8@c', rsv1=False, rsv2=False, rsv3=False)
2112018-12-24 08:15:17,323 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\xdc\xd8@c', rsv1=False, rsv2=False, rsv3=False)
2122018-12-24 08:15:17,323 [ scanner][ protocol][ DEBUG] server - received solicited pong: dcd84063
2132018-12-24 08:15:22,857 [ Thread-35][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657322.8572404
2142018-12-24 08:15:22,859 [ Thread-35][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:15:22] "POST / HTTP/1.1" 200 -
2152018-12-24 08:15:22,859 [ Thread-36][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657322.8587613
2162018-12-24 08:15:22,860 [ Thread-36][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:15:22] "POST / HTTP/1.1" 200 -
2172018-12-24 08:15:22,871 [ Thread-37][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657322.8714378
2182018-12-24 08:15:22,872 [ Thread-37][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:15:22] "POST / HTTP/1.1" 200 -
2192018-12-24 08:15:22,877 [ Thread-38][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657322.8777244
2202018-12-24 08:15:22,878 [ Thread-38][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:15:22] "POST / HTTP/1.1" 200 -
2212018-12-24 08:15:22,880 [ Thread-39][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657322.880577
2222018-12-24 08:15:22,881 [ Thread-39][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:15:22] "POST / HTTP/1.1" 200 -
2232018-12-24 08:15:22,956 [ Thread-40][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545657322.956729
2242018-12-24 08:15:22,957 [ Thread-40][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:15:22] "POST / HTTP/1.1" 200 -
2252018-12-24 08:15:23,048 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
2262018-12-24 08:15:23,049 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
2272018-12-24 08:15:23,049 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
2282018-12-24 08:15:23,063 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
2292018-12-24 08:15:23,080 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
2302018-12-24 08:15:23,080 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
2312018-12-24 08:15:23,082 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
2322018-12-24 08:15:23,082 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
2332018-12-24 08:15:23,083 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
2342018-12-24 08:15:23,085 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
2352018-12-24 08:15:23,093 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
2362018-12-24 08:15:23,093 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
2372018-12-24 08:15:23,094 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #361 at 42.78478347201546, -81.18280250140161. Despawning at 2018-12-24 13:42:39 (non-init) (9358295669543)
2382018-12-24 08:15:23,095 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
2392018-12-24 08:15:23,096 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #48 at 42.785161915891486, -81.18280250140161. Despawning at 2018-12-24 13:20:23 (init) (9358295669573)
2402018-12-24 08:15:37,325 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'y\x1a[w', rsv1=False, rsv2=False, rsv3=False)
2412018-12-24 08:15:37,393 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'y\x1a[w', rsv1=False, rsv2=False, rsv3=False)
2422018-12-24 08:15:37,394 [ scanner][ protocol][ DEBUG] server - received solicited pong: 791a5b77
2432018-12-24 08:15:52,902 [ Thread-42][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657352.9028506
2442018-12-24 08:15:52,904 [ Thread-42][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:15:52] "POST / HTTP/1.1" 200 -
2452018-12-24 08:15:52,904 [ Thread-41][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657352.9041708
2462018-12-24 08:15:52,905 [ Thread-41][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:15:52] "POST / HTTP/1.1" 200 -
2472018-12-24 08:15:52,908 [ Thread-43][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657352.9082441
2482018-12-24 08:15:52,908 [ Thread-43][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:15:52] "POST / HTTP/1.1" 200 -
2492018-12-24 08:15:52,916 [ Thread-44][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657352.9162488
2502018-12-24 08:15:52,917 [ Thread-44][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:15:52] "POST / HTTP/1.1" 200 -
2512018-12-24 08:15:53,014 [ Thread-45][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545657353.0148942
2522018-12-24 08:15:53,015 [ Thread-45][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:15:53] "POST / HTTP/1.1" 200 -
2532018-12-24 08:15:53,097 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
2542018-12-24 08:15:53,097 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
2552018-12-24 08:15:53,098 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
2562018-12-24 08:15:53,116 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
2572018-12-24 08:15:53,132 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
2582018-12-24 08:15:53,132 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
2592018-12-24 08:15:53,134 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
2602018-12-24 08:15:53,135 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
2612018-12-24 08:15:53,135 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
2622018-12-24 08:15:53,137 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
2632018-12-24 08:15:53,143 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
2642018-12-24 08:15:53,143 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
2652018-12-24 08:15:53,144 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #361 at 42.78478347201546, -81.18280250140161. Despawning at 2018-12-24 13:42:39 (non-init) (9358295669543)
2662018-12-24 08:15:53,145 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
2672018-12-24 08:15:53,146 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #48 at 42.785161915891486, -81.18280250140161. Despawning at 2018-12-24 13:20:53 (init) (9358295669573)
2682018-12-24 08:15:55,769 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=9, data=b'', rsv1=False, rsv2=False, rsv3=False)
2692018-12-24 08:15:55,769 [ scanner][ protocol][ DEBUG] server - received ping, sending pong: [empty]
2702018-12-24 08:15:55,770 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=10, data=b'', rsv1=False, rsv2=False, rsv3=False)
2712018-12-24 08:15:57,396 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\x1eO\x88\xac', rsv1=False, rsv2=False, rsv3=False)
2722018-12-24 08:15:58,180 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\x1eO\x88\xac', rsv1=False, rsv2=False, rsv3=False)
2732018-12-24 08:15:58,181 [ scanner][ protocol][ DEBUG] server - received solicited pong: 1e4f88ac
2742018-12-24 08:16:18,181 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\x0e\x0f\xe8\xbe', rsv1=False, rsv2=False, rsv3=False)
2752018-12-24 08:16:18,251 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\x0e\x0f\xe8\xbe', rsv1=False, rsv2=False, rsv3=False)
2762018-12-24 08:16:18,251 [ scanner][ protocol][ DEBUG] server - received solicited pong: 0e0fe8be
2772018-12-24 08:16:22,951 [ Thread-47][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657382.9518483
2782018-12-24 08:16:22,952 [ Thread-47][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:16:22] "POST / HTTP/1.1" 200 -
2792018-12-24 08:16:22,954 [ Thread-46][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657382.9541335
2802018-12-24 08:16:22,956 [ Thread-46][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:16:22] "POST / HTTP/1.1" 200 -
2812018-12-24 08:16:22,956 [ Thread-48][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657382.955686
2822018-12-24 08:16:22,957 [ Thread-48][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:16:22] "POST / HTTP/1.1" 200 -
2832018-12-24 08:16:22,974 [ Thread-49][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657382.9748106
2842018-12-24 08:16:22,975 [ Thread-49][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:16:22] "POST / HTTP/1.1" 200 -
2852018-12-24 08:16:23,091 [ Thread-50][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545657383.091903
2862018-12-24 08:16:23,092 [ Thread-50][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:16:23] "POST / HTTP/1.1" 200 -
2872018-12-24 08:16:23,146 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
2882018-12-24 08:16:23,147 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
2892018-12-24 08:16:23,148 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
2902018-12-24 08:16:23,160 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
2912018-12-24 08:16:23,183 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
2922018-12-24 08:16:23,183 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
2932018-12-24 08:16:23,185 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
2942018-12-24 08:16:23,185 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
2952018-12-24 08:16:23,185 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
2962018-12-24 08:16:23,187 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
2972018-12-24 08:16:23,198 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
2982018-12-24 08:16:23,199 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
2992018-12-24 08:16:23,200 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #361 at 42.78478347201546, -81.18280250140161. Despawning at 2018-12-24 13:42:39 (non-init) (9358295669543)
3002018-12-24 08:16:23,200 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
3012018-12-24 08:16:23,201 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #48 at 42.785161915891486, -81.18280250140161. Despawning at 2018-12-24 13:21:23 (init) (9358295669573)
3022018-12-24 08:16:38,252 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b's\x07\xcd\x0f', rsv1=False, rsv2=False, rsv3=False)
3032018-12-24 08:16:38,324 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b's\x07\xcd\x0f', rsv1=False, rsv2=False, rsv3=False)
3042018-12-24 08:16:38,325 [ scanner][ protocol][ DEBUG] server - received solicited pong: 7307cd0f
3052018-12-24 08:16:52,993 [ Thread-52][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657412.9931552
3062018-12-24 08:16:52,995 [ Thread-52][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:16:52] "POST / HTTP/1.1" 200 -
3072018-12-24 08:16:52,995 [ Thread-51][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657412.994677
3082018-12-24 08:16:52,997 [ Thread-51][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:16:52] "POST / HTTP/1.1" 200 -
3092018-12-24 08:16:52,998 [ Thread-53][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657412.9971607
3102018-12-24 08:16:52,999 [ Thread-53][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:16:52] "POST / HTTP/1.1" 200 -
3112018-12-24 08:16:53,009 [ Thread-54][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657413.0097544
3122018-12-24 08:16:53,010 [ Thread-54][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:16:53] "POST / HTTP/1.1" 200 -
3132018-12-24 08:16:53,080 [ Thread-55][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545657413.0803585
3142018-12-24 08:16:53,081 [ Thread-55][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:16:53] "POST / HTTP/1.1" 200 -
3152018-12-24 08:16:53,200 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
3162018-12-24 08:16:53,200 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
3172018-12-24 08:16:53,201 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
3182018-12-24 08:16:53,220 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
3192018-12-24 08:16:53,236 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
3202018-12-24 08:16:53,236 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
3212018-12-24 08:16:53,238 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
3222018-12-24 08:16:53,239 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
3232018-12-24 08:16:53,239 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
3242018-12-24 08:16:53,241 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
3252018-12-24 08:16:53,248 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
3262018-12-24 08:16:53,248 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
3272018-12-24 08:16:53,250 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #361 at 42.78478347201546, -81.18280250140161. Despawning at 2018-12-24 13:42:39 (non-init) (9358295669543)
3282018-12-24 08:16:53,250 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
3292018-12-24 08:16:53,251 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #48 at 42.785161915891486, -81.18280250140161. Despawning at 2018-12-24 13:21:53 (init) (9358295669573)
3302018-12-24 08:16:55,766 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=9, data=b'', rsv1=False, rsv2=False, rsv3=False)
3312018-12-24 08:16:55,766 [ scanner][ protocol][ DEBUG] server - received ping, sending pong: [empty]
3322018-12-24 08:16:55,767 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=10, data=b'', rsv1=False, rsv2=False, rsv3=False)
3332018-12-24 08:16:58,326 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\x88\xab\xd4\x15', rsv1=False, rsv2=False, rsv3=False)
3342018-12-24 08:16:58,393 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\x88\xab\xd4\x15', rsv1=False, rsv2=False, rsv3=False)
3352018-12-24 08:16:58,393 [ scanner][ protocol][ DEBUG] server - received solicited pong: 88abd415
3362018-12-24 08:17:18,395 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'T\x08\xc1\xda', rsv1=False, rsv2=False, rsv3=False)
3372018-12-24 08:17:18,465 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'T\x08\xc1\xda', rsv1=False, rsv2=False, rsv3=False)
3382018-12-24 08:17:18,466 [ scanner][ protocol][ DEBUG] server - received solicited pong: 5408c1da
3392018-12-24 08:17:24,071 [ Thread-56][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657444.0718682
3402018-12-24 08:17:24,072 [ Thread-56][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:17:24] "POST / HTTP/1.1" 200 -
3412018-12-24 08:17:24,074 [ Thread-58][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657444.0742989
3422018-12-24 08:17:24,076 [ Thread-58][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:17:24] "POST / HTTP/1.1" 200 -
3432018-12-24 08:17:24,077 [ Thread-57][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657444.075593
3442018-12-24 08:17:24,079 [ Thread-57][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:17:24] "POST / HTTP/1.1" 200 -
3452018-12-24 08:17:24,079 [ Thread-59][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657444.0789602
3462018-12-24 08:17:24,080 [ Thread-59][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:17:24] "POST / HTTP/1.1" 200 -
3472018-12-24 08:17:24,216 [ Thread-60][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545657444.2159202
3482018-12-24 08:17:24,216 [ Thread-60][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:17:24] "POST / HTTP/1.1" 200 -
3492018-12-24 08:17:24,252 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
3502018-12-24 08:17:24,253 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
3512018-12-24 08:17:24,254 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
3522018-12-24 08:17:24,266 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
3532018-12-24 08:17:24,280 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
3542018-12-24 08:17:24,280 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
3552018-12-24 08:17:24,282 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
3562018-12-24 08:17:24,283 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
3572018-12-24 08:17:24,283 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
3582018-12-24 08:17:24,286 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
3592018-12-24 08:17:24,296 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
3602018-12-24 08:17:24,296 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
3612018-12-24 08:17:24,298 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #361 at 42.78478347201546, -81.18280250140161. Despawning at 2018-12-24 13:42:39 (non-init) (9358295669543)
3622018-12-24 08:17:24,298 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
3632018-12-24 08:17:24,299 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #48 at 42.785161915891486, -81.18280250140161. Despawning at 2018-12-24 13:22:24 (init) (9358295669573)
3642018-12-24 08:17:38,469 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\x94\xb7!\xee', rsv1=False, rsv2=False, rsv3=False)
3652018-12-24 08:17:38,536 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\x94\xb7!\xee', rsv1=False, rsv2=False, rsv3=False)
3662018-12-24 08:17:38,537 [ scanner][ protocol][ DEBUG] server - received solicited pong: 94b721ee
3672018-12-24 08:17:54,095 [ Thread-61][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657474.0951667
3682018-12-24 08:17:54,095 [ Thread-61][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:17:54] "POST / HTTP/1.1" 200 -
3692018-12-24 08:17:54,100 [ Thread-62][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657474.100139
3702018-12-24 08:17:54,101 [ Thread-62][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:17:54] "POST / HTTP/1.1" 200 -
3712018-12-24 08:17:54,106 [ Thread-63][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657474.1059697
3722018-12-24 08:17:54,106 [ Thread-63][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:17:54] "POST / HTTP/1.1" 200 -
3732018-12-24 08:17:54,110 [ Thread-64][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657474.1100216
3742018-12-24 08:17:54,110 [ Thread-64][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:17:54] "POST / HTTP/1.1" 200 -
3752018-12-24 08:17:54,216 [ Thread-65][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545657474.2159357
3762018-12-24 08:17:54,216 [ Thread-65][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:17:54] "POST / HTTP/1.1" 200 -
3772018-12-24 08:17:54,304 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
3782018-12-24 08:17:54,305 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
3792018-12-24 08:17:54,306 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
3802018-12-24 08:17:54,320 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
3812018-12-24 08:17:54,331 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
3822018-12-24 08:17:54,332 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
3832018-12-24 08:17:54,332 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
3842018-12-24 08:17:54,332 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
3852018-12-24 08:17:54,333 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
3862018-12-24 08:17:54,334 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
3872018-12-24 08:17:54,342 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
3882018-12-24 08:17:54,342 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
3892018-12-24 08:17:54,343 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #361 at 42.78478347201546, -81.18280250140161. Despawning at 2018-12-24 13:42:39 (non-init) (9358295669543)
3902018-12-24 08:17:54,344 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
3912018-12-24 08:17:54,345 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #48 at 42.785161915891486, -81.18280250140161. Despawning at 2018-12-24 13:22:54 (init) (9358295669573)
3922018-12-24 08:17:55,723 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=9, data=b'', rsv1=False, rsv2=False, rsv3=False)
3932018-12-24 08:17:55,724 [ scanner][ protocol][ DEBUG] server - received ping, sending pong: [empty]
3942018-12-24 08:17:55,724 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=10, data=b'', rsv1=False, rsv2=False, rsv3=False)
3952018-12-24 08:17:58,539 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'A\xf7{\xd1', rsv1=False, rsv2=False, rsv3=False)
3962018-12-24 08:17:58,606 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'A\xf7{\xd1', rsv1=False, rsv2=False, rsv3=False)
3972018-12-24 08:17:58,607 [ scanner][ protocol][ DEBUG] server - received solicited pong: 41f77bd1
3982018-12-24 08:18:14,132 [ Thread-66][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657494.1319814
3992018-12-24 08:18:14,132 [ Thread-66][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:14] "POST / HTTP/1.1" 200 -
4002018-12-24 08:18:14,136 [ Thread-67][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657494.1368592
4012018-12-24 08:18:14,137 [ Thread-67][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:14] "POST / HTTP/1.1" 200 -
4022018-12-24 08:18:14,139 [ Thread-68][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657494.1397743
4032018-12-24 08:18:14,140 [ Thread-68][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:14] "POST / HTTP/1.1" 200 -
4042018-12-24 08:18:14,143 [ Thread-69][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657494.1431684
4052018-12-24 08:18:14,143 [ Thread-69][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:14] "POST / HTTP/1.1" 200 -
4062018-12-24 08:18:14,148 [ Thread-70][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657494.1484408
4072018-12-24 08:18:14,148 [ Thread-70][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:14] "POST / HTTP/1.1" 200 -
4082018-12-24 08:18:14,152 [ Thread-71][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657494.15294
4092018-12-24 08:18:14,153 [ Thread-71][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:14] "POST / HTTP/1.1" 200 -
4102018-12-24 08:18:15,166 [ Thread-72][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657495.1661055
4112018-12-24 08:18:15,166 [ Thread-72][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:15] "POST / HTTP/1.1" 200 -
4122018-12-24 08:18:15,168 [ Thread-73][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657495.168884
4132018-12-24 08:18:15,169 [ Thread-73][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:15] "POST / HTTP/1.1" 200 -
4142018-12-24 08:18:17,166 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=8, data=b'\x03\xe8', rsv1=False, rsv2=False, rsv3=False)
4152018-12-24 08:18:17,167 [ scanner][ protocol][ DEBUG] server - state = CLOSING
4162018-12-24 08:18:17,167 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=8, data=b'\x03\xe8', rsv1=False, rsv2=False, rsv3=False)
4172018-12-24 08:18:17,168 [ scanner][ protocol][ DEBUG] server x half-closing TCP connection
4182018-12-24 08:18:17,168 [ scanner][WebsocketServerBase][ DEBUG] Connection closed while receiving data
4192018-12-24 08:18:17,169 [ scanner][WebsocketServerBase][ DEBUG] Closed connection to 071607f34fa91503
4202018-12-24 08:18:17,169 [ scanner][WebsocketServerBase][ INFO] All done with 071607f34fa91503
4212018-12-24 08:18:17,173 [ scanner][ protocol][ DEBUG] server - event = eof_received()
4222018-12-24 08:18:17,173 [ scanner][ protocol][ DEBUG] server - event = connection_lost(None)
4232018-12-24 08:18:17,174 [ scanner][ protocol][ DEBUG] server - state = CLOSED
4242018-12-24 08:18:17,174 [ scanner][ protocol][ DEBUG] server x code = 1000, reason = [no reason]
4252018-12-24 08:18:19,708 [ scanner][ protocol][ DEBUG] server - state = CONNECTING
4262018-12-24 08:18:19,708 [ scanner][ protocol][ DEBUG] server - event = connection_made(<_SelectorSocketTransport fd=18 read=idle write=<idle, bufsize=0>>)
4272018-12-24 08:18:19,716 [ scanner][ protocol][ DEBUG] server - state = OPEN
4282018-12-24 08:18:19,717 [ scanner][WebsocketServerBase][ DEBUG] Waiting for connections
4292018-12-24 08:18:19,717 [ scanner][WebsocketServerBase][ INFO] Client registering....
4302018-12-24 08:18:19,719 [ 071607f34fa91503][ WorkerMITM][ INFO] MITM worker starting
4312018-12-24 08:18:19,720 [mitm_asyncio_071607f34fa91503][selector_events][ DEBUG] Using selector: EpollSelector
4322018-12-24 08:18:19,720 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Sending command: more topmost app
433
4342018-12-24 08:18:19,721 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Sending:
4352018-12-24 08:18:19,721 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] To be sent: 4;more topmost app
436
4372018-12-24 08:18:19,721 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Timeout: 30
4382018-12-24 08:18:19,739 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=1, data=b'4;more topmost app\r\n', rsv1=False, rsv2=False, rsv3=False)
4392018-12-24 08:18:19,868 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=1, data=b'4;org.lineageos.trebuchet\r\n', rsv1=False, rsv2=False, rsv3=False)
4402018-12-24 08:18:19,869 [ scanner][WebsocketServerBase][ DEBUG] Receiving message: 4;org.lineageos.trebuchet
441
4422018-12-24 08:18:19,869 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received anser, popping response
4432018-12-24 08:18:19,870 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received an answer
4442018-12-24 08:18:19,870 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Answer: org.lineageos.trebuchet
445
4462018-12-24 08:18:19,870 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received response: org.lineageos.trebuchet
447
4482018-12-24 08:18:19,870 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Sending command: more state screen
449
4502018-12-24 08:18:19,871 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Sending:
4512018-12-24 08:18:19,871 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] To be sent: 5;more state screen
452
4532018-12-24 08:18:19,871 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Timeout: 30
4542018-12-24 08:18:19,883 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=1, data=b'5;more state screen\r\n', rsv1=False, rsv2=False, rsv3=False)
4552018-12-24 08:18:19,995 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=1, data=b'5;on\r\n', rsv1=False, rsv2=False, rsv3=False)
4562018-12-24 08:18:19,996 [ scanner][WebsocketServerBase][ DEBUG] Receiving message: 5;on
457
4582018-12-24 08:18:19,997 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received anser, popping response
4592018-12-24 08:18:19,997 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received an answer
4602018-12-24 08:18:19,997 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Answer: on
461
4622018-12-24 08:18:19,998 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received response: on
463
4642018-12-24 08:18:19,998 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Sending command: more start com.nianticlabs.pokemongo
465
4662018-12-24 08:18:19,998 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Sending:
4672018-12-24 08:18:19,998 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] To be sent: 6;more start com.nianticlabs.pokemongo
468
4692018-12-24 08:18:19,999 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Timeout: 30
4702018-12-24 08:18:20,007 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=1, data=b'6;more start com.nianticlabs.pokemongo\r\n', rsv1=False, rsv2=False, rsv3=False)
4712018-12-24 08:18:20,041 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=1, data=b'6;OK\r\n', rsv1=False, rsv2=False, rsv3=False)
4722018-12-24 08:18:20,042 [ scanner][WebsocketServerBase][ DEBUG] Receiving message: 6;OK
473
4742018-12-24 08:18:20,042 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received anser, popping response
4752018-12-24 08:18:20,042 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received an answer
4762018-12-24 08:18:20,043 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Answer: OK
477
4782018-12-24 08:18:20,043 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received response: OK
479
4802018-12-24 08:18:21,045 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Sending command: more topmost app
481
4822018-12-24 08:18:21,045 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Sending:
4832018-12-24 08:18:21,046 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] To be sent: 7;more topmost app
484
4852018-12-24 08:18:21,046 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Timeout: 30
4862018-12-24 08:18:21,050 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=1, data=b'7;more topmost app\r\n', rsv1=False, rsv2=False, rsv3=False)
4872018-12-24 08:18:21,147 [ Thread-79][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657501.14724
4882018-12-24 08:18:21,148 [ Thread-79][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:21] "POST / HTTP/1.1" 200 -
4892018-12-24 08:18:21,149 [ Thread-80][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657501.1484997
4902018-12-24 08:18:21,150 [ Thread-80][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:21] "POST / HTTP/1.1" 200 -
4912018-12-24 08:18:21,153 [ Thread-82][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657501.1534548
4922018-12-24 08:18:21,154 [ Thread-82][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:21] "POST / HTTP/1.1" 200 -
4932018-12-24 08:18:21,158 [ Thread-81][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657501.158783
4942018-12-24 08:18:21,159 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=1, data=b'7;com.nianticlabs.pokemongo\r\n', rsv1=False, rsv2=False, rsv3=False)
4952018-12-24 08:18:21,159 [ Thread-81][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:21] "POST / HTTP/1.1" 200 -
4962018-12-24 08:18:21,160 [ scanner][WebsocketServerBase][ DEBUG] Receiving message: 7;com.nianticlabs.pokemongo
497
4982018-12-24 08:18:21,162 [ Thread-83][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657501.162251
4992018-12-24 08:18:21,162 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received anser, popping response
5002018-12-24 08:18:21,163 [ Thread-83][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:21] "POST / HTTP/1.1" 200 -
5012018-12-24 08:18:21,163 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received an answer
5022018-12-24 08:18:21,164 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Answer: com.nianticlabs.pokemongo
503
5042018-12-24 08:18:21,164 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received response: com.nianticlabs.pokemongo
505
5062018-12-24 08:18:21,165 [ 071607f34fa91503][ WorkerMITM][ WARNING] startPogo: Starting pogo...
5072018-12-24 08:18:24,180 [ Thread-84][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657504.180115
5082018-12-24 08:18:24,180 [ Thread-84][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:24] "POST / HTTP/1.1" 200 -
5092018-12-24 08:18:24,186 [ Thread-85][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657504.1863215
5102018-12-24 08:18:24,187 [ Thread-85][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:24] "POST / HTTP/1.1" 200 -
5112018-12-24 08:18:24,289 [ Thread-86][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545657504.2899044
5122018-12-24 08:18:24,290 [ Thread-86][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:24] "POST / HTTP/1.1" 200 -
5132018-12-24 08:18:24,327 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
5142018-12-24 08:18:24,328 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
5152018-12-24 08:18:24,329 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
5162018-12-24 08:18:24,340 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
5172018-12-24 08:18:24,356 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
5182018-12-24 08:18:24,356 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
5192018-12-24 08:18:24,358 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
5202018-12-24 08:18:24,359 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
5212018-12-24 08:18:24,359 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
5222018-12-24 08:18:24,362 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
5232018-12-24 08:18:24,373 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
5242018-12-24 08:18:24,373 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
5252018-12-24 08:18:24,374 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #361 at 42.78478347201546, -81.18280250140161. Despawning at 2018-12-24 13:42:39 (non-init) (9358295669543)
5262018-12-24 08:18:24,374 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
5272018-12-24 08:18:24,375 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #48 at 42.785161915891486, -81.18280250140161. Despawning at 2018-12-24 13:23:24 (init) (9358295669573)
5282018-12-24 08:18:27,193 [ Thread-87][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657507.1936944
5292018-12-24 08:18:27,195 [ Thread-87][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:27] "POST / HTTP/1.1" 200 -
5302018-12-24 08:18:27,197 [ Thread-88][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657507.197578
5312018-12-24 08:18:27,198 [ Thread-88][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:27] "POST / HTTP/1.1" 200 -
5322018-12-24 08:18:27,199 [ Thread-89][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657507.1996596
5332018-12-24 08:18:27,200 [ Thread-89][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:27] "POST / HTTP/1.1" 200 -
5342018-12-24 08:18:27,202 [ Thread-90][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657507.202283
5352018-12-24 08:18:27,202 [ Thread-90][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:27] "POST / HTTP/1.1" 200 -
5362018-12-24 08:18:31,179 [ Thread-91][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657511.1797557
5372018-12-24 08:18:31,180 [ Thread-91][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:31] "POST / HTTP/1.1" 200 -
5382018-12-24 08:18:34,205 [ Thread-92][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657514.205826
5392018-12-24 08:18:34,207 [ Thread-92][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:34] "POST / HTTP/1.1" 200 -
5402018-12-24 08:18:34,208 [ Thread-93][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657514.2071443
5412018-12-24 08:18:34,209 [ Thread-93][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:34] "POST / HTTP/1.1" 200 -
5422018-12-24 08:18:34,211 [ Thread-94][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657514.2111135
5432018-12-24 08:18:34,212 [ Thread-94][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:34] "POST / HTTP/1.1" 200 -
5442018-12-24 08:18:34,213 [ Thread-95][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657514.2139523
5452018-12-24 08:18:34,214 [ Thread-95][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:34] "POST / HTTP/1.1" 200 -
5462018-12-24 08:18:37,206 [ Thread-96][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657517.205972
5472018-12-24 08:18:37,206 [ Thread-96][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:37] "POST / HTTP/1.1" 200 -
5482018-12-24 08:18:39,721 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\x0b$\xf1N', rsv1=False, rsv2=False, rsv3=False)
5492018-12-24 08:18:39,771 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\x0b$\xf1N', rsv1=False, rsv2=False, rsv3=False)
5502018-12-24 08:18:39,772 [ scanner][ protocol][ DEBUG] server - received solicited pong: 0b24f14e
5512018-12-24 08:18:40,218 [ Thread-97][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657520.2187238
5522018-12-24 08:18:40,222 [ Thread-97][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:40] "POST / HTTP/1.1" 200 -
5532018-12-24 08:18:40,223 [ Thread-98][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657520.2205977
5542018-12-24 08:18:40,225 [ Thread-98][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:40] "POST / HTTP/1.1" 200 -
5552018-12-24 08:18:40,226 [ Thread-99][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657520.2220433
5562018-12-24 08:18:40,227 [ Thread-99][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:40] "POST / HTTP/1.1" 200 -
5572018-12-24 08:18:40,227 [ Thread-100][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657520.225021
5582018-12-24 08:18:40,227 [ Thread-100][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:40] "POST / HTTP/1.1" 200 -
5592018-12-24 08:18:44,216 [ Thread-101][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657524.216224
5602018-12-24 08:18:44,216 [ Thread-101][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:44] "POST / HTTP/1.1" 200 -
5612018-12-24 08:18:47,226 [ Thread-102][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657527.226345
5622018-12-24 08:18:47,231 [ Thread-102][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:47] "POST / HTTP/1.1" 200 -
5632018-12-24 08:18:47,231 [ Thread-103][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657527.2278128
5642018-12-24 08:18:47,232 [ Thread-103][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:47] "POST / HTTP/1.1" 200 -
5652018-12-24 08:18:47,232 [ Thread-104][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657527.2290444
5662018-12-24 08:18:47,233 [ Thread-104][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:47] "POST / HTTP/1.1" 200 -
5672018-12-24 08:18:47,234 [ Thread-105][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657527.2307303
5682018-12-24 08:18:47,234 [ Thread-105][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:47] "POST / HTTP/1.1" 200 -
5692018-12-24 08:18:50,219 [ Thread-106][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657530.2191296
5702018-12-24 08:18:50,219 [ Thread-106][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:50] "POST / HTTP/1.1" 200 -
5712018-12-24 08:18:53,238 [ Thread-107][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657533.2383792
5722018-12-24 08:18:53,239 [ Thread-107][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:53] "POST / HTTP/1.1" 200 -
5732018-12-24 08:18:53,262 [ Thread-108][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657533.2627506
5742018-12-24 08:18:53,265 [ Thread-108][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:53] "POST / HTTP/1.1" 200 -
5752018-12-24 08:18:53,266 [ Thread-109][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657533.2648468
5762018-12-24 08:18:53,267 [ Thread-109][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:53] "POST / HTTP/1.1" 200 -
5772018-12-24 08:18:53,268 [ Thread-110][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657533.2666576
5782018-12-24 08:18:53,269 [ Thread-110][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:53] "POST / HTTP/1.1" 200 -
5792018-12-24 08:18:54,248 [ Thread-111][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657534.248749
5802018-12-24 08:18:54,249 [ Thread-111][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:54] "POST / HTTP/1.1" 200 -
5812018-12-24 08:18:54,363 [ Thread-112][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545657534.3632884
5822018-12-24 08:18:54,364 [ Thread-112][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:54] "POST / HTTP/1.1" 200 -
5832018-12-24 08:18:54,378 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
5842018-12-24 08:18:54,379 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
5852018-12-24 08:18:54,380 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
5862018-12-24 08:18:54,398 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
5872018-12-24 08:18:54,412 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
5882018-12-24 08:18:54,412 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
5892018-12-24 08:18:54,414 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
5902018-12-24 08:18:54,414 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
5912018-12-24 08:18:54,415 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
5922018-12-24 08:18:54,417 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
5932018-12-24 08:18:54,425 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
5942018-12-24 08:18:54,425 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
5952018-12-24 08:18:54,426 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #361 at 42.78478347201546, -81.18280250140161. Despawning at 2018-12-24 13:42:39 (non-init) (9358295669543)
5962018-12-24 08:18:54,426 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
5972018-12-24 08:18:54,428 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #48 at 42.785161915891486, -81.18280250140161. Despawning at 2018-12-24 13:23:54 (init) (9358295669573)
5982018-12-24 08:18:56,271 [ Thread-113][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657536.2714884
5992018-12-24 08:18:56,272 [ Thread-113][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:56] "POST / HTTP/1.1" 200 -
6002018-12-24 08:18:59,279 [ Thread-114][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657539.2799156
6012018-12-24 08:18:59,280 [ Thread-114][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:59] "POST / HTTP/1.1" 200 -
6022018-12-24 08:18:59,286 [ Thread-116][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657539.2864614
6032018-12-24 08:18:59,289 [ Thread-116][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:59] "POST / HTTP/1.1" 200 -
6042018-12-24 08:18:59,289 [ Thread-117][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657539.287988
6052018-12-24 08:18:59,290 [ Thread-117][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:59] "POST / HTTP/1.1" 200 -
6062018-12-24 08:18:59,291 [ Thread-115][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657539.2894738
6072018-12-24 08:18:59,291 [ Thread-115][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:18:59] "POST / HTTP/1.1" 200 -
6082018-12-24 08:18:59,774 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\x12f, ', rsv1=False, rsv2=False, rsv3=False)
6092018-12-24 08:18:59,843 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\x12f, ', rsv1=False, rsv2=False, rsv3=False)
6102018-12-24 08:18:59,844 [ scanner][ protocol][ DEBUG] server - received solicited pong: 12662c20
6112018-12-24 08:19:03,273 [ Thread-118][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657543.2732935
6122018-12-24 08:19:03,273 [ Thread-118][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:03] "POST / HTTP/1.1" 200 -
6132018-12-24 08:19:06,272 [ Thread-119][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657546.272587
6142018-12-24 08:19:06,273 [ Thread-119][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:06] "POST / HTTP/1.1" 200 -
6152018-12-24 08:19:06,274 [ Thread-120][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657546.2749
6162018-12-24 08:19:06,276 [ Thread-120][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:06] "POST / HTTP/1.1" 200 -
6172018-12-24 08:19:06,278 [ Thread-121][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657546.278296
6182018-12-24 08:19:06,278 [ Thread-121][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:06] "POST / HTTP/1.1" 200 -
6192018-12-24 08:19:06,283 [ Thread-122][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657546.2839563
6202018-12-24 08:19:06,284 [ Thread-122][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:06] "POST / HTTP/1.1" 200 -
6212018-12-24 08:19:09,280 [ Thread-123][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657549.2807565
6222018-12-24 08:19:09,281 [ Thread-123][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:09] "POST / HTTP/1.1" 200 -
6232018-12-24 08:19:12,285 [ Thread-125][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657552.2853813
6242018-12-24 08:19:12,287 [ Thread-125][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:12] "POST / HTTP/1.1" 200 -
6252018-12-24 08:19:12,287 [ Thread-124][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657552.2868598
6262018-12-24 08:19:12,290 [ Thread-124][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:12] "POST / HTTP/1.1" 200 -
6272018-12-24 08:19:12,290 [ Thread-126][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657552.2888937
6282018-12-24 08:19:12,292 [ Thread-126][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:12] "POST / HTTP/1.1" 200 -
6292018-12-24 08:19:12,293 [ Thread-127][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657552.2920418
6302018-12-24 08:19:12,294 [ Thread-127][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:12] "POST / HTTP/1.1" 200 -
6312018-12-24 08:19:15,289 [ Thread-128][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657555.2894976
6322018-12-24 08:19:15,290 [ Thread-128][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:15] "POST / HTTP/1.1" 200 -
6332018-12-24 08:19:19,302 [ Thread-129][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657559.302329
6342018-12-24 08:19:19,303 [ Thread-129][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:19] "POST / HTTP/1.1" 200 -
6352018-12-24 08:19:19,304 [ Thread-131][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657559.3048763
6362018-12-24 08:19:19,305 [ Thread-131][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:19] "POST / HTTP/1.1" 200 -
6372018-12-24 08:19:19,307 [ Thread-130][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657559.3072622
6382018-12-24 08:19:19,308 [ Thread-130][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:19] "POST / HTTP/1.1" 200 -
6392018-12-24 08:19:19,310 [ Thread-132][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657559.3103251
6402018-12-24 08:19:19,311 [ Thread-132][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:19] "POST / HTTP/1.1" 200 -
6412018-12-24 08:19:19,729 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=9, data=b'', rsv1=False, rsv2=False, rsv3=False)
6422018-12-24 08:19:19,730 [ scanner][ protocol][ DEBUG] server - received ping, sending pong: [empty]
6432018-12-24 08:19:19,730 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=10, data=b'', rsv1=False, rsv2=False, rsv3=False)
6442018-12-24 08:19:19,845 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\xbb3\x7f\xcc', rsv1=False, rsv2=False, rsv3=False)
6452018-12-24 08:19:19,850 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\xbb3\x7f\xcc', rsv1=False, rsv2=False, rsv3=False)
6462018-12-24 08:19:19,851 [ scanner][ protocol][ DEBUG] server - received solicited pong: bb337fcc
6472018-12-24 08:19:21,225 [ 071607f34fa91503][ WorkerMITM][ DEBUG] Worker: acquiring lock for restart check
6482018-12-24 08:19:21,226 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Sending command: more topmost app
649
6502018-12-24 08:19:21,226 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Sending:
6512018-12-24 08:19:21,227 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] To be sent: 8;more topmost app
652
6532018-12-24 08:19:21,227 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Timeout: 30
6542018-12-24 08:19:21,229 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=1, data=b'8;more topmost app\r\n', rsv1=False, rsv2=False, rsv3=False)
6552018-12-24 08:19:21,328 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=1, data=b'8;com.nianticlabs.pokemongo\r\n', rsv1=False, rsv2=False, rsv3=False)
6562018-12-24 08:19:21,329 [ scanner][WebsocketServerBase][ DEBUG] Receiving message: 8;com.nianticlabs.pokemongo
657
6582018-12-24 08:19:21,330 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received anser, popping response
6592018-12-24 08:19:21,330 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received an answer
6602018-12-24 08:19:21,330 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Answer: com.nianticlabs.pokemongo
661
6622018-12-24 08:19:21,330 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received response: com.nianticlabs.pokemongo
663
6642018-12-24 08:19:21,331 [ 071607f34fa91503][ WorkerMITM][ DEBUG] Worker: acquired lock
6652018-12-24 08:19:21,331 [ 071607f34fa91503][ WorkerMITM][ DEBUG] Worker: lock released
6662018-12-24 08:19:21,331 [ 071607f34fa91503][ RouteManager][ INFO] main: Moving on with gym at {'lat': 42.783622375027676, 'lng': -81.18344840064591}
6672018-12-24 08:19:21,332 [ 071607f34fa91503][ WorkerMITM][ DEBUG] main: next stop: Location(lat=42.783622375027676, lng=-81.18344840064591)
6682018-12-24 08:19:21,332 [ 071607f34fa91503][ WorkerMITM][ DEBUG] main: LastLat: 0.0, LastLng: 0.0, CurLat: 42.783622375027676, CurLng: -81.18344840064591
6692018-12-24 08:19:21,332 [ 071607f34fa91503][ WorkerMITM][ INFO] main: Moving 9292268.81466955 meters to the next position
6702018-12-24 08:19:21,333 [ 071607f34fa91503][ WorkerMITM][ DEBUG] Getting time
6712018-12-24 08:19:21,333 [ 071607f34fa91503][ WorkerMITM][ INFO] main: Teleporting...
6722018-12-24 08:19:21,333 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Sending command: geo fix 42.783622375027676 -81.18344840064591 0
673
6742018-12-24 08:19:21,334 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Sending:
6752018-12-24 08:19:21,334 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] To be sent: 9;geo fix 42.783622375027676 -81.18344840064591 0
676
6772018-12-24 08:19:21,334 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Timeout: 30
6782018-12-24 08:19:21,354 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=1, data=b'9;geo fix 42.783622375027676 -81.18344840064591 0\r\n', rsv1=False, rsv2=False, rsv3=False)
6792018-12-24 08:19:21,366 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=1, data=b'9;OK\r\n', rsv1=False, rsv2=False, rsv3=False)
6802018-12-24 08:19:21,366 [ scanner][WebsocketServerBase][ DEBUG] Receiving message: 9;OK
681
6822018-12-24 08:19:21,367 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received anser, popping response
6832018-12-24 08:19:21,367 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received an answer
6842018-12-24 08:19:21,367 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Answer: OK
685
6862018-12-24 08:19:21,368 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received response: OK
687
6882018-12-24 08:19:22,295 [ Thread-133][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657562.295154
6892018-12-24 08:19:22,295 [ Thread-133][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:22] "POST / HTTP/1.1" 200 -
6902018-12-24 08:19:23,333 [ Thread-134][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657563.333747
6912018-12-24 08:19:23,334 [ Thread-134][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:23] "POST / HTTP/1.1" 200 -
6922018-12-24 08:19:23,363 [ Thread-135][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657563.363325
6932018-12-24 08:19:23,364 [ Thread-135][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:23] "POST / HTTP/1.1" 200 -
6942018-12-24 08:19:23,458 [ Thread-136][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545657563.4588833
6952018-12-24 08:19:23,459 [ Thread-136][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:23] "POST / HTTP/1.1" 200 -
6962018-12-24 08:19:23,628 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
6972018-12-24 08:19:23,629 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
6982018-12-24 08:19:23,629 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
6992018-12-24 08:19:23,643 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
7002018-12-24 08:19:23,654 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
7012018-12-24 08:19:23,654 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
7022018-12-24 08:19:23,655 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
7032018-12-24 08:19:23,655 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
7042018-12-24 08:19:23,655 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
7052018-12-24 08:19:23,656 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
7062018-12-24 08:19:23,666 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
7072018-12-24 08:19:23,666 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
7082018-12-24 08:19:23,668 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #361 at 42.7835924105845, -81.18306086207986. Despawning at 2018-12-24 13:24:23 (init) (9358295666645)
7092018-12-24 08:19:23,668 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
7102018-12-24 08:19:23,669 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #363 at 42.78379950493722, -81.18280250140161. Despawning at 2018-12-24 13:44:12 (non-init) (9358295666749)
7112018-12-24 08:19:25,343 [ Thread-137][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657565.3430285
7122018-12-24 08:19:25,344 [ Thread-137][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:25] "POST / HTTP/1.1" 200 -
7132018-12-24 08:19:25,345 [ Thread-138][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657565.3455288
7142018-12-24 08:19:25,346 [ Thread-138][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:25] "POST / HTTP/1.1" 200 -
7152018-12-24 08:19:25,350 [ Thread-139][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657565.3508472
7162018-12-24 08:19:25,351 [ Thread-139][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:25] "POST / HTTP/1.1" 200 -
7172018-12-24 08:19:28,358 [ Thread-140][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657568.3586888
7182018-12-24 08:19:28,359 [ Thread-140][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:28] "POST / HTTP/1.1" 200 -
7192018-12-24 08:19:28,419 [ Thread-141][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657568.4190025
7202018-12-24 08:19:28,420 [ Thread-141][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:28] "POST / HTTP/1.1" 200 -
7212018-12-24 08:19:32,368 [ Thread-143][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657572.3681765
7222018-12-24 08:19:32,369 [ Thread-143][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:32] "POST / HTTP/1.1" 200 -
7232018-12-24 08:19:32,370 [ Thread-142][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657572.3706672
7242018-12-24 08:19:32,373 [ Thread-142][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:32] "POST / HTTP/1.1" 200 -
7252018-12-24 08:19:32,373 [ Thread-144][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657572.3725994
7262018-12-24 08:19:32,374 [ Thread-144][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:32] "POST / HTTP/1.1" 200 -
7272018-12-24 08:19:35,376 [ Thread-145][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657575.3762357
7282018-12-24 08:19:35,378 [ Thread-145][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:35] "POST / HTTP/1.1" 200 -
7292018-12-24 08:19:35,378 [ Thread-146][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657575.3781505
7302018-12-24 08:19:35,379 [ Thread-146][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:35] "POST / HTTP/1.1" 200 -
7312018-12-24 08:19:38,375 [ Thread-147][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657578.374984
7322018-12-24 08:19:38,376 [ Thread-147][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:38] "POST / HTTP/1.1" 200 -
7332018-12-24 08:19:38,377 [ Thread-148][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657578.3764458
7342018-12-24 08:19:38,378 [ Thread-148][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:38] "POST / HTTP/1.1" 200 -
7352018-12-24 08:19:38,380 [ Thread-149][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657578.3805227
7362018-12-24 08:19:38,381 [ Thread-149][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:38] "POST / HTTP/1.1" 200 -
7372018-12-24 08:19:39,852 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\x9c\xe4\x0bV', rsv1=False, rsv2=False, rsv3=False)
7382018-12-24 08:19:39,881 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\x9c\xe4\x0bV', rsv1=False, rsv2=False, rsv3=False)
7392018-12-24 08:19:39,882 [ scanner][ protocol][ DEBUG] server - received solicited pong: 9ce40b56
7402018-12-24 08:19:41,383 [ Thread-150][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657581.3829749
7412018-12-24 08:19:41,384 [ Thread-150][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:41] "POST / HTTP/1.1" 200 -
7422018-12-24 08:19:41,384 [ Thread-151][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657581.3842037
7432018-12-24 08:19:41,385 [ Thread-151][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:41] "POST / HTTP/1.1" 200 -
7442018-12-24 08:19:44,389 [ Thread-152][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657584.389468
7452018-12-24 08:19:44,390 [ Thread-152][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:44] "POST / HTTP/1.1" 200 -
7462018-12-24 08:19:44,392 [ Thread-153][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657584.392187
7472018-12-24 08:19:44,395 [ Thread-153][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:44] "POST / HTTP/1.1" 200 -
7482018-12-24 08:19:44,396 [ Thread-154][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657584.3948445
7492018-12-24 08:19:44,396 [ Thread-154][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:44] "POST / HTTP/1.1" 200 -
7502018-12-24 08:19:48,400 [ Thread-156][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657588.4003463
7512018-12-24 08:19:48,402 [ Thread-156][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:48] "POST / HTTP/1.1" 200 -
7522018-12-24 08:19:48,402 [ Thread-155][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657588.4015963
7532018-12-24 08:19:48,403 [ Thread-155][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:48] "POST / HTTP/1.1" 200 -
7542018-12-24 08:19:51,414 [ Thread-158][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657591.4143362
7552018-12-24 08:19:51,415 [ Thread-158][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:51] "POST / HTTP/1.1" 200 -
7562018-12-24 08:19:51,418 [ Thread-159][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657591.418025
7572018-12-24 08:19:51,418 [ Thread-159][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:51] "POST / HTTP/1.1" 200 -
7582018-12-24 08:19:51,621 [ Thread-157][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657591.62135
7592018-12-24 08:19:51,622 [ Thread-157][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:51] "POST / HTTP/1.1" 200 -
7602018-12-24 08:19:52,439 [ Thread-161][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657592.4396772
7612018-12-24 08:19:52,440 [ Thread-161][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:52] "POST / HTTP/1.1" 200 -
7622018-12-24 08:19:52,443 [ Thread-160][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657592.4434774
7632018-12-24 08:19:52,444 [ Thread-160][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:52] "POST / HTTP/1.1" 200 -
7642018-12-24 08:19:52,541 [ Thread-162][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545657592.5417063
7652018-12-24 08:19:52,542 [ Thread-162][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:52] "POST / HTTP/1.1" 200 -
7662018-12-24 08:19:52,677 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
7672018-12-24 08:19:52,679 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
7682018-12-24 08:19:52,679 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
7692018-12-24 08:19:52,696 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
7702018-12-24 08:19:52,708 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
7712018-12-24 08:19:52,709 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
7722018-12-24 08:19:52,710 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
7732018-12-24 08:19:52,711 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
7742018-12-24 08:19:52,711 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
7752018-12-24 08:19:52,713 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
7762018-12-24 08:19:52,720 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
7772018-12-24 08:19:52,721 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
7782018-12-24 08:19:52,722 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #361 at 42.7835924105845, -81.18306086207986. Despawning at 2018-12-24 13:24:52 (init) (9358295666645)
7792018-12-24 08:19:52,722 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
7802018-12-24 08:19:52,723 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #363 at 42.78379950493722, -81.18280250140161. Despawning at 2018-12-24 13:44:12 (non-init) (9358295666749)
7812018-12-24 08:19:54,426 [ Thread-163][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657594.4262173
7822018-12-24 08:19:54,426 [ Thread-163][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:54] "POST / HTTP/1.1" 200 -
7832018-12-24 08:19:57,437 [ Thread-164][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657597.437595
7842018-12-24 08:19:57,438 [ Thread-164][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:57] "POST / HTTP/1.1" 200 -
7852018-12-24 08:19:57,439 [ Thread-165][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657597.4399145
7862018-12-24 08:19:57,440 [ Thread-165][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:57] "POST / HTTP/1.1" 200 -
7872018-12-24 08:19:57,444 [ Thread-167][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657597.4440086
7882018-12-24 08:19:57,445 [ Thread-167][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:57] "POST / HTTP/1.1" 200 -
7892018-12-24 08:19:57,445 [ Thread-166][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657597.4453027
7902018-12-24 08:19:57,446 [ Thread-166][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:19:57] "POST / HTTP/1.1" 200 -
7912018-12-24 08:19:59,883 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'h5\xeb\xdb', rsv1=False, rsv2=False, rsv3=False)
7922018-12-24 08:19:59,951 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'h5\xeb\xdb', rsv1=False, rsv2=False, rsv3=False)
7932018-12-24 08:19:59,952 [ scanner][ protocol][ DEBUG] server - received solicited pong: 6835ebdb
7942018-12-24 08:20:01,440 [ Thread-168][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657601.4407947
7952018-12-24 08:20:01,441 [ Thread-168][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:20:01] "POST / HTTP/1.1" 200 -
7962018-12-24 08:20:04,453 [ Thread-169][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657604.4531574
7972018-12-24 08:20:04,453 [ Thread-169][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:20:04] "POST / HTTP/1.1" 200 -
7982018-12-24 08:20:04,458 [ Thread-170][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657604.4583004
7992018-12-24 08:20:04,459 [ Thread-170][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:20:04] "POST / HTTP/1.1" 200 -
8002018-12-24 08:20:04,463 [ Thread-171][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657604.4632196
8012018-12-24 08:20:04,465 [ Thread-171][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:20:04] "POST / HTTP/1.1" 200 -
8022018-12-24 08:20:04,465 [ Thread-172][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657604.4642143
8032018-12-24 08:20:04,465 [ Thread-172][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:20:04] "POST / HTTP/1.1" 200 -
8042018-12-24 08:20:07,454 [ Thread-173][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657607.4542348
8052018-12-24 08:20:07,454 [ Thread-173][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:20:07] "POST / HTTP/1.1" 200 -
8062018-12-24 08:20:10,489 [ Thread-174][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657610.4893079
8072018-12-24 08:20:10,491 [ Thread-174][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:20:10] "POST / HTTP/1.1" 200 -
8082018-12-24 08:20:10,492 [ Thread-175][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657610.4908466
8092018-12-24 08:20:10,492 [ Thread-175][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:20:10] "POST / HTTP/1.1" 200 -
8102018-12-24 08:20:10,502 [ Thread-176][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657610.5023148
8112018-12-24 08:20:10,504 [ Thread-176][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:20:10] "POST / HTTP/1.1" 200 -
8122018-12-24 08:20:10,504 [ Thread-177][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657610.5038505
8132018-12-24 08:20:10,505 [ Thread-177][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:20:10] "POST / HTTP/1.1" 200 -
8142018-12-24 08:20:14,468 [ Thread-178][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657614.468742
8152018-12-24 08:20:14,469 [ Thread-178][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:20:14] "POST / HTTP/1.1" 200 -
8162018-12-24 08:20:17,482 [ Thread-179][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657617.4824247
8172018-12-24 08:20:17,483 [ Thread-179][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:20:17] "POST / HTTP/1.1" 200 -
8182018-12-24 08:20:17,489 [ Thread-180][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657617.489789
8192018-12-24 08:20:17,491 [ Thread-180][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:20:17] "POST / HTTP/1.1" 200 -
8202018-12-24 08:20:17,493 [ Thread-181][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657617.4935427
8212018-12-24 08:20:17,494 [ Thread-181][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:20:17] "POST / HTTP/1.1" 200 -
8222018-12-24 08:20:17,495 [ Thread-182][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657617.494398
8232018-12-24 08:20:17,495 [ Thread-182][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:20:17] "POST / HTTP/1.1" 200 -
8242018-12-24 08:20:19,730 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=9, data=b'', rsv1=False, rsv2=False, rsv3=False)
8252018-12-24 08:20:19,730 [ scanner][ protocol][ DEBUG] server - received ping, sending pong: [empty]
8262018-12-24 08:20:19,731 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=10, data=b'', rsv1=False, rsv2=False, rsv3=False)
8272018-12-24 08:20:19,953 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\xc72\x17\xd9', rsv1=False, rsv2=False, rsv3=False)
8282018-12-24 08:20:19,958 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\xc72\x17\xd9', rsv1=False, rsv2=False, rsv3=False)
8292018-12-24 08:20:19,959 [ scanner][ protocol][ DEBUG] server - received solicited pong: c73217d9
8302018-12-24 08:20:22,627 [ Thread-183][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657622.6272542
8312018-12-24 08:20:22,630 [ Thread-183][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:20:22] "POST / HTTP/1.1" 200 -
8322018-12-24 08:20:22,631 [ Thread-184][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657622.6295767
8332018-12-24 08:20:22,633 [ Thread-184][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:20:22] "POST / HTTP/1.1" 200 -
8342018-12-24 08:20:22,634 [ Thread-185][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657622.6314378
8352018-12-24 08:20:22,635 [ Thread-185][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:20:22] "POST / HTTP/1.1" 200 -
8362018-12-24 08:20:22,643 [ Thread-186][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545657622.6436148
8372018-12-24 08:20:22,644 [ Thread-186][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:20:22] "POST / HTTP/1.1" 200 -
8382018-12-24 08:20:22,728 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
8392018-12-24 08:20:22,729 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
8402018-12-24 08:20:22,730 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
8412018-12-24 08:20:22,743 [ Thread-187][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657622.7436206
8422018-12-24 08:20:22,744 [ Thread-187][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:20:22] "POST / HTTP/1.1" 200 -
8432018-12-24 08:20:22,747 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
8442018-12-24 08:20:22,763 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
8452018-12-24 08:20:22,763 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
8462018-12-24 08:20:22,765 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
8472018-12-24 08:20:22,765 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
8482018-12-24 08:20:22,766 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
8492018-12-24 08:20:22,767 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
8502018-12-24 08:20:22,774 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
8512018-12-24 08:20:22,774 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
8522018-12-24 08:20:22,776 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #361 at 42.7835924105845, -81.18306086207986. Despawning at 2018-12-24 13:25:22 (init) (9358295666645)
8532018-12-24 08:20:22,776 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
8542018-12-24 08:20:22,777 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #363 at 42.78379950493722, -81.18280250140161. Despawning at 2018-12-24 13:44:12 (non-init) (9358295666749)
8552018-12-24 08:20:39,960 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'E\xfa\xdf\xdb', rsv1=False, rsv2=False, rsv3=False)
8562018-12-24 08:20:39,990 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'E\xfa\xdf\xdb', rsv1=False, rsv2=False, rsv3=False)
8572018-12-24 08:20:39,991 [ scanner][ protocol][ DEBUG] server - received solicited pong: 45fadfdb
8582018-12-24 08:20:53,599 [ Thread-189][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657653.5993664
8592018-12-24 08:20:53,601 [ Thread-189][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:20:53] "POST / HTTP/1.1" 200 -
8602018-12-24 08:20:53,602 [ Thread-188][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657653.6009402
8612018-12-24 08:20:53,602 [ Thread-188][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:20:53] "POST / HTTP/1.1" 200 -
8622018-12-24 08:20:53,617 [ Thread-190][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657653.617192
8632018-12-24 08:20:53,617 [ Thread-190][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:20:53] "POST / HTTP/1.1" 200 -
8642018-12-24 08:20:53,620 [ Thread-191][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657653.6209285
8652018-12-24 08:20:53,621 [ Thread-191][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:20:53] "POST / HTTP/1.1" 200 -
8662018-12-24 08:20:53,745 [ Thread-192][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545657653.745128
8672018-12-24 08:20:53,746 [ Thread-192][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:20:53] "POST / HTTP/1.1" 200 -
8682018-12-24 08:20:53,780 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
8692018-12-24 08:20:53,781 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
8702018-12-24 08:20:53,782 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
8712018-12-24 08:20:53,798 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
8722018-12-24 08:20:53,815 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
8732018-12-24 08:20:53,815 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
8742018-12-24 08:20:53,817 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
8752018-12-24 08:20:53,817 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
8762018-12-24 08:20:53,818 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
8772018-12-24 08:20:53,820 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
8782018-12-24 08:20:53,826 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
8792018-12-24 08:20:53,827 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
8802018-12-24 08:20:53,828 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #361 at 42.7835924105845, -81.18306086207986. Despawning at 2018-12-24 13:25:53 (init) (9358295666645)
8812018-12-24 08:20:53,829 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
8822018-12-24 08:20:53,830 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #363 at 42.78379950493722, -81.18280250140161. Despawning at 2018-12-24 13:44:12 (non-init) (9358295666749)
8832018-12-24 08:20:59,992 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'C\x81\xd1\xda', rsv1=False, rsv2=False, rsv3=False)
8842018-12-24 08:21:00,491 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'C\x81\xd1\xda', rsv1=False, rsv2=False, rsv3=False)
8852018-12-24 08:21:00,492 [ scanner][ protocol][ DEBUG] server - received solicited pong: 4381d1da
8862018-12-24 08:21:19,738 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=9, data=b'', rsv1=False, rsv2=False, rsv3=False)
8872018-12-24 08:21:19,738 [ scanner][ protocol][ DEBUG] server - received ping, sending pong: [empty]
8882018-12-24 08:21:19,739 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=10, data=b'', rsv1=False, rsv2=False, rsv3=False)
8892018-12-24 08:21:20,494 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\xb4\x8eKB', rsv1=False, rsv2=False, rsv3=False)
8902018-12-24 08:21:20,671 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\xb4\x8eKB', rsv1=False, rsv2=False, rsv3=False)
8912018-12-24 08:21:20,672 [ scanner][ protocol][ DEBUG] server - received solicited pong: b48e4b42
8922018-12-24 08:21:23,657 [ Thread-193][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657683.6573813
8932018-12-24 08:21:23,658 [ Thread-193][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:21:23] "POST / HTTP/1.1" 200 -
8942018-12-24 08:21:23,659 [ Thread-194][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657683.659759
8952018-12-24 08:21:23,660 [ Thread-194][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:21:23] "POST / HTTP/1.1" 200 -
8962018-12-24 08:21:23,665 [ Thread-195][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657683.665168
8972018-12-24 08:21:23,665 [ Thread-195][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:21:23] "POST / HTTP/1.1" 200 -
8982018-12-24 08:21:23,673 [ Thread-196][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657683.6732697
8992018-12-24 08:21:23,673 [ Thread-196][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:21:23] "POST / HTTP/1.1" 200 -
9002018-12-24 08:21:23,785 [ Thread-197][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545657683.7852435
9012018-12-24 08:21:23,786 [ Thread-197][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:21:23] "POST / HTTP/1.1" 200 -
9022018-12-24 08:21:23,833 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
9032018-12-24 08:21:23,833 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
9042018-12-24 08:21:23,834 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
9052018-12-24 08:21:23,850 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
9062018-12-24 08:21:23,867 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
9072018-12-24 08:21:23,867 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
9082018-12-24 08:21:23,868 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
9092018-12-24 08:21:23,868 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
9102018-12-24 08:21:23,869 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
9112018-12-24 08:21:23,871 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
9122018-12-24 08:21:23,880 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
9132018-12-24 08:21:23,880 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
9142018-12-24 08:21:23,882 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #361 at 42.7835924105845, -81.18306086207986. Despawning at 2018-12-24 13:26:23 (init) (9358295666645)
9152018-12-24 08:21:23,882 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
9162018-12-24 08:21:23,884 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #363 at 42.78379950493722, -81.18280250140161. Despawning at 2018-12-24 13:44:12 (non-init) (9358295666749)
9172018-12-24 08:21:40,673 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\xa3Bv\xa3', rsv1=False, rsv2=False, rsv3=False)
9182018-12-24 08:21:40,768 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\xa3Bv\xa3', rsv1=False, rsv2=False, rsv3=False)
9192018-12-24 08:21:40,769 [ scanner][ protocol][ DEBUG] server - received solicited pong: a34276a3
9202018-12-24 08:21:53,693 [ Thread-198][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657713.6937163
9212018-12-24 08:21:53,695 [ Thread-198][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:21:53] "POST / HTTP/1.1" 200 -
9222018-12-24 08:21:53,697 [ Thread-200][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657713.6952615
9232018-12-24 08:21:53,699 [ Thread-200][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:21:53] "POST / HTTP/1.1" 200 -
9242018-12-24 08:21:53,700 [ Thread-199][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657713.6970985
9252018-12-24 08:21:53,700 [ Thread-199][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:21:53] "POST / HTTP/1.1" 200 -
9262018-12-24 08:21:53,701 [ Thread-201][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657713.6989987
9272018-12-24 08:21:53,702 [ Thread-201][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:21:53] "POST / HTTP/1.1" 200 -
9282018-12-24 08:21:53,810 [ Thread-202][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545657713.8101022
9292018-12-24 08:21:53,810 [ Thread-202][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:21:53] "POST / HTTP/1.1" 200 -
9302018-12-24 08:21:53,883 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
9312018-12-24 08:21:53,884 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
9322018-12-24 08:21:53,885 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
9332018-12-24 08:21:53,899 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
9342018-12-24 08:21:53,913 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
9352018-12-24 08:21:53,913 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
9362018-12-24 08:21:53,915 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
9372018-12-24 08:21:53,916 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
9382018-12-24 08:21:53,916 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
9392018-12-24 08:21:53,918 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
9402018-12-24 08:21:53,928 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
9412018-12-24 08:21:53,928 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
9422018-12-24 08:21:53,930 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #361 at 42.7835924105845, -81.18306086207986. Despawning at 2018-12-24 13:26:53 (init) (9358295666645)
9432018-12-24 08:21:53,930 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
9442018-12-24 08:21:53,931 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #363 at 42.78379950493722, -81.18280250140161. Despawning at 2018-12-24 13:44:12 (non-init) (9358295666749)
9452018-12-24 08:22:00,772 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\xc9wvo', rsv1=False, rsv2=False, rsv3=False)
9462018-12-24 08:22:00,890 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\xc9wvo', rsv1=False, rsv2=False, rsv3=False)
9472018-12-24 08:22:00,891 [ scanner][ protocol][ DEBUG] server - received solicited pong: c977766f
9482018-12-24 08:22:19,726 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=9, data=b'', rsv1=False, rsv2=False, rsv3=False)
9492018-12-24 08:22:19,727 [ scanner][ protocol][ DEBUG] server - received ping, sending pong: [empty]
9502018-12-24 08:22:19,727 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=10, data=b'', rsv1=False, rsv2=False, rsv3=False)
9512018-12-24 08:22:20,893 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\x8bE\xf7\xe1', rsv1=False, rsv2=False, rsv3=False)
9522018-12-24 08:22:21,782 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\x8bE\xf7\xe1', rsv1=False, rsv2=False, rsv3=False)
9532018-12-24 08:22:21,783 [ scanner][ protocol][ DEBUG] server - received solicited pong: 8b45f7e1
9542018-12-24 08:22:23,754 [ Thread-204][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657743.754124
9552018-12-24 08:22:23,755 [ Thread-204][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:22:23] "POST / HTTP/1.1" 200 -
9562018-12-24 08:22:23,756 [ Thread-203][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657743.7554898
9572018-12-24 08:22:23,757 [ Thread-203][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:22:23] "POST / HTTP/1.1" 200 -
9582018-12-24 08:22:23,760 [ Thread-205][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657743.7603986
9592018-12-24 08:22:23,760 [ Thread-205][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:22:23] "POST / HTTP/1.1" 200 -
9602018-12-24 08:22:23,772 [ Thread-206][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657743.7728531
9612018-12-24 08:22:23,773 [ Thread-206][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:22:23] "POST / HTTP/1.1" 200 -
9622018-12-24 08:22:23,885 [ Thread-207][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545657743.8852751
9632018-12-24 08:22:23,886 [ Thread-207][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:22:23] "POST / HTTP/1.1" 200 -
9642018-12-24 08:22:23,935 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
9652018-12-24 08:22:23,936 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
9662018-12-24 08:22:23,936 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
9672018-12-24 08:22:23,948 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
9682018-12-24 08:22:23,967 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
9692018-12-24 08:22:23,967 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
9702018-12-24 08:22:23,969 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
9712018-12-24 08:22:23,969 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
9722018-12-24 08:22:23,969 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
9732018-12-24 08:22:23,972 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
9742018-12-24 08:22:23,982 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
9752018-12-24 08:22:23,982 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
9762018-12-24 08:22:23,984 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #361 at 42.7835924105845, -81.18306086207986. Despawning at 2018-12-24 13:27:23 (init) (9358295666645)
9772018-12-24 08:22:23,985 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
9782018-12-24 08:22:23,987 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #363 at 42.78379950493722, -81.18280250140161. Despawning at 2018-12-24 13:44:12 (non-init) (9358295666749)
9792018-12-24 08:22:41,784 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\xdaL;\xa0', rsv1=False, rsv2=False, rsv3=False)
9802018-12-24 08:22:41,852 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\xdaL;\xa0', rsv1=False, rsv2=False, rsv3=False)
9812018-12-24 08:22:41,853 [ scanner][ protocol][ DEBUG] server - received solicited pong: da4c3ba0
9822018-12-24 08:22:53,806 [ Thread-208][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657773.8065226
9832018-12-24 08:22:53,808 [ Thread-208][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:22:53] "POST / HTTP/1.1" 200 -
9842018-12-24 08:22:53,808 [ Thread-209][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657773.8079047
9852018-12-24 08:22:53,809 [ Thread-209][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:22:53] "POST / HTTP/1.1" 200 -
9862018-12-24 08:22:53,812 [ Thread-210][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657773.8125374
9872018-12-24 08:22:53,813 [ Thread-210][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:22:53] "POST / HTTP/1.1" 200 -
9882018-12-24 08:22:53,814 [ Thread-211][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657773.8145905
9892018-12-24 08:22:53,815 [ Thread-211][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:22:53] "POST / HTTP/1.1" 200 -
9902018-12-24 08:22:53,938 [ Thread-212][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545657773.9383821
9912018-12-24 08:22:53,939 [ Thread-212][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:22:53] "POST / HTTP/1.1" 200 -
9922018-12-24 08:22:53,985 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
9932018-12-24 08:22:53,986 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
9942018-12-24 08:22:53,987 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
9952018-12-24 08:22:54,008 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
9962018-12-24 08:22:54,024 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
9972018-12-24 08:22:54,024 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
9982018-12-24 08:22:54,026 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
9992018-12-24 08:22:54,026 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
10002018-12-24 08:22:54,026 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
10012018-12-24 08:22:54,028 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
10022018-12-24 08:22:54,034 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
10032018-12-24 08:22:54,034 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
10042018-12-24 08:22:54,036 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #361 at 42.7835924105845, -81.18306086207986. Despawning at 2018-12-24 13:27:54 (init) (9358295666645)
10052018-12-24 08:22:54,036 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
10062018-12-24 08:22:54,038 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #363 at 42.78379950493722, -81.18280250140161. Despawning at 2018-12-24 13:44:12 (non-init) (9358295666749)
10072018-12-24 08:23:01,855 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\xe0\\\x8d\xa6', rsv1=False, rsv2=False, rsv3=False)
10082018-12-24 08:23:01,919 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\xe0\\\x8d\xa6', rsv1=False, rsv2=False, rsv3=False)
10092018-12-24 08:23:01,920 [ scanner][ protocol][ DEBUG] server - received solicited pong: e05c8da6
10102018-12-24 08:23:19,731 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=9, data=b'', rsv1=False, rsv2=False, rsv3=False)
10112018-12-24 08:23:19,732 [ scanner][ protocol][ DEBUG] server - received ping, sending pong: [empty]
10122018-12-24 08:23:19,732 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=10, data=b'', rsv1=False, rsv2=False, rsv3=False)
10132018-12-24 08:23:21,923 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'C\x06\xae\x1d', rsv1=False, rsv2=False, rsv3=False)
10142018-12-24 08:23:21,926 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'C\x06\xae\x1d', rsv1=False, rsv2=False, rsv3=False)
10152018-12-24 08:23:21,927 [ scanner][ protocol][ DEBUG] server - received solicited pong: 4306ae1d
10162018-12-24 08:23:23,837 [ Thread-213][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657803.8377357
10172018-12-24 08:23:23,838 [ Thread-213][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:23:23] "POST / HTTP/1.1" 200 -
10182018-12-24 08:23:23,840 [ Thread-215][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657803.8402426
10192018-12-24 08:23:23,842 [ Thread-215][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:23:23] "POST / HTTP/1.1" 200 -
10202018-12-24 08:23:23,843 [ Thread-214][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657803.841982
10212018-12-24 08:23:23,843 [ Thread-214][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:23:23] "POST / HTTP/1.1" 200 -
10222018-12-24 08:23:23,859 [ Thread-216][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657803.8596742
10232018-12-24 08:23:23,860 [ Thread-216][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:23:23] "POST / HTTP/1.1" 200 -
10242018-12-24 08:23:24,100 [ Thread-217][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545657804.1001043
10252018-12-24 08:23:24,100 [ Thread-217][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:23:24] "POST / HTTP/1.1" 200 -
10262018-12-24 08:23:24,236 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
10272018-12-24 08:23:24,237 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
10282018-12-24 08:23:24,237 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
10292018-12-24 08:23:24,255 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
10302018-12-24 08:23:24,269 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
10312018-12-24 08:23:24,269 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
10322018-12-24 08:23:24,271 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
10332018-12-24 08:23:24,271 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
10342018-12-24 08:23:24,272 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
10352018-12-24 08:23:24,274 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
10362018-12-24 08:23:24,281 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
10372018-12-24 08:23:24,281 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
10382018-12-24 08:23:24,283 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #361 at 42.7835924105845, -81.18306086207986. Despawning at 2018-12-24 13:28:24 (init) (9358295666645)
10392018-12-24 08:23:24,283 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
10402018-12-24 08:23:24,284 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #363 at 42.78379950493722, -81.18280250140161. Despawning at 2018-12-24 13:44:12 (non-init) (9358295666749)
10412018-12-24 08:23:41,928 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\x89\xafy,', rsv1=False, rsv2=False, rsv3=False)
10422018-12-24 08:23:41,957 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\x89\xafy,', rsv1=False, rsv2=False, rsv3=False)
10432018-12-24 08:23:41,958 [ scanner][ protocol][ DEBUG] server - received solicited pong: 89af792c
10442018-12-24 08:23:53,898 [ Thread-219][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657833.8988078
10452018-12-24 08:23:53,899 [ Thread-219][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:23:53] "POST / HTTP/1.1" 200 -
10462018-12-24 08:23:53,902 [ Thread-220][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657833.9020774
10472018-12-24 08:23:53,902 [ Thread-220][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:23:53] "POST / HTTP/1.1" 200 -
10482018-12-24 08:23:53,904 [ Thread-218][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657833.9043367
10492018-12-24 08:23:53,905 [ Thread-218][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:23:53] "POST / HTTP/1.1" 200 -
10502018-12-24 08:23:53,908 [ Thread-221][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657833.908761
10512018-12-24 08:23:53,909 [ Thread-221][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:23:53] "POST / HTTP/1.1" 200 -
10522018-12-24 08:23:54,029 [ Thread-222][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545657834.0289452
10532018-12-24 08:23:54,029 [ Thread-222][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:23:54] "POST / HTTP/1.1" 200 -
10542018-12-24 08:23:54,086 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
10552018-12-24 08:23:54,087 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
10562018-12-24 08:23:54,088 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
10572018-12-24 08:23:54,106 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
10582018-12-24 08:23:54,123 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
10592018-12-24 08:23:54,124 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
10602018-12-24 08:23:54,126 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
10612018-12-24 08:23:54,126 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
10622018-12-24 08:23:54,127 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
10632018-12-24 08:23:54,129 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
10642018-12-24 08:23:54,140 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
10652018-12-24 08:23:54,141 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
10662018-12-24 08:23:54,143 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #361 at 42.7835924105845, -81.18306086207986. Despawning at 2018-12-24 13:28:54 (init) (9358295666645)
10672018-12-24 08:23:54,143 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
10682018-12-24 08:23:54,145 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #363 at 42.78379950493722, -81.18280250140161. Despawning at 2018-12-24 13:44:12 (non-init) (9358295666749)
10692018-12-24 08:24:01,960 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\x1a\x97m\xc6', rsv1=False, rsv2=False, rsv3=False)
10702018-12-24 08:24:02,031 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\x1a\x97m\xc6', rsv1=False, rsv2=False, rsv3=False)
10712018-12-24 08:24:02,032 [ scanner][ protocol][ DEBUG] server - received solicited pong: 1a976dc6
10722018-12-24 08:24:19,730 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=9, data=b'', rsv1=False, rsv2=False, rsv3=False)
10732018-12-24 08:24:19,731 [ scanner][ protocol][ DEBUG] server - received ping, sending pong: [empty]
10742018-12-24 08:24:19,731 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=10, data=b'', rsv1=False, rsv2=False, rsv3=False)
10752018-12-24 08:24:22,033 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\x14\xc2\t\xe6', rsv1=False, rsv2=False, rsv3=False)
10762018-12-24 08:24:22,099 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\x14\xc2\t\xe6', rsv1=False, rsv2=False, rsv3=False)
10772018-12-24 08:24:22,100 [ scanner][ protocol][ DEBUG] server - received solicited pong: 14c209e6
10782018-12-24 08:24:23,942 [ Thread-223][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657863.9429345
10792018-12-24 08:24:23,944 [ Thread-223][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:24:23] "POST / HTTP/1.1" 200 -
10802018-12-24 08:24:23,945 [ Thread-224][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657863.9443815
10812018-12-24 08:24:23,945 [ Thread-224][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:24:23] "POST / HTTP/1.1" 200 -
10822018-12-24 08:24:23,954 [ Thread-225][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657863.9542685
10832018-12-24 08:24:23,954 [ Thread-225][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:24:23] "POST / HTTP/1.1" 200 -
10842018-12-24 08:24:23,963 [ Thread-226][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657863.9636495
10852018-12-24 08:24:23,964 [ Thread-226][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:24:23] "POST / HTTP/1.1" 200 -
10862018-12-24 08:24:24,091 [ Thread-227][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545657864.0909483
10872018-12-24 08:24:24,091 [ Thread-227][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:24:24] "POST / HTTP/1.1" 200 -
10882018-12-24 08:24:24,138 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
10892018-12-24 08:24:24,138 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
10902018-12-24 08:24:24,139 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
10912018-12-24 08:24:24,158 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
10922018-12-24 08:24:24,170 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
10932018-12-24 08:24:24,170 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
10942018-12-24 08:24:24,171 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
10952018-12-24 08:24:24,171 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
10962018-12-24 08:24:24,171 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
10972018-12-24 08:24:24,173 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
10982018-12-24 08:24:24,179 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
10992018-12-24 08:24:24,179 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
11002018-12-24 08:24:24,180 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #361 at 42.7835924105845, -81.18306086207986. Despawning at 2018-12-24 13:29:24 (init) (9358295666645)
11012018-12-24 08:24:24,181 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
11022018-12-24 08:24:24,182 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #363 at 42.78379950493722, -81.18280250140161. Despawning at 2018-12-24 13:44:12 (non-init) (9358295666749)
11032018-12-24 08:24:42,101 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\xef\xdf\x936', rsv1=False, rsv2=False, rsv3=False)
11042018-12-24 08:24:42,170 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\xef\xdf\x936', rsv1=False, rsv2=False, rsv3=False)
11052018-12-24 08:24:42,170 [ scanner][ protocol][ DEBUG] server - received solicited pong: efdf9336
11062018-12-24 08:24:54,030 [ Thread-229][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657894.030644
11072018-12-24 08:24:54,032 [ Thread-229][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:24:54] "POST / HTTP/1.1" 200 -
11082018-12-24 08:24:54,033 [ Thread-228][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657894.0322056
11092018-12-24 08:24:54,034 [ Thread-228][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:24:54] "POST / HTTP/1.1" 200 -
11102018-12-24 08:24:54,047 [ Thread-230][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657894.0473268
11112018-12-24 08:24:54,048 [ Thread-230][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:24:54] "POST / HTTP/1.1" 200 -
11122018-12-24 08:24:54,054 [ Thread-231][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657894.054649
11132018-12-24 08:24:54,055 [ Thread-231][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:24:54] "POST / HTTP/1.1" 200 -
11142018-12-24 08:24:54,134 [ Thread-232][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545657894.1344252
11152018-12-24 08:24:54,135 [ Thread-232][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:24:54] "POST / HTTP/1.1" 200 -
11162018-12-24 08:24:54,187 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
11172018-12-24 08:24:54,188 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
11182018-12-24 08:24:54,188 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
11192018-12-24 08:24:54,200 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
11202018-12-24 08:24:54,215 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
11212018-12-24 08:24:54,215 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
11222018-12-24 08:24:54,217 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
11232018-12-24 08:24:54,217 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
11242018-12-24 08:24:54,217 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
11252018-12-24 08:24:54,219 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
11262018-12-24 08:24:54,228 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
11272018-12-24 08:24:54,229 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
11282018-12-24 08:24:54,230 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #361 at 42.7835924105845, -81.18306086207986. Despawning at 2018-12-24 13:29:54 (init) (9358295666645)
11292018-12-24 08:24:54,231 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
11302018-12-24 08:24:54,232 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #363 at 42.78379950493722, -81.18280250140161. Despawning at 2018-12-24 13:44:12 (non-init) (9358295666749)
11312018-12-24 08:25:02,172 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'9\xf6\x88>', rsv1=False, rsv2=False, rsv3=False)
11322018-12-24 08:25:02,240 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'9\xf6\x88>', rsv1=False, rsv2=False, rsv3=False)
11332018-12-24 08:25:02,241 [ scanner][ protocol][ DEBUG] server - received solicited pong: 39f6883e
11342018-12-24 08:25:19,731 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=9, data=b'', rsv1=False, rsv2=False, rsv3=False)
11352018-12-24 08:25:19,731 [ scanner][ protocol][ DEBUG] server - received ping, sending pong: [empty]
11362018-12-24 08:25:19,732 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=10, data=b'', rsv1=False, rsv2=False, rsv3=False)
11372018-12-24 08:25:22,242 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\xab\x00\x01.', rsv1=False, rsv2=False, rsv3=False)
11382018-12-24 08:25:22,312 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\xab\x00\x01.', rsv1=False, rsv2=False, rsv3=False)
11392018-12-24 08:25:22,312 [ scanner][ protocol][ DEBUG] server - received solicited pong: ab00012e
11402018-12-24 08:25:25,074 [ Thread-233][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657925.0747547
11412018-12-24 08:25:25,075 [ Thread-233][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:25:25] "POST / HTTP/1.1" 200 -
11422018-12-24 08:25:25,078 [ Thread-235][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657925.0788372
11432018-12-24 08:25:25,080 [ Thread-235][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:25:25] "POST / HTTP/1.1" 200 -
11442018-12-24 08:25:25,081 [ Thread-234][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657925.0802352
11452018-12-24 08:25:25,081 [ Thread-234][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:25:25] "POST / HTTP/1.1" 200 -
11462018-12-24 08:25:25,090 [ Thread-236][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657925.090156
11472018-12-24 08:25:25,090 [ Thread-236][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:25:25] "POST / HTTP/1.1" 200 -
11482018-12-24 08:25:25,181 [ Thread-237][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545657925.1811638
11492018-12-24 08:25:25,182 [ Thread-237][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:25:25] "POST / HTTP/1.1" 200 -
11502018-12-24 08:25:25,239 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
11512018-12-24 08:25:25,240 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
11522018-12-24 08:25:25,240 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
11532018-12-24 08:25:25,259 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
11542018-12-24 08:25:25,270 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
11552018-12-24 08:25:25,270 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
11562018-12-24 08:25:25,272 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
11572018-12-24 08:25:25,272 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
11582018-12-24 08:25:25,272 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
11592018-12-24 08:25:25,274 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
11602018-12-24 08:25:25,281 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
11612018-12-24 08:25:25,281 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
11622018-12-24 08:25:25,283 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #361 at 42.7835924105845, -81.18306086207986. Despawning at 2018-12-24 13:30:25 (init) (9358295666645)
11632018-12-24 08:25:25,283 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
11642018-12-24 08:25:25,284 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #363 at 42.78379950493722, -81.18280250140161. Despawning at 2018-12-24 13:44:12 (non-init) (9358295666749)
11652018-12-24 08:25:42,314 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'x\xfc\xe2\xe7', rsv1=False, rsv2=False, rsv3=False)
11662018-12-24 08:25:42,382 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'x\xfc\xe2\xe7', rsv1=False, rsv2=False, rsv3=False)
11672018-12-24 08:25:42,383 [ scanner][ protocol][ DEBUG] server - received solicited pong: 78fce2e7
11682018-12-24 08:25:55,140 [ Thread-239][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657955.1399848
11692018-12-24 08:25:55,142 [ Thread-239][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:25:55] "POST / HTTP/1.1" 200 -
11702018-12-24 08:25:55,143 [ Thread-238][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657955.1415617
11712018-12-24 08:25:55,144 [ Thread-238][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:25:55] "POST / HTTP/1.1" 200 -
11722018-12-24 08:25:55,144 [ Thread-240][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657955.1425123
11732018-12-24 08:25:55,146 [ Thread-240][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:25:55] "POST / HTTP/1.1" 200 -
11742018-12-24 08:25:55,147 [ Thread-241][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657955.1478245
11752018-12-24 08:25:55,149 [ Thread-241][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:25:55] "POST / HTTP/1.1" 200 -
11762018-12-24 08:25:55,285 [ Thread-242][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545657955.2855847
11772018-12-24 08:25:55,286 [ Thread-242][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:25:55] "POST / HTTP/1.1" 200 -
11782018-12-24 08:25:55,289 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
11792018-12-24 08:25:55,289 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
11802018-12-24 08:25:55,290 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
11812018-12-24 08:25:55,303 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
11822018-12-24 08:25:55,320 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
11832018-12-24 08:25:55,321 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
11842018-12-24 08:25:55,323 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
11852018-12-24 08:25:55,323 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
11862018-12-24 08:25:55,324 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
11872018-12-24 08:25:55,326 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
11882018-12-24 08:25:55,336 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
11892018-12-24 08:25:55,336 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
11902018-12-24 08:25:55,338 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #361 at 42.7835924105845, -81.18306086207986. Despawning at 2018-12-24 13:30:55 (init) (9358295666645)
11912018-12-24 08:25:55,338 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
11922018-12-24 08:25:55,339 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #363 at 42.78379950493722, -81.18280250140161. Despawning at 2018-12-24 13:44:12 (non-init) (9358295666749)
11932018-12-24 08:26:02,384 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\xf1\x85\xff5', rsv1=False, rsv2=False, rsv3=False)
11942018-12-24 08:26:02,454 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\xf1\x85\xff5', rsv1=False, rsv2=False, rsv3=False)
11952018-12-24 08:26:02,455 [ scanner][ protocol][ DEBUG] server - received solicited pong: f185ff35
11962018-12-24 08:26:19,730 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=9, data=b'', rsv1=False, rsv2=False, rsv3=False)
11972018-12-24 08:26:19,731 [ scanner][ protocol][ DEBUG] server - received ping, sending pong: [empty]
11982018-12-24 08:26:19,731 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=10, data=b'', rsv1=False, rsv2=False, rsv3=False)
11992018-12-24 08:26:22,456 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'g\xa6\xf1\x1f', rsv1=False, rsv2=False, rsv3=False)
12002018-12-24 08:26:22,549 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'g\xa6\xf1\x1f', rsv1=False, rsv2=False, rsv3=False)
12012018-12-24 08:26:22,550 [ scanner][ protocol][ DEBUG] server - received solicited pong: 67a6f11f
12022018-12-24 08:26:25,180 [ Thread-243][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545657985.1800427
12032018-12-24 08:26:25,180 [ Thread-243][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:26:25] "POST / HTTP/1.1" 200 -
12042018-12-24 08:26:25,183 [ Thread-244][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545657985.1838367
12052018-12-24 08:26:25,184 [ Thread-244][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:26:25] "POST / HTTP/1.1" 200 -
12062018-12-24 08:26:25,189 [ Thread-245][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545657985.189201
12072018-12-24 08:26:25,189 [ Thread-245][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:26:25] "POST / HTTP/1.1" 200 -
12082018-12-24 08:26:25,191 [ Thread-246][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545657985.1910055
12092018-12-24 08:26:25,191 [ Thread-246][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:26:25] "POST / HTTP/1.1" 200 -
12102018-12-24 08:26:25,326 [ Thread-247][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545657985.3262033
12112018-12-24 08:26:25,327 [ Thread-247][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:26:25] "POST / HTTP/1.1" 200 -
12122018-12-24 08:26:25,339 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
12132018-12-24 08:26:25,340 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
12142018-12-24 08:26:25,340 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
12152018-12-24 08:26:25,356 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
12162018-12-24 08:26:25,373 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
12172018-12-24 08:26:25,373 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
12182018-12-24 08:26:25,374 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
12192018-12-24 08:26:25,374 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
12202018-12-24 08:26:25,374 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
12212018-12-24 08:26:25,376 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
12222018-12-24 08:26:25,382 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
12232018-12-24 08:26:25,382 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
12242018-12-24 08:26:25,383 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #361 at 42.7835924105845, -81.18306086207986. Despawning at 2018-12-24 13:31:25 (init) (9358295666645)
12252018-12-24 08:26:25,383 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
12262018-12-24 08:26:25,385 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #363 at 42.78379950493722, -81.18280250140161. Despawning at 2018-12-24 13:44:12 (non-init) (9358295666749)
12272018-12-24 08:26:42,551 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\x86yqE', rsv1=False, rsv2=False, rsv3=False)
12282018-12-24 08:26:42,559 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\x86yqE', rsv1=False, rsv2=False, rsv3=False)
12292018-12-24 08:26:42,559 [ scanner][ protocol][ DEBUG] server - received solicited pong: 86797145
12302018-12-24 08:26:55,227 [ Thread-248][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545658015.2270963
12312018-12-24 08:26:55,227 [ Thread-248][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:26:55] "POST / HTTP/1.1" 200 -
12322018-12-24 08:26:55,231 [ Thread-249][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545658015.2313986
12332018-12-24 08:26:55,232 [ Thread-249][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:26:55] "POST / HTTP/1.1" 200 -
12342018-12-24 08:26:55,234 [ Thread-250][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545658015.234154
12352018-12-24 08:26:55,236 [ Thread-250][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:26:55] "POST / HTTP/1.1" 200 -
12362018-12-24 08:26:55,236 [ Thread-251][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545658015.2359762
12372018-12-24 08:26:55,237 [ Thread-251][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:26:55] "POST / HTTP/1.1" 200 -
12382018-12-24 08:26:55,360 [ Thread-252][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545658015.3601005
12392018-12-24 08:26:55,361 [ Thread-252][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:26:55] "POST / HTTP/1.1" 200 -
12402018-12-24 08:26:55,389 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
12412018-12-24 08:26:55,390 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
12422018-12-24 08:26:55,391 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
12432018-12-24 08:26:55,406 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
12442018-12-24 08:26:55,425 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
12452018-12-24 08:26:55,426 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
12462018-12-24 08:26:55,428 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
12472018-12-24 08:26:55,428 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
12482018-12-24 08:26:55,428 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
12492018-12-24 08:26:55,430 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
12502018-12-24 08:26:55,439 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
12512018-12-24 08:26:55,439 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
12522018-12-24 08:26:55,440 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #361 at 42.7835924105845, -81.18306086207986. Despawning at 2018-12-24 13:31:55 (init) (9358295666645)
12532018-12-24 08:26:55,440 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
12542018-12-24 08:26:55,442 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #363 at 42.78379950493722, -81.18280250140161. Despawning at 2018-12-24 13:44:12 (non-init) (9358295666749)
12552018-12-24 08:27:02,561 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\x00\x83\xc6\xc1', rsv1=False, rsv2=False, rsv3=False)
12562018-12-24 08:27:02,665 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\x00\x83\xc6\xc1', rsv1=False, rsv2=False, rsv3=False)
12572018-12-24 08:27:02,666 [ scanner][ protocol][ DEBUG] server - received solicited pong: 0083c6c1
12582018-12-24 08:27:19,732 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=9, data=b'', rsv1=False, rsv2=False, rsv3=False)
12592018-12-24 08:27:19,732 [ scanner][ protocol][ DEBUG] server - received ping, sending pong: [empty]
12602018-12-24 08:27:19,733 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=10, data=b'', rsv1=False, rsv2=False, rsv3=False)
12612018-12-24 08:27:22,669 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'@\xfc\x80Q', rsv1=False, rsv2=False, rsv3=False)
12622018-12-24 08:27:22,735 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'@\xfc\x80Q', rsv1=False, rsv2=False, rsv3=False)
12632018-12-24 08:27:22,736 [ scanner][ protocol][ DEBUG] server - received solicited pong: 40fc8051
12642018-12-24 08:27:25,282 [ Thread-253][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545658045.2827182
12652018-12-24 08:27:25,283 [ Thread-253][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:27:25] "POST / HTTP/1.1" 200 -
12662018-12-24 08:27:25,284 [ Thread-254][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545658045.2849565
12672018-12-24 08:27:25,285 [ Thread-254][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:27:25] "POST / HTTP/1.1" 200 -
12682018-12-24 08:27:25,287 [ Thread-255][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545658045.2878435
12692018-12-24 08:27:25,288 [ Thread-255][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:27:25] "POST / HTTP/1.1" 200 -
12702018-12-24 08:27:25,296 [ Thread-256][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545658045.2965634
12712018-12-24 08:27:25,297 [ Thread-256][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:27:25] "POST / HTTP/1.1" 200 -
12722018-12-24 08:27:25,424 [ Thread-257][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545658045.4241524
12732018-12-24 08:27:25,425 [ Thread-257][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:27:25] "POST / HTTP/1.1" 200 -
12742018-12-24 08:27:25,440 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
12752018-12-24 08:27:25,441 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
12762018-12-24 08:27:25,442 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
12772018-12-24 08:27:25,456 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
12782018-12-24 08:27:25,474 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
12792018-12-24 08:27:25,474 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
12802018-12-24 08:27:25,476 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
12812018-12-24 08:27:25,477 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
12822018-12-24 08:27:25,477 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
12832018-12-24 08:27:25,480 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
12842018-12-24 08:27:25,490 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
12852018-12-24 08:27:25,490 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
12862018-12-24 08:27:25,492 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #361 at 42.7835924105845, -81.18306086207986. Despawning at 2018-12-24 13:32:25 (init) (9358295666645)
12872018-12-24 08:27:25,492 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
12882018-12-24 08:27:25,493 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #363 at 42.78379950493722, -81.18280250140161. Despawning at 2018-12-24 13:44:12 (non-init) (9358295666749)
12892018-12-24 08:27:42,739 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\xe6\xedg\xaa', rsv1=False, rsv2=False, rsv3=False)
12902018-12-24 08:27:42,805 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\xe6\xedg\xaa', rsv1=False, rsv2=False, rsv3=False)
12912018-12-24 08:27:42,806 [ scanner][ protocol][ DEBUG] server - received solicited pong: e6ed67aa
12922018-12-24 08:27:55,345 [ Thread-258][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545658075.3452885
12932018-12-24 08:27:55,346 [ Thread-258][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:27:55] "POST / HTTP/1.1" 200 -
12942018-12-24 08:27:55,361 [ Thread-260][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545658075.361658
12952018-12-24 08:27:55,362 [ Thread-260][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:27:55] "POST / HTTP/1.1" 200 -
12962018-12-24 08:27:55,363 [ Thread-259][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545658075.3638783
12972018-12-24 08:27:55,364 [ Thread-259][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:27:55] "POST / HTTP/1.1" 200 -
12982018-12-24 08:27:55,367 [ Thread-261][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545658075.3676765
12992018-12-24 08:27:55,368 [ Thread-261][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:27:55] "POST / HTTP/1.1" 200 -
13002018-12-24 08:27:55,498 [ Thread-262][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545658075.498473
13012018-12-24 08:27:55,499 [ Thread-262][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:27:55] "POST / HTTP/1.1" 200 -
13022018-12-24 08:27:55,691 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
13032018-12-24 08:27:55,692 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
13042018-12-24 08:27:55,693 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
13052018-12-24 08:27:55,705 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
13062018-12-24 08:27:55,724 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
13072018-12-24 08:27:55,724 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
13082018-12-24 08:27:55,726 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
13092018-12-24 08:27:55,726 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
13102018-12-24 08:27:55,727 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
13112018-12-24 08:27:55,729 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
13122018-12-24 08:27:55,740 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
13132018-12-24 08:27:55,740 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
13142018-12-24 08:27:55,742 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #361 at 42.7835924105845, -81.18306086207986. Despawning at 2018-12-24 13:32:55 (init) (9358295666645)
13152018-12-24 08:27:55,742 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
13162018-12-24 08:27:55,744 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #363 at 42.78379950493722, -81.18280250140161. Despawning at 2018-12-24 13:44:12 (non-init) (9358295666749)
13172018-12-24 08:28:02,807 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\x05/\xb8\xe8', rsv1=False, rsv2=False, rsv3=False)
13182018-12-24 08:28:02,877 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\x05/\xb8\xe8', rsv1=False, rsv2=False, rsv3=False)
13192018-12-24 08:28:02,877 [ scanner][ protocol][ DEBUG] server - received solicited pong: 052fb8e8
13202018-12-24 08:28:19,736 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=9, data=b'', rsv1=False, rsv2=False, rsv3=False)
13212018-12-24 08:28:19,737 [ scanner][ protocol][ DEBUG] server - received ping, sending pong: [empty]
13222018-12-24 08:28:19,737 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=10, data=b'', rsv1=False, rsv2=False, rsv3=False)
13232018-12-24 08:28:22,879 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\x0fHP\x82', rsv1=False, rsv2=False, rsv3=False)
13242018-12-24 08:28:22,882 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\x0fHP\x82', rsv1=False, rsv2=False, rsv3=False)
13252018-12-24 08:28:22,882 [ scanner][ protocol][ DEBUG] server - received solicited pong: 0f485082
13262018-12-24 08:28:25,377 [ Thread-263][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545658105.3773594
13272018-12-24 08:28:25,377 [ Thread-263][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:28:25] "POST / HTTP/1.1" 200 -
13282018-12-24 08:28:25,379 [ Thread-264][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545658105.3795526
13292018-12-24 08:28:25,380 [ Thread-264][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:28:25] "POST / HTTP/1.1" 200 -
13302018-12-24 08:28:25,391 [ Thread-265][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545658105.3915226
13312018-12-24 08:28:25,391 [ Thread-265][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:28:25] "POST / HTTP/1.1" 200 -
13322018-12-24 08:28:25,404 [ Thread-266][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545658105.4042757
13332018-12-24 08:28:25,404 [ Thread-266][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:28:25] "POST / HTTP/1.1" 200 -
13342018-12-24 08:28:25,515 [ Thread-267][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545658105.5150099
13352018-12-24 08:28:25,515 [ Thread-267][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:28:25] "POST / HTTP/1.1" 200 -
13362018-12-24 08:28:25,541 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
13372018-12-24 08:28:25,542 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
13382018-12-24 08:28:25,543 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
13392018-12-24 08:28:25,559 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
13402018-12-24 08:28:25,571 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
13412018-12-24 08:28:25,572 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
13422018-12-24 08:28:25,574 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
13432018-12-24 08:28:25,574 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
13442018-12-24 08:28:25,574 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
13452018-12-24 08:28:25,577 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
13462018-12-24 08:28:25,586 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
13472018-12-24 08:28:25,587 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
13482018-12-24 08:28:25,589 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #361 at 42.7835924105845, -81.18306086207986. Despawning at 2018-12-24 13:33:25 (init) (9358295666645)
13492018-12-24 08:28:25,589 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
13502018-12-24 08:28:25,591 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #363 at 42.78379950493722, -81.18280250140161. Despawning at 2018-12-24 13:44:12 (non-init) (9358295666749)
13512018-12-24 08:28:42,884 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\xf9"a\x7f', rsv1=False, rsv2=False, rsv3=False)
13522018-12-24 08:28:42,916 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\xf9"a\x7f', rsv1=False, rsv2=False, rsv3=False)
13532018-12-24 08:28:42,917 [ scanner][ protocol][ DEBUG] server - received solicited pong: f922617f
13542018-12-24 08:28:51,990 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=8, data=b'\x03\xe8', rsv1=False, rsv2=False, rsv3=False)
13552018-12-24 08:28:51,991 [ scanner][ protocol][ DEBUG] server - state = CLOSING
13562018-12-24 08:28:51,991 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=8, data=b'\x03\xe8', rsv1=False, rsv2=False, rsv3=False)
13572018-12-24 08:28:51,992 [ scanner][ protocol][ DEBUG] server x half-closing TCP connection
13582018-12-24 08:28:51,992 [ scanner][WebsocketServerBase][ DEBUG] Connection closed while receiving data
13592018-12-24 08:28:51,992 [ scanner][WebsocketServerBase][ DEBUG] Closed connection to 071607f34fa91503
13602018-12-24 08:28:51,993 [ scanner][WebsocketServerBase][ INFO] All done with 071607f34fa91503
13612018-12-24 08:28:52,003 [ scanner][ protocol][ DEBUG] server - event = eof_received()
13622018-12-24 08:28:52,003 [ scanner][ protocol][ DEBUG] server - event = connection_lost(None)
13632018-12-24 08:28:52,004 [ scanner][ protocol][ DEBUG] server - state = CLOSED
13642018-12-24 08:28:52,004 [ scanner][ protocol][ DEBUG] server x code = 1000, reason = [no reason]
13652018-12-24 08:28:52,554 [ scanner][ protocol][ DEBUG] server - state = CONNECTING
13662018-12-24 08:28:52,555 [ scanner][ protocol][ DEBUG] server - event = connection_made(<_SelectorSocketTransport fd=18 read=idle write=<idle, bufsize=0>>)
13672018-12-24 08:28:52,579 [ scanner][ protocol][ DEBUG] server - state = OPEN
13682018-12-24 08:28:52,579 [ scanner][WebsocketServerBase][ DEBUG] Waiting for connections
13692018-12-24 08:28:52,579 [ scanner][WebsocketServerBase][ INFO] Client registering....
13702018-12-24 08:28:52,582 [ 071607f34fa91503][ WorkerMITM][ INFO] MITM worker starting
13712018-12-24 08:28:52,583 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Sending command: more topmost app
1372
13732018-12-24 08:28:52,584 [mitm_asyncio_071607f34fa91503][selector_events][ DEBUG] Using selector: EpollSelector
13742018-12-24 08:28:52,584 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Sending:
13752018-12-24 08:28:52,585 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] To be sent: 10;more topmost app
1376
13772018-12-24 08:28:52,585 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Timeout: 30
13782018-12-24 08:28:52,603 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=1, data=b'10;more topmost app\r\n', rsv1=False, rsv2=False, rsv3=False)
13792018-12-24 08:28:52,706 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=1, data=b'10;org.lineageos.trebuchet\r\n', rsv1=False, rsv2=False, rsv3=False)
13802018-12-24 08:28:52,707 [ scanner][WebsocketServerBase][ DEBUG] Receiving message: 10;org.lineageos.trebuchet
1381
13822018-12-24 08:28:52,707 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received anser, popping response
13832018-12-24 08:28:52,708 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received an answer
13842018-12-24 08:28:52,708 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Answer: org.lineageos.trebuchet
1385
13862018-12-24 08:28:52,708 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received response: org.lineageos.trebuchet
1387
13882018-12-24 08:28:52,708 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Sending command: more state screen
1389
13902018-12-24 08:28:52,709 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Sending:
13912018-12-24 08:28:52,709 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] To be sent: 11;more state screen
1392
13932018-12-24 08:28:52,709 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Timeout: 30
13942018-12-24 08:28:52,726 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=1, data=b'11;more state screen\r\n', rsv1=False, rsv2=False, rsv3=False)
13952018-12-24 08:28:52,777 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=1, data=b'11;on\r\n', rsv1=False, rsv2=False, rsv3=False)
13962018-12-24 08:28:52,777 [ scanner][WebsocketServerBase][ DEBUG] Receiving message: 11;on
1397
13982018-12-24 08:28:52,778 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received anser, popping response
13992018-12-24 08:28:52,778 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received an answer
14002018-12-24 08:28:52,778 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Answer: on
1401
14022018-12-24 08:28:52,779 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received response: on
1403
14042018-12-24 08:28:52,779 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Sending command: more start com.nianticlabs.pokemongo
1405
14062018-12-24 08:28:52,779 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Sending:
14072018-12-24 08:28:52,779 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] To be sent: 12;more start com.nianticlabs.pokemongo
1408
14092018-12-24 08:28:52,780 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Timeout: 30
14102018-12-24 08:28:52,788 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=1, data=b'12;more start com.nianticlabs.pokemongo\r\n', rsv1=False, rsv2=False, rsv3=False)
14112018-12-24 08:28:52,824 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=1, data=b'12;OK\r\n', rsv1=False, rsv2=False, rsv3=False)
14122018-12-24 08:28:52,825 [ scanner][WebsocketServerBase][ DEBUG] Receiving message: 12;OK
1413
14142018-12-24 08:28:52,826 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received anser, popping response
14152018-12-24 08:28:52,826 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received an answer
14162018-12-24 08:28:52,826 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Answer: OK
1417
14182018-12-24 08:28:52,826 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received response: OK
1419
14202018-12-24 08:28:53,414 [ Thread-273][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545658133.4145148
14212018-12-24 08:28:53,415 [ Thread-273][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:28:53] "POST / HTTP/1.1" 200 -
14222018-12-24 08:28:53,417 [ Thread-274][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545658133.4172418
14232018-12-24 08:28:53,418 [ Thread-274][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:28:53] "POST / HTTP/1.1" 200 -
14242018-12-24 08:28:53,420 [ Thread-275][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545658133.42025
14252018-12-24 08:28:53,421 [ Thread-275][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:28:53] "POST / HTTP/1.1" 200 -
14262018-12-24 08:28:53,424 [ Thread-276][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545658133.4240615
14272018-12-24 08:28:53,424 [ Thread-276][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:28:53] "POST / HTTP/1.1" 200 -
14282018-12-24 08:28:53,828 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Sending command: more topmost app
1429
14302018-12-24 08:28:53,829 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Sending:
14312018-12-24 08:28:53,829 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] To be sent: 13;more topmost app
1432
14332018-12-24 08:28:53,830 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Timeout: 30
14342018-12-24 08:28:53,831 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=1, data=b'13;more topmost app\r\n', rsv1=False, rsv2=False, rsv3=False)
14352018-12-24 08:28:53,966 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=1, data=b'13;com.nianticlabs.pokemongo\r\n', rsv1=False, rsv2=False, rsv3=False)
14362018-12-24 08:28:53,967 [ scanner][WebsocketServerBase][ DEBUG] Receiving message: 13;com.nianticlabs.pokemongo
1437
14382018-12-24 08:28:53,967 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received anser, popping response
14392018-12-24 08:28:53,968 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received an answer
14402018-12-24 08:28:53,968 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Answer: com.nianticlabs.pokemongo
1441
14422018-12-24 08:28:53,968 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received response: com.nianticlabs.pokemongo
1443
14442018-12-24 08:28:53,969 [ 071607f34fa91503][ WorkerMITM][ WARNING] startPogo: Starting pogo...
14452018-12-24 08:28:55,520 [ Thread-277][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545658135.52083
14462018-12-24 08:28:55,521 [ Thread-277][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:28:55] "POST / HTTP/1.1" 200 -
14472018-12-24 08:28:55,588 [ Thread-278][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545658135.588498
14482018-12-24 08:28:55,589 [ Thread-278][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:28:55] "POST / HTTP/1.1" 200 -
14492018-12-24 08:28:55,589 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
14502018-12-24 08:28:55,591 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
14512018-12-24 08:28:55,591 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
14522018-12-24 08:28:55,607 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
14532018-12-24 08:28:55,624 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
14542018-12-24 08:28:55,625 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
14552018-12-24 08:28:55,627 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
14562018-12-24 08:28:55,627 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
14572018-12-24 08:28:55,627 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
14582018-12-24 08:28:55,630 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
14592018-12-24 08:28:55,637 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
14602018-12-24 08:28:55,637 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
14612018-12-24 08:28:55,639 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #361 at 42.7835924105845, -81.18306086207986. Despawning at 2018-12-24 13:33:55 (init) (9358295666645)
14622018-12-24 08:28:55,639 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
14632018-12-24 08:28:55,641 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #363 at 42.78379950493722, -81.18280250140161. Despawning at 2018-12-24 13:44:12 (non-init) (9358295666749)
14642018-12-24 08:29:12,583 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\xfe\x99\xf1\x87', rsv1=False, rsv2=False, rsv3=False)
14652018-12-24 08:29:12,613 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\xfe\x99\xf1\x87', rsv1=False, rsv2=False, rsv3=False)
14662018-12-24 08:29:12,614 [ scanner][ protocol][ DEBUG] server - received solicited pong: fe99f187
14672018-12-24 08:29:26,496 [ Thread-279][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545658166.4959953
14682018-12-24 08:29:26,499 [ Thread-279][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:29:26] "POST / HTTP/1.1" 200 -
14692018-12-24 08:29:26,499 [ Thread-281][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545658166.497514
14702018-12-24 08:29:26,502 [ Thread-281][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:29:26] "POST / HTTP/1.1" 200 -
14712018-12-24 08:29:26,502 [ Thread-280][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545658166.4986122
14722018-12-24 08:29:26,503 [ Thread-280][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:29:26] "POST / HTTP/1.1" 200 -
14732018-12-24 08:29:26,503 [ Thread-282][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545658166.5014298
14742018-12-24 08:29:26,505 [ Thread-282][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:29:26] "POST / HTTP/1.1" 200 -
14752018-12-24 08:29:26,641 [ Thread-283][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545658166.6410277
14762018-12-24 08:29:26,641 [ Thread-283][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:29:26] "POST / HTTP/1.1" 200 -
14772018-12-24 08:29:26,642 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
14782018-12-24 08:29:26,642 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
14792018-12-24 08:29:26,643 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
14802018-12-24 08:29:26,662 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
14812018-12-24 08:29:26,677 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
14822018-12-24 08:29:26,678 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
14832018-12-24 08:29:26,678 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
14842018-12-24 08:29:26,679 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
14852018-12-24 08:29:26,679 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
14862018-12-24 08:29:26,680 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
14872018-12-24 08:29:26,687 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
14882018-12-24 08:29:26,687 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
14892018-12-24 08:29:26,689 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #361 at 42.7835924105845, -81.18306086207986. Despawning at 2018-12-24 13:34:26 (init) (9358295666645)
14902018-12-24 08:29:26,689 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
14912018-12-24 08:29:26,691 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #363 at 42.78379950493722, -81.18280250140161. Despawning at 2018-12-24 13:44:12 (non-init) (9358295666749)
14922018-12-24 08:29:32,615 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b"jr'7", rsv1=False, rsv2=False, rsv3=False)
14932018-12-24 08:29:32,682 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b"jr'7", rsv1=False, rsv2=False, rsv3=False)
14942018-12-24 08:29:32,683 [ scanner][ protocol][ DEBUG] server - received solicited pong: 6a722737
14952018-12-24 08:29:52,643 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=9, data=b'', rsv1=False, rsv2=False, rsv3=False)
14962018-12-24 08:29:52,644 [ scanner][ protocol][ DEBUG] server - received ping, sending pong: [empty]
14972018-12-24 08:29:52,644 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=10, data=b'', rsv1=False, rsv2=False, rsv3=False)
14982018-12-24 08:29:52,684 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'S(2n', rsv1=False, rsv2=False, rsv3=False)
14992018-12-24 08:29:52,723 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'S(2n', rsv1=False, rsv2=False, rsv3=False)
15002018-12-24 08:29:52,724 [ scanner][ protocol][ DEBUG] server - received solicited pong: 5328326e
15012018-12-24 08:29:54,009 [ 071607f34fa91503][ WorkerMITM][ DEBUG] Worker: acquiring lock for restart check
15022018-12-24 08:29:54,009 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Sending command: more topmost app
1503
15042018-12-24 08:29:54,010 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Sending:
15052018-12-24 08:29:54,010 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] To be sent: 14;more topmost app
1506
15072018-12-24 08:29:54,010 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Timeout: 30
15082018-12-24 08:29:54,026 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=1, data=b'14;more topmost app\r\n', rsv1=False, rsv2=False, rsv3=False)
15092018-12-24 08:29:54,128 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=1, data=b'14;com.nianticlabs.pokemongo\r\n', rsv1=False, rsv2=False, rsv3=False)
15102018-12-24 08:29:54,129 [ scanner][WebsocketServerBase][ DEBUG] Receiving message: 14;com.nianticlabs.pokemongo
1511
15122018-12-24 08:29:54,130 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received anser, popping response
15132018-12-24 08:29:54,130 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received an answer
15142018-12-24 08:29:54,131 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Answer: com.nianticlabs.pokemongo
1515
15162018-12-24 08:29:54,131 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received response: com.nianticlabs.pokemongo
1517
15182018-12-24 08:29:54,131 [ 071607f34fa91503][ WorkerMITM][ DEBUG] Worker: acquired lock
15192018-12-24 08:29:54,131 [ 071607f34fa91503][ WorkerMITM][ DEBUG] Worker: lock released
15202018-12-24 08:29:54,132 [ 071607f34fa91503][ RouteManager][ INFO] main: Moving on with gym at {'lat': 42.78621665545678, 'lng': -81.1846971225464}
15212018-12-24 08:29:54,132 [ 071607f34fa91503][ WorkerMITM][ DEBUG] main: next stop: Location(lat=42.78621665545678, lng=-81.1846971225464)
15222018-12-24 08:29:54,132 [ 071607f34fa91503][ WorkerMITM][ DEBUG] main: LastLat: 0.0, LastLng: 0.0, CurLat: 42.78621665545678, CurLng: -81.1846971225464
15232018-12-24 08:29:54,133 [ 071607f34fa91503][ WorkerMITM][ INFO] main: Moving 9292400.42168191 meters to the next position
15242018-12-24 08:29:54,133 [ 071607f34fa91503][ WorkerMITM][ DEBUG] Getting time
15252018-12-24 08:29:54,133 [ 071607f34fa91503][ WorkerMITM][ INFO] main: Teleporting...
15262018-12-24 08:29:54,133 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Sending command: geo fix 42.78621665545678 -81.1846971225464 0
1527
15282018-12-24 08:29:54,134 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Sending:
15292018-12-24 08:29:54,134 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] To be sent: 15;geo fix 42.78621665545678 -81.1846971225464 0
1530
15312018-12-24 08:29:54,134 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Timeout: 30
15322018-12-24 08:29:54,150 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=1, data=b'15;geo fix 42.78621665545678 -81.1846971225464 0\r\n', rsv1=False, rsv2=False, rsv3=False)
15332018-12-24 08:29:54,159 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=1, data=b'15;OK\r\n', rsv1=False, rsv2=False, rsv3=False)
15342018-12-24 08:29:54,159 [ scanner][WebsocketServerBase][ DEBUG] Receiving message: 15;OK
1535
15362018-12-24 08:29:54,160 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received anser, popping response
15372018-12-24 08:29:54,160 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received an answer
15382018-12-24 08:29:54,160 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Answer: OK
1539
15402018-12-24 08:29:54,161 [ 071607f34fa91503][WebsocketServerBase][ DEBUG] Received response: OK
1541
15422018-12-24 08:29:55,729 [ Thread-285][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545658195.7294712
15432018-12-24 08:29:55,730 [ Thread-285][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:29:55] "POST / HTTP/1.1" 200 -
15442018-12-24 08:29:55,731 [ Thread-284][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545658195.7318177
15452018-12-24 08:29:55,732 [ Thread-284][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:29:55] "POST / HTTP/1.1" 200 -
15462018-12-24 08:29:55,734 [ Thread-286][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545658195.7341166
15472018-12-24 08:29:55,734 [ Thread-286][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:29:55] "POST / HTTP/1.1" 200 -
15482018-12-24 08:29:55,737 [ Thread-287][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545658195.7377164
15492018-12-24 08:29:55,738 [ Thread-287][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:29:55] "POST / HTTP/1.1" 200 -
15502018-12-24 08:29:56,576 [ Thread-288][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545658196.57623
15512018-12-24 08:29:56,576 [ Thread-288][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:29:56] "POST / HTTP/1.1" 200 -
15522018-12-24 08:29:56,692 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
15532018-12-24 08:29:56,693 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
15542018-12-24 08:29:56,694 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
15552018-12-24 08:29:56,710 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
15562018-12-24 08:29:56,723 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
15572018-12-24 08:29:56,723 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
15582018-12-24 08:29:56,725 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
15592018-12-24 08:29:56,725 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
15602018-12-24 08:29:56,728 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
15612018-12-24 08:30:12,724 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\xedh6\xf9', rsv1=False, rsv2=False, rsv3=False)
15622018-12-24 08:30:12,828 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\xedh6\xf9', rsv1=False, rsv2=False, rsv3=False)
15632018-12-24 08:30:12,828 [ scanner][ protocol][ DEBUG] server - received solicited pong: ed6836f9
15642018-12-24 08:30:25,590 [ Thread-289][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545658225.5900083
15652018-12-24 08:30:25,590 [ Thread-289][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:30:25] "POST / HTTP/1.1" 200 -
15662018-12-24 08:30:25,600 [ Thread-290][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545658225.59997
15672018-12-24 08:30:25,600 [ Thread-290][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:30:25] "POST / HTTP/1.1" 200 -
15682018-12-24 08:30:25,602 [ Thread-291][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545658225.6023533
15692018-12-24 08:30:25,604 [ Thread-291][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:30:25] "POST / HTTP/1.1" 200 -
15702018-12-24 08:30:25,605 [ Thread-292][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545658225.6040862
15712018-12-24 08:30:25,606 [ Thread-292][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:30:25] "POST / HTTP/1.1" 200 -
15722018-12-24 08:30:25,680 [ Thread-293][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545658225.6799972
15732018-12-24 08:30:25,680 [ Thread-293][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:30:25] "POST / HTTP/1.1" 200 -
15742018-12-24 08:30:25,741 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
15752018-12-24 08:30:25,742 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
15762018-12-24 08:30:25,743 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
15772018-12-24 08:30:25,754 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
15782018-12-24 08:30:25,770 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
15792018-12-24 08:30:25,770 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
15802018-12-24 08:30:25,772 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
15812018-12-24 08:30:25,773 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
15822018-12-24 08:30:25,773 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
15832018-12-24 08:30:25,776 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
15842018-12-24 08:30:25,779 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
15852018-12-24 08:30:25,782 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
15862018-12-24 08:30:25,783 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
15872018-12-24 08:30:25,784 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
15882018-12-24 08:30:25,785 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
15892018-12-24 08:30:25,786 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
15902018-12-24 08:30:25,787 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
15912018-12-24 08:30:25,793 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
15922018-12-24 08:30:25,793 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
15932018-12-24 08:30:25,794 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #215 at 42.78664169532551, -81.18529995193826. Despawning at 2018-12-24 13:54:37 (non-init) (9358295662629)
15942018-12-24 08:30:25,795 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
15952018-12-24 08:30:25,796 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #25 at 42.786269917901535, -81.18538606948907. Despawning at 2018-12-24 13:39:54 (non-init) (9358295662685)
15962018-12-24 08:30:25,796 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
15972018-12-24 08:30:25,797 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #215 at 42.78599625384355, -81.18478324462686. Despawning at 2018-12-24 13:43:51 (non-init) (9358295662861)
15982018-12-24 08:30:25,797 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
15992018-12-24 08:30:25,798 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #52 at 42.78574255947827, -81.18443877117492. Despawning at 2018-12-24 13:56:44 (non-init) (9358295662943)
16002018-12-24 08:30:25,798 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
16012018-12-24 08:30:25,799 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #225 at 42.786272371752034, -81.18443877117492. Despawning at 2018-12-24 13:45:59 (non-init) (9358295662985)
16022018-12-24 08:30:25,800 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
16032018-12-24 08:30:25,801 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #220 at 42.786381347745326, -81.18486936275097. Despawning at 2018-12-24 14:05:01 (non-init) (9358295663033)
16042018-12-24 08:30:25,801 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
16052018-12-24 08:30:25,802 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #225 at 42.78581158927479, -81.18435265257307. Despawning at 2018-12-24 14:00:24 (non-init) (9358295663583)
16062018-12-24 08:30:25,802 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
16072018-12-24 08:30:25,803 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #427 at 42.78566021356432, -81.18435265257307. Despawning at 2018-12-24 13:38:41 (non-init) (9358295663587)
16082018-12-24 08:30:25,803 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
16092018-12-24 08:30:25,804 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #363 at 42.786746465846974, -81.1846971264072. Despawning at 2018-12-24 13:42:19 (non-init) (9358295662431)
16102018-12-24 08:30:26,567 [ Thread-295][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545658226.567464
16112018-12-24 08:30:26,568 [ Thread-295][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:30:26] "POST / HTTP/1.1" 200 -
16122018-12-24 08:30:26,569 [ Thread-294][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545658226.5696182
16132018-12-24 08:30:26,570 [ Thread-294][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:30:26] "POST / HTTP/1.1" 200 -
16142018-12-24 08:30:32,830 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'5\x85y}', rsv1=False, rsv2=False, rsv3=False)
16152018-12-24 08:30:32,895 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'5\x85y}', rsv1=False, rsv2=False, rsv3=False)
16162018-12-24 08:30:32,895 [ scanner][ protocol][ DEBUG] server - received solicited pong: 3585797d
16172018-12-24 08:30:52,593 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=9, data=b'', rsv1=False, rsv2=False, rsv3=False)
16182018-12-24 08:30:52,593 [ scanner][ protocol][ DEBUG] server - received ping, sending pong: [empty]
16192018-12-24 08:30:52,593 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=10, data=b'', rsv1=False, rsv2=False, rsv3=False)
16202018-12-24 08:30:52,897 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'+\xd1\x1e\x91', rsv1=False, rsv2=False, rsv3=False)
16212018-12-24 08:30:52,940 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'+\xd1\x1e\x91', rsv1=False, rsv2=False, rsv3=False)
16222018-12-24 08:30:52,941 [ scanner][ protocol][ DEBUG] server - received solicited pong: 2bd11e91
16232018-12-24 08:30:55,619 [ Thread-296][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545658255.619821
16242018-12-24 08:30:55,620 [ Thread-296][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:30:55] "POST / HTTP/1.1" 200 -
16252018-12-24 08:30:55,639 [ Thread-298][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545658255.639615
16262018-12-24 08:30:55,640 [ Thread-298][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:30:55] "POST / HTTP/1.1" 200 -
16272018-12-24 08:30:55,641 [ Thread-297][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545658255.6418688
16282018-12-24 08:30:55,642 [ Thread-297][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:30:55] "POST / HTTP/1.1" 200 -
16292018-12-24 08:30:55,646 [ Thread-299][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545658255.646215
16302018-12-24 08:30:55,647 [ Thread-299][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:30:55] "POST / HTTP/1.1" 200 -
16312018-12-24 08:30:55,841 [ Thread-300][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545658255.8415604
16322018-12-24 08:30:55,842 [ Thread-300][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:30:55] "POST / HTTP/1.1" 200 -
16332018-12-24 08:30:55,991 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
16342018-12-24 08:30:55,992 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
16352018-12-24 08:30:55,993 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
16362018-12-24 08:30:56,011 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
16372018-12-24 08:30:56,022 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
16382018-12-24 08:30:56,023 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
16392018-12-24 08:30:56,024 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
16402018-12-24 08:30:56,024 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
16412018-12-24 08:30:56,024 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
16422018-12-24 08:30:56,026 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
16432018-12-24 08:30:56,028 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
16442018-12-24 08:30:56,030 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
16452018-12-24 08:30:56,032 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
16462018-12-24 08:30:56,033 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
16472018-12-24 08:30:56,034 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
16482018-12-24 08:30:56,035 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
16492018-12-24 08:30:56,036 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
16502018-12-24 08:30:56,042 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
16512018-12-24 08:30:56,042 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
16522018-12-24 08:30:56,043 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #215 at 42.78664169532551, -81.18529995193826. Despawning at 2018-12-24 13:54:37 (non-init) (9358295662629)
16532018-12-24 08:30:56,043 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
16542018-12-24 08:30:56,044 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #25 at 42.786269917901535, -81.18538606948907. Despawning at 2018-12-24 13:39:54 (non-init) (9358295662685)
16552018-12-24 08:30:56,045 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
16562018-12-24 08:30:56,046 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #215 at 42.78599625384355, -81.18478324462686. Despawning at 2018-12-24 13:43:51 (non-init) (9358295662861)
16572018-12-24 08:30:56,046 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
16582018-12-24 08:30:56,047 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #52 at 42.78574255947827, -81.18443877117492. Despawning at 2018-12-24 13:56:44 (non-init) (9358295662943)
16592018-12-24 08:30:56,047 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
16602018-12-24 08:30:56,048 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #225 at 42.786272371752034, -81.18443877117492. Despawning at 2018-12-24 13:45:59 (non-init) (9358295662985)
16612018-12-24 08:30:56,048 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
16622018-12-24 08:30:56,049 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #220 at 42.786381347745326, -81.18486936275097. Despawning at 2018-12-24 14:05:01 (non-init) (9358295663033)
16632018-12-24 08:30:56,049 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
16642018-12-24 08:30:56,050 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #225 at 42.78581158927479, -81.18435265257307. Despawning at 2018-12-24 14:00:24 (non-init) (9358295663583)
16652018-12-24 08:30:56,051 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
16662018-12-24 08:30:56,052 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #427 at 42.78566021356432, -81.18435265257307. Despawning at 2018-12-24 13:38:41 (non-init) (9358295663587)
16672018-12-24 08:30:56,052 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
16682018-12-24 08:30:56,053 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #363 at 42.786746465846974, -81.1846971264072. Despawning at 2018-12-24 13:42:19 (non-init) (9358295662431)
16692018-12-24 08:31:12,633 [ Thread-301][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545658272.633358
16702018-12-24 08:31:12,637 [ Thread-301][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:31:12] "POST / HTTP/1.1" 200 -
16712018-12-24 08:31:12,638 [ Thread-302][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545658272.6352777
16722018-12-24 08:31:12,640 [ Thread-302][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:31:12] "POST / HTTP/1.1" 200 -
16732018-12-24 08:31:12,640 [ Thread-303][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545658272.6366007
16742018-12-24 08:31:12,641 [ Thread-303][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:31:12] "POST / HTTP/1.1" 200 -
16752018-12-24 08:31:12,641 [ Thread-304][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545658272.6394584
16762018-12-24 08:31:12,642 [ Thread-304][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:31:12] "POST / HTTP/1.1" 200 -
16772018-12-24 08:31:12,943 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'x\x95.\xee', rsv1=False, rsv2=False, rsv3=False)
16782018-12-24 08:31:12,959 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'x\x95.\xee', rsv1=False, rsv2=False, rsv3=False)
16792018-12-24 08:31:12,960 [ scanner][ protocol][ DEBUG] server - received solicited pong: 78952eee
16802018-12-24 08:31:25,729 [ Thread-306][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 5 to 1545658285.7295375
16812018-12-24 08:31:25,733 [ Thread-306][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:31:25] "POST / HTTP/1.1" 200 -
16822018-12-24 08:31:25,733 [ Thread-305][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 126 to 1545658285.7308373
16832018-12-24 08:31:25,734 [ Thread-305][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:31:25] "POST / HTTP/1.1" 200 -
16842018-12-24 08:31:25,735 [ Thread-307][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 4 to 1545658285.7319577
16852018-12-24 08:31:25,735 [ Thread-307][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:31:25] "POST / HTTP/1.1" 200 -
16862018-12-24 08:31:25,736 [ Thread-308][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 900 to 1545658285.7328908
16872018-12-24 08:31:25,737 [ Thread-308][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:31:25] "POST / HTTP/1.1" 200 -
16882018-12-24 08:31:25,808 [ Thread-309][ReceivedMapper][ DEBUG] Updating timestamp of 071607f34fa91503 with method 106 to 1545658285.8079453
16892018-12-24 08:31:25,808 [ Thread-309][ _internal][ INFO] 192.168.250.36 - - [24/Dec/2018 08:31:25] "POST / HTTP/1.1" 200 -
16902018-12-24 08:31:25,839 [mitm_receiver_071607f34fa91503][ WorkerMITM][ INFO] Processing MITM Data
16912018-12-24 08:31:25,840 [mitm_receiver_071607f34fa91503][ WorkerMITM][ DEBUG] Updating time...
16922018-12-24 08:31:25,841 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_pokestops_map_proto} called
16932018-12-24 08:31:25,852 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_gyms_map_proto} called
16942018-12-24 08:31:25,866 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] submit_gyms done
16952018-12-24 08:31:25,867 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_raids_map_proto} called
16962018-12-24 08:31:25,869 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] dbWrapper::submit_raids_map_proto: Done submitting raids
16972018-12-24 08:31:25,869 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::submit_spawnpoints_map_proto} called
16982018-12-24 08:31:25,870 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
16992018-12-24 08:31:25,871 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
17002018-12-24 08:31:25,873 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
17012018-12-24 08:31:25,875 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
17022018-12-24 08:31:25,876 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
17032018-12-24 08:31:25,878 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
17042018-12-24 08:31:25,879 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
17052018-12-24 08:31:25,881 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
17062018-12-24 08:31:25,882 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::getspawndef} called
17072018-12-24 08:31:25,890 [mitm_asyncio_071607f34fa91503][ rmWrapper][ DEBUG] {RmWrapper::submit_mons_map_proto} called
17082018-12-24 08:31:25,891 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
17092018-12-24 08:31:25,892 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #215 at 42.78664169532551, -81.18529995193826. Despawning at 2018-12-24 13:54:37 (non-init) (9358295662629)
17102018-12-24 08:31:25,892 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
17112018-12-24 08:31:25,893 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #25 at 42.786269917901535, -81.18538606948907. Despawning at 2018-12-24 13:39:54 (non-init) (9358295662685)
17122018-12-24 08:31:25,893 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
17132018-12-24 08:31:25,894 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #215 at 42.78599625384355, -81.18478324462686. Despawning at 2018-12-24 13:43:51 (non-init) (9358295662861)
17142018-12-24 08:31:25,894 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
17152018-12-24 08:31:25,895 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #52 at 42.78574255947827, -81.18443877117492. Despawning at 2018-12-24 13:56:44 (non-init) (9358295662943)
17162018-12-24 08:31:25,895 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
17172018-12-24 08:31:25,896 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #225 at 42.786272371752034, -81.18443877117492. Despawning at 2018-12-24 13:45:59 (non-init) (9358295662985)
17182018-12-24 08:31:25,896 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
17192018-12-24 08:31:25,897 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #220 at 42.786381347745326, -81.18486936275097. Despawning at 2018-12-24 14:05:01 (non-init) (9358295663033)
17202018-12-24 08:31:25,897 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
17212018-12-24 08:31:25,898 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #225 at 42.78581158927479, -81.18435265257307. Despawning at 2018-12-24 14:00:24 (non-init) (9358295663583)
17222018-12-24 08:31:25,898 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
17232018-12-24 08:31:25,899 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #427 at 42.78566021356432, -81.18435265257307. Despawning at 2018-12-24 13:38:41 (non-init) (9358295663587)
17242018-12-24 08:31:25,899 [mitm_asyncio_071607f34fa91503][ dbWrapperBase][ DEBUG] {DbWrapperBase::get_detected_endtime} called
17252018-12-24 08:31:25,900 [mitm_asyncio_071607f34fa91503][ rmWrapper][ INFO] Adding mon with id #363 at 42.786746465846974, -81.1846971264072. Despawning at 2018-12-24 13:42:19 (non-init) (9358295662431)
17262018-12-24 08:31:32,962 [ scanner][ protocol][ DEBUG] server > Frame(fin=True, opcode=9, data=b'\xef\x89\xdd\x03', rsv1=False, rsv2=False, rsv3=False)
17272018-12-24 08:31:32,966 [ scanner][ protocol][ DEBUG] server < Frame(fin=True, opcode=10, data=b'\xef\x89\xdd\x03', rsv1=False, rsv2=False, rsv3=False)
17282018-12-24 08:31:32,967 [ scanner][ protocol][ DEBUG] server - received solicited pong: ef89dd03