· 7 years ago · Jan 01, 2019, 01:33 AM
1[12-31 17:14:42] [webhook_asyncio_loop] [selector_events] [ DEBUG] Using selector: SelectSelector
2 [12-31 17:14:42] [ MainThread] [ dbWrapperBase] [ INFO] Connecting pool to DB
3 [12-31 17:14:42] [ MainThread] [ dbWrapperBase] [ DEBUG] {DbWrapperBase::create_hash_database_if_not_exists} called
4 [12-31 17:14:42] [ MainThread] [ dbWrapperBase] [ DEBUG] Creating hash db in database
5 [12-31 17:14:42] [ 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))
6 [12-31 17:14:42] [ MainThread] [ dbWrapperBase] [ DEBUG] {DbWrapperBase::check_and_create_spawn_tables} called
7 [12-31 17:14:42] [ MainThread] [ rmWrapper] [ INFO] {RmWrapper::ensure_last_updated_column} called, returning True since RM doesn't need it
8 [12-31 17:14:42] [ MainThread] [geofenceHelper] [ INFO] Loading geofenced or excluded areas.
9 [12-31 17:14:42] [ MainThread] [geofenceHelper] [ DEBUG] Found geofence: kitsap.
10 [12-31 17:14:42] [ MainThread] [geofenceHelper] [ INFO] Loaded 1 geofenced and 0 excluded areas.
11 [12-31 17:14:42] [ MainThread] [geofenceHelper] [ INFO] Loading geofenced or excluded areas.
12 [12-31 17:14:42] [ MainThread] [geofenceHelper] [ DEBUG] Found geofence: kitsap.
13 [12-31 17:14:42] [ MainThread] [geofenceHelper] [ INFO] Loaded 1 geofenced and 0 excluded areas.
14 [12-31 17:14:42] [prio_queue_update_kitsap] [ rmWrapper] [ DEBUG] {RmWrapper::get_next_raid_hatches} called
15 [12-31 17:14:42] [ MainThread] [ rmWrapper] [ DEBUG] {RmWrapper::gyms_from_db} called
16 [12-31 17:14:42] [prio_queue_update_kitsap] [ rmWrapper] [ DEBUG] Latest Q: []
17 [12-31 17:14:42] [prio_queue_update_kitsap] [RouteManagerBase] [ INFO] New priorityqueue: []
18 [12-31 17:14:42] [ MainThread] [geofenceHelper] [ INFO] Using matplotlib: True.
19 [12-31 17:14:42] [ MainThread] [geofenceHelper] [ INFO] Found 201 coordinates to geofence.
20 [12-31 17:14:42] [ MainThread] [geofenceHelper] [ INFO] Geofenced to 177 coordinates
21 [12-31 17:14:42] [ MainThread] [geofenceHelper] [ INFO] Using matplotlib: True.
22 [12-31 17:14:42] [ MainThread] [geofenceHelper] [ INFO] Found 177 coordinates to geofence.
23 [12-31 17:14:42] [ MainThread] [geofenceHelper] [ INFO] Geofenced to 177 coordinates
24 [12-31 17:14:42] [ MainThread] [ mappingParser] [ DEBUG] <multiprocessing.pool.ApplyResult object at 0x000001D8E30F2160>
25 [12-31 17:14:42] [ Thread-1] [calculate_route] [ INFO] Found existing Routefile
26 [12-31 17:14:42] [ MainThread] [ start] [ INFO] Starting scanner....
27 [12-31 17:14:42] [ scanner] [WebsocketServerBase] [ INFO] Starting websocket server...
28 [12-31 17:14:42] [ MainThread] [ start] [ INFO] Starting Madmin on Port: 5000
29 [12-31 17:14:42] [ scanner] [selector_events] [ DEBUG] Using selector: SelectSelector
30 [12-31 17:14:42] [ scanner] [WebsocketServerBase] [ INFO] Device mappings: {'s4': {'daytime_area': None, 'nighttime_area': None, 'settings': {'cool_down_sleep': False}}}
31 [12-31 17:14:42] [ scanner] [WebsocketServerBase] [ INFO] Allowed origins derived: ['s4']
32 * Serving Flask app "MITMReceiver" (lazy loading)
33 * Environment: production
34 WARNING: Do not use the development server in a production environment.
35 Use a production WSGI server instead.
36 * Debug mode: off
37 [12-31 17:14:42] [ madmin] [ dbWrapperBase] [ INFO] Connecting pool to DB
38 * Serving Flask app "madmin.madmin" (lazy loading)
39 * Environment: production
40 WARNING: Do not use the development server in a production environment.
41 Use a production WSGI server instead.
42 * Debug mode: off
43 [12-31 17:14:42] [ mitm_receiver] [ _internal] [ INFO] * Running on http://0.0.0.0:8000/ (Press CTRL+C to quit)
44 [12-31 17:14:43] [ madmin] [ _internal] [ INFO] * Running on http://127.0.0.3:5000/ (Press CTRL+C to quit)
45 [12-31 17:14:45] [ scanner] [ protocol] [ DEBUG] server - state = CONNECTING
46 [12-31 17:14:45] [ scanner] [ protocol] [ DEBUG] server - event = connection_made(<_SelectorSocketTransport fd=1132 read=idle write=<idle, bufsize=0>>)
47 [12-31 17:14:45] [ scanner] [ protocol] [ DEBUG] server - state = OPEN
48 [12-31 17:14:45] [ scanner] [WebsocketServerBase] [ DEBUG] Waiting for connections
49 [12-31 17:14:45] [ scanner] [WebsocketServerBase] [ INFO] Client registering....
50 [12-31 17:14:45] [ scanner] [ server] [ ERROR] Error in connection handler
51Traceback (most recent call last):
52 File "C:\Users\Administrator\AppData\Local\Programs\Python\Python36\lib\site-packages\websockets\server.py", line 169, in handler
53 yield from self.ws_handler(self, path)
54 File "c:\MAD\MAD\websocket\WebsocketServerBase.py", line 168, in handler
55 continueWork = await self.__register(websocket)
56 File "c:\MAD\MAD\websocket\WebsocketServerBase.py", line 89, in __register
57 daytime_routemanager = self.routemanagers[client_mapping["daytime_area"]].get("routemanager")
58KeyError: None
59 [12-31 17:14:45] [ scanner] [ protocol] [ DEBUG] server ! failing WebSocket connection in the OPEN state: 1011 [no reason]
60 [12-31 17:14:45] [ scanner] [ protocol] [ DEBUG] server - state = CLOSING
61 [12-31 17:14:45] [ scanner] [ protocol] [ DEBUG] server > Frame(fin=True, opcode=8, data=b'\x03\xf3', rsv1=False, rsv2=False, rsv3=False)
62 [12-31 17:14:45] [ scanner] [ protocol] [ DEBUG] server x half-closing TCP connection
63 [12-31 17:14:45] [ scanner] [ protocol] [ DEBUG] server - event = connection_lost(None)
64 [12-31 17:14:45] [ scanner] [ protocol] [ DEBUG] server - state = CLOSED
65 [12-31 17:14:45] [ scanner] [ protocol] [ DEBUG] server x code = 1006, reason = [no reason]
66 [12-31 17:14:54] [ scanner] [ protocol] [ DEBUG] server - state = CONNECTING
67 [12-31 17:14:54] [ scanner] [ protocol] [ DEBUG] server - event = connection_made(<_SelectorSocketTransport fd=1216 read=idle write=<idle, bufsize=0>>)
68 [12-31 17:14:54] [ scanner] [ protocol] [ DEBUG] server - state = OPEN
69 [12-31 17:14:54] [ scanner] [WebsocketServerBase] [ DEBUG] Waiting for connections
70 [12-31 17:14:54] [ scanner] [WebsocketServerBase] [ INFO] Client registering....
71 [12-31 17:14:54] [ scanner] [ server] [ ERROR] Error in connection handler
72Traceback (most recent call last):
73 File "C:\Users\Administrator\AppData\Local\Programs\Python\Python36\lib\site-packages\websockets\server.py", line 169, in handler
74 yield from self.ws_handler(self, path)
75 File "c:\MAD\MAD\websocket\WebsocketServerBase.py", line 168, in handler
76 continueWork = await self.__register(websocket)
77 File "c:\MAD\MAD\websocket\WebsocketServerBase.py", line 89, in __register
78 daytime_routemanager = self.routemanagers[client_mapping["daytime_area"]].get("routemanager")
79KeyError: None
80 [12-31 17:14:54] [ scanner] [ protocol] [ DEBUG] server ! failing WebSocket connection in the OPEN state: 1011 [no reason]
81 [12-31 17:14:54] [ scanner] [ protocol] [ DEBUG] server - state = CLOSING
82 [12-31 17:14:54] [ scanner] [ protocol] [ DEBUG] server > Frame(fin=True, opcode=8, data=b'\x03\xf3', rsv1=False, rsv2=False, rsv3=False)
83 [12-31 17:14:54] [ scanner] [ protocol] [ DEBUG] server x half-closing TCP connection
84 [12-31 17:14:54] [ scanner] [ protocol] [ DEBUG] server - event = connection_lost(None)
85 [12-31 17:14:54] [ scanner] [ protocol] [ DEBUG] server - state = CLOSED
86 [12-31 17:14:54] [ scanner] [ protocol] [ DEBUG] server x code = 1006, reason = [no reason]
87 [12-31 17:15:17] [ scanner] [ protocol] [ DEBUG] server - state = CONNECTING
88 [12-31 17:15:17] [ scanner] [ protocol] [ DEBUG] server - event = connection_made(<_SelectorSocketTransport fd=1220 read=idle write=<idle, bufsize=0>>)
89 [12-31 17:15:17] [ scanner] [ protocol] [ DEBUG] server - state = OPEN
90 [12-31 17:15:17] [ scanner] [WebsocketServerBase] [ DEBUG] Waiting for connections
91 [12-31 17:15:17] [ scanner] [WebsocketServerBase] [ INFO] Client registering....
92 [12-31 17:15:17] [ scanner] [ server] [ ERROR] Error in connection handler
93Traceback (most recent call last):
94 File "C:\Users\Administrator\AppData\Local\Programs\Python\Python36\lib\site-packages\websockets\server.py", line 169, in handler
95 yield from self.ws_handler(self, path)
96 File "c:\MAD\MAD\websocket\WebsocketServerBase.py", line 168, in handler
97 continueWork = await self.__register(websocket)
98 File "c:\MAD\MAD\websocket\WebsocketServerBase.py", line 89, in __register
99 daytime_routemanager = self.routemanagers[client_mapping["daytime_area"]].get("routemanager")
100KeyError: None