yahoo-eng-team team mailing list archive

[Matt Riedemann <mriedem@xxxxxxxxxx>]

Public bug reported:

Logging with an instance kwarg used to just log the instance uuid but
now it looks like after the change to use oslo_log we're logging the
entire representation of the instance object which blows up the logs and
makes things hard to read:

http://logs.openstack.org/40/122240/19/gate/gate-tempest-dsvm-neutron-
full/4ef0a02/logs/screen-n-cpu.txt.gz

For example:

2015-02-27 18:03:45.510 8433 WARNING nova.compute.manager [-]
Instance(access_ip_v4=None,access_ip_v6=None,architecture=None,auto_disk_config=False,availability_zone=None,cell_name=None,cleaned=False,config_drive='',created_at=2015-02-27T18:03:40Z,default_ephemeral_device=None,default_swap_device=None,deleted=False,deleted_at=None,disable_terminate=False,display_description
='ImagesTestJSON-instance-902123019',display_name='ImagesTestJSON-
instance-902123019',ephemeral_gb=0,ephemeral_key_uuid=None,fault=<?>,flavor=Flavor(6),host
='devstack-trusty-rax-dfw-1041350.slave.openstack.org',hostname
='imagestestjson-instance-902123019',id=9,image_ref='801203df-
0ef4-45c5-bdd2-f981358dff40',info_cache=InstanceInfoCache,instance_type_id=6,kernel_id='525a7006
-cf4b-45be-
b2e8-a6fd46e52d47',key_data=None,key_name=None,launch_index=0,launched_at=2015-02-27T18:03:42Z,launched_on
='devstack-trusty-rax-
dfw-1041350.slave.openstack.org',locked=False,locked_by=None,memory_mb=64,metadata={},new_flavor=None,node
='devstack-trusty-rax-
dfw-1041350.slave.openstack.org',numa_topology=<?>,old_flavor=None,os_type=None,pci_devices=<?>,pci_requests=<?>,power_state=1,progress=0,project_id='e619583f4404465ab6d1d85c065c05c3',ramdisk_id='6949db12
-e5cd-416a-
b1c5-7318595d3382',reservation_id='r-l5zukbbw',root_device_name='/dev/vda',root_gb=0,scheduled_at=None,security_groups=SecurityGroupList,shutdown_terminate=False,system_metadata={image_base_image_ref
='801203df-
0ef4-45c5-bdd2-f981358dff40',image_container_format='ami',image_disk_format='ami',image_kernel_id='525a7006
-cf4b-45be-
b2e8-a6fd46e52d47',image_min_disk='0',image_min_ram='0',image_ramdisk_id='6949db12
-e5cd-416a-
b1c5-7318595d3382'},tags=<?>,task_state=None,terminated_at=None,updated_at=2015-02-27T18:03:45Z,user_data=None,user_id='78901d21abe4437384eaa007da8558e0',uuid
=8997322e-a1fe-
4f80-ba89-2a34c54a8985,vcpu_model=<?>,vcpus=1,vm_mode=None,vm_state='active')Image
not found during snapshot

** Affects: nova
     Importance: Undecided
         Status: New

** Affects: oslo.log
     Importance: Undecided
         Status: New


** Tags: oslo

** Also affects: oslo.log
   Importance: Undecided
       Status: New

** Summary changed:

- Change to oslo_log blows up instance object repr in logs
+ Nova switching to oslo_log blows up instance object repr in logs

-- 
You received this bug notification because you are a member of Yahoo!
Engineering Team, which is subscribed to OpenStack Compute (nova).
https://bugs.launchpad.net/bugs/1426544

Title:
  Nova switching to oslo_log blows up instance object repr in logs

Status in OpenStack Compute (Nova):
  New
Status in Logging configuration library for OpenStack:
  New

Bug description:
  Logging with an instance kwarg used to just log the instance uuid but
  now it looks like after the change to use oslo_log we're logging the
  entire representation of the instance object which blows up the logs
  and makes things hard to read:

  http://logs.openstack.org/40/122240/19/gate/gate-tempest-dsvm-neutron-
  full/4ef0a02/logs/screen-n-cpu.txt.gz

  For example:

  2015-02-27 18:03:45.510 8433 WARNING nova.compute.manager [-]
  Instance(access_ip_v4=None,access_ip_v6=None,architecture=None,auto_disk_config=False,availability_zone=None,cell_name=None,cleaned=False,config_drive='',created_at=2015-02-27T18:03:40Z,default_ephemeral_device=None,default_swap_device=None,deleted=False,deleted_at=None,disable_terminate=False,display_description
  ='ImagesTestJSON-instance-902123019',display_name='ImagesTestJSON-
  instance-902123019',ephemeral_gb=0,ephemeral_key_uuid=None,fault=<?>,flavor=Flavor(6),host
  ='devstack-trusty-rax-dfw-1041350.slave.openstack.org',hostname
  ='imagestestjson-instance-902123019',id=9,image_ref='801203df-
  0ef4-45c5-bdd2-f981358dff40',info_cache=InstanceInfoCache,instance_type_id=6,kernel_id='525a7006
  -cf4b-45be-
  b2e8-a6fd46e52d47',key_data=None,key_name=None,launch_index=0,launched_at=2015-02-27T18:03:42Z,launched_on
  ='devstack-trusty-rax-
  dfw-1041350.slave.openstack.org',locked=False,locked_by=None,memory_mb=64,metadata={},new_flavor=None,node
  ='devstack-trusty-rax-
  dfw-1041350.slave.openstack.org',numa_topology=<?>,old_flavor=None,os_type=None,pci_devices=<?>,pci_requests=<?>,power_state=1,progress=0,project_id='e619583f4404465ab6d1d85c065c05c3',ramdisk_id='6949db12
  -e5cd-416a-
  b1c5-7318595d3382',reservation_id='r-l5zukbbw',root_device_name='/dev/vda',root_gb=0,scheduled_at=None,security_groups=SecurityGroupList,shutdown_terminate=False,system_metadata={image_base_image_ref
  ='801203df-
  0ef4-45c5-bdd2-f981358dff40',image_container_format='ami',image_disk_format='ami',image_kernel_id='525a7006
  -cf4b-45be-
  b2e8-a6fd46e52d47',image_min_disk='0',image_min_ram='0',image_ramdisk_id='6949db12
  -e5cd-416a-
  b1c5-7318595d3382'},tags=<?>,task_state=None,terminated_at=None,updated_at=2015-02-27T18:03:45Z,user_data=None,user_id='78901d21abe4437384eaa007da8558e0',uuid
  =8997322e-a1fe-
  4f80-ba89-2a34c54a8985,vcpu_model=<?>,vcpus=1,vm_mode=None,vm_state='active')Image
  not found during snapshot

To manage notifications about this bug go to:
https://bugs.launchpad.net/nova/+bug/1426544/+subscriptions