search

AllenNeuralDynamics / dynamic-foraging-task

Bonsai/Harp workflow for Dynamic Foraging with Python GUI for visualization and control
MIT License
5 stars 4 forks source link

Starting session on branch: add_running_wheel_2 #1030

Open alexpiet opened 3 days ago

alexpiet commented 3 days ago

This issue was automatically generated from GUI logs.

file: Foraging.py
function: _Start
line 3821
logfile: W10DT713669/W10DT713669-A_gui_log_2024-11-18_13-57-33.txt
boxes: ephys1
count: 1
text: Starting session on branch: add_running_wheel_2

GUI Log snippet (click for full log)

02:02:15 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2520.915968, '127.0.0.1', 4003]
02:02:15 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2520.982144, '127.0.0.1', 4003]
02:02:15 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2521.13216, '127.0.0.1', 4003]
02:02:15 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2521.31312, '127.0.0.1', 4003]
02:02:15 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2521.332128, '127.0.0.1', 4003]
02:02:16 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2521.813312, '127.0.0.1', 4003]
02:02:19 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2525.529088, '127.0.0.1', 4003]
02:02:20 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2525.627296, '127.0.0.1', 4003]
02:02:20 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2525.650336, '127.0.0.1', 4003]
02:02:20 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2525.695744, '127.0.0.1', 4003]
02:02:20 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2525.712128, '127.0.0.1', 4003]
02:02:20 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2525.7376, '127.0.0.1', 4003]
02:02:20 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2525.743552, '127.0.0.1', 4003]
02:02:20 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2526.040864, '127.0.0.1', 4003]
02:02:20 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2526.211712, '127.0.0.1', 4003]
02:02:26 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2532.42464, '127.0.0.1', 4003]
02:02:48 PM:INFO:Foraging:Foraging.py:_Start:line 3737:Start button pressed: starting trial loop
02:02:48 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1881:processing parameter changes
02:02:51 PM:INFO:Foraging:Foraging.py:_Start:line 3805:Starting session, with experimenter: Anna Lakunina
02:02:52 PM:ERROR:Foraging:Foraging.py:_Start:line 3821:Starting session on branch: add_running_wheel_2

 Full GUI log (first 200 and last 200 lines)

01:57:33 PM:INFO:Foraging:Foraging.py:start_gui_log_file:line 4679:Starting logfile!
01:57:33 PM:INFO:Foraging:Foraging.py:log_git_hash:line 4690:Python version: 3.11.9 | packaged by Anaconda, Inc. | (main, Apr 19 2024, 16:40:41) [MSC v.1916 64 bit (AMD64)]
01:57:33 PM:INFO:Foraging:Foraging.py:log_git_hash:line 4707:Current git commit branch, hash: add_running_wheel_2, 8db63acfe80778856c6615620d9b967daef4564c
01:57:33 PM:INFO:Foraging:Foraging.py:log_git_hash:line 4711:Current foraging_gui version: 1.6.9
01:57:33 PM:WARNING:Foraging:Foraging.py:log_git_hash:line 4721:local repository is clean
01:57:33 PM:INFO:Foraging:Foraging.py:<module>:line 4822:Setting QApplication attributes
01:57:33 PM:INFO:Foraging:Foraging.py:<module>:line 4830:Starting QApplication and Window
01:57:33 PM:INFO:Foraging:Foraging.py:__init__:line 69:Creating Window
01:57:33 PM:INFO:Foraging:Foraging.py:_GetSettings:line 1166:Loaded settings_box file
01:57:33 PM:INFO:Foraging:Foraging.py:_GetSettings:line 1194:Loaded settings file
01:57:33 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1204:Missing setting (FIP_workflow_path), using default: 
01:57:33 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1204:Missing setting (FIP_settings), using default: C:\Users\svc_aind_ephys\Documents\FIPSettings
01:57:33 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1204:Missing setting (bonsai_config_path), using default: C:\Users\svc_aind_ephys\Documents\GitHub\dynamic-foraging-task\bonsai\Bonsai.config
01:57:33 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1204:Missing setting (metadata_dialog_folder), using default: C:\Users\svc_aind_ephys\Documents\ForagingSettings\metadata_dialog\
01:57:33 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1204:Missing setting (rig_metadata_folder), using default: C:\Users\svc_aind_ephys\Documents\ForagingSettings\rig_metadata\
01:57:33 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1204:Missing setting (project_info_file), using default: C:\Users\svc_aind_ephys\Documents\ForagingSettings\Project Name and Funding Source v2.csv
01:57:33 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1204:Missing setting (schedule_path), using default: Z:\dynamic_foraging\DynamicForagingSchedule.csv
01:57:33 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1204:Missing setting (go_cue_decibel_box1), using default: 60
01:57:33 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1204:Missing setting (go_cue_decibel_box2), using default: 60
01:57:33 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1204:Missing setting (go_cue_decibel_box3), using default: 60
01:57:33 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1204:Missing setting (go_cue_decibel_box4), using default: 60
01:57:33 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1204:Missing setting (lick_spout_distance_box1), using default: 5000
01:57:33 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1204:Missing setting (lick_spout_distance_box2), using default: 5000
01:57:33 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1204:Missing setting (lick_spout_distance_box3), using default: 5000
01:57:33 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1204:Missing setting (lick_spout_distance_box4), using default: 5000
01:57:33 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1204:Missing setting (name_mapper_file), using default: C:\Users\svc_aind_ephys\Documents\ForagingSettings\name_mapper.json
01:57:33 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1204:Missing setting (save_each_trial), using default: True
01:57:33 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1204:Missing setting (AutomaticUpload), using default: True
01:57:33 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1204:Missing setting (manifest_flag_dir), using default: C:\Users\svc_aind_ephys\Documents\aind_watchdog_service\manifest
01:57:33 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1204:Missing setting (auto_engage), using default: True
01:57:33 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1204:Missing setting (clear_figure_after_save), using default: True
01:57:33 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1204:Missing setting (add_default_project_name), using default: True
01:57:33 PM:INFO:Foraging:Foraging.py:_LoadSchedule:line 1092:Loaded behavior schedule
01:57:33 PM:INFO:Foraging:Foraging.py:_GetWaterCalibration:line 1056:Loaded Water Calibration
01:57:33 PM:INFO:Foraging:Foraging.py:_LoadRigJson:line 1536:Skipping rig metadata creation because create_rig_metadata=False
01:57:33 PM:INFO:Foraging:Foraging.py:_LoadUI:line 275:Using ForagingGUI.ui interface
01:57:33 PM:INFO:Foraging:Foraging.py:__init__:line 119:Setting Window title: 323_EPHYS1
01:57:33 PM:INFO:Foraging:Foraging.py:_InitializeBonsai:line 1363:Trying to connect to already running Bonsai
01:57:33 PM:INFO:Foraging:Foraging.py:_ConnectOSC:line 1410:connecting to GUI and Bonsai through OSC
01:57:34 PM:INFO:Foraging:Foraging.py:_InitializeBonsai:line 1367:Could not connect: timed out
01:57:34 PM:INFO:Foraging:Foraging.py:_InitializeBonsai:line 1376:Starting Bonsai
01:57:34 PM:INFO:Foraging:Foraging.py:log_subprocess_output:line 4794:BONSAI logging starting
01:57:35 PM:INFO:Foraging:Foraging.py:_ConnectOSC:line 1410:connecting to GUI and Bonsai through OSC
01:57:36 PM:INFO:Foraging:Foraging.py:_InitializeBonsai:line 1390:Could not connect, total waiting time 0.5 seconds: timed out
01:57:36 PM:INFO:Foraging:Foraging.py:_ConnectOSC:line 1410:connecting to GUI and Bonsai through OSC
01:57:37 PM:INFO:Foraging:Foraging.py:_InitializeBonsai:line 1390:Could not connect, total waiting time 1.0 seconds: timed out
01:57:38 PM:INFO:Foraging:Foraging.py:_ConnectOSC:line 1410:connecting to GUI and Bonsai through OSC
01:57:39 PM:INFO:Foraging:Foraging.py:_InitializeBonsai:line 1390:Could not connect, total waiting time 1.5 seconds: timed out
01:57:39 PM:INFO:Foraging:Foraging.py:_ConnectOSC:line 1410:connecting to GUI and Bonsai through OSC
01:57:40 PM:INFO:Foraging:Foraging.py:log_subprocess_output:line 4800:BONSAI: Not able to parse a Harp Data Frame (01:57:40 PM)!
01:57:40 PM:INFO:Foraging:Foraging.py:log_subprocess_output:line 4800:BONSAI: Raw Harp Data Frame: 01:10:03:0B:20:FF:11:A7:04:00:00:A2:47:00:D2:03:0B:20
01:57:40 PM:INFO:Foraging:Foraging.py:log_subprocess_output:line 4800:BONSAI: Not able to parse a Harp Data Frame (01:57:40 PM)!
01:57:40 PM:INFO:Foraging:Foraging.py:log_subprocess_output:line 4800:BONSAI: Raw Harp Data Frame: 01:DF:03:0B:20:FF:11:A6:04:00:00:2B:63:00:76:03:0B:20:FF:11:A6:04:00:00:D2:68:01:23:03:0B:20:FF:11:A6:04:00:00:13:70:00:6B:03:0B:20:FF:11:A6:04:00:00:23:74:01:80:03:0B:20:FF:11:A7:04:00:00:50:05:00:3E:03:0B:20:FF:11:A7:04:00:00:E8:09:01:DB:03:0B:20:FF:11:A7:04:00:00:CB:11:00:C5:03:0B:20:FF:11:A7:04:00:00:1C:14:01:1A:03:0B:20:FF:11:A7:04:00:00:55:15:00:53:03:0B:20:FF:11:A7:04:00:00:DD:1B:01:E2:03:0B:20:FF:11:A7:04:00:00:E7:1D:00:ED:03:0B:20:FF:11:A7:04:00:00:F0:34:01:0E:03:0B:20:FF:11:A7:04:00:00:C8:37:00:E8:03:0B:20:FF:11:A7:04:00:00:08:3A:01:2C:03:0B:20:FF:11:A7:04:00:00:4C:3B:00:70:03:0B:20:FF:11:A9:04:00:00:8F:0B:01:86:03:0B:20:FF:11:A9:04:00:00:A6:18:00:A9:03:0B
01:57:40 PM:INFO:Foraging:Foraging.py:_InitializeBonsai:line 1393:Connected to Bonsai after 2.0 seconds
01:57:40 PM:INFO:Foraging:Foraging.py:_InitializeBonsai:line 1394:Bonsai started successfully
01:57:40 PM:INFO:Foraging:Foraging.py:_ConnectSlims:line 1273:Attempting to connect to Slims
01:57:41 PM:INFO:Foraging:Foraging.py:_ConnectSlims:line 1290:Successfully connected to Slims
01:57:41 PM:WARNING:Dialogs:Dialogs.py:_LoadCalibrationParameters:line 507:could not find water calibration parameters: C:\Users\svc_aind_ephys\Documents\ForagingSettings\WaterCalibrationPar_1.json
01:57:41 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1881:processing parameter changes
01:57:41 PM:INFO:Foraging:Foraging.py:_InitializeMotorStage:line 867:Scanning for newscale stages
01:57:41 PM:INFO:Foraging:Foraging.py:_InitializeMotorStage:line 882:found 3 newscale stages
01:57:41 PM:INFO:Foraging:Foraging.py:_InitializeMotorStage:line 906:Found the newscale stage from the settings file
01:57:41 PM:INFO:Foraging:Foraging.py:_connect_stage:line 933:Successfully connected to newscale stage: 46809
01:57:41 PM:INFO:Foraging:Foraging.py:_CheckStageConnection:line 753:Checking stage connection
01:57:41 PM:INFO:Foraging:Foraging.py:_GetPositions:line 765:Grabbing current stage position
01:57:41 PM:INFO:Foraging:Foraging.py:_load_most_recent_rig_json:line 1526:Found existing rig.json: rig_323_EPHYS1_2024-06-17.json
01:57:41 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1881:processing parameter changes
01:57:41 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: RightValue, 0.03 -> 0.036
01:57:41 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: LeftValue, 0.03 -> 0.04
01:57:41 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: RightValue, 0.03 -> 0.036
01:57:41 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: LeftValue, 0.03 -> 0.04
01:57:41 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: GiveWaterL, 0.03 -> 0.04
01:57:41 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: GiveWaterR, 0.03 -> 0.036
01:57:41 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: PositionZ,  -> 7128.5
01:57:41 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: PositionY,  -> 11629.5
01:57:41 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: PositionX,  -> 6946.5
01:57:41 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1881:processing parameter changes
01:57:42 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1881:processing parameter changes
01:57:42 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1881:processing parameter changes
01:57:42 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1881:processing parameter changes
01:57:42 PM:INFO:Foraging:Foraging.py:__init__:line 219:Start up complete
01:57:43 PM:INFO:aws_util:aws_util.py:import_df_from_s3:line 115:Dataframe imported from s3://aind-behavior-data/foraging_nwb_bonsai_processed/df_sessions.pkl, len(df) = 5495
01:57:43 PM:INFO:aws_util:aws_util.py:import_df_from_s3:line 115:Dataframe imported from s3://aind-behavior-data/foraging_auto_training/df_manager_447_demo.pkl, len(df) = 4054
01:57:44 PM:INFO:aws_util:aws_util.py:download_dir_from_s3:line 140:134 objects downloaded from s3://aind-behavior-data/foraging_auto_training/saved_curriculums/ to C:\Users\svc_aind_ephys/capsule/scratch/saved_curriculums/
01:57:44 PM:INFO:curriculum_manager:curriculum_manager.py:download_curriculums:line 162:Found 29 curriculums in C:\Users\svc_aind_ephys/capsule/scratch/saved_curriculums/
01:57:45 PM:INFO:aws_util:aws_util.py:download_dir_from_s3:line 140:134 objects downloaded from s3://aind-behavior-data/foraging_auto_training/saved_curriculums/ to C:\Users\svc_aind_ephys/.aind_auto_train/curriculum_manager/
01:57:45 PM:INFO:curriculum_manager:curriculum_manager.py:download_curriculums:line 162:Found 29 curriculums in C:\Users\svc_aind_ephys/.aind_auto_train/curriculum_manager/
01:57:45 PM:INFO:Dialogs:Dialogs.py:update_auto_train_fields:line 2386:No entry found in df_training_manager for subject_id: 0
01:57:45 PM:INFO:Dialogs:Dialogs.py:_override_curriculum_clicked:line 2734:Override stage clicked: state=2
01:57:45 PM:INFO:Dialogs:Dialogs.py:_update_stage_to_apply:line 2760:Current stage to apply: unknown training stage @unknown curriculum
01:58:05 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/ManualLeftWaterStartTime', 2271.112, '127.0.0.1', 4003]
01:58:05 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftRewardDeliveryTimeHarp', 2271.117504, '127.0.0.1', 4003]
01:58:10 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/ManualLeftWaterStartTime', 2275.96, '127.0.0.1', 4003]
01:58:10 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftRewardDeliveryTimeHarp', 2275.961504, '127.0.0.1', 4003]
01:58:11 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/ManualRightWaterStartTime', 2277.532, '127.0.0.1', 4003]
01:58:11 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightRewardDeliveryTimeHarp', 2277.534496, '127.0.0.1', 4003]
01:58:17 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/ManualRightWaterStartTime', 2283.068, '127.0.0.1', 4003]
01:58:17 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightRewardDeliveryTimeHarp', 2283.069504, '127.0.0.1', 4003]
01:58:17 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2283.163104, '127.0.0.1', 4003]
01:58:17 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2283.163168, '127.0.0.1', 4003]
01:58:18 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/ManualLeftWaterStartTime', 2283.772, '127.0.0.1', 4003]
01:58:18 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftRewardDeliveryTimeHarp', 2283.774496, '127.0.0.1', 4003]
01:58:24 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/ManualLeftWaterStartTime', 2290.046976, '127.0.0.1', 4003]
01:58:24 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftRewardDeliveryTimeHarp', 2290.049504, '127.0.0.1', 4003]
01:58:26 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/ManualLeftWaterStartTime', 2291.784, '127.0.0.1', 4003]
01:58:26 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftRewardDeliveryTimeHarp', 2291.786496, '127.0.0.1', 4003]
01:58:27 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/ManualLeftWaterStartTime', 2293.28, '127.0.0.1', 4003]
01:58:27 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftRewardDeliveryTimeHarp', 2293.281504, '127.0.0.1', 4003]
01:58:29 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/ManualRightWaterStartTime', 2295.256, '127.0.0.1', 4003]
01:58:29 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightRewardDeliveryTimeHarp', 2295.258496, '127.0.0.1', 4003]
01:58:31 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/ManualRightWaterStartTime', 2296.781984, '127.0.0.1', 4003]
01:58:31 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightRewardDeliveryTimeHarp', 2296.783488, '127.0.0.1', 4003]
01:59:44 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2370.077504, '127.0.0.1', 4003]
01:59:44 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2370.208416, '127.0.0.1', 4003]
01:59:44 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2370.450176, '127.0.0.1', 4003]
01:59:45 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2370.570464, '127.0.0.1', 4003]
01:59:45 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2370.824672, '127.0.0.1', 4003]
01:59:45 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2370.935296, '127.0.0.1', 4003]
01:59:45 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2371.042272, '127.0.0.1', 4003]
01:59:45 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2371.175488, '127.0.0.1', 4003]
01:59:45 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2371.30016, '127.0.0.1', 4003]
01:59:45 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2371.428832, '127.0.0.1', 4003]
01:59:46 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2371.568992, '127.0.0.1', 4003]
01:59:46 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2371.698912, '127.0.0.1', 4003]
01:59:46 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2371.831104, '127.0.0.1', 4003]
01:59:46 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2371.964096, '127.0.0.1', 4003]
01:59:46 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2372.093024, '127.0.0.1', 4003]
01:59:46 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2372.225728, '127.0.0.1', 4003]
01:59:46 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2372.359488, '127.0.0.1', 4003]
01:59:46 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2372.486272, '127.0.0.1', 4003]
01:59:47 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2372.611616, '127.0.0.1', 4003]
01:59:47 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2372.74304, '127.0.0.1', 4003]
01:59:47 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2372.869888, '127.0.0.1', 4003]
01:59:47 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2372.998528, '127.0.0.1', 4003]
01:59:47 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2373.126976, '127.0.0.1', 4003]
01:59:47 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2373.263648, '127.0.0.1', 4003]
01:59:47 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2373.387136, '127.0.0.1', 4003]
01:59:47 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2373.514848, '127.0.0.1', 4003]
01:59:48 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2373.658368, '127.0.0.1', 4003]
01:59:48 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2373.784352, '127.0.0.1', 4003]
01:59:48 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2373.920352, '127.0.0.1', 4003]
01:59:48 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2374.05072, '127.0.0.1', 4003]
01:59:48 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2374.176896, '127.0.0.1', 4003]
01:59:48 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2374.306016, '127.0.0.1', 4003]
01:59:48 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2374.422944, '127.0.0.1', 4003]
01:59:49 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2374.550784, '127.0.0.1', 4003]
01:59:49 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2374.685088, '127.0.0.1', 4003]
01:59:49 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2374.824832, '127.0.0.1', 4003]
01:59:49 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2374.963872, '127.0.0.1', 4003]
01:59:49 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2375.118208, '127.0.0.1', 4003]
01:59:49 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2375.268928, '127.0.0.1', 4003]
01:59:49 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2375.397056, '127.0.0.1', 4003]
01:59:49 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2375.535232, '127.0.0.1', 4003]
01:59:50 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2375.818144, '127.0.0.1', 4003]
01:59:50 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2375.9808, '127.0.0.1', 4003]
01:59:50 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2376.130048, '127.0.0.1', 4003]
01:59:50 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2376.258432, '127.0.0.1', 4003]
01:59:50 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2376.503264, '127.0.0.1', 4003]
01:59:51 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2376.653344, '127.0.0.1', 4003]
01:59:51 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2376.768384, '127.0.0.1', 4003]
01:59:51 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2376.89584, '127.0.0.1', 4003]
01:59:51 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2377.15424, '127.0.0.1', 4003]
01:59:51 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2377.284224, '127.0.0.1', 4003]
01:59:51 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2377.3096, '127.0.0.1', 4003]
01:59:51 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2377.478624, '127.0.0.1', 4003]
01:59:52 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2377.667488, '127.0.0.1', 4003]
01:59:52 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2378.33344, '127.0.0.1', 4003]
01:59:52 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2378.481824, '127.0.0.1', 4003]
01:59:53 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2378.624224, '127.0.0.1', 4003]
01:59:53 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2378.736704, '127.0.0.1', 4003]
01:59:53 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2378.874912, '127.0.0.1', 4003]
01:59:53 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2378.908736, '127.0.0.1', 4003]
01:59:53 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2379.08912, '127.0.0.1', 4003]
01:59:53 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2379.32944, '127.0.0.1', 4003]
01:59:53 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2379.450016, '127.0.0.1', 4003]
01:59:54 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2379.564384, '127.0.0.1', 4003]
01:59:54 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2379.687296, '127.0.0.1', 4003]
01:59:54 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2379.81184, '127.0.0.1', 4003]
01:59:54 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2379.93664, '127.0.0.1', 4003]
01:59:54 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2380.063136, '127.0.0.1', 4003]
01:59:54 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2380.192864, '127.0.0.1', 4003]
01:59:54 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2380.321344, '127.0.0.1', 4003]
01:59:54 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2380.448608, '127.0.0.1', 4003]
01:59:55 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2380.575584, '127.0.0.1', 4003]
01:59:55 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2381.106624, '127.0.0.1', 4003]
01:59:55 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2381.222848, '127.0.0.1', 4003]
01:59:55 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2381.359744, '127.0.0.1', 4003]
01:59:55 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2381.47776, '127.0.0.1', 4003]
01:59:56 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2381.620384, '127.0.0.1', 4003]
01:59:56 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2381.76368, '127.0.0.1', 4003]
01:59:56 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2381.876032, '127.0.0.1', 4003]
01:59:56 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2381.9992, '127.0.0.1', 4003]
01:59:56 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2382.134816, '127.0.0.1', 4003]
01:59:56 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2382.265184, '127.0.0.1', 4003]
01:59:56 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2382.378528, '127.0.0.1', 4003]
01:59:56 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2382.50624, '127.0.0.1', 4003]
01:59:57 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2382.886016, '127.0.0.1', 4003]
01:59:57 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2383.014848, '127.0.0.1', 4003]
01:59:57 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2383.209664, '127.0.0.1', 4003]
01:59:57 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2383.330752, '127.0.0.1', 4003]
_____SKIPPING_____
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: BlockMax, 60.0 -> 35.0
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: ITIMax, 8.0 -> 30.0
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: ITIBeta, 2.0 -> 3.0
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: Ignored, 100.0 -> 10.0
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: StopIgnores, 20.0 -> 25.0
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: MaxTime, 120.0 -> 75.0
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: Multiplier, 0.8 -> 0.5
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: RightValue_volume, 3.0 -> 2.0
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: RightValue, 0.036 -> 0.024
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: LeftValue, 0.04 -> 0.028
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: Unrewarded, 200.0 -> 10.0
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: LeftValue_volume, 3.0 -> 2.0
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: BlockMax, 60.0 -> 35.0
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: ITIMax, 8.0 -> 30.0
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: ITIBeta, 2.0 -> 3.0
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: Ignored, 100.0 -> 10.0
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: StopIgnores, 20.0 -> 25.0
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: MaxTime, 120.0 -> 75.0
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: Multiplier, 0.8 -> 0.5
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: RightValue_volume, 3.0 -> 2.0
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: RightValue, 0.036 -> 0.024
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: LeftValue, 0.04 -> 0.028
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: Unrewarded, 200.0 -> 10.0
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: LeftValue_volume, 3.0 -> 2.0
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: PositionZ, 7128.5 -> 6534.5
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: PositionY, 11629.5 -> 11599.0
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: PositionX, 6946.5 -> 7546.5
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: SuggestedWater,  -> 0.506
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: BaseWeight,  -> 29.97
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1940:Changing parameter: TargetWeight,  -> 25.474
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1881:processing parameter changes
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1881:processing parameter changes
02:01:37 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1881:processing parameter changes
02:01:38 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1881:processing parameter changes
02:01:38 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2483.780256, '127.0.0.1', 4003]
02:01:38 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2483.90528, '127.0.0.1', 4003]
02:01:38 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1881:processing parameter changes
02:01:38 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1881:processing parameter changes
02:01:38 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1881:processing parameter changes
02:01:38 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2484.213824, '127.0.0.1', 4003]
02:01:38 PM:INFO:Foraging:Foraging.py:_check_drop_frames:line 674:
02:01:38 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1881:processing parameter changes
02:01:38 PM:INFO:Dialogs:Dialogs.py:update_auto_train_lock:line 2938:AutoTrain disengaged!
02:01:38 PM:INFO:curriculum_manager:curriculum_manager.py:get_curriculum:line 131:Loaded a DynamicForagingCurriculum model from 'Uncoupled Baiting_curriculum_v2.3_schema_v1.0.json'.
02:01:38 PM:INFO:Dialogs:Dialogs.py:_override_curriculum_clicked:line 2734:Override stage clicked: state=0
02:01:38 PM:INFO:Dialogs:Dialogs.py:_update_curriculum_diagrams:line 2680:Selected curriculum: {'curriculum_name': 'Uncoupled Baiting', 'curriculum_version': '2.3', 'curriculum_schema_version': '1.0', 'curriculum_description': '2024-08-16 max_len = 75 mins; decrease finished trial criterion'}
02:01:38 PM:INFO:curriculum_manager:curriculum_manager.py:get_curriculum:line 131:Loaded a DynamicForagingCurriculum model from 'Uncoupled Baiting_curriculum_v2.3_schema_v1.0.json'.
02:01:38 PM:INFO:Dialogs:Dialogs.py:_update_stage_to_apply:line 2760:Current stage to apply: GRADUATED @Uncoupled Baiting (v2.3@1.0)
02:01:38 PM:INFO:Dialogs:Dialogs.py:_update_stage_to_apply:line 2760:Current stage to apply: GRADUATED @Uncoupled Baiting (v2.3@1.0)
02:01:38 PM:INFO:Dialogs:Dialogs.py:_update_curriculum_diagrams:line 2680:Selected curriculum: {'curriculum_name': 'Uncoupled Baiting', 'curriculum_version': '2.3', 'curriculum_schema_version': '1.0', 'curriculum_description': '2024-08-16 max_len = 75 mins; decrease finished trial criterion'}
02:01:38 PM:INFO:curriculum_manager:curriculum_manager.py:get_curriculum:line 131:Loaded a DynamicForagingCurriculum model from 'Uncoupled Baiting_curriculum_v2.3_schema_v1.0.json'.
02:01:38 PM:INFO:Dialogs:Dialogs.py:update_auto_train_lock:line 2887:AutoTrain engaged! GRADUATED @ Uncoupled Baiting (v2.3@1.0)
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3018: Widget "training_stage" not found. skipped...
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3010:Task is set to Uncoupled Baiting
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3018: Widget "task_url" not found. skipped...
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3018: Widget "task_schema_version" not found. skipped...
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3018: Widget "description" not found. skipped...
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3030: Widget "BaseRewardSum" has been disabled by the GUI. skipped...
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3030: Widget "RewardFamily" has been disabled by the GUI. skipped...
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3030: Widget "RewardPairsN" has been disabled by the GUI. skipped...
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3065:UncoupledReward is set to 0.1, 0.4, 0.7
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3065:Randomness is set to Exponential
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3065:BlockMin is set to 20
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3065:BlockMax is set to 35
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3030: Widget "BlockBeta" has been disabled by the GUI. skipped...
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3030: Widget "BlockMinReward" has been disabled by the GUI. skipped...
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3065:DelayMin is set to 1.0
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3065:DelayMax is set to 1.0
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3065:DelayBeta is set to 0.0
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3065:RewardDelay is set to 0.0
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3065:AutoReward is set to False
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3030: Widget "AutoWaterType" has been disabled by the GUI. skipped...
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3030: Widget "Multiplier" has been disabled by the GUI. skipped...
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3030: Widget "Unrewarded" has been disabled by the GUI. skipped...
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3030: Widget "Ignored" has been disabled by the GUI. skipped...
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3065:ITIMin is set to 1.0
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3065:ITIMax is set to 30.0
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3065:ITIBeta is set to 3.0
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3030: Widget "ITIIncrease" has been disabled by the GUI. skipped...
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3065:ResponseTime is set to 1.0
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3065:RewardConsumeTime is set to 3.0
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3065:StopIgnores is set to 25
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3030: Widget "AdvancedBlockAuto" has been disabled by the GUI. skipped...
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3030: Widget "SwitchThr" has been disabled by the GUI. skipped...
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3030: Widget "PointsInARow" has been disabled by the GUI. skipped...
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3065:MaxTrial is set to 1000
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3065:MaxTime is set to 75
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3065:RightValue_volume is set to 2.0
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3065:LeftValue_volume is set to 2.0
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3030: Widget "warm_min_trial" has been disabled by the GUI. skipped...
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3030: Widget "warm_max_choice_ratio_bias" has been disabled by the GUI. skipped...
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3030: Widget "warm_min_finish_ratio" has been disabled by the GUI. skipped...
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3030: Widget "warm_windowsize" has been disabled by the GUI. skipped...
02:01:38 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 3065:warmup is set to off
02:01:38 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1881:processing parameter changes
02:01:38 PM:INFO:Dialogs:Dialogs.py:update_auto_train_fields:line 2515:Auto engage successful for mouse 746896
02:02:02 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2507.88128, '127.0.0.1', 4003]
02:02:02 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2507.897056, '127.0.0.1', 4003]
02:02:02 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2507.991744, '127.0.0.1', 4003]
02:02:02 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2507.996352, '127.0.0.1', 4003]
02:02:02 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2508.102016, '127.0.0.1', 4003]
02:02:02 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2508.105408, '127.0.0.1', 4003]
02:02:02 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2508.19312, '127.0.0.1', 4003]
02:02:02 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2508.221216, '127.0.0.1', 4003]
02:02:02 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2508.223808, '127.0.0.1', 4003]
02:02:02 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2508.336704, '127.0.0.1', 4003]
02:02:02 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2508.347136, '127.0.0.1', 4003]
02:02:02 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2508.474272, '127.0.0.1', 4003]
02:02:02 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2508.481024, '127.0.0.1', 4003]
02:02:03 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2508.621664, '127.0.0.1', 4003]
02:02:03 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2508.625728, '127.0.0.1', 4003]
02:02:03 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2508.745344, '127.0.0.1', 4003]
02:02:03 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2508.767456, '127.0.0.1', 4003]
02:02:03 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2508.868576, '127.0.0.1', 4003]
02:02:03 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2508.910272, '127.0.0.1', 4003]
02:02:03 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2508.917248, '127.0.0.1', 4003]
02:02:03 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2508.984544, '127.0.0.1', 4003]
02:02:03 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2509.031712, '127.0.0.1', 4003]
02:02:03 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2509.0464, '127.0.0.1', 4003]
02:02:03 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2509.196864, '127.0.0.1', 4003]
02:02:03 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2509.221024, '127.0.0.1', 4003]
02:02:03 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2509.36752, '127.0.0.1', 4003]
02:02:03 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2509.389696, '127.0.0.1', 4003]
02:02:03 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2509.487008, '127.0.0.1', 4003]
02:02:04 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2509.551872, '127.0.0.1', 4003]
02:02:04 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2509.590688, '127.0.0.1', 4003]
02:02:04 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2509.742208, '127.0.0.1', 4003]
02:02:04 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2509.768352, '127.0.0.1', 4003]
02:02:04 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2509.804192, '127.0.0.1', 4003]
02:02:04 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2509.847616, '127.0.0.1', 4003]
02:02:04 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2509.910432, '127.0.0.1', 4003]
02:02:04 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2509.986816, '127.0.0.1', 4003]
02:02:04 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2510.185344, '127.0.0.1', 4003]
02:02:04 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2510.198944, '127.0.0.1', 4003]
02:02:04 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2510.372768, '127.0.0.1', 4003]
02:02:04 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2510.43136, '127.0.0.1', 4003]
02:02:04 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2510.432608, '127.0.0.1', 4003]
02:02:05 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2510.643168, '127.0.0.1', 4003]
02:02:05 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2510.688992, '127.0.0.1', 4003]
02:02:05 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2510.703072, '127.0.0.1', 4003]
02:02:06 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2512.439872, '127.0.0.1', 4003]
02:02:06 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2512.501152, '127.0.0.1', 4003]
02:02:06 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2512.542784, '127.0.0.1', 4003]
02:02:07 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2512.667104, '127.0.0.1', 4003]
02:02:07 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2512.704544, '127.0.0.1', 4003]
02:02:07 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2512.773184, '127.0.0.1', 4003]
02:02:07 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2512.895424, '127.0.0.1', 4003]
02:02:07 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2512.921536, '127.0.0.1', 4003]
02:02:07 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2512.962944, '127.0.0.1', 4003]
02:02:07 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2513.142464, '127.0.0.1', 4003]
02:02:07 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2513.230016, '127.0.0.1', 4003]
02:02:07 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2513.286624, '127.0.0.1', 4003]
02:02:07 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2513.328544, '127.0.0.1', 4003]
02:02:07 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2513.350528, '127.0.0.1', 4003]
02:02:07 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2513.425984, '127.0.0.1', 4003]
02:02:07 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2513.46544, '127.0.0.1', 4003]
02:02:08 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2513.652704, '127.0.0.1', 4003]
02:02:08 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2513.725152, '127.0.0.1', 4003]
02:02:08 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2513.734432, '127.0.0.1', 4003]
02:02:08 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2513.976352, '127.0.0.1', 4003]
02:02:08 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2514.092448, '127.0.0.1', 4003]
02:02:09 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2515.29136, '127.0.0.1', 4003]
02:02:13 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2519.480224, '127.0.0.1', 4003]
02:02:13 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2519.526592, '127.0.0.1', 4003]
02:02:14 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2519.579616, '127.0.0.1', 4003]
02:02:14 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2519.751776, '127.0.0.1', 4003]
02:02:14 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2519.850208, '127.0.0.1', 4003]
02:02:14 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2519.974432, '127.0.0.1', 4003]
02:02:14 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2519.98032, '127.0.0.1', 4003]
02:02:14 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2520.112672, '127.0.0.1', 4003]
02:02:14 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2520.169984, '127.0.0.1', 4003]
02:02:14 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2520.218144, '127.0.0.1', 4003]
02:02:14 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2520.327648, '127.0.0.1', 4003]
02:02:14 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2520.37696, '127.0.0.1', 4003]
02:02:14 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2520.39728, '127.0.0.1', 4003]
02:02:14 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2520.54368, '127.0.0.1', 4003]
02:02:15 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2520.63248, '127.0.0.1', 4003]
02:02:15 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2520.633824, '127.0.0.1', 4003]
02:02:15 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2520.803744, '127.0.0.1', 4003]
02:02:15 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2520.90576, '127.0.0.1', 4003]
02:02:15 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2520.915968, '127.0.0.1', 4003]
02:02:15 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2520.982144, '127.0.0.1', 4003]
02:02:15 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2521.13216, '127.0.0.1', 4003]
02:02:15 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2521.31312, '127.0.0.1', 4003]
02:02:15 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2521.332128, '127.0.0.1', 4003]
02:02:16 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2521.813312, '127.0.0.1', 4003]
02:02:19 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2525.529088, '127.0.0.1', 4003]
02:02:20 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2525.627296, '127.0.0.1', 4003]
02:02:20 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2525.650336, '127.0.0.1', 4003]
02:02:20 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2525.695744, '127.0.0.1', 4003]
02:02:20 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2525.712128, '127.0.0.1', 4003]
02:02:20 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2525.7376, '127.0.0.1', 4003]
02:02:20 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2525.743552, '127.0.0.1', 4003]
02:02:20 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2526.040864, '127.0.0.1', 4003]
02:02:20 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 2526.211712, '127.0.0.1', 4003]
02:02:26 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/LeftLickTime', 2532.42464, '127.0.0.1', 4003]
02:02:48 PM:INFO:Foraging:Foraging.py:_Start:line 3737:Start button pressed: starting trial loop
02:02:48 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1881:processing parameter changes
02:02:51 PM:INFO:Foraging:Foraging.py:_Start:line 3805:Starting session, with experimenter: Anna Lakunina
02:02:52 PM:ERROR:Foraging:Foraging.py:_Start:line 3821:Starting session on branch: add_running_wheel_2

alexpiet commented 3 days ago

@alakunina Another reminder that you are free to run on a separate branch, but I highly advise merging any updates to the main branch so you can continue to get updates and bug fixes. Let me know if you need help merging your updates.