Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

Percentage of cross side lick intervals under 100 ms in Box 3C mouse 743573 exceeded 10% #1243

Open
alexpiet opened this issue Dec 23, 2024 · 0 comments
Open

Percentage of cross side lick intervals under 100 ms in Box 3C mouse 743573 exceeded 10% #1243

alexpiet opened this issue Dec 23, 2024 · 0 comments
Labels
low priority - auto-generated autogenerated issues that have only occurred once

Comments

@alexpiet
Copy link
Collaborator

This issue was automatically generated from GUI logs.

file: MyFunctions.py
function: calculate_inter_lick_intervals
line 957
logfile: W10DT714030/W10DT714030-C_gui_log_2024-12-18_12-35-04.txt
boxes: 3C
count: 5
text: Percentage of cross side lick intervals under 100 ms in Box 3C mouse 743573 exceeded 10%

GUI Log snippet (click for full log)

01:19:34 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306388.875776, '127.0.0.1', 4023]
01:19:34 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306388.984704, '127.0.0.1', 4023]
01:19:35 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306389.432064, '127.0.0.1', 4023]
01:19:35 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/TrialEndTime', 4306389.525984, '127.0.0.1', 4022]
01:19:35 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/BehaviorEvent', 4306389.52848, '127.0.0.1', 4022]
01:19:35 PM:INFO:Foraging:Foraging.py:_CheckStageConnection:line 793:Checking stage connection
01:19:35 PM:INFO:Foraging:Foraging.py:_GetPositions:line 805:Grabbing current stage position
01:19:35 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306389.584352, '127.0.0.1', 4023]
01:19:35 PM:WARNING:MyFunctions:MyFunctions.py:_CheckStop:line 1194:
01:19:35 PM:INFO:Foraging:Foraging.py:_StartTrialLoop:line 4246:Current trial: 193
01:19:35 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/TrialStartTime', 4306389.656, '127.0.0.1', 4022]
01:19:35 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/ITIStartTimeHarp', 4306389.659488, '127.0.0.1', 4022]
01:19:35 PM:WARNING:warnings:warnings.py:_showwarnmsg:line 110:C:\Users\svc_aind_behavior\Documents\GitHub\dynamic-foraging-task\src\foraging_gui\Visualization.py:160: RuntimeWarning: Mean of empty slice
  RewardedHistoryF[i+1-self.kernel_size]=np.nanmean(RewardedHistoryT[i+1-self.kernel_size:i+1])

01:19:36 PM:INFO:MyFunctions:MyFunctions.py:calculate_inter_lick_intervals:line 913:Percentage of left lick intervals under 100 ms is 2.59%.
01:19:36 PM:INFO:MyFunctions:MyFunctions.py:calculate_inter_lick_intervals:line 919:Percentage of right lick intervals under 100 ms is 8.17%.
01:19:36 PM:INFO:MyFunctions:MyFunctions.py:calculate_inter_lick_intervals:line 926:Percentage of right and left lick intervals under 100 ms is 6.71%.
01:19:36 PM:INFO:MyFunctions:MyFunctions.py:calculate_inter_lick_intervals:line 951:Percentage of cross side lick intervals under 100 ms is 25.00%.
01:19:36 PM:ERROR:MyFunctions:MyFunctions.py:calculate_inter_lick_intervals:line 957:Percentage of cross side lick intervals under 100 ms in Box 3C mouse 743573 exceeded 10%
Full GUI log (first 200 and last 200 lines) 
12:35:04 PM:INFO:Foraging:Foraging.py:start_gui_log_file:line 4796:Starting logfile!
12:35:05 PM:INFO:Foraging:Foraging.py:log_git_hash:line 4807:Python version: 3.11.9 | packaged by Anaconda, Inc. | (main, Apr 19 2024, 16:40:41) [MSC v.1916 64 bit (AMD64)]
12:35:05 PM:INFO:Foraging:Foraging.py:log_git_hash:line 4824:Current git commit branch, hash: main, 698fb9fecded812fcf96d570658d9bc3766b14c6
12:35:05 PM:INFO:Foraging:Foraging.py:log_git_hash:line 4828:Current foraging_gui version: 1.6.19
12:35:05 PM:WARNING:Foraging:Foraging.py:log_git_hash:line 4838:local repository is clean
12:35:05 PM:INFO:Foraging:Foraging.py:<module>:line 4944:Setting QApplication attributes
12:35:05 PM:INFO:Foraging:Foraging.py:<module>:line 4952:Starting QApplication and Window
12:35:05 PM:INFO:Foraging:Foraging.py:__init__:line 77:Creating Window
12:35:05 PM:INFO:Foraging:Foraging.py:_GetSettings:line 1211:Loaded settings_box file
12:35:05 PM:INFO:Foraging:Foraging.py:_GetSettings:line 1239:Loaded settings file
12:35:05 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1249:Missing setting (FIP_settings), using default: C:\Users\svc_aind_behavior\Documents\FIPSettings
12:35:05 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1249:Missing setting (bonsai_config_path), using default: C:\Users\svc_aind_behavior\Documents\GitHub\dynamic-foraging-task\bonsai\Bonsai.config
12:35:05 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1249:Missing setting (open_ephys_machine_ip_address), using default: 
12:35:05 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1249:Missing setting (metadata_dialog_folder), using default: C:\Users\svc_aind_behavior\Documents\ForagingSettings\metadata_dialog\
12:35:05 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1249:Missing setting (rig_metadata_folder), using default: C:\Users\svc_aind_behavior\Documents\ForagingSettings\rig_metadata\
12:35:05 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1249:Missing setting (project_info_file), using default: C:\Users\svc_aind_behavior\Documents\ForagingSettings\Project Name and Funding Source v2.csv
12:35:05 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1249:Missing setting (schedule_path), using default: Z:\dynamic_foraging\DynamicForagingSchedule.csv
12:35:05 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1249:Missing setting (lick_spout_distance_box1), using default: 5000
12:35:05 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1249:Missing setting (lick_spout_distance_box2), using default: 5000
12:35:05 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1249:Missing setting (lick_spout_distance_box3), using default: 5000
12:35:05 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1249:Missing setting (lick_spout_distance_box4), using default: 5000
12:35:05 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1249:Missing setting (name_mapper_file), using default: C:\Users\svc_aind_behavior\Documents\ForagingSettings\name_mapper.json
12:35:05 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1249:Missing setting (AutomaticUpload), using default: True
12:35:05 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1249:Missing setting (manifest_flag_dir), using default: C:\Users\svc_aind_behavior\Documents\aind_watchdog_service\manifest
12:35:05 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1249:Missing setting (auto_engage), using default: True
12:35:05 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1249:Missing setting (clear_figure_after_save), using default: True
12:35:05 PM:WARNING:Foraging:Foraging.py:_GetSettings:line 1249:Missing setting (add_default_project_name), using default: True
12:35:05 PM:INFO:Foraging:Foraging.py:_LoadSchedule:line 1137:Loaded behavior schedule
12:35:05 PM:INFO:Foraging:Foraging.py:_GetWaterCalibration:line 1101:Loaded Water Calibration
12:35:05 PM:INFO:Foraging:Foraging.py:_load_most_recent_rig_json:line 1572:Found existing rig.json: rig_447-3-C_2024-12-17_12_34_12.json
12:35:05 PM:INFO:RigJsonBuilder:RigJsonBuilder.py:build_rig_json_core:line 60:building rig json
12:35:05 PM:INFO:RigJsonBuilder:RigJsonBuilder.py:build_rig_json_core:line 624:finished building rig json
12:35:05 PM:INFO:RigJsonBuilder:RigJsonBuilder.py:build_rig_json:line 53:Using existing rig json
12:35:05 PM:INFO:Foraging:Foraging.py:_LoadUI:line 299:Using ForagingGUI.ui interface
12:35:05 PM:INFO:Foraging:Foraging.py:__init__:line 143:Setting Window title: 447-3-C
12:35:05 PM:INFO:Foraging:Foraging.py:_InitializeBonsai:line 1409:Trying to connect to already running Bonsai
12:35:05 PM:INFO:Foraging:Foraging.py:_ConnectOSC:line 1456:connecting to GUI and Bonsai through OSC
12:35:06 PM:INFO:Foraging:Foraging.py:_InitializeBonsai:line 1413:Could not connect: timed out
12:35:06 PM:INFO:Foraging:Foraging.py:_InitializeBonsai:line 1422:Starting Bonsai
12:35:06 PM:INFO:Foraging:Foraging.py:log_subprocess_output:line 4911:BONSAI logging starting
12:35:07 PM:INFO:Foraging:Foraging.py:_ConnectOSC:line 1456:connecting to GUI and Bonsai through OSC
12:35:08 PM:INFO:Foraging:Foraging.py:_InitializeBonsai:line 1436:Could not connect, total waiting time 0.5 seconds: timed out
12:35:08 PM:INFO:Foraging:Foraging.py:_ConnectOSC:line 1456:connecting to GUI and Bonsai through OSC
12:35:09 PM:INFO:Foraging:Foraging.py:_InitializeBonsai:line 1439:Connected to Bonsai after 1.0 seconds
12:35:09 PM:INFO:Foraging:Foraging.py:_InitializeBonsai:line 1440:Bonsai started successfully
12:35:09 PM:INFO:Foraging:Foraging.py:_ConnectSlims:line 1318:Attempting to connect to Slims
12:35:09 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 52:['/PhotometryFalling', 4303723.961536, '127.0.0.1', 4023], displaying at 0.5 Hz
12:35:09 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/BehaviorEvent', 4303723.969504, '127.0.0.1', 4022]
12:35:10 PM:INFO:Foraging:Foraging.py:_ConnectSlims:line 1335:Successfully connected to Slims
12:35:10 PM:WARNING:Dialogs:Dialogs.py:_LoadCalibrationParameters:line 480:could not find water calibration parameters: C:\Users\svc_aind_behavior\Documents\ForagingSettings\WaterCalibrationPar_3.json
12:35:10 PM:INFO:Foraging:Foraging.py:_InitializeMotorStage:line 912:Scanning for newscale stages
12:35:10 PM:INFO:Foraging:Foraging.py:_InitializeMotorStage:line 927:found 2 newscale stages
12:35:10 PM:INFO:Foraging:Foraging.py:_InitializeMotorStage:line 951:Found the newscale stage from the settings file
12:35:10 PM:INFO:Foraging:Foraging.py:_connect_stage:line 978:Successfully connected to newscale stage: 46808
12:35:10 PM:INFO:Foraging:Foraging.py:_CheckStageConnection:line 793:Checking stage connection
12:35:10 PM:INFO:Foraging:Foraging.py:_GetPositions:line 805:Grabbing current stage position
12:35:10 PM:INFO:Foraging:Foraging.py:_CheckStageConnection:line 793:Checking stage connection
12:35:10 PM:INFO:Foraging:Foraging.py:_GetPositions:line 805:Grabbing current stage position
12:35:10 PM:INFO:Foraging:Foraging.py:_CheckStageConnection:line 793:Checking stage connection
12:35:10 PM:INFO:Foraging:Foraging.py:_GetPositions:line 805:Grabbing current stage position
12:35:10 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1901:processing parameter changes
12:35:10 PM:INFO:Foraging:Foraging.py:_load_most_recent_rig_json:line 1572:Found existing rig.json: rig_447-3-C_2024-12-17_12_34_12.json
12:35:10 PM:INFO:Foraging:Foraging.py:_ReconnectBonsai:line 1008:attempting to close bonsai connection
12:35:14 PM:INFO:Foraging:Foraging.py:_ReconnectBonsai:line 1016:bonsai connection closed
12:35:14 PM:INFO:Foraging:Foraging.py:_ReconnectBonsai:line 1018:attempting to restart bonsai
12:35:14 PM:INFO:Foraging:Foraging.py:_InitializeBonsai:line 1409:Trying to connect to already running Bonsai
12:35:14 PM:INFO:Foraging:Foraging.py:_ConnectOSC:line 1456:connecting to GUI and Bonsai through OSC
12:35:14 PM:INFO:Foraging:Foraging.py:_InitializeBonsai:line 1416:Connected to already running Bonsai
12:35:14 PM:INFO:Foraging:Foraging.py:_InitializeBonsai:line 1417:Bonsai started successfully
12:35:14 PM:INFO:Foraging:Foraging.py:__init__:line 243:Start up complete
12:35:15 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) = 8976
12:35:16 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) = 4633
12:35:17 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_behavior/capsule/scratch/saved_curriculums/
12:35:17 PM:INFO:curriculum_manager:curriculum_manager.py:download_curriculums:line 162:Found 29 curriculums in C:\Users\svc_aind_behavior/capsule/scratch/saved_curriculums/
12:35:17 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_behavior/.aind_auto_train/curriculum_manager/
12:35:17 PM:INFO:curriculum_manager:curriculum_manager.py:download_curriculums:line 162:Found 29 curriculums in C:\Users\svc_aind_behavior/.aind_auto_train/curriculum_manager/
12:35:17 PM:INFO:Dialogs:Dialogs.py:update_auto_train_fields:line 2292:No entry found in df_training_manager for subject_id: 0
12:35:17 PM:INFO:Dialogs:Dialogs.py:_override_curriculum_clicked:line 2640:Override stage clicked: state=2
12:35:17 PM:INFO:Dialogs:Dialogs.py:_update_stage_to_apply:line 2666:Current stage to apply: unknown training stage @unknown curriculum
12:36:20 PM:INFO:Foraging:Foraging.py:_StopCurrentSession:line 3675:Stopping current trials
12:36:38 PM:INFO:Foraging:Foraging.py:_Open:line 3023:User selected: C:/behavior_data/447-3-C/743573/behavior_743573_2024-12-17_13-00-16/behavior/behavior_743573_2024-12-17_13-00-16.json
12:36:38 PM:INFO:Foraging:Foraging.py:_NewSession:line 3585:New Session pressed
12:36:38 PM:INFO:Foraging:Foraging.py:_NewSession:line 3617:Resetting session run flag
12:36:38 PM:INFO:Foraging:Foraging.py:_NewSession:line 3655:New Session complete
12:36:38 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1901:processing parameter changes
12:36:38 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: DelayMin, 0.0 -> 0.25
12:36:38 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: DelayBeta, 1.0 -> 0.0
12:36:38 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: DelayMax, 1.0 -> 0.25
12:36:38 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: RightValue, 0.03 -> 0.038
12:36:38 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: LeftValue, 0.03 -> 0.026
12:36:38 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: LeftValue_volume, 3.0 -> 2.0
12:36:38 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: ID, 0.0 -> 743573.0
12:36:38 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: DelayMin, 0.0 -> 0.25
12:36:38 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: DelayBeta, 1.0 -> 0.0
12:36:38 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: DelayMax, 1.0 -> 0.25
12:36:38 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: RightValue, 0.03 -> 0.038
12:36:38 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: LeftValue, 0.03 -> 0.026
12:36:38 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: LeftValue_volume, 3.0 -> 2.0
12:36:38 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: GiveWaterL, 0.03 -> 0.026
12:36:38 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: GiveWaterR, 0.03 -> 0.038
12:36:38 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: GiveWaterL_volume, 3.0 -> 2.0
12:36:38 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1901:processing parameter changes
12:36:39 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1901:processing parameter changes
12:36:39 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: BlockMax, 60.0 -> 35.0
12:36:39 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: RewardDelay, 0.0 -> 0.1
12:36:39 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: ITIMax, 8.0 -> 10.0
12:36:39 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: ITIBeta, 2.0 -> 3.0
12:36:39 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: ResponseTime, 1.0 -> 1.5
12:36:39 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: BlockMax, 60.0 -> 35.0
12:36:39 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: RewardDelay, 0.0 -> 0.1
12:36:39 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: ITIMax, 8.0 -> 10.0
12:36:39 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: ITIBeta, 2.0 -> 3.0
12:36:39 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: ResponseTime, 1.0 -> 1.5
12:36:39 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1901:processing parameter changes
12:36:39 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1901:processing parameter changes
12:36:39 PM:WARNING:warnings:warnings.py:_showwarnmsg:line 110:C:\Users\svc_aind_behavior\Documents\GitHub\dynamic-foraging-task\src\foraging_gui\Visualization.py:160: RuntimeWarning: Mean of empty slice
  RewardedHistoryF[i+1-self.kernel_size]=np.nanmean(RewardedHistoryT[i+1-self.kernel_size:i+1])

12:36:39 PM:INFO:Foraging:Foraging.py:_check_drop_frames:line 714:
12:36:40 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1901:processing parameter changes
12:36:40 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: Ignored, 100.0 -> 7.0
12:36:40 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: BlockBeta, 20.0 -> 10.0
12:36:40 PM:WARNING:Foraging:Foraging.py:keyPressEvent:line 1944:Cannot convert input to float: auto_stop_ignore_win, ''
12:36:40 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: MaxTime, 120.0 -> 75.0
12:36:40 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: RewardConsumeTime, 3.0 -> 1.0
12:36:40 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: Multiplier, 0.8 -> 0.5
12:36:40 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: RightValue_volume, 3.0 -> 2.0
12:36:40 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: RightValue, 0.038 -> 0.027
12:36:40 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: Unrewarded, 200.0 -> 7.0
12:36:40 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: warm_min_trial, 60.0 -> 50.0
12:36:40 PM:WARNING:Foraging:Foraging.py:keyPressEvent:line 1944:Cannot convert input to float: min_time, ''
12:36:40 PM:WARNING:Foraging:Foraging.py:keyPressEvent:line 1944:Cannot convert input to float: auto_stop_ignore_ratio_threshold, ''
12:36:40 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: Ignored, 100.0 -> 7.0
12:36:40 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: BlockBeta, 20.0 -> 10.0
12:36:40 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: MaxTime, 120.0 -> 75.0
12:36:40 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: RewardConsumeTime, 3.0 -> 1.0
12:36:40 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: Multiplier, 0.8 -> 0.5
12:36:40 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: RightValue_volume, 3.0 -> 2.0
12:36:40 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: RightValue, 0.038 -> 0.027
12:36:40 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: Unrewarded, 200.0 -> 7.0
12:36:40 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: warm_min_trial, 60.0 -> 50.0
12:36:40 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: GiveWaterR, 0.038 -> 0.027
12:36:40 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: GiveWaterR_volume, 3.0 -> 2.0
12:36:40 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: PositionY, 7489.5 -> 7489.0
12:36:40 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: PositionX, 7451.0 -> 7051.5
12:36:40 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: SuggestedWater,  -> 1.736
12:36:40 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: BaseWeight,  -> 32.63
12:36:40 PM:INFO:Foraging:Foraging.py:keyPressEvent:line 1960:Changing parameter: TargetWeight,  -> 27.736
12:36:40 PM:INFO:Dialogs:Dialogs.py:update_auto_train_lock:line 2844:AutoTrain disengaged!
12:36:40 PM:INFO:curriculum_manager:curriculum_manager.py:get_curriculum:line 131:Loaded a DynamicForagingCurriculum model from 'Uncoupled Without Baiting_curriculum_v2.3.1rwdDelay159_schema_v1.0.json'.
12:36:40 PM:INFO:Dialogs:Dialogs.py:_override_curriculum_clicked:line 2640:Override stage clicked: state=0
12:36:40 PM:INFO:Dialogs:Dialogs.py:_update_curriculum_diagrams:line 2586:Selected curriculum: {'curriculum_name': 'Uncoupled Without Baiting', 'curriculum_version': '2.3.1rwdDelay159', 'curriculum_schema_version': '1.0', 'curriculum_description': '2024-08-16 max_len = 75 mins; decrease finished trial criterion'}
12:36:40 PM:INFO:curriculum_manager:curriculum_manager.py:get_curriculum:line 131:Loaded a DynamicForagingCurriculum model from 'Uncoupled Without Baiting_curriculum_v2.3.1rwdDelay159_schema_v1.0.json'.
12:36:40 PM:INFO:Dialogs:Dialogs.py:_update_stage_to_apply:line 2666:Current stage to apply: STAGE_2 @Uncoupled Without Baiting ([email protected])
12:36:40 PM:INFO:Dialogs:Dialogs.py:_update_stage_to_apply:line 2666:Current stage to apply: STAGE_2 @Uncoupled Without Baiting ([email protected])
12:36:40 PM:INFO:Dialogs:Dialogs.py:_update_curriculum_diagrams:line 2586:Selected curriculum: {'curriculum_name': 'Uncoupled Without Baiting', 'curriculum_version': '2.3.1rwdDelay159', 'curriculum_schema_version': '1.0', 'curriculum_description': '2024-08-16 max_len = 75 mins; decrease finished trial criterion'}
12:36:40 PM:INFO:curriculum_manager:curriculum_manager.py:get_curriculum:line 131:Loaded a DynamicForagingCurriculum model from 'Uncoupled Without Baiting_curriculum_v2.3.1rwdDelay159_schema_v1.0.json'.
12:36:40 PM:INFO:Dialogs:Dialogs.py:update_auto_train_lock:line 2793:AutoTrain engaged! STAGE_2 @ Uncoupled Without Baiting ([email protected])
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2924: Widget "training_stage" not found. skipped...
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2916:Task is set to Coupled Without Baiting
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2924: Widget "task_url" not found. skipped...
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2924: Widget "task_schema_version" not found. skipped...
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2924: Widget "description" not found. skipped...
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2971:BaseRewardSum is set to 0.8
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2971:RewardFamily is set to 1
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2971:RewardPairsN is set to 1
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2936: Widget "UncoupledReward" has been disabled by the GUI. skipped...
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2971:Randomness is set to Exponential
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2971:BlockMin is set to 20
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2971:BlockMax is set to 35
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2971:BlockBeta is set to 10
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2971:BlockMinReward is set to 0
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2971:DelayMin is set to 0.25
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2971:DelayMax is set to 0.25
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2971:DelayBeta is set to 0.0
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2971:RewardDelay is set to 0.1
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2971:AutoReward is set to True
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2971:AutoWaterType is set to Natural
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2971:Multiplier is set to 0.5
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2971:Unrewarded is set to 7
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2971:Ignored is set to 7
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2971:ITIMin is set to 1.0
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2971:ITIMax is set to 10.0
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2971:ITIBeta is set to 3.0
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2936: Widget "ITIIncrease" has been disabled by the GUI. skipped...
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2971:ResponseTime is set to 1.5
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2971:RewardConsumeTime is set to 1.0
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2924: Widget "StopIgnores" not found. skipped...
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2971:AdvancedBlockAuto is set to now
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2971:SwitchThr is set to 0.5
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2971:PointsInARow is set to 5
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2971:MaxTrial is set to 1000
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2971:MaxTime is set to 75
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2971:RightValue_volume is set to 2.0
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2971:LeftValue_volume is set to 2.0
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2936: Widget "warm_min_trial" has been disabled by the GUI. skipped...
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2936: Widget "warm_max_choice_ratio_bias" has been disabled by the GUI. skipped...
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2936: Widget "warm_min_finish_ratio" has been disabled by the GUI. skipped...
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2936: Widget "warm_windowsize" has been disabled by the GUI. skipped...
12:36:40 PM:INFO:Dialogs:Dialogs.py:_set_training_parameters:line 2971:warmup is set to off
_____SKIPPING_____
01:18:57 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306352.212576, '127.0.0.1', 4023]
01:18:57 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306352.37792, '127.0.0.1', 4023]
01:18:58 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306352.525824, '127.0.0.1', 4023]
01:18:58 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306352.946912, '127.0.0.1', 4023]
01:19:03 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306357.837088, '127.0.0.1', 4023]
01:19:03 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306358.016736, '127.0.0.1', 4023]
01:19:03 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306358.246144, '127.0.0.1', 4023]
01:19:03 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306358.262784, '127.0.0.1', 4023]
01:19:04 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/DelayStartTime', 4306359.109984, '127.0.0.1', 4022]
01:19:04 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/BehaviorEvent', 4306359.111488, '127.0.0.1', 4022]
01:19:04 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/GoCueTime', 4306359.36, '127.0.0.1', 4022]
01:19:04 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/BehaviorEvent', 4306359.361504, '127.0.0.1', 4022]
01:19:04 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/GoCueTimeSoundCard', 4306359.362336, 4, '127.0.0.1']
01:19:05 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306359.58784, '127.0.0.1', 4023]
01:19:05 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RewardOutcomeTime', 4306359.586976, '127.0.0.1', 4022]
01:19:05 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RewardOutcome', 'ErrorRight', '127.0.0.1', 4022]
01:19:05 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306359.646336, '127.0.0.1', 4023]
01:19:05 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306359.787936, '127.0.0.1', 4023]
01:19:06 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/TrialEndTime', 4306360.576, '127.0.0.1', 4022]
01:19:06 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/BehaviorEvent', 4306360.577504, '127.0.0.1', 4022]
01:19:06 PM:INFO:Foraging:Foraging.py:_CheckStageConnection:line 793:Checking stage connection
01:19:06 PM:INFO:Foraging:Foraging.py:_GetPositions:line 805:Grabbing current stage position
01:19:06 PM:WARNING:MyFunctions:MyFunctions.py:_CheckStop:line 1194:
01:19:06 PM:INFO:Foraging:Foraging.py:_StartTrialLoop:line 4246:Current trial: 187
01:19:06 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/TrialStartTime', 4306360.729984, '127.0.0.1', 4022]
01:19:06 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/ITIStartTimeHarp', 4306360.733504, '127.0.0.1', 4022]
01:19:06 PM:WARNING:warnings:warnings.py:_showwarnmsg:line 110:C:\Users\svc_aind_behavior\Documents\GitHub\dynamic-foraging-task\src\foraging_gui\Visualization.py:160: RuntimeWarning: Mean of empty slice
  RewardedHistoryF[i+1-self.kernel_size]=np.nanmean(RewardedHistoryT[i+1-self.kernel_size:i+1])

01:19:07 PM:INFO:Foraging:Foraging.py:_CheckStageConnection:line 793:Checking stage connection
01:19:08 PM:INFO:Foraging:Foraging.py:_Move:line 836:Moving stage
01:19:13 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/DelayStartTime', 4306367.725984, '127.0.0.1', 4022]
01:19:13 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/BehaviorEvent', 4306367.72848, '127.0.0.1', 4022]
01:19:13 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/GoCueTime', 4306367.976, '127.0.0.1', 4022]
01:19:13 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/GoCueTimeSoundCard', 4306367.979328, 4, '127.0.0.1']
01:19:13 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/BehaviorEvent', 4306367.978496, '127.0.0.1', 4022]
01:19:13 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306368.242016, '127.0.0.1', 4023]
01:19:13 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RewardOutcomeTime', 4306368.240992, '127.0.0.1', 4022]
01:19:13 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightRewardDeliveryTime', 4306368.240992, '127.0.0.1', 4023]
01:19:13 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RewardOutcome', 'RewardRight', '127.0.0.1', 4022]
01:19:13 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/EarnedRightWaterStartTime', 4306368.342976, '127.0.0.1', 4023]
01:19:13 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightRewardDeliveryTimeHarp', 4306368.34448, '127.0.0.1', 4023]
01:19:13 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306368.400512, '127.0.0.1', 4023]
01:19:14 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306368.580384, '127.0.0.1', 4023]
01:19:14 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306368.687456, '127.0.0.1', 4023]
01:19:14 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306368.82944, '127.0.0.1', 4023]
01:19:14 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306369.104096, '127.0.0.1', 4023]
01:19:14 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/TrialEndTime', 4306369.225984, '127.0.0.1', 4022]
01:19:14 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/BehaviorEvent', 4306369.22848, '127.0.0.1', 4022]
01:19:14 PM:INFO:Foraging:Foraging.py:_CheckStageConnection:line 793:Checking stage connection
01:19:14 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306369.258272, '127.0.0.1', 4023]
01:19:14 PM:INFO:Foraging:Foraging.py:_GetPositions:line 805:Grabbing current stage position
01:19:14 PM:WARNING:MyFunctions:MyFunctions.py:_CheckStop:line 1194:
01:19:14 PM:INFO:Foraging:Foraging.py:_StartTrialLoop:line 4246:Current trial: 188
01:19:14 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/TrialStartTime', 4306369.346976, '127.0.0.1', 4022]
01:19:14 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/ITIStartTimeHarp', 4306369.351488, '127.0.0.1', 4022]
01:19:14 PM:WARNING:warnings:warnings.py:_showwarnmsg:line 110:C:\Users\svc_aind_behavior\Documents\GitHub\dynamic-foraging-task\src\foraging_gui\Visualization.py:160: RuntimeWarning: Mean of empty slice
  RewardedHistoryF[i+1-self.kernel_size]=np.nanmean(RewardedHistoryT[i+1-self.kernel_size:i+1])

01:19:14 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306369.410688, '127.0.0.1', 4023]
01:19:15 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306370.275392, '127.0.0.1', 4023]
01:19:15 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306370.41712, '127.0.0.1', 4023]
01:19:16 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306370.43264, '127.0.0.1', 4023]
01:19:16 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306370.602784, '127.0.0.1', 4023]
01:19:17 PM:INFO:Foraging:Foraging.py:_CheckStageConnection:line 793:Checking stage connection
01:19:17 PM:INFO:Foraging:Foraging.py:_Move:line 836:Moving stage
01:19:17 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/DelayStartTime', 4306372.16, '127.0.0.1', 4022]
01:19:17 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/BehaviorEvent', 4306372.161504, '127.0.0.1', 4022]
01:19:17 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/GoCueTime', 4306372.409984, '127.0.0.1', 4022]
01:19:17 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/BehaviorEvent', 4306372.411488, '127.0.0.1', 4022]
01:19:17 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/GoCueTimeSoundCard', 4306372.41232, 4, '127.0.0.1']
01:19:18 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306372.550592, '127.0.0.1', 4023]
01:19:18 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RewardOutcomeTime', 4306372.549984, '127.0.0.1', 4022]
01:19:18 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RewardOutcome', 'ErrorRight', '127.0.0.1', 4022]
01:19:18 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306372.724448, '127.0.0.1', 4023]
01:19:18 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306372.885472, '127.0.0.1', 4023]
01:19:19 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/TrialEndTime', 4306373.542976, '127.0.0.1', 4022]
01:19:19 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/BehaviorEvent', 4306373.54448, '127.0.0.1', 4022]
01:19:19 PM:INFO:Foraging:Foraging.py:_CheckStageConnection:line 793:Checking stage connection
01:19:19 PM:INFO:Foraging:Foraging.py:_GetPositions:line 805:Grabbing current stage position
01:19:19 PM:WARNING:MyFunctions:MyFunctions.py:_CheckStop:line 1194:
01:19:19 PM:INFO:Foraging:Foraging.py:_StartTrialLoop:line 4246:Current trial: 189
01:19:19 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/TrialStartTime', 4306373.692992, '127.0.0.1', 4022]
01:19:19 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/ITIStartTimeHarp', 4306373.69648, '127.0.0.1', 4022]
01:19:19 PM:WARNING:warnings:warnings.py:_showwarnmsg:line 110:C:\Users\svc_aind_behavior\Documents\GitHub\dynamic-foraging-task\src\foraging_gui\Visualization.py:160: RuntimeWarning: Mean of empty slice
  RewardedHistoryF[i+1-self.kernel_size]=np.nanmean(RewardedHistoryT[i+1-self.kernel_size:i+1])

01:19:20 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/DelayStartTime', 4306374.96, '127.0.0.1', 4022]
01:19:20 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/BehaviorEvent', 4306374.961504, '127.0.0.1', 4022]
01:19:20 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/GoCueTime', 4306375.209984, '127.0.0.1', 4022]
01:19:20 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/BehaviorEvent', 4306375.211488, '127.0.0.1', 4022]
01:19:20 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/GoCueTimeSoundCard', 4306375.21264, 4, '127.0.0.1']
01:19:20 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306375.315072, '127.0.0.1', 4023]
01:19:20 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RewardOutcomeTime', 4306375.314976, '127.0.0.1', 4022]
01:19:20 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RewardOutcome', 'ErrorRight', '127.0.0.1', 4022]
01:19:21 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306375.467136, '127.0.0.1', 4023]
01:19:21 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306375.642656, '127.0.0.1', 4023]
01:19:21 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306375.877216, '127.0.0.1', 4023]
01:19:21 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306375.926752, '127.0.0.1', 4023]
01:19:21 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/TrialEndTime', 4306376.309984, '127.0.0.1', 4022]
01:19:21 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/BehaviorEvent', 4306376.311488, '127.0.0.1', 4022]
01:19:21 PM:INFO:Foraging:Foraging.py:_CheckStageConnection:line 793:Checking stage connection
01:19:21 PM:INFO:Foraging:Foraging.py:_GetPositions:line 805:Grabbing current stage position
01:19:22 PM:WARNING:MyFunctions:MyFunctions.py:_CheckStop:line 1194:
01:19:22 PM:INFO:Foraging:Foraging.py:_StartTrialLoop:line 4246:Current trial: 190
01:19:22 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/TrialStartTime', 4306376.464, '127.0.0.1', 4022]
01:19:22 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/ITIStartTimeHarp', 4306376.46848, '127.0.0.1', 4022]
01:19:22 PM:WARNING:warnings:warnings.py:_showwarnmsg:line 110:C:\Users\svc_aind_behavior\Documents\GitHub\dynamic-foraging-task\src\foraging_gui\Visualization.py:160: RuntimeWarning: Mean of empty slice
  RewardedHistoryF[i+1-self.kernel_size]=np.nanmean(RewardedHistoryT[i+1-self.kernel_size:i+1])

01:19:22 PM:INFO:bias_indicator:bias_indicator.py:calculate_bias:line 158:Bias: 0.3346025265408829 Trial Count: 189
01:19:24 PM:INFO:Foraging:Foraging.py:_CheckStageConnection:line 793:Checking stage connection
01:19:24 PM:INFO:Foraging:Foraging.py:_Move:line 836:Moving stage
01:19:25 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/DelayStartTime', 4306379.509984, '127.0.0.1', 4022]
01:19:25 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/BehaviorEvent', 4306379.511488, '127.0.0.1', 4022]
01:19:25 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/GoCueTime', 4306379.76, '127.0.0.1', 4022]
01:19:25 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/GoCueTimeSoundCard', 4306379.762304, 4, '127.0.0.1']
01:19:25 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/BehaviorEvent', 4306379.761504, '127.0.0.1', 4022]
01:19:25 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306379.913408, '127.0.0.1', 4023]
01:19:25 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RewardOutcomeTime', 4306379.912992, '127.0.0.1', 4022]
01:19:25 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RewardOutcome', 'ErrorRight', '127.0.0.1', 4022]
01:19:25 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306380.054688, '127.0.0.1', 4023]
01:19:26 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306380.43072, '127.0.0.1', 4023]
01:19:26 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306380.621952, '127.0.0.1', 4023]
01:19:26 PM:INFO:Foraging:Foraging.py:_CheckStageConnection:line 793:Checking stage connection
01:19:26 PM:INFO:Foraging:Foraging.py:_Move:line 836:Moving stage
01:19:26 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/TrialEndTime', 4306380.909984, '127.0.0.1', 4022]
01:19:26 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/BehaviorEvent', 4306380.911488, '127.0.0.1', 4022]
01:19:26 PM:INFO:Foraging:Foraging.py:_CheckStageConnection:line 793:Checking stage connection
01:19:26 PM:INFO:Foraging:Foraging.py:_GetPositions:line 805:Grabbing current stage position
01:19:26 PM:WARNING:MyFunctions:MyFunctions.py:_CheckStop:line 1194:
01:19:26 PM:INFO:Foraging:Foraging.py:_StartTrialLoop:line 4246:Current trial: 191
01:19:26 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/TrialStartTime', 4306381.034976, '127.0.0.1', 4022]
01:19:26 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/ITIStartTimeHarp', 4306381.038496, '127.0.0.1', 4022]
01:19:26 PM:WARNING:warnings:warnings.py:_showwarnmsg:line 110:C:\Users\svc_aind_behavior\Documents\GitHub\dynamic-foraging-task\src\foraging_gui\Visualization.py:160: RuntimeWarning: Mean of empty slice
  RewardedHistoryF[i+1-self.kernel_size]=np.nanmean(RewardedHistoryT[i+1-self.kernel_size:i+1])

01:19:29 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/DelayStartTime', 4306384.109984, '127.0.0.1', 4022]
01:19:29 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/BehaviorEvent', 4306384.111488, '127.0.0.1', 4022]
01:19:29 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/GoCueTime', 4306384.36, '127.0.0.1', 4022]
01:19:29 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/BehaviorEvent', 4306384.361504, '127.0.0.1', 4022]
01:19:29 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/GoCueTimeSoundCard', 4306384.362304, 4, '127.0.0.1']
01:19:30 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306384.493856, '127.0.0.1', 4023]
01:19:30 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RewardOutcomeTime', 4306384.492992, '127.0.0.1', 4022]
01:19:30 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightRewardDeliveryTime', 4306384.492992, '127.0.0.1', 4023]
01:19:30 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RewardOutcome', 'RewardRight', '127.0.0.1', 4022]
01:19:30 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/EarnedRightWaterStartTime', 4306384.609984, '127.0.0.1', 4023]
01:19:30 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightRewardDeliveryTimeHarp', 4306384.611488, '127.0.0.1', 4023]
01:19:30 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306384.615584, '127.0.0.1', 4023]
01:19:30 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306384.799808, '127.0.0.1', 4023]
01:19:30 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306384.9128, '127.0.0.1', 4023]
01:19:30 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306385.066208, '127.0.0.1', 4023]
01:19:30 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306385.223776, '127.0.0.1', 4023]
01:19:30 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306385.377376, '127.0.0.1', 4023]
01:19:31 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/TrialEndTime', 4306385.492992, '127.0.0.1', 4022]
01:19:31 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/BehaviorEvent', 4306385.494496, '127.0.0.1', 4022]
01:19:31 PM:INFO:Foraging:Foraging.py:_CheckStageConnection:line 793:Checking stage connection
01:19:31 PM:INFO:Foraging:Foraging.py:_GetPositions:line 805:Grabbing current stage position
01:19:31 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306385.571744, '127.0.0.1', 4023]
01:19:31 PM:WARNING:MyFunctions:MyFunctions.py:_CheckStop:line 1194:
01:19:31 PM:INFO:Foraging:Foraging.py:_StartTrialLoop:line 4246:Current trial: 192
01:19:31 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/TrialStartTime', 4306385.617984, '127.0.0.1', 4022]
01:19:31 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/ITIStartTimeHarp', 4306385.621504, '127.0.0.1', 4022]
01:19:31 PM:WARNING:warnings:warnings.py:_showwarnmsg:line 110:C:\Users\svc_aind_behavior\Documents\GitHub\dynamic-foraging-task\src\foraging_gui\Visualization.py:160: RuntimeWarning: Mean of empty slice
  RewardedHistoryF[i+1-self.kernel_size]=np.nanmean(RewardedHistoryT[i+1-self.kernel_size:i+1])

01:19:32 PM:INFO:Foraging:Foraging.py:_CheckStageConnection:line 793:Checking stage connection
01:19:32 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/DelayStartTime', 4306387.342976, '127.0.0.1', 4022]
01:19:32 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/BehaviorEvent', 4306387.34448, '127.0.0.1', 4022]
01:19:32 PM:INFO:Foraging:Foraging.py:_Move:line 836:Moving stage
01:19:33 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/GoCueTime', 4306387.592992, '127.0.0.1', 4022]
01:19:33 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/GoCueTimeSoundCard', 4306387.595296, 4, '127.0.0.1']
01:19:33 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/BehaviorEvent', 4306387.594496, '127.0.0.1', 4022]
01:19:34 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306388.53936, '127.0.0.1', 4023]
01:19:34 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RewardOutcomeTime', 4306388.538976, '127.0.0.1', 4022]
01:19:34 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightRewardDeliveryTime', 4306388.538976, '127.0.0.1', 4023]
01:19:34 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RewardOutcome', 'RewardRight', '127.0.0.1', 4022]
01:19:34 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/EarnedRightWaterStartTime', 4306388.642976, '127.0.0.1', 4023]
01:19:34 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightRewardDeliveryTimeHarp', 4306388.64448, '127.0.0.1', 4023]
01:19:34 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306388.704544, '127.0.0.1', 4023]
01:19:34 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306388.875776, '127.0.0.1', 4023]
01:19:34 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306388.984704, '127.0.0.1', 4023]
01:19:35 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306389.432064, '127.0.0.1', 4023]
01:19:35 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/TrialEndTime', 4306389.525984, '127.0.0.1', 4022]
01:19:35 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/BehaviorEvent', 4306389.52848, '127.0.0.1', 4022]
01:19:35 PM:INFO:Foraging:Foraging.py:_CheckStageConnection:line 793:Checking stage connection
01:19:35 PM:INFO:Foraging:Foraging.py:_GetPositions:line 805:Grabbing current stage position
01:19:35 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/RightLickTime', 4306389.584352, '127.0.0.1', 4023]
01:19:35 PM:WARNING:MyFunctions:MyFunctions.py:_CheckStop:line 1194:
01:19:35 PM:INFO:Foraging:Foraging.py:_StartTrialLoop:line 4246:Current trial: 193
01:19:35 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/TrialStartTime', 4306389.656, '127.0.0.1', 4022]
01:19:35 PM:INFO:rigcontrol:rigcontrol.py:msg_handler:line 56:['/ITIStartTimeHarp', 4306389.659488, '127.0.0.1', 4022]
01:19:35 PM:WARNING:warnings:warnings.py:_showwarnmsg:line 110:C:\Users\svc_aind_behavior\Documents\GitHub\dynamic-foraging-task\src\foraging_gui\Visualization.py:160: RuntimeWarning: Mean of empty slice
  RewardedHistoryF[i+1-self.kernel_size]=np.nanmean(RewardedHistoryT[i+1-self.kernel_size:i+1])

01:19:36 PM:INFO:MyFunctions:MyFunctions.py:calculate_inter_lick_intervals:line 913:Percentage of left lick intervals under 100 ms is 2.59%.
01:19:36 PM:INFO:MyFunctions:MyFunctions.py:calculate_inter_lick_intervals:line 919:Percentage of right lick intervals under 100 ms is 8.17%.
01:19:36 PM:INFO:MyFunctions:MyFunctions.py:calculate_inter_lick_intervals:line 926:Percentage of right and left lick intervals under 100 ms is 6.71%.
01:19:36 PM:INFO:MyFunctions:MyFunctions.py:calculate_inter_lick_intervals:line 951:Percentage of cross side lick intervals under 100 ms is 25.00%.
01:19:36 PM:ERROR:MyFunctions:MyFunctions.py:calculate_inter_lick_intervals:line 957:Percentage of cross side lick intervals under 100 ms in Box 3C mouse 743573 exceeded 10%
@alexpiet alexpiet added the low priority - auto-generated autogenerated issues that have only occurred once label Dec 23, 2024
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
low priority - auto-generated autogenerated issues that have only occurred once
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
1 participant
@alexpiet